Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250825220009\orcl_vkrm_20816_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:35212M/63366M, Ph+PgF:40315M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 26 Windows thread id: 20816, image: ORACLE.EXE (VKRM) *** 2025-08-25 22:00:09.476 *** SESSION ID:(209.25627) 2025-08-25 22:00:09.476 *** 2025-08-25 22:00:09.476 Process diagnostic dump for ORACLE.EXE (VKRM), OS id=20816, pid: 26, proc_ser: 1, sid: 209, sess_ser: 25627 ------------------------------------------------------------------------------- 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=9.469211 sec, exc=9.469211 sec, total=9.469211 sec wait times: max=infinite, heur=9.469211 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 25627 --------------------------------------------------- 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 --------------------------------------------------- [10 samples, 22:00:00 - 22:00:09] 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-25 22:00:09.476 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 26 (osid: 20816, VKRM) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-08-25 21:55:49.152832 :C49F4EBD:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=15164 (legacy spawn) 2025-08-25 21:55:49.159418 :C49F4EBE: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-08-25 21:55:49.159592 :C49F4EC4: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-08-25 21:55:49.160434 :C49F4EC8:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-25 21:56:02.853946 :C49F52F2:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-25 21:56:02.839 2025-08-25 21:56:02.853947 :C49F52F3:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=4644 pso_num=26 pso_serial#=230 2025-08-25 21:56:02.854087 :C49F52F4:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=4644 (legacy spawn) 2025-08-25 21:56:02.860576 :C49F52F5: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-08-25 21:56:02.860746 :C49F52FA: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-08-25 21:56:02.861558 :C49F52FF:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-25 21:56:02.878970 :C49F530E:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-25 21:56:02.870 2025-08-25 21:56:02.878973 :C49F530F:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=22468 pso_num=26 pso_serial#=231 2025-08-25 21:56:02.879134 :C49F5310:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=22468 (legacy spawn) 2025-08-25 21:56:02.885631 :C49F5311: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-08-25 21:56:02.885801 :C49F531A: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-08-25 21:56:02.886668 :C49F531B:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-25 21:56:06.065799 :C49F53F5:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-25 21:56:06.052 2025-08-25 21:56:06.065801 :C49F53F6:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=19784 pso_num=26 pso_serial#=232 2025-08-25 21:56:06.065946 :C49F53F7:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=19784 (legacy spawn) 2025-08-25 21:56:06.072649 :C49F540B: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-08-25 21:56:06.072828 :C49F5414: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-08-25 21:56:06.073662 :C49F5415:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-25 21:56:06.082580 :C49F5418:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-25 21:56:06.068 2025-08-25 21:56:06.082582 :C49F5419:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=19096 pso_num=26 pso_serial#=233 2025-08-25 21:56:06.082724 :C49F541A:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=19096 (legacy spawn) 2025-08-25 21:56:06.089334 :C49F541B: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-08-25 21:56:06.089508 :C49F5424: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-08-25 21:56:06.090326 :C49F5425:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-25 21:56:42.343877 :C49F5FA6:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-25 21:56:42.330 2025-08-25 21:56:42.343880 :C49F5FA7:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=19244 pso_num=26 pso_serial#=234 2025-08-25 21:56:42.344019 :C49F5FA8:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=19244 (legacy spawn) 2025-08-25 21:56:42.350602 :C49F5FA9: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-08-25 21:56:42.350769 :C49F5FAE: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-08-25 21:56:42.351562 :C49F5FB3:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-25 21:56:42.360361 :C49F5FB6:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-25 21:56:42.346 2025-08-25 21:56:42.360362 :C49F5FB7:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=23312 pso_num=26 pso_serial#=235 2025-08-25 21:56:42.360505 :C49F5FB8:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=23312 (legacy spawn) 2025-08-25 21:56:42.367195 :C49F5FB9: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-08-25 21:56:42.367365 :C49F5FC2: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-08-25 21:56:42.368193 :C49F5FC3:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-25 21:56:45.720702 :C49F609D:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-25 21:56:45.711 2025-08-25 21:56:45.720704 :C49F609E:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=20392 pso_num=26 pso_serial#=236 2025-08-25 21:56:45.720848 :C49F609F:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=20392 (legacy spawn) 2025-08-25 21:56:45.727348 :C49F60A0: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-08-25 21:56:45.727514 :C49F60A5: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-08-25 21:56:45.728330 :C49F60AA:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-25 21:56:49.955278 :C49F61EB:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-25 21:56:49.941 2025-08-25 21:56:49.955281 :C49F61EC:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=23204 pso_num=26 pso_serial#=237 2025-08-25 21:56:49.955424 :C49F61ED:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=23204 (legacy spawn) 2025-08-25 21:56:49.962400 :C49F61EE: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-08-25 21:56:49.962584 :C49F61F3: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-08-25 21:56:49.963518 :C49F61F8:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-25 21:56:49.973094 :C49F61FB:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-25 21:56:49.972 2025-08-25 21:56:49.973096 :C49F61FC:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=23428 pso_num=26 pso_serial#=238 2025-08-25 21:56:49.973246 :C49F61FD:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=23428 (legacy spawn) 2025-08-25 21:56:49.980283 :C49F61FE: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-08-25 21:56:49.980461 :C49F6207: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-08-25 21:56:49.981369 :C49F6208:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-25 21:56:51.324595 :C49F62A0:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-25 21:56:51.316 2025-08-25 21:56:51.324597 :C49F62A1:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=21628 pso_num=26 pso_serial#=239 2025-08-25 21:56:51.324784 :C49F62A2:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=21628 (legacy spawn) 2025-08-25 21:56:51.331255 :C49F62A3: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-08-25 21:56:51.331426 :C49F62A8: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-08-25 21:56:51.332307 :C49F62AD:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-25 21:57:51.855518 :C49F75C6:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-25 21:57:51.855 2025-08-25 21:57:51.855521 :C49F75C7:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=22856 pso_num=26 pso_serial#=240 2025-08-25 21:57:51.855695 :C49F75C8:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=22856 (legacy spawn) 2025-08-25 21:57:51.862474 :C49F75C9: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-08-25 21:57:51.862672 :C49F75D2: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-08-25 21:57:51.863526 :C49F75D3:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-25 21:57:51.894385 :C49F75D6:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-25 21:57:51.887 2025-08-25 21:57:51.894387 :C49F75D7:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=22152 pso_num=26 pso_serial#=241 2025-08-25 21:57:51.894527 :C49F75D8:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=22152 (legacy spawn) 2025-08-25 21:57:51.901165 :C49F75D9: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-08-25 21:57:51.901334 :C49F75E2: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-08-25 21:57:51.902201 :C49F75E3:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-25 21:57:53.561745 :C49F7652:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-25 21:57:53.553 2025-08-25 21:57:53.561747 :C49F7653:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=16416 pso_num=26 pso_serial#=242 2025-08-25 21:57:53.561880 :C49F7654:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=16416 (legacy spawn) 2025-08-25 21:57:53.568382 :C49F7655: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-08-25 21:57:53.568563 :C49F765A: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-08-25 21:57:53.569374 :C49F765F:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-25 21:57:53.906462 :C49F76B5:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-25 21:57:53.897 2025-08-25 21:57:53.906464 :C49F76B6:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=22772 pso_num=26 pso_serial#=243 2025-08-25 21:57:53.906601 :C49F76B7:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=22772 (legacy spawn) 2025-08-25 21:57:53.913143 :C49F76B8: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-08-25 21:57:53.913308 :C49F76C1: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-08-25 21:57:53.914143 :C49F76C2:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-25 21:57:55.093573 :C49F76EF:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-25 21:57:55.081 2025-08-25 21:57:55.093575 :C49F76F0:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=22272 pso_num=26 pso_serial#=244 2025-08-25 21:57:55.093705 :C49F76F1:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=22272 (legacy spawn) 2025-08-25 21:57:55.100106 :C49F7715: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-08-25 21:57:55.100278 :C49F771C: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-08-25 21:57:55.101077 :C49F771E:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-25 21:57:55.109965 :C49F7721:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-25 21:57:55.097 2025-08-25 21:57:55.109967 :C49F7722:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=22780 pso_num=26 pso_serial#=245 2025-08-25 21:57:55.110104 :C49F7723:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=22780 (legacy spawn) 2025-08-25 21:57:55.116694 :C49F7724: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-08-25 21:57:55.116855 :C49F772D: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-08-25 21:57:55.117677 :C49F772E:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-25 21:58:55.771684 :C49F89DD:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-25 21:58:55.763 2025-08-25 21:58:55.771686 :C49F89DE:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=16164 pso_num=26 pso_serial#=246 2025-08-25 21:58:55.771836 :C49F89DF:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=16164 (legacy spawn) 2025-08-25 21:58:55.778649 :C49F89E0: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-08-25 21:58:55.778831 :C49F89E5: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-08-25 21:58:55.779700 :C49F89EA:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-25 21:59:02.197550 :C49F8BEB:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-25 21:59:02.188 2025-08-25 21:59:02.197551 :C49F8BEC:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=22868 pso_num=26 pso_serial#=247 2025-08-25 21:59:02.197693 :C49F8BED:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=22868 (legacy spawn) 2025-08-25 21:59:02.204300 :C49F8BEE: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-08-25 21:59:02.204476 :C49F8BF3: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-08-25 21:59:02.205280 :C49F8BF8:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-25 21:59:04.569210 :C49F8CAC:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-25 21:59:04.561 2025-08-25 21:59:04.569212 :C49F8CAD:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=208 pso_num=26 pso_serial#=248 2025-08-25 21:59:04.569353 :C49F8CAE:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=208 (legacy spawn) 2025-08-25 21:59:04.575895 :C49F8CAF: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-08-25 21:59:04.576087 :C49F8CB4: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-08-25 21:59:04.576905 :C49F8CB9:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-25 21:59:04.585726 :C49F8CBC:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-25 21:59:04.576 2025-08-25 21:59:04.585728 :C49F8CBD:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=23068 pso_num=26 pso_serial#=249 2025-08-25 21:59:04.585865 :C49F8CBE:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=23068 (legacy spawn) 2025-08-25 21:59:04.592544 :C49F8CBF: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-08-25 21:59:04.592711 :C49F8CC7: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-08-25 21:59:04.593568 :C49F8CC9:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-25 21:59:07.652962 :C49F8DB3:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-25 21:59:07.639 2025-08-25 21:59:07.652964 :C49F8DB4:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=21444 pso_num=26 pso_serial#=250 2025-08-25 21:59:07.653092 :C49F8DB5:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=21444 (legacy spawn) 2025-08-25 21:59:07.659924 :C49F8DB6: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-08-25 21:59:07.660093 :C49F8DBB: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-08-25 21:59:07.661003 :C49F8DC0:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-25 21:59:07.670326 :C49F8DC3:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-25 21:59:07.670 2025-08-25 21:59:07.670328 :C49F8DC4:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=23240 pso_num=26 pso_serial#=251 2025-08-25 21:59:07.670473 :C49F8DC5:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=23240 (legacy spawn) 2025-08-25 21:59:07.677433 :C49F8DC6: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-08-25 21:59:07.677611 :C49F8DCF: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-08-25 21:59:07.678523 :C49F8DD0:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-25 21:59:10.254263 :C49F8EA1:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-25 21:59:10.249 2025-08-25 21:59:10.254265 :C49F8EA2:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=22728 pso_num=26 pso_serial#=252 2025-08-25 21:59:10.254403 :C49F8EA3:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=22728 osp_idx=24 osp_ver=731847 osp_pg=0 (spawn #525817) 2025-08-25 21:59:10.254404 :C49F8EA4:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-25 21:59:10.254404 :C49F8EA5:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=187 time=544804987 2025-08-25 21:59:10.254404 :C49F8EA6:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-08-25 21:59:10.254405 :C49F8EA7:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-08-25 21:59:10.254405 :C49F8EA8:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-08-25 21:59:10.254405 :C49F8EA9:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-25 21:59:10.254406 :C49F8EAA:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-25 21:59:10.254920 :C49F8EAB: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-08-25 21:59:10.254966 :C49F8EB1: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-08-25 21:59:10.274842 :C49F8F1E:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-25 21:59:44.056216 :C49F99D6:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-25 21:59:44.042 2025-08-25 21:59:44.056218 :C49F99D7:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=20596 pso_num=26 pso_serial#=253 2025-08-25 21:59:44.056361 :C49F99D8:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=20596 (legacy spawn) 2025-08-25 21:59:44.062873 :C49F99D9: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-08-25 21:59:44.063065 :C49F99DE: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-08-25 21:59:44.063874 :C49F99E3:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-25 21:59:44.072630 :C49F99E6:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-25 21:59:44.058 2025-08-25 21:59:44.072633 :C49F99E7:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=23248 pso_num=26 pso_serial#=254 2025-08-25 21:59:44.072765 :C49F99E8:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=23248 (legacy spawn) 2025-08-25 21:59:44.079325 :C49F9A86: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-08-25 21:59:44.079496 :C49F9A8F: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-08-25 21:59:44.080330 :C49F9A90:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-25 21:59:57.954448 :C49F9EBA:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-25 21:59:57.946 2025-08-25 21:59:57.954450 :C49F9EBB:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=20800 pso_num=26 pso_serial#=255 2025-08-25 21:59:57.954586 :C49F9EBC:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=20800 (legacy spawn) 2025-08-25 21:59:57.961080 :C49F9EBD: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-08-25 21:59:57.961272 :C49F9EC2: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-08-25 21:59:57.962158 :C49F9EC7:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-08-25 22:00:00.015358 :C49F9F6D:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 08-25 22:00:00.007 2025-08-25 22:00:00.015360 :C49F9F6E:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=20816 pso_num=26 pso_serial#=1 2025-08-25 22:00:00.015474 :C49F9F6F:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=20816 osp_idx=24 osp_ver=731851 osp_pg=0 (spawn #525821) 2025-08-25 22:00:00.015475 :C49F9F70:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=3656 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-25 22:00:00.015475 :C49F9F71:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=188 time=544854752 2025-08-25 22:00:00.015476 :C49F9F72:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-08-25 22:00:00.015477 :C49F9F73:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-08-25 22:00:00.015477 :C49F9F74:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-08-25 22:00:00.015477 :C49F9F75:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-25 22:00:00.015478 :C49F9F76:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-25 22:00:00.015552 :C49F9F77: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-08-25 22:00:00.015558 :C49F9F78: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: 20816, VKRM)