Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250822220007\orcl_vkrm_11176_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:35278M/63366M, Ph+PgF:40408M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 27 Windows thread id: 11176, image: ORACLE.EXE (VKRM) *** 2025-08-22 22:00:07.498 *** SESSION ID:(219.3857) 2025-08-22 22:00:07.498 *** 2025-08-22 22:00:07.498 Process diagnostic dump for ORACLE.EXE (VKRM), OS id=11176, pid: 27, proc_ser: 135, sid: 219, sess_ser: 3857 ------------------------------------------------------------------------------- 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=7.482427 sec, exc=7.482427 sec, total=7.482427 sec wait times: max=infinite, heur=7.482427 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 219 serial 3857 --------------------------------------------------- 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 --------------------------------------------------- [8 samples, 22:00:00 - 22:00:07] idle wait at each sample [session created at: 22:00:00] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-08-22 22:00:07.498 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 27 (osid: 11176, VKRM) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-08-22 21:55:43.615351 :C34C724C:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-22 21:55:43.604 2025-08-22 21:55:43.615353 :C34C724D:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=19792 pso_num=27 pso_serial#=111 2025-08-22 21:55:43.615488 :C34C724E:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=19792 (legacy spawn) 2025-08-22 21:55:43.622039 :C34C724F: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-08-22 21:55:43.622214 :C34C7258: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-08-22 21:55:43.623018 :C34C7259:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-22 21:56:41.753220 :C34C84F4:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-22 21:56:41.751 2025-08-22 21:56:41.753222 :C34C84F5:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=16876 pso_num=27 pso_serial#=112 2025-08-22 21:56:41.753367 :C34C84F6:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=16876 (legacy spawn) 2025-08-22 21:56:41.759857 :C34C84F7: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-08-22 21:56:41.760034 :C34C8500: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-08-22 21:56:41.760855 :C34C8501:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-22 21:56:41.884159 :C34C8504:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-22 21:56:41.876 2025-08-22 21:56:41.884161 :C34C8505:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=22316 pso_num=27 pso_serial#=113 2025-08-22 21:56:41.884302 :C34C8506:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=22316 (legacy spawn) 2025-08-22 21:56:41.890837 :C34C8507: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-08-22 21:56:41.891014 :C34C8510: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-08-22 21:56:41.892015 :C34C8511:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-22 21:56:52.191426 :C34C88A9:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-22 21:56:52.184 2025-08-22 21:56:52.191428 :C34C88AA:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=22048 pso_num=27 pso_serial#=114 2025-08-22 21:56:52.191568 :C34C88AB:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=22048 (legacy spawn) 2025-08-22 21:56:52.198019 :C34C88AC: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-08-22 21:56:52.198189 :C34C88B1: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-08-22 21:56:52.198999 :C34C88B6:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-22 21:56:52.207827 :C34C88B9:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-22 21:56:52.199 2025-08-22 21:56:52.207829 :C34C88BA:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=20116 pso_num=27 pso_serial#=115 2025-08-22 21:56:52.207962 :C34C88BB:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=20116 (legacy spawn) 2025-08-22 21:56:52.214394 :C34C88BC: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-08-22 21:56:52.214559 :C34C88C5: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-08-22 21:56:52.215554 :C34C88C6:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-22 21:56:55.479108 :C34C89B4:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-22 21:56:55.466 2025-08-22 21:56:55.479110 :C34C89B5:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=20152 pso_num=27 pso_serial#=116 2025-08-22 21:56:55.479248 :C34C89B6:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=20152 (legacy spawn) 2025-08-22 21:56:55.485790 :C34C89B7: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-08-22 21:56:55.485969 :C34C89BC: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-08-22 21:56:55.486763 :C34C89C1:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-22 21:56:55.495503 :C34C89C4:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-22 21:56:55.482 2025-08-22 21:56:55.495506 :C34C89C5:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=20520 pso_num=27 pso_serial#=117 2025-08-22 21:56:55.495638 :C34C89C6:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=20520 (legacy spawn) 2025-08-22 21:56:55.502128 :C34C89C7: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-08-22 21:56:55.502298 :C34C89D0: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-08-22 21:56:55.503127 :C34C89D1:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-22 21:57:12.964061 :C34C8F03:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-22 21:57:12.951 2025-08-22 21:57:12.964063 :C34C8F04:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=15600 pso_num=27 pso_serial#=118 2025-08-22 21:57:12.964204 :C34C8F05:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=15600 (legacy spawn) 2025-08-22 21:57:12.970734 :C34C8F06: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-08-22 21:57:12.970897 :C34C8F0B: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-08-22 21:57:12.971713 :C34C8F10:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-22 21:57:32.145018 :C34C9574:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-22 21:57:32.132 2025-08-22 21:57:32.145020 :C34C9575:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=20392 pso_num=27 pso_serial#=119 2025-08-22 21:57:32.145154 :C34C9576:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=20392 (legacy spawn) 2025-08-22 21:57:32.151678 :C34C9577: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-08-22 21:57:32.151867 :C34C9580: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-08-22 21:57:32.152655 :C34C9581:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-22 21:57:32.161507 :C34C9584:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-22 21:57:32.147 2025-08-22 21:57:32.161509 :C34C9585:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=21724 pso_num=27 pso_serial#=120 2025-08-22 21:57:32.161652 :C34C9586:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=21724 (legacy spawn) 2025-08-22 21:57:32.168140 :C34C9587: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-08-22 21:57:32.168309 :C34C9590: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-08-22 21:57:32.169102 :C34C9591:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-22 21:57:44.045525 :C34C9928:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-22 21:57:44.036 2025-08-22 21:57:44.045527 :C34C9929:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=19108 pso_num=27 pso_serial#=121 2025-08-22 21:57:44.045666 :C34C992A:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=19108 (legacy spawn) 2025-08-22 21:57:44.052546 :C34C992B: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-08-22 21:57:44.052740 :C34C9934: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-08-22 21:57:44.053689 :C34C9935:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-22 21:57:49.717671 :C34C9B05:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-22 21:57:49.710 2025-08-22 21:57:49.717673 :C34C9B06:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=16164 pso_num=27 pso_serial#=122 2025-08-22 21:57:49.717817 :C34C9B07:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=16164 (legacy spawn) 2025-08-22 21:57:49.724317 :C34C9B08: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-08-22 21:57:49.724493 :C34C9B0D: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-08-22 21:57:49.725294 :C34C9B12:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-22 21:58:42.177743 :C34CABE8:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-22 21:58:42.163 2025-08-22 21:58:42.177745 :C34CABE9:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=21668 pso_num=27 pso_serial#=123 2025-08-22 21:58:42.177879 :C34CABEA:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=21668 (legacy spawn) 2025-08-22 21:58:42.184388 :C34CABEB: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-08-22 21:58:42.184557 :C34CABF4: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-08-22 21:58:42.185356 :C34CABF5:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-22 21:58:42.194040 :C34CABF8:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-22 21:58:42.178 2025-08-22 21:58:42.194042 :C34CABF9:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=1852 pso_num=27 pso_serial#=124 2025-08-22 21:58:42.194189 :C34CABFA:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=1852 (legacy spawn) 2025-08-22 21:58:42.200592 :C34CABFB: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-08-22 21:58:42.200758 :C34CAC04: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-08-22 21:58:42.201562 :C34CAC05:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-22 21:58:45.306630 :C34CACE8:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-22 21:58:45.298 2025-08-22 21:58:45.306632 :C34CACE9:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=19756 pso_num=27 pso_serial#=125 2025-08-22 21:58:45.306765 :C34CACEA:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=19756 (legacy spawn) 2025-08-22 21:58:45.313257 :C34CACEB: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-08-22 21:58:45.313288 :C34CACEE: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-08-22 21:58:45.313444 :C34CACF2: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-08-22 21:58:45.314309 :C34CAD02:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-22 21:58:45.323198 :C34CAD05:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-22 21:58:45.313 2025-08-22 21:58:45.323200 :C34CAD06:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=10356 pso_num=27 pso_serial#=126 2025-08-22 21:58:45.323357 :C34CAD07:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=10356 (legacy spawn) 2025-08-22 21:58:45.330225 :C34CAD08: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-08-22 21:58:45.330392 :C34CAD10: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-08-22 21:58:45.331252 :C34CAD12:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-22 21:58:46.259613 :C34CAD90:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-22 21:58:46.251 2025-08-22 21:58:46.259614 :C34CAD91:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=21428 pso_num=27 pso_serial#=127 2025-08-22 21:58:46.259749 :C34CAD92:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=21428 (legacy spawn) 2025-08-22 21:58:46.266303 :C34CAD93: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-08-22 21:58:46.266476 :C34CAD98: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-08-22 21:58:46.267315 :C34CAD9D:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-22 21:58:51.010737 :C34CAF1B:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-22 21:58:51.005 2025-08-22 21:58:51.010739 :C34CAF1C:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=20600 pso_num=27 pso_serial#=128 2025-08-22 21:58:51.010881 :C34CAF1D:db_trace:kso.c@4093:ksonfy(): [10420:27:0] kso: new process: pid=20600 osp_idx=25 osp_ver=329341 osp_pg=0 (spawn #515805) 2025-08-22 21:58:51.010881 :C34CAF1E:db_trace:kso.c@4099:ksonfy(): [10420:27:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-22 21:58:51.010882 :C34CAF1F:db_trace:kso.c@4103:ksonfy(): [10420:27:0] kso: new process: pso_index=27 reservation=69 time=285633018 2025-08-22 21:58:51.010882 :C34CAF20:db_trace:kso.c@4109:ksonfy(): [10420:27:0] kso: spawn diagnostics: queue time=0 secs 2025-08-22 21:58:51.010883 :C34CAF21:db_trace:kso.c@4111:ksonfy(): [10420:27:0] kso: spawn diagnostics: fork time=0 secs 2025-08-22 21:58:51.010883 :C34CAF22:db_trace:kso.c@4113:ksonfy(): [10420:27:0] kso: spawn diagnostics: exec time=0 secs 2025-08-22 21:58:51.010883 :C34CAF23:db_trace:kso.c@4115:ksonfy(): [10420:27:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-22 21:58:51.010884 :C34CAF24:db_trace:kso.c@4117:ksonfy(): [10420:27:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-22 21:58:51.011416 :C34CAF25: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-08-22 21:58:51.011469 :C34CAF2B: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-08-22 21:58:51.015586 :C34CAF54:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:kelt.c:517 2025-08-22 21:58:51.015626 :C34CAF55:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:kelt.c:517 2025-08-22 21:58:51.015890 :C34CAF56:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:kelt.c:517 2025-08-22 21:58:51.015907 :C34CAF57:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:kelt.c:517 2025-08-22 21:58:51.016129 :C34CAF58:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:kelt.c:517 2025-08-22 21:58:51.016142 :C34CAF59:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:kelt.c:517 2025-08-22 21:58:51.016352 :C34CAF5A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:kelt.c:517 2025-08-22 21:58:51.016365 :C34CAF5B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:kelt.c:517 2025-08-22 21:58:51.016576 :C34CAF5C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:kelt.c:517 2025-08-22 21:58:51.016588 :C34CAF5D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:kelt.c:517 2025-08-22 21:58:51.016799 :C34CAF5E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:kelt.c:517 2025-08-22 21:58:51.016812 :C34CAF5F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:kelt.c:517 2025-08-22 21:58:51.019145 :C34CAF60:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-22 21:58:57.839430 :C34CB139:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-22 21:58:57.830 2025-08-22 21:58:57.839432 :C34CB13A:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=21012 pso_num=27 pso_serial#=129 2025-08-22 21:58:57.839574 :C34CB13B:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=21012 (legacy spawn) 2025-08-22 21:58:57.846051 :C34CB13C: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-08-22 21:58:57.846221 :C34CB141: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-08-22 21:58:57.847024 :C34CB146:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-22 21:59:31.840177 :C34CBCAE:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-22 21:59:31.830 2025-08-22 21:59:31.840179 :C34CBCAF:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=20104 pso_num=27 pso_serial#=130 2025-08-22 21:59:31.840327 :C34CBCB0:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=20104 (legacy spawn) 2025-08-22 21:59:31.846835 :C34CBCB1: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-08-22 21:59:31.846996 :C34CBCB6: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-08-22 21:59:31.847801 :C34CBCBB:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-22 21:59:55.063305 :C34CC37B:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-22 21:59:55.048 2025-08-22 21:59:55.063307 :C34CC37C:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=19660 pso_num=27 pso_serial#=131 2025-08-22 21:59:55.063449 :C34CC37D:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=19660 (legacy spawn) 2025-08-22 21:59:55.069916 :C34CC37E: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-08-22 21:59:55.070095 :C34CC383: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-08-22 21:59:55.070927 :C34CC388:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-22 21:59:55.079560 :C34CC38B:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-22 21:59:55.064 2025-08-22 21:59:55.079562 :C34CC38C:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=19940 pso_num=27 pso_serial#=132 2025-08-22 21:59:55.079702 :C34CC38D:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=19940 (legacy spawn) 2025-08-22 21:59:55.086155 :C34CC3B7: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-08-22 21:59:55.086321 :C34CC3C0: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-08-22 21:59:55.087116 :C34CC3C1:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-22 21:59:58.295787 :C34CC4DC:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-22 21:59:58.287 2025-08-22 21:59:58.295789 :C34CC4DD:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=22380 pso_num=27 pso_serial#=133 2025-08-22 21:59:58.295932 :C34CC4DE:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=22380 (legacy spawn) 2025-08-22 21:59:58.302883 :C34CC4DF: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-08-22 21:59:58.303074 :C34CC4E4: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-08-22 21:59:58.303980 :C34CC4E9:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-22 21:59:58.313361 :C34CC4EC:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-22 21:59:58.303 2025-08-22 21:59:58.313363 :C34CC4ED:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=16340 pso_num=27 pso_serial#=134 2025-08-22 21:59:58.313513 :C34CC4EE:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=16340 (legacy spawn) 2025-08-22 21:59:58.320629 :C34CC4EF: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-08-22 21:59:58.320813 :C34CC4F8: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-08-22 21:59:58.321673 :C34CC4F9:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-22 22:00:00.013627 :C34CC576:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-22 22:00:00.006 2025-08-22 22:00:00.013629 :C34CC577:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=11176 pso_num=27 pso_serial#=135 2025-08-22 22:00:00.013738 :C34CC578:db_trace:kso.c@4093:ksonfy(): [10420:27:0] kso: new process: pid=11176 osp_idx=25 osp_ver=329348 osp_pg=0 (spawn #515808) 2025-08-22 22:00:00.013740 :C34CC579:db_trace:kso.c@4099:ksonfy(): [10420:27:0] kso: new process: first_req_pid=3656 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-22 22:00:00.013741 :C34CC57A:db_trace:kso.c@4103:ksonfy(): [10420:27:0] kso: new process: pso_index=27 reservation=70 time=285702018 2025-08-22 22:00:00.013741 :C34CC57B:db_trace:kso.c@4109:ksonfy(): [10420:27:0] kso: spawn diagnostics: queue time=0 secs 2025-08-22 22:00:00.013741 :C34CC57C:db_trace:kso.c@4111:ksonfy(): [10420:27:0] kso: spawn diagnostics: fork time=0 secs 2025-08-22 22:00:00.013742 :C34CC57D:db_trace:kso.c@4113:ksonfy(): [10420:27:0] kso: spawn diagnostics: exec time=0 secs 2025-08-22 22:00:00.013742 :C34CC57E:db_trace:kso.c@4115:ksonfy(): [10420:27:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-22 22:00:00.013742 :C34CC57F:db_trace:kso.c@4117:ksonfy(): [10420:27:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-22 22:00:00.013815 :C34CC580:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:0] KSL POST SENT postee=6 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-22 22:00:00.013822 :C34CC581:db_trace:kso.c@5554:kso_spawn_diag_end(): [10420:27:0] kso: spawn diagnostics: init time=0 secs ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 27 (osid: 11176, VKRM)