Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250601140716\orcl_j000_14120_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:37165M/63366M, Ph+PgF:44019M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 34 Windows thread id: 14120, image: ORACLE.EXE (J000) *** 2025-06-01 14:07:17.063 *** 2025-06-01 14:07:17.063 Process diagnostic dump for ORACLE.EXE (J000), OS id=14120, pid: 34, proc_ser: 194, 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-01 14:07:17.063 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 34 (osid: 14120, J000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-27 23:59:30.193943 :9CE2F3A4:db_trace:kso.c@4070:ksonfy(): [10420:34:0] kso: new process: pid=14668 (legacy spawn) 2025-05-27 23:59:30.213834 :9CE2F3A5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-27 23:59:33.540561 :9CE2F4F5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-27 23:59:33.540735 :9CE2F4FA:db_trace:ksl2.c@12699:ksliwat(): [10005:34:18] 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-05-27 23:59:33.541897 :9CE2F4FF:db_trace:kst.c@698:kstpsodel(): [10280:34:0] kst: process state object about to be deleted 2025-05-27 23:59:33.792113 :9CE2F50E:db_trace:kst.c@673:kstipg(): [10280:34:0] kst: process state object created on 05-27 23:59:33.785 2025-05-27 23:59:33.792115 :9CE2F50F:db_trace:kst.c@679:kstipg(): [10280:34:0] kst: process info: ospid=14952 pso_num=34 pso_serial#=179 2025-05-27 23:59:33.792252 :9CE2F510:db_trace:kso.c@4070:ksonfy(): [10420:34:0] kso: new process: pid=14952 (legacy spawn) 2025-05-27 23:59:33.806464 :9CE2F511:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-28 00:00:06.977262 :9CE3013A:db_trace:kst.c@698:kstpsodel(): [10280:34:0] kst: process state object about to be deleted 2025-05-28 00:00:11.406274 :9CE3029B:db_trace:kst.c@673:kstipg(): [10280:34:0] kst: process state object created on 05-28 00:00:11.401 2025-05-28 00:00:11.406276 :9CE3029C:db_trace:kst.c@679:kstipg(): [10280:34:0] kst: process info: ospid=15068 pso_num=34 pso_serial#=180 2025-05-28 00:00:11.406419 :9CE3029D:db_trace:kso.c@4093:ksonfy(): [10420:34:0] kso: new process: pid=15068 osp_idx=32 osp_ver=179 osp_pg=0 (spawn #226098) 2025-05-28 00:00:11.406420 :9CE3029E:db_trace:kso.c@4099:ksonfy(): [10420:34:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-28 00:00:11.406420 :9CE3029F:db_trace:kso.c@4103:ksonfy(): [10420:34:0] kso: new process: pso_index=34 reservation=34 time=1366183657 2025-05-28 00:00:11.406421 :9CE302A0:db_trace:kso.c@4109:ksonfy(): [10420:34:0] kso: spawn diagnostics: queue time=0 secs 2025-05-28 00:00:11.406421 :9CE302A1:db_trace:kso.c@4111:ksonfy(): [10420:34:0] kso: spawn diagnostics: fork time=0 secs 2025-05-28 00:00:11.406421 :9CE302A2:db_trace:kso.c@4113:ksonfy(): [10420:34:0] kso: spawn diagnostics: exec time=0 secs 2025-05-28 00:00:11.406422 :9CE302A3:db_trace:kso.c@4115:ksonfy(): [10420:34:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-28 00:00:11.406422 :9CE302A4:db_trace:kso.c@4117:ksonfy(): [10420:34:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-28 00:00:11.406915 :9CE302A5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-28 00:00:11.406957 :9CE302AB:db_trace:ksl2.c@12699:ksliwat(): [10005:34:18] 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-28 00:00:11.411345 :9CE302BE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-28 00:00:11.436123 :9CE302C6:db_trace:ksb.c@6610:ksbcic_int(): [10254:34:18] KSBCIC: (USER) starting cic on opcode KSBCIRCO [1] with args (1 4286500091 8467208) 2025-05-28 00:00:11.436130 :9CE302C7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=15 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-28 00:00:11.436178 :9CE302CF:db_trace:ksl2.c@12699:ksliwat(): [10005:34:18] KSL POST RCVD poster=15 loc='ksa2.h LINE:286 ID:ksasnr' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-28 00:00:11.436226 :9CE302DF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-28 00:00:11.451139 :9CE302E7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-28 00:00:11.477888 :9CE302EF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-28 00:00:11.481814 :9CE302F7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-28 00:00:11.485523 :9CE302FF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-28 00:00:11.489818 :9CE30307:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-28 00:00:11.490903 :9CE3030F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-28 00:00:11.544881 :9CE30317:db_trace:ktu.c@4871:ktuaex1r(): [10442:34:18] Extension usn 9, ext 2, nex 4 2025-05-28 00:00:11.544888 :9CE30318:db_trace:ktusm.c@2117:ktusmasp(): [10445:34:18] des1:tsn:1 rdba:0x00812e47 where: kdiwh22: kdifind 2025-05-28 00:00:12.121753 :9CE3037C:db_trace:ktu.c@4871:ktuaex1r(): [10442:34:18] Extension usn 9, ext 3, nex 5 2025-05-28 00:00:12.121762 :9CE3037D:db_trace:ktusm.c@2117:ktusmasp(): [10445:34:18] des1:tsn:1 rdba:0x00813143 where: kdiwh22: kdifind 2025-05-28 00:00:12.746910 :9CE3038A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-28 00:00:12.777735 :9CE30392:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-28 00:00:12.778044 :9CE3039A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-28 00:00:12.778321 :9CE303A2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-28 00:00:12.778337 :9CE303A5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=18 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-28 00:00:12.778403 :9CE303B5:db_trace:ksl2.c@12699:ksliwat(): [10005:34:18] 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-05-28 00:00:12.781980 :9CE303BF:db_trace:kst.c@698:kstpsodel(): [10280:34:0] kst: process state object about to be deleted 2025-05-28 23:59:18.277303 :9D535AEC:db_trace:kst.c@673:kstipg(): [10280:34:0] kst: process state object created on 05-28 23:59:18.265 2025-05-28 23:59:18.277305 :9D535AED:db_trace:kst.c@679:kstipg(): [10280:34:0] kst: process info: ospid=14868 pso_num=34 pso_serial#=181 2025-05-28 23:59:18.277431 :9D535AEE:db_trace:kso.c@4070:ksonfy(): [10420:34:0] kso: new process: pid=14868 (legacy spawn) 2025-05-28 23:59:18.283749 :9D535AF7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-28 23:59:18.283887 :9D535B00:db_trace:ksl2.c@12699:ksliwat(): [10005:34:18] 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-05-28 23:59:18.284641 :9D535B01:db_trace:kst.c@698:kstpsodel(): [10280:34:0] kst: process state object about to be deleted 2025-05-28 23:59:30.510573 :9D535F37:db_trace:kst.c@673:kstipg(): [10280:34:0] kst: process state object created on 05-28 23:59:30.497 2025-05-28 23:59:30.510576 :9D535F38:db_trace:kst.c@679:kstipg(): [10280:34:0] kst: process info: ospid=12904 pso_num=34 pso_serial#=182 2025-05-28 23:59:30.510720 :9D535F39:db_trace:kso.c@4070:ksonfy(): [10420:34:0] kso: new process: pid=12904 (legacy spawn) 2025-05-28 23:59:30.524651 :9D535F3A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 00:00:03.662930 :9D536BB6:db_trace:kst.c@698:kstpsodel(): [10280:34:0] kst: process state object about to be deleted 2025-05-29 23:59:22.058316 :9DC44852:db_trace:kst.c@673:kstipg(): [10280:34:0] kst: process state object created on 05-29 23:59:22.051 2025-05-29 23:59:22.058318 :9DC44853:db_trace:kst.c@679:kstipg(): [10280:34:0] kst: process info: ospid=14196 pso_num=34 pso_serial#=183 2025-05-29 23:59:22.058460 :9DC44854:db_trace:kso.c@4070:ksonfy(): [10420:34:0] kso: new process: pid=14196 (legacy spawn) 2025-05-29 23:59:22.072570 :9DC44855:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 23:59:25.287186 :9DC4495C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 23:59:25.287367 :9DC44961:db_trace:ksl2.c@12699:ksliwat(): [10005:34:18] 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-05-29 23:59:25.288597 :9DC44966:db_trace:kst.c@698:kstpsodel(): [10280:34:0] kst: process state object about to be deleted 2025-05-29 23:59:25.541338 :9DC44996:db_trace:kst.c@673:kstipg(): [10280:34:0] kst: process state object created on 05-29 23:59:25.528 2025-05-29 23:59:25.541340 :9DC44997:db_trace:kst.c@679:kstipg(): [10280:34:0] kst: process info: ospid=15120 pso_num=34 pso_serial#=184 2025-05-29 23:59:25.541480 :9DC44998:db_trace:kso.c@4070:ksonfy(): [10420:34:0] kso: new process: pid=15120 (legacy spawn) 2025-05-29 23:59:25.555624 :9DC44999:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 23:59:58.757174 :9DC4556C:db_trace:kst.c@698:kstpsodel(): [10280:34:0] kst: process state object about to be deleted 2025-05-30 23:59:26.306455 :9E3532A8:db_trace:kst.c@673:kstipg(): [10280:34:0] kst: process state object created on 05-30 23:59:26.299 2025-05-30 23:59:26.306457 :9E3532A9:db_trace:kst.c@679:kstipg(): [10280:34:0] kst: process info: ospid=4804 pso_num=34 pso_serial#=185 2025-05-30 23:59:26.306587 :9E3532AA:db_trace:kso.c@4070:ksonfy(): [10420:34:0] kso: new process: pid=4804 (legacy spawn) 2025-05-30 23:59:26.313003 :9E3532AB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-30 23:59:26.313175 :9E3532B0:db_trace:ksl2.c@12699:ksliwat(): [10005:34:18] 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-05-30 23:59:26.313966 :9E3532B5:db_trace:kst.c@698:kstpsodel(): [10280:34:0] kst: process state object about to be deleted 2025-05-30 23:59:28.589346 :9E353366:db_trace:kst.c@673:kstipg(): [10280:34:0] kst: process state object created on 05-30 23:59:28.580 2025-05-30 23:59:28.589348 :9E353367:db_trace:kst.c@679:kstipg(): [10280:34:0] kst: process info: ospid=12736 pso_num=34 pso_serial#=186 2025-05-30 23:59:28.589482 :9E353368:db_trace:kso.c@4070:ksonfy(): [10420:34:0] kso: new process: pid=12736 (legacy spawn) 2025-05-30 23:59:28.595956 :9E353369:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-30 23:59:28.596148 :9E35336E:db_trace:ksl2.c@12699:ksliwat(): [10005:34:18] 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-05-30 23:59:28.596950 :9E353373:db_trace:kst.c@698:kstpsodel(): [10280:34:0] kst: process state object about to be deleted 2025-05-30 23:59:30.250293 :9E353413:db_trace:kst.c@673:kstipg(): [10280:34:0] kst: process state object created on 05-30 23:59:30.241 2025-05-30 23:59:30.250295 :9E353414:db_trace:kst.c@679:kstipg(): [10280:34:0] kst: process info: ospid=13436 pso_num=34 pso_serial#=187 2025-05-30 23:59:30.250427 :9E353415:db_trace:kso.c@4070:ksonfy(): [10420:34:0] kso: new process: pid=13436 (legacy spawn) 2025-05-30 23:59:30.264604 :9E353416:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-30 23:59:33.514720 :9E35351E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-30 23:59:33.514909 :9E353523:db_trace:ksl2.c@12699:ksliwat(): [10005:34:18] 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-05-30 23:59:33.516274 :9E353528:db_trace:kst.c@698:kstpsodel(): [10280:34:0] kst: process state object about to be deleted 2025-05-30 23:59:33.529231 :9E353543:db_trace:kst.c@673:kstipg(): [10280:34:0] kst: process state object created on 05-30 23:59:33.522 2025-05-30 23:59:33.529234 :9E353544:db_trace:kst.c@679:kstipg(): [10280:34:0] kst: process info: ospid=13928 pso_num=34 pso_serial#=188 2025-05-30 23:59:33.529518 :9E353545:db_trace:kso.c@4093:ksonfy(): [10420:34:0] kso: new process: pid=13928 osp_idx=32 osp_ver=187 osp_pg=0 (spawn #236084) 2025-05-30 23:59:33.529519 :9E353546:db_trace:kso.c@4099:ksonfy(): [10420:34:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-30 23:59:33.529520 :9E353547:db_trace:kso.c@4103:ksonfy(): [10420:34:0] kso: new process: pso_index=34 reservation=35 time=1625332172 2025-05-30 23:59:33.529520 :9E353548:db_trace:kso.c@4109:ksonfy(): [10420:34:0] kso: spawn diagnostics: queue time=0 secs 2025-05-30 23:59:33.529521 :9E353549:db_trace:kso.c@4111:ksonfy(): [10420:34:0] kso: spawn diagnostics: fork time=0 secs 2025-05-30 23:59:33.529521 :9E35354A:db_trace:kso.c@4113:ksonfy(): [10420:34:0] kso: spawn diagnostics: exec time=0 secs 2025-05-30 23:59:33.529521 :9E35354B:db_trace:kso.c@4115:ksonfy(): [10420:34:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-30 23:59:33.529522 :9E35354C:db_trace:kso.c@4117:ksonfy(): [10420:34:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-30 23:59:33.530232 :9E35354D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-30 23:59:33.531247 :9E353562:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-30 23:59:33.542569 :9E35357E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:34:18] atxpus:psdpgi.c:2235 2025-05-30 23:59:33.542961 :9E35357F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-30 23:59:33.542995 :9E353582:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:34:18] atxpop:psdpgi.c:2235 2025-05-30 23:59:33.543811 :9E353588:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-30 23:59:33.543937 :9E353591:db_trace:ksl2.c@12699:ksliwat(): [10005:34:18] 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-05-31 00:00:03.624294 :9E354059:db_trace:kst.c@698:kstpsodel(): [10280:34:0] kst: process state object about to be deleted 2025-05-31 00:00:06.454325 :9E3541DC:db_trace:kst.c@673:kstipg(): [10280:34:0] kst: process state object created on 05-31 00:00:06.441 2025-05-31 00:00:06.454327 :9E3541DD:db_trace:kst.c@679:kstipg(): [10280:34:0] kst: process info: ospid=15000 pso_num=34 pso_serial#=189 2025-05-31 00:00:06.454458 :9E3541DE:db_trace:kso.c@4093:ksonfy(): [10420:34:0] kso: new process: pid=15000 osp_idx=32 osp_ver=188 osp_pg=0 (spawn #236088) 2025-05-31 00:00:06.454459 :9E3541DF:db_trace:kso.c@4099:ksonfy(): [10420:34:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-31 00:00:06.454459 :9E3541E0:db_trace:kso.c@4103:ksonfy(): [10420:34:0] kso: new process: pso_index=34 reservation=36 time=1625365094 2025-05-31 00:00:06.454460 :9E3541E1:db_trace:kso.c@4109:ksonfy(): [10420:34:0] kso: spawn diagnostics: queue time=0 secs 2025-05-31 00:00:06.454460 :9E3541E2:db_trace:kso.c@4111:ksonfy(): [10420:34:0] kso: spawn diagnostics: fork time=0 secs 2025-05-31 00:00:06.454461 :9E3541E3:db_trace:kso.c@4113:ksonfy(): [10420:34:0] kso: spawn diagnostics: exec time=0 secs 2025-05-31 00:00:06.454461 :9E3541E4:db_trace:kso.c@4115:ksonfy(): [10420:34:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-31 00:00:06.454461 :9E3541E5:db_trace:kso.c@4117:ksonfy(): [10420:34:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-31 00:00:06.454965 :9E3541E6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-31 00:00:06.455013 :9E3541EC:db_trace:ksl2.c@12699:ksliwat(): [10005:34:18] 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 00:00:06.462851 :9E3541FA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 00:00:06.463920 :9E354202:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 00:00:06.464560 :9E35420A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 00:00:06.465037 :9E354212:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 00:00:06.465478 :9E35421A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 00:00:06.467906 :9E354222:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 00:00:06.469071 :9E35422A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 00:00:06.518776 :9E354232:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 00:00:06.519809 :9E35423A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 00:00:06.520077 :9E354242:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 00:00:06.520315 :9E35424A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 00:00:06.520564 :9E354253:db_trace:ksl2.c@12699:ksliwat(): [10005:34:18] 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-05-31 00:00:06.522154 :9E354254:db_trace:kst.c@698:kstpsodel(): [10280:34:0] kst: process state object about to be deleted 2025-05-31 23:59:19.652908 :9EA4E0B7:db_trace:kst.c@673:kstipg(): [10280:34:0] kst: process state object created on 05-31 23:59:19.645 2025-05-31 23:59:19.652910 :9EA4E0B8:db_trace:kst.c@679:kstipg(): [10280:34:0] kst: process info: ospid=14964 pso_num=34 pso_serial#=190 2025-05-31 23:59:19.653050 :9EA4E0B9:db_trace:kso.c@4070:ksonfy(): [10420:34:0] kso: new process: pid=14964 (legacy spawn) 2025-05-31 23:59:19.659607 :9EA4E0BA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 23:59:19.659796 :9EA4E0BF:db_trace:ksl2.c@12699:ksliwat(): [10005:34:18] 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-05-31 23:59:19.660947 :9EA4E0C4:db_trace:kst.c@698:kstpsodel(): [10280:34:0] kst: process state object about to be deleted 2025-05-31 23:59:22.209421 :9EA4E161:db_trace:kst.c@673:kstipg(): [10280:34:0] kst: process state object created on 05-31 23:59:22.197 2025-05-31 23:59:22.209423 :9EA4E162:db_trace:kst.c@679:kstipg(): [10280:34:0] kst: process info: ospid=10376 pso_num=34 pso_serial#=191 2025-05-31 23:59:22.209561 :9EA4E163:db_trace:kso.c@4070:ksonfy(): [10420:34:0] kso: new process: pid=10376 (legacy spawn) 2025-05-31 23:59:22.223681 :9EA4E164:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 23:59:25.317835 :9EA4E274:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 23:59:25.318029 :9EA4E279:db_trace:ksl2.c@12699:ksliwat(): [10005:34:18] 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-05-31 23:59:25.319289 :9EA4E27E:db_trace:kst.c@698:kstpsodel(): [10280:34:0] kst: process state object about to be deleted 2025-05-31 23:59:26.732836 :9EA4E353:db_trace:kst.c@673:kstipg(): [10280:34:0] kst: process state object created on 05-31 23:59:26.718 2025-05-31 23:59:26.732838 :9EA4E354:db_trace:kst.c@679:kstipg(): [10280:34:0] kst: process info: ospid=13120 pso_num=34 pso_serial#=192 2025-05-31 23:59:26.732970 :9EA4E355:db_trace:kso.c@4070:ksonfy(): [10420:34:0] kso: new process: pid=13120 (legacy spawn) 2025-05-31 23:59:26.739837 :9EA4E356:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 23:59:26.740012 :9EA4E35F:db_trace:ksl2.c@12699:ksliwat(): [10005:34:18] 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-05-31 23:59:26.740903 :9EA4E360:db_trace:kst.c@698:kstpsodel(): [10280:34:0] kst: process state object about to be deleted 2025-05-31 23:59:26.758062 :9EA4E363:db_trace:kst.c@673:kstipg(): [10280:34:0] kst: process state object created on 05-31 23:59:26.750 2025-05-31 23:59:26.758064 :9EA4E364:db_trace:kst.c@679:kstipg(): [10280:34:0] kst: process info: ospid=12564 pso_num=34 pso_serial#=193 2025-05-31 23:59:26.758220 :9EA4E365:db_trace:kso.c@4070:ksonfy(): [10420:34:0] kso: new process: pid=12564 (legacy spawn) 2025-05-31 23:59:26.766048 :9EA4E366:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 23:59:26.766318 :9EA4E36F:db_trace:ksl2.c@12699:ksliwat(): [10005:34:18] 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-05-31 23:59:26.769272 :9EA4E370:db_trace:kst.c@698:kstpsodel(): [10280:34:0] kst: process state object about to be deleted 2025-05-31 23:59:27.989600 :9EA4E3AA:db_trace:kst.c@673:kstipg(): [10280:34:0] kst: process state object created on 05-31 23:59:27.984 2025-05-31 23:59:27.989602 :9EA4E3AB:db_trace:kst.c@679:kstipg(): [10280:34:0] kst: process info: ospid=14120 pso_num=34 pso_serial#=194 2025-05-31 23:59:27.989743 :9EA4E3AC:db_trace:kso.c@4093:ksonfy(): [10420:34:0] kso: new process: pid=14120 osp_idx=32 osp_ver=193 osp_pg=0 (spawn #239429) 2025-05-31 23:59:27.989743 :9EA4E3AD:db_trace:kso.c@4099:ksonfy(): [10420:34:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-31 23:59:27.989743 :9EA4E3AE:db_trace:kso.c@4103:ksonfy(): [10420:34:0] kso: new process: pso_index=34 reservation=37 time=1711726641 2025-05-31 23:59:27.989744 :9EA4E3AF:db_trace:kso.c@4109:ksonfy(): [10420:34:0] kso: spawn diagnostics: queue time=0 secs 2025-05-31 23:59:27.989744 :9EA4E3B0:db_trace:kso.c@4111:ksonfy(): [10420:34:0] kso: spawn diagnostics: fork time=0 secs 2025-05-31 23:59:27.989744 :9EA4E3B1:db_trace:kso.c@4113:ksonfy(): [10420:34:0] kso: spawn diagnostics: exec time=0 secs 2025-05-31 23:59:27.989745 :9EA4E3B2:db_trace:kso.c@4115:ksonfy(): [10420:34:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-31 23:59:27.989745 :9EA4E3B3:db_trace:kso.c@4117:ksonfy(): [10420:34:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-31 23:59:27.990264 :9EA4E3B4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-31 23:59:27.990923 :9EA4E3C9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 23:59:27.996371 :9EA4E3E5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 23:59:27.997443 :9EA4E3ED:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 23:59:27.997590 :9EA4E3F6:db_trace:ksl2.c@12699:ksliwat(): [10005:34:18] 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-05-31 23:59:53.013494 :9EA4ED1E:db_trace:ksl2.c@12699:ksliwat(): [10005:34:18] KSL POST RCVD poster=59 loc='kkj.h LINE:914 ID:kkjpstnp' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-31 23:59:53.013517*:9EA4ED23:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000002715BB58 estart=1748707192 eid=16887520 ctx=0x000000077BD98A08 cwh=0x0000000026BD02A0 cpu=0 buffg=1 interb=0 r=0 rb=0 w=0 wb=0 2025-05-31 23:59:53.013517*:9EA4ED24:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000002715BB58 curCtx=0x0000000026BDF300 pubTabIdxCnt=0 2025-05-31 23:59:53.013517*:9EA4ED25:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000002715BB58 2025-05-31 23:59:53.013517*:9EA4ED26:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000002715BB58 2025-05-31 23:59:53.013517*:9EA4ED27:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000002715BB58 curCtx=0x0000000026BDF300 xsc->flg4=65792 flags=2 2025-05-31 23:59:53.013517*:9EA4ED28:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000002715BB58 2025-05-31 23:59:53.014034 :9EA4ED29:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 23:59:53.021398 :9EA4ED31:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:34:18] atxpus:psdpgi.c:2235 2025-05-31 23:59:53.021767 :9EA4ED32:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 23:59:53.021803 :9EA4ED35:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:34:18] atxpop:psdpgi.c:2235 2025-05-31 23:59:53.022611 :9EA4ED3B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:34:18] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 23:59:53.022733 :9EA4ED44:db_trace:ksl2.c@12699:ksliwat(): [10005:34:18] 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-01 00:00:23.048462 :9EA4F93C:db_trace:kst.c@698:kstpsodel(): [10280:34:0] kst: process state object about to be deleted ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 34 (osid: 14120, J000)