Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250809180635\orcl_j002_13960_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:35635M/63366M, Ph+PgF:41134M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 28 Windows thread id: 13960, image: ORACLE.EXE (J002) *** 2025-08-09 18:06:35.291 *** SESSION ID:(225.32959) 2025-08-09 18:06:35.291 *** 2025-08-09 18:06:35.291 Process diagnostic dump for ORACLE.EXE (J002), OS id=13960, pid: 28, proc_ser: 217, sid: 225, sess_ser: 32959 ------------------------------------------------------------------------------- current sql: client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 13960 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.214334 sec, exc=0.214334 sec, total=0.214334 sec wait times: max=0.500000 sec, heur=7.711529 sec wait counts: calls=1 os=1 in_wait=1 iflags=0x5a8 Wait State: fixed_waits=0 flags=0x22 boundary=0x0000000000000000/-1 Session Wait History: elapsed time of 0.000010 sec since current wait 0: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=14 seq_num=15 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 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=13 seq_num=14 snap_id=1 wait times: snap=0.499994 sec, exc=0.499994 sec, total=0.499994 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=12 seq_num=13 snap_id=1 wait times: snap=0.499993 sec, exc=0.499993 sec, total=0.499993 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000012 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.499997 sec, exc=0.499997 sec, total=0.499997 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 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.502095 sec, exc=0.502095 sec, total=0.502095 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 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.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.000013 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.000009 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.499994 sec, exc=0.499994 sec, total=0.499994 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=6 seq_num=7 snap_id=1 wait times: snap=0.499992 sec, exc=0.499992 sec, total=0.499992 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000013 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.501085 sec, exc=0.501085 sec, total=0.501085 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time Sampled Session History of session 225 serial 32959 --------------------------------------------------- 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, 18:06:27 - 18:06:35] idle wait at each sample [session created at: 18:06:27] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-08-09 18:06:35.291 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 28 (osid: 13960, J002) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-08-09 18:02:00.333902 :BD866824:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=19404 (legacy spawn) 2025-08-09 18:02:00.340426 :BD866825: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 18:02:00.340593 :BD86682E: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 18:02:00.341387 :BD86682F:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-09 18:02:03.408614 :BD86691F:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-09 18:02:03.395 2025-08-09 18:02:03.408616 :BD866920:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=20564 pso_num=28 pso_serial#=190 2025-08-09 18:02:03.408753 :BD866921:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=20564 (legacy spawn) 2025-08-09 18:02:03.415250 :BD866922: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 18:02:03.415426 :BD866927: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 18:02:03.416259 :BD86692C:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-09 18:02:03.424851 :BD86692F:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-09 18:02:03.411 2025-08-09 18:02:03.424853 :BD866930:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=18716 pso_num=28 pso_serial#=191 2025-08-09 18:02:03.424991 :BD866931:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=18716 (legacy spawn) 2025-08-09 18:02:03.443961 :BD866932: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 18:02:03.444126 :BD86693B: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 18:02:03.444970 :BD86693C:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-09 18:02:17.163534 :BD866D44:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-09 18:02:17.154 2025-08-09 18:02:17.163536 :BD866D45:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=12636 pso_num=28 pso_serial#=192 2025-08-09 18:02:17.163676 :BD866D46:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=12636 (legacy spawn) 2025-08-09 18:02:17.170078 :BD866D47: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 18:02:17.170250 :BD866D50: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 18:02:17.171071 :BD866D51:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-09 18:02:51.348527 :BD867971:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-09 18:02:51.340 2025-08-09 18:02:51.348529 :BD867972:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=20388 pso_num=28 pso_serial#=193 2025-08-09 18:02:51.348666 :BD867973:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=20388 (legacy spawn) 2025-08-09 18:02:51.355180 :BD867974: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 18:02:51.355356 :BD867979: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 18:02:51.356159 :BD86797E:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-09 18:02:56.122960 :BD867AFB:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-09 18:02:56.114 2025-08-09 18:02:56.122962 :BD867AFC:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=21172 pso_num=28 pso_serial#=194 2025-08-09 18:02:56.123099 :BD867AFD:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=21172 (legacy spawn) 2025-08-09 18:02:56.129526 :BD867AFE: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 18:02:56.129700 :BD867B07: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 18:02:56.130496 :BD867B08:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-09 18:03:12.897399 :BD868028:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-09 18:03:12.882 2025-08-09 18:03:12.897401 :BD868029:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=14932 pso_num=28 pso_serial#=195 2025-08-09 18:03:12.897535 :BD86802A:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=14932 (legacy spawn) 2025-08-09 18:03:12.904042 :BD86802B: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 18:03:12.904209 :BD868030: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 18:03:12.905013 :BD868035:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-09 18:03:12.913739 :BD868038:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-09 18:03:12.898 2025-08-09 18:03:12.913741 :BD868039:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=14304 pso_num=28 pso_serial#=196 2025-08-09 18:03:12.913887 :BD86803A:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=14304 (legacy spawn) 2025-08-09 18:03:12.920385 :BD86803B: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 18:03:12.920562 :BD868043: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 18:03:12.921366 :BD868045:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-09 18:03:16.171953 :BD86812A:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-09 18:03:16.158 2025-08-09 18:03:16.171955 :BD86812B:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=20504 pso_num=28 pso_serial#=197 2025-08-09 18:03:16.172110 :BD86812C:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=20504 (legacy spawn) 2025-08-09 18:03:16.191573 :BD86812D: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 18:03:16.191742 :BD868132: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 18:03:16.192596 :BD868137:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-09 18:03:16.201322 :BD86813A:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-09 18:03:16.189 2025-08-09 18:03:16.201323 :BD86813B:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=19676 pso_num=28 pso_serial#=198 2025-08-09 18:03:16.201468 :BD86813C:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=19676 (legacy spawn) 2025-08-09 18:03:16.208052 :BD86813D: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 18:03:16.208214 :BD868146: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 18:03:16.209034 :BD868147:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-09 18:03:49.497116 :BD868BC2:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-09 18:03:49.489 2025-08-09 18:03:49.497118 :BD868BC3:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=16664 pso_num=28 pso_serial#=199 2025-08-09 18:03:49.497265 :BD868BC4:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=16664 (legacy spawn) 2025-08-09 18:03:49.503753 :BD868BC5: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 18:03:49.503924 :BD868BCA: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 18:03:49.504752 :BD868BCF:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-09 18:03:49.513499 :BD868BD2:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-09 18:03:49.504 2025-08-09 18:03:49.513501 :BD868BD3:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=9604 pso_num=28 pso_serial#=200 2025-08-09 18:03:49.513647 :BD868BD4:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=9604 (legacy spawn) 2025-08-09 18:03:49.520209 :BD868BD5: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 18:03:49.520380 :BD868BDD: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 18:03:49.521211 :BD868BDF:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-09 18:03:52.585045 :BD868CC7:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-09 18:03:52.571 2025-08-09 18:03:52.585047 :BD868CC8:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=19392 pso_num=28 pso_serial#=201 2025-08-09 18:03:52.585181 :BD868CC9:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=19392 (legacy spawn) 2025-08-09 18:03:52.591707 :BD868CCA: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 18:03:52.591881 :BD868CCF: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 18:03:52.592676 :BD868CD4:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-09 18:03:52.610655 :BD868CD7:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-09 18:03:52.603 2025-08-09 18:03:52.610657 :BD868CD8:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=18760 pso_num=28 pso_serial#=202 2025-08-09 18:03:52.610804 :BD868CD9:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=18760 (legacy spawn) 2025-08-09 18:03:52.617375 :BD868CDA: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 18:03:52.617544 :BD868CE3: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 18:03:52.618378 :BD868CE4:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-09 18:03:58.329737 :BD868EC2:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-09 18:03:58.321 2025-08-09 18:03:58.329738 :BD868EC3:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=17932 pso_num=28 pso_serial#=203 2025-08-09 18:03:58.329875 :BD868EC4:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=17932 (legacy spawn) 2025-08-09 18:03:58.336336 :BD868EC5: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 18:03:58.336532 :BD868ECA: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 18:03:58.337429 :BD868ECF:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-09 18:03:59.486743 :BD868F1C:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-09 18:03:59.478 2025-08-09 18:03:59.486745 :BD868F1D:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=14620 pso_num=28 pso_serial#=204 2025-08-09 18:03:59.486875 :BD868F1E:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=14620 (legacy spawn) 2025-08-09 18:03:59.493340 :BD868F1F: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 18:03:59.493509 :BD868F24: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 18:03:59.494352 :BD868F29:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-09 18:04:17.153449 :BD869487:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-09 18:04:17.140 2025-08-09 18:04:17.153451 :BD869488:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=7996 pso_num=28 pso_serial#=205 2025-08-09 18:04:17.153585 :BD869489:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=7996 (legacy spawn) 2025-08-09 18:04:17.160115 :BD86948A: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 18:04:17.160294 :BD869493: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 18:04:17.161100 :BD869494:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-09 18:04:17.180121 :BD869497:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-09 18:04:17.171 2025-08-09 18:04:17.180123 :BD869498:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=7532 pso_num=28 pso_serial#=206 2025-08-09 18:04:17.180262 :BD869499:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=7532 (legacy spawn) 2025-08-09 18:04:17.186658 :BD86949A: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 18:04:17.186843 :BD8694A3: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 18:04:17.187653 :BD8694A4:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-09 18:05:00.469857 :BD86A2C7:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-09 18:05:00.462 2025-08-09 18:05:00.469859 :BD86A2C8:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=20580 pso_num=28 pso_serial#=207 2025-08-09 18:05:00.469996 :BD86A2C9:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=20580 (legacy spawn) 2025-08-09 18:05:00.476475 :BD86A2CA: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 18:05:00.476645 :BD86A2D3: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 18:05:00.477447 :BD86A2D4:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-09 18:05:02.305019 :BD86A361:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-09 18:05:02.290 2025-08-09 18:05:02.305021 :BD86A362:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=20796 pso_num=28 pso_serial#=208 2025-08-09 18:05:02.305159 :BD86A363:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=20796 (legacy spawn) 2025-08-09 18:05:02.311660 :BD86A364: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 18:05:02.311829 :BD86A36C: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 18:05:02.312594 :BD86A36E:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-09 18:05:02.321467 :BD86A371:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-09 18:05:02.321 2025-08-09 18:05:02.321469 :BD86A372:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=19912 pso_num=28 pso_serial#=209 2025-08-09 18:05:02.321610 :BD86A373:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=19912 (legacy spawn) 2025-08-09 18:05:02.328081 :BD86A374: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 18:05:02.328271 :BD86A37B: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 18:05:02.329077 :BD86A37E:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-09 18:05:05.516847 :BD86A475:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-09 18:05:05.503 2025-08-09 18:05:05.516849 :BD86A476:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=19984 pso_num=28 pso_serial#=210 2025-08-09 18:05:05.516989 :BD86A477:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=19984 (legacy spawn) 2025-08-09 18:05:05.523806 :BD86A478: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 18:05:05.523977 :BD86A481: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 18:05:05.524830 :BD86A482:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-09 18:05:05.533721 :BD86A485:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-09 18:05:05.519 2025-08-09 18:05:05.533724 :BD86A486:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=20780 pso_num=28 pso_serial#=211 2025-08-09 18:05:05.533861 :BD86A487:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=20780 (legacy spawn) 2025-08-09 18:05:05.540528 :BD86A488: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 18:05:05.540686 :BD86A48D: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 18:05:05.541515 :BD86A492:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-09 18:05:08.789989 :BD86A6E1:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-09 18:05:08.780 2025-08-09 18:05:08.789991 :BD86A6E2:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=15644 pso_num=28 pso_serial#=212 2025-08-09 18:05:08.790127 :BD86A6E3:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=15644 (legacy spawn) 2025-08-09 18:05:08.796683 :BD86A6E4: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 18:05:08.796864 :BD86A6E9: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 18:05:08.797694 :BD86A6EE:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-09 18:06:02.610728 :BD86BDDF:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-09 18:06:02.603 2025-08-09 18:06:02.610730 :BD86BDE0:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=18604 pso_num=28 pso_serial#=213 2025-08-09 18:06:02.610876 :BD86BDE1:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=18604 (legacy spawn) 2025-08-09 18:06:02.617310 :BD86BDE2: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 18:06:02.617480 :BD86BDEB: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 18:06:02.618311 :BD86BDEC:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-09 18:06:15.281910 :BD86C1E9:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-09 18:06:15.268 2025-08-09 18:06:15.281912 :BD86C1EA:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=21128 pso_num=28 pso_serial#=214 2025-08-09 18:06:15.282053 :BD86C1EB:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=21128 (legacy spawn) 2025-08-09 18:06:15.288507 :BD86C1EC: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 18:06:15.288699 :BD86C1F1: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 18:06:15.289547 :BD86C1F6:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-09 18:06:15.305924 :BD86C1F9:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-09 18:06:15.299 2025-08-09 18:06:15.305926 :BD86C1FA:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=21052 pso_num=28 pso_serial#=215 2025-08-09 18:06:15.306065 :BD86C1FB:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=21052 (legacy spawn) 2025-08-09 18:06:15.312642 :BD86C1FC: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 18:06:15.312805 :BD86C205: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 18:06:15.313601 :BD86C206:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-09 18:06:17.026630 :BD86C277:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-09 18:06:17.018 2025-08-09 18:06:17.026633 :BD86C278:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=19156 pso_num=28 pso_serial#=216 2025-08-09 18:06:17.026773 :BD86C279:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=19156 (legacy spawn) 2025-08-09 18:06:17.033559 :BD86C27A: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 18:06:17.033730 :BD86C27F: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 18:06:17.034615 :BD86C284:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-09 18:06:27.590213 :BD86CA90:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-09 18:06:27.584 2025-08-09 18:06:27.590215 :BD86CA91:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=13960 pso_num=28 pso_serial#=217 2025-08-09 18:06:27.590358 :BD86CA92:db_trace:kso.c@4093:ksonfy(): [10420:28:0] kso: new process: pid=13960 osp_idx=26 osp_ver=212935 osp_pg=0 (spawn #471955) 2025-08-09 18:06:27.590359 :BD86CA93: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 18:06:27.590360 :BD86CA94:db_trace:kso.c@4103:ksonfy(): [10420:28:0] kso: new process: pso_index=28 reservation=177 time=3443456892 2025-08-09 18:06:27.590360 :BD86CA95:db_trace:kso.c@4109:ksonfy(): [10420:28:0] kso: spawn diagnostics: queue time=0 secs 2025-08-09 18:06:27.590361 :BD86CA96:db_trace:kso.c@4111:ksonfy(): [10420:28:0] kso: spawn diagnostics: fork time=0 secs 2025-08-09 18:06:27.590361 :BD86CA97:db_trace:kso.c@4113:ksonfy(): [10420:28:0] kso: spawn diagnostics: exec time=0 secs 2025-08-09 18:06:27.590361 :BD86CA98:db_trace:kso.c@4115:ksonfy(): [10420:28:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-09 18:06:27.590362 :BD86CA99:db_trace:kso.c@4117:ksonfy(): [10420:28:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-09 18:06:27.590860 :BD86CA9A: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: 13960, J002)