Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250629221114\orcl_m003_14108_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:36546M/63366M, Ph+PgF:42663M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 31 Windows thread id: 14108, image: ORACLE.EXE (M003) *** 2025-06-29 22:11:14.843 *** 2025-06-29 22:11:14.843 Process diagnostic dump for ORACLE.EXE (M003), OS id=14108, pid: 31, proc_ser: 90, 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-06-29 22:11:14.843 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 31 (osid: 14108, M003) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-06-27 23:59:13.580262 :AA8899A9:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=3236 (legacy spawn) 2025-06-27 23:59:13.594354 :AA8899AA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-27 23:59:46.769304 :AA88A561:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-27 23:59:46.828362 :AA88A564:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-27 23:59:46.813 2025-06-27 23:59:46.828364 :AA88A565:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=18052 pso_num=31 pso_serial#=75 2025-06-27 23:59:46.828480 :AA88A566:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=18052 (legacy spawn) 2025-06-27 23:59:46.841874 :AA88A567:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-27 23:59:50.159032 :AA88A66B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-27 23:59:50.159205 :AA88A670:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-27 23:59:50.160467 :AA88A675:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-27 23:59:50.417869 :AA88A678:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-27 23:59:50.417 2025-06-27 23:59:50.417871 :AA88A679:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=16556 pso_num=31 pso_serial#=76 2025-06-27 23:59:50.418008 :AA88A67A:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=16556 (legacy spawn) 2025-06-27 23:59:50.432689 :AA88A67B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 00:00:23.581298 :AA88B37B:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-28 06:00:02.240668 :AAA4CEFE:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-28 06:00:02.238 2025-06-28 06:00:02.240669 :AAA4CEFF:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=8296 pso_num=31 pso_serial#=77 2025-06-28 06:00:02.240798 :AAA4CF00:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=8296 osp_idx=29 osp_ver=586 osp_pg=0 (spawn #330280) 2025-06-28 06:00:02.240799 :AAA4CF01:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-28 06:00:02.240799 :AAA4CF02:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=178 time=4066145422 2025-06-28 06:00:02.240800 :AAA4CF03:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-06-28 06:00:02.240800 :AAA4CF04:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-06-28 06:00:02.240800 :AAA4CF05:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-06-28 06:00:02.240801 :AAA4CF06:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-28 06:00:02.240801 :AAA4CF07:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-28 06:00:02.241347 :AAA4CF1B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-28 06:00:32.323571 :AAA4E2CD:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-28 23:59:07.599869 :AAFAC180:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-28 23:59:07.585 2025-06-28 23:59:07.599871 :AAFAC181:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=9416 pso_num=31 pso_serial#=78 2025-06-28 23:59:07.600006 :AAFAC182:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=9416 (legacy spawn) 2025-06-28 23:59:07.606730 :AAFAC183:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 23:59:07.606924 :AAFAC188:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-28 23:59:07.607704 :AAFAC18D:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-28 23:59:07.616840 :AAFAC190:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-28 23:59:07.616 2025-06-28 23:59:07.616842 :AAFAC191:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=17392 pso_num=31 pso_serial#=79 2025-06-28 23:59:07.616998 :AAFAC192:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=17392 (legacy spawn) 2025-06-28 23:59:07.623862 :AAFAC193:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 23:59:07.624034 :AAFAC19C:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-28 23:59:07.624856 :AAFAC19D:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-28 23:59:10.084465 :AAFAC277:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-28 23:59:10.073 2025-06-28 23:59:10.084467 :AAFAC278:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=12636 pso_num=31 pso_serial#=80 2025-06-28 23:59:10.084607 :AAFAC279:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=12636 (legacy spawn) 2025-06-28 23:59:10.099302 :AAFAC27A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 23:59:13.289580 :AAFAC396:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 23:59:13.289744 :AAFAC39F:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-28 23:59:13.291099 :AAFAC3A0:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-28 23:59:13.540771 :AAFAC3CB:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-28 23:59:13.538 2025-06-28 23:59:13.540773 :AAFAC3CC:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=16320 pso_num=31 pso_serial#=81 2025-06-28 23:59:13.540921 :AAFAC3CD:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=16320 (legacy spawn) 2025-06-28 23:59:13.555738 :AAFAC3CE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 23:59:46.823554 :AAFACFD8:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-28 23:59:51.586013 :AAFAD17D:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-28 23:59:51.586 2025-06-28 23:59:51.586016 :AAFAD17E:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=16604 pso_num=31 pso_serial#=82 2025-06-28 23:59:51.586183 :AAFAD17F:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=16604 (legacy spawn) 2025-06-28 23:59:51.601227 :AAFAD180:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 23:59:54.866285 :AAFAD2C2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 23:59:54.866455 :AAFAD2CB:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-28 23:59:54.867761 :AAFAD2CC:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-28 23:59:55.119322 :AAFAD2E6:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-28 23:59:55.113 2025-06-28 23:59:55.119324 :AAFAD2E7:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=17844 pso_num=31 pso_serial#=83 2025-06-28 23:59:55.119457 :AAFAD2E8:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=17844 (legacy spawn) 2025-06-28 23:59:55.134182 :AAFAD2E9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 00:00:28.311646 :AAFAE185:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-29 06:00:02.044734 :AB170613:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-29 06:00:02.037 2025-06-29 06:00:02.044735 :AB170614:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=12024 pso_num=31 pso_serial#=84 2025-06-29 06:00:02.044891 :AB170616:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=12024 osp_idx=29 osp_ver=593 osp_pg=0 (spawn #333624) 2025-06-29 06:00:02.044891 :AB170617:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-29 06:00:02.044892 :AB170618:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=179 time=4152545235 2025-06-29 06:00:02.044893 :AB170619:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-06-29 06:00:02.044894 :AB17061A:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-06-29 06:00:02.044894 :AB17061B:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-06-29 06:00:02.044895 :AB17061C:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-29 06:00:02.044895 :AB17061D:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-29 06:00:02.045506 :AB170626:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-29 06:00:32.098293 :AB171805:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-29 14:00:05.545919 :AB3D1498:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-29 14:00:05.536 2025-06-29 14:00:05.545921 :AB3D1499:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=17680 pso_num=31 pso_serial#=85 2025-06-29 14:00:05.546060 :AB3D149A:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=17680 osp_idx=29 osp_ver=594 osp_pg=0 (spawn #334736) 2025-06-29 14:00:05.546061 :AB3D149B:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-29 14:00:05.546061 :AB3D149C:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=180 time=4181348735 2025-06-29 14:00:05.546062 :AB3D149D:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-06-29 14:00:05.546062 :AB3D149E:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-06-29 14:00:05.546063 :AB3D149F:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-06-29 14:00:05.546063 :AB3D14A0:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-29 14:00:05.546063 :AB3D14A1:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-29 14:00:05.546579 :AB3D14A2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-29 14:00:05.546621 :AB3D14A8:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-29 14:00:05.555845 :AB3D14CD:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-29 15:00:13.208788 :AB41C87C:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-29 15:00:13.198 2025-06-29 15:00:13.208789 :AB41C87D:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=15492 pso_num=31 pso_serial#=86 2025-06-29 15:00:13.208933 :AB41C87E:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=15492 osp_idx=29 osp_ver=595 osp_pg=0 (spawn #334874) 2025-06-29 15:00:13.208934 :AB41C87F:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-29 15:00:13.208934 :AB41C880:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=181 time=4184956391 2025-06-29 15:00:13.208935 :AB41C881:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-06-29 15:00:13.208935 :AB41C882:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-06-29 15:00:13.208935 :AB41C883:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-06-29 15:00:13.208936 :AB41C884:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-29 15:00:13.208936 :AB41C885:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-29 15:00:13.209459 :AB41C886:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-29 15:00:13.209510 :AB41C88C:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-29 15:00:13.218372 :AB41C8B1:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-29 16:00:20.570215 :AB46746D:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-29 16:00:20.567 2025-06-29 16:00:20.570216 :AB46746E:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=13592 pso_num=31 pso_serial#=87 2025-06-29 16:00:20.570353 :AB46746F:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=13592 osp_idx=29 osp_ver=596 osp_pg=0 (spawn #335011) 2025-06-29 16:00:20.570354 :AB467470:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-29 16:00:20.570354 :AB467471:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=182 time=4188563750 2025-06-29 16:00:20.570355 :AB467472:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-06-29 16:00:20.570355 :AB467473:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-06-29 16:00:20.570355 :AB467474:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-06-29 16:00:20.570356 :AB467475:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-29 16:00:20.570356 :AB467476:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-29 16:00:20.570855 :AB46747B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-29 16:00:20.570899 :AB467481:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-29 16:00:20.576503 :AB46749A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 16:00:20.601354 :AB4674CA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 16:00:20.616302 :AB4674D2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 16:00:20.645424 :AB4674DA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 16:00:20.649224 :AB4674E2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 16:00:20.652924 :AB4674EA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 16:00:20.657235 :AB4674FD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 16:00:20.658399 :AB467505:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 16:00:20.684897 :AB46750D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=16 loc='ktm.h LINE:583 ID:ktmpsm' id1=0 id2=0 name= type=0 2025-06-29 16:00:20.696138 :AB46761B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='kcrf.h LINE:3299 ID:kcrfw_redo_gen: wake LGWR after redo copy' id1=0 id2=0 name= type=0 2025-06-29 16:00:20.704691 :AB4676DA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 16:00:20.704702 :AB4676DB:db_trace:ktur.c@3079:ktuabt(): [10444:31:249] ABORT TRANSACTION - xid: 0x000a.009.00170690 2025-06-29 16:00:20.705044 :AB4676E3:db_trace:ktu.c@4871:ktuaex1r(): [10442:31:249] Extension usn 10, ext 1, nex 4 2025-06-29 16:00:20.705051 :AB4676E4:db_trace:ktusm.c@2117:ktusmasp(): [10445:31:249] des1:tsn:1 rdba:0x008159ed where: ktspbwh1: ktspfsrch 2025-06-29 16:00:21.780793*:AB467758:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000002DC74678 estart=1751184020 eid=16779586 ctx=0x000000077BA4B1C8 cwh=0x000000002DCA1530 cpu=484375 buffg=0 interb=0 r=0 rb=0 w=0 wb=0 2025-06-29 16:00:21.780793*:AB467759:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000002DC74678 curCtx=0x000000002DCAAFE8 pubTabIdxCnt=0 2025-06-29 16:00:21.780793*:AB46775A:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000002DC74678 2025-06-29 16:00:21.780793*:AB46775B:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000002DC74678 2025-06-29 16:00:21.780793*:AB46775C:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000002DCBDA98 estart=1751184020 eid=16779572 ctx=0x0000000787AD5BF0 cwh=0x000000002DC60AA0 cpu=484375 buffg=0 interb=0 r=0 rb=0 w=0 wb=0 2025-06-29 16:00:21.780793*:AB46775D:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000002DCBDA98 curCtx=0x0000000029960EB8 pubTabIdxCnt=0 2025-06-29 16:00:21.780793*:AB46775E:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000002DCBDA98 2025-06-29 16:00:21.780793*:AB46775F:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000002DCBDA98 2025-06-29 16:00:21.843291*:AB467760:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000002DC74678 curCtx=0x000000002DCAAFE8 xsc->flg4=65792 flags=1 2025-06-29 16:00:21.843291*:AB467761:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000002DC74678 2025-06-29 16:00:21.843291*:AB467762:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000002DCBDA98 curCtx=0x0000000029960EB8 xsc->flg4=65792 flags=2 2025-06-29 16:00:21.843291*:AB467763:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000002DCBDA98 2025-06-29 16:00:21.920601 :AB467764:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 16:00:21.956518 :AB467778:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 16:00:21.956840 :AB467780:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 16:00:21.957119 :AB467788:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 16:00:21.957136 :AB46778B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=18 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 16:00:21.957195 :AB467799:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-29 16:00:21.959855 :AB4677A5:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-29 19:00:43.438726 :AB547EAF:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-29 19:00:43.427 2025-06-29 19:00:43.438728 :AB547EB0:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=6984 pso_num=31 pso_serial#=88 2025-06-29 19:00:43.438882 :AB547EB1:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=6984 osp_idx=29 osp_ver=597 osp_pg=0 (spawn #335424) 2025-06-29 19:00:43.438883 :AB547EB2:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-29 19:00:43.438883 :AB547EB3:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=183 time=4199386625 2025-06-29 19:00:43.438884 :AB547EB4:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-06-29 19:00:43.438885 :AB547EB5:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-06-29 19:00:43.438885 :AB547EB6:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-06-29 19:00:43.438886 :AB547EB7:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-29 19:00:43.438886 :AB547EB8:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-29 19:00:43.439380 :AB547EBC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-29 19:00:43.439424 :AB547EC2:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-29 19:00:43.448524 :AB547ED4:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-29 20:00:50.457736 :AB592BB6:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-29 20:00:50.448 2025-06-29 20:00:50.457739 :AB592BB7:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=18080 pso_num=31 pso_serial#=89 2025-06-29 20:00:50.457879 :AB592BB8:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=18080 osp_idx=29 osp_ver=598 osp_pg=0 (spawn #335562) 2025-06-29 20:00:50.457880 :AB592BB9:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-29 20:00:50.457881 :AB592BBA:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=184 time=4202993641 2025-06-29 20:00:50.457881 :AB592BBB:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-06-29 20:00:50.457882 :AB592BBC:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-06-29 20:00:50.457882 :AB592BBD:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-06-29 20:00:50.457882 :AB592BBE:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-29 20:00:50.457883 :AB592BBF:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-29 20:00:50.458406 :AB592BC0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-29 20:00:50.458444 :AB592BC6:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-29 20:00:50.467353 :AB592BDB:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-29 21:00:57.902278 :AB5DD6C8:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-29 21:00:57.892 2025-06-29 21:00:57.902280 :AB5DD6C9:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=14108 pso_num=31 pso_serial#=90 2025-06-29 21:00:57.902424 :AB5DD6CA:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=14108 osp_idx=29 osp_ver=599 osp_pg=0 (spawn #335700) 2025-06-29 21:00:57.902425 :AB5DD6CB:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-29 21:00:57.902426 :AB5DD6CC:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=185 time=4206601094 2025-06-29 21:00:57.902426 :AB5DD6CD:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-06-29 21:00:57.902426 :AB5DD6CE:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-06-29 21:00:57.902427 :AB5DD6CF:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-06-29 21:00:57.902427 :AB5DD6D0:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-29 21:00:57.902427 :AB5DD6D1:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-29 21:00:57.903016 :AB5DD6D5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-29 21:00:57.903058 :AB5DD6DB:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-29 21:00:57.912306 :AB5DD6F8:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 31 (osid: 14108, M003)