Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250830100312\orcl_j000_17416_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250830100312\orcl_j000_17416_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:35116M/63366M, Ph+PgF:40137M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 24 Windows thread id: 17416, image: ORACLE.EXE (J000) *** 2025-08-30 10:03:12.833 *** SESSION ID:(193.65515) 2025-08-30 10:03:12.833 *** 2025-08-30 10:03:12.833 Process diagnostic dump for ORACLE.EXE (J000), OS id=17416, pid: 24, proc_ser: 162, sid: 193, sess_ser: 65515 ------------------------------------------------------------------------------- current sql: call dbms_stats.gather_database_stats_job_proc ( ) client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 17416 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J000) application name: DBMS_SCHEDULER, hash value=2478762354 action name: ORA$AT_OS_OPT_SY_12997, hash value=2224113393 Current Wait Stack: Not in wait; last wait ended 2.256788 sec ago Wait State: fixed_waits=0 flags=0x21 boundary=0x0000000000000000/-1 Session Wait History: elapsed time of 2.256813 sec since last wait 0: waited for 'Disk file operations I/O' FileOperation=0x2, fileno=0xc9, filetype=0x2 wait_id=39 seq_num=40 snap_id=1 wait times: snap=0.000150 sec, exc=0.000150 sec, total=0.000150 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.049700 sec of elapsed time 1: waited for 'asynch descriptor resize' outstanding #aio=0x0, current aio limit=0xffffffff, new aio limit=0x82 wait_id=38 seq_num=39 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.758798 sec of elapsed time 2: waited for 'asynch descriptor resize' outstanding #aio=0x0, current aio limit=0xffffffff, new aio limit=0x82 wait_id=37 seq_num=38 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.026483 sec of elapsed time 3: waited for 'asynch descriptor resize' outstanding #aio=0x0, current aio limit=0xffffffff, new aio limit=0x82 wait_id=36 seq_num=37 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.012756 sec of elapsed time 4: waited for 'db file sequential read' file#=0x2, block#=0x78fa, blocks=0x1 wait_id=35 seq_num=36 snap_id=1 wait times: snap=0.000118 sec, exc=0.000118 sec, total=0.000118 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.049589 sec of elapsed time 5: waited for 'db file sequential read' file#=0x2, block#=0x1e5a, blocks=0x1 wait_id=34 seq_num=35 snap_id=1 wait times: snap=0.003133 sec, exc=0.003133 sec, total=0.003133 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.007790 sec of elapsed time 6: waited for 'db file sequential read' file#=0x1, block#=0x2d00, blocks=0x1 wait_id=33 seq_num=34 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.261658 sec of elapsed time 7: waited for 'db file sequential read' file#=0x1, block#=0x130, blocks=0x1 wait_id=32 seq_num=33 snap_id=1 wait times: snap=0.003191 sec, exc=0.003191 sec, total=0.003191 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000167 sec of elapsed time 8: waited for 'db file sequential read' file#=0x1, block#=0xc8, blocks=0x1 wait_id=31 seq_num=32 snap_id=1 wait times: snap=0.000123 sec, exc=0.000123 sec, total=0.000123 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.007993 sec of elapsed time 9: waited for 'asynch descriptor resize' outstanding #aio=0x0, current aio limit=0xffffffff, new aio limit=0x82 wait_id=30 seq_num=31 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.000057 sec of elapsed time Sampled Session History of session 193 serial 65515 --------------------------------------------------- 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, 10:03:09 - 10:03:12] not in wait at each sample [1 sample, 10:03:08] idle wait at each sample [session created at: 10:03:08] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.015000 sec (max dump time=30.000000 sec) *** 2025-08-30 10:03:12.848 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 24 (osid: 17416, J000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-08-30 10:01:28.693410 :C699B1A1:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-30 10:01:28.693410 :C699B1A2:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-30 10:01:28.693892 :C699B1A3: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-30 10:01:28.694605 :C699B1B8: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-30 10:01:28.702048 :C699B1D4:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-08-30 10:01:28.702474 :C699B1D5: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-30 10:01:28.702513 :C699B1D8:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-08-30 10:01:28.703386 :C699B1DE: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-30 10:01:28.703513 :C699B1E7: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-30 10:01:58.823605 :C699BB72:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-08-30 10:02:05.385268 :C699BD88:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 08-30 10:02:05.371 2025-08-30 10:02:05.385269 :C699BD89:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=21524 pso_num=24 pso_serial#=154 2025-08-30 10:02:05.385409 :C699BD8A:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=21524 (legacy spawn) 2025-08-30 10:02:05.391961 :C699BD8B: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-30 10:02:05.392133 :C699BD90: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-30 10:02:05.392934 :C699BD95:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-08-30 10:02:05.401670 :C699BD98:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 08-30 10:02:05.402 2025-08-30 10:02:05.401673 :C699BD99:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=20840 pso_num=24 pso_serial#=155 2025-08-30 10:02:05.401813 :C699BD9A:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=20840 (legacy spawn) 2025-08-30 10:02:05.408201 :C699BD9B: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-30 10:02:05.408369 :C699BDA4: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-30 10:02:05.409161 :C699BDA5:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-08-30 10:02:08.587793 :C699BE84:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 08-30 10:02:08.574 2025-08-30 10:02:08.587795 :C699BE85:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=20988 pso_num=24 pso_serial#=156 2025-08-30 10:02:08.587934 :C699BE86:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=20988 (legacy spawn) 2025-08-30 10:02:08.594330 :C699BEB4: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-30 10:02:08.594513 :C699BEB9: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-30 10:02:08.595315 :C699BEBE:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-08-30 10:02:08.614505 :C699BEC1:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 08-30 10:02:08.605 2025-08-30 10:02:08.614507 :C699BEC2:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=21868 pso_num=24 pso_serial#=157 2025-08-30 10:02:08.614649 :C699BEC3:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=21868 (legacy spawn) 2025-08-30 10:02:08.621203 :C699BEC4: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-30 10:02:08.621365 :C699BECD: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-30 10:02:08.622175 :C699BECE:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-08-30 10:02:28.337362 :C699C4D6:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 08-30 10:02:28.329 2025-08-30 10:02:28.337364 :C699C4D7:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=4124 pso_num=24 pso_serial#=158 2025-08-30 10:02:28.337510 :C699C4D8:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=4124 (legacy spawn) 2025-08-30 10:02:28.343989 :C699C4D9: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-30 10:02:28.344151 :C699C4DE: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-30 10:02:28.344955 :C699C4E3:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-08-30 10:02:28.787441 :C699C50B:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 08-30 10:02:28.782 2025-08-30 10:02:28.787443 :C699C50C:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=17340 pso_num=24 pso_serial#=159 2025-08-30 10:02:28.787577 :C699C50D:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=17340 osp_idx=22 osp_ver=820759 osp_pg=0 (spawn #540827) 2025-08-30 10:02:28.787577 :C699C50E: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-30 10:02:28.787578 :C699C50F:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=236 time=933800096 2025-08-30 10:02:28.787578 :C699C510:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-08-30 10:02:28.787579 :C699C511:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-08-30 10:02:28.787579 :C699C512:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-08-30 10:02:28.787579 :C699C513:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-30 10:02:28.787580 :C699C514:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-30 10:02:28.788062 :C699C515: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-30 10:02:28.788784 :C699C52A: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-30 10:02:28.803219 :C699C546:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-08-30 10:02:28.803303 :C699C547:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-08-30 10:02:28.823348 :C699C548:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-08-30 10:02:28.823412 :C699C549:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-08-30 10:02:28.823699 :C699C54A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-08-30 10:02:28.823736 :C699C54B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-08-30 10:02:28.823787 :C699C54C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-08-30 10:02:28.824132 :C699C54D: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-30 10:02:28.824171 :C699C550:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-08-30 10:02:28.835202 :C699C556: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-30 10:02:28.835280 :C699C559:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:ktcc.c:879 2025-08-30 10:02:28.835326 :C699C55A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:ktcc.c:879 2025-08-30 10:02:28.837267 :C699C560:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-08-30 10:02:28.837313 :C699C561:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-08-30 10:02:28.837800 :C699C562:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-08-30 10:02:28.838033 :C699C563: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-30 10:02:28.838070 :C699C566:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-08-30 10:02:28.843048 :C699C56C: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-30 10:02:28.843109 :C699C56F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:ktcc.c:879 2025-08-30 10:02:28.843141 :C699C570:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:ktcc.c:879 2025-08-30 10:02:28.843415 :C699C576:db_trace:kwqid.c@2146:kwqidrdq(): [10960:24:193] kwqidrdq: Error: 1403 occured in OCI execute 2025-08-30 10:02:28.843730 :C699C577:db_trace:kwqid.c@2146:kwqidrdq(): [10960:24:193] kwqidrdq: Error: 1403 occured in OCI execute 2025-08-30 10:02:28.843908 :C699C578:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-08-30 10:02:28.844142 :C699C579: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-30 10:02:28.844163 :C699C57C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-08-30 10:02:28.845821 :C699C582:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-08-30 10:02:28.846039 :C699C583: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-30 10:02:28.846069 :C699C586:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-08-30 10:02:28.846946 :C699C58C: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-30 10:02:28.847063 :C699C595: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-30 10:02:58.926988 :C699CF34:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-08-30 10:03:02.534370 :C699D057:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 08-30 10:03:02.525 2025-08-30 10:03:02.534372 :C699D058:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=7280 pso_num=24 pso_serial#=160 2025-08-30 10:03:02.534508 :C699D059:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=7280 (legacy spawn) 2025-08-30 10:03:02.541069 :C699D05A: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-30 10:03:02.541240 :C699D05F: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-30 10:03:02.542033 :C699D064:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-08-30 10:03:08.714754 :C699D279:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 08-30 10:03:08.709 2025-08-30 10:03:08.714756 :C699D27A:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=17932 pso_num=24 pso_serial#=161 2025-08-30 10:03:08.714896 :C699D27B:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=17932 osp_idx=22 osp_ver=820761 osp_pg=0 (spawn #540829) 2025-08-30 10:03:08.714896 :C699D27C:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-30 10:03:08.714897 :C699D27D:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=237 time=933840018 2025-08-30 10:03:08.714898 :C699D27E:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-08-30 10:03:08.714898 :C699D27F:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-08-30 10:03:08.714898 :C699D280:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-08-30 10:03:08.714899 :C699D281:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-30 10:03:08.714899 :C699D282:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-30 10:03:08.715399 :C699D283:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-30 10:03:08.715451 :C699D289:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-08-30 10:03:08.719575 :C699D2A0:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:kelt.c:517 2025-08-30 10:03:08.719621 :C699D2A1:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:kelt.c:517 2025-08-30 10:03:08.719875 :C699D2A2:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:kelt.c:517 2025-08-30 10:03:08.719891 :C699D2A3:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:kelt.c:517 2025-08-30 10:03:08.720117 :C699D2A4:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:kelt.c:517 2025-08-30 10:03:08.720130 :C699D2A5:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:kelt.c:517 2025-08-30 10:03:08.720337 :C699D2A6:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:kelt.c:517 2025-08-30 10:03:08.720349 :C699D2A7:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:kelt.c:517 2025-08-30 10:03:08.720563 :C699D2A8:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:kelt.c:517 2025-08-30 10:03:08.720576 :C699D2A9:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:kelt.c:517 2025-08-30 10:03:08.720779 :C699D2AA:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:kelt.c:517 2025-08-30 10:03:08.720792 :C699D2AB:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:kelt.c:517 2025-08-30 10:03:08.723294 :C699D2D0:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-08-30 10:03:08.816065 :C699D3FA:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 08-30 10:03:08.810 2025-08-30 10:03:08.816066 :C699D3FB:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=17416 pso_num=24 pso_serial#=162 2025-08-30 10:03:08.816190 :C699D3FC:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=17416 osp_idx=22 osp_ver=820762 osp_pg=0 (spawn #540832) 2025-08-30 10:03:08.816191 :C699D3FD: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-30 10:03:08.816192 :C699D3FE:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=238 time=933840112 2025-08-30 10:03:08.816192 :C699D3FF:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-08-30 10:03:08.816192 :C699D400:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-08-30 10:03:08.816193 :C699D401:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-08-30 10:03:08.816193 :C699D402:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-30 10:03:08.816193 :C699D403:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-30 10:03:08.817516 :C699D404: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-30 10:03:08.823024 :C699D423: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-30 10:03:08.823063 :C699D426:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:jslv.c:9203 2025-08-30 10:03:08.840121 :C699D43C: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-30 10:03:08.840323 :C699D444: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-30 10:03:08.840488 :C699D44C: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-30 10:03:08.840643 :C699D454: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-30 10:03:08.840811 :C699D45C: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-30 10:03:08.840978 :C699D464: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-30 10:03:08.841163 :C699D480: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-30 10:03:08.841311 :C699D488: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-30 10:03:08.841470 :C699D490: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-30 10:03:08.841617 :C699D4AC: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-30 10:03:08.841769 :C699D4B4: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-30 10:03:08.841911 :C699D4BC: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-30 10:03:08.842112 :C699D4C4: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-30 10:03:08.842362 :C699D4CC: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-30 10:03:08.842514 :C699D4D4: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-30 10:03:08.842851 :C699D4DC: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-30 10:03:08.843123 :C699D4E4: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-30 10:03:08.865961 :C699D4EC: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-30 10:03:10.374398*:C699D58E:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000029143AD0 estart=1756519389 eid=21866662 ctx=0x0000000777968158 cwh=0x00000000299A0068 cpu=0 buffg=2 interb=0 r=0 rb=0 w=0 wb=0 2025-08-30 10:03:10.374398*:C699D58F:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000029143AD0 curCtx=0x0000000029A619A8 pubTabIdxCnt=0 2025-08-30 10:03:10.374398*:C699D590:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000029143AD0 2025-08-30 10:03:10.374398*:C699D591:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000029143AD0 2025-08-30 10:03:10.374398*:C699D592:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x00000000291BB820 estart=1756519388 eid=16777552 ctx=0x000000077B54EAC8 cwh=0x0000000024C80608 cpu=1343750 buffg=72864 interb=196608 r=24 rb=196608 w=0 wb=0 2025-08-30 10:03:10.374398*:C699D593:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x00000000291BB820 curCtx=0x0000000029A69FF0 pubTabIdxCnt=0 2025-08-30 10:03:10.374398*:C699D594:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x00000000291BB820 2025-08-30 10:03:10.374398*:C699D595:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x00000000291BB820 2025-08-30 10:03:10.374398*:C699D596:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000029143AD0 curCtx=0x0000000029A619A8 xsc->flg4=65792 flags=1 2025-08-30 10:03:10.374398*:C699D597:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000029143AD0 2025-08-30 10:03:10.515016*:C699D5E1:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x00000000291BB820 curCtx=0x0000000029A69FF0 xsc->flg4=65792 flags=2 2025-08-30 10:03:10.515016*:C699D5E2:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x00000000291BB820 2025-08-30 10:03:10.522737 :C699D5E3: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-30 10:03:10.542862 :C699D5FC: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-30 10:03:10.544725 :C699D60D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-08-30 10:03:10.544924 :C699D60E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-08-30 10:03:10.545713 :C699D60F: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-30 10:03:10.545804 :C699D612: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-30 10:03:10.546623 :C699D624: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-30 10:03:10.548151 :C699D62C: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-30 10:03:10.548467 :C699D634: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-30 10:03:10.593154*: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-30 10:03:10.593154*:SQL_Analyze:qksan.c@936:qksanBindSql(begin): binding for SQL analyze 2025-08-30 10:03:10.593154*:SQL_Analyze:qksan.c@1344:qksanBindSql(end): Done binding: status=0 ret=0 bind#=0 byPos=1 wasBoundP=0x0000000000000000 bindIndP=0x0000000000000000 2025-08-30 10:03:10.593154*:SQL_Analyze:qksan.c@6338:qksanAvgExecStats(): The number of total executions: 1 and execution count: 0 2025-08-30 10:03:10.593154*:SQL_Analyze:qksan.c@4776:qksanPostAnalyzeDump(begin): qksanPostAnalyzeDump(): Dumping analyze context after compilation qksanStatus=SUCCESS ecode=0 2025-08-30 10:03:10.593154*:SQL_Analyze:qksan.c@4800:qksanPostAnalyzeDump(end): 2025-08-30 10:03:10.593154*:SQL_Analyze:qksan.c@3690:qksanAnalyzeSql(end): exit: ecode=0 status=0 2025-08-30 10:03:10.671297 :C699D67F: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-30 10:03:12.554598 :C699D76D: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-30 10:03:12.554613 :C699D76E:db_trace:ktur.c@3079:ktuabt(): [10444:24:193] ABORT TRANSACTION - xid: 0x0009.01c.0001dbef ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 24 (osid: 17416, J000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de