Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250531220510\orcl_m002_14568_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:37228M/63366M, Ph+PgF:44132M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 30 Windows thread id: 14568, image: ORACLE.EXE (M002) *** 2025-05-31 22:05:10.184 *** 2025-05-31 22:05:10.184 Process diagnostic dump for ORACLE.EXE (M002), OS id=14568, pid: 30, proc_ser: 28, 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-31 22:05:10.184 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 30 (osid: 14568, M002) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-31 15:04:05.437487 :9E7B8B07:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 05-31 15:04:05.433 2025-05-31 15:04:05.437490 :9E7B8B08:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=12992 pso_num=30 pso_serial#=20 2025-05-31 15:04:05.437661 :9E7B8B09:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=12992 osp_idx=28 osp_ver=1039 osp_pg=0 (spawn #238194) 2025-05-31 15:04:05.437662 :9E7B8B0A:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-31 15:04:05.437662 :9E7B8B0B:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=204 time=1679604063 2025-05-31 15:04:05.437662 :9E7B8B0C:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-05-31 15:04:05.437663 :9E7B8B0D:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-05-31 15:04:05.437663 :9E7B8B0E:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-05-31 15:04:05.437664 :9E7B8B0F:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-31 15:04:05.437664 :9E7B8B10:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-31 15:04:05.438229 :9E7B8B11: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-05-31 15:04:05.438278 :9E7B8B17: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-05-31 15:04:05.447045 :9E7B8B2F:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-05-31 16:00:13.877078 :9E7FDD62:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 05-31 16:00:13.868 2025-05-31 16:00:13.877081 :9E7FDD63:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=13044 pso_num=30 pso_serial#=21 2025-05-31 16:00:13.877213 :9E7FDD64:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=13044 osp_idx=28 osp_ver=1040 osp_pg=0 (spawn #238321) 2025-05-31 16:00:13.877214 :9E7FDD65:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-31 16:00:13.877214 :9E7FDD66:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=205 time=1682972516 2025-05-31 16:00:13.877215 :9E7FDD67:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-05-31 16:00:13.877215 :9E7FDD68:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-05-31 16:00:13.877215 :9E7FDD69:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-05-31 16:00:13.877216 :9E7FDD6A:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-31 16:00:13.877216 :9E7FDD6B:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-31 16:00:13.877714 :9E7FDD6C: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-05-31 16:00:13.877760 :9E7FDD72: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-05-31 16:00:13.884979 :9E7FDD80: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-05-31 16:00:13.886026 :9E7FDD88: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-05-31 16:00:13.886616 :9E7FDD90: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-05-31 16:00:13.887115 :9E7FDD98: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-05-31 16:00:13.887561 :9E7FDDA0: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-05-31 16:00:13.889986 :9E7FDDA8: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-05-31 16:00:13.891158 :9E7FDDB0: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-05-31 16:00:13.940722 :9E7FDDB8: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-05-31 16:00:13.941612 :9E7FDDC0: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-05-31 16:00:13.941855 :9E7FDDC8: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-05-31 16:00:13.942069 :9E7FDDD0: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-05-31 16:00:13.943862 :9E7FDDD8:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-05-31 16:04:13.047140 :9E802B92:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 05-31 16:04:13.043 2025-05-31 16:04:13.047141 :9E802B93:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=14420 pso_num=30 pso_serial#=22 2025-05-31 16:04:13.047277 :9E802B94:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=14420 osp_idx=28 osp_ver=1041 osp_pg=0 (spawn #238333) 2025-05-31 16:04:13.047277 :9E802B95:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-31 16:04:13.047278 :9E802B96:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=206 time=1683211672 2025-05-31 16:04:13.047278 :9E802B97:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-05-31 16:04:13.047279 :9E802B98:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-05-31 16:04:13.047279 :9E802B99:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-05-31 16:04:13.047279 :9E802B9A:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-31 16:04:13.047280 :9E802B9B:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-31 16:04:13.047805 :9E802B9C: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-05-31 16:04:13.047854 :9E802BA3: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-05-31 16:04:13.056706 :9E802BBA:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-05-31 17:04:20.793159 :9E84D2B1:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 05-31 17:04:20.789 2025-05-31 17:04:20.793161 :9E84D2B2:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=14028 pso_num=30 pso_serial#=23 2025-05-31 17:04:20.793352 :9E84D2B3:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=14028 osp_idx=28 osp_ver=1042 osp_pg=0 (spawn #238472) 2025-05-31 17:04:20.793352 :9E84D2B4:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-31 17:04:20.793353 :9E84D2B5:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=207 time=1686819422 2025-05-31 17:04:20.793353 :9E84D2B6:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-05-31 17:04:20.793353 :9E84D2B7:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-05-31 17:04:20.793354 :9E84D2B8:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-05-31 17:04:20.793354 :9E84D2B9:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-31 17:04:20.793354 :9E84D2BA:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-31 17:04:20.793937 :9E84D2BB: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-05-31 17:04:20.793990 :9E84D2C1: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-05-31 17:04:20.803650 :9E84D2D9:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-05-31 18:04:29.317552 :9E897A74:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 05-31 18:04:29.316 2025-05-31 18:04:29.317554 :9E897A75:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=12796 pso_num=30 pso_serial#=24 2025-05-31 18:04:29.317700 :9E897A76:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=12796 osp_idx=28 osp_ver=1043 osp_pg=0 (spawn #238610) 2025-05-31 18:04:29.317701 :9E897A77:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-31 18:04:29.317701 :9E897A78:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=208 time=1690427954 2025-05-31 18:04:29.317702 :9E897A79:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-05-31 18:04:29.317702 :9E897A7A:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-05-31 18:04:29.317702 :9E897A7B:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-05-31 18:04:29.317703 :9E897A7C:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-31 18:04:29.317703 :9E897A7D:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-31 18:04:29.318205 :9E897A7E: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-05-31 18:04:29.318246 :9E897A85: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-05-31 18:04:29.318318 :9E897A8F: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-05-31 18:04:29.322788 :9E897A9B: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-05-31 18:04:29.377309 :9E897ACB: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-05-31 18:04:29.378690 :9E897AD3: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-05-31 18:04:29.379064 :9E897ADB: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-05-31 18:04:29.379083 :9E897ADE: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-05-31 18:04:29.379124 :9E897AE9: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-05-31 18:04:29.380083 :9E897AF4: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-05-31 18:04:29.380103 :9E897AF7: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-05-31 18:04:29.380130 :9E897B02: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-05-31 18:04:29.380556 :9E897B0D: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-05-31 18:04:29.383029 :9E897B15: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-05-31 18:04:29.388172 :9E897B1D: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-05-31 18:04:29.393613 :9E897B25: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-05-31 18:04:29.394919 :9E897B2D: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-05-31 18:04:29.397853 :9E897B35: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-05-31 18:04:29.398935 :9E897B3D: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-05-31 18:04:29.398942 :9E897B3E:db_trace:ktur.c@3079:ktuabt(): [10444:30:241] ABORT TRANSACTION - xid: 0x000a.015.0016bbe3 2025-05-31 18:04:29.401669 :9E897B46: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-05-31 18:04:29.401822 :9E897B55: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-05-31 18:04:29.402091 :9E897B60: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-05-31 18:04:29.402136 :9E897B63:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:ktcc.c:879 2025-05-31 18:04:29.402149 :9E897B64:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:ktcc.c:879 2025-05-31 18:04:29.403975 :9E897B77: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-05-31 18:04:29.404151 :9E897B80: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-05-31 18:04:29.404189 :9E897B83:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:ktcc.c:879 2025-05-31 18:04:29.404203 :9E897B84:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:ktcc.c:879 2025-05-31 18:04:29.404366 :9E897B8E: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-05-31 18:04:29.404378 :9E897B95: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-05-31 18:04:29.404434 :9E897BA0: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-05-31 18:04:29.406633 :9E897BB1:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-05-31 19:04:37.327273 :9E8E227E:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 05-31 19:04:37.322 2025-05-31 19:04:37.327275 :9E8E227F:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=6600 pso_num=30 pso_serial#=25 2025-05-31 19:04:37.327453 :9E8E2280:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=6600 osp_idx=28 osp_ver=1044 osp_pg=0 (spawn #238752) 2025-05-31 19:04:37.327454 :9E8E2281:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-31 19:04:37.327455 :9E8E2282:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=209 time=1694035954 2025-05-31 19:04:37.327455 :9E8E2283:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-05-31 19:04:37.327456 :9E8E2284:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-05-31 19:04:37.327456 :9E8E2285:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-05-31 19:04:37.327457 :9E8E2286:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-31 19:04:37.327458 :9E8E2287:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-31 19:04:37.328201 :9E8E2288: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-05-31 19:04:37.328250 :9E8E228E: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-05-31 19:04:37.337329 :9E8E22A6:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-05-31 20:04:45.166052 :9E92C037:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 05-31 20:04:45.163 2025-05-31 20:04:45.166053 :9E92C038:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=13728 pso_num=30 pso_serial#=26 2025-05-31 20:04:45.166189 :9E92C039:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=13728 osp_idx=28 osp_ver=1045 osp_pg=0 (spawn #238890) 2025-05-31 20:04:45.166190 :9E92C03A:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-31 20:04:45.166191 :9E92C03B:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=210 time=1697643797 2025-05-31 20:04:45.166191 :9E92C03C:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-05-31 20:04:45.166191 :9E92C03D:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-05-31 20:04:45.166192 :9E92C03E:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-05-31 20:04:45.166192 :9E92C03F:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-31 20:04:45.166193 :9E92C040:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-31 20:04:45.166790 :9E92C041: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-05-31 20:04:45.166854 :9E92C047: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-05-31 20:04:45.175861 :9E92C05F:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-05-31 21:04:53.192052 :9E975FE4:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 05-31 21:04:53.188 2025-05-31 21:04:53.192053 :9E975FE5:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=11524 pso_num=30 pso_serial#=27 2025-05-31 21:04:53.192184 :9E975FE6:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=11524 osp_idx=28 osp_ver=1046 osp_pg=0 (spawn #239029) 2025-05-31 21:04:53.192185 :9E975FE7:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-31 21:04:53.192185 :9E975FE8:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=211 time=1701251829 2025-05-31 21:04:53.192186 :9E975FE9:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-05-31 21:04:53.192186 :9E975FEA:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-05-31 21:04:53.192187 :9E975FEB:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-05-31 21:04:53.192187 :9E975FEC:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-31 21:04:53.192188 :9E975FED:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-31 21:04:53.192743 :9E975FEE: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-05-31 21:04:53.192793 :9E975FF4: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-05-31 21:04:53.201585 :9E97600C:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-05-31 22:05:01.615343 :9E9C09FF:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 05-31 22:05:01.612 2025-05-31 22:05:01.615344 :9E9C0A00:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=14568 pso_num=30 pso_serial#=28 2025-05-31 22:05:01.615485 :9E9C0A01:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=14568 osp_idx=28 osp_ver=1047 osp_pg=0 (spawn #239168) 2025-05-31 22:05:01.615487 :9E9C0A02:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-31 22:05:01.615487 :9E9C0A03:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=212 time=1704860250 2025-05-31 22:05:01.615487 :9E9C0A04:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-05-31 22:05:01.615488 :9E9C0A05:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-05-31 22:05:01.615488 :9E9C0A06:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-05-31 22:05:01.615489 :9E9C0A07:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-31 22:05:01.615489 :9E9C0A08:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-31 22:05:01.616001 :9E9C0A09: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-05-31 22:05:01.616049 :9E9C0A0F: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-05-31 22:05:01.616114 :9E9C0A15: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-05-31 22:05:01.620500 :9E9C0A34: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-05-31 22:05:01.673758 :9E9C0A3F: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-05-31 22:05:01.675673 :9E9C0A47: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-05-31 22:05:01.676060 :9E9C0A4F: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-05-31 22:05:01.676078 :9E9C0A52: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-05-31 22:05:01.676118 :9E9C0A5D: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-05-31 22:05:01.677097 :9E9C0A68: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-05-31 22:05:01.677112 :9E9C0A6B: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-05-31 22:05:01.677140 :9E9C0A76: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-05-31 22:05:01.677577 :9E9C0A81: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-05-31 22:05:01.679974 :9E9C0A89: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-05-31 22:05:01.685176 :9E9C0A91: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-05-31 22:05:01.690597 :9E9C0A99: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-05-31 22:05:01.692203 :9E9C0AA1: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-05-31 22:05:01.695387 :9E9C0AA9: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-05-31 22:05:01.696504 :9E9C0AB1: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-05-31 22:05:01.696514 :9E9C0AB2:db_trace:ktur.c@3079:ktuabt(): [10444:30:241] ABORT TRANSACTION - xid: 0x000a.013.0016bc5c 2025-05-31 22:05:01.699325 :9E9C0ABA: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-05-31 22:05:01.699485 :9E9C0AC9: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-05-31 22:05:01.699745 :9E9C0AD4: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-05-31 22:05:01.699789 :9E9C0AD7:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:ktcc.c:879 2025-05-31 22:05:01.699801 :9E9C0AD8:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:ktcc.c:879 2025-05-31 22:05:01.701637 :9E9C0AE7: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-05-31 22:05:01.701838 :9E9C0AF3: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-05-31 22:05:01.701878 :9E9C0AF6:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:ktcc.c:879 2025-05-31 22:05:01.701890 :9E9C0AF7:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:ktcc.c:879 2025-05-31 22:05:01.702051 :9E9C0AFF: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-05-31 22:05:01.702067 :9E9C0B02: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-05-31 22:05:01.702110 :9E9C0B0D: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-05-31 22:05:01.704372 :9E9C0B21: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: 14568, M002)