Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250516220403\orcl_ora_6844_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:37410M/63366M, Ph+PgF:44634M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 29 Windows thread id: 6844, image: ORACLE.EXE (SHAD) *** 2025-05-16 22:04:03.646 *** 2025-05-16 22:04:03.646 Process diagnostic dump for ORACLE.EXE (SHAD), OS id=6844, pid: 29, proc_ser: 83, 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-05-16 22:04:03.646 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 29 (osid: 6844) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-16 01:42:33.662945 :97A41130:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-16 01:42:33.662946 :97A41131:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=111 time=335563532 2025-05-16 01:42:33.662946 :97A41132:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-16 01:42:33.662946 :97A41133:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-16 01:42:33.662947 :97A41134:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-16 01:42:33.662947 :97A41135:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-16 01:42:33.662947 :97A41136:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-16 01:42:33.663479 :97A41137: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-05-16 01:42:33.663530 :97A4113D: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-05-16 01:42:33.667554 :97A41166:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-16 01:42:33.667596 :97A41167:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-16 01:42:33.667858 :97A41168:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-16 01:42:33.667874 :97A41169:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-16 01:42:33.668095 :97A4116A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-16 01:42:33.668108 :97A4116B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-16 01:42:33.668312 :97A4116C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-16 01:42:33.668324 :97A4116D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-16 01:42:33.668531 :97A4116E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-16 01:42:33.668543 :97A4116F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-16 01:42:33.668743 :97A41170:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-16 01:42:33.668756 :97A41171:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-16 01:42:33.671106 :97A41172:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-16 21:00:10.062471 :97FF2FEF:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-16 21:00:10.060 2025-05-16 21:00:10.062473 :97FF2FF0:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=13000 pso_num=29 pso_serial#=74 2025-05-16 21:00:10.062608 :97FF2FF1:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=13000 osp_idx=27 osp_ver=11038 osp_pg=0 (spawn #189016) 2025-05-16 21:00:10.062609 :97FF2FF2:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-16 21:00:10.062610 :97FF2FF3:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=112 time=405019922 2025-05-16 21:00:10.062611 :97FF2FF4:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-16 21:00:10.062612 :97FF2FF5:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-16 21:00:10.062612 :97FF2FF6:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-16 21:00:10.062612 :97FF2FF7:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-16 21:00:10.062613 :97FF2FF8:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-16 21:00:10.063162 :97FF2FF9: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-05-16 21:00:10.063204 :97FF2FFF: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-05-16 21:00:10.071630 :97FF3034:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-16 22:00:00.918105 :9803D797:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-16 22:00:00.911 2025-05-16 22:00:00.918106 :9803D798:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=7880 pso_num=29 pso_serial#=75 2025-05-16 22:00:00.918249 :9803D79F:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=7880 osp_idx=27 osp_ver=11039 osp_pg=0 (spawn #189155) 2025-05-16 22:00:00.918249 :9803D7A0:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-16 22:00:00.918250 :9803D7A1:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=113 time=408610782 2025-05-16 22:00:00.918250 :9803D7A2:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-16 22:00:00.918251 :9803D7A3:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-16 22:00:00.918252 :9803D7A4:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-16 22:00:00.918253 :9803D7A5:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-16 22:00:00.918253 :9803D7A6:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-16 22:00:00.918741 :9803D7A7: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-05-16 22:00:00.923726 :9803D7C6: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-05-16 22:00:00.923764 :9803D7C9:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:jslv.c:9203 2025-05-16 22:00:00.942069 :9803D9A3: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-05-16 22:00:00.942316 :9803D9AB: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-05-16 22:00:00.942474 :9803D9B3: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-05-16 22:00:00.942650 :9803D9BB: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-05-16 22:00:00.942804 :9803D9C3: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-05-16 22:00:00.942954 :9803D9CB: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-05-16 22:00:00.943101 :9803D9D3: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-05-16 22:00:00.943255 :9803D9DB: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-05-16 22:00:00.943403 :9803D9E3: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-05-16 22:00:00.943547 :9803D9EB: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-05-16 22:00:00.943740 :9803D9F3: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-05-16 22:00:00.944072 :9803D9FB: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-05-16 22:00:00.944221 :9803DA03: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-05-16 22:00:00.944394 :9803DA0B: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-05-16 22:00:00.944547 :9803DA13: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-05-16 22:00:00.944704 :9803DA1B: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-05-16 22:00:00.944857 :9803DA23: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-05-16 22:00:00.945009 :9803DA2B: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-05-16 22:00:00.945163 :9803DA33: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-05-16 22:00:00.945312 :9803DA3B: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-05-16 22:00:00.945464 :9803DA43: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-05-16 22:00:00.945608 :9803DA4B: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-05-16 22:00:00.945747 :9803DA53: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-05-16 22:00:00.966112 :9803DA5B: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-05-16 22:00:02.155573*:9803DD1B:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x00000000318F3AD0 estart=1747404002 eid=18432376 ctx=0x0000000777968158 cwh=0x00000000319209C8 cpu=0 buffg=2 interb=0 r=0 rb=0 w=0 wb=0 2025-05-16 22:00:02.155573*:9803DD1C:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x00000000318F3AD0 curCtx=0x000000003C637918 pubTabIdxCnt=0 2025-05-16 22:00:02.155573*:9803DD1D:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x00000000318F3AD0 2025-05-16 22:00:02.155573*:9803DD1E:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x00000000318F3AD0 2025-05-16 22:00:02.155573*:9803DD1F:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000003196B6F0 estart=1747404000 eid=16777325 ctx=0x000000077B54EAC8 cwh=0x0000000031920518 cpu=1000000 buffg=56614 interb=204800 r=25 rb=204800 w=0 wb=0 2025-05-16 22:00:02.155573*:9803DD20:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000003196B6F0 curCtx=0x000000003C5187D0 pubTabIdxCnt=0 2025-05-16 22:00:02.155573*:9803DD21:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000003196B6F0 2025-05-16 22:00:02.155573*:9803DD22:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000003196B6F0 2025-05-16 22:00:02.155573*:9803DD24:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x00000000318F3AD0 curCtx=0x000000003C637918 xsc->flg4=65792 flags=1 2025-05-16 22:00:02.155573*:9803DD26:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x00000000318F3AD0 2025-05-16 22:00:02.639951*:9803DE13:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000003196B6F0 curCtx=0x000000003C5187D0 xsc->flg4=65792 flags=2 2025-05-16 22:00:02.639951*:9803DE14:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000003196B6F0 2025-05-16 22:00:02.648269 :9803DE15: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-05-16 22:00:02.668951 :9803DE37: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-05-16 22:00:02.670839 :9803DE3F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:psdpgi.c:2235 2025-05-16 22:00:02.671041 :9803DE40:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:psdpgi.c:2235 2025-05-16 22:00:02.672089 :9803DE41: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-05-16 22:00:02.672184 :9803DE44: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-05-16 22:00:02.673123 :9803DE56: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-05-16 22:00:02.674623 :9803DE5E: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-05-16 22:00:02.674906 :9803DE66: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-05-16 22:00:02.733697*:SQL_Analyze:qksan.c@3402:qksanAnalyzeSql(begin): qksanAnalyzeSql(enter): goal=15 options=16778048 pgadep=0 binds#=0 byPos=0 timeLim=0 timeFired=0 2025-05-16 22:00:02.733697*:SQL_Analyze:qksan.c@936:qksanBindSql(begin): binding for SQL analyze 2025-05-16 22:00:02.733697*:SQL_Analyze:qksan.c@1344:qksanBindSql(end): Done binding: status=0 ret=0 bind#=0 byPos=1 wasBoundP=0x0000000000000000 bindIndP=0x0000000000000000 2025-05-16 22:00:02.733697*:SQL_Analyze:qksan.c@6338:qksanAvgExecStats(): The number of total executions: 1 and execution count: 0 2025-05-16 22:00:02.733697*:SQL_Analyze:qksan.c@4776:qksanPostAnalyzeDump(begin): qksanPostAnalyzeDump(): Dumping analyze context after compilation qksanStatus=SUCCESS ecode=0 2025-05-16 22:00:02.733697*:SQL_Analyze:qksan.c@4800:qksanPostAnalyzeDump(end): 2025-05-16 22:00:02.733697*:SQL_Analyze:qksan.c@3690:qksanAnalyzeSql(end): exit: ecode=0 status=0 2025-05-16 22:00:02.806916 :9803DEB9: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-05-16 22:00:04.705359 :9803E03B: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-05-16 22:00:04.705371 :9803E03C:db_trace:ktur.c@3079:ktuabt(): [10444:29:233] ABORT TRANSACTION - xid: 0x0009.012.0001c74a 2025-05-16 22:00:07.123090 :9803E1C1: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-05-16 22:00:07.125325 :9803E1C9: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-05-16 22:00:07.136785 :9803E1D1: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-05-16 22:00:07.161070 :9803E1F0: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-05-16 22:00:08.326243 :9803E2F0:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:jslv.c:9203 2025-05-16 22:00:08.337850 :9803E2F1: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-05-16 22:00:08.338327 :9803E2F9:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-16 22:00:08.740788 :9803E34E:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-16 22:00:08.733 2025-05-16 22:00:08.740790 :9803E34F:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=10576 pso_num=29 pso_serial#=76 2025-05-16 22:00:08.740928 :9803E350:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=10576 (legacy spawn) 2025-05-16 22:00:08.765320 :9803E365: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-05-16 22:00:08.765476 :9803E36E: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-05-16 22:00:08.766299 :9803E36F:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-16 22:00:18.250149 :9803E7CC:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-16 22:00:18.245 2025-05-16 22:00:18.250151 :9803E7CD:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=9552 pso_num=29 pso_serial#=77 2025-05-16 22:00:18.250287 :9803E7CE:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=9552 osp_idx=27 osp_ver=11041 osp_pg=0 (spawn #189158) 2025-05-16 22:00:18.250287 :9803E7CF:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-16 22:00:18.250288 :9803E7D0:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=114 time=408628125 2025-05-16 22:00:18.250288 :9803E7D1:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-16 22:00:18.250289 :9803E7D2:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-16 22:00:18.250289 :9803E7D3:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-16 22:00:18.250289 :9803E7D4:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-16 22:00:18.250290 :9803E7D5:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-16 22:00:18.250785 :9803E7D6: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-05-16 22:00:18.250843 :9803E7DC: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-05-16 22:00:18.271250 :9803E850:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-16 22:00:19.648489 :9803E915:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-16 22:00:19.638 2025-05-16 22:00:19.648491 :9803E916:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=10448 pso_num=29 pso_serial#=78 2025-05-16 22:00:19.648621 :9803E917:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=10448 osp_idx=27 osp_ver=11042 osp_pg=0 (spawn #189161) 2025-05-16 22:00:19.648622 :9803E918:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-16 22:00:19.648622 :9803E919:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=115 time=408629516 2025-05-16 22:00:19.648623 :9803E91A:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-16 22:00:19.648623 :9803E91B:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-16 22:00:19.648623 :9803E91C:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-16 22:00:19.648624 :9803E91D:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-16 22:00:19.648624 :9803E91E:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-16 22:00:19.649116 :9803E91F: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-05-16 22:00:19.649161 :9803E925: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-05-16 22:00:19.656833 :9803E933: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-05-16 22:00:19.657929 :9803E93B: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-05-16 22:00:19.658581 :9803E943: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-05-16 22:00:19.659072 :9803E94B: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-05-16 22:00:19.659528 :9803E953: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-05-16 22:00:19.661921 :9803E95B: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-05-16 22:00:19.663072 :9803E963: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-05-16 22:00:19.712158 :9803E96B: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-05-16 22:00:19.713070 :9803E973: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-05-16 22:00:19.713310 :9803E97B: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-05-16 22:00:19.713525 :9803E983: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-05-16 22:00:19.715250 :9803E98B:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-16 22:00:20.786826 :9803E9DA:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-16 22:00:20.778 2025-05-16 22:00:20.786828 :9803E9DB:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=11708 pso_num=29 pso_serial#=79 2025-05-16 22:00:20.786969 :9803E9DC:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=11708 (legacy spawn) 2025-05-16 22:00:20.793482 :9803E9DD: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-05-16 22:00:20.793659 :9803E9E6: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-05-16 22:00:20.794480 :9803E9E7:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-16 22:00:23.125272 :9803EA8D:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-16 22:00:23.111 2025-05-16 22:00:23.125274 :9803EA8E:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=13132 pso_num=29 pso_serial#=80 2025-05-16 22:00:23.125411 :9803EA8F:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=13132 (legacy spawn) 2025-05-16 22:00:23.131917 :9803EA90: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-05-16 22:00:23.132091 :9803EA95: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-05-16 22:00:23.132898 :9803EA9A:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-16 22:00:23.141519 :9803EA9D:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-16 22:00:23.127 2025-05-16 22:00:23.141521 :9803EA9E:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=12852 pso_num=29 pso_serial#=81 2025-05-16 22:00:23.141660 :9803EA9F:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=12852 (legacy spawn) 2025-05-16 22:00:23.148237 :9803EAA0: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-05-16 22:00:23.148411 :9803EAA9: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-05-16 22:00:23.149200 :9803EAAA:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-16 22:00:26.311489 :9803EBD0:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-16 22:00:26.298 2025-05-16 22:00:26.311491 :9803EBD1:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=12148 pso_num=29 pso_serial#=82 2025-05-16 22:00:26.311626 :9803EBD2:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=12148 (legacy spawn) 2025-05-16 22:00:26.318069 :9803EBD3: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-05-16 22:00:26.318235 :9803EBD8: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-05-16 22:00:26.319013 :9803EBDD:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-16 22:00:26.327820 :9803EBE0:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-16 22:00:26.314 2025-05-16 22:00:26.327822 :9803EBE1:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=6844 pso_num=29 pso_serial#=83 2025-05-16 22:00:26.327962 :9803EBE2:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=6844 (legacy spawn) 2025-05-16 22:00:26.349786 :9803EBE3: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-05-16 22:00:26.349944 :9803EBEC: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-05-16 22:00:26.350752 :9803EBED: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: 6844)