Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250824140413\orcl_j002_20048_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:35250M/63366M, Ph+PgF:40395M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 28 Windows thread id: 20048, image: ORACLE.EXE (J002) *** 2025-08-24 14:04:13.147 *** SESSION ID:(225.62791) 2025-08-24 14:04:13.147 *** 2025-08-24 14:04:13.147 Process diagnostic dump for ORACLE.EXE (J002), OS id=20048, pid: 28, proc_ser: 169, sid: 225, sess_ser: 62791 ------------------------------------------------------------------------------- current sql: client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 20048 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J002) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=9 seq_num=10 snap_id=1 wait times: snap=0.194534 sec, exc=0.194534 sec, total=0.194534 sec wait times: max=0.500000 sec, heur=4.614836 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.000013 sec since current wait 0: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=8 seq_num=9 snap_id=1 wait times: snap=0.498856 sec, exc=0.498856 sec, total=0.498856 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000005 sec of elapsed time 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=7 seq_num=8 snap_id=1 wait times: snap=0.407392 sec, exc=0.407392 sec, total=0.407392 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=6 seq_num=7 snap_id=1 wait times: snap=0.510123 sec, exc=0.510123 sec, total=0.510123 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000010 sec of elapsed time 3: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=5 seq_num=6 snap_id=1 wait times: snap=0.499987 sec, exc=0.499987 sec, total=0.499987 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=4 seq_num=5 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 5: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=3 seq_num=4 snap_id=1 wait times: snap=0.500008 sec, exc=0.500008 sec, total=0.500008 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=2 seq_num=3 snap_id=1 wait times: snap=0.499977 sec, exc=0.499977 sec, total=0.499977 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000014 sec of elapsed time 7: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=1 seq_num=2 snap_id=1 wait times: snap=0.510115 sec, exc=0.510115 sec, total=0.510115 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000013 sec of elapsed time 8: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=0 seq_num=1 snap_id=1 wait times: snap=0.493755 sec, exc=0.493755 sec, total=0.493755 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 62791 --------------------------------------------------- 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, 14:04:08 - 14:04:13] idle wait at each sample [session created at: 14:04:08] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-08-24 14:04:13.147 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 28 (osid: 20048, J002) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-08-24 14:00:16.600573 :C40A8F0F:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-24 14:00:19.681655 :C40A9003:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-24 14:00:19.668 2025-08-24 14:00:19.681657 :C40A9004:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=19536 pso_num=28 pso_serial#=143 2025-08-24 14:00:19.681802 :C40A9005:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=19536 (legacy spawn) 2025-08-24 14:00:19.688744 :C40A9006: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-24 14:00:19.688926 :C40A900B: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-24 14:00:19.689854 :C40A9010:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-24 14:00:19.699382 :C40A9013:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-24 14:00:19.699 2025-08-24 14:00:19.699385 :C40A9014:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=13028 pso_num=28 pso_serial#=144 2025-08-24 14:00:19.699537 :C40A9015:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=13028 (legacy spawn) 2025-08-24 14:00:19.706518 :C40A9016: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-24 14:00:19.706693 :C40A901F: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-24 14:00:19.707659 :C40A9020:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-24 14:00:43.515342 :C40A9793:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-24 14:00:43.507 2025-08-24 14:00:43.515344 :C40A9794:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=14932 pso_num=28 pso_serial#=145 2025-08-24 14:00:43.515488 :C40A9795:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=14932 (legacy spawn) 2025-08-24 14:00:43.522080 :C40A9796: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-24 14:00:43.522263 :C40A979D: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-24 14:00:43.523123 :C40A97A0:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-24 14:00:50.124878 :C40A99C7:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-24 14:00:50.115 2025-08-24 14:00:50.124880 :C40A99C8:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=20488 pso_num=28 pso_serial#=146 2025-08-24 14:00:50.125022 :C40A99C9:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=20488 (legacy spawn) 2025-08-24 14:00:50.131642 :C40A99CA: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-24 14:00:50.131816 :C40A99CF: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-24 14:00:50.132651 :C40A99D4:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-24 14:00:52.786374 :C40A9A8C:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-24 14:00:52.772 2025-08-24 14:00:52.786376 :C40A9A8D:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=20612 pso_num=28 pso_serial#=147 2025-08-24 14:00:52.786513 :C40A9A8E:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=20612 (legacy spawn) 2025-08-24 14:00:52.805056 :C40A9A8F: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-24 14:00:52.805228 :C40A9A94: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-24 14:00:52.806076 :C40A9A99:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-24 14:00:52.814697 :C40A9A9C:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-24 14:00:52.803 2025-08-24 14:00:52.814699 :C40A9A9D:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=22460 pso_num=28 pso_serial#=148 2025-08-24 14:00:52.814877 :C40A9A9E:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=22460 (legacy spawn) 2025-08-24 14:00:52.821379 :C40A9A9F: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-24 14:00:52.821551 :C40A9AA8: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-24 14:00:52.822388 :C40A9AA9:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-24 14:00:55.990881 :C40A9BCB:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-24 14:00:55.988 2025-08-24 14:00:55.990883 :C40A9BCC:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=19848 pso_num=28 pso_serial#=149 2025-08-24 14:00:55.991023 :C40A9BCD:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=19848 (legacy spawn) 2025-08-24 14:00:55.997498 :C40A9BCE: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-24 14:00:55.997672 :C40A9BD3: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-24 14:00:55.998494 :C40A9BD8:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-24 14:00:56.007155 :C40A9BDB:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-24 14:00:56.004 2025-08-24 14:00:56.007157 :C40A9BDC:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=20384 pso_num=28 pso_serial#=150 2025-08-24 14:00:56.007295 :C40A9BDD:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=20384 (legacy spawn) 2025-08-24 14:00:56.013753 :C40A9BDE: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-24 14:00:56.013926 :C40A9BE7: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-24 14:00:56.014742 :C40A9BE8:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-24 14:01:14.598745 :C40AA24C:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-24 14:01:14.590 2025-08-24 14:01:14.598747 :C40AA24D:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=19868 pso_num=28 pso_serial#=151 2025-08-24 14:01:14.598884 :C40AA24E:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=19868 (legacy spawn) 2025-08-24 14:01:14.605410 :C40AA24F: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-24 14:01:14.605610 :C40AA254: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-24 14:01:14.606407 :C40AA259:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-24 14:01:24.043092 :C40AA559:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-24 14:01:24.036 2025-08-24 14:01:24.043094 :C40AA55A:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=22216 pso_num=28 pso_serial#=152 2025-08-24 14:01:24.043228 :C40AA55B:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=22216 (legacy spawn) 2025-08-24 14:01:24.049767 :C40AA55C: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-24 14:01:24.049937 :C40AA565: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-24 14:01:24.050718 :C40AA566:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-24 14:01:29.206813 :C40AA6F0:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-24 14:01:29.193 2025-08-24 14:01:29.206815 :C40AA6F1:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=13960 pso_num=28 pso_serial#=153 2025-08-24 14:01:29.206992 :C40AA6F2:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=13960 (legacy spawn) 2025-08-24 14:01:29.213774 :C40AA6F3: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-24 14:01:29.213939 :C40AA6F8: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-24 14:01:29.214928 :C40AA6FD:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-24 14:01:29.223453 :C40AA700:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-24 14:01:29.208 2025-08-24 14:01:29.223455 :C40AA701:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=20352 pso_num=28 pso_serial#=154 2025-08-24 14:01:29.223608 :C40AA702:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=20352 (legacy spawn) 2025-08-24 14:01:29.230199 :C40AA703: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-24 14:01:29.230361 :C40AA70C: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-24 14:01:29.231171 :C40AA70D:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-24 14:01:32.315060 :C40AA808:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-24 14:01:32.307 2025-08-24 14:01:32.315062 :C40AA809:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=21844 pso_num=28 pso_serial#=155 2025-08-24 14:01:32.315195 :C40AA80A:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=21844 (legacy spawn) 2025-08-24 14:01:32.321676 :C40AA80B: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-24 14:01:32.321713 :C40AA80E: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-24 14:01:32.321863 :C40AA811: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-24 14:01:32.322676 :C40AA822:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-24 14:01:32.331365 :C40AA825:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-24 14:01:32.323 2025-08-24 14:01:32.331367 :C40AA826:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=19768 pso_num=28 pso_serial#=156 2025-08-24 14:01:32.331504 :C40AA827:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=19768 (legacy spawn) 2025-08-24 14:01:32.337940 :C40AA828: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-24 14:01:32.338097 :C40AA831: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-24 14:01:32.338878 :C40AA832:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-24 14:02:24.596592 :C40AB902:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-24 14:02:24.583 2025-08-24 14:02:24.596594 :C40AB903:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=21680 pso_num=28 pso_serial#=157 2025-08-24 14:02:24.596726 :C40AB904:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=21680 (legacy spawn) 2025-08-24 14:02:24.603281 :C40AB905: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-24 14:02:24.603454 :C40AB90E: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-24 14:02:24.604281 :C40AB90F:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-24 14:02:24.612866 :C40AB912:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-24 14:02:24.599 2025-08-24 14:02:24.612868 :C40AB913:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=20776 pso_num=28 pso_serial#=158 2025-08-24 14:02:24.613004 :C40AB914:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=20776 (legacy spawn) 2025-08-24 14:02:24.619536 :C40AB915: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-24 14:02:24.619705 :C40AB91E: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-24 14:02:24.620478 :C40AB91F:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-24 14:02:32.326425 :C40ABBA5:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-24 14:02:32.316 2025-08-24 14:02:32.326427 :C40ABBA6:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=19224 pso_num=28 pso_serial#=159 2025-08-24 14:02:32.326578 :C40ABBA7:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=19224 (legacy spawn) 2025-08-24 14:02:32.333556 :C40ABBA8: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-24 14:02:32.333734 :C40ABBAD: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-24 14:02:32.334732 :C40ABBB2:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-24 14:02:41.687490 :C40ABE72:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-24 14:02:41.687 2025-08-24 14:02:41.687492 :C40ABE73:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=16392 pso_num=28 pso_serial#=160 2025-08-24 14:02:41.687641 :C40ABE74:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=16392 (legacy spawn) 2025-08-24 14:02:41.694329 :C40ABE75: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-24 14:02:41.694512 :C40ABE7A: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-24 14:02:41.695367 :C40ABE7F:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-24 14:02:41.704462 :C40ABE82:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-24 14:02:41.703 2025-08-24 14:02:41.704464 :C40ABE83:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=22500 pso_num=28 pso_serial#=161 2025-08-24 14:02:41.704601 :C40ABE84:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=22500 (legacy spawn) 2025-08-24 14:02:41.711235 :C40ABE85: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-24 14:02:41.711405 :C40ABE8E: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-24 14:02:41.712281 :C40ABE8F:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-24 14:03:17.909710 :C40ACB3D:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-24 14:03:17.895 2025-08-24 14:03:17.909712 :C40ACB3E:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=21328 pso_num=28 pso_serial#=162 2025-08-24 14:03:17.909853 :C40ACB3F:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=21328 (legacy spawn) 2025-08-24 14:03:17.916348 :C40ACB40: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-24 14:03:17.916535 :C40ACB45: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-24 14:03:17.917331 :C40ACB4A:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-24 14:03:17.925998 :C40ACB4D:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-24 14:03:17.911 2025-08-24 14:03:17.925999 :C40ACB4E:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=21796 pso_num=28 pso_serial#=163 2025-08-24 14:03:17.926138 :C40ACB4F:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=21796 (legacy spawn) 2025-08-24 14:03:17.932638 :C40ACB50: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-24 14:03:17.932803 :C40ACB59: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-24 14:03:17.933603 :C40ACB5A:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-24 14:03:19.002580 :C40ACB87:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-24 14:03:18.994 2025-08-24 14:03:19.002582 :C40ACB88:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=21952 pso_num=28 pso_serial#=164 2025-08-24 14:03:19.002722 :C40ACB89:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=21952 (legacy spawn) 2025-08-24 14:03:19.009182 :C40ACB8A: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-24 14:03:19.009354 :C40ACB93: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-24 14:03:19.010218 :C40ACB94:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-24 14:03:20.976038 :C40ACC54:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-24 14:03:20.963 2025-08-24 14:03:20.976040 :C40ACC55:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=13804 pso_num=28 pso_serial#=165 2025-08-24 14:03:20.976181 :C40ACC56:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=13804 (legacy spawn) 2025-08-24 14:03:20.982733 :C40ACC57: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-24 14:03:20.982905 :C40ACC5C: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-24 14:03:20.983697 :C40ACC61:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-24 14:03:20.992416 :C40ACC64:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-24 14:03:20.978 2025-08-24 14:03:20.992418 :C40ACC65:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=17496 pso_num=28 pso_serial#=166 2025-08-24 14:03:20.992557 :C40ACC66:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=17496 (legacy spawn) 2025-08-24 14:03:20.999151 :C40ACC67: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-24 14:03:20.999318 :C40ACC70: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-24 14:03:21.000129 :C40ACC71:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-24 14:03:40.419756 :C40AD23E:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-24 14:03:40.410 2025-08-24 14:03:40.419758 :C40AD23F:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=21864 pso_num=28 pso_serial#=167 2025-08-24 14:03:40.419898 :C40AD240:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=21864 (legacy spawn) 2025-08-24 14:03:40.426756 :C40AD24D: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-24 14:03:40.426949 :C40AD256: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-24 14:03:40.427825 :C40AD257:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-24 14:04:08.333184 :C40ADBF7:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-24 14:04:08.330 2025-08-24 14:04:08.333186 :C40ADBF8:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=19096 pso_num=28 pso_serial#=168 2025-08-24 14:04:08.333343 :C40ADBF9:db_trace:kso.c@4093:ksonfy(): [10420:28:0] kso: new process: pid=19096 osp_idx=26 osp_ver=260571 osp_pg=0 (spawn #521391) 2025-08-24 14:04:08.333344 :C40ADBFA:db_trace:kso.c@4099:ksonfy(): [10420:28:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-24 14:04:08.333345 :C40ADBFB:db_trace:kso.c@4103:ksonfy(): [10420:28:0] kso: new process: pso_index=28 reservation=61 time=429950330 2025-08-24 14:04:08.333345 :C40ADBFC:db_trace:kso.c@4109:ksonfy(): [10420:28:0] kso: spawn diagnostics: queue time=0 secs 2025-08-24 14:04:08.333346 :C40ADBFD:db_trace:kso.c@4111:ksonfy(): [10420:28:0] kso: spawn diagnostics: fork time=0 secs 2025-08-24 14:04:08.333346 :C40ADBFE:db_trace:kso.c@4113:ksonfy(): [10420:28:0] kso: spawn diagnostics: exec time=0 secs 2025-08-24 14:04:08.333346 :C40ADBFF:db_trace:kso.c@4115:ksonfy(): [10420:28:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-24 14:04:08.333347 :C40ADC00:db_trace:kso.c@4117:ksonfy(): [10420:28:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-24 14:04:08.333944 :C40ADC01:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-24 14:04:08.333994 :C40ADC07:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] KSL POST RCVD poster=18 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-24 14:04:08.342163 :C40ADC19:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-24 14:04:08.538256 :C40AE05E:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-24 14:04:08.533 2025-08-24 14:04:08.538258 :C40AE05F:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=20048 pso_num=28 pso_serial#=169 2025-08-24 14:04:08.538390 :C40AE060:db_trace:kso.c@4093:ksonfy(): [10420:28:0] kso: new process: pid=20048 osp_idx=26 osp_ver=260572 osp_pg=0 (spawn #521394) 2025-08-24 14:04:08.538391 :C40AE061: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-24 14:04:08.538391 :C40AE062:db_trace:kso.c@4103:ksonfy(): [10420:28:0] kso: new process: pso_index=28 reservation=62 time=429950549 2025-08-24 14:04:08.538392 :C40AE063:db_trace:kso.c@4109:ksonfy(): [10420:28:0] kso: spawn diagnostics: queue time=0 secs 2025-08-24 14:04:08.538393 :C40AE064:db_trace:kso.c@4111:ksonfy(): [10420:28:0] kso: spawn diagnostics: fork time=0 secs 2025-08-24 14:04:08.538393 :C40AE065:db_trace:kso.c@4113:ksonfy(): [10420:28:0] kso: spawn diagnostics: exec time=0 secs 2025-08-24 14:04:08.538393 :C40AE066:db_trace:kso.c@4115:ksonfy(): [10420:28:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-24 14:04:08.538394 :C40AE067:db_trace:kso.c@4117:ksonfy(): [10420:28:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-24 14:04:08.538912 :C40AE071: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 2025-08-24 14:04:12.460539 :C40AE33E:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] KSL POST RCVD poster=59 loc='kkj.h LINE:914 ID:kkjpstnp' id1=0 id2=0 name= type=0 fac#=0 facpost=1 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 28 (osid: 20048, J002)