Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250522220955\orcl_ora_11896_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:37351M/63366M, Ph+PgF:44419M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 32 Windows thread id: 11896, image: ORACLE.EXE (SHAD) *** 2025-05-22 22:09:55.623 *** 2025-05-22 22:09:55.623 Process diagnostic dump for ORACLE.EXE (SHAD), OS id=11896, pid: 32, proc_ser: 123, 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-22 22:09:55.623 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 32 (osid: 11896) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-17 23:59:11.105929 :987FC571:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-17 23:59:11.093 2025-05-17 23:59:11.105931 :987FC572:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=14252 pso_num=32 pso_serial#=102 2025-05-17 23:59:11.106073 :987FC573:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=14252 (legacy spawn) 2025-05-17 23:59:11.112540 :987FC574:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 23:59:11.112707 :987FC579:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-17 23:59:11.113508 :987FC57E:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-17 23:59:11.122130 :987FC581:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-17 23:59:11.109 2025-05-17 23:59:11.122131 :987FC582:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=12684 pso_num=32 pso_serial#=103 2025-05-17 23:59:11.122268 :987FC583:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=12684 (legacy spawn) 2025-05-17 23:59:11.128740 :987FC584:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 23:59:11.128775 :987FC587:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 23:59:11.128934 :987FC58E:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-17 23:59:11.129740 :987FC59B:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-17 23:59:13.960970 :987FC69C:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-17 23:59:13.953 2025-05-17 23:59:13.960973 :987FC69D:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=11480 pso_num=32 pso_serial#=104 2025-05-17 23:59:13.961108 :987FC69E:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=11480 (legacy spawn) 2025-05-17 23:59:13.975064 :987FC69F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 23:59:47.032873 :987FD2C8:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-17 23:59:47.171630 :987FD2CB:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-17 23:59:47.171 2025-05-17 23:59:47.171632 :987FD2CC:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=11600 pso_num=32 pso_serial#=105 2025-05-17 23:59:47.171773 :987FD2CD:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=11600 (legacy spawn) 2025-05-17 23:59:47.185414 :987FD2CE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-18 00:00:20.235525 :987FDE30:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-18 23:59:11.356806 :98F32817:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-18 23:59:11.348 2025-05-18 23:59:11.356808 :98F32818:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=12432 pso_num=32 pso_serial#=106 2025-05-18 23:59:11.356942 :98F32819:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=12432 (legacy spawn) 2025-05-18 23:59:11.363472 :98F3281A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-18 23:59:11.363501 :98F3281D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-18 23:59:11.363659 :98F32820:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-18 23:59:11.364457 :98F32831:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-18 23:59:14.201144 :98F32943:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-18 23:59:14.191 2025-05-18 23:59:14.201146 :98F32944:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=6428 pso_num=32 pso_serial#=107 2025-05-18 23:59:14.201282 :98F32945:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=6428 (legacy spawn) 2025-05-18 23:59:14.215382 :98F32946:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-18 23:59:47.365171 :98F3357B:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-18 23:59:55.204065 :98F3388D:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-18 23:59:55.189 2025-05-18 23:59:55.204068 :98F3388E:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=13704 pso_num=32 pso_serial#=108 2025-05-18 23:59:55.204217 :98F3388F:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=13704 (legacy spawn) 2025-05-18 23:59:55.211053 :98F33890:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-18 23:59:55.211269 :98F33898:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-18 23:59:55.212398 :98F3389A:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-18 23:59:55.228934 :98F3389D:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-18 23:59:55.220 2025-05-18 23:59:55.228936 :98F3389E:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=13436 pso_num=32 pso_serial#=109 2025-05-18 23:59:55.229154 :98F3389F:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=13436 (legacy spawn) 2025-05-18 23:59:55.235981 :98F338A0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-18 23:59:55.236167 :98F338A9:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-18 23:59:55.237094 :98F338B5:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-18 23:59:59.156709 :98F339FA:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-18 23:59:59.154 2025-05-18 23:59:59.156710 :98F339FB:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=13528 pso_num=32 pso_serial#=110 2025-05-18 23:59:59.156846 :98F339FC:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=13528 (legacy spawn) 2025-05-18 23:59:59.170580 :98F339FD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 00:06:19.141804 :98F3C537:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 00:06:19.142000 :98F3C53C:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-19 00:06:19.143221 :98F3C541:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-19 22:00:05.373559 :995BD883:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-19 22:00:05.367 2025-05-19 22:00:05.373561 :995BD884:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=13820 pso_num=32 pso_serial#=111 2025-05-19 22:00:05.373696 :995BD885:db_trace:kso.c@4093:ksonfy(): [10420:32:0] kso: new process: pid=13820 osp_idx=30 osp_ver=365 osp_pg=0 (spawn #199180) 2025-05-19 22:00:05.373697 :995BD886:db_trace:kso.c@4099:ksonfy(): [10420:32:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-19 22:00:05.373697 :995BD887:db_trace:kso.c@4103:ksonfy(): [10420:32:0] kso: new process: pso_index=32 reservation=100 time=667815235 2025-05-19 22:00:05.373698 :995BD888:db_trace:kso.c@4109:ksonfy(): [10420:32:0] kso: spawn diagnostics: queue time=0 secs 2025-05-19 22:00:05.373698 :995BD889:db_trace:kso.c@4111:ksonfy(): [10420:32:0] kso: spawn diagnostics: fork time=0 secs 2025-05-19 22:00:05.373699 :995BD88A:db_trace:kso.c@4113:ksonfy(): [10420:32:0] kso: spawn diagnostics: exec time=0 secs 2025-05-19 22:00:05.373699 :995BD88B:db_trace:kso.c@4115:ksonfy(): [10420:32:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-19 22:00:05.373699 :995BD88C:db_trace:kso.c@4117:ksonfy(): [10420:32:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-19 22:00:05.374190 :995BD88D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-19 22:00:05.374238 :995BD893:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-19 22:00:05.378789 :995BD8A8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:05.403825 :995BD8D5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:05.418554 :995BD8EE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:05.446264 :995BD903:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:05.450499 :995BD90B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:05.454320 :995BD913:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:05.458803 :995BD91B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:05.459961 :995BD923:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:06.517665*:995BD96A:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000034594FC8 estart=1747663205 eid=16778602 ctx=0x000000077BA4B1C8 cwh=0x0000000034580500 cpu=437500 buffg=0 interb=0 r=0 rb=0 w=0 wb=0 2025-05-19 22:00:06.517665*:995BD96B:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000034594FC8 curCtx=0x000000003462F9B8 pubTabIdxCnt=0 2025-05-19 22:00:06.517665*:995BD96C:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000034594FC8 2025-05-19 22:00:06.517665*:995BD96D:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000034594FC8 2025-05-19 22:00:06.517665*:995BD96E:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000034591560 estart=1747663205 eid=16778594 ctx=0x0000000787AD5BF0 cwh=0x00000000345807D0 cpu=437500 buffg=0 interb=0 r=0 rb=0 w=0 wb=0 2025-05-19 22:00:06.517665*:995BD96F:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000034591560 curCtx=0x0000000034632058 pubTabIdxCnt=0 2025-05-19 22:00:06.517665*:995BD970:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000034591560 2025-05-19 22:00:06.517665*:995BD971:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000034591560 2025-05-19 22:00:06.625744*:995BD985:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000034594FC8 curCtx=0x000000003462F9B8 xsc->flg4=65792 flags=1 2025-05-19 22:00:06.625744*:995BD986:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000034594FC8 2025-05-19 22:00:06.625744*:995BD987:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000034591560 curCtx=0x0000000034632058 xsc->flg4=65792 flags=2 2025-05-19 22:00:06.625744*:995BD988:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000034591560 2025-05-19 22:00:06.710238 :995BD9E8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:06.754695 :995BD9F0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:06.755058 :995BD9F8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:06.755329 :995BDA00:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:06.755345 :995BDA03:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=18 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:06.755426 :995BDA15:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-19 22:00:06.758359 :995BDA1D:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-19 23:59:22.155858 :9965A4F3:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-19 23:59:22.151 2025-05-19 23:59:22.155860 :9965A4F4:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=9872 pso_num=32 pso_serial#=112 2025-05-19 23:59:22.156004 :9965A4F5:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=9872 (legacy spawn) 2025-05-19 23:59:22.170154 :9965A4F6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 23:59:55.291961 :9965B113:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-19 23:59:58.917775 :9965B230:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-19 23:59:58.908 2025-05-19 23:59:58.917777 :9965B231:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=13400 pso_num=32 pso_serial#=113 2025-05-19 23:59:58.917922 :9965B232:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=13400 (legacy spawn) 2025-05-19 23:59:58.931754 :9965B233:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-20 00:06:18.892021 :99663B7C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-20 00:06:18.892183 :99663B85:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-20 00:06:18.893400 :99663B86:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-20 22:00:21.761229 :99CC9447:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-20 22:00:21.749 2025-05-20 22:00:21.761231 :99CC9448:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=1880 pso_num=32 pso_serial#=114 2025-05-20 22:00:21.761361 :99CC9449:db_trace:kso.c@4093:ksonfy(): [10420:32:0] kso: new process: pid=1880 osp_idx=30 osp_ver=368 osp_pg=0 (spawn #202512) 2025-05-20 22:00:21.761362 :99CC944A:db_trace:kso.c@4099:ksonfy(): [10420:32:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-20 22:00:21.761364 :99CC944B:db_trace:kso.c@4103:ksonfy(): [10420:32:0] kso: new process: pso_index=32 reservation=101 time=754231625 2025-05-20 22:00:21.761364 :99CC944C:db_trace:kso.c@4109:ksonfy(): [10420:32:0] kso: spawn diagnostics: queue time=0 secs 2025-05-20 22:00:21.761365 :99CC944D:db_trace:kso.c@4111:ksonfy(): [10420:32:0] kso: spawn diagnostics: fork time=0 secs 2025-05-20 22:00:21.761365 :99CC944E:db_trace:kso.c@4113:ksonfy(): [10420:32:0] kso: spawn diagnostics: exec time=0 secs 2025-05-20 22:00:21.761365 :99CC944F:db_trace:kso.c@4115:ksonfy(): [10420:32:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-20 22:00:21.761366 :99CC9450:db_trace:kso.c@4117:ksonfy(): [10420:32:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-20 22:00:21.761938 :99CC9451:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-20 22:00:21.761986 :99CC9457:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-20 22:00:21.769132 :99CC9465:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-20 22:00:21.770221 :99CC946D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-20 22:00:21.770712 :99CC9475:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-20 22:00:21.771152 :99CC947D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-20 22:00:21.771582 :99CC9485:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-20 22:00:21.774063 :99CC948D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-20 22:00:21.775171 :99CC9495:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-20 22:00:21.824042 :99CC949D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-20 22:00:21.824927 :99CC94A5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-20 22:00:21.825157 :99CC94AD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-20 22:00:21.825363 :99CC94B5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-20 22:00:21.827011 :99CC94BD:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-20 23:59:14.002171 :99D6397C:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-20 23:59:13.999 2025-05-20 23:59:14.002173 :99D6397D:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=13804 pso_num=32 pso_serial#=115 2025-05-20 23:59:14.002309 :99D6397E:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=13804 (legacy spawn) 2025-05-20 23:59:14.016356 :99D6397F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-20 23:59:47.329070 :99D64577:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-20 23:59:50.749307 :99D646D0:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-20 23:59:50.748 2025-05-20 23:59:50.749309 :99D646D1:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=11836 pso_num=32 pso_serial#=116 2025-05-20 23:59:50.749445 :99D646D2:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=11836 (legacy spawn) 2025-05-20 23:59:50.763529 :99D646D3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-21 00:00:24.112146 :99D651BF:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-21 23:59:12.456901 :9A4544A8:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-21 23:59:12.444 2025-05-21 23:59:12.456903 :9A4544A9:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=12436 pso_num=32 pso_serial#=117 2025-05-21 23:59:12.457041 :9A4544AA:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=12436 (legacy spawn) 2025-05-21 23:59:12.463579 :9A4544AB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-21 23:59:12.463747 :9A4544B0:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-21 23:59:12.464551 :9A4544B5:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-21 23:59:13.857520 :9A454505:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-21 23:59:13.850 2025-05-21 23:59:13.857522 :9A454506:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=13904 pso_num=32 pso_serial#=118 2025-05-21 23:59:13.857662 :9A454507:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=13904 (legacy spawn) 2025-05-21 23:59:13.864296 :9A454508:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-21 23:59:13.864474 :9A454510:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-21 23:59:13.865350 :9A454512:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-21 23:59:14.279289 :9A45452F:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-21 23:59:14.272 2025-05-21 23:59:14.279291 :9A454530:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=11608 pso_num=32 pso_serial#=119 2025-05-21 23:59:14.279424 :9A454531:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=11608 (legacy spawn) 2025-05-21 23:59:14.293217 :9A454532:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-21 23:59:47.478511 :9A4550C1:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-21 23:59:55.407525 :9A4553CE:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-21 23:59:55.394 2025-05-21 23:59:55.407527 :9A4553CF:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=11704 pso_num=32 pso_serial#=120 2025-05-21 23:59:55.407661 :9A4553D0:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=11704 (legacy spawn) 2025-05-21 23:59:55.414424 :9A4553D1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-21 23:59:55.414452 :9A4553D4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-21 23:59:55.414593 :9A4553DB:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-21 23:59:55.415376 :9A4553E8:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-21 23:59:55.424085 :9A4553EB:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-21 23:59:55.410 2025-05-21 23:59:55.424086 :9A4553EC:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=13876 pso_num=32 pso_serial#=121 2025-05-21 23:59:55.424223 :9A4553ED:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=13876 (legacy spawn) 2025-05-21 23:59:55.430931 :9A4553EE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-21 23:59:55.431094 :9A4553F3:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-21 23:59:55.431929 :9A4553F8:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-21 23:59:59.236301 :9A455511:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-21 23:59:59.228 2025-05-21 23:59:59.236302 :9A455512:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=13816 pso_num=32 pso_serial#=122 2025-05-21 23:59:59.236442 :9A455513:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=13816 (legacy spawn) 2025-05-21 23:59:59.250754 :9A455520:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-22 00:06:19.211966 :9A45DE3C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-22 00:06:19.212143 :9A45DE41:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-22 00:06:19.213201 :9A45DE46:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-05-22 22:00:03.040254 :9AAA42F6:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 05-22 22:00:03.027 2025-05-22 22:00:03.040255 :9AAA42F7:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=11896 pso_num=32 pso_serial#=123 2025-05-22 22:00:03.040384 :9AAA42F8:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=11896 (legacy spawn) 2025-05-22 22:00:03.047010 :9AAA4301:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-22 22:00:03.047160 :9AAA430A:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-22 22:00:03.047956 :9AAA430B:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 32 (osid: 11896)