Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250427140926\orcl_m000_8224_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:37563M/63366M, Ph+PgF:45232M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 29 Windows thread id: 8224, image: ORACLE.EXE (M000) *** 2025-04-27 14:09:26.440 *** 2025-04-27 14:09:26.440 Process diagnostic dump for ORACLE.EXE (M000), OS id=8224, pid: 29, proc_ser: 99, 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-04-27 14:09:26.440 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 29 (osid: 8224, M000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-04-27 09:01:10.492009 :8F646DAE:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 09:01:10.492010 :8F646DAF:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 09:01:10.492010 :8F646DB0:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 09:01:10.492010 :8F646DB1:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 09:01:10.492010 :8F646DB2:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 09:01:10.492444 :8F646DB3: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-04-27 09:01:10.492474 :8F646DBF: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-04-27 09:01:10.499167 :8F646DC6:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-04-27 10:01:12.222832 :8F694088:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 04-27 10:01:12.217 2025-04-27 10:01:12.222834 :8F694089:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=6948 pso_num=29 pso_serial#=81 2025-04-27 10:01:12.222977 :8F69408A:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=6948 osp_idx=27 osp_ver=9770 osp_pg=0 (spawn #123310) 2025-04-27 10:01:12.222978 :8F69408B:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-27 10:01:12.222979 :8F69408C:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=91 time=3018874015 2025-04-27 10:01:12.222979 :8F69408D:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 10:01:12.222979 :8F69408E:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 10:01:12.222980 :8F69408F:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 10:01:12.222980 :8F694090:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 10:01:12.222980 :8F694091:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 10:01:12.223469 :8F694092: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-04-27 10:01:12.223509 :8F694099: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-04-27 10:01:12.230223 :8F6940A6:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-04-27 10:08:53.296187 :8F69EA39:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 04-27 10:08:53.293 2025-04-27 10:08:53.296189 :8F69EA3A:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=6028 pso_num=29 pso_serial#=82 2025-04-27 10:08:53.297332 :8F69EA3B:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=6028 (legacy spawn) 2025-04-27 10:08:53.329783 :8F69EA59: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-04-27 10:08:53.329955 :8F69EA5E: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-04-27 10:08:53.330862 :8F69EA63:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-04-27 10:08:53.350501 :8F69EA66:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 04-27 10:08:53.340 2025-04-27 10:08:53.350503 :8F69EA67:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=10380 pso_num=29 pso_serial#=83 2025-04-27 10:08:53.350637 :8F69EA68:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=10380 (legacy spawn) 2025-04-27 10:08:53.357106 :8F69EA69: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-04-27 10:08:53.357263 :8F69EA72: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-04-27 10:08:53.358077 :8F69EA73:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-04-27 10:08:55.188287 :8F69EB00:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 04-27 10:08:55.184 2025-04-27 10:08:55.188289 :8F69EB01:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=10408 pso_num=29 pso_serial#=84 2025-04-27 10:08:55.188425 :8F69EB02:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=10408 osp_idx=27 osp_ver=9773 osp_pg=0 (spawn #123333) 2025-04-27 10:08:55.188426 :8F69EB03:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-27 10:08:55.188426 :8F69EB04:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=92 time=3019336984 2025-04-27 10:08:55.188427 :8F69EB05:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 10:08:55.188427 :8F69EB06:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 10:08:55.188427 :8F69EB07:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 10:08:55.188429 :8F69EB08:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 10:08:55.188430 :8F69EB09:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 10:08:55.188931 :8F69EB0A: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-04-27 10:08:55.188978 :8F69EB11: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-04-27 10:08:55.335663 :8F69EB3B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-27 10:08:55.336035 :8F69EB4E:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-04-27 10:08:56.488548 :8F69EC90:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 04-27 10:08:56.481 2025-04-27 10:08:56.488550 :8F69EC91:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=9784 pso_num=29 pso_serial#=85 2025-04-27 10:08:56.488682 :8F69EC92:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=9784 (legacy spawn) 2025-04-27 10:08:56.495207 :8F69EC99: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-04-27 10:08:56.495360 :8F69EC9E: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-04-27 10:08:56.496137 :8F69ECA3:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-04-27 10:08:56.504720 :8F69ECAA:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 04-27 10:08:56.496 2025-04-27 10:08:56.504722 :8F69ECAB:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=10400 pso_num=29 pso_serial#=86 2025-04-27 10:08:56.504855 :8F69ECAC:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=10400 (legacy spawn) 2025-04-27 10:08:56.511275 :8F69ECB1: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-04-27 10:08:56.511428 :8F69ECBA: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-04-27 10:08:56.512187 :8F69ECBB:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-04-27 13:00:06.032091 :8F77AB9C:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 04-27 13:00:06.024 2025-04-27 13:00:06.032094 :8F77AB9D:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=5940 pso_num=29 pso_serial#=87 2025-04-27 13:00:06.032226 :8F77AB9E:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=5940 (legacy spawn) 2025-04-27 13:00:06.038763 :8F77AB9F: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-04-27 13:00:06.038946 :8F77ABA8: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-04-27 13:00:06.039958 :8F77ABA9:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-04-27 13:00:10.430331 :8F77AD2B:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 04-27 13:00:10.424 2025-04-27 13:00:10.430333 :8F77AD2C:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=9508 pso_num=29 pso_serial#=88 2025-04-27 13:00:10.430465 :8F77AD2D:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=9508 osp_idx=27 osp_ver=9777 osp_pg=0 (spawn #123732) 2025-04-27 13:00:10.430466 :8F77AD2E:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-27 13:00:10.430466 :8F77AD2F:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=93 time=3029612218 2025-04-27 13:00:10.430466 :8F77AD30:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 13:00:10.430467 :8F77AD31:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 13:00:10.430467 :8F77AD32:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 13:00:10.430467 :8F77AD33:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 13:00:10.430468 :8F77AD34:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 13:00:10.430969 :8F77AD35: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-04-27 13:00:10.431014 :8F77AD3B: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-04-27 13:00:10.435504 :8F77AD4F: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-04-27 13:00:10.461399 :8F77AD57:db_trace:ksb.c@6610:ksbcic_int(): [10254:29:233] KSBCIC: (USER) starting cic on opcode KSBCIRCO [1] with args (1 4286502095 8465201) 2025-04-27 13:00:10.461408 :8F77AD58:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=15 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-27 13:00:10.461446 :8F77AD63:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=15 loc='ksa2.h LINE:286 ID:ksasnr' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-04-27 13:00:10.461497 :8F77AD70: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-04-27 13:00:10.475908 :8F77AD78: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-04-27 13:00:10.500647 :8F77AD80: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-04-27 13:00:10.504373 :8F77AD88: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-04-27 13:00:10.508147 :8F77AD90: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-04-27 13:00:10.513397 :8F77AD98: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-04-27 13:00:10.514433 :8F77ADA0: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-04-27 13:00:11.689548*:8F77AE2B:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000029A2A2D0 estart=1745730010 eid=16778062 ctx=0x000000077BA4B1C8 cwh=0x0000000029950AF8 cpu=546875 buffg=0 interb=0 r=0 rb=0 w=0 wb=0 2025-04-27 13:00:11.689548*:8F77AE2C:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000029A2A2D0 curCtx=0x0000000029A29008 pubTabIdxCnt=0 2025-04-27 13:00:11.689548*:8F77AE2D:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000029A2A2D0 2025-04-27 13:00:11.689548*:8F77AE2E:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000029A2A2D0 2025-04-27 13:00:11.689548*:8F77AE2F:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000029998AD8 estart=1745730010 eid=16778057 ctx=0x0000000787AD5BF0 cwh=0x0000000029950410 cpu=546875 buffg=0 interb=0 r=0 rb=0 w=0 wb=0 2025-04-27 13:00:11.689548*:8F77AE30:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000029998AD8 curCtx=0x0000000029A2B270 pubTabIdxCnt=0 2025-04-27 13:00:11.689548*:8F77AE31:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000029998AD8 2025-04-27 13:00:11.689548*:8F77AE32:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000029998AD8 2025-04-27 13:00:11.689548*:8F77AE33:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000029A2A2D0 curCtx=0x0000000029A29008 xsc->flg4=65792 flags=1 2025-04-27 13:00:11.689548*:8F77AE34:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000029A2A2D0 2025-04-27 13:00:11.689548*:8F77AE35:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000029998AD8 curCtx=0x0000000029A2B270 xsc->flg4=65792 flags=2 2025-04-27 13:00:11.689548*:8F77AE36:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000029998AD8 2025-04-27 13:00:11.757422 :8F77AE37: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-04-27 13:00:11.809008 :8F77AE4B: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-04-27 13:00:11.809348 :8F77AE61: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-04-27 13:00:11.809630 :8F77AE69: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-04-27 13:00:11.809646 :8F77AE6C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-27 13:00:11.809705 :8F77AE79: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-04-27 13:00:11.812480 :8F77AE85:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-04-27 13:00:18.811285 :8F77B1FE:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 04-27 13:00:18.798 2025-04-27 13:00:18.811287 :8F77B1FF:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=580 pso_num=29 pso_serial#=89 2025-04-27 13:00:18.811420 :8F77B200:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=580 (legacy spawn) 2025-04-27 13:00:18.817950 :8F77B201: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-04-27 13:00:18.818124 :8F77B206: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-04-27 13:00:18.818969 :8F77B20B:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-04-27 13:00:18.827595 :8F77B20E:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 04-27 13:00:18.824 2025-04-27 13:00:18.827598 :8F77B20F:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=3508 pso_num=29 pso_serial#=90 2025-04-27 13:00:18.827733 :8F77B210:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=3508 (legacy spawn) 2025-04-27 13:00:18.834149 :8F77B211: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-04-27 13:00:18.834316 :8F77B21A: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-04-27 13:00:18.835120 :8F77B21B:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-04-27 13:00:27.103990 :8F77B4F5:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 04-27 13:00:27.089 2025-04-27 13:00:27.103992 :8F77B4F6:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=7192 pso_num=29 pso_serial#=91 2025-04-27 13:00:27.104128 :8F77B4F7:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=7192 (legacy spawn) 2025-04-27 13:00:27.122550 :8F77B4F8: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-04-27 13:00:27.122728 :8F77B501: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-04-27 13:00:27.123555 :8F77B502:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-04-27 13:00:27.132081 :8F77B505:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 04-27 13:00:27.120 2025-04-27 13:00:27.132083 :8F77B506:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=10276 pso_num=29 pso_serial#=92 2025-04-27 13:00:27.132245 :8F77B507:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=10276 (legacy spawn) 2025-04-27 13:00:27.138631 :8F77B508: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-04-27 13:00:27.138793 :8F77B511: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-04-27 13:00:27.139625 :8F77B512:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-04-27 13:00:28.326594 :8F77B521:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 04-27 13:00:28.318 2025-04-27 13:00:28.326596 :8F77B522:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=8028 pso_num=29 pso_serial#=93 2025-04-27 13:00:28.326731 :8F77B523:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=8028 (legacy spawn) 2025-04-27 13:00:28.333143 :8F77B524: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-04-27 13:00:28.333319 :8F77B529: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-04-27 13:00:28.334117 :8F77B52E:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-04-27 13:00:28.498770 :8F77B554:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 04-27 13:00:28.490 2025-04-27 13:00:28.498772 :8F77B555:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=2180 pso_num=29 pso_serial#=94 2025-04-27 13:00:28.498903 :8F77B556:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=2180 (legacy spawn) 2025-04-27 13:00:28.505328 :8F77B557: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-04-27 13:00:28.505503 :8F77B560: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-04-27 13:00:28.506318 :8F77B561:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-04-27 13:00:30.201011 :8F77B622:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 04-27 13:00:30.187 2025-04-27 13:00:30.201013 :8F77B623:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=11060 pso_num=29 pso_serial#=95 2025-04-27 13:00:30.201150 :8F77B624:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=11060 (legacy spawn) 2025-04-27 13:00:30.207519 :8F77B625: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-04-27 13:00:30.207548 :8F77B628: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-04-27 13:00:30.207710 :8F77B630: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-04-27 13:00:30.208504 :8F77B63C:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-04-27 13:00:30.217179 :8F77B63F:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 04-27 13:00:30.203 2025-04-27 13:00:30.217181 :8F77B640:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=10472 pso_num=29 pso_serial#=96 2025-04-27 13:00:30.217322 :8F77B641:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=10472 (legacy spawn) 2025-04-27 13:00:30.239310 :8F77B642: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-04-27 13:00:30.239484 :8F77B64B: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-04-27 13:00:30.240275 :8F77B64C:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-04-27 14:09:25.516015 :8F7D4AD1:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 04-27 14:09:25.503 2025-04-27 14:09:25.516017 :8F7D4AD2:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=10944 pso_num=29 pso_serial#=97 2025-04-27 14:09:25.516155 :8F7D4AD3:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=10944 (legacy spawn) 2025-04-27 14:09:25.522595 :8F7D4AD4: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-04-27 14:09:25.522757 :8F7D4AD9: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-04-27 14:09:25.523566 :8F7D4ADE:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-04-27 14:09:25.542569 :8F7D4AE1:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 04-27 14:09:25.534 2025-04-27 14:09:25.542571 :8F7D4AE2:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=10268 pso_num=29 pso_serial#=98 2025-04-27 14:09:25.542698 :8F7D4AE3:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=10268 (legacy spawn) 2025-04-27 14:09:25.549142 :8F7D4AE4: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-04-27 14:09:25.549305 :8F7D4AED: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-04-27 14:09:25.550130 :8F7D4AEE:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-04-27 14:09:25.570060 :8F7D4B0D:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 04-27 14:09:25.565 2025-04-27 14:09:25.570062 :8F7D4B0E:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=8224 pso_num=29 pso_serial#=99 2025-04-27 14:09:25.570188 :8F7D4B0F:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=8224 osp_idx=27 osp_ver=9788 osp_pg=0 (spawn #123898) 2025-04-27 14:09:25.570188 :8F7D4B10:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-27 14:09:25.570189 :8F7D4B11:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=94 time=3033767359 2025-04-27 14:09:25.570189 :8F7D4B12:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 14:09:25.570190 :8F7D4B13:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 14:09:25.570190 :8F7D4B14:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 14:09:25.570190 :8F7D4B15:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 14:09:25.570191 :8F7D4B16:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 14:09:25.570670 :8F7D4B17: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-04-27 14:09:25.570717 :8F7D4B1E: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-04-27 14:09:25.730514 :8F7D4B55:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-27 14:09:25.730891 :8F7D4B68: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: 8224, M000)