Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250504220239\orcl_m001_11168_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:37570M/63366M, Ph+PgF:45093M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 38 Windows thread id: 11168, image: ORACLE.EXE (M001) *** 2025-05-04 22:02:39.427 *** 2025-05-04 22:02:39.427 Process diagnostic dump for ORACLE.EXE (M001), OS id=11168, pid: 38, proc_ser: 14, 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-04 22:02:39.427 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 38 (osid: 11168, M001) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-03-23 11:26:20.571006 :8000062D:db_trace:kst.c@673:kstipg(): [10280:38:0] kst: process state object created on 03-23 11:26:20.561 2025-03-23 11:26:20.571007 :8000062E:db_trace:kst.c@679:kstipg(): [10280:38:0] kst: process info: ospid=3344 pso_num=38 pso_serial#=1 2025-03-23 11:26:20.571076 :8000062F:db_trace:kso.c@4093:ksonfy(): [10420:38:0] kso: new process: pid=3344 osp_idx=36 osp_ver=0 osp_pg=0 (spawn #37) 2025-03-23 11:26:20.571076 :80000630:db_trace:kso.c@4099:ksonfy(): [10420:38:0] kso: new process: first_req_pid=3724 spawner_pid=3660 sga_crt_ts=x8A8A 2025-03-23 11:26:20.571076 :80000631:db_trace:kso.c@4103:ksonfy(): [10420:38:0] kso: new process: pso_index=38 reservation=1 time=40593 2025-03-23 11:26:20.571076 :80000632:db_trace:kso.c@4109:ksonfy(): [10420:38:0] kso: spawn diagnostics: queue time=0 secs 2025-03-23 11:26:20.571076 :80000633:db_trace:kso.c@4111:ksonfy(): [10420:38:0] kso: spawn diagnostics: fork time=0 secs 2025-03-23 11:26:20.571076 :80000634:db_trace:kso.c@4113:ksonfy(): [10420:38:0] kso: spawn diagnostics: exec time=0 secs 2025-03-23 11:26:20.571077 :80000635:db_trace:kso.c@4115:ksonfy(): [10420:38:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-03-23 11:26:20.571077 :80000636:db_trace:kso.c@4117:ksonfy(): [10420:38:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-03-23 11:26:20.571109 :80000637:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:38:0] KSL POST SENT postee=22 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-03-23 11:26:20.611469 :8000082D:db_trace:ksl2.c@12699:ksliwat(): [10005:38:0] KSL POST RCVD poster=22 loc='kxfp.h LINE:4291 ID:kxfprienq: slave' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-03-23 11:26:20.613937 :80000894:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:38:50] KSL POST SENT postee=22 loc='kxfp.h LINE:4291 ID:kxfprienq: slave' id1=0 id2=0 name= type=0 2025-03-23 11:26:20.622506 :800008B8:db_trace:ksl2.c@12699:ksliwat(): [10005:38:50] KSL POST RCVD poster=22 loc='kxfp.h LINE:4291 ID:kxfprienq: slave' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-03-23 11:26:20.636444 :800008FA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:38:50] KSL POST SENT postee=22 loc='kxfp.h LINE:4291 ID:kxfprienq: slave' id1=0 id2=0 name= type=0 2025-03-23 11:26:20.639081 :80000946:db_trace:ksl2.c@12699:ksliwat(): [10005:38:50] KSL POST RCVD poster=22 loc='kxfp.h LINE:4291 ID:kxfprienq: slave' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-03-23 11:26:20.639087 :8000094F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:38:50] KSL POST SENT postee=10 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-03-23 11:26:20.642636 :800009F2:db_trace:ksl2.c@12699:ksliwat(): [10005:38:50] KSL POST RCVD poster=10 loc='ksa2.h LINE:286 ID:ksasnr' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-03-23 11:26:20.666305 :80000AA1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:38:50] KSL POST SENT postee=22 loc='kxfp.h LINE:4291 ID:kxfprienq: slave' id1=0 id2=0 name= type=0 2025-03-23 11:26:20.736171 :800021BF:db_trace:ksl2.c@12699:ksliwat(): [10005:38:50] KSL POST RCVD poster=22 loc='kxfp.h LINE:4291 ID:kxfprienq: slave' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-03-23 11:26:20.740240 :800021E4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:38:50] KSL POST SENT postee=22 loc='kxfp.h LINE:4291 ID:kxfprienq: slave' id1=0 id2=0 name= type=0 2025-03-23 11:26:20.740605 :80002370:db_trace:ksl2.c@12699:ksliwat(): [10005:38:50] KSL POST RCVD poster=22 loc='kxfp.h LINE:4291 ID:kxfprienq: slave' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-03-23 11:26:20.747064 :80002386:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:38:50] KSL POST SENT postee=22 loc='kxfp.h LINE:4291 ID:kxfprienq: slave' id1=0 id2=0 name= type=0 2025-03-23 11:26:20.863294 :80002A48:db_trace:ksl2.c@12699:ksliwat(): [10005:38:50] KSL POST RCVD poster=22 loc='kxfp.h LINE:4291 ID:kxfprienq: slave' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-03-23 11:26:20.863303 :80002A58:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:38:50] KSL POST SENT postee=22 loc='kxfp.h LINE:4291 ID:kxfprienq: slave' id1=0 id2=0 name= type=0 2025-03-23 11:26:20.873005 :80002C77:db_trace:ksl2.c@12699:ksliwat(): [10005:38:50] KSL POST RCVD poster=22 loc='kxfp.h LINE:4291 ID:kxfprienq: slave' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-03-23 11:26:20.876136 :80002CB3:KFNU:kfn.c@2200:kfnPrepareASM(): kfnPrepareASM force=0 state_kfnsg=0x7 2025-03-23 11:26:20.886662 :80002D23:db_trace:ksl2.c@12699:ksliwat(): [10005:38:50] KSL POST RCVD poster=35 loc='ksq.h LINE:1877 ID:ksqrcl' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-03-23 11:26:20.887007 :80002D26:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:38:50] KSL POST SENT postee=37 loc='ksq.h LINE:1877 ID:ksqrcl' id1=0 id2=0 name= type=0 2025-03-23 11:26:20.887065 :80002D28:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:38:50] KSL POST SENT postee=22 loc='kxfp.h LINE:4291 ID:kxfprienq: slave' id1=0 id2=0 name= type=0 2025-03-23 11:26:20.887838 :80002D53:db_trace:ksl2.c@12699:ksliwat(): [10005:38:50] KSL POST RCVD poster=22 loc='ksu.h LINE:12733 ID:ksusig' error and flags=2147494035 id2=136 name= type=0 fac#=0 facpost=1 2025-03-23 11:26:20.890080 :80002D86:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:38:50] KSL POST SENT postee=22 loc='kxfp.h LINE:4295 ID:kxfpqr: QC' id1=0 id2=0 name= type=0 2025-03-23 11:26:20.890081 :80002D88:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:38:50] KSL POST SENT postee=22 loc='kxfp.h LINE:4291 ID:kxfprienq: slave' id1=0 id2=0 name= type=0 2025-03-23 11:26:20.890164 :80002DD1:db_trace:ksl2.c@12699:ksliwat(): [10005:38:50] KSL POST RCVD poster=22 loc='kxfp.h LINE:4291 ID:kxfprienq: slave' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-03-23 11:26:20.890186 :80002DE4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:38:50] KSL POST SENT postee=22 loc='kxfp.h LINE:4291 ID:kxfprienq: slave' id1=0 id2=0 name= type=0 2025-03-23 11:26:21.764433 :800030BC:db_trace:ksl2.c@12699:ksliwat(): [10005:38:0] KSL POST RCVD poster=22 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-03-23 11:31:22.395825 :80009AC4:db_trace:ksl2.c@2324:kslwtbctx(): [10005:38:0] KSL WAIT BEG [latch: call allocation] 136410064/0x82173d0 10/0xa 0/0x0 wait_id=0 seq_num=0 snap_id=0 2025-03-23 11:31:22.396123 :80009ADA:db_trace:ksl2.c@2611:kslwtectx(): [10005:38:0] KSL WAIT END [latch: call allocation] 136410064/0x82173d0 10/0xa 0/0x0 wait_id=0 seq_num=0 snap_id=0 2025-03-23 11:31:22.396124 :80009ADB:db_trace:ksl2.c@2619:kslwtectx(): [10005:38:0] KSL WAIT END wait times (usecs) - snap=299, exc=299, tot=299 2025-03-23 11:31:22.397467 :80009B32:db_trace:kst.c@698:kstpsodel(): [10280:38:0] kst: process state object about to be deleted 2025-03-24 23:59:59.241438 :80AB4714:db_trace:kst.c@673:kstipg(): [10280:38:0] kst: process state object created on 03-24 23:59:59.229 2025-03-24 23:59:59.241441 :80AB4715:db_trace:kst.c@679:kstipg(): [10280:38:0] kst: process info: ospid=7640 pso_num=38 pso_serial#=2 2025-03-24 23:59:59.241569 :80AB4716:db_trace:kso.c@4093:ksonfy(): [10420:38:0] kso: new process: pid=7640 osp_idx=36 osp_ver=1 osp_pg=0 (spawn #5512) 2025-03-24 23:59:59.241570 :80AB4717:db_trace:kso.c@4099:ksonfy(): [10420:38:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-03-24 23:59:59.241570 :80AB4718:db_trace:kso.c@4103:ksonfy(): [10420:38:0] kso: new process: pso_index=38 reservation=2 time=131659265 2025-03-24 23:59:59.241571 :80AB4719:db_trace:kso.c@4109:ksonfy(): [10420:38:0] kso: spawn diagnostics: queue time=0 secs 2025-03-24 23:59:59.241571 :80AB471A:db_trace:kso.c@4111:ksonfy(): [10420:38:0] kso: spawn diagnostics: fork time=0 secs 2025-03-24 23:59:59.241571 :80AB471B:db_trace:kso.c@4113:ksonfy(): [10420:38:0] kso: spawn diagnostics: exec time=0 secs 2025-03-24 23:59:59.241572 :80AB471C:db_trace:kso.c@4115:ksonfy(): [10420:38:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-03-24 23:59:59.241572 :80AB471D:db_trace:kso.c@4117:ksonfy(): [10420:38:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-03-24 23:59:59.242085 :80AB471E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:38:51] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-03-24 23:59:59.242128 :80AB4724:db_trace:ksl2.c@12699:ksliwat(): [10005:38:51] 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-03-24 23:59:59.246390 :80AB473D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:38:51] atxpus:kelt.c:517 2025-03-24 23:59:59.246434 :80AB473E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:38:51] atxpop:kelt.c:517 2025-03-24 23:59:59.246693 :80AB473F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:38:51] atxpus:kelt.c:517 2025-03-24 23:59:59.246709 :80AB4740:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:38:51] atxpop:kelt.c:517 2025-03-24 23:59:59.246923 :80AB4741:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:38:51] atxpus:kelt.c:517 2025-03-24 23:59:59.246936 :80AB4742:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:38:51] atxpop:kelt.c:517 2025-03-24 23:59:59.247139 :80AB4743:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:38:51] atxpus:kelt.c:517 2025-03-24 23:59:59.247151 :80AB4744:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:38:51] atxpop:kelt.c:517 2025-03-24 23:59:59.247357 :80AB4745:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:38:51] atxpus:kelt.c:517 2025-03-24 23:59:59.247369 :80AB4746:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:38:51] atxpop:kelt.c:517 2025-03-24 23:59:59.247580 :80AB4747:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:38:51] atxpus:kelt.c:517 2025-03-24 23:59:59.247592 :80AB4748:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:38:51] atxpop:kelt.c:517 2025-03-24 23:59:59.250089 :80AB4749:db_trace:kst.c@698:kstpsodel(): [10280:38:0] kst: process state object about to be deleted 2025-04-04 23:59:46.905185 :85869CEB:db_trace:kst.c@673:kstipg(): [10280:38:0] kst: process state object created on 04-04 23:59:46.897 2025-04-04 23:59:46.905188 :85869CEC:db_trace:kst.c@679:kstipg(): [10280:38:0] kst: process info: ospid=1248 pso_num=38 pso_serial#=3 2025-04-04 23:59:46.905326 :85869CED:db_trace:kso.c@4070:ksonfy(): [10420:38:0] kso: new process: pid=1248 (legacy spawn) 2025-04-04 23:59:46.911765 :85869CEE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:38:51] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-04 23:59:46.911949 :85869CF6:db_trace:ksl2.c@12699:ksliwat(): [10005:38:51] 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-04 23:59:46.912726 :85869CF8:db_trace:kst.c@698:kstpsodel(): [10280:38:0] kst: process state object about to be deleted 2025-04-04 23:59:59.294055 :8586A187:db_trace:kst.c@673:kstipg(): [10280:38:0] kst: process state object created on 04-04 23:59:59.286 2025-04-04 23:59:59.294057 :8586A188:db_trace:kst.c@679:kstipg(): [10280:38:0] kst: process info: ospid=6484 pso_num=38 pso_serial#=4 2025-04-04 23:59:59.294194 :8586A189:db_trace:kso.c@4070:ksonfy(): [10420:38:0] kso: new process: pid=6484 (legacy spawn) 2025-04-04 23:59:59.300759 :8586A18A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:38:51] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-04 23:59:59.300931 :8586A192:db_trace:ksl2.c@12699:ksliwat(): [10005:38:51] 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-04 23:59:59.301808 :8586A194:db_trace:kst.c@698:kstpsodel(): [10280:38:0] kst: process state object about to be deleted 2025-04-07 23:59:30.554562 :86D660EC:db_trace:kst.c@673:kstipg(): [10280:38:0] kst: process state object created on 04-07 23:59:30.540 2025-04-07 23:59:30.554564 :86D660ED:db_trace:kst.c@679:kstipg(): [10280:38:0] kst: process info: ospid=3560 pso_num=38 pso_serial#=5 2025-04-07 23:59:30.554700 :86D660EE:db_trace:kso.c@4070:ksonfy(): [10420:38:0] kso: new process: pid=3560 (legacy spawn) 2025-04-07 23:59:30.561407 :86D660EF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:38:51] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-07 23:59:30.561571 :86D660F7:db_trace:ksl2.c@12699:ksliwat(): [10005:38:51] 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-07 23:59:30.562449 :86D660F9:db_trace:kst.c@698:kstpsodel(): [10280:38:0] kst: process state object about to be deleted 2025-04-07 23:59:30.571251 :86D660FC:db_trace:kst.c@673:kstipg(): [10280:38:0] kst: process state object created on 04-07 23:59:30.571 2025-04-07 23:59:30.571253 :86D660FD:db_trace:kst.c@679:kstipg(): [10280:38:0] kst: process info: ospid=8172 pso_num=38 pso_serial#=6 2025-04-07 23:59:30.571398 :86D660FE:db_trace:kso.c@4070:ksonfy(): [10420:38:0] kso: new process: pid=8172 (legacy spawn) 2025-04-07 23:59:30.577941 :86D660FF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:38:51] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-07 23:59:30.578113 :86D66108:db_trace:ksl2.c@12699:ksliwat(): [10005:38:51] 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-07 23:59:30.578936 :86D66109:db_trace:kst.c@698:kstpsodel(): [10280:38:0] kst: process state object about to be deleted 2025-04-09 23:59:34.705585 :87B709AD:db_trace:kst.c@673:kstipg(): [10280:38:0] kst: process state object created on 04-09 23:59:34.693 2025-04-09 23:59:34.705588 :87B709AE:db_trace:kst.c@679:kstipg(): [10280:38:0] kst: process info: ospid=7140 pso_num=38 pso_serial#=7 2025-04-09 23:59:34.705716 :87B709AF:db_trace:kso.c@4070:ksonfy(): [10420:38:0] kso: new process: pid=7140 (legacy spawn) 2025-04-09 23:59:34.712399 :87B709B0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:38:51] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-09 23:59:34.712568 :87B709B7:db_trace:ksl2.c@12699:ksliwat(): [10005:38:51] 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-09 23:59:34.713422 :87B709BA:db_trace:kst.c@698:kstpsodel(): [10280:38:0] kst: process state object about to be deleted 2025-04-09 23:59:34.732071 :87B709BD:db_trace:kst.c@673:kstipg(): [10280:38:0] kst: process state object created on 04-09 23:59:34.724 2025-04-09 23:59:34.732074 :87B709BE:db_trace:kst.c@679:kstipg(): [10280:38:0] kst: process info: ospid=8232 pso_num=38 pso_serial#=8 2025-04-09 23:59:34.732232 :87B709BF:db_trace:kso.c@4070:ksonfy(): [10420:38:0] kso: new process: pid=8232 (legacy spawn) 2025-04-09 23:59:34.738802 :87B709C0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:38:51] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-09 23:59:34.738982 :87B709C8:db_trace:ksl2.c@12699:ksliwat(): [10005:38:51] 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-09 23:59:34.739855 :87B709CA:db_trace:kst.c@698:kstpsodel(): [10280:38:0] kst: process state object about to be deleted 2025-04-12 23:59:34.310006 :89085037:db_trace:kst.c@673:kstipg(): [10280:38:0] kst: process state object created on 04-12 23:59:34.305 2025-04-12 23:59:34.310008 :89085038:db_trace:kst.c@679:kstipg(): [10280:38:0] kst: process info: ospid=8780 pso_num=38 pso_serial#=9 2025-04-12 23:59:34.310149 :89085039:db_trace:kso.c@4070:ksonfy(): [10420:38:0] kso: new process: pid=8780 (legacy spawn) 2025-04-12 23:59:34.323920 :8908503A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:38:51] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-13 00:00:07.600029 :89085BCE:db_trace:kst.c@698:kstpsodel(): [10280:38:0] kst: process state object about to be deleted 2025-04-21 23:59:32.787161 :8CFCFC82:db_trace:kst.c@673:kstipg(): [10280:38:0] kst: process state object created on 04-21 23:59:32.783 2025-04-21 23:59:32.787163 :8CFCFC83:db_trace:kst.c@679:kstipg(): [10280:38:0] kst: process info: ospid=4320 pso_num=38 pso_serial#=10 2025-04-21 23:59:32.787298 :8CFCFC84:db_trace:kso.c@4070:ksonfy(): [10420:38:0] kso: new process: pid=4320 (legacy spawn) 2025-04-21 23:59:32.793766 :8CFCFC85:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:38:51] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-21 23:59:32.793943 :8CFCFC8A:db_trace:ksl2.c@12699:ksliwat(): [10005:38:51] 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-21 23:59:32.794795 :8CFCFC8F:db_trace:kst.c@698:kstpsodel(): [10280:38:0] kst: process state object about to be deleted 2025-04-21 23:59:32.803472 :8CFCFC92:db_trace:kst.c@673:kstipg(): [10280:38:0] kst: process state object created on 04-21 23:59:32.799 2025-04-21 23:59:32.803474 :8CFCFC93:db_trace:kst.c@679:kstipg(): [10280:38:0] kst: process info: ospid=10664 pso_num=38 pso_serial#=11 2025-04-21 23:59:32.803612 :8CFCFC94:db_trace:kso.c@4070:ksonfy(): [10420:38:0] kso: new process: pid=10664 (legacy spawn) 2025-04-21 23:59:32.810102 :8CFCFC95:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:38:51] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-21 23:59:32.810273 :8CFCFC9E:db_trace:ksl2.c@12699:ksliwat(): [10005:38:51] 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-21 23:59:32.811070 :8CFCFC9F:db_trace:kst.c@698:kstpsodel(): [10280:38:0] kst: process state object about to be deleted 2025-04-21 23:59:34.926651 :8CFCFD6D:db_trace:kst.c@673:kstipg(): [10280:38:0] kst: process state object created on 04-21 23:59:34.921 2025-04-21 23:59:34.926653 :8CFCFD6E:db_trace:kst.c@679:kstipg(): [10280:38:0] kst: process info: ospid=9412 pso_num=38 pso_serial#=12 2025-04-21 23:59:34.926790 :8CFCFD6F:db_trace:kso.c@4070:ksonfy(): [10420:38:0] kso: new process: pid=9412 (legacy spawn) 2025-04-21 23:59:34.940675 :8CFCFD70:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:38:51] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-22 00:00:07.993805 :8CFD08C9:db_trace:kst.c@698:kstpsodel(): [10280:38:0] kst: process state object about to be deleted 2025-04-24 00:00:01.570000 :8DDE1BC7:db_trace:kst.c@673:kstipg(): [10280:38:0] kst: process state object created on 04-24 00:00:01.557 2025-04-24 00:00:01.570001 :8DDE1BC8:db_trace:kst.c@679:kstipg(): [10280:38:0] kst: process info: ospid=11056 pso_num=38 pso_serial#=13 2025-04-24 00:00:01.570139 :8DDE1BC9:db_trace:kso.c@4070:ksonfy(): [10420:38:0] kso: new process: pid=11056 (legacy spawn) 2025-04-24 00:00:01.576999 :8DDE1BCD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:38:51] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-24 00:00:01.577160 :8DDE1BD6:db_trace:ksl2.c@12699:ksliwat(): [10005:38:51] 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-24 00:00:01.577958 :8DDE1BD7:db_trace:kst.c@698:kstpsodel(): [10280:38:0] kst: process state object about to be deleted 2025-05-03 23:59:37.547763 :9255EB3B:db_trace:kst.c@673:kstipg(): [10280:38:0] kst: process state object created on 05-03 23:59:37.535 2025-05-03 23:59:37.547765 :9255EB3C:db_trace:kst.c@679:kstipg(): [10280:38:0] kst: process info: ospid=11168 pso_num=38 pso_serial#=14 2025-05-03 23:59:37.547898 :9255EB3D:db_trace:kso.c@4093:ksonfy(): [10420:38:0] kso: new process: pid=11168 osp_idx=36 osp_ver=13 osp_pg=0 (spawn #145616) 2025-05-03 23:59:37.547898 :9255EB3E:db_trace:kso.c@4099:ksonfy(): [10420:38:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-03 23:59:37.547899 :9255EB3F:db_trace:kso.c@4103:ksonfy(): [10420:38:0] kso: new process: pso_index=38 reservation=3 time=3587554703 2025-05-03 23:59:37.547900 :9255EB40:db_trace:kso.c@4109:ksonfy(): [10420:38:0] kso: spawn diagnostics: queue time=0 secs 2025-05-03 23:59:37.547900 :9255EB41:db_trace:kso.c@4111:ksonfy(): [10420:38:0] kso: spawn diagnostics: fork time=0 secs 2025-05-03 23:59:37.547901 :9255EB42:db_trace:kso.c@4113:ksonfy(): [10420:38:0] kso: spawn diagnostics: exec time=0 secs 2025-05-03 23:59:37.547901 :9255EB43:db_trace:kso.c@4115:ksonfy(): [10420:38:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-03 23:59:37.547901 :9255EB44:db_trace:kso.c@4117:ksonfy(): [10420:38:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-03 23:59:37.548419 :9255EB45:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:38:51] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-03 23:59:37.548461 :9255EB4B:db_trace:ksl2.c@12699:ksliwat(): [10005:38:51] 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-03 23:59:37.552561 :9255EB64:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:38:51] atxpus:kelt.c:517 2025-05-03 23:59:37.552609 :9255EB65:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:38:51] atxpop:kelt.c:517 2025-05-03 23:59:37.552858 :9255EB66:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:38:51] atxpus:kelt.c:517 2025-05-03 23:59:37.552875 :9255EB67:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:38:51] atxpop:kelt.c:517 2025-05-03 23:59:37.553131 :9255EB68:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:38:51] atxpus:kelt.c:517 2025-05-03 23:59:37.553155 :9255EB69:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:38:51] atxpop:kelt.c:517 2025-05-03 23:59:37.553405 :9255EB6A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:38:51] atxpus:kelt.c:517 2025-05-03 23:59:37.553418 :9255EB6B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:38:51] atxpop:kelt.c:517 2025-05-03 23:59:37.553624 :9255EB6C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:38:51] atxpus:kelt.c:517 2025-05-03 23:59:37.553637 :9255EB6D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:38:51] atxpop:kelt.c:517 2025-05-03 23:59:37.553849 :9255EB6E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:38:51] atxpus:kelt.c:517 2025-05-03 23:59:37.553863 :9255EB6F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:38:51] atxpop:kelt.c:517 2025-05-03 23:59:37.556270 :9255EB70:db_trace:kst.c@698:kstpsodel(): [10280:38:0] kst: process state object about to be deleted ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 38 (osid: 11168, M001)