Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250712221122\orcl_j002_17352_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:36413M/63366M, Ph+PgF:42475M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 27 Windows thread id: 17352, image: ORACLE.EXE (J002) *** 2025-07-12 22:11:22.345 *** SESSION ID:(219.48245) 2025-07-12 22:11:22.345 *** 2025-07-12 22:11:22.345 Process diagnostic dump for ORACLE.EXE (J002), OS id=17352, pid: 27, proc_ser: 45, sid: 219, sess_ser: 48245 ------------------------------------------------------------------------------- current sql: client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 17352 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J002) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=8 seq_num=9 snap_id=1 wait times: snap=0.047593 sec, exc=0.047593 sec, total=0.047593 sec wait times: max=0.500000 sec, heur=4.053055 sec wait counts: calls=1 os=1 in_wait=1 iflags=0x5a8 Wait State: fixed_waits=0 flags=0x22 boundary=0x0000000000000000/-1 Session Wait History: elapsed time of 0.000010 sec since current wait 0: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=7 seq_num=8 snap_id=1 wait times: snap=0.499993 sec, exc=0.499993 sec, total=0.499993 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000011 sec of elapsed time 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=6 seq_num=7 snap_id=1 wait times: snap=0.499995 sec, exc=0.499995 sec, total=0.499995 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 2: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=5 seq_num=6 snap_id=1 wait times: snap=0.499996 sec, exc=0.499996 sec, total=0.499996 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000011 sec of elapsed time 3: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=4 seq_num=5 snap_id=1 wait times: snap=0.500172 sec, exc=0.500172 sec, total=0.500172 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000012 sec of elapsed time 4: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=3 seq_num=4 snap_id=1 wait times: snap=0.500005 sec, exc=0.500005 sec, total=0.500005 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000006 sec of elapsed time 5: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=2 seq_num=3 snap_id=1 wait times: snap=0.511636 sec, exc=0.511636 sec, total=0.511636 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 6: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=1 seq_num=2 snap_id=1 wait times: snap=0.499995 sec, exc=0.499995 sec, total=0.499995 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000010 sec of elapsed time 7: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=0 seq_num=1 snap_id=1 wait times: snap=0.493594 sec, exc=0.493594 sec, total=0.493594 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000000 sec of elapsed time Sampled Session History of session 219 serial 48245 --------------------------------------------------- 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 --------------------------------------------------- [5 samples, 22:11:18 - 22:11:22] idle wait at each sample [session created at: 22:11:18] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-07-12 22:11:22.345 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 27 (osid: 17352, J002) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-07-12 22:06:39.081989 :B12A1CD0:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=4080 (legacy spawn) 2025-07-12 22:06:39.088501 :B12A1CD1: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-07-12 22:06:39.088672 :B12A1CD6: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-07-12 22:06:39.089571 :B12A1CDB:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-12 22:06:43.041514 :B12A1DDB:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-12 22:06:43.032 2025-07-12 22:06:43.041516 :B12A1DDC:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=17348 pso_num=27 pso_serial#=18 2025-07-12 22:06:43.041652 :B12A1DDD:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=17348 (legacy spawn) 2025-07-12 22:06:43.048255 :B12A1DDE: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-07-12 22:06:43.048425 :B12A1DE3: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-07-12 22:06:43.049259 :B12A1DE8:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-12 22:06:49.887339 :B12A1FFE:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-12 22:06:49.872 2025-07-12 22:06:49.887341 :B12A1FFF:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=8692 pso_num=27 pso_serial#=19 2025-07-12 22:06:49.887486 :B12A2000:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=8692 (legacy spawn) 2025-07-12 22:06:49.894104 :B12A201C: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-07-12 22:06:49.894275 :B12A2021: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-07-12 22:06:49.895100 :B12A2034:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-12 22:06:49.904029 :B12A2037:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-12 22:06:49.903 2025-07-12 22:06:49.904031 :B12A2038:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=18312 pso_num=27 pso_serial#=20 2025-07-12 22:06:49.904168 :B12A2039:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=18312 (legacy spawn) 2025-07-12 22:06:49.910757 :B12A203A: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-07-12 22:06:49.910929 :B12A2043: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-07-12 22:06:49.911762 :B12A2044:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-12 22:06:53.108246 :B12A2142:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-12 22:06:53.095 2025-07-12 22:06:53.108248 :B12A2143:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=9904 pso_num=27 pso_serial#=21 2025-07-12 22:06:53.108389 :B12A2144:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=9904 (legacy spawn) 2025-07-12 22:06:53.114880 :B12A2145: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-07-12 22:06:53.115064 :B12A214A: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-07-12 22:06:53.115854 :B12A214F:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-12 22:06:53.124439 :B12A2152:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-12 22:06:53.110 2025-07-12 22:06:53.124440 :B12A2153:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=7532 pso_num=27 pso_serial#=22 2025-07-12 22:06:53.124576 :B12A2154:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=7532 (legacy spawn) 2025-07-12 22:06:53.131095 :B12A2155: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-07-12 22:06:53.131261 :B12A215E: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-07-12 22:06:53.132067 :B12A215F:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-12 22:07:41.306820 :B12A3132:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-12 22:07:41.299 2025-07-12 22:07:41.306822 :B12A3133:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=15704 pso_num=27 pso_serial#=23 2025-07-12 22:07:41.306969 :B12A3134:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=15704 (legacy spawn) 2025-07-12 22:07:41.313469 :B12A3135: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-07-12 22:07:41.313639 :B12A313A: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-07-12 22:07:41.314458 :B12A313F:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-12 22:07:51.239031 :B12A3460:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-12 22:07:51.229 2025-07-12 22:07:51.239034 :B12A3461:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=15676 pso_num=27 pso_serial#=24 2025-07-12 22:07:51.239167 :B12A3462:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=15676 (legacy spawn) 2025-07-12 22:07:51.245598 :B12A3463: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-07-12 22:07:51.245769 :B12A3468: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-07-12 22:07:51.246551 :B12A346D:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-12 22:08:02.585245 :B12A37B8:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-12 22:08:02.581 2025-07-12 22:08:02.585248 :B12A37B9:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=3568 pso_num=27 pso_serial#=25 2025-07-12 22:08:02.585380 :B12A37BA:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=3568 (legacy spawn) 2025-07-12 22:08:02.591867 :B12A37BB: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-07-12 22:08:02.592050 :B12A37C4: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-07-12 22:08:02.592838 :B12A37C5:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-12 22:08:02.601349 :B12A37EB:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-12 22:08:02.597 2025-07-12 22:08:02.601351 :B12A37EC:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=17964 pso_num=27 pso_serial#=26 2025-07-12 22:08:02.601489 :B12A37ED:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=17964 (legacy spawn) 2025-07-12 22:08:02.608000 :B12A37EE: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-07-12 22:08:02.608166 :B12A37F7: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-07-12 22:08:02.609014 :B12A37F8:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-12 22:08:38.986844 :B12A440C:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-12 22:08:38.972 2025-07-12 22:08:38.986846 :B12A440D:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=17920 pso_num=27 pso_serial#=27 2025-07-12 22:08:38.986980 :B12A440E:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=17920 (legacy spawn) 2025-07-12 22:08:38.993413 :B12A440F: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-07-12 22:08:38.993594 :B12A4414: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-07-12 22:08:38.994384 :B12A4419:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-12 22:08:39.012328 :B12A441C:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-12 22:08:39.003 2025-07-12 22:08:39.012330 :B12A441D:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=5276 pso_num=27 pso_serial#=28 2025-07-12 22:08:39.012469 :B12A441E:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=5276 (legacy spawn) 2025-07-12 22:08:39.018923 :B12A441F: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-07-12 22:08:39.019110 :B12A4427: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-07-12 22:08:39.019916 :B12A4429:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-12 22:08:42.183143 :B12A4518:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-12 22:08:42.170 2025-07-12 22:08:42.183145 :B12A4519:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=3592 pso_num=27 pso_serial#=29 2025-07-12 22:08:42.183278 :B12A451A:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=3592 (legacy spawn) 2025-07-12 22:08:42.189709 :B12A451B: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-07-12 22:08:42.189891 :B12A4523: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-07-12 22:08:42.190770 :B12A4525:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-12 22:08:42.199444 :B12A4528:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-12 22:08:42.185 2025-07-12 22:08:42.199446 :B12A4529:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=13944 pso_num=27 pso_serial#=30 2025-07-12 22:08:42.199581 :B12A452A:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=13944 (legacy spawn) 2025-07-12 22:08:42.206085 :B12A452B: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-07-12 22:08:42.206252 :B12A4534: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-07-12 22:08:42.207066 :B12A4535:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-12 22:08:59.548106 :B12A4ADC:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-12 22:08:59.547 2025-07-12 22:08:59.548108 :B12A4ADD:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=876 pso_num=27 pso_serial#=31 2025-07-12 22:08:59.548256 :B12A4ADE:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=876 (legacy spawn) 2025-07-12 22:08:59.555052 :B12A4ADF: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-07-12 22:08:59.555235 :B12A4AE4: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-07-12 22:08:59.556135 :B12A4AE9:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-12 22:09:14.622362 :B12A4F7D:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-12 22:09:14.614 2025-07-12 22:09:14.622364 :B12A4F7E:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=15532 pso_num=27 pso_serial#=32 2025-07-12 22:09:14.622507 :B12A4F7F:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=15532 (legacy spawn) 2025-07-12 22:09:14.628979 :B12A4F80: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-07-12 22:09:14.629156 :B12A4F85: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-07-12 22:09:14.630072 :B12A4F8A:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-12 22:09:15.404026 :B12A4FE4:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-12 22:09:15.390 2025-07-12 22:09:15.404028 :B12A4FE5:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=15780 pso_num=27 pso_serial#=33 2025-07-12 22:09:15.404167 :B12A4FE6:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=15780 (legacy spawn) 2025-07-12 22:09:15.410623 :B12A4FE7: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-07-12 22:09:15.410784 :B12A4FEF: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-07-12 22:09:15.411580 :B12A4FF1:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-12 22:09:15.420245 :B12A4FF4:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-12 22:09:15.405 2025-07-12 22:09:15.420247 :B12A4FF5:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=10992 pso_num=27 pso_serial#=34 2025-07-12 22:09:15.420378 :B12A4FF6:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=10992 (legacy spawn) 2025-07-12 22:09:15.426830 :B12A4FF7: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-07-12 22:09:15.426998 :B12A5000: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-07-12 22:09:15.427848 :B12A5001:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-12 22:09:18.506491 :B12A50F2:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-12 22:09:18.493 2025-07-12 22:09:18.506493 :B12A50F3:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=4428 pso_num=27 pso_serial#=35 2025-07-12 22:09:18.506627 :B12A50F4:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=4428 (legacy spawn) 2025-07-12 22:09:18.513079 :B12A50F5: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-07-12 22:09:18.513250 :B12A50FA: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-07-12 22:09:18.514027 :B12A50FF:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-12 22:09:18.532837 :B12A5102:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-12 22:09:18.525 2025-07-12 22:09:18.532839 :B12A5103:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=10836 pso_num=27 pso_serial#=36 2025-07-12 22:09:18.532977 :B12A5104:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=10836 (legacy spawn) 2025-07-12 22:09:18.539449 :B12A5105: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-07-12 22:09:18.539617 :B12A510A: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-07-12 22:09:18.540499 :B12A510F:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-12 22:09:33.742397 :B12A562B:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-12 22:09:33.731 2025-07-12 22:09:33.742399 :B12A562C:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=2512 pso_num=27 pso_serial#=37 2025-07-12 22:09:33.742535 :B12A562D:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=2512 (legacy spawn) 2025-07-12 22:09:33.749043 :B12A562E: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-07-12 22:09:33.749207 :B12A5633: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-07-12 22:09:33.750026 :B12A5638:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-12 22:09:45.737407 :B12A59E5:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-12 22:09:45.729 2025-07-12 22:09:45.737408 :B12A59E6:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=18260 pso_num=27 pso_serial#=38 2025-07-12 22:09:45.737544 :B12A59E7:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=18260 (legacy spawn) 2025-07-12 22:09:45.744108 :B12A59E8: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-07-12 22:09:45.744275 :B12A59ED: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-07-12 22:09:45.745094 :B12A59F2:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-12 22:09:51.690431 :B12A5BC1:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-12 22:09:51.675 2025-07-12 22:09:51.690433 :B12A5BC2:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=12796 pso_num=27 pso_serial#=39 2025-07-12 22:09:51.690582 :B12A5BC3:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=12796 (legacy spawn) 2025-07-12 22:09:51.697072 :B12A5BC4: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-07-12 22:09:51.697243 :B12A5BC9: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-07-12 22:09:51.698048 :B12A5BCE:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-12 22:09:51.707027 :B12A5BD1:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-12 22:09:51.706 2025-07-12 22:09:51.707029 :B12A5BD2:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=11328 pso_num=27 pso_serial#=40 2025-07-12 22:09:51.707179 :B12A5BD3:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=11328 (legacy spawn) 2025-07-12 22:09:51.713648 :B12A5BD4: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-07-12 22:09:51.713812 :B12A5BDD: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-07-12 22:09:51.714625 :B12A5BDE:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-12 22:09:54.880358 :B12A5CE4:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-12 22:09:54.867 2025-07-12 22:09:54.880360 :B12A5CE5:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=17112 pso_num=27 pso_serial#=41 2025-07-12 22:09:54.880502 :B12A5CE6:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=17112 (legacy spawn) 2025-07-12 22:09:54.900139 :B12A5CE7: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-07-12 22:09:54.900313 :B12A5CEC: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-07-12 22:09:54.901170 :B12A5CF1:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-12 22:09:54.909932 :B12A5CF4:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-12 22:09:54.898 2025-07-12 22:09:54.909934 :B12A5CF5:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=12164 pso_num=27 pso_serial#=42 2025-07-12 22:09:54.910070 :B12A5CF6:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=12164 (legacy spawn) 2025-07-12 22:09:54.916703 :B12A5CF7: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-07-12 22:09:54.916873 :B12A5D00: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-07-12 22:09:54.917719 :B12A5D01:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-12 22:10:41.857213 :B12A6C1A:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-12 22:10:41.846 2025-07-12 22:10:41.857215 :B12A6C1B:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=15800 pso_num=27 pso_serial#=43 2025-07-12 22:10:41.857353 :B12A6C1C:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=15800 (legacy spawn) 2025-07-12 22:10:41.863845 :B12A6C1D: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-07-12 22:10:41.864024 :B12A6C25: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-07-12 22:10:41.864839 :B12A6C27:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-12 22:10:47.930557 :B12A6E00:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-12 22:10:47.922 2025-07-12 22:10:47.930559 :B12A6E01:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=4120 pso_num=27 pso_serial#=44 2025-07-12 22:10:47.930694 :B12A6E02:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=4120 (legacy spawn) 2025-07-12 22:10:47.937212 :B12A6E03: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-07-12 22:10:47.937388 :B12A6E08: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-07-12 22:10:47.938213 :B12A6E0D:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-12 22:11:18.291809 :B12A7C9F:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-12 22:11:18.286 2025-07-12 22:11:18.291811 :B12A7CA0:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=17352 pso_num=27 pso_serial#=45 2025-07-12 22:11:18.291947 :B12A7CA1:db_trace:kso.c@4093:ksonfy(): [10420:27:0] kso: new process: pid=17352 osp_idx=25 osp_ver=155093 osp_pg=0 (spawn #379193) 2025-07-12 22:11:18.291947 :B12A7CA2:db_trace:kso.c@4099:ksonfy(): [10420:27:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-12 22:11:18.291948 :B12A7CA3:db_trace:kso.c@4103:ksonfy(): [10420:27:0] kso: new process: pso_index=27 reservation=224 time=1039054189 2025-07-12 22:11:18.291948 :B12A7CA4:db_trace:kso.c@4109:ksonfy(): [10420:27:0] kso: spawn diagnostics: queue time=0 secs 2025-07-12 22:11:18.291949 :B12A7CA5:db_trace:kso.c@4111:ksonfy(): [10420:27:0] kso: spawn diagnostics: fork time=0 secs 2025-07-12 22:11:18.291949 :B12A7CA6:db_trace:kso.c@4113:ksonfy(): [10420:27:0] kso: spawn diagnostics: exec time=0 secs 2025-07-12 22:11:18.291949 :B12A7CA7:db_trace:kso.c@4115:ksonfy(): [10420:27:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-12 22:11:18.291950 :B12A7CA8:db_trace:kso.c@4117:ksonfy(): [10420:27:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-12 22:11:18.292455 :B12A7CB2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 27 (osid: 17352, J002)