Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250527220004\orcl_j001_13512_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:37287M/63366M, Ph+PgF:44260M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 33 Windows thread id: 13512, image: ORACLE.EXE (J001) *** 2025-05-27 22:00:04.872 *** 2025-05-27 22:00:04.872 Process diagnostic dump for ORACLE.EXE (J001), OS id=13512, pid: 33, proc_ser: 76, 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-27 22:00:04.872 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 33 (osid: 13512, J001) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-22 00:00:09.257637 :9A455E2C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:33:9] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-22 00:00:09.258350 :9A455E3B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:33:9] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-22 00:00:09.258843 :9A455E48:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:33:9] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-22 00:00:09.259740 :9A455E50:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:33:9] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-22 00:00:09.260332 :9A455E58:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:33:9] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-22 00:00:09.261075 :9A455E60:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:33:9] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-22 00:00:09.262263 :9A455E68:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:33:9] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-22 00:00:09.262370 :9A455E70:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:33:9] atxpus:psdpgi.c:2235 2025-05-22 00:00:09.262618 :9A455E71:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:33:9] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-22 00:00:09.262639 :9A455E74:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:33:9] atxpop:psdpgi.c:2235 2025-05-22 00:00:09.265001 :9A455E7A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:33:9] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-22 00:00:09.265136 :9A455E83:db_trace:ksl2.c@12699:ksliwat(): [10005:33:9] 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:00:39.334877 :9A456832:db_trace:kst.c@698:kstpsodel(): [10280:33:0] kst: process state object about to be deleted 2025-05-22 23:59:16.982006 :9AB3ED35:db_trace:kst.c@673:kstipg(): [10280:33:0] kst: process state object created on 05-22 23:59:16.973 2025-05-22 23:59:16.982008 :9AB3ED36:db_trace:kst.c@679:kstipg(): [10280:33:0] kst: process info: ospid=13616 pso_num=33 pso_serial#=56 2025-05-22 23:59:16.982152 :9AB3ED37:db_trace:kso.c@4070:ksonfy(): [10420:33:0] kso: new process: pid=13616 (legacy spawn) 2025-05-22 23:59:16.988877 :9AB3ED38:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:33:9] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-22 23:59:16.989068 :9AB3ED3D:db_trace:ksl2.c@12699:ksliwat(): [10005:33:9] 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 23:59:16.989910 :9AB3ED42:db_trace:kst.c@698:kstpsodel(): [10280:33:0] kst: process state object about to be deleted 2025-05-22 23:59:18.072146 :9AB3ED88:db_trace:kst.c@673:kstipg(): [10280:33:0] kst: process state object created on 05-22 23:59:18.069 2025-05-22 23:59:18.072148 :9AB3ED89:db_trace:kst.c@679:kstipg(): [10280:33:0] kst: process info: ospid=14056 pso_num=33 pso_serial#=57 2025-05-22 23:59:18.072275 :9AB3ED8A:db_trace:kso.c@4070:ksonfy(): [10420:33:0] kso: new process: pid=14056 (legacy spawn) 2025-05-22 23:59:18.096717 :9AB3ED8B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:33:9] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-22 23:59:21.408128 :9AB3EEFD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:33:9] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-22 23:59:21.408156 :9AB3EF00:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:33:9] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-22 23:59:21.408300 :9AB3EF06:db_trace:ksl2.c@12699:ksliwat(): [10005:33:9] 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 23:59:21.409630 :9AB3EF14:db_trace:kst.c@698:kstpsodel(): [10280:33:0] kst: process state object about to be deleted 2025-05-22 23:59:24.689595 :9AB3F033:db_trace:kst.c@673:kstipg(): [10280:33:0] kst: process state object created on 05-22 23:59:24.676 2025-05-22 23:59:24.689597 :9AB3F034:db_trace:kst.c@679:kstipg(): [10280:33:0] kst: process info: ospid=14216 pso_num=33 pso_serial#=58 2025-05-22 23:59:24.689738 :9AB3F035:db_trace:kso.c@4070:ksonfy(): [10420:33:0] kso: new process: pid=14216 (legacy spawn) 2025-05-22 23:59:24.696496 :9AB3F036:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:33:9] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-22 23:59:24.696665 :9AB3F03F:db_trace:ksl2.c@12699:ksliwat(): [10005:33:9] 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 23:59:24.697587 :9AB3F040:db_trace:kst.c@698:kstpsodel(): [10280:33:0] kst: process state object about to be deleted 2025-05-22 23:59:24.706672 :9AB3F043:db_trace:kst.c@673:kstipg(): [10280:33:0] kst: process state object created on 05-22 23:59:24.692 2025-05-22 23:59:24.706674 :9AB3F044:db_trace:kst.c@679:kstipg(): [10280:33:0] kst: process info: ospid=11988 pso_num=33 pso_serial#=59 2025-05-22 23:59:24.706807 :9AB3F045:db_trace:kso.c@4070:ksonfy(): [10420:33:0] kso: new process: pid=11988 (legacy spawn) 2025-05-22 23:59:24.713699 :9AB3F046:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:33:9] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-22 23:59:24.713884 :9AB3F04F:db_trace:ksl2.c@12699:ksliwat(): [10005:33:9] 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 23:59:24.714706 :9AB3F050:db_trace:kst.c@698:kstpsodel(): [10280:33:0] kst: process state object about to be deleted 2025-05-22 23:59:26.226407 :9AB3F0B7:db_trace:kst.c@673:kstipg(): [10280:33:0] kst: process state object created on 05-22 23:59:26.218 2025-05-22 23:59:26.226409 :9AB3F0B8:db_trace:kst.c@679:kstipg(): [10280:33:0] kst: process info: ospid=7736 pso_num=33 pso_serial#=60 2025-05-22 23:59:26.226545 :9AB3F0B9:db_trace:kso.c@4070:ksonfy(): [10420:33:0] kso: new process: pid=7736 (legacy spawn) 2025-05-22 23:59:26.240331 :9AB3F0BA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:33:9] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-22 23:59:29.587496 :9AB3F1B0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:33:9] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-22 23:59:29.603470 :9AB3F1B5:db_trace:ksl2.c@12699:ksliwat(): [10005:33:9] 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 23:59:29.604938 :9AB3F1BA:db_trace:kst.c@698:kstpsodel(): [10280:33:0] kst: process state object about to be deleted 2025-05-22 23:59:29.839478 :9AB3F1BD:db_trace:kst.c@673:kstipg(): [10280:33:0] kst: process state object created on 05-22 23:59:29.833 2025-05-22 23:59:29.839479 :9AB3F1BE:db_trace:kst.c@679:kstipg(): [10280:33:0] kst: process info: ospid=13284 pso_num=33 pso_serial#=61 2025-05-22 23:59:29.839618 :9AB3F1BF:db_trace:kso.c@4070:ksonfy(): [10420:33:0] kso: new process: pid=13284 (legacy spawn) 2025-05-22 23:59:29.853626 :9AB3F1C0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:33:9] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-23 00:00:02.902916 :9AB3FDA4:db_trace:kst.c@698:kstpsodel(): [10280:33:0] kst: process state object about to be deleted 2025-05-23 23:59:18.082841 :9B22612A:db_trace:kst.c@673:kstipg(): [10280:33:0] kst: process state object created on 05-23 23:59:18.076 2025-05-23 23:59:18.082843 :9B22612B:db_trace:kst.c@679:kstipg(): [10280:33:0] kst: process info: ospid=9360 pso_num=33 pso_serial#=62 2025-05-23 23:59:18.082973 :9B22612C:db_trace:kso.c@4070:ksonfy(): [10420:33:0] kso: new process: pid=9360 (legacy spawn) 2025-05-23 23:59:18.097335 :9B22612D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:33:9] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-23 23:59:51.182290 :9B226CCF:db_trace:kst.c@698:kstpsodel(): [10280:33:0] kst: process state object about to be deleted 2025-05-24 00:00:08.163513 :9B2272B1:db_trace:kst.c@673:kstipg(): [10280:33:0] kst: process state object created on 05-24 00:00:08.154 2025-05-24 00:00:08.163515 :9B2272B2:db_trace:kst.c@679:kstipg(): [10280:33:0] kst: process info: ospid=13780 pso_num=33 pso_serial#=63 2025-05-24 00:00:08.163650 :9B2272B3:db_trace:kso.c@4070:ksonfy(): [10420:33:0] kso: new process: pid=13780 (legacy spawn) 2025-05-24 00:00:08.170104 :9B2272B4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:33:9] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 00:00:08.170282 :9B2272B9:db_trace:ksl2.c@12699:ksliwat(): [10005:33:9] 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-24 00:00:08.171064 :9B2272BE:db_trace:kst.c@698:kstpsodel(): [10280:33:0] kst: process state object about to be deleted 2025-05-24 00:00:10.273356 :9B227362:db_trace:kst.c@673:kstipg(): [10280:33:0] kst: process state object created on 05-24 00:00:10.267 2025-05-24 00:00:10.273358 :9B227363:db_trace:kst.c@679:kstipg(): [10280:33:0] kst: process info: ospid=13572 pso_num=33 pso_serial#=64 2025-05-24 00:00:10.273494 :9B227364:db_trace:kso.c@4093:ksonfy(): [10420:33:0] kso: new process: pid=13572 osp_idx=31 osp_ver=318 osp_pg=0 (spawn #212777) 2025-05-24 00:00:10.273495 :9B227365:db_trace:kso.c@4099:ksonfy(): [10420:33:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-24 00:00:10.273495 :9B227366:db_trace:kso.c@4103:ksonfy(): [10420:33:0] kso: new process: pso_index=33 reservation=93 time=1020582532 2025-05-24 00:00:10.273496 :9B227367:db_trace:kso.c@4109:ksonfy(): [10420:33:0] kso: spawn diagnostics: queue time=0 secs 2025-05-24 00:00:10.273496 :9B227368:db_trace:kso.c@4111:ksonfy(): [10420:33:0] kso: spawn diagnostics: fork time=0 secs 2025-05-24 00:00:10.273496 :9B227369:db_trace:kso.c@4113:ksonfy(): [10420:33:0] kso: spawn diagnostics: exec time=0 secs 2025-05-24 00:00:10.273497 :9B22736A:db_trace:kso.c@4115:ksonfy(): [10420:33:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-24 00:00:10.273497 :9B22736B:db_trace:kso.c@4117:ksonfy(): [10420:33:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-24 00:00:10.273992 :9B22736C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:33:9] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-24 00:00:10.274041 :9B227372:db_trace:ksl2.c@12699:ksliwat(): [10005:33:9] 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-24 00:00:10.278483 :9B227385:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:33:9] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 00:00:10.302579 :9B22738D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:33:9] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 00:00:10.317555 :9B2273A1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:33:9] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 00:00:10.344241 :9B2273A9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:33:9] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 00:00:10.347833 :9B2273B1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:33:9] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 00:00:10.351526 :9B2273B9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:33:9] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 00:00:10.355860 :9B2273C1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:33:9] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 00:00:10.356849 :9B2273C9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:33:9] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 00:00:11.470065*:9B227443:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000002B4111F0 estart=1748016010 eid=16778700 ctx=0x000000077BA4B1C8 cwh=0x0000000029A50500 cpu=500000 buffg=0 interb=0 r=0 rb=0 w=0 wb=0 2025-05-24 00:00:11.470065*:9B227444:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000002B4111F0 curCtx=0x000000002B54F998 pubTabIdxCnt=0 2025-05-24 00:00:11.470065*:9B227445:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000002B4111F0 2025-05-24 00:00:11.470065*:9B227446:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000002B4111F0 2025-05-24 00:00:11.470065*:9B227447:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000002B41FCB8 estart=1748016010 eid=16778692 ctx=0x0000000787AD5BF0 cwh=0x0000000029A508C0 cpu=500000 buffg=0 interb=0 r=0 rb=0 w=0 wb=0 2025-05-24 00:00:11.470065*:9B227448:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000002B41FCB8 curCtx=0x000000002B412190 pubTabIdxCnt=0 2025-05-24 00:00:11.470065*:9B227449:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000002B41FCB8 2025-05-24 00:00:11.470065*:9B22744A:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000002B41FCB8 2025-05-24 00:00:11.532581*:9B227456:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000002B4111F0 curCtx=0x000000002B54F998 xsc->flg4=65792 flags=1 2025-05-24 00:00:11.532581*:9B227457:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000002B4111F0 2025-05-24 00:00:11.532581*:9B227458:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000002B41FCB8 curCtx=0x000000002B412190 xsc->flg4=65792 flags=2 2025-05-24 00:00:11.532581*:9B227459:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000002B41FCB8 2025-05-24 00:00:11.600022 :9B22745A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:33:9] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 00:00:11.629398 :9B227465:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:33:9] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 00:00:11.629730 :9B22746D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:33:9] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 00:00:11.630022 :9B227475:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:33:9] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 00:00:11.630040 :9B227478:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:33:9] KSL POST SENT postee=18 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 00:00:11.630138 :9B22748A:db_trace:ksl2.c@12699:ksliwat(): [10005:33:9] 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-24 00:00:11.633089 :9B227492:db_trace:kst.c@698:kstpsodel(): [10280:33:0] kst: process state object about to be deleted 2025-05-24 00:00:14.153614 :9B22760F:db_trace:kst.c@673:kstipg(): [10280:33:0] kst: process state object created on 05-24 00:00:14.142 2025-05-24 00:00:14.153615 :9B227610:db_trace:kst.c@679:kstipg(): [10280:33:0] kst: process info: ospid=13340 pso_num=33 pso_serial#=65 2025-05-24 00:00:14.153749 :9B227611:db_trace:kso.c@4093:ksonfy(): [10420:33:0] kso: new process: pid=13340 osp_idx=31 osp_ver=319 osp_pg=0 (spawn #212780) 2025-05-24 00:00:14.153749 :9B227612:db_trace:kso.c@4099:ksonfy(): [10420:33:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-24 00:00:14.153750 :9B227613:db_trace:kso.c@4103:ksonfy(): [10420:33:0] kso: new process: pso_index=33 reservation=94 time=1020586407 2025-05-24 00:00:14.153750 :9B227614:db_trace:kso.c@4109:ksonfy(): [10420:33:0] kso: spawn diagnostics: queue time=0 secs 2025-05-24 00:00:14.153750 :9B227615:db_trace:kso.c@4111:ksonfy(): [10420:33:0] kso: spawn diagnostics: fork time=0 secs 2025-05-24 00:00:14.153751 :9B227616:db_trace:kso.c@4113:ksonfy(): [10420:33:0] kso: spawn diagnostics: exec time=0 secs 2025-05-24 00:00:14.153751 :9B227617:db_trace:kso.c@4115:ksonfy(): [10420:33:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-24 00:00:14.153751 :9B227618:db_trace:kso.c@4117:ksonfy(): [10420:33:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-24 00:00:14.154247 :9B227619:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:33:9] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-24 00:00:44.231462 :9B2281B0:db_trace:kst.c@698:kstpsodel(): [10280:33:0] kst: process state object about to be deleted 2025-05-24 23:59:26.393387 :9B9238EC:db_trace:kst.c@673:kstipg(): [10280:33:0] kst: process state object created on 05-24 23:59:26.392 2025-05-24 23:59:26.393389 :9B9238ED:db_trace:kst.c@679:kstipg(): [10280:33:0] kst: process info: ospid=10660 pso_num=33 pso_serial#=66 2025-05-24 23:59:26.393529 :9B9238EE:db_trace:kso.c@4070:ksonfy(): [10420:33:0] kso: new process: pid=10660 (legacy spawn) 2025-05-24 23:59:26.407809 :9B9238EF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:33:9] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 23:59:59.568261 :9B9244ED:db_trace:kst.c@698:kstpsodel(): [10280:33:0] kst: process state object about to be deleted 2025-05-25 00:00:01.420983 :9B9245A4:db_trace:kst.c@673:kstipg(): [10280:33:0] kst: process state object created on 05-25 00:00:01.407 2025-05-25 00:00:01.420985 :9B9245A5:db_trace:kst.c@679:kstipg(): [10280:33:0] kst: process info: ospid=10824 pso_num=33 pso_serial#=67 2025-05-25 00:00:01.421123 :9B9245A6:db_trace:kso.c@4070:ksonfy(): [10420:33:0] kso: new process: pid=10824 (legacy spawn) 2025-05-25 00:00:01.427565 :9B9245A7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:33:9] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-25 00:00:01.427738 :9B9245AC:db_trace:ksl2.c@12699:ksliwat(): [10005:33:9] 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-25 00:00:01.428531 :9B9245B1:db_trace:kst.c@698:kstpsodel(): [10280:33:0] kst: process state object about to be deleted 2025-05-25 00:00:01.448734 :9B9245B4:db_trace:kst.c@673:kstipg(): [10280:33:0] kst: process state object created on 05-25 00:00:01.439 2025-05-25 00:00:01.448736 :9B9245B5:db_trace:kst.c@679:kstipg(): [10280:33:0] kst: process info: ospid=11216 pso_num=33 pso_serial#=68 2025-05-25 00:00:01.448882 :9B9245B6:db_trace:kso.c@4070:ksonfy(): [10420:33:0] kso: new process: pid=11216 (legacy spawn) 2025-05-25 00:00:01.455639 :9B9245B7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:33:9] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-25 00:00:01.455884 :9B9245BF:db_trace:ksl2.c@12699:ksliwat(): [10005:33:9] 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-25 00:00:01.456970 :9B9245C1:db_trace:kst.c@698:kstpsodel(): [10280:33:0] kst: process state object about to be deleted 2025-05-25 23:59:17.895213 :9C02E9E0:db_trace:kst.c@673:kstipg(): [10280:33:0] kst: process state object created on 05-25 23:59:17.892 2025-05-25 23:59:17.895215 :9C02E9E1:db_trace:kst.c@679:kstipg(): [10280:33:0] kst: process info: ospid=14788 pso_num=33 pso_serial#=69 2025-05-25 23:59:17.895362 :9C02E9E2:db_trace:kso.c@4070:ksonfy(): [10420:33:0] kso: new process: pid=14788 (legacy spawn) 2025-05-25 23:59:17.909273 :9C02E9E3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:33:9] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-25 23:59:51.166463 :9C02F5ED:db_trace:kst.c@698:kstpsodel(): [10280:33:0] kst: process state object about to be deleted 2025-05-25 23:59:54.946306 :9C02F72E:db_trace:kst.c@673:kstipg(): [10280:33:0] kst: process state object created on 05-25 23:59:54.935 2025-05-25 23:59:54.946308 :9C02F72F:db_trace:kst.c@679:kstipg(): [10280:33:0] kst: process info: ospid=14508 pso_num=33 pso_serial#=70 2025-05-25 23:59:54.946450 :9C02F730:db_trace:kso.c@4070:ksonfy(): [10420:33:0] kso: new process: pid=14508 (legacy spawn) 2025-05-25 23:59:54.960823 :9C02F731:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:33:9] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 00:00:28.123263 :9C03031B:db_trace:kst.c@698:kstpsodel(): [10280:33:0] kst: process state object about to be deleted 2025-05-26 23:59:18.248656 :9C73AFCD:db_trace:kst.c@673:kstipg(): [10280:33:0] kst: process state object created on 05-26 23:59:18.248 2025-05-26 23:59:18.248659 :9C73AFCE:db_trace:kst.c@679:kstipg(): [10280:33:0] kst: process info: ospid=14716 pso_num=33 pso_serial#=71 2025-05-26 23:59:18.248797 :9C73AFCF:db_trace:kso.c@4070:ksonfy(): [10420:33:0] kso: new process: pid=14716 (legacy spawn) 2025-05-26 23:59:18.262837 :9C73AFD0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:33:9] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 23:59:21.524752 :9C73B0ED:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:33:9] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 23:59:21.524929 :9C73B0F3:db_trace:ksl2.c@12699:ksliwat(): [10005:33:9] 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-26 23:59:21.526109 :9C73B0F7:db_trace:kst.c@698:kstpsodel(): [10280:33:0] kst: process state object about to be deleted 2025-05-26 23:59:21.775578 :9C73B0FA:db_trace:kst.c@673:kstipg(): [10280:33:0] kst: process state object created on 05-26 23:59:21.764 2025-05-26 23:59:21.775580 :9C73B0FB:db_trace:kst.c@679:kstipg(): [10280:33:0] kst: process info: ospid=15304 pso_num=33 pso_serial#=72 2025-05-26 23:59:21.775721 :9C73B0FC:db_trace:kso.c@4070:ksonfy(): [10420:33:0] kso: new process: pid=15304 (legacy spawn) 2025-05-26 23:59:21.789993 :9C73B0FD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:33:9] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 23:59:54.954211 :9C73BCB0:db_trace:kst.c@698:kstpsodel(): [10280:33:0] kst: process state object about to be deleted 2025-05-26 23:59:59.817315 :9C73BE83:db_trace:kst.c@673:kstipg(): [10280:33:0] kst: process state object created on 05-26 23:59:59.804 2025-05-26 23:59:59.817317 :9C73BE84:db_trace:kst.c@679:kstipg(): [10280:33:0] kst: process info: ospid=13880 pso_num=33 pso_serial#=73 2025-05-26 23:59:59.817454 :9C73BE85:db_trace:kso.c@4070:ksonfy(): [10420:33:0] kso: new process: pid=13880 (legacy spawn) 2025-05-26 23:59:59.823923 :9C73BE86:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:33:9] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 23:59:59.824099 :9C73BE8F:db_trace:ksl2.c@12699:ksliwat(): [10005:33:9] 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-26 23:59:59.824895 :9C73BE90:db_trace:kst.c@698:kstpsodel(): [10280:33:0] kst: process state object about to be deleted 2025-05-26 23:59:59.833611 :9C73BE93:db_trace:kst.c@673:kstipg(): [10280:33:0] kst: process state object created on 05-26 23:59:59.819 2025-05-26 23:59:59.833613 :9C73BE94:db_trace:kst.c@679:kstipg(): [10280:33:0] kst: process info: ospid=12564 pso_num=33 pso_serial#=74 2025-05-26 23:59:59.833748 :9C73BE95:db_trace:kso.c@4070:ksonfy(): [10420:33:0] kso: new process: pid=12564 (legacy spawn) 2025-05-26 23:59:59.840508 :9C73BE96:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:33:9] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-26 23:59:59.840671 :9C73BE9F:db_trace:ksl2.c@12699:ksliwat(): [10005:33:9] 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-26 23:59:59.841468 :9C73BEA0:db_trace:kst.c@698:kstpsodel(): [10280:33:0] kst: process state object about to be deleted 2025-05-27 00:00:11.175710 :9C73C20C:db_trace:kst.c@673:kstipg(): [10280:33:0] kst: process state object created on 05-27 00:00:11.167 2025-05-27 00:00:11.175712 :9C73C20D:db_trace:kst.c@679:kstipg(): [10280:33:0] kst: process info: ospid=14832 pso_num=33 pso_serial#=75 2025-05-27 00:00:11.175848 :9C73C20E:db_trace:kso.c@4070:ksonfy(): [10420:33:0] kso: new process: pid=14832 (legacy spawn) 2025-05-27 00:00:11.182345 :9C73C20F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:33:9] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-27 00:00:11.182513 :9C73C214:db_trace:ksl2.c@12699:ksliwat(): [10005:33:9] 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-27 00:00:11.183327 :9C73C219:db_trace:kst.c@698:kstpsodel(): [10280:33:0] kst: process state object about to be deleted 2025-05-27 00:00:13.956826 :9C73C348:db_trace:kst.c@673:kstipg(): [10280:33:0] kst: process state object created on 05-27 00:00:13.946 2025-05-27 00:00:13.956828 :9C73C349:db_trace:kst.c@679:kstipg(): [10280:33:0] kst: process info: ospid=13512 pso_num=33 pso_serial#=76 2025-05-27 00:00:13.956948 :9C73C34A:db_trace:kso.c@4093:ksonfy(): [10420:33:0] kso: new process: pid=13512 osp_idx=31 osp_ver=330 osp_pg=0 (spawn #222763) 2025-05-27 00:00:13.956949 :9C73C34B:db_trace:kso.c@4099:ksonfy(): [10420:33:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-27 00:00:13.956949 :9C73C34C:db_trace:kso.c@4103:ksonfy(): [10420:33:0] kso: new process: pso_index=33 reservation=95 time=1279786204 2025-05-27 00:00:13.956950 :9C73C34D:db_trace:kso.c@4109:ksonfy(): [10420:33:0] kso: spawn diagnostics: queue time=0 secs 2025-05-27 00:00:13.956950 :9C73C34E:db_trace:kso.c@4111:ksonfy(): [10420:33:0] kso: spawn diagnostics: fork time=0 secs 2025-05-27 00:00:13.956950 :9C73C34F:db_trace:kso.c@4113:ksonfy(): [10420:33:0] kso: spawn diagnostics: exec time=0 secs 2025-05-27 00:00:13.956951 :9C73C350:db_trace:kso.c@4115:ksonfy(): [10420:33:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-27 00:00:13.956951 :9C73C351:db_trace:kso.c@4117:ksonfy(): [10420:33:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-27 00:00:13.957420 :9C73C352:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:33:9] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-27 00:00:43.997194 :9C73CF29:db_trace:kst.c@698:kstpsodel(): [10280:33:0] kst: process state object about to be deleted ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 33 (osid: 13512, J001)