Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250427221536\orcl_m001_8928_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:37589M/63366M, Ph+PgF:45240M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 30 Windows thread id: 8928, image: ORACLE.EXE (M001) *** 2025-04-27 22:15:36.753 *** 2025-04-27 22:15:36.753 Process diagnostic dump for ORACLE.EXE (M001), OS id=8928, pid: 30, proc_ser: 46, 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 22:15:36.753 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 30 (osid: 8928, M001) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 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 2025-04-27 19:00:09.157270 :8F94C1F4:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 04-27 19:00:09.155 2025-04-27 19:00:09.157271 :8F94C1F5:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=10924 pso_num=30 pso_serial#=39 2025-04-27 19:00:09.157405 :8F94C1F6:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=10924 osp_idx=28 osp_ver=548 osp_pg=0 (spawn #124584) 2025-04-27 19:00:09.157405 :8F94C1F7: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 19:00:09.157406 :8F94C1F8:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=4 time=3051198625 2025-04-27 19:00:09.157406 :8F94C1F9:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 19:00:09.157407 :8F94C1FA:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 19:00:09.157407 :8F94C1FB:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 19:00:09.157407 :8F94C1FC:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 19:00:09.157408 :8F94C1FD:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 19:00:09.157899 :8F94C1FE: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 19:00:09.157940 :8F94C204: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 19:00:09.166067 :8F94C226:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-04-27 20:00:16.604245 :8F999638:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 04-27 20:00:16.601 2025-04-27 20:00:16.604246 :8F999639:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=8672 pso_num=30 pso_serial#=40 2025-04-27 20:00:16.604389 :8F99963A:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=8672 osp_idx=28 osp_ver=549 osp_pg=0 (spawn #124723) 2025-04-27 20:00:16.604390 :8F99963B: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 20:00:16.604391 :8F99963C:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=5 time=3054806078 2025-04-27 20:00:16.604391 :8F99963D:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 20:00:16.604392 :8F99963E:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 20:00:16.604392 :8F99963F:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 20:00:16.604392 :8F999640:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 20:00:16.604393 :8F999641:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 20:00:16.604885 :8F999642: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 20:00:16.604929 :8F999648: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 20:00:16.613099 :8F99966A:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-04-27 21:00:24.711606 :8F9E6D6A:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 04-27 21:00:24.712 2025-04-27 21:00:24.711608 :8F9E6D6B:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=9992 pso_num=30 pso_serial#=41 2025-04-27 21:00:24.711747 :8F9E6D6C:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=9992 osp_idx=28 osp_ver=550 osp_pg=0 (spawn #124863) 2025-04-27 21:00:24.711748 :8F9E6D6D: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 21:00:24.711749 :8F9E6D6E:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=6 time=3058414187 2025-04-27 21:00:24.711750 :8F9E6D6F:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 21:00:24.711750 :8F9E6D70:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 21:00:24.711750 :8F9E6D71:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 21:00:24.711751 :8F9E6D72:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 21:00:24.711752 :8F9E6D73:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 21:00:24.712255 :8F9E6D74: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 21:00:24.712293 :8F9E6D7A: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 21:00:24.720629 :8F9E6D8C:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-04-27 22:00:32.372519 :8FA3442E:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 04-27 22:00:32.370 2025-04-27 22:00:32.372520 :8FA3442F:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=9476 pso_num=30 pso_serial#=42 2025-04-27 22:00:32.372649 :8FA34430:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=9476 osp_idx=28 osp_ver=551 osp_pg=0 (spawn #125004) 2025-04-27 22:00:32.372649 :8FA34431: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 22:00:32.372649 :8FA34432:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=7 time=3062021843 2025-04-27 22:00:32.372650 :8FA34433:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 22:00:32.372651 :8FA34434:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 22:00:32.372651 :8FA34435:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 22:00:32.372651 :8FA34436:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 22:00:32.372652 :8FA34437:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 22:00:32.373141 :8FA34438: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 22:00:32.373186 :8FA3443E: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 22:00:32.381460 :8FA34450:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-04-27 22:10:33.564351 :8FA41B11:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 04-27 22:10:33.561 2025-04-27 22:10:33.564353 :8FA41B12:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=10516 pso_num=30 pso_serial#=43 2025-04-27 22:10:33.564496 :8FA41B13:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=10516 osp_idx=28 osp_ver=552 osp_pg=0 (spawn #125029) 2025-04-27 22:10:33.564497 :8FA41B14: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 22:10:33.564497 :8FA41B15:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=8 time=3062623031 2025-04-27 22:10:33.564498 :8FA41B16:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 22:10:33.564498 :8FA41B17:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 22:10:33.564499 :8FA41B18:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 22:10:33.564499 :8FA41B19:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 22:10:33.564499 :8FA41B1A:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 22:10:33.565026 :8FA41B1B: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 22:10:33.565083 :8FA41B21: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 22:10:33.565155 :8FA41B27: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 22:10:33.569563 :8FA41B4D: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 22:10:33.618815 :8FA41B58: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 22:10:33.623720 :8FA41B60: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 22:10:33.624170 :8FA41B68: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 22:10:33.624191 :8FA41B6B: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 22:10:33.624230 :8FA41B76: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 22:10:33.625218 :8FA41B81: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 22:10:33.625238 :8FA41B84: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 22:10:33.625266 :8FA41B8F: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 22:10:33.625710 :8FA41B9A: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 22:10:33.628175 :8FA41BA2: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 22:10:33.633254 :8FA41BAA: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 22:10:33.634336 :8FA41BB2: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 22:10:33.639265 :8FA41BBA: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 22:10:33.640549 :8FA41BC2: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 22:10:33.643051 :8FA41BCA: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 22:10:33.643774 :8FA41BD2: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 22:10:33.644884 :8FA41BDA: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 22:10:33.644893 :8FA41BDB:db_trace:ktur.c@3079:ktuabt(): [10444:30:241] ABORT TRANSACTION - xid: 0x000a.017.001664e8 2025-04-27 22:10:33.647731 :8FA41BE3: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 22:10:33.647890 :8FA41BF2: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 22:10:33.648083 :8FA41BFA: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 22:10:33.648131 :8FA41BFD:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:ktcc.c:879 2025-04-27 22:10:33.648144 :8FA41BFE:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:ktcc.c:879 2025-04-27 22:10:33.650082 :8FA41C04: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 22:10:33.650130 :8FA41C07:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:ktcc.c:879 2025-04-27 22:10:33.650141 :8FA41C08:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:ktcc.c:879 2025-04-27 22:10:33.650302 :8FA41C0E: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 22:10:33.650315 :8FA41C11: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 22:10:33.650352 :8FA41C1C: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 22:10:33.652248 :8FA41C27:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-04-27 22:10:39.701490 :8FA421B6:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 04-27 22:10:39.703 2025-04-27 22:10:39.701492 :8FA421B7:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=10632 pso_num=30 pso_serial#=44 2025-04-27 22:10:39.701628 :8FA421B8:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=10632 osp_idx=28 osp_ver=553 osp_pg=0 (spawn #125032) 2025-04-27 22:10:39.701629 :8FA421B9: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 22:10:39.701629 :8FA421BA:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=9 time=3062629171 2025-04-27 22:10:39.701630 :8FA421BB:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 22:10:39.701630 :8FA421BC:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 22:10:39.701631 :8FA421BD:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 22:10:39.701631 :8FA421BE:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 22:10:39.701631 :8FA421BF:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 22:10:39.702139 :8FA421C0: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 22:10:39.702183 :8FA421C9: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 22:10:39.708901 :8FA421D4:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-04-27 22:15:34.870191 :8FA4C10D:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 04-27 22:15:34.858 2025-04-27 22:15:34.870194 :8FA4C10E:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=11160 pso_num=30 pso_serial#=45 2025-04-27 22:15:34.873851 :8FA4C10F:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=11160 osp_idx=28 osp_ver=554 osp_pg=0 (spawn #125047) 2025-04-27 22:15:34.873852 :8FA4C110: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 22:15:34.873856 :8FA4C111:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=10 time=3062924328 2025-04-27 22:15:34.873857 :8FA4C112:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 22:15:34.873857 :8FA4C113:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 22:15:34.873858 :8FA4C114:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 22:15:34.873858 :8FA4C115:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 22:15:34.873858 :8FA4C116:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 22:15:34.877589 :8FA4C117: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 22:15:34.877639 :8FA4C11D: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 22:15:34.878130 :8FA4C11E:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-04-27 22:15:36.153899 :8FA4C1BF:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 04-27 22:15:36.144 2025-04-27 22:15:36.153901 :8FA4C1C0:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=8928 pso_num=30 pso_serial#=46 2025-04-27 22:15:36.154029 :8FA4C1C1:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=8928 osp_idx=28 osp_ver=555 osp_pg=0 (spawn #125049) 2025-04-27 22:15:36.154030 :8FA4C1C2: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 22:15:36.154030 :8FA4C1C3:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=11 time=3062925625 2025-04-27 22:15:36.154031 :8FA4C1C4:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 22:15:36.154031 :8FA4C1C5:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 22:15:36.154031 :8FA4C1C6:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 22:15:36.154032 :8FA4C1C7:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 22:15:36.154032 :8FA4C1C8:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 22:15:36.154569 :8FA4C1C9: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 22:15:36.154613 :8FA4C1CF: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 22:15:36.155007 :8FA4C1D0: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: 8928, M001)