Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250809100536\orcl_j002_17264_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:35647M/63366M, Ph+PgF:41155M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 28 Windows thread id: 17264, image: ORACLE.EXE (J002) *** 2025-08-09 10:05:36.126 *** SESSION ID:(225.27273) 2025-08-09 10:05:36.126 *** 2025-08-09 10:05:36.126 Process diagnostic dump for ORACLE.EXE (J002), OS id=17264, pid: 28, proc_ser: 179, sid: 225, sess_ser: 27273 ------------------------------------------------------------------------------- current sql: client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 17264 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J002) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=15 seq_num=16 snap_id=1 wait times: snap=0.412209 sec, exc=0.412209 sec, total=0.412209 sec wait times: max=0.500000 sec, heur=7.914293 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=14 seq_num=15 snap_id=1 wait times: snap=0.500003 sec, exc=0.500003 sec, total=0.500003 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=13 seq_num=14 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 2: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=12 seq_num=13 snap_id=1 wait times: snap=0.499991 sec, exc=0.499991 sec, total=0.499991 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=11 seq_num=12 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 4: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=10 seq_num=11 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 5: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=9 seq_num=10 snap_id=1 wait times: snap=0.505098 sec, exc=0.505098 sec, total=0.505098 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 sec of elapsed time 6: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=8 seq_num=9 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.000008 sec of elapsed time 7: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=7 seq_num=8 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.000010 sec of elapsed time 8: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=6 seq_num=7 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.000012 sec of elapsed time 9: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=5 seq_num=6 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.000007 sec of elapsed time Sampled Session History of session 225 serial 27273 --------------------------------------------------- The sampled session history is constructed by sampling the target session every 1 second. The sampling process captures at each sample if the session is in a non-idle wait, an idle wait, or not in a wait. If the session is in a non-idle wait then one interval is shown for all the samples the session was in the same non-idle wait. If the session is in an idle wait or not in a wait for consecutive samples then one interval is shown for all the consecutive samples. Though we display these consecutive samples in a single interval the session may NOT be continuously idle or not in a wait (the sampling process does not know). The history is displayed in reverse chronological order. sample interval: 1 sec, max history 120 sec --------------------------------------------------- [8 samples, 10:05:28 - 10:05:36] idle wait at each sample [session created at: 10:05:28] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-08-09 10:05:36.126 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 28 (osid: 17264, J002) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-08-09 10:02:10.031789 :BD61883F:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=20384 pso_num=28 pso_serial#=156 2025-08-09 10:02:10.031920 :BD618840:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=20384 (legacy spawn) 2025-08-09 10:02:10.038460 :BD618841: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-09 10:02:10.038623 :BD61884A: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-09 10:02:10.039411 :BD61884B:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-09 10:02:26.827868 :BD618D2C:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-09 10:02:26.818 2025-08-09 10:02:26.827870 :BD618D2D:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=21240 pso_num=28 pso_serial#=157 2025-08-09 10:02:26.828015 :BD618D2E:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=21240 (legacy spawn) 2025-08-09 10:02:26.835185 :BD618D2F: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-09 10:02:26.835364 :BD618D37: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-09 10:02:26.836316 :BD618D39:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-09 10:02:33.425121 :BD618F3A:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-09 10:02:33.416 2025-08-09 10:02:33.425123 :BD618F3B:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=12960 pso_num=28 pso_serial#=158 2025-08-09 10:02:33.425263 :BD618F3C:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=12960 (legacy spawn) 2025-08-09 10:02:33.431809 :BD618F3D: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-09 10:02:33.431980 :BD618F42: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-09 10:02:33.432818 :BD618F47:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-09 10:03:19.617496 :BD619DFB:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-09 10:03:19.603 2025-08-09 10:03:19.617498 :BD619DFC:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=20864 pso_num=28 pso_serial#=159 2025-08-09 10:03:19.617635 :BD619DFD:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=20864 (legacy spawn) 2025-08-09 10:03:19.624127 :BD619DFE: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-09 10:03:19.624157 :BD619E01: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-09 10:03:19.624309 :BD619E04: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-09 10:03:19.625113 :BD619E15:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-09 10:03:19.633867 :BD619E18:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-09 10:03:19.619 2025-08-09 10:03:19.633869 :BD619E19:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=14152 pso_num=28 pso_serial#=160 2025-08-09 10:03:19.634004 :BD619E1A:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=14152 (legacy spawn) 2025-08-09 10:03:19.640513 :BD619E1B: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-09 10:03:19.640674 :BD619E24: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-09 10:03:19.641472 :BD619E25:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-09 10:03:22.908164 :BD619F0E:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-09 10:03:22.894 2025-08-09 10:03:22.908166 :BD619F0F:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=19484 pso_num=28 pso_serial#=161 2025-08-09 10:03:22.908298 :BD619F10:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=19484 (legacy spawn) 2025-08-09 10:03:22.914723 :BD619F11: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-09 10:03:22.914899 :BD619F16: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-09 10:03:22.915684 :BD619F1B:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-09 10:03:22.924408 :BD619F1E:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-09 10:03:22.910 2025-08-09 10:03:22.924410 :BD619F1F:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=19492 pso_num=28 pso_serial#=162 2025-08-09 10:03:22.924548 :BD619F20:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=19492 (legacy spawn) 2025-08-09 10:03:22.931141 :BD619F2D: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-09 10:03:22.931304 :BD619F36: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-09 10:03:22.932117 :BD619F37:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-09 10:03:34.943724 :BD61A2CD:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-09 10:03:34.934 2025-08-09 10:03:34.943727 :BD61A2CE:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=20932 pso_num=28 pso_serial#=163 2025-08-09 10:03:34.943882 :BD61A2CF:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=20932 (legacy spawn) 2025-08-09 10:03:34.950355 :BD61A2D0: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-09 10:03:34.950543 :BD61A2D5: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-09 10:03:34.951346 :BD61A2DA:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-09 10:03:35.630576 :BD61A325:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-09 10:03:35.622 2025-08-09 10:03:35.630578 :BD61A326:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=19316 pso_num=28 pso_serial#=164 2025-08-09 10:03:35.630717 :BD61A327:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=19316 (legacy spawn) 2025-08-09 10:03:35.637156 :BD61A328: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-09 10:03:35.637193 :BD61A32B: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-09 10:03:35.637346 :BD61A332: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-09 10:03:35.638164 :BD61A33F:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-09 10:04:06.703175 :BD61AD12:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-09 10:04:06.695 2025-08-09 10:04:06.703178 :BD61AD13:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=10320 pso_num=28 pso_serial#=165 2025-08-09 10:04:06.703350 :BD61AD14:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=10320 (legacy spawn) 2025-08-09 10:04:06.709758 :BD61AD15: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-09 10:04:06.709932 :BD61AD1E: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-09 10:04:06.710792 :BD61AD1F:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-09 10:04:10.279234 :BD61AE5D:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-09 10:04:10.267 2025-08-09 10:04:10.279236 :BD61AE5E:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=4152 pso_num=28 pso_serial#=166 2025-08-09 10:04:10.279371 :BD61AE5F:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=4152 (legacy spawn) 2025-08-09 10:04:10.285906 :BD61AE60: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-09 10:04:10.286099 :BD61AE65: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-09 10:04:10.286893 :BD61AE6A:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-09 10:04:32.285152 :BD61B4ED:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-09 10:04:32.271 2025-08-09 10:04:32.285154 :BD61B4EE:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=20524 pso_num=28 pso_serial#=167 2025-08-09 10:04:32.285291 :BD61B4EF:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=20524 (legacy spawn) 2025-08-09 10:04:32.291733 :BD61B4F0: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-09 10:04:32.291898 :BD61B4F5: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-09 10:04:32.292702 :BD61B4FA:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-09 10:04:32.301442 :BD61B4FD:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-09 10:04:32.286 2025-08-09 10:04:32.301444 :BD61B4FE:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=19564 pso_num=28 pso_serial#=168 2025-08-09 10:04:32.301580 :BD61B4FF:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=19564 (legacy spawn) 2025-08-09 10:04:32.308042 :BD61B500: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-09 10:04:32.308205 :BD61B509: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-09 10:04:32.308995 :BD61B50A:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-09 10:04:35.497114 :BD61B602:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-09 10:04:35.484 2025-08-09 10:04:35.497116 :BD61B603:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=10824 pso_num=28 pso_serial#=169 2025-08-09 10:04:35.497258 :BD61B604:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=10824 (legacy spawn) 2025-08-09 10:04:35.503733 :BD61B605: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-09 10:04:35.503905 :BD61B60E: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-09 10:04:35.515953 :BD61B60F:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-09 10:04:35.524893 :BD61B612:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-09 10:04:35.515 2025-08-09 10:04:35.524895 :BD61B613:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=20252 pso_num=28 pso_serial#=170 2025-08-09 10:04:35.525032 :BD61B614:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=20252 (legacy spawn) 2025-08-09 10:04:35.531962 :BD61B615: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-09 10:04:35.532144 :BD61B61E: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-09 10:04:35.533027 :BD61B61F:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-09 10:05:08.590522 :BD61C4DC:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-09 10:05:08.587 2025-08-09 10:05:08.590524 :BD61C4DD:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=17416 pso_num=28 pso_serial#=171 2025-08-09 10:05:08.590678 :BD61C4DE:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=17416 (legacy spawn) 2025-08-09 10:05:08.597425 :BD61C4DF: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-09 10:05:08.597628 :BD61C4E8: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-09 10:05:08.598494 :BD61C4E9:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-09 10:05:08.607783 :BD61C4EC:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-09 10:05:08.602 2025-08-09 10:05:08.607785 :BD61C4ED:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=18400 pso_num=28 pso_serial#=172 2025-08-09 10:05:08.607926 :BD61C4EE:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=18400 (legacy spawn) 2025-08-09 10:05:08.614993 :BD61C4EF: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-09 10:05:08.615167 :BD61C4F8: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-09 10:05:08.616080 :BD61C4F9:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-09 10:05:08.875901 :BD61C4FD:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-09 10:05:08.868 2025-08-09 10:05:08.875903 :BD61C4FE:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=14304 pso_num=28 pso_serial#=173 2025-08-09 10:05:08.876037 :BD61C4FF:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=14304 (legacy spawn) 2025-08-09 10:05:08.882501 :BD61C500: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-09 10:05:08.882672 :BD61C509: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-09 10:05:08.883477 :BD61C50A:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-09 10:05:11.896283 :BD61C88F:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-09 10:05:11.888 2025-08-09 10:05:11.896285 :BD61C890:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=13808 pso_num=28 pso_serial#=174 2025-08-09 10:05:11.896417 :BD61C891:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=13808 (legacy spawn) 2025-08-09 10:05:11.902920 :BD61C892: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-09 10:05:11.903101 :BD61C89B: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-09 10:05:11.903909 :BD61C89C:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-09 10:05:11.912671 :BD61C89F:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-09 10:05:11.904 2025-08-09 10:05:11.912672 :BD61C8A0:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=20168 pso_num=28 pso_serial#=175 2025-08-09 10:05:11.912810 :BD61C8A1:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=20168 (legacy spawn) 2025-08-09 10:05:11.919326 :BD61C8A2: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-09 10:05:11.919514 :BD61C8AB: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-09 10:05:11.920329 :BD61C8AC:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-09 10:05:18.224693 :BD61CA83:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-09 10:05:18.215 2025-08-09 10:05:18.224695 :BD61CA84:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=16340 pso_num=28 pso_serial#=176 2025-08-09 10:05:18.224831 :BD61CA85:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=16340 (legacy spawn) 2025-08-09 10:05:18.231406 :BD61CA86: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-09 10:05:18.231582 :BD61CA8E: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-09 10:05:18.232398 :BD61CA8F:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-09 10:05:19.007150 :BD61CAF2:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-09 10:05:19.002 2025-08-09 10:05:19.007152 :BD61CAF3:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=19144 pso_num=28 pso_serial#=177 2025-08-09 10:05:19.007296 :BD61CAF4:db_trace:kso.c@4093:ksonfy(): [10420:28:0] kso: new process: pid=19144 osp_idx=26 osp_ver=210090 osp_pg=0 (spawn #470837) 2025-08-09 10:05:19.007297 :BD61CAF5: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-09 10:05:19.007297 :BD61CAF6:db_trace:kso.c@4103:ksonfy(): [10420:28:0] kso: new process: pso_index=28 reservation=109 time=3414588314 2025-08-09 10:05:19.007298 :BD61CAF7:db_trace:kso.c@4109:ksonfy(): [10420:28:0] kso: spawn diagnostics: queue time=0 secs 2025-08-09 10:05:19.007298 :BD61CAF8:db_trace:kso.c@4111:ksonfy(): [10420:28:0] kso: spawn diagnostics: fork time=0 secs 2025-08-09 10:05:19.007298 :BD61CAF9:db_trace:kso.c@4113:ksonfy(): [10420:28:0] kso: spawn diagnostics: exec time=0 secs 2025-08-09 10:05:19.007299 :BD61CAFA:db_trace:kso.c@4115:ksonfy(): [10420:28:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-09 10:05:19.007299 :BD61CAFB:db_trace:kso.c@4117:ksonfy(): [10420:28:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-09 10:05:19.007801 :BD61CAFC: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-09 10:05:19.007843 :BD61CB02: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-09 10:05:19.027737 :BD61CB13:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-09 10:05:28.019535 :BD61CDDA:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-09 10:05:28.014 2025-08-09 10:05:28.019537 :BD61CDDB:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=20372 pso_num=28 pso_serial#=178 2025-08-09 10:05:28.019676 :BD61CDDC:db_trace:kso.c@4093:ksonfy(): [10420:28:0] kso: new process: pid=20372 osp_idx=26 osp_ver=210091 osp_pg=0 (spawn #470838) 2025-08-09 10:05:28.019677 :BD61CDDD: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-09 10:05:28.019677 :BD61CDDE:db_trace:kso.c@4103:ksonfy(): [10420:28:0] kso: new process: pso_index=28 reservation=110 time=3414597329 2025-08-09 10:05:28.019678 :BD61CDDF:db_trace:kso.c@4109:ksonfy(): [10420:28:0] kso: spawn diagnostics: queue time=0 secs 2025-08-09 10:05:28.019678 :BD61CDE0:db_trace:kso.c@4111:ksonfy(): [10420:28:0] kso: spawn diagnostics: fork time=0 secs 2025-08-09 10:05:28.019678 :BD61CDE1:db_trace:kso.c@4113:ksonfy(): [10420:28:0] kso: spawn diagnostics: exec time=0 secs 2025-08-09 10:05:28.019678 :BD61CDE2:db_trace:kso.c@4115:ksonfy(): [10420:28:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-09 10:05:28.019678 :BD61CDE3:db_trace:kso.c@4117:ksonfy(): [10420:28:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-09 10:05:28.020205 :BD61CDE4: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-09 10:05:28.020249 :BD61CDEA: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-09 10:05:28.024566 :BD61CDFC:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:kelt.c:517 2025-08-09 10:05:28.024626 :BD61CDFD:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:kelt.c:517 2025-08-09 10:05:28.024891 :BD61CDFE:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:kelt.c:517 2025-08-09 10:05:28.024908 :BD61CDFF:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:kelt.c:517 2025-08-09 10:05:28.025123 :BD61CE00:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:kelt.c:517 2025-08-09 10:05:28.025136 :BD61CE01:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:kelt.c:517 2025-08-09 10:05:28.025343 :BD61CE02:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:kelt.c:517 2025-08-09 10:05:28.025355 :BD61CE03:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:kelt.c:517 2025-08-09 10:05:28.025563 :BD61CE04:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:kelt.c:517 2025-08-09 10:05:28.025576 :BD61CE05:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:kelt.c:517 2025-08-09 10:05:28.025777 :BD61CE06:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:kelt.c:517 2025-08-09 10:05:28.025789 :BD61CE07:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:kelt.c:517 2025-08-09 10:05:28.028512 :BD61CE35:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-09 10:05:28.222712 :BD61D276:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-09 10:05:28.217 2025-08-09 10:05:28.222714 :BD61D277:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=17264 pso_num=28 pso_serial#=179 2025-08-09 10:05:28.222852 :BD61D278:db_trace:kso.c@4093:ksonfy(): [10420:28:0] kso: new process: pid=17264 osp_idx=26 osp_ver=210092 osp_pg=0 (spawn #470840) 2025-08-09 10:05:28.222852 :BD61D279: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-09 10:05:28.222853 :BD61D27A:db_trace:kso.c@4103:ksonfy(): [10420:28:0] kso: new process: pso_index=28 reservation=111 time=3414597533 2025-08-09 10:05:28.222853 :BD61D27B:db_trace:kso.c@4109:ksonfy(): [10420:28:0] kso: spawn diagnostics: queue time=0 secs 2025-08-09 10:05:28.222853 :BD61D27C:db_trace:kso.c@4111:ksonfy(): [10420:28:0] kso: spawn diagnostics: fork time=0 secs 2025-08-09 10:05:28.222854 :BD61D27D:db_trace:kso.c@4113:ksonfy(): [10420:28:0] kso: spawn diagnostics: exec time=0 secs 2025-08-09 10:05:28.222854 :BD61D27E:db_trace:kso.c@4115:ksonfy(): [10420:28:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-09 10:05:28.222855 :BD61D27F:db_trace:kso.c@4117:ksonfy(): [10420:28:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-09 10:05:28.223358 :BD61D289: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: 17264, J002)