Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250901220009\orcl_j002_22768_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:35037M/63366M, Ph+PgF:39984M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 28 Windows thread id: 22768, image: ORACLE.EXE (J002) *** 2025-09-01 22:00:09.428 *** 2025-09-01 22:00:09.428 Process diagnostic dump for ORACLE.EXE (J002), OS id=22768, pid: 28, proc_ser: 153, sid: ------------------------------------------------------------------------------- Skipping session state dump because target process has no session. ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-09-01 22:00:09.428 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 28 (osid: 22768, J002) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-09-01 13:00:19.128068 :C78AA2A6:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-09-01 13:00:19.135915 :C78AA2B4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 13:00:19.137005 :C78AA2BC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 13:00:19.137503 :C78AA2C4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 13:00:19.137942 :C78AA2CC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 13:00:19.138360 :C78AA2D4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 13:00:19.140918 :C78AA2DC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 13:00:19.141987 :C78AA2E4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 13:00:19.192857 :C78AA2EC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 13:00:19.193860 :C78AA2F4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 13:00:19.194116 :C78AA2FC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 13:00:19.194339 :C78AA304:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 13:00:19.196085 :C78AA30C:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-09-01 14:19:26.961771 :C790DCD2:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 09-01 14:19:26.949 2025-09-01 14:19:26.961773 :C790DCD3:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=22644 pso_num=28 pso_serial#=147 2025-09-01 14:19:26.961909 :C790DCD4:db_trace:kso.c@4093:ksonfy(): [10420:28:0] kso: new process: pid=22644 osp_idx=26 osp_ver=285795 osp_pg=0 (spawn #548098) 2025-09-01 14:19:26.961910 :C790DCD5:db_trace:kso.c@4099:ksonfy(): [10420:28:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-01 14:19:26.961910 :C790DCD6:db_trace:kso.c@4103:ksonfy(): [10420:28:0] kso: new process: pso_index=28 reservation=237 time=1122018252 2025-09-01 14:19:26.961911 :C790DCD7:db_trace:kso.c@4109:ksonfy(): [10420:28:0] kso: spawn diagnostics: queue time=0 secs 2025-09-01 14:19:26.961911 :C790DCD8:db_trace:kso.c@4111:ksonfy(): [10420:28:0] kso: spawn diagnostics: fork time=0 secs 2025-09-01 14:19:26.961911 :C790DCD9:db_trace:kso.c@4113:ksonfy(): [10420:28:0] kso: spawn diagnostics: exec time=0 secs 2025-09-01 14:19:26.961912 :C790DCDA:db_trace:kso.c@4115:ksonfy(): [10420:28:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-01 14:19:26.961912 :C790DCDB:db_trace:kso.c@4117:ksonfy(): [10420:28:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-01 14:19:26.962431 :C790DCDC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-01 14:19:26.962475 :C790DCE2:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-09-01 14:19:26.966588 :C790DCFB:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:kelt.c:517 2025-09-01 14:19:26.966649 :C790DCFC:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:kelt.c:517 2025-09-01 14:19:26.966915 :C790DCFD:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:kelt.c:517 2025-09-01 14:19:26.966933 :C790DCFE:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:kelt.c:517 2025-09-01 14:19:26.967158 :C790DCFF:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:kelt.c:517 2025-09-01 14:19:26.967172 :C790DD00:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:kelt.c:517 2025-09-01 14:19:26.967383 :C790DD01:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:kelt.c:517 2025-09-01 14:19:26.967395 :C790DD02:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:kelt.c:517 2025-09-01 14:19:26.967603 :C790DD03:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:kelt.c:517 2025-09-01 14:19:26.967615 :C790DD04:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:kelt.c:517 2025-09-01 14:19:26.967826 :C790DD05:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:kelt.c:517 2025-09-01 14:19:26.967839 :C790DD06:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:kelt.c:517 2025-09-01 14:19:26.970189 :C790DD07:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-09-01 15:04:13.150361 :C7945F27:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 09-01 15:04:13.147 2025-09-01 15:04:13.150363 :C7945F28:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=19120 pso_num=28 pso_serial#=148 2025-09-01 15:04:13.150506 :C7945F29:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=19120 (legacy spawn) 2025-09-01 15:04:13.167773 :C7945F37:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 15:04:13.167931 :C7945F40:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-09-01 15:04:13.168744 :C7945F41:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-09-01 16:00:26.731835 :C798C915:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 09-01 16:00:26.719 2025-09-01 16:00:26.731837 :C798C916:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=18848 pso_num=28 pso_serial#=149 2025-09-01 16:00:26.731973 :C798C917:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=18848 (legacy spawn) 2025-09-01 16:00:26.745742 :C798C918:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 16:00:26.745915 :C798C920:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-09-01 16:00:26.746816 :C798C922:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-09-01 16:00:29.301530 :C798C9C7:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 09-01 16:00:29.293 2025-09-01 16:00:29.301532 :C798C9C8:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=22628 pso_num=28 pso_serial#=150 2025-09-01 16:00:29.301669 :C798C9C9:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=22628 (legacy spawn) 2025-09-01 16:00:29.308105 :C798C9CA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 16:00:29.308279 :C798C9CF:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-09-01 16:00:29.309103 :C798C9D4:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-09-01 17:00:33.313064 :C79D808D:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 09-01 17:00:33.304 2025-09-01 17:00:33.313066 :C79D808E:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=23432 pso_num=28 pso_serial#=151 2025-09-01 17:00:33.313209 :C79D808F:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=23432 (legacy spawn) 2025-09-01 17:00:33.319692 :C79D8090:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 17:00:33.321501 :C79D809F:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-09-01 17:00:33.322230 :C79D80A6:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-09-01 22:00:00.052966 :C7B52AF7:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 09-01 22:00:00.044 2025-09-01 22:00:00.052969 :C7B52AF8:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=23216 pso_num=28 pso_serial#=152 2025-09-01 22:00:00.053115 :C7B52AF9:db_trace:kso.c@4093:ksonfy(): [10420:28:0] kso: new process: pid=23216 osp_idx=26 osp_ver=285800 osp_pg=0 (spawn #549160) 2025-09-01 22:00:00.053116 :C7B52AFA:db_trace:kso.c@4099:ksonfy(): [10420:28:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-01 22:00:00.053116 :C7B52AFB:db_trace:kso.c@4103:ksonfy(): [10420:28:0] kso: new process: pso_index=28 reservation=238 time=1149651346 2025-09-01 22:00:00.053116 :C7B52AFC:db_trace:kso.c@4109:ksonfy(): [10420:28:0] kso: spawn diagnostics: queue time=0 secs 2025-09-01 22:00:00.053117 :C7B52AFD:db_trace:kso.c@4111:ksonfy(): [10420:28:0] kso: spawn diagnostics: fork time=0 secs 2025-09-01 22:00:00.053117 :C7B52AFE:db_trace:kso.c@4113:ksonfy(): [10420:28:0] kso: spawn diagnostics: exec time=0 secs 2025-09-01 22:00:00.053117 :C7B52AFF:db_trace:kso.c@4115:ksonfy(): [10420:28:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-01 22:00:00.053118 :C7B52B00:db_trace:kso.c@4117:ksonfy(): [10420:28:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-01 22:00:00.053626 :C7B52B01:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-01 22:00:00.053668 :C7B52B08:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-09-01 22:00:00.053746 :C7B52B1C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-09-01 22:00:00.057692 :C7B52B2B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:00.058859 :C7B52B33:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:00.058882 :C7B52B36:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-09-01 22:00:00.058920 :C7B52B41:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] KSL POST RCVD poster=18 loc='ksr2.h LINE:607 ID:ksrmdone' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-09-01 22:00:00.060787 :C7B52B4C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:00.060829 :C7B52B4F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-09-01 22:00:00.060889 :C7B52B5A:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] KSL POST RCVD poster=18 loc='ksr2.h LINE:607 ID:ksrmdone' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-09-01 22:00:00.061367 :C7B52B65:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:00.063758 :C7B52B6D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:00.069158 :C7B52B75:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:00.074501 :C7B52B7D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:00.075893 :C7B52B85:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:00.079112 :C7B52B8D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:00.080374 :C7B52B95:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:00.083425 :C7B52B9D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:00.086870 :C7B52BA5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-09-01 22:00:00.087268 :C7B52BB4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:00.087312 :C7B52BB7:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:ktcc.c:879 2025-09-01 22:00:00.087325 :C7B52BB8:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:ktcc.c:879 2025-09-01 22:00:00.089268 :C7B52BBE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:00.089324 :C7B52BC1:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:ktcc.c:879 2025-09-01 22:00:00.089344 :C7B52BC2:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:ktcc.c:879 2025-09-01 22:00:00.091374 :C7B52BC8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:00.091422 :C7B52BCB:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:ktcc.c:879 2025-09-01 22:00:00.091434 :C7B52BCC:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:ktcc.c:879 2025-09-01 22:00:00.091610 :C7B52BD2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:00.091624 :C7B52BD5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-09-01 22:00:00.091665 :C7B52BE0:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] KSL POST RCVD poster=18 loc='ksr2.h LINE:607 ID:ksrmdone' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-09-01 22:00:00.093147 :C7B52BEB:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-09-01 22:00:01.799681 :C7B52CA0:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 09-01 22:00:01.794 2025-09-01 22:00:01.799682 :C7B52CA1:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=22768 pso_num=28 pso_serial#=153 2025-09-01 22:00:01.799822 :C7B52CA2:db_trace:kso.c@4093:ksonfy(): [10420:28:0] kso: new process: pid=22768 osp_idx=26 osp_ver=285801 osp_pg=0 (spawn #549161) 2025-09-01 22:00:01.799823 :C7B52CA3:db_trace:kso.c@4099:ksonfy(): [10420:28:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-01 22:00:01.799823 :C7B52CA4:db_trace:kso.c@4103:ksonfy(): [10420:28:0] kso: new process: pso_index=28 reservation=239 time=1149653096 2025-09-01 22:00:01.799824 :C7B52CA5:db_trace:kso.c@4109:ksonfy(): [10420:28:0] kso: spawn diagnostics: queue time=0 secs 2025-09-01 22:00:01.799824 :C7B52CA6:db_trace:kso.c@4111:ksonfy(): [10420:28:0] kso: spawn diagnostics: fork time=0 secs 2025-09-01 22:00:01.799824 :C7B52CA7:db_trace:kso.c@4113:ksonfy(): [10420:28:0] kso: spawn diagnostics: exec time=0 secs 2025-09-01 22:00:01.799825 :C7B52CA8:db_trace:kso.c@4115:ksonfy(): [10420:28:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-01 22:00:01.799825 :C7B52CA9:db_trace:kso.c@4117:ksonfy(): [10420:28:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-01 22:00:01.800335 :C7B52CB7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-01 22:00:01.805360 :C7B52CD9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:01.805401 :C7B52CDC:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:jslv.c:9203 2025-09-01 22:00:01.822481 :C7B52D75:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:01.822679 :C7B52D7D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:01.822846 :C7B52D85:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:01.823000 :C7B52D8D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:01.823168 :C7B52D95:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:01.823344 :C7B52D9D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:01.823489 :C7B52DA5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:01.823635 :C7B52DAD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:01.823780 :C7B52DB5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:01.823938 :C7B52DBD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:01.824088 :C7B52DC5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:01.824239 :C7B52DCD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:01.824452 :C7B52DEE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:01.824624 :C7B52E0A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:01.824812 :C7B52E19:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:01.825089 :C7B52E21:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:01.825253 :C7B52E2E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:01.825404 :C7B52E55:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:01.825545 :C7B52EA5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:01.825702 :C7B52EB3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:01.825840 :C7B52EF5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:01.826067 :C7B52F71:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:01.826492 :C7B52F79:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:01.826656 :C7B52F81:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:01.847513 :C7B52FD6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:02.850409*:C7B5316F:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000002B443AD0 estart=1756735202 eid=21996799 ctx=0x0000000777968158 cwh=0x000000002B4709C8 cpu=0 buffg=2 interb=0 r=0 rb=0 w=0 wb=0 2025-09-01 22:00:02.850409*:C7B53174:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000002B443AD0 curCtx=0x000000005BFA7918 pubTabIdxCnt=0 2025-09-01 22:00:02.850409*:C7B53175:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000002B443AD0 2025-09-01 22:00:02.850409*:C7B53176:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000002B443AD0 2025-09-01 22:00:02.850409*:C7B53177:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000002B4BB6F0 estart=1756735201 eid=16777561 ctx=0x000000077B54EAC8 cwh=0x000000002B470518 cpu=812500 buffg=46263 interb=196608 r=24 rb=196608 w=0 wb=0 2025-09-01 22:00:02.850409*:C7B53178:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000002B4BB6F0 curCtx=0x000000005BC887D0 pubTabIdxCnt=0 2025-09-01 22:00:02.850409*:C7B53179:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000002B4BB6F0 2025-09-01 22:00:02.850409*:C7B5317A:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000002B4BB6F0 2025-09-01 22:00:02.850409*:C7B5317B:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000002B443AD0 curCtx=0x000000005BFA7918 xsc->flg4=65792 flags=1 2025-09-01 22:00:02.850409*:C7B5317C:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000002B443AD0 2025-09-01 22:00:03.522296*:C7B5334A:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000002B4BB6F0 curCtx=0x000000005BC887D0 xsc->flg4=65792 flags=2 2025-09-01 22:00:03.522296*:C7B5334B:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000002B4BB6F0 2025-09-01 22:00:03.529120 :C7B5334F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:03.551769 :C7B53361:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:03.554159 :C7B53372:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:psdpgi.c:2235 2025-09-01 22:00:03.554401 :C7B53376:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:psdpgi.c:2235 2025-09-01 22:00:03.555440 :C7B5337D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:03.555552 :C7B53380:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:03.556647 :C7B5339A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:03.558497 :C7B533A2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:03.558814 :C7B533AA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:03.616044*:SQL_Analyze:qksan.c@3402:qksanAnalyzeSql(begin): qksanAnalyzeSql(enter): goal=15 options=16778048 pgadep=0 binds#=0 byPos=0 timeLim=0 timeFired=0 2025-09-01 22:00:03.616044*:SQL_Analyze:qksan.c@936:qksanBindSql(begin): binding for SQL analyze 2025-09-01 22:00:03.616044*:SQL_Analyze:qksan.c@1344:qksanBindSql(end): Done binding: status=0 ret=0 bind#=0 byPos=1 wasBoundP=0x0000000000000000 bindIndP=0x0000000000000000 2025-09-01 22:00:03.631689*:SQL_Analyze:qksan.c@6338:qksanAvgExecStats(): The number of total executions: 1 and execution count: 0 2025-09-01 22:00:03.631689*:SQL_Analyze:qksan.c@4776:qksanPostAnalyzeDump(begin): qksanPostAnalyzeDump(): Dumping analyze context after compilation qksanStatus=SUCCESS ecode=0 2025-09-01 22:00:03.631689*:SQL_Analyze:qksan.c@4800:qksanPostAnalyzeDump(end): 2025-09-01 22:00:03.631689*:SQL_Analyze:qksan.c@3690:qksanAnalyzeSql(end): exit: ecode=0 status=0 2025-09-01 22:00:03.707422 :C7B53425:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:05.627318 :C7B53518:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:05.627330 :C7B53519:db_trace:ktur.c@3079:ktuabt(): [10444:28:225] ABORT TRANSACTION - xid: 0x0009.014.0001dc63 2025-09-01 22:00:08.021437 :C7B536B9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:08.026473 :C7B536C1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:08.036200 :C7B536C9:db_trace:ktu.c@4871:ktuaex1r(): [10442:28:225] Extension usn 2, ext 1, nex 2 2025-09-01 22:00:08.036209 :C7B536CA:db_trace:ktusm.c@2117:ktusmasp(): [10445:28:225] des1:tsn:1 rdba:0x00815592 where: kdiwh22: kdifind 2025-09-01 22:00:08.039500 :C7B536CB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:08.069809 :C7B536FC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:09.163806 :C7B537B0:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:jslv.c:9203 2025-09-01 22:00:09.174755 :C7B537B1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:0] KSL POST SENT postee=59 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-01 22:00:09.175378 :C7B537B9:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 28 (osid: 22768, J002)