Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250810180926\orcl_j002_20516_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:35594M/63366M, Ph+PgF:41062M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 28 Windows thread id: 20516, image: ORACLE.EXE (J002) *** 2025-08-10 18:09:26.276 *** SESSION ID:(225.46983) 2025-08-10 18:09:26.276 *** 2025-08-10 18:09:26.276 Process diagnostic dump for ORACLE.EXE (J002), OS id=20516, pid: 28, proc_ser: 86, sid: 225, sess_ser: 46983 ------------------------------------------------------------------------------- current sql: client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 20516 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J002) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=8 seq_num=9 snap_id=1 wait times: snap=0.222640 sec, exc=0.222640 sec, total=0.222640 sec wait times: max=0.500000 sec, heur=4.226590 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.000014 sec since current wait 0: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=7 seq_num=8 snap_id=1 wait times: snap=0.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.000007 sec of elapsed time 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=6 seq_num=7 snap_id=1 wait times: snap=0.500014 sec, exc=0.500014 sec, total=0.500014 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000007 sec of elapsed time 2: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=5 seq_num=6 snap_id=1 wait times: snap=0.499989 sec, exc=0.499989 sec, total=0.499989 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=4 seq_num=5 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 4: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=3 seq_num=4 snap_id=1 wait times: snap=0.510108 sec, exc=0.510108 sec, total=0.510108 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000006 sec of elapsed time 5: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=2 seq_num=3 snap_id=1 wait times: snap=0.500001 sec, exc=0.500001 sec, total=0.500001 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 6: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=1 seq_num=2 snap_id=1 wait times: snap=0.499976 sec, exc=0.499976 sec, total=0.499976 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 7: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=0 seq_num=1 snap_id=1 wait times: snap=0.493801 sec, exc=0.493801 sec, total=0.493801 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 46983 --------------------------------------------------- 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, 18:09:22 - 18:09:26] idle wait at each sample [session created at: 18:09:22] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-08-10 18:09:26.276 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 28 (osid: 20516, J002) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-08-10 18:06:02.308694 :BDF5E697: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-10 18:06:02.309505 :BDF5E69C:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-10 18:06:02.318262 :BDF5E69F:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-10 18:06:02.313 2025-08-10 18:06:02.318264 :BDF5E6A0:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=21092 pso_num=28 pso_serial#=60 2025-08-10 18:06:02.318398 :BDF5E6A1:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=21092 (legacy spawn) 2025-08-10 18:06:02.324910 :BDF5E6A2: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-10 18:06:02.324939 :BDF5E6A5: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-10 18:06:02.325085 :BDF5E6AC: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-10 18:06:02.325934 :BDF5E6B9:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-10 18:06:05.492884 :BDF5E7E5:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-10 18:06:05.479 2025-08-10 18:06:05.492887 :BDF5E7E6:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=16632 pso_num=28 pso_serial#=61 2025-08-10 18:06:05.493021 :BDF5E7E7:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=16632 (legacy spawn) 2025-08-10 18:06:05.499606 :BDF5E7E8: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-10 18:06:05.499802 :BDF5E7ED: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-10 18:06:05.500613 :BDF5E7F2:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-10 18:06:05.519196 :BDF5E7F5:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-10 18:06:05.511 2025-08-10 18:06:05.519199 :BDF5E7F6:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=21048 pso_num=28 pso_serial#=62 2025-08-10 18:06:05.519335 :BDF5E7F7:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=21048 (legacy spawn) 2025-08-10 18:06:05.525933 :BDF5E7F8: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-10 18:06:05.526103 :BDF5E801: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-10 18:06:05.526952 :BDF5E802:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-10 18:06:14.025844 :BDF5EA92:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-10 18:06:14.017 2025-08-10 18:06:14.025846 :BDF5EA93:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=19176 pso_num=28 pso_serial#=63 2025-08-10 18:06:14.025980 :BDF5EA94:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=19176 (legacy spawn) 2025-08-10 18:06:14.032403 :BDF5EA95: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-10 18:06:14.032584 :BDF5EA9A: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-10 18:06:14.033645 :BDF5EA9F:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-10 18:06:14.824023 :BDF5EB06:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-10 18:06:14.814 2025-08-10 18:06:14.824025 :BDF5EB07:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=13548 pso_num=28 pso_serial#=64 2025-08-10 18:06:14.824164 :BDF5EB08:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=13548 (legacy spawn) 2025-08-10 18:06:14.831041 :BDF5EB09: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-10 18:06:14.831221 :BDF5EB0E: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-10 18:06:14.832093 :BDF5EB13:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-10 18:07:05.885632 :BDF5FCDE:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-10 18:07:05.871 2025-08-10 18:07:05.885635 :BDF5FCDF:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=10356 pso_num=28 pso_serial#=65 2025-08-10 18:07:05.885786 :BDF5FCE0:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=10356 (legacy spawn) 2025-08-10 18:07:05.892880 :BDF5FCE1: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-10 18:07:05.893082 :BDF5FCE6: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-10 18:07:05.894036 :BDF5FCEB:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-10 18:07:05.903385 :BDF5FCEE:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-10 18:07:05.902 2025-08-10 18:07:05.903388 :BDF5FCEF:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=20148 pso_num=28 pso_serial#=66 2025-08-10 18:07:05.903530 :BDF5FCF0:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=20148 (legacy spawn) 2025-08-10 18:07:05.910366 :BDF5FCF1: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-10 18:07:05.910543 :BDF5FCF9: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-10 18:07:05.911465 :BDF5FCFB:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-10 18:07:15.001022 :BDF5FFAF:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-10 18:07:14.990 2025-08-10 18:07:15.001024 :BDF5FFB0:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=19692 pso_num=28 pso_serial#=67 2025-08-10 18:07:15.001163 :BDF5FFB1:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=19692 (legacy spawn) 2025-08-10 18:07:15.007756 :BDF5FFB2: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-10 18:07:15.007936 :BDF5FFB7: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-10 18:07:15.008762 :BDF5FFBC:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-10 18:07:15.017501 :BDF5FFBF:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-10 18:07:15.005 2025-08-10 18:07:15.017504 :BDF5FFC0:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=21156 pso_num=28 pso_serial#=68 2025-08-10 18:07:15.017636 :BDF5FFC1:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=21156 (legacy spawn) 2025-08-10 18:07:15.024152 :BDF5FFC2: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-10 18:07:15.024182 :BDF5FFC5: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-10 18:07:15.024344 :BDF5FFCB: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-10 18:07:15.025197 :BDF5FFD9:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-10 18:07:16.180533 :BDF6002B:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-10 18:07:16.172 2025-08-10 18:07:16.180536 :BDF6002C:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=20512 pso_num=28 pso_serial#=69 2025-08-10 18:07:16.180684 :BDF6002D:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=20512 (legacy spawn) 2025-08-10 18:07:16.187062 :BDF6002E: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-10 18:07:16.187238 :BDF60036: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-10 18:07:16.188070 :BDF60038:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-10 18:07:18.289417 :BDF600DB:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-10 18:07:18.275 2025-08-10 18:07:18.289419 :BDF600DC:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=19316 pso_num=28 pso_serial#=70 2025-08-10 18:07:18.289556 :BDF600DD:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=19316 (legacy spawn) 2025-08-10 18:07:18.296039 :BDF600DE: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-10 18:07:18.296210 :BDF600E3: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-10 18:07:18.297019 :BDF600E8:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-10 18:07:18.305745 :BDF600EB:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-10 18:07:18.291 2025-08-10 18:07:18.305747 :BDF600EC:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=20736 pso_num=28 pso_serial#=71 2025-08-10 18:07:18.305887 :BDF600ED:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=20736 (legacy spawn) 2025-08-10 18:07:18.312471 :BDF600EE: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-10 18:07:18.312653 :BDF600F7: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-10 18:07:18.313516 :BDF600F8:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-10 18:07:51.580917 :BDF60B92:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-10 18:07:51.581 2025-08-10 18:07:51.580919 :BDF60B93:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=18956 pso_num=28 pso_serial#=72 2025-08-10 18:07:51.581084 :BDF60B94:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=18956 (legacy spawn) 2025-08-10 18:07:51.588265 :BDF60B95: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-10 18:07:51.588455 :BDF60B9D: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-10 18:07:51.589441 :BDF60B9E:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-10 18:07:51.606177 :BDF60BA1:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-10 18:07:51.597 2025-08-10 18:07:51.606180 :BDF60BA2:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=19508 pso_num=28 pso_serial#=73 2025-08-10 18:07:51.606329 :BDF60BA3:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=19508 (legacy spawn) 2025-08-10 18:07:51.613435 :BDF60BA4: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-10 18:07:51.613620 :BDF60BAC: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-10 18:07:51.614532 :BDF60BAD:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-10 18:07:54.698324 :BDF60CBA:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-10 18:07:54.685 2025-08-10 18:07:54.698326 :BDF60CBB:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=21284 pso_num=28 pso_serial#=74 2025-08-10 18:07:54.698462 :BDF60CBC:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=21284 (legacy spawn) 2025-08-10 18:07:54.705148 :BDF60CBD: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-10 18:07:54.705329 :BDF60CC2: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-10 18:07:54.706181 :BDF60CC7:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-10 18:07:54.715154 :BDF60CCA:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-10 18:07:54.701 2025-08-10 18:07:54.715157 :BDF60CCB:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=20876 pso_num=28 pso_serial#=75 2025-08-10 18:07:54.715292 :BDF60CCC:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=20876 (legacy spawn) 2025-08-10 18:07:54.722163 :BDF60CCD: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-10 18:07:54.722345 :BDF60CD6: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-10 18:07:54.723316 :BDF60CD7:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-10 18:07:57.129743 :BDF60DA8:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-10 18:07:57.120 2025-08-10 18:07:57.129746 :BDF60DA9:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=19660 pso_num=28 pso_serial#=76 2025-08-10 18:07:57.129906 :BDF60DAA:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=19660 (legacy spawn) 2025-08-10 18:07:57.136474 :BDF60DAB: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-10 18:07:57.136669 :BDF60DB0: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-10 18:07:57.137509 :BDF60DB5:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-10 18:08:18.387027 :BDF61410:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-10 18:08:18.379 2025-08-10 18:08:18.387029 :BDF61411:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=20028 pso_num=28 pso_serial#=77 2025-08-10 18:08:18.387167 :BDF61412:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=20028 (legacy spawn) 2025-08-10 18:08:18.393610 :BDF61413: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-10 18:08:18.393791 :BDF61418: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-10 18:08:18.394599 :BDF6141D:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-10 18:09:04.194265 :BDF622EC:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-10 18:09:04.190 2025-08-10 18:09:04.194267 :BDF622ED:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=8984 pso_num=28 pso_serial#=78 2025-08-10 18:09:04.194405 :BDF622EE:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=8984 (legacy spawn) 2025-08-10 18:09:04.200979 :BDF622EF: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-10 18:09:04.201155 :BDF622F8: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-10 18:09:04.202012 :BDF622F9:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-10 18:09:04.210799 :BDF622FC:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-10 18:09:04.206 2025-08-10 18:09:04.210801 :BDF622FD:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=19376 pso_num=28 pso_serial#=79 2025-08-10 18:09:04.210941 :BDF622FE:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=19376 (legacy spawn) 2025-08-10 18:09:04.217430 :BDF622FF: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-10 18:09:04.217608 :BDF62308: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-10 18:09:04.218452 :BDF62309:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-10 18:09:05.309046 :BDF6234C:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-10 18:09:05.299 2025-08-10 18:09:05.309049 :BDF6234D:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=11728 pso_num=28 pso_serial#=80 2025-08-10 18:09:05.309188 :BDF6234E:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=11728 (legacy spawn) 2025-08-10 18:09:05.315686 :BDF6234F: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-10 18:09:05.315857 :BDF62354: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-10 18:09:05.316659 :BDF62359:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-10 18:09:07.281332 :BDF62411:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-10 18:09:07.268 2025-08-10 18:09:07.281334 :BDF62412:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=19768 pso_num=28 pso_serial#=81 2025-08-10 18:09:07.281474 :BDF62413:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=19768 (legacy spawn) 2025-08-10 18:09:07.288323 :BDF62414: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-10 18:09:07.288491 :BDF6241D: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-10 18:09:07.289489 :BDF6241E:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-10 18:09:07.298196 :BDF62421:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-10 18:09:07.284 2025-08-10 18:09:07.298198 :BDF62422:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=17692 pso_num=28 pso_serial#=82 2025-08-10 18:09:07.298333 :BDF62423:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=17692 (legacy spawn) 2025-08-10 18:09:07.304863 :BDF62424: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-10 18:09:07.305036 :BDF6242D: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-10 18:09:07.305838 :BDF6242E:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-10 18:09:12.820249 :BDF625EE:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-10 18:09:12.815 2025-08-10 18:09:12.820251 :BDF625EF:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=20836 pso_num=28 pso_serial#=83 2025-08-10 18:09:12.820389 :BDF625F0:db_trace:kso.c@4093:ksonfy(): [10420:28:0] kso: new process: pid=20836 osp_idx=26 osp_ver=219941 osp_pg=0 (spawn #475292) 2025-08-10 18:09:12.820389 :BDF625F1: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-10 18:09:12.820390 :BDF625F2:db_trace:kso.c@4103:ksonfy(): [10420:28:0] kso: new process: pso_index=28 reservation=62 time=3530022126 2025-08-10 18:09:12.820390 :BDF625F3:db_trace:kso.c@4109:ksonfy(): [10420:28:0] kso: spawn diagnostics: queue time=0 secs 2025-08-10 18:09:12.820391 :BDF625F4:db_trace:kso.c@4111:ksonfy(): [10420:28:0] kso: spawn diagnostics: fork time=0 secs 2025-08-10 18:09:12.820391 :BDF625F5:db_trace:kso.c@4113:ksonfy(): [10420:28:0] kso: spawn diagnostics: exec time=0 secs 2025-08-10 18:09:12.820391 :BDF625F6:db_trace:kso.c@4115:ksonfy(): [10420:28:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-10 18:09:12.820392 :BDF625F7:db_trace:kso.c@4117:ksonfy(): [10420:28:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-10 18:09:12.820900 :BDF625F8: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-10 18:09:12.820946 :BDF625FE: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-10 18:09:12.840862 :BDF6260F:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-10 18:09:17.651494 :BDF62764:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-10 18:09:17.643 2025-08-10 18:09:17.651496 :BDF62765:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=16800 pso_num=28 pso_serial#=84 2025-08-10 18:09:17.651635 :BDF62766:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=16800 (legacy spawn) 2025-08-10 18:09:17.658174 :BDF62767: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-10 18:09:17.658344 :BDF62770: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-10 18:09:17.659152 :BDF62771:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-10 18:09:20.595277 :BDF62857:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-10 18:09:20.587 2025-08-10 18:09:20.595279 :BDF62858:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=17424 pso_num=28 pso_serial#=85 2025-08-10 18:09:20.595420 :BDF62859:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=17424 (legacy spawn) 2025-08-10 18:09:20.602036 :BDF6285A: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-10 18:09:20.602234 :BDF6285F: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-10 18:09:20.603100 :BDF62864:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-10 18:09:22.052255 :BDF62B42:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-10 18:09:22.047 2025-08-10 18:09:22.052256 :BDF62B43:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=20516 pso_num=28 pso_serial#=86 2025-08-10 18:09:22.052397 :BDF62B44:db_trace:kso.c@4093:ksonfy(): [10420:28:0] kso: new process: pid=20516 osp_idx=26 osp_ver=219944 osp_pg=0 (spawn #475297) 2025-08-10 18:09:22.052397 :BDF62B45: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-10 18:09:22.052398 :BDF62B46:db_trace:kso.c@4103:ksonfy(): [10420:28:0] kso: new process: pso_index=28 reservation=63 time=3530031361 2025-08-10 18:09:22.052398 :BDF62B47:db_trace:kso.c@4109:ksonfy(): [10420:28:0] kso: spawn diagnostics: queue time=0 secs 2025-08-10 18:09:22.052399 :BDF62B48:db_trace:kso.c@4111:ksonfy(): [10420:28:0] kso: spawn diagnostics: fork time=0 secs 2025-08-10 18:09:22.052400 :BDF62B49:db_trace:kso.c@4113:ksonfy(): [10420:28:0] kso: spawn diagnostics: exec time=0 secs 2025-08-10 18:09:22.052400 :BDF62B4A:db_trace:kso.c@4115:ksonfy(): [10420:28:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-10 18:09:22.052400 :BDF62B4B:db_trace:kso.c@4117:ksonfy(): [10420:28:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-10 18:09:22.052885 :BDF62B55: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: 20516, J002)