Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250514220007\orcl_vkrm_13248_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:37384M/63366M, Ph+PgF:44628M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 26 Windows thread id: 13248, image: ORACLE.EXE (VKRM) *** 2025-05-14 22:00:07.465 *** SESSION ID:(209.14337) 2025-05-14 22:00:07.465 *** 2025-05-14 22:00:07.465 Process diagnostic dump for ORACLE.EXE (VKRM), OS id=13248, pid: 26, proc_ser: 221, sid: 209, sess_ser: 14337 ------------------------------------------------------------------------------- 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.454054 sec, exc=7.454054 sec, total=7.454054 sec wait times: max=infinite, heur=7.454054 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 14337 --------------------------------------------------- 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-05-14 22:00:07.465 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 26 (osid: 13248, VKRM) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-14 21:55:54.577039 :971FB995:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=2404 pso_num=26 pso_serial#=197 2025-05-14 21:55:54.577184 :971FB996:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=2404 (legacy spawn) 2025-05-14 21:55:54.583845 :971FB997: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-14 21:55:54.584044 :971FB99C: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-14 21:55:54.584919 :971FB9A1:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-14 21:55:54.815805 :971FB9B7:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-14 21:55:54.802 2025-05-14 21:55:54.815807 :971FB9B8:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12352 pso_num=26 pso_serial#=198 2025-05-14 21:55:54.815949 :971FB9B9:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=12352 (legacy spawn) 2025-05-14 21:55:54.822366 :971FB9BA: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-14 21:55:54.822534 :971FB9C3: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-14 21:55:54.823332 :971FB9C4:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-14 21:55:54.832098 :971FB9C7:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-14 21:55:54.818 2025-05-14 21:55:54.832100 :971FB9C8:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12816 pso_num=26 pso_serial#=199 2025-05-14 21:55:54.832240 :971FB9C9:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=12816 (legacy spawn) 2025-05-14 21:55:54.838721 :971FB9CA: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-14 21:55:54.838883 :971FB9D3: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-14 21:55:54.839682 :971FB9D4:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-14 21:55:58.042141 :971FBB13:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-14 21:55:58.032 2025-05-14 21:55:58.042143 :971FBB14:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12136 pso_num=26 pso_serial#=200 2025-05-14 21:55:58.042289 :971FBB15:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=12136 (legacy spawn) 2025-05-14 21:55:58.048850 :971FBB16: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-14 21:55:58.049009 :971FBB1F: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-14 21:55:58.049814 :971FBB20:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-14 21:55:58.058539 :971FBB23:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-14 21:55:58.047 2025-05-14 21:55:58.058541 :971FBB24:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=3352 pso_num=26 pso_serial#=201 2025-05-14 21:55:58.058683 :971FBB25:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=3352 (legacy spawn) 2025-05-14 21:55:58.065195 :971FBB26: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-14 21:55:58.065357 :971FBB2F: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-14 21:55:58.066170 :971FBB30:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-14 21:56:01.212091 :971FBC2F:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-14 21:56:01.204 2025-05-14 21:56:01.212093 :971FBC30:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=13000 pso_num=26 pso_serial#=202 2025-05-14 21:56:01.212227 :971FBC31:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=13000 (legacy spawn) 2025-05-14 21:56:01.218627 :971FBC32: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-14 21:56:01.218801 :971FBC3B: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-14 21:56:01.219620 :971FBC3C:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-14 21:57:02.857170 :971FCF6D:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-14 21:57:02.848 2025-05-14 21:57:02.857172 :971FCF6E:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=7708 pso_num=26 pso_serial#=203 2025-05-14 21:57:02.857312 :971FCF6F:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=7708 (legacy spawn) 2025-05-14 21:57:02.863819 :971FCF70: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-14 21:57:02.864010 :971FCF75: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-14 21:57:02.865030 :971FCF7A:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-14 21:57:03.449180 :971FCFB1:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-14 21:57:03.441 2025-05-14 21:57:03.449182 :971FCFB2:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=13116 pso_num=26 pso_serial#=204 2025-05-14 21:57:03.449319 :971FCFB3:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=13116 (legacy spawn) 2025-05-14 21:57:03.455793 :971FCFB4: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-14 21:57:03.455967 :971FCFBD: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-14 21:57:03.456782 :971FCFBE:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-14 21:57:07.517538 :971FD11B:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-14 21:57:07.514 2025-05-14 21:57:07.517540 :971FD11C:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=11308 pso_num=26 pso_serial#=205 2025-05-14 21:57:07.517681 :971FD11D:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=11308 (legacy spawn) 2025-05-14 21:57:07.524145 :971FD11E: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-14 21:57:07.524313 :971FD126: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-14 21:57:07.525115 :971FD128:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-14 21:57:07.533702 :971FD12B:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-14 21:57:07.530 2025-05-14 21:57:07.533704 :971FD12C:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=13080 pso_num=26 pso_serial#=206 2025-05-14 21:57:07.533841 :971FD12D:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=13080 (legacy spawn) 2025-05-14 21:57:07.540269 :971FD12E: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-14 21:57:07.540432 :971FD137: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-14 21:57:07.541234 :971FD138:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-14 21:57:10.726559 :971FD22F:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-14 21:57:10.718 2025-05-14 21:57:10.726561 :971FD230:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=11856 pso_num=26 pso_serial#=207 2025-05-14 21:57:10.726697 :971FD231:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=11856 (legacy spawn) 2025-05-14 21:57:10.733132 :971FD232: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-14 21:57:10.733323 :971FD23A: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-14 21:57:10.734163 :971FD23C:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-14 21:57:10.742811 :971FD23F:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-14 21:57:10.733 2025-05-14 21:57:10.742813 :971FD240:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12192 pso_num=26 pso_serial#=208 2025-05-14 21:57:10.742950 :971FD241:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=12192 (legacy spawn) 2025-05-14 21:57:10.749459 :971FD242: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-14 21:57:10.749624 :971FD24B: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-14 21:57:10.750429 :971FD24C:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-14 21:57:47.104075 :971FDE65:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-14 21:57:47.090 2025-05-14 21:57:47.104077 :971FDE66:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=3020 pso_num=26 pso_serial#=209 2025-05-14 21:57:47.104212 :971FDE67:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=3020 (legacy spawn) 2025-05-14 21:57:47.110682 :971FDE68: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-14 21:57:47.110865 :971FDE6D: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-14 21:57:47.111634 :971FDE72:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-14 21:57:47.120215 :971FDE75:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-14 21:57:47.106 2025-05-14 21:57:47.120217 :971FDE76:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=8396 pso_num=26 pso_serial#=210 2025-05-14 21:57:47.120358 :971FDE77:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=8396 (legacy spawn) 2025-05-14 21:57:47.126848 :971FDE78: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-14 21:57:47.127012 :971FDE81: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-14 21:57:47.127803 :971FDE82:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-14 21:58:05.627374 :971FE435:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-14 21:58:05.619 2025-05-14 21:58:05.627376 :971FE436:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12720 pso_num=26 pso_serial#=211 2025-05-14 21:58:05.627519 :971FE437:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=12720 (legacy spawn) 2025-05-14 21:58:05.633968 :971FE438: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-14 21:58:05.634139 :971FE43D: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-14 21:58:05.634991 :971FE442:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-14 21:58:11.059429 :971FE5E4:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-14 21:58:11.046 2025-05-14 21:58:11.059431 :971FE5E5:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=11852 pso_num=26 pso_serial#=212 2025-05-14 21:58:11.059565 :971FE5E6:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=11852 (legacy spawn) 2025-05-14 21:58:11.066005 :971FE5E7: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-14 21:58:11.066034 :971FE5EA: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-14 21:58:11.066187 :971FE5F1: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-14 21:58:11.066976 :971FE5FE:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-14 21:58:47.280558 :971FF200:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-14 21:58:47.275 2025-05-14 21:58:47.280560 :971FF201:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=10268 pso_num=26 pso_serial#=213 2025-05-14 21:58:47.280701 :971FF202:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=10268 osp_idx=24 osp_ver=268217 osp_pg=0 (spawn #182485) 2025-05-14 21:58:47.280701 :971FF203: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-14 21:58:47.280702 :971FF204:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=239 time=235737157 2025-05-14 21:58:47.280702 :971FF205:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-14 21:58:47.280702 :971FF206:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-14 21:58:47.280703 :971FF207:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-14 21:58:47.280703 :971FF208:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-14 21:58:47.280704 :971FF209:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-14 21:58:47.281213 :971FF20A: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-14 21:58:47.281258 :971FF210: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-14 21:58:47.285300 :971FF239:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-05-14 21:58:47.285335 :971FF23A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-05-14 21:58:47.285582 :971FF23B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-05-14 21:58:47.285597 :971FF23C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-05-14 21:58:47.285804 :971FF23D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-05-14 21:58:47.285816 :971FF23E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-05-14 21:58:47.286020 :971FF23F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-05-14 21:58:47.286033 :971FF240:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-05-14 21:58:47.286240 :971FF241:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-05-14 21:58:47.286257 :971FF242:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-05-14 21:58:47.286459 :971FF243:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-05-14 21:58:47.286472 :971FF244:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-05-14 21:58:47.288959 :971FF245:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-14 21:58:56.612739 :971FF50F:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-14 21:58:56.599 2025-05-14 21:58:56.612741 :971FF510:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=6232 pso_num=26 pso_serial#=214 2025-05-14 21:58:56.612883 :971FF511:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=6232 (legacy spawn) 2025-05-14 21:58:56.619317 :971FF512: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-14 21:58:56.619496 :971FF517: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-14 21:58:56.620284 :971FF51C:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-14 21:58:56.628975 :971FF51F:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-14 21:58:56.614 2025-05-14 21:58:56.628977 :971FF520:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12732 pso_num=26 pso_serial#=215 2025-05-14 21:58:56.629114 :971FF521:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=12732 (legacy spawn) 2025-05-14 21:58:56.635506 :971FF522: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-14 21:58:56.635668 :971FF52B: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-14 21:58:56.636477 :971FF52C:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-14 21:58:59.815900 :971FF612:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-14 21:58:59.803 2025-05-14 21:58:59.815902 :971FF613:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=10696 pso_num=26 pso_serial#=216 2025-05-14 21:58:59.816038 :971FF614:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=10696 (legacy spawn) 2025-05-14 21:58:59.822981 :971FF615: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-14 21:58:59.823150 :971FF61A: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-14 21:58:59.823936 :971FF61E:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-14 21:58:59.832539 :971FF621:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-14 21:58:59.819 2025-05-14 21:58:59.832541 :971FF622:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=5912 pso_num=26 pso_serial#=217 2025-05-14 21:58:59.832675 :971FF623:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=5912 (legacy spawn) 2025-05-14 21:58:59.851468 :971FF624: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-14 21:58:59.851639 :971FF62B: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-14 21:58:59.852486 :971FF62E:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-14 21:59:07.791058 :971FF8C3:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-14 21:59:07.778 2025-05-14 21:59:07.791060 :971FF8C4:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=11132 pso_num=26 pso_serial#=218 2025-05-14 21:59:07.791193 :971FF8C5:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=11132 (legacy spawn) 2025-05-14 21:59:07.797696 :971FF8C6: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-14 21:59:07.797870 :971FF8CC: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-14 21:59:07.798675 :971FF8CF:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-14 21:59:11.931535 :971FF9EC:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-14 21:59:11.923 2025-05-14 21:59:11.931537 :971FF9ED:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=11748 pso_num=26 pso_serial#=219 2025-05-14 21:59:11.931679 :971FF9EE:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=11748 (legacy spawn) 2025-05-14 21:59:11.938554 :971FF9EF: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-14 21:59:11.938723 :971FF9F4: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-14 21:59:11.939542 :971FF9F9:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-14 21:59:53.460610 :972008A6:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-14 21:59:53.452 2025-05-14 21:59:53.460613 :972008A7:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=10904 pso_num=26 pso_serial#=220 2025-05-14 21:59:53.460751 :972008A8:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=10904 (legacy spawn) 2025-05-14 21:59:53.467230 :972008A9: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-14 21:59:53.467400 :972008AE: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-14 21:59:53.468219 :972008B3:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-14 22:00:00.017419 :97200AAA:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-14 22:00:00.010 2025-05-14 22:00:00.017421 :97200AAB:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=13248 pso_num=26 pso_serial#=221 2025-05-14 22:00:00.017538 :97200AAC:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=13248 osp_idx=24 osp_ver=268225 osp_pg=0 (spawn #182488) 2025-05-14 22:00:00.017539 :97200AAD: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-14 22:00:00.017539 :97200AAE:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=240 time=235809891 2025-05-14 22:00:00.017540 :97200AAF:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-14 22:00:00.017540 :97200AB0:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-14 22:00:00.017540 :97200AB1:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-14 22:00:00.017541 :97200AB2:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-14 22:00:00.017541 :97200AB3:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-14 22:00:00.017615 :97200AB4: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-14 22:00:00.017623 :97200AB5: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: 13248, VKRM)