Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250521220826\orcl_j000_13940_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:37359M/63366M, Ph+PgF:44465M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 24 Windows thread id: 13940, image: ORACLE.EXE (J000) *** 2025-05-21 22:08:26.583 *** SESSION ID:(193.42871) 2025-05-21 22:08:26.583 *** 2025-05-21 22:08:26.583 Process diagnostic dump for ORACLE.EXE (J000), OS id=13940, pid: 24, proc_ser: 69, sid: 193, sess_ser: 42871 ------------------------------------------------------------------------------- current sql: client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 13940 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J000) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=56 seq_num=57 snap_id=1 wait times: snap=0.453574 sec, exc=0.453574 sec, total=0.453574 sec wait times: max=0.500000 sec, heur=28.560072 sec wait counts: calls=1 os=1 in_wait=1 iflags=0x5a8 Wait State: fixed_waits=0 flags=0x22 boundary=0x0000000000000000/-1 Session Wait History: elapsed time of 0.000009 sec since current wait 0: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=55 seq_num=56 snap_id=1 wait times: snap=0.499986 sec, exc=0.499986 sec, total=0.499986 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000015 sec of elapsed time 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=54 seq_num=55 snap_id=1 wait times: snap=0.499995 sec, exc=0.499995 sec, total=0.499995 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000015 sec of elapsed time 2: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=53 seq_num=54 snap_id=1 wait times: snap=0.512343 sec, exc=0.512343 sec, total=0.512343 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 sec of elapsed time 3: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=52 seq_num=53 snap_id=1 wait times: snap=0.499968 sec, exc=0.499968 sec, total=0.499968 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 sec of elapsed time 4: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=51 seq_num=52 snap_id=1 wait times: snap=0.503217 sec, exc=0.503217 sec, total=0.503217 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000013 sec of elapsed time 5: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=50 seq_num=51 snap_id=1 wait times: snap=0.499998 sec, exc=0.499998 sec, total=0.499998 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000013 sec of elapsed time 6: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=49 seq_num=50 snap_id=1 wait times: snap=0.499996 sec, exc=0.499996 sec, total=0.499996 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000010 sec of elapsed time 7: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=48 seq_num=49 snap_id=1 wait times: snap=0.500004 sec, exc=0.500004 sec, total=0.500004 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000007 sec of elapsed time 8: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=47 seq_num=48 snap_id=1 wait times: snap=0.500206 sec, exc=0.500206 sec, total=0.500206 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000012 sec of elapsed time 9: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=46 seq_num=47 snap_id=1 wait times: snap=0.499997 sec, exc=0.499997 sec, total=0.499997 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000010 sec of elapsed time Sampled Session History of session 193 serial 42871 --------------------------------------------------- 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 --------------------------------------------------- [29 samples, 22:07:58 - 22:08:26] idle wait at each sample [session created at: 22:07:58] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-05-21 22:08:26.583 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 24 (osid: 13940, J000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-21 22:06:57.944752 :9A3C5004:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:ktcc.c:879 2025-05-21 22:06:57.944784 :9A3C5005:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:ktcc.c:879 2025-05-21 22:06:57.946498 :9A3C500B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-21 22:06:57.946542 :9A3C500C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-21 22:06:57.946668 :9A3C500D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-21 22:06:57.946697 :9A3C500E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-21 22:06:57.946722 :9A3C500F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-21 22:06:57.946932 :9A3C5010: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-05-21 22:06:57.946966 :9A3C5013:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-21 22:06:57.951504 :9A3C5019: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-05-21 22:06:57.951561 :9A3C501C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:ktcc.c:879 2025-05-21 22:06:57.951594 :9A3C501D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:ktcc.c:879 2025-05-21 22:06:57.953423 :9A3C5023:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-21 22:06:57.953468 :9A3C5024:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-21 22:06:57.956687 :9A3C5025:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-21 22:06:57.956960 :9A3C5026: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-05-21 22:06:57.957001 :9A3C5029:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-21 22:06:57.961807 :9A3C502F: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-05-21 22:06:57.961866 :9A3C5032:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:ktcc.c:879 2025-05-21 22:06:57.961902 :9A3C5033:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:ktcc.c:879 2025-05-21 22:06:57.963768 :9A3C5039:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-21 22:06:57.963812 :9A3C503A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-21 22:06:57.964194 :9A3C503B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-21 22:06:57.964231 :9A3C503C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-21 22:06:57.964450 :9A3C503D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-21 22:06:57.964481 :9A3C503E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-21 22:06:57.964576 :9A3C503F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-21 22:06:57.964849 :9A3C5040: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-05-21 22:06:57.964882 :9A3C5043:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-21 22:06:57.973255 :9A3C5049: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-05-21 22:06:57.973314 :9A3C504C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:ktcc.c:879 2025-05-21 22:06:57.973344 :9A3C504D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:ktcc.c:879 2025-05-21 22:06:57.975105 :9A3C5053:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-21 22:06:57.975149 :9A3C5054:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-21 22:06:57.975175 :9A3C5055:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-21 22:06:57.975202 :9A3C5056:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-21 22:06:57.975482 :9A3C5057:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-21 22:06:57.975512 :9A3C5058:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-21 22:06:57.975517 :9A3C5059:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-21 22:06:57.975543 :9A3C505A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-21 22:06:57.975648 :9A3C505B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-21 22:06:57.975674 :9A3C505C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-21 22:06:57.975680 :9A3C505D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-21 22:06:57.975704 :9A3C505E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-21 22:06:57.975828 :9A3C505F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-21 22:06:57.975868 :9A3C5060:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-21 22:06:57.975876 :9A3C5061:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-21 22:06:57.975914 :9A3C5062:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-21 22:06:57.976034 :9A3C5063:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-21 22:06:57.976060 :9A3C5064:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-21 22:06:57.976065 :9A3C5065:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-21 22:06:57.976090 :9A3C5066:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-21 22:06:57.976193 :9A3C5067:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-21 22:06:57.976220 :9A3C5068:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-21 22:06:57.976225 :9A3C5069:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-21 22:06:57.976251 :9A3C506A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-21 22:06:57.976355 :9A3C506B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-21 22:06:57.976384 :9A3C506C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-21 22:06:57.976419 :9A3C506D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-21 22:06:57.976659 :9A3C506E: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-05-21 22:06:57.976694 :9A3C5071:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-21 22:06:57.988742 :9A3C5077: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-05-21 22:06:57.988812 :9A3C507A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:ktcc.c:879 2025-05-21 22:06:57.988848 :9A3C507B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:ktcc.c:879 2025-05-21 22:06:57.990638 :9A3C5081:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-21 22:06:57.990682 :9A3C5082:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-21 22:06:57.990869 :9A3C5083:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-21 22:06:57.991082 :9A3C5084: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-05-21 22:06:57.991113 :9A3C5087:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-21 22:06:57.995652 :9A3C508D: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-05-21 22:06:57.995712 :9A3C5090:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:ktcc.c:879 2025-05-21 22:06:57.995742 :9A3C5091:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:ktcc.c:879 2025-05-21 22:06:58.003400 :9A3C5097: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-05-21 22:06:58.003480 :9A3C509A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:ktcc.c:879 2025-05-21 22:06:58.003541 :9A3C509B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:ktcc.c:879 2025-05-21 22:06:58.005551 :9A3C50A1:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-21 22:06:58.005597 :9A3C50A2:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-21 22:06:58.005623 :9A3C50A3:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-21 22:06:58.005654 :9A3C50A4:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-21 22:06:58.005961 :9A3C50A5:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-21 22:06:58.005996 :9A3C50A6:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-21 22:06:58.006529 :9A3C50A7:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-21 22:06:58.006563 :9A3C50A8:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-21 22:06:58.006692 :9A3C50A9:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-21 22:06:58.006722 :9A3C50AA:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-21 22:06:58.006816 :9A3C50AB:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-21 22:06:58.006844 :9A3C50AC:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-21 22:06:58.006939 :9A3C50AD:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-21 22:06:58.006967 :9A3C50AE:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-21 22:06:58.007072 :9A3C50AF:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-21 22:06:58.007100 :9A3C50B0:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-21 22:06:58.007139 :9A3C50B1:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-21 22:06:58.007393 :9A3C50B2: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-05-21 22:06:58.007431 :9A3C50B5:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-21 22:06:58.013878 :9A3C50BB: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-05-21 22:06:58.013947 :9A3C50BE:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:ktcc.c:879 2025-05-21 22:06:58.013980 :9A3C50BF:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:ktcc.c:879 2025-05-21 22:06:58.014304 :9A3C50C5:db_trace:kwqid.c@2146:kwqidrdq(): [10960:24:193] kwqidrdq: Error: 1403 occured in OCI execute 2025-05-21 22:06:58.014650 :9A3C50C6:db_trace:kwqid.c@2146:kwqidrdq(): [10960:24:193] kwqidrdq: Error: 1403 occured in OCI execute 2025-05-21 22:06:58.014779 :9A3C50C7:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-21 22:06:58.015062 :9A3C50C8: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-05-21 22:06:58.015090 :9A3C50CB:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-21 22:06:58.016663 :9A3C50D1:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-21 22:06:58.016892 :9A3C50D2: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-05-21 22:06:58.016921 :9A3C50D5:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-21 22:06:58.017912 :9A3C50DB: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-05-21 22:07:28.097956 :9A3C5A78:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-21 22:07:38.740586 :9A3C5DFE:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-21 22:07:38.733 2025-05-21 22:07:38.740589 :9A3C5DFF:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=11860 pso_num=24 pso_serial#=63 2025-05-21 22:07:38.740729 :9A3C5E00:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=11860 (legacy spawn) 2025-05-21 22:07:38.747236 :9A3C5E01: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-05-21 22:07:38.747423 :9A3C5E06: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-05-21 22:07:38.748242 :9A3C5E0B:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-21 22:07:38.756947 :9A3C5E0E:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-21 22:07:38.748 2025-05-21 22:07:38.756949 :9A3C5E0F:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=12032 pso_num=24 pso_serial#=64 2025-05-21 22:07:38.757080 :9A3C5E10:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=12032 (legacy spawn) 2025-05-21 22:07:38.763585 :9A3C5E11: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-05-21 22:07:38.763756 :9A3C5E1A: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-05-21 22:07:38.764596 :9A3C5E1B:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-21 22:07:42.115807 :9A3C5F1A:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-21 22:07:42.102 2025-05-21 22:07:42.115809 :9A3C5F1B:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=12880 pso_num=24 pso_serial#=65 2025-05-21 22:07:42.115945 :9A3C5F1C:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=12880 (legacy spawn) 2025-05-21 22:07:42.122453 :9A3C5F1D: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-05-21 22:07:42.122622 :9A3C5F26: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-05-21 22:07:42.123460 :9A3C5F27:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-21 22:07:42.132169 :9A3C5F2A:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-21 22:07:42.118 2025-05-21 22:07:42.132171 :9A3C5F2B:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=8776 pso_num=24 pso_serial#=66 2025-05-21 22:07:42.132309 :9A3C5F2C:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=8776 (legacy spawn) 2025-05-21 22:07:42.138880 :9A3C5F2D: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-05-21 22:07:42.139057 :9A3C5F36: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-05-21 22:07:42.139896 :9A3C5F37:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-21 22:07:45.311068 :9A3C6029:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-21 22:07:45.303 2025-05-21 22:07:45.311070 :9A3C602A:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=13204 pso_num=24 pso_serial#=67 2025-05-21 22:07:45.311208 :9A3C602B:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=13204 (legacy spawn) 2025-05-21 22:07:45.317695 :9A3C602C: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-05-21 22:07:45.317863 :9A3C6031: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-05-21 22:07:45.318678 :9A3C6036:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-21 22:07:46.372262 :9A3C6079:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-21 22:07:46.366 2025-05-21 22:07:46.372264 :9A3C607A:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=13420 pso_num=24 pso_serial#=68 2025-05-21 22:07:46.372404 :9A3C607B:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=13420 (legacy spawn) 2025-05-21 22:07:46.378908 :9A3C607C: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-05-21 22:07:46.379085 :9A3C6081: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-05-21 22:07:46.379895 :9A3C6086:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-21 22:07:58.012725 :9A3C6442:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-21 22:07:58.006 2025-05-21 22:07:58.012727 :9A3C6443:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=13940 pso_num=24 pso_serial#=69 2025-05-21 22:07:58.012875 :9A3C6444:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=13940 osp_idx=22 osp_ver=301733 osp_pg=0 (spawn #205865) 2025-05-21 22:07:58.012876 :9A3C6445:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-21 22:07:58.012876 :9A3C6446:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=26 time=841087875 2025-05-21 22:07:58.012877 :9A3C6447:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-05-21 22:07:58.012877 :9A3C6448:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-05-21 22:07:58.012877 :9A3C6449:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-05-21 22:07:58.012878 :9A3C644A:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-21 22:07:58.012878 :9A3C644B:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-21 22:07:58.013372 :9A3C644C: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-05-21 22:07:58.014028 :9A3C6461: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-05-21 22:07:58.021582 :9A3C647D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-21 22:07:58.021945 :9A3C647E: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-05-21 22:07:58.021979 :9A3C6481:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-21 22:07:58.022848 :9A3C6487: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-05-21 22:07:58.022974 :9A3C6490: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 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 24 (osid: 13940, J000)