Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250817100020\orcl_j002_21280_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:35435M/63366M, Ph+PgF:40735M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 28 Windows thread id: 21280, image: ORACLE.EXE (J002) *** 2025-08-17 10:00:20.382 *** SESSION ID:(225.17787) 2025-08-17 10:00:20.382 *** 2025-08-17 10:00:20.382 Process diagnostic dump for ORACLE.EXE (J002), OS id=21280, pid: 28, proc_ser: 129, sid: 225, sess_ser: 17787 ------------------------------------------------------------------------------- current sql: client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 21280 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.319057 sec, exc=0.319057 sec, total=0.319057 sec wait times: max=0.500000 sec, heur=4.321915 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.000009 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.500000 sec, exc=0.500000 sec, total=0.500000 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 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.499998 sec, exc=0.499998 sec, total=0.499998 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000011 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.500001 sec, exc=0.500001 sec, total=0.500001 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 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.499985 sec, exc=0.499985 sec, total=0.499985 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000010 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.504589 sec, exc=0.504589 sec, total=0.504589 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 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.499999 sec, exc=0.499999 sec, total=0.499999 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.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.000008 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.498219 sec, exc=0.498219 sec, total=0.498219 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 225 serial 17787 --------------------------------------------------- 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, 10:00:16 - 10:00:20] idle wait at each sample [session created at: 10:00:16] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-08-17 10:00:20.382 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 28 (osid: 21280, J002) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-08-17 09:54:39.407350 :C0E32E7A:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=8216 (legacy spawn) 2025-08-17 09:54:39.414315 :C0E32E7B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-17 09:54:39.414488 :C0E32E84:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-17 09:54:39.415339 :C0E32E85:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-17 09:54:41.822824 :C0E32F5A:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-17 09:54:41.814 2025-08-17 09:54:41.822825 :C0E32F5B:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=20860 pso_num=28 pso_serial#=102 2025-08-17 09:54:41.822960 :C0E32F5C:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=20860 (legacy spawn) 2025-08-17 09:54:41.829431 :C0E32F5D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-17 09:54:41.829598 :C0E32F62:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-17 09:54:41.830434 :C0E32F67:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-17 09:54:46.348038 :C0E3310B:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-17 09:54:46.339 2025-08-17 09:54:46.348040 :C0E3310C:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=21596 pso_num=28 pso_serial#=103 2025-08-17 09:54:46.348174 :C0E3310D:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=21596 (legacy spawn) 2025-08-17 09:54:46.354638 :C0E3310E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-17 09:54:46.354814 :C0E33115:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-17 09:54:46.355655 :C0E33117:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-17 09:55:48.541358 :C0E34514:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-17 09:55:48.529 2025-08-17 09:55:48.541360 :C0E34515:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=21872 pso_num=28 pso_serial#=104 2025-08-17 09:55:48.541498 :C0E34516:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=21872 (legacy spawn) 2025-08-17 09:55:48.547996 :C0E34517:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-17 09:55:48.548168 :C0E3451C:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-17 09:55:48.548975 :C0E34521:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-17 09:55:48.777399 :C0E34524:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-17 09:55:48.763 2025-08-17 09:55:48.777400 :C0E34525:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=22444 pso_num=28 pso_serial#=105 2025-08-17 09:55:48.777533 :C0E34526:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=22444 (legacy spawn) 2025-08-17 09:55:48.784000 :C0E34527:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-17 09:55:48.784168 :C0E34530:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-17 09:55:48.784964 :C0E34531:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-17 09:55:48.802054 :C0E34534:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-17 09:55:48.794 2025-08-17 09:55:48.802056 :C0E34535:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=21888 pso_num=28 pso_serial#=106 2025-08-17 09:55:48.802192 :C0E34536:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=21888 (legacy spawn) 2025-08-17 09:55:48.808645 :C0E34537:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-17 09:55:48.808809 :C0E34540:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-17 09:55:48.809618 :C0E34541:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-17 09:55:50.035249 :C0E345F8:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-17 09:55:50.026 2025-08-17 09:55:50.035251 :C0E345F9:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=17544 pso_num=28 pso_serial#=107 2025-08-17 09:55:50.035388 :C0E345FA:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=17544 (legacy spawn) 2025-08-17 09:55:50.041918 :C0E345FB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-17 09:55:50.042085 :C0E34600:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-17 09:55:50.042886 :C0E34605:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-17 09:56:24.022378 :C0E351E1:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-17 09:56:24.012 2025-08-17 09:56:24.022381 :C0E351E2:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=22452 pso_num=28 pso_serial#=108 2025-08-17 09:56:24.022530 :C0E351E3:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=22452 (legacy spawn) 2025-08-17 09:56:24.029559 :C0E351E4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-17 09:56:24.029743 :C0E351ED:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-17 09:56:24.030631 :C0E351EE:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-17 09:56:25.026758 :C0E35220:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-17 09:56:25.012 2025-08-17 09:56:25.026760 :C0E35221:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=22220 pso_num=28 pso_serial#=109 2025-08-17 09:56:25.026897 :C0E35222:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=22220 (legacy spawn) 2025-08-17 09:56:25.033348 :C0E35223:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-17 09:56:25.033515 :C0E35228:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-17 09:56:25.034319 :C0E3522D:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-17 09:56:25.042957 :C0E35230:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-17 09:56:25.028 2025-08-17 09:56:25.042959 :C0E35231:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=20380 pso_num=28 pso_serial#=110 2025-08-17 09:56:25.043103 :C0E35232:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=20380 (legacy spawn) 2025-08-17 09:56:25.049586 :C0E35233:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-17 09:56:25.049620 :C0E35236:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-17 09:56:25.049783 :C0E3523D:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-17 09:56:25.050587 :C0E3524A:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-17 09:56:28.198446 :C0E35368:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-17 09:56:28.196 2025-08-17 09:56:28.198447 :C0E35369:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=12612 pso_num=28 pso_serial#=111 2025-08-17 09:56:28.198576 :C0E3536A:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=12612 (legacy spawn) 2025-08-17 09:56:28.205064 :C0E3536B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-17 09:56:28.205241 :C0E35370:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-17 09:56:28.206055 :C0E35375:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-17 09:56:28.553534 :C0E353C9:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-17 09:56:28.540 2025-08-17 09:56:28.553536 :C0E353CA:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=16996 pso_num=28 pso_serial#=112 2025-08-17 09:56:28.553678 :C0E353CB:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=16996 (legacy spawn) 2025-08-17 09:56:28.560479 :C0E353CC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-17 09:56:28.560656 :C0E353D5:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-17 09:56:28.561514 :C0E353D6:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-17 09:56:45.306217 :C0E358D4:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-17 09:56:45.292 2025-08-17 09:56:45.306219 :C0E358D5:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=21744 pso_num=28 pso_serial#=113 2025-08-17 09:56:45.306376 :C0E358D6:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=21744 (legacy spawn) 2025-08-17 09:56:45.312828 :C0E358D7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-17 09:56:45.313016 :C0E358DC:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-17 09:56:45.313819 :C0E358E1:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-17 09:56:45.322476 :C0E358E4:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-17 09:56:45.308 2025-08-17 09:56:45.322478 :C0E358E5:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=17836 pso_num=28 pso_serial#=114 2025-08-17 09:56:45.322620 :C0E358E6:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=17836 (legacy spawn) 2025-08-17 09:56:45.329093 :C0E358E7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-17 09:56:45.329250 :C0E358F0:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-17 09:56:45.330046 :C0E358F1:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-17 09:57:21.773690 :C0E36520:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-17 09:57:21.765 2025-08-17 09:57:21.773692 :C0E36521:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=7216 pso_num=28 pso_serial#=115 2025-08-17 09:57:21.773856 :C0E36522:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=7216 (legacy spawn) 2025-08-17 09:57:21.780971 :C0E36523:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-17 09:57:21.781155 :C0E36528:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-17 09:57:21.782119 :C0E3652D:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-17 09:57:32.242040 :C0E368B0:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-17 09:57:32.228 2025-08-17 09:57:32.242042 :C0E368B1:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=21144 pso_num=28 pso_serial#=116 2025-08-17 09:57:32.242187 :C0E368B2:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=21144 (legacy spawn) 2025-08-17 09:57:32.248625 :C0E368B3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-17 09:57:32.248801 :C0E368BC:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-17 09:57:32.249606 :C0E368BD:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-17 09:57:34.966499 :C0E36996:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-17 09:57:34.958 2025-08-17 09:57:34.966501 :C0E36997:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=19984 pso_num=28 pso_serial#=117 2025-08-17 09:57:34.966641 :C0E36998:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=19984 (legacy spawn) 2025-08-17 09:57:34.973082 :C0E36999:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-17 09:57:34.973268 :C0E369A1:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-17 09:57:34.974053 :C0E369A3:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-17 09:57:37.989112 :C0E36AA1:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-17 09:57:37.974 2025-08-17 09:57:37.989115 :C0E36AA2:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=21756 pso_num=28 pso_serial#=118 2025-08-17 09:57:37.989255 :C0E36AA3:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=21756 (legacy spawn) 2025-08-17 09:57:37.995724 :C0E36AAF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-17 09:57:37.995896 :C0E36AB8:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-17 09:57:37.996708 :C0E36AB9:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-17 09:57:38.014383 :C0E36ABC:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-17 09:57:38.006 2025-08-17 09:57:38.014385 :C0E36ABD:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=18912 pso_num=28 pso_serial#=119 2025-08-17 09:57:38.014527 :C0E36ABE:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=18912 (legacy spawn) 2025-08-17 09:57:38.020999 :C0E36ABF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-17 09:57:38.021161 :C0E36AC8:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-17 09:57:38.022035 :C0E36AC9:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-17 09:57:41.382252 :C0E36BD1:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-17 09:57:41.368 2025-08-17 09:57:41.382255 :C0E36BD2:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=16392 pso_num=28 pso_serial#=120 2025-08-17 09:57:41.382399 :C0E36BD3:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=16392 (legacy spawn) 2025-08-17 09:57:41.389469 :C0E36BD4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-17 09:57:41.389652 :C0E36BD9:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-17 09:57:41.390550 :C0E36BDE:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-17 09:57:41.400007 :C0E36BE1:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-17 09:57:41.399 2025-08-17 09:57:41.400009 :C0E36BE2:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=21964 pso_num=28 pso_serial#=121 2025-08-17 09:57:41.400155 :C0E36BE3:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=21964 (legacy spawn) 2025-08-17 09:57:41.407037 :C0E36BE4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-17 09:57:41.407210 :C0E36BED:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-17 09:57:41.408061 :C0E36BEE:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-17 09:58:40.436609 :C0E37E9B:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-17 09:58:40.423 2025-08-17 09:58:40.436611 :C0E37E9C:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=20960 pso_num=28 pso_serial#=122 2025-08-17 09:58:40.436750 :C0E37E9D:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=20960 (legacy spawn) 2025-08-17 09:58:40.443306 :C0E37E9E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-17 09:58:40.443477 :C0E37EA3:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-17 09:58:40.444275 :C0E37EA8:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-17 09:59:26.164717 :C0E38E9D:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-17 09:59:26.156 2025-08-17 09:59:26.164719 :C0E38E9E:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=21856 pso_num=28 pso_serial#=123 2025-08-17 09:59:26.164854 :C0E38E9F:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=21856 (legacy spawn) 2025-08-17 09:59:26.171411 :C0E38EA0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-17 09:59:26.171595 :C0E38EA9:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-17 09:59:26.172397 :C0E38EAA:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-17 09:59:27.389390 :C0E38EEC:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-17 09:59:27.380 2025-08-17 09:59:27.389392 :C0E38EED:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=15096 pso_num=28 pso_serial#=124 2025-08-17 09:59:27.389536 :C0E38EEE:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=15096 (legacy spawn) 2025-08-17 09:59:27.396546 :C0E38EEF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-17 09:59:27.396738 :C0E38EF4:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-17 09:59:27.397668 :C0E38EF9:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-17 09:59:27.407129 :C0E38EFC:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-17 09:59:27.396 2025-08-17 09:59:27.407131 :C0E38EFD:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=21456 pso_num=28 pso_serial#=125 2025-08-17 09:59:27.407269 :C0E38EFE:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=21456 (legacy spawn) 2025-08-17 09:59:27.414455 :C0E38EFF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-17 09:59:27.414626 :C0E38F08:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-17 09:59:27.415546 :C0E38F09:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-17 09:59:30.683704 :C0E39005:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-17 09:59:30.682 2025-08-17 09:59:30.683706 :C0E39006:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=17392 pso_num=28 pso_serial#=126 2025-08-17 09:59:30.683842 :C0E39007:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=17392 (legacy spawn) 2025-08-17 09:59:30.690369 :C0E39008:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-17 09:59:30.690545 :C0E3900D:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-17 09:59:30.691343 :C0E39012:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-17 09:59:30.700060 :C0E39015:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-17 09:59:30.697 2025-08-17 09:59:30.700062 :C0E39016:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=17716 pso_num=28 pso_serial#=127 2025-08-17 09:59:30.700196 :C0E39017:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=17716 (legacy spawn) 2025-08-17 09:59:30.716308 :C0E39018:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-17 09:59:30.716470 :C0E39021:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-17 09:59:30.717296 :C0E39022:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-17 09:59:48.626197 :C0E395D6:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-17 09:59:48.617 2025-08-17 09:59:48.626199 :C0E395D7:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=22364 pso_num=28 pso_serial#=128 2025-08-17 09:59:48.626333 :C0E395D8:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=22364 (legacy spawn) 2025-08-17 09:59:48.632867 :C0E395D9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-17 09:59:48.633034 :C0E395E1:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-17 09:59:48.633829 :C0E395E3:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-17 10:00:16.065926 :C0E3A09B:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-17 10:00:16.065 2025-08-17 10:00:16.065928 :C0E3A09C:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=21280 pso_num=28 pso_serial#=129 2025-08-17 10:00:16.066064 :C0E3A0A1:db_trace:kso.c@4093:ksonfy(): [10420:28:0] kso: new process: pid=21280 osp_idx=26 osp_ver=238092 osp_pg=0 (spawn #497490) 2025-08-17 10:00:16.066064 :C0E3A0A2:db_trace:kso.c@4099:ksonfy(): [10420:28:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-17 10:00:16.066065 :C0E3A0A3:db_trace:kso.c@4103:ksonfy(): [10420:28:0] kso: new process: pso_index=28 reservation=226 time=4105485361 2025-08-17 10:00:16.066065 :C0E3A0A4:db_trace:kso.c@4109:ksonfy(): [10420:28:0] kso: spawn diagnostics: queue time=0 secs 2025-08-17 10:00:16.066066 :C0E3A0A5:db_trace:kso.c@4111:ksonfy(): [10420:28:0] kso: spawn diagnostics: fork time=0 secs 2025-08-17 10:00:16.066066 :C0E3A0A6:db_trace:kso.c@4113:ksonfy(): [10420:28:0] kso: spawn diagnostics: exec time=0 secs 2025-08-17 10:00:16.066066 :C0E3A0A7:db_trace:kso.c@4115:ksonfy(): [10420:28:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-17 10:00:16.066067 :C0E3A0A8:db_trace:kso.c@4117:ksonfy(): [10420:28:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-17 10:00:16.066572 :C0E3A0AE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] 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 28 (osid: 21280, J002)