Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250427181010\orcl_m001_9372_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:37560M/63366M, Ph+PgF:45222M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 30 Windows thread id: 9372, image: ORACLE.EXE (M001) *** 2025-04-27 18:10:10.253 *** 2025-04-27 18:10:10.253 Process diagnostic dump for ORACLE.EXE (M001), OS id=9372, pid: 30, proc_ser: 38, 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 18:10:10.253 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 30 (osid: 9372, M001) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-04-26 23:59:36.773381 :8F3923CC:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-04-26 23:59:50.788049 :8F392902:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 04-26 23:59:50.779 2025-04-26 23:59:50.788051 :8F392903:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=7880 pso_num=30 pso_serial#=31 2025-04-26 23:59:50.788188 :8F392904:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=7880 (legacy spawn) 2025-04-26 23:59:50.802009 :8F392905:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-27 00:00:24.150585 :8F3936DB:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-04-27 06:00:02.051933 :8F55EF30:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 04-27 06:00:02.051 2025-04-27 06:00:02.051934 :8F55EF31:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=10388 pso_num=30 pso_serial#=32 2025-04-27 06:00:02.052081 :8F55EF37:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=10388 osp_idx=28 osp_ver=541 osp_pg=0 (spawn #122742) 2025-04-27 06:00:02.052081 :8F55EF38:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-27 06:00:02.052082 :8F55EF39:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=253 time=3004403843 2025-04-27 06:00:02.052082 :8F55EF3A:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 06:00:02.052083 :8F55EF3B:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 06:00:02.052083 :8F55EF3C:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 06:00:02.052083 :8F55EF3D:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 06:00:02.052084 :8F55EF3E:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 06:00:02.052664 :8F55EF47:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-04-27 06:00:02.057615 :8F55EF64:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-27 06:00:02.057645 :8F55EF67:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:jslv.c:9203 2025-04-27 06:00:02.062652 :8F55EF89:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-27 06:00:02.215444 :8F55F25E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-27 06:00:02.351077 :8F55F272:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-27 06:00:02.481247 :8F55F28A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-27 06:00:03.615924 :8F55F487:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-27 06:00:03.616988 :8F55F48F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-27 06:00:03.622410 :8F55F497:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-27 06:00:03.623910 :8F55F49F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-27 06:00:03.639097 :8F55F4A7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-27 06:00:03.640056 :8F55F4AF:db_trace:ktu.c@4871:ktuaex1r(): [10442:30:241] Extension usn 9, ext 1, nex 2 2025-04-27 06:00:03.640062 :8F55F4B0:db_trace:ktusm.c@2117:ktusmasp(): [10445:30:241] des1:tsn:1 rdba:0x008120b6 where: kduwh01: kdusru 2025-04-27 06:00:03.640211 :8F55F4B1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-27 06:00:03.640804 :8F55F4B9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-27 06:00:03.641315 :8F55F4C1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-27 06:00:03.643942 :8F55F4C9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-27 06:00:03.644812 :8F55F4D1:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-04-27 06:00:03.645603 :8F55F4D2:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-04-27 06:00:03.646403 :8F55F4D3:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-04-27 06:00:03.646816 :8F55F4D4:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-04-27 06:00:03.646822 :8F55F4D5:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-04-27 06:00:03.647436 :8F55F4D6:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-04-27 06:00:03.647921 :8F55F4D7:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-04-27 06:00:03.648212 :8F55F4D8:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-04-27 06:00:03.649230 :8F55F4D9:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-04-27 06:00:03.680098 :8F55F4DA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-27 06:00:03.680141 :8F55F4DD:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-04-27 06:00:03.680983 :8F55F4E3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-27 06:00:03.681862 :8F55F4EB:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-04-27 06:00:03.682366 :8F55F4EC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-27 06:00:03.701376 :8F55F4F4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-27 06:00:03.701426 :8F55F4F7:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-04-27 06:00:03.702265 :8F55F4FD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-27 06:00:03.713733 :8F55F505:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-04-27 06:00:03.714239 :8F55F506:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-27 06:00:03.733144 :8F55F50E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-27 06:00:03.733192 :8F55F511:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-04-27 06:00:03.734035 :8F55F517:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-27 06:00:03.734486 :8F55F51F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-27 06:00:03.734843 :8F55F527:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-27 06:00:03.735021 :8F55F52F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-27 06:00:03.735164 :8F55F537:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-27 06:00:03.735311 :8F55F53F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:jslv.c:9203 2025-04-27 06:00:03.739036 :8F55F540:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-27 06:00:03.739110 :8F55F543:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 2025-04-27 06:00:03.739211 :8F55F550:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] 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 06:00:33.827700 :8F560371:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-04-27 10:08:55.342478 :8F69EB51:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 04-27 10:08:55.340 2025-04-27 10:08:55.342480 :8F69EB52:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=8504 pso_num=30 pso_serial#=33 2025-04-27 10:08:55.342611 :8F69EB53:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=8504 osp_idx=28 osp_ver=542 osp_pg=0 (spawn #123334) 2025-04-27 10:08:55.342611 :8F69EB54:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-27 10:08:55.342612 :8F69EB55:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=254 time=3019337140 2025-04-27 10:08:55.342612 :8F69EB56:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 10:08:55.342613 :8F69EB57:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 10:08:55.342613 :8F69EB58:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 10:08:55.342613 :8F69EB59:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 10:08:55.342614 :8F69EB5A:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 10:08:55.343183 :8F69EB5B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] 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.343226 :8F69EB63:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] 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.349967 :8F69EB6E:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-04-27 13:00:11.817061 :8F77AE88:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 04-27 13:00:11.815 2025-04-27 13:00:11.817064 :8F77AE89:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=8164 pso_num=30 pso_serial#=34 2025-04-27 13:00:11.817196 :8F77AE8A:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=8164 osp_idx=28 osp_ver=543 osp_pg=0 (spawn #123733) 2025-04-27 13:00:11.817197 :8F77AE8B:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-27 13:00:11.817197 :8F77AE8C:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=255 time=3029613593 2025-04-27 13:00:11.817197 :8F77AE8D:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 13:00:11.817198 :8F77AE8E:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 13:00:11.817198 :8F77AE8F:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 13:00:11.817199 :8F77AE90:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 13:00:11.817199 :8F77AE91:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 13:00:11.817684 :8F77AE92:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] 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:11.817725 :8F77AE98:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] 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:11.824904 :8F77AEA6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] 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.826013 :8F77AEAE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] 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.826583 :8F77AEB6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] 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.827050 :8F77AEBE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] 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.827481 :8F77AEC6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] 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.829893 :8F77AECE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] 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.831002 :8F77AED6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] 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.880636 :8F77AEDE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] 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.881529 :8F77AEE6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] 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.881766 :8F77AEEE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] 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.881977 :8F77AEF6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] 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.883686 :8F77AEFE:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-04-27 14:09:25.736726 :8F7D4B6B:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 04-27 14:09:25.737 2025-04-27 14:09:25.736728 :8F7D4B6C:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=8568 pso_num=30 pso_serial#=35 2025-04-27 14:09:25.736862 :8F7D4B6D:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=8568 osp_idx=28 osp_ver=544 osp_pg=0 (spawn #123899) 2025-04-27 14:09:25.736863 :8F7D4B6E:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-27 14:09:25.736863 :8F7D4B6F:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=0 time=3033767515 2025-04-27 14:09:25.736864 :8F7D4B70:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 14:09:25.736864 :8F7D4B71:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 14:09:25.736865 :8F7D4B72:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 14:09:25.736865 :8F7D4B73:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 14:09:25.736866 :8F7D4B74:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 14:09:25.737371 :8F7D4B75:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] 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.737416 :8F7D4B7D:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] 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.744322 :8F7D4B89:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-04-27 18:00:01.834343 :8F8FE822:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 04-27 18:00:01.832 2025-04-27 18:00:01.834345 :8F8FE823:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=1872 pso_num=30 pso_serial#=36 2025-04-27 18:00:01.834471 :8F8FE824:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=1872 osp_idx=28 osp_ver=545 osp_pg=0 (spawn #124440) 2025-04-27 18:00:01.834472 :8F8FE825:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-27 18:00:01.834472 :8F8FE826:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=1 time=3047591296 2025-04-27 18:00:01.834472 :8F8FE827:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 18:00:01.834473 :8F8FE828:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 18:00:01.834473 :8F8FE829:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 18:00:01.834474 :8F8FE82A:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 18:00:01.834474 :8F8FE82B:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 18:00:01.834960 :8F8FE82C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-04-27 18:00:01.835002 :8F8FE832:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] 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 18:00:01.843329 :8F8FE854:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-04-27 18:10:03.090440 :8F90BF40:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 04-27 18:10:03.087 2025-04-27 18:10:03.090441 :8F90BF41:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=6672 pso_num=30 pso_serial#=37 2025-04-27 18:10:03.090579 :8F90BF42:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=6672 osp_idx=28 osp_ver=546 osp_pg=0 (spawn #124464) 2025-04-27 18:10:03.090580 :8F90BF43:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-27 18:10:03.090580 :8F90BF44:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=2 time=3048192562 2025-04-27 18:10:03.090581 :8F90BF45:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 18:10:03.090581 :8F90BF46:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 18:10:03.090582 :8F90BF47:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 18:10:03.090582 :8F90BF48:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 18:10:03.090583 :8F90BF49:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 18:10:03.091153 :8F90BF4A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-04-27 18:10:03.091201 :8F90BF50:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] 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 18:10:03.091273 :8F90BF5A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-04-27 18:10:03.095813 :8F90BF75:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-27 18:10:03.148720 :8F90BF80:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-27 18:10:03.150271 :8F90BF88:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-27 18:10:03.150668 :8F90BF90:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-27 18:10:03.150688 :8F90BF93:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-04-27 18:10:03.150731 :8F90BF9E:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] KSL POST RCVD poster=18 loc='ksr2.h LINE:607 ID:ksrmdone' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-04-27 18:10:03.151703 :8F90BFA9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-27 18:10:03.151718 :8F90BFAC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-04-27 18:10:03.151747 :8F90BFB7:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] KSL POST RCVD poster=18 loc='ksr2.h LINE:607 ID:ksrmdone' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-04-27 18:10:03.152184 :8F90BFC2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-27 18:10:03.154669 :8F90BFCA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-27 18:10:03.159695 :8F90BFD2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-27 18:10:03.164995 :8F90BFDA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-27 18:10:03.166277 :8F90BFE2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-27 18:10:03.168684 :8F90BFEA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-27 18:10:03.169456 :8F90BFF2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-27 18:10:03.170547 :8F90BFFA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-27 18:10:03.170555 :8F90BFFB:db_trace:ktur.c@3079:ktuabt(): [10444:30:241] ABORT TRANSACTION - xid: 0x000a.002.00166439 2025-04-27 18:10:03.173784 :8F90C003:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-04-27 18:10:03.173991 :8F90C012:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=59 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-27 18:10:03.174262 :8F90C01D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-27 18:10:03.174309 :8F90C020:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:ktcc.c:879 2025-04-27 18:10:03.174323 :8F90C021:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:ktcc.c:879 2025-04-27 18:10:03.177150 :8F90C03F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-04-27 18:10:03.177245 :8F90C04E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=59 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-27 18:10:03.177421 :8F90C056:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-27 18:10:03.177462 :8F90C059:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:ktcc.c:879 2025-04-27 18:10:03.177477 :8F90C05A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:ktcc.c:879 2025-04-27 18:10:03.177731 :8F90C060:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-27 18:10:03.177749 :8F90C063:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-04-27 18:10:03.177775 :8F90C06F:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] KSL POST RCVD poster=18 loc='ksr2.h LINE:607 ID:ksrmdone' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-04-27 18:10:03.179904 :8F90C079:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-04-27 18:10:09.237297 :8F90C5AD:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 04-27 18:10:09.237 2025-04-27 18:10:09.237299 :8F90C5AE:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=9372 pso_num=30 pso_serial#=38 2025-04-27 18:10:09.237430 :8F90C5AF:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=9372 osp_idx=28 osp_ver=547 osp_pg=0 (spawn #124467) 2025-04-27 18:10:09.237430 :8F90C5B0:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-27 18:10:09.237431 :8F90C5B1:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=3 time=3048198703 2025-04-27 18:10:09.237431 :8F90C5B2:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 18:10:09.237432 :8F90C5B3:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 18:10:09.237432 :8F90C5B4:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 18:10:09.237433 :8F90C5B5:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 18:10:09.237433 :8F90C5B6:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 18:10:09.237917 :8F90C5B7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-04-27 18:10:09.237964 :8F90C5C0:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] 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 18:10:09.244817 :8F90C60A:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 30 (osid: 9372, M001)