Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250703220552\orcl_j005_17692_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:36986M/63366M, Ph+PgF:42946M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 31 Windows thread id: 17692, image: ORACLE.EXE (J005) *** 2025-07-03 22:05:52.255 *** 2025-07-03 22:05:52.255 Process diagnostic dump for ORACLE.EXE (J005), OS id=17692, pid: 31, proc_ser: 105, 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-03 22:05:52.255 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 31 (osid: 17692, J005) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-06-29 16:00:20.704691 :AB4676DA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 16:00:20.704702 :AB4676DB:db_trace:ktur.c@3079:ktuabt(): [10444:31:249] ABORT TRANSACTION - xid: 0x000a.009.00170690 2025-06-29 16:00:20.705044 :AB4676E3:db_trace:ktu.c@4871:ktuaex1r(): [10442:31:249] Extension usn 10, ext 1, nex 4 2025-06-29 16:00:20.705051 :AB4676E4:db_trace:ktusm.c@2117:ktusmasp(): [10445:31:249] des1:tsn:1 rdba:0x008159ed where: ktspbwh1: ktspfsrch 2025-06-29 16:00:21.780793*:AB467758:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000002DC74678 estart=1751184020 eid=16779586 ctx=0x000000077BA4B1C8 cwh=0x000000002DCA1530 cpu=484375 buffg=0 interb=0 r=0 rb=0 w=0 wb=0 2025-06-29 16:00:21.780793*:AB467759:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000002DC74678 curCtx=0x000000002DCAAFE8 pubTabIdxCnt=0 2025-06-29 16:00:21.780793*:AB46775A:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000002DC74678 2025-06-29 16:00:21.780793*:AB46775B:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000002DC74678 2025-06-29 16:00:21.780793*:AB46775C:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000002DCBDA98 estart=1751184020 eid=16779572 ctx=0x0000000787AD5BF0 cwh=0x000000002DC60AA0 cpu=484375 buffg=0 interb=0 r=0 rb=0 w=0 wb=0 2025-06-29 16:00:21.780793*:AB46775D:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000002DCBDA98 curCtx=0x0000000029960EB8 pubTabIdxCnt=0 2025-06-29 16:00:21.780793*:AB46775E:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000002DCBDA98 2025-06-29 16:00:21.780793*:AB46775F:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000002DCBDA98 2025-06-29 16:00:21.843291*:AB467760:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000002DC74678 curCtx=0x000000002DCAAFE8 xsc->flg4=65792 flags=1 2025-06-29 16:00:21.843291*:AB467761:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000002DC74678 2025-06-29 16:00:21.843291*:AB467762:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000002DCBDA98 curCtx=0x0000000029960EB8 xsc->flg4=65792 flags=2 2025-06-29 16:00:21.843291*:AB467763:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000002DCBDA98 2025-06-29 16:00:21.920601 :AB467764:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 16:00:21.956518 :AB467778:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 16:00:21.956840 :AB467780:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 16:00:21.957119 :AB467788:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 16:00:21.957136 :AB46778B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=18 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 16:00:21.957195 :AB467799:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-29 16:00:21.959855 :AB4677A5:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-29 19:00:43.438726 :AB547EAF:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-29 19:00:43.427 2025-06-29 19:00:43.438728 :AB547EB0:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=6984 pso_num=31 pso_serial#=88 2025-06-29 19:00:43.438882 :AB547EB1:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=6984 osp_idx=29 osp_ver=597 osp_pg=0 (spawn #335424) 2025-06-29 19:00:43.438883 :AB547EB2:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-29 19:00:43.438883 :AB547EB3:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=183 time=4199386625 2025-06-29 19:00:43.438884 :AB547EB4:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-06-29 19:00:43.438885 :AB547EB5:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-06-29 19:00:43.438885 :AB547EB6:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-06-29 19:00:43.438886 :AB547EB7:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-29 19:00:43.438886 :AB547EB8:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-29 19:00:43.439380 :AB547EBC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-29 19:00:43.439424 :AB547EC2:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-29 19:00:43.448524 :AB547ED4:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-29 20:00:50.457736 :AB592BB6:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-29 20:00:50.448 2025-06-29 20:00:50.457739 :AB592BB7:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=18080 pso_num=31 pso_serial#=89 2025-06-29 20:00:50.457879 :AB592BB8:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=18080 osp_idx=29 osp_ver=598 osp_pg=0 (spawn #335562) 2025-06-29 20:00:50.457880 :AB592BB9:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-29 20:00:50.457881 :AB592BBA:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=184 time=4202993641 2025-06-29 20:00:50.457881 :AB592BBB:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-06-29 20:00:50.457882 :AB592BBC:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-06-29 20:00:50.457882 :AB592BBD:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-06-29 20:00:50.457882 :AB592BBE:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-29 20:00:50.457883 :AB592BBF:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-29 20:00:50.458406 :AB592BC0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-29 20:00:50.458444 :AB592BC6:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-29 20:00:50.467353 :AB592BDB:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-29 21:00:57.902278 :AB5DD6C8:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-29 21:00:57.892 2025-06-29 21:00:57.902280 :AB5DD6C9:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=14108 pso_num=31 pso_serial#=90 2025-06-29 21:00:57.902424 :AB5DD6CA:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=14108 osp_idx=29 osp_ver=599 osp_pg=0 (spawn #335700) 2025-06-29 21:00:57.902425 :AB5DD6CB:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-29 21:00:57.902426 :AB5DD6CC:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=185 time=4206601094 2025-06-29 21:00:57.902426 :AB5DD6CD:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-06-29 21:00:57.902426 :AB5DD6CE:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-06-29 21:00:57.902427 :AB5DD6CF:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-06-29 21:00:57.902427 :AB5DD6D0:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-29 21:00:57.902427 :AB5DD6D1:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-29 21:00:57.903016 :AB5DD6D5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-29 21:00:57.903058 :AB5DD6DB:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-29 21:00:57.912306 :AB5DD6F8:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-29 23:59:10.077800 :AB6BD7E2:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-29 23:59:10.068 2025-06-29 23:59:10.077802 :AB6BD7E3:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=16012 pso_num=31 pso_serial#=91 2025-06-29 23:59:10.077947 :AB6BD7E4:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=16012 (legacy spawn) 2025-06-29 23:59:10.092533 :AB6BD7E5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 23:59:13.185062 :AB6BD91C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 23:59:13.185243 :AB6BD921:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-29 23:59:13.186436 :AB6BD926:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-29 23:59:13.351015 :AB6BD929:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-29 23:59:13.349 2025-06-29 23:59:13.351016 :AB6BD92A:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=6652 pso_num=31 pso_serial#=92 2025-06-29 23:59:13.351160 :AB6BD92B:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=6652 (legacy spawn) 2025-06-29 23:59:13.365489 :AB6BD92C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 23:59:46.545072 :AB6BE50A:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-29 23:59:55.028845 :AB6BE864:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-29 23:59:55.018 2025-06-29 23:59:55.028847 :AB6BE865:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=1168 pso_num=31 pso_serial#=93 2025-06-29 23:59:55.028987 :AB6BE866:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=1168 (legacy spawn) 2025-06-29 23:59:55.042650 :AB6BE867:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 23:59:58.179731 :AB6BE956:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 23:59:58.179920 :AB6BE95B:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-29 23:59:58.181092 :AB6BE960:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-29 23:59:58.400486 :AB6BE964:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-29 23:59:58.393 2025-06-29 23:59:58.400488 :AB6BE965:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=7880 pso_num=31 pso_serial#=94 2025-06-29 23:59:58.400628 :AB6BE966:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=7880 (legacy spawn) 2025-06-29 23:59:58.415004 :AB6BE967:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-30 00:06:18.380043 :AB6C746A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-30 00:06:18.380215 :AB6C746F:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-30 00:06:18.381314 :AB6C7474:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-30 22:00:01.601197 :ABD35203:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-30 22:00:01.598 2025-06-30 22:00:01.601197 :ABD35204:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=8032 pso_num=31 pso_serial#=95 2025-06-30 22:00:01.601326 :ABD35205:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=8032 osp_idx=29 osp_ver=604 osp_pg=0 (spawn #339177) 2025-06-30 22:00:01.601327 :ABD35206:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-30 22:00:01.601328 :ABD35207:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=186 time=1577486 2025-06-30 22:00:01.601328 :ABD35208:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-06-30 22:00:01.601328 :ABD35209:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-06-30 22:00:01.601329 :ABD3520A:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-06-30 22:00:01.601329 :ABD3520B:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-30 22:00:01.601330 :ABD3520C:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-30 22:00:01.601857 :ABD3521E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-30 22:00:31.719185 :ABD36540:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-30 23:59:17.220097 :ABDD54DE:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-30 23:59:17.209 2025-06-30 23:59:17.220099 :ABDD54DF:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=18200 pso_num=31 pso_serial#=96 2025-06-30 23:59:17.220225 :ABDD54E0:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=18200 osp_idx=29 osp_ver=605 osp_pg=0 (spawn #339457) 2025-06-30 23:59:17.220225 :ABDD54E1:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-30 23:59:17.220226 :ABDD54E2:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=187 time=8733111 2025-06-30 23:59:17.220226 :ABDD54E3:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-06-30 23:59:17.220227 :ABDD54E4:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-06-30 23:59:17.220227 :ABDD54E5:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-06-30 23:59:17.220227 :ABDD54E6:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-30 23:59:17.220227 :ABDD54E7:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-30 23:59:17.220761 :ABDD54E8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-30 23:59:47.276202 :ABDD5F6A:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-30 23:59:52.087007 :ABDD6155:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-30 23:59:52.085 2025-06-30 23:59:52.087010 :ABDD6156:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=15516 pso_num=31 pso_serial#=97 2025-06-30 23:59:52.087146 :ABDD6157:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=15516 (legacy spawn) 2025-06-30 23:59:52.101254 :ABDD6158:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-01 00:00:25.153059 :ABDD6FD8:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-07-01 22:00:00.510726 :AC4243E4:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 07-01 22:00:00.507 2025-07-01 22:00:00.510727 :AC4243E5:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=9584 pso_num=31 pso_serial#=98 2025-07-01 22:00:00.510851 :AC4243E6:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=9584 osp_idx=29 osp_ver=607 osp_pg=0 (spawn #342504) 2025-07-01 22:00:00.510852 :AC4243E8:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-01 22:00:00.510852 :AC4243E9:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=188 time=87976392 2025-07-01 22:00:00.510853 :AC4243EA:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-07-01 22:00:00.510853 :AC4243EB:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-07-01 22:00:00.510853 :AC4243EC:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-07-01 22:00:00.510854 :AC4243ED:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-01 22:00:00.510854 :AC4243EE:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-01 22:00:00.511447 :AC4243FF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-01 22:00:30.559286 :AC4255B4:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-07-01 23:59:18.205497 :AC4BFEB3:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 07-01 23:59:18.205 2025-07-01 23:59:18.205499 :AC4BFEB4:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=2648 pso_num=31 pso_serial#=99 2025-07-01 23:59:18.205641 :AC4BFEB5:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=2648 (legacy spawn) 2025-07-01 23:59:18.220327 :AC4BFEB6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-01 23:59:51.406055 :AC4C0B1F:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-07-01 23:59:55.023387 :AC4C0C32:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 07-01 23:59:55.021 2025-07-01 23:59:55.023389 :AC4C0C33:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=4292 pso_num=31 pso_serial#=100 2025-07-01 23:59:55.023526 :AC4C0C34:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=4292 (legacy spawn) 2025-07-01 23:59:55.038290 :AC4C0C35:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-02 00:00:28.132001 :AC4C1AAA:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-07-02 22:00:02.083464 :ACB29315:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 07-02 22:00:02.077 2025-07-02 22:00:02.083467 :ACB29316:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=15440 pso_num=31 pso_serial#=101 2025-07-02 22:00:02.083657 :ACB29317:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=15440 osp_idx=29 osp_ver=610 osp_pg=0 (spawn #345834) 2025-07-02 22:00:02.083658 :ACB29318:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-02 22:00:02.083659 :ACB29319:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=189 time=174377954 2025-07-02 22:00:02.083660 :ACB2931A:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-07-02 22:00:02.083660 :ACB2931B:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-07-02 22:00:02.083660 :ACB2931C:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-07-02 22:00:02.083661 :ACB2931D:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-02 22:00:02.083661 :ACB2931E:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-02 22:00:02.084415 :ACB2931F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-02 22:00:32.174891 :ACB2A768:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-07-02 23:59:18.404521 :ACBC6F09:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 07-02 23:59:18.391 2025-07-02 23:59:18.404523 :ACBC6F0A:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=13548 pso_num=31 pso_serial#=102 2025-07-02 23:59:18.404675 :ACBC6F0B:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=13548 (legacy spawn) 2025-07-02 23:59:18.420106 :ACBC6F0C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-02 23:59:51.721890 :ACBC7B5C:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-07-02 23:59:55.747826 :ACBC7C74:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 07-02 23:59:55.745 2025-07-02 23:59:55.747828 :ACBC7C75:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=11032 pso_num=31 pso_serial#=103 2025-07-02 23:59:55.747972 :ACBC7C76:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=11032 (legacy spawn) 2025-07-02 23:59:55.762657 :ACBC7C77:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-03 00:00:28.807596 :ACBC89B4:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-07-03 01:00:19.193361 :ACC13BBC:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 07-03 01:00:19.191 2025-07-03 01:00:19.193362 :ACC13BBD:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=15208 pso_num=31 pso_serial#=104 2025-07-03 01:00:19.193499 :ACC13BBE:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=15208 osp_idx=29 osp_ver=613 osp_pg=0 (spawn #346254) 2025-07-03 01:00:19.193500 :ACC13BBF:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-03 01:00:19.193501 :ACC13BC0:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=190 time=185195079 2025-07-03 01:00:19.193501 :ACC13BC1:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-07-03 01:00:19.193501 :ACC13BC2:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-07-03 01:00:19.193502 :ACC13BC3:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-07-03 01:00:19.193502 :ACC13BC4:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-03 01:00:19.193502 :ACC13BC5:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-03 01:00:19.194005 :ACC13BC6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-03 01:00:19.194051 :ACC13BCC:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-03 01:00:19.202365 :ACC13BDE:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-07-03 22:00:02.060195 :AD227BA2:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 07-03 22:00:02.051 2025-07-03 22:00:02.060196 :AD227BA3:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=17692 pso_num=31 pso_serial#=105 2025-07-03 22:00:02.060334 :AD227BA4:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=17692 osp_idx=29 osp_ver=614 osp_pg=0 (spawn #349164) 2025-07-03 22:00:02.060335 :AD227BA5:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-03 22:00:02.060335 :AD227BA6:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=191 time=260777954 2025-07-03 22:00:02.060335 :AD227BA7:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-07-03 22:00:02.060336 :AD227BA8:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-07-03 22:00:02.060337 :AD227BA9:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-07-03 22:00:02.060337 :AD227BAA:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-03 22:00:02.060337 :AD227BAB:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-03 22:00:02.061313 :AD227BAC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-03 22:00:32.154160 :AD228D62:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 31 (osid: 17692, J005)