Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250822081034\orcl_m001_21000_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:35303M/63366M, Ph+PgF:40457M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 29 Windows thread id: 21000, image: ORACLE.EXE (M001) *** 2025-08-22 08:10:34.674 *** 2025-08-22 08:10:34.674 Process diagnostic dump for ORACLE.EXE (M001), OS id=21000, pid: 29, proc_ser: 178, 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-08-22 08:10:34.674 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 29 (osid: 21000, M001) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-08-22 00:03:29.338578 :C2E60C02:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-22 00:03:29.338579 :C2E60C03:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=83 time=206711346 2025-08-22 00:03:29.338579 :C2E60C04:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-08-22 00:03:29.338579 :C2E60C05:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-08-22 00:03:29.338580 :C2E60C06:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-08-22 00:03:29.338580 :C2E60C07:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-22 00:03:29.338580 :C2E60C08:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-22 00:03:29.339066 :C2E60C09:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-22 00:03:59.451034 :C2E615D4:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-08-22 00:04:29.441989 :C2E61F3F:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 08-22 00:04:29.431 2025-08-22 00:04:29.441992 :C2E61F40:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=19168 pso_num=29 pso_serial#=167 2025-08-22 00:04:29.442113 :C2E61F41:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=19168 osp_idx=27 osp_ver=16231 osp_pg=0 (spawn #512773) 2025-08-22 00:04:29.442114 :C2E61F42:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-22 00:04:29.442115 :C2E61F43:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=84 time=206771440 2025-08-22 00:04:29.442115 :C2E61F44:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-08-22 00:04:29.442116 :C2E61F45:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-08-22 00:04:29.442116 :C2E61F46:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-08-22 00:04:29.442116 :C2E61F47:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-22 00:04:29.442117 :C2E61F48:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-22 00:04:29.442607 :C2E61F49:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-22 00:04:44.459481 :C2E6243D:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=59 loc='kkj.h LINE:914 ID:kkjpstnp' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-22 00:05:14.516795 :C2E62E03:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-08-22 00:05:29.543472 :C2E63333:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 08-22 00:05:29.532 2025-08-22 00:05:29.543474 :C2E63334:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=21784 pso_num=29 pso_serial#=168 2025-08-22 00:05:29.543615 :C2E63335:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=21784 osp_idx=27 osp_ver=16232 osp_pg=0 (spawn #512775) 2025-08-22 00:05:29.543616 :C2E63336:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-22 00:05:29.543616 :C2E63337:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=85 time=206831549 2025-08-22 00:05:29.543617 :C2E63338:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-08-22 00:05:29.543617 :C2E63339:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-08-22 00:05:29.543618 :C2E6333A:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-08-22 00:05:29.543618 :C2E6333B:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-22 00:05:29.543618 :C2E6333C:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-22 00:05:29.544097 :C2E6333D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-22 00:05:59.632338 :C2E63E1E:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-08-22 00:15:59.329874 :C2E7075D:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 08-22 00:15:59.317 2025-08-22 00:15:59.329876 :C2E7075E:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=17932 pso_num=29 pso_serial#=169 2025-08-22 00:15:59.330015 :C2E7075F:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=17932 osp_idx=27 osp_ver=16233 osp_pg=0 (spawn #512798) 2025-08-22 00:15:59.330015 :C2E70760:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-22 00:15:59.330016 :C2E70761:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=86 time=207461330 2025-08-22 00:15:59.330016 :C2E70762:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-08-22 00:15:59.330016 :C2E70763:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-08-22 00:15:59.330017 :C2E70764:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-08-22 00:15:59.330017 :C2E70765:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-22 00:15:59.330018 :C2E70766:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-22 00:15:59.330513 :C2E70767:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-22 00:15:59.330552 :C2E7076D:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-08-22 00:15:59.334689 :C2E70786:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-08-22 00:15:59.334732 :C2E70787:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-08-22 00:15:59.334984 :C2E70788:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-08-22 00:15:59.335001 :C2E70789:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-08-22 00:15:59.335220 :C2E7078A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-08-22 00:15:59.335234 :C2E7078B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-08-22 00:15:59.335436 :C2E7078C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-08-22 00:15:59.335449 :C2E7078D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-08-22 00:15:59.335701 :C2E7078E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-08-22 00:15:59.335723 :C2E7078F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-08-22 00:15:59.335957 :C2E70790:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-08-22 00:15:59.335970 :C2E70791:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-08-22 00:15:59.338312 :C2E70792:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-08-22 00:46:03.147655 :C2E9587F:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 08-22 00:46:03.135 2025-08-22 00:46:03.147657 :C2E95880:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=21212 pso_num=29 pso_serial#=170 2025-08-22 00:46:03.147794 :C2E95881:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=21212 osp_idx=27 osp_ver=16234 osp_pg=0 (spawn #512866) 2025-08-22 00:46:03.147795 :C2E95882:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-22 00:46:03.147795 :C2E95883:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=87 time=209265143 2025-08-22 00:46:03.147795 :C2E95884:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-08-22 00:46:03.147796 :C2E95885:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-08-22 00:46:03.147796 :C2E95886:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-08-22 00:46:03.147796 :C2E95887:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-22 00:46:03.147797 :C2E95888:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-22 00:46:03.148387 :C2E95889:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-22 00:46:03.148427 :C2E9588F:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-08-22 00:46:03.152531 :C2E958A8:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-08-22 00:46:03.152573 :C2E958A9:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-08-22 00:46:03.152841 :C2E958AA:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-08-22 00:46:03.152856 :C2E958AB:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-08-22 00:46:03.153069 :C2E958AC:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-08-22 00:46:03.153082 :C2E958AD:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-08-22 00:46:03.153296 :C2E958AE:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-08-22 00:46:03.153309 :C2E958AF:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-08-22 00:46:03.153516 :C2E958B0:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-08-22 00:46:03.153529 :C2E958B1:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-08-22 00:46:03.153749 :C2E958B2:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-08-22 00:46:03.153761 :C2E958B3:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-08-22 00:46:03.156025 :C2E958B4:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-08-22 01:00:05.058262 :C2EA6D69:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 08-22 01:00:05.053 2025-08-22 01:00:05.058264 :C2EA6D6A:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=21852 pso_num=29 pso_serial#=171 2025-08-22 01:00:05.058406 :C2EA6D6B:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=21852 osp_idx=27 osp_ver=16235 osp_pg=0 (spawn #512899) 2025-08-22 01:00:05.058407 :C2EA6D6C:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-22 01:00:05.058407 :C2EA6D6D:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=88 time=210107065 2025-08-22 01:00:05.058408 :C2EA6D6E:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-08-22 01:00:05.058408 :C2EA6D6F:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-08-22 01:00:05.058408 :C2EA6D70:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-08-22 01:00:05.058409 :C2EA6D71:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-22 01:00:05.058409 :C2EA6D72:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-22 01:00:05.058900 :C2EA6D73:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-22 01:00:05.058958 :C2EA6D79:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-08-22 01:00:05.063415 :C2EA6D8C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-22 01:00:05.085716 :C2EA6D94:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-22 01:00:05.100993 :C2EA6D9C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-22 01:00:05.134766 :C2EA6DA4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-22 01:00:05.138460 :C2EA6DAC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-22 01:00:05.142122 :C2EA6DB4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-22 01:00:05.146415 :C2EA6DBC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-22 01:00:05.147561 :C2EA6DC4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-22 01:00:06.298659*:C2EA6DEB:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000002B4C1B88 estart=1755795605 eid=16780874 ctx=0x000000077BA4B1C8 cwh=0x000000002B420500 cpu=546875 buffg=0 interb=0 r=0 rb=0 w=0 wb=0 2025-08-22 01:00:06.298659*:C2EA6DEC:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000002B4C1B88 curCtx=0x000000002B54F998 pubTabIdxCnt=0 2025-08-22 01:00:06.298659*:C2EA6DED:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000002B4C1B88 2025-08-22 01:00:06.298659*:C2EA6DEE:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000002B4C1B88 2025-08-22 01:00:06.298659*:C2EA6DEF:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000002B433990 estart=1755795605 eid=16780853 ctx=0x0000000787AD5BF0 cwh=0x000000002B4207D0 cpu=546875 buffg=0 interb=0 r=0 rb=0 w=0 wb=0 2025-08-22 01:00:06.298659*:C2EA6DF0:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000002B433990 curCtx=0x000000002B4C2B28 pubTabIdxCnt=0 2025-08-22 01:00:06.298659*:C2EA6DF1:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000002B433990 2025-08-22 01:00:06.298659*:C2EA6DF2:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000002B433990 2025-08-22 01:00:06.298659*:C2EA6DF3:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000002B4C1B88 curCtx=0x000000002B54F998 xsc->flg4=65792 flags=1 2025-08-22 01:00:06.298659*:C2EA6DF4:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000002B4C1B88 2025-08-22 01:00:06.298659*:C2EA6DF5:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000002B433990 curCtx=0x000000002B4C2B28 xsc->flg4=65792 flags=2 2025-08-22 01:00:06.298659*:C2EA6DF6:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000002B433990 2025-08-22 01:00:06.372803 :C2EA6DF7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-22 01:00:06.419883 :C2EA6DFF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-22 01:00:06.420217 :C2EA6E07:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-22 01:00:06.420498 :C2EA6E0F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-22 01:00:06.420515 :C2EA6E12:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-22 01:00:06.420578 :C2EA6E1E:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-08-22 01:00:06.423357 :C2EA6E2C:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-08-22 01:00:14.924418 :C2EA7161:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 08-22 01:00:14.911 2025-08-22 01:00:14.924420 :C2EA7162:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=20664 pso_num=29 pso_serial#=172 2025-08-22 01:00:14.924555 :C2EA7163:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=20664 (legacy spawn) 2025-08-22 01:00:14.931065 :C2EA7164:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-22 01:00:14.931234 :C2EA7169:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-08-22 01:00:14.932028 :C2EA716E:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-08-22 01:00:28.388049 :C2EA7578:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 08-22 01:00:28.373 2025-08-22 01:00:28.388050 :C2EA7579:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=21252 pso_num=29 pso_serial#=173 2025-08-22 01:00:28.388187 :C2EA757A:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=21252 (legacy spawn) 2025-08-22 01:00:28.394697 :C2EA757B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-22 01:00:28.394875 :C2EA7581:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-08-22 01:00:28.395670 :C2EA7585:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-08-22 01:00:28.413709 :C2EA7588:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 08-22 01:00:28.405 2025-08-22 01:00:28.413712 :C2EA7589:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=16876 pso_num=29 pso_serial#=174 2025-08-22 01:00:28.413853 :C2EA758A:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=16876 (legacy spawn) 2025-08-22 01:00:28.420440 :C2EA758B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-22 01:00:28.420619 :C2EA7593:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-08-22 01:00:28.421461 :C2EA7595:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-08-22 01:00:31.584095 :C2EA7682:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 08-22 01:00:31.571 2025-08-22 01:00:31.584097 :C2EA7683:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=20408 pso_num=29 pso_serial#=175 2025-08-22 01:00:31.584238 :C2EA7684:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=20408 (legacy spawn) 2025-08-22 01:00:31.590794 :C2EA7685:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-22 01:00:31.590970 :C2EA768A:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-08-22 01:00:31.591851 :C2EA768F:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-08-22 01:00:31.600439 :C2EA7692:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 08-22 01:00:31.587 2025-08-22 01:00:31.600442 :C2EA7693:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=21796 pso_num=29 pso_serial#=176 2025-08-22 01:00:31.600580 :C2EA7694:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=21796 (legacy spawn) 2025-08-22 01:00:31.607082 :C2EA7695:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-22 01:00:31.607250 :C2EA769E:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-08-22 01:00:31.608090 :C2EA769F:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-08-22 08:10:32.100664 :C30C3275:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 08-22 08:10:32.096 2025-08-22 08:10:32.100665 :C30C3276:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=22044 pso_num=29 pso_serial#=177 2025-08-22 08:10:32.103283 :C30C3277:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=22044 osp_idx=27 osp_ver=16241 osp_pg=0 (spawn #513895) 2025-08-22 08:10:32.103285 :C30C3278:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-22 08:10:32.103285 :C30C3279:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=89 time=235934096 2025-08-22 08:10:32.103285 :C30C327A:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-08-22 08:10:32.103286 :C30C327B:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-08-22 08:10:32.103286 :C30C327C:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-08-22 08:10:32.103287 :C30C327D:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-22 08:10:32.103287 :C30C327E:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-22 08:10:32.109634 :C30C327F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-22 08:10:32.109682 :C30C3285:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-08-22 08:10:32.110114 :C30C3286:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-08-22 08:10:34.376830 :C30C33F6:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 08-22 08:10:34.361 2025-08-22 08:10:34.376831 :C30C33F7:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=21000 pso_num=29 pso_serial#=178 2025-08-22 08:10:34.376998 :C30C33F8:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=21000 osp_idx=27 osp_ver=16242 osp_pg=0 (spawn #513897) 2025-08-22 08:10:34.376999 :C30C33F9:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-22 08:10:34.376999 :C30C33FA:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=90 time=235936377 2025-08-22 08:10:34.376999 :C30C33FB:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-08-22 08:10:34.377000 :C30C33FC:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-08-22 08:10:34.377000 :C30C33FD:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-08-22 08:10:34.377001 :C30C33FE:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-22 08:10:34.377001 :C30C33FF:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-22 08:10:34.377522 :C30C3400:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-22 08:10:34.377562 :C30C3406:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-08-22 08:10:34.377939 :C30C3407:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 29 (osid: 21000, M001)