Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250522220006\orcl_vkrm_9952_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:37338M/63366M, Ph+PgF:44417M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 26 Windows thread id: 9952, image: ORACLE.EXE (VKRM) *** 2025-05-22 22:00:06.115 *** SESSION ID:(209.41381) 2025-05-22 22:00:06.115 *** 2025-05-22 22:00:06.115 Process diagnostic dump for ORACLE.EXE (VKRM), OS id=9952, pid: 26, proc_ser: 221, sid: 209, sess_ser: 41381 ------------------------------------------------------------------------------- current sql: Current Wait Stack: 0: waiting for 'VKRM Idle' =0x0, =0x0, =0x0 wait_id=1 seq_num=2 snap_id=1 wait times: snap=5.994620 sec, exc=5.994620 sec, total=5.994620 sec wait times: max=infinite, heur=5.994620 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.001139 sec since current wait 0: waited for 'resmgr:internal state change' location=0x3, =0x0, =0x0 wait_id=0 seq_num=1 snap_id=1 wait times: snap=0.099797 sec, exc=0.099797 sec, total=0.099797 sec wait times: max=0.100000 sec wait counts: calls=1 os=1 occurred after 0.000000 sec of elapsed time Sampled Session History of session 209 serial 41381 --------------------------------------------------- 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 --------------------------------------------------- [7 samples, 22:00:00 - 22:00:06] 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-22 22:00:06.115 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 26 (osid: 9952, VKRM) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-22 21:55:06.104562 :9AA9DD77:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=10124 (legacy spawn) 2025-05-22 21:55:06.111089 :9AA9DD78: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-22 21:55:06.111259 :9AA9DD7D: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-22 21:55:06.112049 :9AA9DD82:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-22 21:55:06.120706 :9AA9DD85:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-22 21:55:06.117 2025-05-22 21:55:06.120708 :9AA9DD86:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=13976 pso_num=26 pso_serial#=194 2025-05-22 21:55:06.120843 :9AA9DD87:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=13976 (legacy spawn) 2025-05-22 21:55:06.127304 :9AA9DD88: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-22 21:55:06.127473 :9AA9DD91: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-22 21:55:06.128292 :9AA9DD92:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-22 21:55:42.250416 :9AA9EA12:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-22 21:55:42.241 2025-05-22 21:55:42.250418 :9AA9EA13:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12532 pso_num=26 pso_serial#=195 2025-05-22 21:55:42.250549 :9AA9EA14:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=12532 (legacy spawn) 2025-05-22 21:55:42.257030 :9AA9EA15: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-22 21:55:42.257208 :9AA9EA1A: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-22 21:55:42.258006 :9AA9EA1F:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-22 21:55:42.474168 :9AA9EA26:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-22 21:55:42.460 2025-05-22 21:55:42.474170 :9AA9EA27:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12128 pso_num=26 pso_serial#=196 2025-05-22 21:55:42.474309 :9AA9EA28:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=12128 (legacy spawn) 2025-05-22 21:55:42.493052 :9AA9EA29: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-22 21:55:42.493227 :9AA9EA32: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-22 21:55:42.494068 :9AA9EA33:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-22 21:55:42.502729 :9AA9EA36:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-22 21:55:42.491 2025-05-22 21:55:42.502732 :9AA9EA37:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12756 pso_num=26 pso_serial#=197 2025-05-22 21:55:42.502867 :9AA9EA38:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=12756 (legacy spawn) 2025-05-22 21:55:42.509331 :9AA9EA39: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-22 21:55:42.509502 :9AA9EA42: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-22 21:55:42.510307 :9AA9EA43:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-22 21:55:45.702948 :9AA9EB40:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-22 21:55:45.689 2025-05-22 21:55:45.702950 :9AA9EB41:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12400 pso_num=26 pso_serial#=198 2025-05-22 21:55:45.703087 :9AA9EB42:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=12400 (legacy spawn) 2025-05-22 21:55:45.709966 :9AA9EB43: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-22 21:55:45.710164 :9AA9EB48: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-22 21:55:45.711035 :9AA9EB4D:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-22 21:55:45.720253 :9AA9EB50:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-22 21:55:45.705 2025-05-22 21:55:45.720256 :9AA9EB51:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=13268 pso_num=26 pso_serial#=199 2025-05-22 21:55:45.720398 :9AA9EB52:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=13268 (legacy spawn) 2025-05-22 21:55:45.727332 :9AA9EB53: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-22 21:55:45.727505 :9AA9EB5C: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-22 21:55:45.728451 :9AA9EB5D:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-22 21:55:54.227109 :9AA9EDED:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-22 21:55:54.219 2025-05-22 21:55:54.227111 :9AA9EDEE:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=14144 pso_num=26 pso_serial#=200 2025-05-22 21:55:54.227245 :9AA9EDEF:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=14144 (legacy spawn) 2025-05-22 21:55:54.233742 :9AA9EDF0: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-22 21:55:54.233916 :9AA9EDF5: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-22 21:55:54.234813 :9AA9EDFA:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-22 21:56:49.977895 :9AA9FF16:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-22 21:56:49.970 2025-05-22 21:56:49.977898 :9AA9FF17:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=13500 pso_num=26 pso_serial#=201 2025-05-22 21:56:49.978030 :9AA9FF18:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=13500 (legacy spawn) 2025-05-22 21:56:49.984566 :9AA9FF19: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-22 21:56:49.984741 :9AA9FF22: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-22 21:56:49.985594 :9AA9FF23:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-22 21:56:50.651704 :9AA9FFA9:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-22 21:56:50.643 2025-05-22 21:56:50.651706 :9AA9FFAA:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=13256 pso_num=26 pso_serial#=202 2025-05-22 21:56:50.651838 :9AA9FFAB:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=13256 (legacy spawn) 2025-05-22 21:56:50.658292 :9AA9FFAC: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-22 21:56:50.658448 :9AA9FFB1: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-22 21:56:50.659236 :9AA9FFB6:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-22 21:56:55.605738 :9AAA00FA:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-22 21:56:55.594 2025-05-22 21:56:55.605740 :9AAA00FB:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12772 pso_num=26 pso_serial#=203 2025-05-22 21:56:55.605876 :9AAA00FC:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=12772 (legacy spawn) 2025-05-22 21:56:55.612352 :9AAA00FD: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-22 21:56:55.612521 :9AAA0106: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-22 21:56:55.613322 :9AAA0107:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-22 21:56:55.622027 :9AAA010A:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-22 21:56:55.610 2025-05-22 21:56:55.622029 :9AAA010B:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=10888 pso_num=26 pso_serial#=204 2025-05-22 21:56:55.622167 :9AAA010C:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=10888 (legacy spawn) 2025-05-22 21:56:55.628648 :9AAA010D: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-22 21:56:55.628810 :9AAA0116: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-22 21:56:55.629630 :9AAA0117:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-22 21:56:56.462165 :9AAA0175:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-22 21:56:56.453 2025-05-22 21:56:56.462167 :9AAA0176:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=11212 pso_num=26 pso_serial#=205 2025-05-22 21:56:56.462310 :9AAA0177:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=11212 (legacy spawn) 2025-05-22 21:56:56.468783 :9AAA0178: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-22 21:56:56.468949 :9AAA017D: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-22 21:56:56.469796 :9AAA0182:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-22 21:56:58.810160 :9AAA0214:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-22 21:56:58.797 2025-05-22 21:56:58.810163 :9AAA0215:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12620 pso_num=26 pso_serial#=206 2025-05-22 21:56:58.810297 :9AAA0216:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=12620 (legacy spawn) 2025-05-22 21:56:58.816710 :9AAA0217: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-22 21:56:58.816886 :9AAA021C: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-22 21:56:58.817676 :9AAA0221:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-22 21:56:58.826254 :9AAA0224:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-22 21:56:58.813 2025-05-22 21:56:58.826256 :9AAA0225:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=6844 pso_num=26 pso_serial#=207 2025-05-22 21:56:58.826391 :9AAA0226:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=6844 (legacy spawn) 2025-05-22 21:56:58.832908 :9AAA0227: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-22 21:56:58.833069 :9AAA0230: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-22 21:56:58.833863 :9AAA0231:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-22 21:57:58.649462 :9AAA1507:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-22 21:57:58.641 2025-05-22 21:57:58.649465 :9AAA1508:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=11852 pso_num=26 pso_serial#=208 2025-05-22 21:57:58.649650 :9AAA1509:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=11852 (legacy spawn) 2025-05-22 21:57:58.656160 :9AAA150A: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-22 21:57:58.656337 :9AAA150F: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-22 21:57:58.657159 :9AAA1514:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-22 21:57:58.837150 :9AAA1517:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-22 21:57:58.829 2025-05-22 21:57:58.837152 :9AAA1518:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=9724 pso_num=26 pso_serial#=209 2025-05-22 21:57:58.837289 :9AAA1519:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=9724 (legacy spawn) 2025-05-22 21:57:58.843756 :9AAA151A: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-22 21:57:58.843933 :9AAA1523: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-22 21:57:58.844725 :9AAA1524:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-22 21:58:29.744622 :9AAA1F40:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-22 21:58:29.737 2025-05-22 21:58:29.744624 :9AAA1F41:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=7792 pso_num=26 pso_serial#=210 2025-05-22 21:58:29.744765 :9AAA1F42:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=7792 (legacy spawn) 2025-05-22 21:58:29.751224 :9AAA1F43: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-22 21:58:29.751393 :9AAA1F48: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-22 21:58:29.752203 :9AAA1F4D:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-22 21:58:32.817541 :9AAA202F:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-22 21:58:32.808 2025-05-22 21:58:32.817543 :9AAA2030:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12492 pso_num=26 pso_serial#=211 2025-05-22 21:58:32.817676 :9AAA2031:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=12492 (legacy spawn) 2025-05-22 21:58:32.824157 :9AAA2032: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-22 21:58:32.824330 :9AAA2037: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-22 21:58:32.825158 :9AAA203C:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-22 21:58:44.793939 :9AAA2401:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-22 21:58:44.779 2025-05-22 21:58:44.793941 :9AAA2402:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=11784 pso_num=26 pso_serial#=212 2025-05-22 21:58:44.794084 :9AAA2403:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=11784 (legacy spawn) 2025-05-22 21:58:44.800585 :9AAA242C: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-22 21:58:44.800747 :9AAA2431: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-22 21:58:44.801513 :9AAA2436:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-22 21:58:44.810060 :9AAA2439:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-22 21:58:44.795 2025-05-22 21:58:44.810062 :9AAA243A:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=13304 pso_num=26 pso_serial#=213 2025-05-22 21:58:44.810196 :9AAA243B:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=13304 (legacy spawn) 2025-05-22 21:58:44.816693 :9AAA243C: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-22 21:58:44.816860 :9AAA2445: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-22 21:58:44.817686 :9AAA2446:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-22 21:58:47.904131 :9AAA2522:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-22 21:58:47.890 2025-05-22 21:58:47.904133 :9AAA2523:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=10948 pso_num=26 pso_serial#=214 2025-05-22 21:58:47.904277 :9AAA2524:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=10948 (legacy spawn) 2025-05-22 21:58:47.910755 :9AAA2525: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-22 21:58:47.910924 :9AAA252A: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-22 21:58:47.911754 :9AAA252F:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-22 21:58:47.920331 :9AAA2532:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-22 21:58:47.906 2025-05-22 21:58:47.920333 :9AAA2533:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=14292 pso_num=26 pso_serial#=215 2025-05-22 21:58:47.920469 :9AAA2534:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=14292 (legacy spawn) 2025-05-22 21:58:47.926935 :9AAA2535: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-22 21:58:47.927111 :9AAA253E: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-22 21:58:47.927909 :9AAA253F:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-22 21:59:00.855026 :9AAA2910:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-22 21:59:00.847 2025-05-22 21:59:00.855028 :9AAA2911:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=9992 pso_num=26 pso_serial#=216 2025-05-22 21:59:00.855159 :9AAA2912:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=9992 (legacy spawn) 2025-05-22 21:59:00.861676 :9AAA2913: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-22 21:59:00.861866 :9AAA2918: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-22 21:59:00.862671 :9AAA291D:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-22 21:59:07.031655 :9AAA2AE8:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-22 21:59:07.018 2025-05-22 21:59:07.031657 :9AAA2AE9:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=13848 pso_num=26 pso_serial#=217 2025-05-22 21:59:07.031808 :9AAA2AEA:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=13848 (legacy spawn) 2025-05-22 21:59:07.038554 :9AAA2AEB: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-22 21:59:07.038721 :9AAA2AF0: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-22 21:59:07.039507 :9AAA2AF5:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-22 21:59:41.132272 :9AAA35E6:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-22 21:59:41.123 2025-05-22 21:59:41.132274 :9AAA35E7:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12908 pso_num=26 pso_serial#=218 2025-05-22 21:59:41.132407 :9AAA35E8:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=12908 (legacy spawn) 2025-05-22 21:59:41.138867 :9AAA35E9: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-22 21:59:41.139043 :9AAA35F1: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-22 21:59:41.139838 :9AAA35F3:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-22 21:59:57.263560 :9AAA3B13:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-22 21:59:57.249 2025-05-22 21:59:57.263562 :9AAA3B14:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=13416 pso_num=26 pso_serial#=219 2025-05-22 21:59:57.263698 :9AAA3B15:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=13416 (legacy spawn) 2025-05-22 21:59:57.270169 :9AAA3B16: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-22 21:59:57.270331 :9AAA3B1B: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-22 21:59:57.270984 :9AAA3B20:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-22 21:59:57.279352 :9AAA3B23:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-22 21:59:57.265 2025-05-22 21:59:57.279354 :9AAA3B24:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=5912 pso_num=26 pso_serial#=220 2025-05-22 21:59:57.279489 :9AAA3B25:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=5912 (legacy spawn) 2025-05-22 21:59:57.285994 :9AAA3B26: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-22 21:59:57.286161 :9AAA3B2F: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-22 21:59:57.286830 :9AAA3B30:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-22 22:00:00.029944 :9AAA3C39:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-22 22:00:00.022 2025-05-22 22:00:00.029946 :9AAA3C3A:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=9952 pso_num=26 pso_serial#=221 2025-05-22 22:00:00.030065 :9AAA3C3B:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=9952 osp_idx=24 osp_ver=314381 osp_pg=0 (spawn #209171) 2025-05-22 22:00:00.030066 :9AAA3C3C: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-22 22:00:00.030067 :9AAA3C3D:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=109 time=926974922 2025-05-22 22:00:00.030067 :9AAA3C3E:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-22 22:00:00.030068 :9AAA3C3F:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-22 22:00:00.030068 :9AAA3C40:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-22 22:00:00.030069 :9AAA3C41:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-22 22:00:00.030069 :9AAA3C42:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-22 22:00:00.030145 :9AAA3C43: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-22 22:00:00.030152 :9AAA3C44: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: 9952, VKRM)