Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250524100036\orcl_vkrm_11304_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:37316M/63366M, Ph+PgF:44384M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 26 Windows thread id: 11304, image: ORACLE.EXE (VKRM) *** 2025-05-24 10:00:36.882 *** SESSION ID:(209.59269) 2025-05-24 10:00:36.882 *** 2025-05-24 10:00:36.882 Process diagnostic dump for ORACLE.EXE (VKRM), OS id=11304, pid: 26, proc_ser: 222, sid: 209, sess_ser: 59269 ------------------------------------------------------------------------------- current sql: Current Wait Stack: 0: waiting for 'VKRM Idle' =0x0, =0x0, =0x0 wait_id=0 seq_num=1 snap_id=1 wait times: snap=240 min 36 sec, exc=240 min 36 sec, total=240 min 36 sec wait times: max=infinite, heur=240 min 36 sec wait counts: calls=0 os=0 in_wait=1 iflags=0x5a0 Wait State: fixed_waits=0 flags=0x22 boundary=0x0000000000000000/-1 Session Wait History: elapsed time of 0.000000 sec since current wait Sampled Session History of session 209 serial 59269 --------------------------------------------------- The sampled session history is constructed by sampling the target session every 1 second. The sampling process captures at each sample if the session is in a non-idle wait, an idle wait, or not in a wait. If the session is in a non-idle wait then one interval is shown for all the samples the session was in the same non-idle wait. If the session is in an idle wait or not in a wait for consecutive samples then one interval is shown for all the consecutive samples. Though we display these consecutive samples in a single interval the session may NOT be continuously idle or not in a wait (the sampling process does not know). The history is displayed in reverse chronological order. sample interval: 1 sec, max history 120 sec --------------------------------------------------- [121 samples, 09:58:36 - 10:00:36] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-05-24 10:00:36.882 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 26 (osid: 11304, VKRM) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-24 05:55:02.852203 :9B3DCAF9:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-24 05:55:02.853031 :9B3DCAFA:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-24 05:55:58.203934 :9B3DDCA5:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-24 05:55:58.196 2025-05-24 05:55:58.203936 :9B3DDCA6:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=3448 pso_num=26 pso_serial#=199 2025-05-24 05:55:58.204080 :9B3DDCA7:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=3448 (legacy spawn) 2025-05-24 05:55:58.210588 :9B3DDCA8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 05:55:58.210769 :9B3DDCAD:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-24 05:55:58.211601 :9B3DDCB2:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-24 05:56:05.672675 :9B3DDEEC:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-24 05:56:05.663 2025-05-24 05:56:05.672678 :9B3DDEED:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12908 pso_num=26 pso_serial#=200 2025-05-24 05:56:05.672817 :9B3DDEEE:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=12908 (legacy spawn) 2025-05-24 05:56:05.679317 :9B3DDEEF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 05:56:05.679480 :9B3DDEF8:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-24 05:56:05.680314 :9B3DDEF9:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-24 05:56:12.229863 :9B3DE0F0:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-24 05:56:12.215 2025-05-24 05:56:12.229865 :9B3DE0F1:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=13980 pso_num=26 pso_serial#=201 2025-05-24 05:56:12.229999 :9B3DE0F2:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=13980 (legacy spawn) 2025-05-24 05:56:12.236467 :9B3DE0F3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 05:56:12.236642 :9B3DE0F8:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-24 05:56:12.237455 :9B3DE0FD:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-24 05:56:12.246231 :9B3DE100:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-24 05:56:12.231 2025-05-24 05:56:12.246232 :9B3DE101:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=13784 pso_num=26 pso_serial#=202 2025-05-24 05:56:12.246376 :9B3DE102:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=13784 (legacy spawn) 2025-05-24 05:56:12.252897 :9B3DE103:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 05:56:12.253067 :9B3DE10C:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-24 05:56:12.253869 :9B3DE10D:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-24 05:56:15.369304 :9B3DE1FF:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-24 05:56:15.361 2025-05-24 05:56:15.369305 :9B3DE200:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=14268 pso_num=26 pso_serial#=203 2025-05-24 05:56:15.369441 :9B3DE201:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=14268 (legacy spawn) 2025-05-24 05:56:15.375956 :9B3DE202:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 05:56:15.376129 :9B3DE20A:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-24 05:56:15.376993 :9B3DE20C:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-24 05:56:15.385710 :9B3DE20F:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-24 05:56:15.377 2025-05-24 05:56:15.385712 :9B3DE210:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=10972 pso_num=26 pso_serial#=204 2025-05-24 05:56:15.385845 :9B3DE211:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=10972 (legacy spawn) 2025-05-24 05:56:15.392350 :9B3DE212:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 05:56:15.392504 :9B3DE21A:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-24 05:56:15.393299 :9B3DE21D:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-24 05:56:48.489777 :9B3DECB1:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-24 05:56:48.478 2025-05-24 05:56:48.489779 :9B3DECB2:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=13460 pso_num=26 pso_serial#=205 2025-05-24 05:56:48.489894 :9B3DECB3:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=13460 osp_idx=24 osp_ver=323290 osp_pg=0 (spawn #213600) 2025-05-24 05:56:48.489894 :9B3DECB4:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-24 05:56:48.489895 :9B3DECB5:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=255 time=1041980735 2025-05-24 05:56:48.489895 :9B3DECB6:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-24 05:56:48.489896 :9B3DECB7:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-24 05:56:48.489896 :9B3DECB8:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-24 05:56:48.489896 :9B3DECB9:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-24 05:56:48.489897 :9B3DECBA:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-24 05:56:48.490394 :9B3DECBB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-24 05:57:18.567327 :9B3DF694:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-24 05:58:00.828964 :9B3E046F:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-24 05:58:00.815 2025-05-24 05:58:00.828967 :9B3E0470:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12156 pso_num=26 pso_serial#=206 2025-05-24 05:58:00.829123 :9B3E0471:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=12156 (legacy spawn) 2025-05-24 05:58:00.835557 :9B3E0472:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 05:58:00.835742 :9B3E047B:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-24 05:58:00.836553 :9B3E047C:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-24 05:58:00.845276 :9B3E047F:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-24 05:58:00.830 2025-05-24 05:58:00.845278 :9B3E0480:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12972 pso_num=26 pso_serial#=207 2025-05-24 05:58:00.845417 :9B3E0481:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=12972 (legacy spawn) 2025-05-24 05:58:00.852087 :9B3E0482:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 05:58:00.852256 :9B3E048B:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-24 05:58:00.853143 :9B3E048C:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-24 05:58:02.592053 :9B3E0536:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-24 05:58:02.585 2025-05-24 05:58:02.592055 :9B3E0537:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=13528 pso_num=26 pso_serial#=208 2025-05-24 05:58:02.592193 :9B3E0538:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=13528 (legacy spawn) 2025-05-24 05:58:02.598713 :9B3E0539:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 05:58:02.598877 :9B3E0542:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-24 05:58:02.599659 :9B3E0543:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-24 05:58:04.125076 :9B3E058F:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-24 05:58:04.111 2025-05-24 05:58:04.125079 :9B3E0590:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=11376 pso_num=26 pso_serial#=209 2025-05-24 05:58:04.125208 :9B3E0591:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=11376 (legacy spawn) 2025-05-24 05:58:04.131716 :9B3E05E0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 05:58:04.131886 :9B3E05E5:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-24 05:58:04.132722 :9B3E05EA:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-24 05:58:04.141411 :9B3E05ED:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-24 05:58:04.127 2025-05-24 05:58:04.141413 :9B3E05EE:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12772 pso_num=26 pso_serial#=210 2025-05-24 05:58:04.141553 :9B3E05EF:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=12772 (legacy spawn) 2025-05-24 05:58:04.148118 :9B3E05F0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 05:58:04.148282 :9B3E05F9:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-24 05:58:04.149083 :9B3E05FA:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-24 05:58:56.281839 :9B3E1751:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-24 05:58:56.273 2025-05-24 05:58:56.281841 :9B3E1752:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=10276 pso_num=26 pso_serial#=211 2025-05-24 05:58:56.281977 :9B3E1753:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=10276 (legacy spawn) 2025-05-24 05:58:56.288524 :9B3E1754:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 05:58:56.288691 :9B3E1759:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-24 05:58:56.289517 :9B3E175E:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-24 05:59:04.764961 :9B3E1A0D:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-24 05:59:04.757 2025-05-24 05:59:04.764963 :9B3E1A0E:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=8784 pso_num=26 pso_serial#=212 2025-05-24 05:59:04.765102 :9B3E1A0F:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=8784 (legacy spawn) 2025-05-24 05:59:04.771534 :9B3E1A10:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 05:59:04.771704 :9B3E1A15:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-24 05:59:04.772521 :9B3E1A1A:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-24 05:59:13.545790 :9B3E1CB7:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-24 05:59:13.537 2025-05-24 05:59:13.545792 :9B3E1CB8:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=14248 pso_num=26 pso_serial#=213 2025-05-24 05:59:13.545936 :9B3E1CB9:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=14248 (legacy spawn) 2025-05-24 05:59:13.552446 :9B3E1CBA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 05:59:13.552622 :9B3E1CBF:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-24 05:59:13.553484 :9B3E1CC4:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-24 05:59:13.562237 :9B3E1CC7:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-24 05:59:13.553 2025-05-24 05:59:13.562239 :9B3E1CC8:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=14240 pso_num=26 pso_serial#=214 2025-05-24 05:59:13.562383 :9B3E1CC9:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=14240 (legacy spawn) 2025-05-24 05:59:13.568933 :9B3E1CCA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 05:59:13.569093 :9B3E1CD3:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-24 05:59:13.569907 :9B3E1CD4:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-24 05:59:16.654399 :9B3E1DC4:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-24 05:59:16.641 2025-05-24 05:59:16.654401 :9B3E1DC5:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=9552 pso_num=26 pso_serial#=215 2025-05-24 05:59:16.654540 :9B3E1DC6:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=9552 (legacy spawn) 2025-05-24 05:59:16.661012 :9B3E1DC7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 05:59:16.661193 :9B3E1DCC:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-24 05:59:16.662021 :9B3E1DD1:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-24 05:59:16.670829 :9B3E1DD4:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-24 05:59:16.657 2025-05-24 05:59:16.670831 :9B3E1DD5:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=10376 pso_num=26 pso_serial#=216 2025-05-24 05:59:16.670965 :9B3E1DD6:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=10376 (legacy spawn) 2025-05-24 05:59:16.677490 :9B3E1DD7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 05:59:16.677651 :9B3E1DE0:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-24 05:59:16.678500 :9B3E1DE1:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-24 05:59:49.727307 :9B3E287B:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-24 05:59:49.713 2025-05-24 05:59:49.727308 :9B3E287C:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=14308 pso_num=26 pso_serial#=217 2025-05-24 05:59:49.727440 :9B3E287D:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=14308 (legacy spawn) 2025-05-24 05:59:49.733919 :9B3E287E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 05:59:49.734096 :9B3E2887:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-24 05:59:49.734888 :9B3E2888:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-24 05:59:49.743584 :9B3E288B:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-24 05:59:49.728 2025-05-24 05:59:49.743586 :9B3E288C:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=13512 pso_num=26 pso_serial#=218 2025-05-24 05:59:49.743720 :9B3E288D:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=13512 (legacy spawn) 2025-05-24 05:59:49.750178 :9B3E288E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 05:59:49.750346 :9B3E2897:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-24 05:59:49.751134 :9B3E2898:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-24 05:59:53.293607 :9B3E298F:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-24 05:59:53.285 2025-05-24 05:59:53.293609 :9B3E2990:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=14276 pso_num=26 pso_serial#=219 2025-05-24 05:59:53.293740 :9B3E2991:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=14276 (legacy spawn) 2025-05-24 05:59:53.300199 :9B3E2992:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 05:59:53.300370 :9B3E2997:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-24 05:59:53.301246 :9B3E29A7:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-24 05:59:53.310203 :9B3E29AA:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-24 05:59:53.301 2025-05-24 05:59:53.310205 :9B3E29AB:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=1880 pso_num=26 pso_serial#=220 2025-05-24 05:59:53.310344 :9B3E29AC:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=1880 (legacy spawn) 2025-05-24 05:59:53.316906 :9B3E29AD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 05:59:53.317068 :9B3E29B5:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-24 05:59:53.317887 :9B3E29B7:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-24 05:59:57.607642 :9B3E2B1E:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-24 05:59:57.602 2025-05-24 05:59:57.607644 :9B3E2B1F:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12588 pso_num=26 pso_serial#=221 2025-05-24 05:59:57.607777 :9B3E2B20:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=12588 osp_idx=24 osp_ver=323306 osp_pg=0 (spawn #213607) 2025-05-24 05:59:57.607778 :9B3E2B21:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-24 05:59:57.607778 :9B3E2B22:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=0 time=1042169860 2025-05-24 05:59:57.607779 :9B3E2B23:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-24 05:59:57.607779 :9B3E2B24:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-24 05:59:57.607779 :9B3E2B25:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-24 05:59:57.607780 :9B3E2B26:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-24 05:59:57.607780 :9B3E2B27:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-24 05:59:57.608253 :9B3E2B28:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-24 05:59:57.608299 :9B3E2B2E:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-24 05:59:57.612418 :9B3E2B47:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-05-24 05:59:57.612461 :9B3E2B48:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-05-24 05:59:57.612792 :9B3E2B49:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-05-24 05:59:57.612811 :9B3E2B4A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-05-24 05:59:57.613032 :9B3E2B4B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-05-24 05:59:57.613045 :9B3E2B4C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-05-24 05:59:57.613262 :9B3E2B4D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-05-24 05:59:57.613275 :9B3E2B4E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-05-24 05:59:57.613488 :9B3E2B4F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-05-24 05:59:57.613502 :9B3E2B50:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-05-24 05:59:57.613709 :9B3E2B51:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-05-24 05:59:57.613722 :9B3E2B52:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-05-24 05:59:57.615987 :9B3E2B53:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-24 06:00:00.020058 :9B3E2C31:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-24 06:00:00.013 2025-05-24 06:00:00.020061 :9B3E2C32:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=11304 pso_num=26 pso_serial#=222 2025-05-24 06:00:00.020177 :9B3E2C33:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=11304 osp_idx=24 osp_ver=323307 osp_pg=0 (spawn #213608) 2025-05-24 06:00:00.020178 :9B3E2C34:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=3656 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-24 06:00:00.020178 :9B3E2C35:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=1 time=1042172266 2025-05-24 06:00:00.020178 :9B3E2C36:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-24 06:00:00.020179 :9B3E2C37:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-24 06:00:00.020179 :9B3E2C38:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-24 06:00:00.020179 :9B3E2C39:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-24 06:00:00.020180 :9B3E2C3A:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-24 06:00:00.020247 :9B3E2C3B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:0] KSL POST SENT postee=6 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-24 06:00:00.020253 :9B3E2C3C:db_trace:kso.c@5554:kso_spawn_diag_end(): [10420:26:0] kso: spawn diagnostics: init time=0 secs ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 26 (osid: 11304, VKRM)