Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250705220908\orcl_m001_11212_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:37329M/63366M, Ph+PgF:43323M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 30 Windows thread id: 11212, image: ORACLE.EXE (M001) *** 2025-07-05 22:09:08.815 *** 2025-07-05 22:09:08.815 Process diagnostic dump for ORACLE.EXE (M001), OS id=11212, pid: 30, proc_ser: 100, 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-07-05 22:09:08.815 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 30 (osid: 11212, M001) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-07-04 22:00:03.843156 :AD937B8C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-07-04 22:00:03.843408 :AD937B8D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-07-04 22:00:03.844434 :AD937B8E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-04 22:00:03.844549 :AD937B91:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-04 22:00:03.845556 :AD937BA3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-04 22:00:03.847313 :AD937BAB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-04 22:00:03.847639 :AD937BB3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-04 22:00:03.848177*:AD937BBF:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x00000000319F3AD0 estart=1751637603 eid=20024555 ctx=0x0000000777968158 cwh=0x00000000326B0E78 cpu=0 buffg=2 interb=0 r=0 rb=0 w=0 wb=0 2025-07-04 22:00:03.848177*:AD937BC1:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x00000000319F3AD0 curCtx=0x00000000326E5F00 pubTabIdxCnt=0 2025-07-04 22:00:03.848177*:AD937BC2:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x00000000319F3AD0 2025-07-04 22:00:03.848177*:AD937BC3:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x00000000319F3AD0 2025-07-04 22:00:03.848177*:AD937BC6:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x00000000319F3AD0 curCtx=0x00000000326E5F00 xsc->flg4=65792 flags=1 2025-07-04 22:00:03.848177*:AD937BC7:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x00000000319F3AD0 2025-07-04 22:00:03.910685*:SQL_Analyze:qksan.c@3402:qksanAnalyzeSql(begin): qksanAnalyzeSql(enter): goal=15 options=16778048 pgadep=0 binds#=0 byPos=0 timeLim=0 timeFired=0 2025-07-04 22:00:03.910685*:SQL_Analyze:qksan.c@936:qksanBindSql(begin): binding for SQL analyze 2025-07-04 22:00:03.910685*:SQL_Analyze:qksan.c@1344:qksanBindSql(end): Done binding: status=0 ret=0 bind#=0 byPos=1 wasBoundP=0x0000000000000000 bindIndP=0x0000000000000000 2025-07-04 22:00:03.910685*:SQL_Analyze:qksan.c@6338:qksanAvgExecStats(): The number of total executions: 1 and execution count: 0 2025-07-04 22:00:03.910685*:SQL_Analyze:qksan.c@4776:qksanPostAnalyzeDump(begin): qksanPostAnalyzeDump(): Dumping analyze context after compilation qksanStatus=SUCCESS ecode=0 2025-07-04 22:00:03.910685*:SQL_Analyze:qksan.c@4800:qksanPostAnalyzeDump(end): 2025-07-04 22:00:03.910685*:SQL_Analyze:qksan.c@3690:qksanAnalyzeSql(end): exit: ecode=0 status=0 2025-07-04 22:00:03.988603 :AD937C5E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-04 22:00:05.911563 :AD937E06:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-04 22:00:05.911576 :AD937E07:db_trace:ktur.c@3079:ktuabt(): [10444:30:241] ABORT TRANSACTION - xid: 0x0008.01c.0000ce09 2025-07-04 22:00:08.343968 :AD937F34:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-04 22:00:08.345343 :AD937F3C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-04 22:00:08.355944 :AD937F6C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-04 22:00:08.381784 :AD937F74:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-04 22:00:09.558036 :AD93806D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:jslv.c:9203 2025-07-04 22:00:09.571211 :AD93806E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:0] KSL POST SENT postee=59 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-04 22:00:09.572793 :AD938076:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-07-04 23:59:02.630094 :AD9D2D26:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 07-04 23:59:02.622 2025-07-04 23:59:02.630096 :AD9D2D27:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=16120 pso_num=30 pso_serial#=90 2025-07-04 23:59:02.630232 :AD9D2D28:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=16120 (legacy spawn) 2025-07-04 23:59:02.644853 :AD9D2D29:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-04 23:59:02.645028 :AD9D2D32:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] 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-07-04 23:59:02.645830 :AD9D2D33:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-07-04 23:59:02.654386 :AD9D2D36:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 07-04 23:59:02.653 2025-07-04 23:59:02.654388 :AD9D2D37:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=7952 pso_num=30 pso_serial#=91 2025-07-04 23:59:02.654529 :AD9D2D38:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=7952 (legacy spawn) 2025-07-04 23:59:02.660993 :AD9D2D39:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-04 23:59:02.661159 :AD9D2D42:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] 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-07-04 23:59:02.661943 :AD9D2D43:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-07-04 23:59:05.698852 :AD9D2E4F:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 07-04 23:59:05.685 2025-07-04 23:59:05.698854 :AD9D2E50:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=4688 pso_num=30 pso_serial#=92 2025-07-04 23:59:05.699003 :AD9D2E51:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=4688 (legacy spawn) 2025-07-04 23:59:05.705919 :AD9D2E52:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-04 23:59:05.706107 :AD9D2E57:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] 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-07-04 23:59:05.707006 :AD9D2E5C:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-07-04 23:59:05.716075 :AD9D2E5F:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 07-04 23:59:05.700 2025-07-04 23:59:05.716077 :AD9D2E60:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=18332 pso_num=30 pso_serial#=93 2025-07-04 23:59:05.716267 :AD9D2E61:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=18332 (legacy spawn) 2025-07-04 23:59:05.733830 :AD9D2E6E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-04 23:59:05.734016 :AD9D2E77:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] 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-07-04 23:59:05.734938 :AD9D2E78:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-07-04 23:59:05.883670 :AD9D2E8E:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 07-04 23:59:05.872 2025-07-04 23:59:05.883672 :AD9D2E8F:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=15012 pso_num=30 pso_serial#=94 2025-07-04 23:59:05.883807 :AD9D2E90:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=15012 (legacy spawn) 2025-07-04 23:59:05.898373 :AD9D2E91:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-04 23:59:39.150803 :AD9D3A29:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-07-04 23:59:42.722942 :AD9D3BB2:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 07-04 23:59:42.719 2025-07-04 23:59:42.722944 :AD9D3BB3:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=15704 pso_num=30 pso_serial#=95 2025-07-04 23:59:42.723112 :AD9D3BB4:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=15704 (legacy spawn) 2025-07-04 23:59:42.737316 :AD9D3BB5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-05 00:00:15.981410 :AD9D472E:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-07-05 00:01:17.268178 :AD9D6029:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 07-05 00:01:17.255 2025-07-05 00:01:17.268180 :AD9D602A:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=13888 pso_num=30 pso_serial#=96 2025-07-05 00:01:17.268329 :AD9D602B:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=13888 osp_idx=28 osp_ver=1370 osp_pg=0 (spawn #352776) 2025-07-05 00:01:17.268330 :AD9D602C:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-05 00:01:17.268330 :AD9D602D:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=103 time=354453158 2025-07-05 00:01:17.268331 :AD9D602E:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-07-05 00:01:17.268331 :AD9D602F:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-07-05 00:01:17.268332 :AD9D6030:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-07-05 00:01:17.268332 :AD9D6031:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-05 00:01:17.268332 :AD9D6032:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-05 00:01:17.268896 :AD9D6033:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-05 00:01:17.268938 :AD9D6039:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] 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-07-05 00:01:17.276875 :AD9D604B:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-07-05 01:00:25.731437 :ADA1FEC4:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 07-05 01:00:25.718 2025-07-05 01:00:25.731439 :ADA1FEC5:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=7628 pso_num=30 pso_serial#=97 2025-07-05 01:00:25.731570 :ADA1FEC6:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=7628 osp_idx=28 osp_ver=1371 osp_pg=0 (spawn #352912) 2025-07-05 01:00:25.731571 :ADA1FEC7:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-05 01:00:25.731572 :ADA1FEC8:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=104 time=358001611 2025-07-05 01:00:25.731572 :ADA1FEC9:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-07-05 01:00:25.731572 :ADA1FECA:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-07-05 01:00:25.731573 :ADA1FECB:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-07-05 01:00:25.731573 :ADA1FECC:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-05 01:00:25.731573 :ADA1FECD:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-05 01:00:25.732072 :ADA1FECE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-05 01:00:25.732116 :ADA1FED4:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] 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-07-05 01:00:25.739614 :ADA1FF27:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-05 01:00:25.740660 :ADA1FF2F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-05 01:00:25.741201 :ADA1FF37:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-05 01:00:25.741734 :ADA1FF3F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-05 01:00:25.742170 :ADA1FF47:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-05 01:00:25.744613 :ADA1FF4F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-05 01:00:25.745766 :ADA1FF57:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-05 01:00:25.795600 :ADA1FF6A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-05 01:00:25.796514 :ADA1FF72:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-05 01:00:25.796758 :ADA1FF7A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-05 01:00:25.796971 :ADA1FF82:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-05 01:00:25.798754 :ADA1FF8A:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-07-05 06:00:01.219456 :ADB9691B:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 07-05 06:00:01.205 2025-07-05 06:00:01.219457 :ADB9691C:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=14052 pso_num=30 pso_serial#=98 2025-07-05 06:00:01.219592 :ADB9692E:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=14052 osp_idx=28 osp_ver=1372 osp_pg=0 (spawn #353610) 2025-07-05 06:00:01.219593 :ADB9692F:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-05 06:00:01.219594 :ADB96930:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=105 time=375977111 2025-07-05 06:00:01.219594 :ADB96931:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-07-05 06:00:01.219595 :ADB96932:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-07-05 06:00:01.219595 :ADB96933:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-07-05 06:00:01.219595 :ADB96934:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-05 06:00:01.219596 :ADB96935:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-05 06:00:01.220399 :ADB9693E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-05 06:00:01.225740 :ADB96953:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-05 06:00:01.225770 :ADB96956:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:jslv.c:9203 2025-07-05 06:00:01.231061 :ADB969A1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-05 06:00:01.386051 :ADB96C88:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-05 06:00:01.536274 :ADB96C90:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-05 06:00:01.667920 :ADB96CD1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-05 06:00:02.792688 :ADB96F1E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-05 06:00:02.793662 :ADB96F26:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-05 06:00:02.796953 :ADB96F2E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-05 06:00:02.800645 :ADB96F36:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-05 06:00:02.816948 :ADB96F3E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-05 06:00:02.817661 :ADB96F46:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-05 06:00:02.818186 :ADB96F4E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-05 06:00:02.818680 :ADB96F56:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-05 06:00:02.821305 :ADB96F5E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-05 06:00:02.822241 :ADB96F66:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-07-05 06:00:02.823004 :ADB96F67:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-07-05 06:00:02.823747 :ADB96F68:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-07-05 06:00:02.824145 :ADB96F69:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-07-05 06:00:02.824151 :ADB96F6A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-07-05 06:00:02.824669 :ADB96F6B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-07-05 06:00:02.825226 :ADB96F6C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-07-05 06:00:02.825504 :ADB96F6D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-07-05 06:00:02.826527 :ADB96F6E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-07-05 06:00:02.870517 :ADB96F6F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-05 06:00:02.870564 :ADB96F72:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-07-05 06:00:02.871434 :ADB96F78:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-05 06:00:02.872305 :ADB96F80:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-07-05 06:00:02.872726 :ADB96F81:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-05 06:00:02.893004 :ADB96F89:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-05 06:00:02.893053 :ADB96F8C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-07-05 06:00:02.893929 :ADB96F92:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-05 06:00:02.894831 :ADB96F9A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-07-05 06:00:02.895267 :ADB96F9B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-05 06:00:02.915087 :ADB96FA3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-05 06:00:02.915136 :ADB96FA6:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-07-05 06:00:02.915988 :ADB96FAC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-05 06:00:02.916433 :ADB96FB4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-05 06:00:02.916798 :ADB96FBC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-05 06:00:02.916976 :ADB96FC4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-05 06:00:02.917111 :ADB96FCC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-05 06:00:02.917248 :ADB96FD4:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:jslv.c:9203 2025-07-05 06:00:02.921260 :ADB96FD5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-05 06:00:02.921338 :ADB96FD8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 2025-07-05 06:00:02.921425 :ADB96FE5:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] 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-07-05 06:00:33.006323 :ADB97FFE:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-07-05 22:07:10.945400 :AE085143:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 07-05 22:07:10.934 2025-07-05 22:07:10.945401 :AE085144:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=16996 pso_num=30 pso_serial#=99 2025-07-05 22:07:10.946430 :AE085145:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=16996 osp_idx=28 osp_ver=1373 osp_pg=0 (spawn #355850) 2025-07-05 22:07:10.946431 :AE085146:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-05 22:07:10.946432 :AE085147:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=106 time=434006814 2025-07-05 22:07:10.946433 :AE085148:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-07-05 22:07:10.946433 :AE085149:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-07-05 22:07:10.946434 :AE08514A:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-07-05 22:07:10.946434 :AE08514B:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-05 22:07:10.946434 :AE08514C:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-05 22:07:10.951844 :AE08514D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-05 22:07:10.951893 :AE085153:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] 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-07-05 22:07:10.952354 :AE085154:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-07-05 22:07:13.256119 :AE085261:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 07-05 22:07:13.256 2025-07-05 22:07:13.256121 :AE085262:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=11212 pso_num=30 pso_serial#=100 2025-07-05 22:07:13.256296 :AE085263:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=11212 osp_idx=28 osp_ver=1374 osp_pg=0 (spawn #355852) 2025-07-05 22:07:13.256297 :AE085264:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-05 22:07:13.256297 :AE085265:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=107 time=434009142 2025-07-05 22:07:13.256298 :AE085266:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-07-05 22:07:13.256298 :AE085267:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-07-05 22:07:13.256299 :AE085268:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-07-05 22:07:13.256299 :AE085269:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-05 22:07:13.256299 :AE08526A:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-05 22:07:13.256933 :AE08526B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-05 22:07:13.256977 :AE085271:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] 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-07-05 22:07:13.257388 :AE085272:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 30 (osid: 11212, M001)