Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250812220302\orcl_m001_15516_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:35553M/63366M, Ph+PgF:40950M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 29 Windows thread id: 15516, image: ORACLE.EXE (M001) *** 2025-08-12 22:03:02.497 *** 2025-08-12 22:03:02.497 Process diagnostic dump for ORACLE.EXE (M001), OS id=15516, pid: 29, proc_ser: 242, 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-08-12 22:03:02.497 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 29 (osid: 15516, M001) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-08-12 01:00:19.794315 :BE8593AC:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=21380 (legacy spawn) 2025-08-12 01:00:19.800702 :BE8593AD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 01:00:19.800872 :BE8593B6:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-12 01:00:19.801707 :BE8593B7:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-08-12 01:00:22.866354 :BE8594BB:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 08-12 01:00:22.852 2025-08-12 01:00:22.866355 :BE8594BC:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=21228 pso_num=29 pso_serial#=230 2025-08-12 01:00:22.866492 :BE8594BD:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=21228 (legacy spawn) 2025-08-12 01:00:22.872963 :BE8594BE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 01:00:22.873142 :BE8594C4:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-12 01:00:22.873921 :BE8594C8:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-08-12 01:00:22.882787 :BE8594CB:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 08-12 01:00:22.868 2025-08-12 01:00:22.882789 :BE8594CC:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=10356 pso_num=29 pso_serial#=231 2025-08-12 01:00:22.882926 :BE8594CD:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=10356 (legacy spawn) 2025-08-12 01:00:22.889322 :BE8594CE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 01:00:22.889352 :BE8594D1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 01:00:22.889515 :BE8594D8:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-12 01:00:22.890303 :BE8594E5:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-08-12 01:00:23.018339 :BE8594E8:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 08-12 01:00:23.008 2025-08-12 01:00:23.018342 :BE8594E9:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=20772 pso_num=29 pso_serial#=232 2025-08-12 01:00:23.018477 :BE8594EA:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=20772 (legacy spawn) 2025-08-12 01:00:23.042080 :BE8594EB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 01:00:23.042254 :BE8594F0:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-12 01:00:23.043150 :BE8594F5:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-08-12 01:00:57.131073 :BE85A1BA:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 08-12 01:00:57.119 2025-08-12 01:00:57.131075 :BE85A1BB:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=19380 pso_num=29 pso_serial#=233 2025-08-12 01:00:57.131209 :BE85A1BC:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=19380 (legacy spawn) 2025-08-12 01:00:57.137793 :BE85A1BD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 01:00:57.138083 :BE85A1C6:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-12 01:00:57.138888 :BE85A1C7:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-08-12 01:00:58.132144 :BE85A28F:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 08-12 01:00:58.119 2025-08-12 01:00:58.132146 :BE85A290:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=21348 pso_num=29 pso_serial#=234 2025-08-12 01:00:58.132288 :BE85A291:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=21348 osp_idx=27 osp_ver=15788 osp_pg=0 (spawn #479581) 2025-08-12 01:00:58.132288 :BE85A292:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-12 01:00:58.132288 :BE85A293:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=223 time=3641127423 2025-08-12 01:00:58.132289 :BE85A294:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-08-12 01:00:58.132289 :BE85A295:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-08-12 01:00:58.132289 :BE85A296:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-08-12 01:00:58.132291 :BE85A297:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-12 01:00:58.132291 :BE85A298:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-12 01:00:58.132806 :BE85A299:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-12 01:00:58.132852 :BE85A29F:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-12 01:00:58.140722 :BE85A2AD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 01:00:58.141866 :BE85A2B5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 01:00:58.142543 :BE85A2BD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 01:00:58.143039 :BE85A2C5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 01:00:58.143487 :BE85A2CD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 01:00:58.145997 :BE85A2D5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 01:00:58.147183 :BE85A2DD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 01:00:58.199205 :BE85A2E5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 01:00:58.200155 :BE85A2ED:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 01:00:58.200416 :BE85A2F5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 01:00:58.200630 :BE85A2FD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 01:00:58.202685 :BE85A305:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-08-12 22:00:02.057579 :BEE79637:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 08-12 22:00:02.051 2025-08-12 22:00:02.057580 :BEE79638:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=316 pso_num=29 pso_serial#=235 2025-08-12 22:00:02.057711 :BEE7963B:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=316 osp_idx=27 osp_ver=15789 osp_pg=0 (spawn #482486) 2025-08-12 22:00:02.057711 :BEE7963C:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-12 22:00:02.057712 :BEE7963D:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=224 time=3716671361 2025-08-12 22:00:02.057712 :BEE7963E:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-08-12 22:00:02.057713 :BEE7963F:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-08-12 22:00:02.057713 :BEE79640:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-08-12 22:00:02.057714 :BEE79641:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-12 22:00:02.057714 :BEE79642:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-12 22:00:02.058207 :BEE79648:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-12 22:00:02.063132 :BEE79667:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:02.063166 :BEE7966A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:jslv.c:9203 2025-08-12 22:00:02.081170 :BEE7987C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:02.081373 :BEE79884:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:02.081544 :BEE7988C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:02.081706 :BEE79894:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:02.081879 :BEE7989C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:02.082097 :BEE798A4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:02.082340 :BEE798AC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:02.082524 :BEE798AF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:02.082675 :BEE798C1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:02.082849 :BEE798C9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:02.083001 :BEE798D1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:02.083157 :BEE798D9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:02.083306 :BEE798E1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:02.083456 :BEE798E9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:02.083704 :BEE798F1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:02.083893 :BEE798F9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:02.084345 :BEE79901:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:02.111835 :BEE79909:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:03.149333*:BEE79B07:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x00000000325D3AD0 estart=1755007203 eid=21332244 ctx=0x0000000777968158 cwh=0x00000000561E0158 cpu=0 buffg=2 interb=0 r=0 rb=0 w=0 wb=0 2025-08-12 22:00:03.149333*:BEE79B08:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x00000000325D3AD0 curCtx=0x00000000560E1BF8 pubTabIdxCnt=0 2025-08-12 22:00:03.149333*:BEE79B09:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x00000000325D3AD0 2025-08-12 22:00:03.149333*:BEE79B0A:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x00000000325D3AD0 2025-08-12 22:00:03.149333*:BEE79B0B:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000003264B6F0 estart=1755007202 eid=16777517 ctx=0x000000077B54EAC8 cwh=0x0000000032640068 cpu=843750 buffg=48130 interb=196608 r=24 rb=196608 w=0 wb=0 2025-08-12 22:00:03.149333*:BEE79B0C:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000003264B6F0 curCtx=0x00000000560D7FD8 pubTabIdxCnt=0 2025-08-12 22:00:03.149333*:BEE79B0D:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000003264B6F0 2025-08-12 22:00:03.149333*:BEE79B0E:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000003264B6F0 2025-08-12 22:00:03.149333*:BEE79B0F:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x00000000325D3AD0 curCtx=0x00000000560E1BF8 xsc->flg4=65792 flags=1 2025-08-12 22:00:03.149333*:BEE79B10:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x00000000325D3AD0 2025-08-12 22:00:03.771537 :BEE79C0E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] 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-08-12 22:00:03.775361 :BEE79C31:db_trace:ktu.c@4871:ktuaex1r(): [10442:29:233] Extension usn 7, ext 1, nex 4 2025-08-12 22:00:03.775367 :BEE79C32:db_trace:ktusm.c@2117:ktusmasp(): [10445:29:233] des1:tsn:1 rdba:0x008191c2 where: kdiwh22: kdifind 2025-08-12 22:00:03.775367*:BEE79C3E:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000003264B6F0 curCtx=0x00000000560D7FD8 xsc->flg4=65792 flags=2 2025-08-12 22:00:03.775367*:BEE79C3F:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000003264B6F0 2025-08-12 22:00:03.779472 :BEE79C40:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:03.799639 :BEE79C4E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:03.801513 :BEE79C56:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:psdpgi.c:2235 2025-08-12 22:00:03.801703 :BEE79C57:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:psdpgi.c:2235 2025-08-12 22:00:03.802668 :BEE79C58:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:03.802770 :BEE79C5B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:03.803686 :BEE79C6D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:03.805160 :BEE79C75:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:03.805437 :BEE79C7D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:03.868111*: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-12 22:00:03.868111*:SQL_Analyze:qksan.c@936:qksanBindSql(begin): binding for SQL analyze 2025-08-12 22:00:03.868111*:SQL_Analyze:qksan.c@1344:qksanBindSql(end): Done binding: status=0 ret=0 bind#=0 byPos=1 wasBoundP=0x0000000000000000 bindIndP=0x0000000000000000 2025-08-12 22:00:03.868111*:SQL_Analyze:qksan.c@6338:qksanAvgExecStats(): The number of total executions: 1 and execution count: 0 2025-08-12 22:00:03.868111*:SQL_Analyze:qksan.c@4776:qksanPostAnalyzeDump(begin): qksanPostAnalyzeDump(): Dumping analyze context after compilation qksanStatus=SUCCESS ecode=0 2025-08-12 22:00:03.868111*:SQL_Analyze:qksan.c@4800:qksanPostAnalyzeDump(end): 2025-08-12 22:00:03.868111*:SQL_Analyze:qksan.c@3690:qksanAnalyzeSql(end): exit: ecode=0 status=0 2025-08-12 22:00:03.936723 :BEE79D07:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:05.819216 :BEE79E9A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:05.819231 :BEE79E9B:db_trace:ktur.c@3079:ktuabt(): [10444:29:233] ABORT TRANSACTION - xid: 0x0008.00c.0000d183 2025-08-12 22:00:08.285709 :BEE7A023:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:08.287092 :BEE7A02B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:08.297733 :BEE7A033:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:08.325636 :BEE7A03B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:09.529211 :BEE7A120:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:jslv.c:9203 2025-08-12 22:00:09.539772 :BEE7A121:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:0] KSL POST SENT postee=59 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:09.540281 :BEE7A129:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-08-12 22:00:12.198904 :BEE7A291:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 08-12 22:00:12.190 2025-08-12 22:00:12.198906 :BEE7A292:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=20872 pso_num=29 pso_serial#=236 2025-08-12 22:00:12.199069 :BEE7A293:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=20872 (legacy spawn) 2025-08-12 22:00:12.206771 :BEE7A294:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:12.206964 :BEE7A299:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-12 22:00:12.207795 :BEE7A29E:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-08-12 22:00:20.940683 :BEE7A560:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 08-12 22:00:20.932 2025-08-12 22:00:20.940685 :BEE7A561:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=19760 pso_num=29 pso_serial#=237 2025-08-12 22:00:20.940820 :BEE7A562:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=19760 (legacy spawn) 2025-08-12 22:00:20.947411 :BEE7A563:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:20.947585 :BEE7A568:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-12 22:00:20.948391 :BEE7A56D:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-08-12 22:00:24.316283 :BEE7A667:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 08-12 22:00:24.301 2025-08-12 22:00:24.316285 :BEE7A668:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=20964 pso_num=29 pso_serial#=238 2025-08-12 22:00:24.316417 :BEE7A669:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=20964 (legacy spawn) 2025-08-12 22:00:24.323276 :BEE7A66A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:24.323483 :BEE7A673:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-12 22:00:24.324287 :BEE7A674:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-08-12 22:00:24.356010 :BEE7A685:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 08-12 22:00:24.348 2025-08-12 22:00:24.356011 :BEE7A686:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=14400 pso_num=29 pso_serial#=239 2025-08-12 22:00:24.356147 :BEE7A687:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=14400 (legacy spawn) 2025-08-12 22:00:24.362598 :BEE7A688:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:24.362775 :BEE7A691:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-12 22:00:24.363581 :BEE7A692:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-08-12 22:00:27.487343 :BEE7A775:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 08-12 22:00:27.473 2025-08-12 22:00:27.487346 :BEE7A776:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=2964 pso_num=29 pso_serial#=240 2025-08-12 22:00:27.487507 :BEE7A777:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=2964 (legacy spawn) 2025-08-12 22:00:27.494741 :BEE7A778:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:27.494947 :BEE7A77D:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-12 22:00:27.495859 :BEE7A782:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-08-12 22:00:27.505171 :BEE7A785:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 08-12 22:00:27.505 2025-08-12 22:00:27.505173 :BEE7A786:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=20200 pso_num=29 pso_serial#=241 2025-08-12 22:00:27.505321 :BEE7A787:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=20200 (legacy spawn) 2025-08-12 22:00:27.511982 :BEE7A788:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:27.512152 :BEE7A791:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-12 22:00:27.513037 :BEE7A792:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-08-12 22:00:40.222419 :BEE7ACFA:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 08-12 22:00:40.213 2025-08-12 22:00:40.222421 :BEE7ACFB:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=15516 pso_num=29 pso_serial#=242 2025-08-12 22:00:40.222573 :BEE7ACFC:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=15516 osp_idx=27 osp_ver=15796 osp_pg=0 (spawn #482490) 2025-08-12 22:00:40.222574 :BEE7ACFD:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-12 22:00:40.222574 :BEE7ACFE:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=225 time=3716709517 2025-08-12 22:00:40.222574 :BEE7ACFF:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-08-12 22:00:40.222575 :BEE7AD00:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-08-12 22:00:40.222575 :BEE7AD01:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-08-12 22:00:40.222576 :BEE7AD02:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-12 22:00:40.222576 :BEE7AD03:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-12 22:00:40.223154 :BEE7AD04:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-12 22:00:40.223206 :BEE7AD0A:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-12 22:00:40.230531 :BEE7AD18:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:40.231655 :BEE7AD20:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:40.232239 :BEE7AD28:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:40.232696 :BEE7AD30:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:40.233130 :BEE7AD38:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:40.235839 :BEE7AD40:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:40.237022 :BEE7AD48:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:40.288840 :BEE7AD50:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:40.289750 :BEE7AD58:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:40.289997 :BEE7AD60:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:40.290238 :BEE7AD68:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-12 22:00:40.292200 :BEE7AD70:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 29 (osid: 15516, M001)