Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250428221612\orcl_m001_3272_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:37579M/63366M, Ph+PgF:45221M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 27 Windows thread id: 3272, image: ORACLE.EXE (M001) *** 2025-04-28 22:16:13.003 *** 2025-04-28 22:16:13.003 Process diagnostic dump for ORACLE.EXE (M001), OS id=3272, pid: 27, proc_ser: 51, sid: ------------------------------------------------------------------------------- Skipping session state dump because target process has no session. ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-04-28 22:16:13.003 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 27 (osid: 3272, M001) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-04-28 22:11:45.044775 :90172CE5:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-04-28 22:12:19.139072 :90173879:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 04-28 22:12:19.130 2025-04-28 22:12:19.139074 :9017387A:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=10904 pso_num=27 pso_serial#=26 2025-04-28 22:12:19.139210 :9017387B:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=10904 (legacy spawn) 2025-04-28 22:12:19.145675 :9017387C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 22:12:19.145851 :90173881:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-04-28 22:12:19.146657 :90173886:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-04-28 22:12:31.375266 :90173C61:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 04-28 22:12:31.367 2025-04-28 22:12:31.375268 :90173C62:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=7708 pso_num=27 pso_serial#=27 2025-04-28 22:12:31.375409 :90173C63:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=7708 (legacy spawn) 2025-04-28 22:12:31.381927 :90173C64:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 22:12:31.382097 :90173C69:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-04-28 22:12:31.382957 :90173C6E:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-04-28 22:12:43.804144 :9017404E:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 04-28 22:12:43.789 2025-04-28 22:12:43.804145 :9017404F:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=4352 pso_num=27 pso_serial#=28 2025-04-28 22:12:43.804282 :90174050:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=4352 (legacy spawn) 2025-04-28 22:12:43.810674 :90174051:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 22:12:43.810862 :9017405A:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-04-28 22:12:43.811664 :9017405B:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-04-28 22:12:43.820345 :9017405E:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 04-28 22:12:43.805 2025-04-28 22:12:43.820347 :9017405F:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=9756 pso_num=27 pso_serial#=29 2025-04-28 22:12:43.820482 :90174060:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=9756 (legacy spawn) 2025-04-28 22:12:43.826898 :90174061:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 22:12:43.827062 :9017406A:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-04-28 22:12:43.827899 :9017406B:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-04-28 22:12:46.948037 :90174158:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 04-28 22:12:46.935 2025-04-28 22:12:46.948039 :90174159:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=4884 pso_num=27 pso_serial#=30 2025-04-28 22:12:46.948181 :9017415A:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=4884 (legacy spawn) 2025-04-28 22:12:46.954671 :9017415B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 22:12:46.954841 :90174164:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-04-28 22:12:46.955630 :90174165:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-04-28 22:12:46.964269 :90174168:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 04-28 22:12:46.950 2025-04-28 22:12:46.964271 :90174169:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=10144 pso_num=27 pso_serial#=31 2025-04-28 22:12:46.964408 :9017416A:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=10144 (legacy spawn) 2025-04-28 22:12:46.970913 :9017416B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 22:12:46.971073 :90174174:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-04-28 22:12:46.971893 :90174175:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-04-28 22:13:20.211178 :90174C06:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 04-28 22:13:20.198 2025-04-28 22:13:20.211180 :90174C07:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=7452 pso_num=27 pso_serial#=32 2025-04-28 22:13:20.211318 :90174C08:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=7452 (legacy spawn) 2025-04-28 22:13:20.217791 :90174C09:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 22:13:20.217961 :90174C12:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-04-28 22:13:20.218757 :90174C13:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-04-28 22:13:20.227424 :90174C16:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 04-28 22:13:20.214 2025-04-28 22:13:20.227427 :90174C17:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=9168 pso_num=27 pso_serial#=33 2025-04-28 22:13:20.227561 :90174C18:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=9168 (legacy spawn) 2025-04-28 22:13:20.234017 :90174C19:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 22:13:20.234180 :90174C22:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-04-28 22:13:20.234951 :90174C23:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-04-28 22:13:23.331068 :90174D1F:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 04-28 22:13:23.318 2025-04-28 22:13:23.331070 :90174D20:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=10428 pso_num=27 pso_serial#=34 2025-04-28 22:13:23.331217 :90174D21:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=10428 (legacy spawn) 2025-04-28 22:13:23.337706 :90174D22:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 22:13:23.337892 :90174D2A:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-04-28 22:13:23.338690 :90174D2C:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-04-28 22:13:23.347424 :90174D2F:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 04-28 22:13:23.334 2025-04-28 22:13:23.347426 :90174D30:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=11240 pso_num=27 pso_serial#=35 2025-04-28 22:13:23.347566 :90174D31:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=11240 (legacy spawn) 2025-04-28 22:13:23.354063 :90174D32:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 22:13:23.354092 :90174D35:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 22:13:23.354245 :90174D3C:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-04-28 22:13:23.355045 :90174D49:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-04-28 22:13:26.288915 :90174E2B:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 04-28 22:13:26.281 2025-04-28 22:13:26.288917 :90174E2C:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=9480 pso_num=27 pso_serial#=36 2025-04-28 22:13:26.289053 :90174E2D:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=9480 (legacy spawn) 2025-04-28 22:13:26.295418 :90174E2E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 22:13:26.295592 :90174E37:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-04-28 22:13:26.296400 :90174E38:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-04-28 22:13:27.159813 :90174E52:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 04-28 22:13:27.151 2025-04-28 22:13:27.159815 :90174E53:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=1164 pso_num=27 pso_serial#=37 2025-04-28 22:13:27.159953 :90174E54:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=1164 (legacy spawn) 2025-04-28 22:13:27.166522 :90174E55:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 22:13:27.166686 :90174E5A:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-04-28 22:13:27.167491 :90174E5F:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-04-28 22:13:33.545473 :90175044:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 04-28 22:13:33.537 2025-04-28 22:13:33.545475 :90175045:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=10320 pso_num=27 pso_serial#=38 2025-04-28 22:13:33.545620 :90175046:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=10320 (legacy spawn) 2025-04-28 22:13:33.552084 :90175047:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 22:13:33.552260 :90175050:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-04-28 22:13:33.553072 :90175051:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-04-28 22:13:34.214184 :901750DA:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 04-28 22:13:34.209 2025-04-28 22:13:34.214186 :901750DB:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=9340 pso_num=27 pso_serial#=39 2025-04-28 22:13:34.214332 :901750DC:db_trace:kso.c@4093:ksonfy(): [10420:27:0] kso: new process: pid=9340 osp_idx=25 osp_ver=34973 osp_pg=0 (spawn #128427) 2025-04-28 22:13:34.214333 :901750DD:db_trace:kso.c@4099:ksonfy(): [10420:27:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-28 22:13:34.214333 :901750DE:db_trace:kso.c@4103:ksonfy(): [10420:27:0] kso: new process: pso_index=27 reservation=165 time=3149203703 2025-04-28 22:13:34.214333 :901750DF:db_trace:kso.c@4109:ksonfy(): [10420:27:0] kso: spawn diagnostics: queue time=0 secs 2025-04-28 22:13:34.214334 :901750E0:db_trace:kso.c@4111:ksonfy(): [10420:27:0] kso: spawn diagnostics: fork time=0 secs 2025-04-28 22:13:34.214334 :901750E1:db_trace:kso.c@4113:ksonfy(): [10420:27:0] kso: spawn diagnostics: exec time=0 secs 2025-04-28 22:13:34.214334 :901750E2:db_trace:kso.c@4115:ksonfy(): [10420:27:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-28 22:13:34.214335 :901750E3:db_trace:kso.c@4117:ksonfy(): [10420:27:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-28 22:13:34.214840 :901750E4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-04-28 22:13:34.214891 :901750EA:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] KSL POST RCVD poster=18 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-04-28 22:13:34.236444 :90175157:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-04-28 22:14:33.049861 :9017652D:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 04-28 22:14:33.035 2025-04-28 22:14:33.049863 :9017652E:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=10236 pso_num=27 pso_serial#=40 2025-04-28 22:14:33.050007 :9017652F:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=10236 (legacy spawn) 2025-04-28 22:14:33.056407 :90176530:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 22:14:33.056582 :90176535:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-04-28 22:14:33.057373 :9017653A:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-04-28 22:14:33.065867 :9017653D:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 04-28 22:14:33.051 2025-04-28 22:14:33.065869 :9017653E:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=608 pso_num=27 pso_serial#=41 2025-04-28 22:14:33.066000 :9017653F:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=608 (legacy spawn) 2025-04-28 22:14:33.072432 :90176540:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 22:14:33.072597 :90176548:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-04-28 22:14:33.073395 :9017654A:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-04-28 22:14:35.450878 :90176628:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 04-28 22:14:35.442 2025-04-28 22:14:35.450880 :90176629:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=9104 pso_num=27 pso_serial#=42 2025-04-28 22:14:35.451012 :9017662A:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=9104 (legacy spawn) 2025-04-28 22:14:35.457468 :9017662B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 22:14:35.457632 :90176630:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-04-28 22:14:35.458514 :90176635:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-04-28 22:14:35.980824 :90176653:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 04-28 22:14:35.973 2025-04-28 22:14:35.980827 :90176654:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=9800 pso_num=27 pso_serial#=43 2025-04-28 22:14:35.980956 :90176655:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=9800 (legacy spawn) 2025-04-28 22:14:35.987439 :90176656:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 22:14:35.987609 :9017665F:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-04-28 22:14:35.988464 :90176660:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-04-28 22:14:36.121968 :90176663:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 04-28 22:14:36.113 2025-04-28 22:14:36.121970 :90176664:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=10108 pso_num=27 pso_serial#=44 2025-04-28 22:14:36.122117 :90176665:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=10108 (legacy spawn) 2025-04-28 22:14:36.128588 :90176666:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 22:14:36.128759 :9017666F:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-04-28 22:14:36.129612 :90176670:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-04-28 22:14:36.138190 :90176673:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 04-28 22:14:36.129 2025-04-28 22:14:36.138193 :90176674:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=10360 pso_num=27 pso_serial#=45 2025-04-28 22:14:36.138328 :90176675:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=10360 (legacy spawn) 2025-04-28 22:14:36.144736 :90176676:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 22:14:36.144899 :9017667F:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-04-28 22:14:36.145682 :90176680:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-04-28 22:15:38.175150 :90177A8F:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 04-28 22:15:38.167 2025-04-28 22:15:38.175152 :90177A90:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=9780 pso_num=27 pso_serial#=46 2025-04-28 22:15:38.175289 :90177A91:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=9780 (legacy spawn) 2025-04-28 22:15:38.181663 :90177A92:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 22:15:38.181848 :90177A9B:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-04-28 22:15:38.182690 :90177A9C:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-04-28 22:15:43.680587 :90177C52:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 04-28 22:15:43.671 2025-04-28 22:15:43.680589 :90177C53:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=7996 pso_num=27 pso_serial#=47 2025-04-28 22:15:43.680727 :90177C54:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=7996 (legacy spawn) 2025-04-28 22:15:43.687256 :90177C55:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 22:15:43.687418 :90177C5A:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-04-28 22:15:43.688183 :90177C5F:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-04-28 22:15:45.818508 :90177C98:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 04-28 22:15:45.804 2025-04-28 22:15:45.818510 :90177C99:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=9048 pso_num=27 pso_serial#=48 2025-04-28 22:15:45.818703 :90177C9A:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=9048 (legacy spawn) 2025-04-28 22:15:45.825121 :90177C9B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 22:15:45.825323 :90177CA0:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-04-28 22:15:45.826118 :90177CA5:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-04-28 22:15:45.834827 :90177CA8:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 04-28 22:15:45.819 2025-04-28 22:15:45.834830 :90177CA9:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=8812 pso_num=27 pso_serial#=49 2025-04-28 22:15:45.834967 :90177CAA:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=8812 (legacy spawn) 2025-04-28 22:15:45.841431 :90177CAB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 22:15:45.841589 :90177CB4:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-04-28 22:15:45.842371 :90177CB5:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-04-28 22:16:11.476372 :9017BF3B:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 04-28 22:16:11.467 2025-04-28 22:16:11.476374 :9017BF3C:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=4208 pso_num=27 pso_serial#=50 2025-04-28 22:16:11.478304 :9017BF3D:db_trace:kso.c@4093:ksonfy(): [10420:27:0] kso: new process: pid=4208 osp_idx=25 osp_ver=34984 osp_pg=0 (spawn #128435) 2025-04-28 22:16:11.478305 :9017BF3E:db_trace:kso.c@4099:ksonfy(): [10420:27:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-28 22:16:11.478306 :9017BF3F:db_trace:kso.c@4103:ksonfy(): [10420:27:0] kso: new process: pso_index=27 reservation=166 time=3149360937 2025-04-28 22:16:11.478307 :9017BF40:db_trace:kso.c@4109:ksonfy(): [10420:27:0] kso: spawn diagnostics: queue time=0 secs 2025-04-28 22:16:11.478307 :9017BF41:db_trace:kso.c@4111:ksonfy(): [10420:27:0] kso: spawn diagnostics: fork time=0 secs 2025-04-28 22:16:11.478307 :9017BF42:db_trace:kso.c@4113:ksonfy(): [10420:27:0] kso: spawn diagnostics: exec time=0 secs 2025-04-28 22:16:11.478308 :9017BF43:db_trace:kso.c@4115:ksonfy(): [10420:27:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-28 22:16:11.478308 :9017BF44:db_trace:kso.c@4117:ksonfy(): [10420:27:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-28 22:16:11.481706 :9017BF45:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-04-28 22:16:11.481757 :9017BF4B:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] KSL POST RCVD poster=18 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-04-28 22:16:11.482243 :9017BF4C:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-04-28 22:16:12.753634 :9017BFB2:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 04-28 22:16:12.753 2025-04-28 22:16:12.753636 :9017BFB3:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=3272 pso_num=27 pso_serial#=51 2025-04-28 22:16:12.753794 :9017BFB4:db_trace:kso.c@4093:ksonfy(): [10420:27:0] kso: new process: pid=3272 osp_idx=25 osp_ver=34985 osp_pg=0 (spawn #128437) 2025-04-28 22:16:12.753795 :9017BFB5:db_trace:kso.c@4099:ksonfy(): [10420:27:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-28 22:16:12.753795 :9017BFB6:db_trace:kso.c@4103:ksonfy(): [10420:27:0] kso: new process: pso_index=27 reservation=167 time=3149362218 2025-04-28 22:16:12.753796 :9017BFB7:db_trace:kso.c@4109:ksonfy(): [10420:27:0] kso: spawn diagnostics: queue time=0 secs 2025-04-28 22:16:12.753796 :9017BFB8:db_trace:kso.c@4111:ksonfy(): [10420:27:0] kso: spawn diagnostics: fork time=0 secs 2025-04-28 22:16:12.753797 :9017BFB9:db_trace:kso.c@4113:ksonfy(): [10420:27:0] kso: spawn diagnostics: exec time=0 secs 2025-04-28 22:16:12.753797 :9017BFBA:db_trace:kso.c@4115:ksonfy(): [10420:27:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-28 22:16:12.753797 :9017BFBB:db_trace:kso.c@4117:ksonfy(): [10420:27:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-28 22:16:12.754437 :9017BFBC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-04-28 22:16:12.754491 :9017BFC2:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] KSL POST RCVD poster=18 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-04-28 22:16:12.754972 :9017BFC3:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 27 (osid: 3272, M001)