Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250621100534\orcl_j002_16080_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:36436M/63366M, Ph+PgF:42856M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 27 Windows thread id: 16080, image: ORACLE.EXE (J002) *** 2025-06-21 10:05:34.538 *** SESSION ID:(219.40907) 2025-06-21 10:05:34.538 *** 2025-06-21 10:05:34.538 Process diagnostic dump for ORACLE.EXE (J002), OS id=16080, pid: 27, proc_ser: 234, sid: 219, sess_ser: 40907 ------------------------------------------------------------------------------- current sql: client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 16080 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J002) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=7 seq_num=8 snap_id=1 wait times: snap=0.219647 sec, exc=0.219647 sec, total=0.219647 sec wait times: max=0.500000 sec, heur=3.728804 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.000012 sec since current wait 0: 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 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=5 seq_num=6 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 2: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=4 seq_num=5 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.000010 sec of elapsed time 3: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=3 seq_num=4 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.000012 sec of elapsed time 4: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=2 seq_num=3 snap_id=1 wait times: snap=0.499988 sec, exc=0.499988 sec, total=0.499988 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000014 sec of elapsed time 5: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=1 seq_num=2 snap_id=1 wait times: snap=0.515205 sec, exc=0.515205 sec, total=0.515205 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000011 sec of elapsed time 6: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=0 seq_num=1 snap_id=1 wait times: snap=0.493906 sec, exc=0.493906 sec, total=0.493906 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 219 serial 40907 --------------------------------------------------- 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 --------------------------------------------------- [4 samples, 10:05:30 - 10:05:34] idle wait at each sample [session created at: 10:05:30] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-06-21 10:05:34.538 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 27 (osid: 16080, J002) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-06-21 10:02:22.995670 :A79E2F12:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-21 10:02:22.996500 :A79E2F17:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-21 10:02:23.005230 :A79E2F1A:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-21 10:02:22.991 2025-06-21 10:02:23.005232 :A79E2F1B:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=17432 pso_num=27 pso_serial#=213 2025-06-21 10:02:23.005365 :A79E2F1C:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=17432 (legacy spawn) 2025-06-21 10:02:23.011825 :A79E2F1D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-21 10:02:23.011989 :A79E2F26:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-21 10:02:23.012771 :A79E2F27:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-21 10:02:25.031341 :A79E2FCA:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-21 10:02:25.022 2025-06-21 10:02:25.031344 :A79E2FCB:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=14744 pso_num=27 pso_serial#=214 2025-06-21 10:02:25.031480 :A79E2FCC:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=14744 (legacy spawn) 2025-06-21 10:02:25.037907 :A79E2FCD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-21 10:02:25.037941 :A79E2FD0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-21 10:02:25.038105 :A79E2FD3:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-21 10:02:25.038893 :A79E2FE4:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-21 10:02:26.216757 :A79E3034:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-21 10:02:26.203 2025-06-21 10:02:26.216759 :A79E3035:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=13888 pso_num=27 pso_serial#=215 2025-06-21 10:02:26.216894 :A79E3036:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=13888 (legacy spawn) 2025-06-21 10:02:26.223386 :A79E3037:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-21 10:02:26.223559 :A79E303C:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-21 10:02:26.224353 :A79E3041:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-21 10:02:26.233096 :A79E3044:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-21 10:02:26.219 2025-06-21 10:02:26.233098 :A79E3045:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=4800 pso_num=27 pso_serial#=216 2025-06-21 10:02:26.233234 :A79E3046:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=4800 (legacy spawn) 2025-06-21 10:02:26.239698 :A79E3047:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-21 10:02:26.239877 :A79E3050:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-21 10:02:26.240691 :A79E3051:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-21 10:02:59.498667 :A79E3AF8:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-21 10:02:59.495 2025-06-21 10:02:59.498670 :A79E3AF9:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=12152 pso_num=27 pso_serial#=217 2025-06-21 10:02:59.498807 :A79E3AFA:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=12152 (legacy spawn) 2025-06-21 10:02:59.505186 :A79E3AFB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-21 10:02:59.505374 :A79E3B00:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-21 10:02:59.506161 :A79E3B05:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-21 10:02:59.514790 :A79E3B08:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-21 10:02:59.511 2025-06-21 10:02:59.514792 :A79E3B09:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=17008 pso_num=27 pso_serial#=218 2025-06-21 10:02:59.514929 :A79E3B0A:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=17008 (legacy spawn) 2025-06-21 10:02:59.521316 :A79E3B0B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-21 10:02:59.521479 :A79E3B14:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-21 10:02:59.522281 :A79E3B15:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-21 10:03:00.284909 :A79E3B24:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-21 10:03:00.276 2025-06-21 10:03:00.284911 :A79E3B25:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=13792 pso_num=27 pso_serial#=219 2025-06-21 10:03:00.285050 :A79E3B26:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=13792 (legacy spawn) 2025-06-21 10:03:00.291587 :A79E3B27:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-21 10:03:00.291758 :A79E3B30:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-21 10:03:00.292421 :A79E3B54:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-21 10:03:02.699268 :A79E3C24:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-21 10:03:02.692 2025-06-21 10:03:02.699270 :A79E3C25:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=17780 pso_num=27 pso_serial#=220 2025-06-21 10:03:02.699412 :A79E3C26:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=17780 (legacy spawn) 2025-06-21 10:03:02.705898 :A79E3C27:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-21 10:03:02.706069 :A79E3C2C:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-21 10:03:02.706909 :A79E3C31:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-21 10:03:02.715619 :A79E3C34:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-21 10:03:02.707 2025-06-21 10:03:02.715621 :A79E3C35:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=18028 pso_num=27 pso_serial#=221 2025-06-21 10:03:02.715756 :A79E3C36:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=18028 (legacy spawn) 2025-06-21 10:03:02.722163 :A79E3C37:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-21 10:03:02.722343 :A79E3C40:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-21 10:03:02.723168 :A79E3C41:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-21 10:03:14.545894 :A79E3FD7:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-21 10:03:14.537 2025-06-21 10:03:14.545896 :A79E3FD8:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=13620 pso_num=27 pso_serial#=222 2025-06-21 10:03:14.546032 :A79E3FD9:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=13620 (legacy spawn) 2025-06-21 10:03:14.552566 :A79E3FDA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-21 10:03:14.552749 :A79E3FDF:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-21 10:03:14.553683 :A79E3FF0:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-21 10:04:08.429136 :A79E51B1:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-21 10:04:08.419 2025-06-21 10:04:08.429138 :A79E51B2:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=17468 pso_num=27 pso_serial#=223 2025-06-21 10:04:08.429277 :A79E51B3:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=17468 (legacy spawn) 2025-06-21 10:04:08.435766 :A79E51B4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-21 10:04:08.435939 :A79E51B9:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-21 10:04:08.436741 :A79E51BE:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-21 10:04:12.316857 :A79E52B6:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-21 10:04:12.302 2025-06-21 10:04:12.316859 :A79E52B7:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=17512 pso_num=27 pso_serial#=224 2025-06-21 10:04:12.316995 :A79E52B8:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=17512 (legacy spawn) 2025-06-21 10:04:12.327841 :A79E52B9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-21 10:04:12.328023 :A79E52BE:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-21 10:04:12.328726 :A79E52C3:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-21 10:04:12.338507 :A79E52C6:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-21 10:04:12.333 2025-06-21 10:04:12.338509 :A79E52C7:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=17168 pso_num=27 pso_serial#=225 2025-06-21 10:04:12.338659 :A79E52C8:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=17168 (legacy spawn) 2025-06-21 10:04:12.345244 :A79E52C9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-21 10:04:12.345408 :A79E52D2:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-21 10:04:12.346245 :A79E52D3:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-21 10:04:15.550460 :A79E53DB:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-21 10:04:15.536 2025-06-21 10:04:15.550462 :A79E53DC:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=16276 pso_num=27 pso_serial#=226 2025-06-21 10:04:15.550600 :A79E53DD:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=16276 (legacy spawn) 2025-06-21 10:04:15.557137 :A79E53DE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-21 10:04:15.573782 :A79E53E3:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-21 10:04:15.574724 :A79E53E8:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-21 10:04:15.591225 :A79E53EB:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-21 10:04:15.583 2025-06-21 10:04:15.591227 :A79E53EC:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=17892 pso_num=27 pso_serial#=227 2025-06-21 10:04:15.591367 :A79E53ED:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=17892 (legacy spawn) 2025-06-21 10:04:15.597871 :A79E53EE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-21 10:04:15.598041 :A79E53F7:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-21 10:04:15.598840 :A79E53F8:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-21 10:04:47.805540 :A79E5E5D:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-21 10:04:47.797 2025-06-21 10:04:47.805542 :A79E5E5E:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=17952 pso_num=27 pso_serial#=228 2025-06-21 10:04:47.805676 :A79E5E5F:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=17952 (legacy spawn) 2025-06-21 10:04:47.812175 :A79E5E60:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-21 10:04:47.812342 :A79E5E65:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-21 10:04:47.813243 :A79E5E72:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-21 10:04:48.687404 :A79E5E9C:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-21 10:04:48.672 2025-06-21 10:04:48.687406 :A79E5E9D:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=17552 pso_num=27 pso_serial#=229 2025-06-21 10:04:48.687552 :A79E5E9E:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=17552 (legacy spawn) 2025-06-21 10:04:48.705806 :A79E5E9F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-21 10:04:48.705993 :A79E5EA7:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-21 10:04:48.706851 :A79E5EA9:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-21 10:04:48.715558 :A79E5EAC:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-21 10:04:48.704 2025-06-21 10:04:48.715560 :A79E5EAD:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=18080 pso_num=27 pso_serial#=230 2025-06-21 10:04:48.715697 :A79E5EAE:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=18080 (legacy spawn) 2025-06-21 10:04:48.722218 :A79E5EAF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-21 10:04:48.722375 :A79E5EB8:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-21 10:04:48.723219 :A79E5EC7:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-21 10:04:51.905073 :A79E600E:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-21 10:04:51.892 2025-06-21 10:04:51.905075 :A79E600F:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=8164 pso_num=27 pso_serial#=231 2025-06-21 10:04:51.905213 :A79E6010:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=8164 (legacy spawn) 2025-06-21 10:04:51.911693 :A79E6011:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-21 10:04:51.911867 :A79E601A:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-21 10:04:51.912670 :A79E601B:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-21 10:04:51.921331 :A79E601E:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-21 10:04:51.907 2025-06-21 10:04:51.921334 :A79E601F:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=16728 pso_num=27 pso_serial#=232 2025-06-21 10:04:51.921468 :A79E6020:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=16728 (legacy spawn) 2025-06-21 10:04:51.927941 :A79E6021:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-21 10:04:51.928102 :A79E602A:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-21 10:04:51.928893 :A79E602B:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-21 10:05:30.602299 :A79E6C73:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-21 10:05:30.600 2025-06-21 10:05:30.602300 :A79E6C74:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=15364 pso_num=27 pso_serial#=233 2025-06-21 10:05:30.602433 :A79E6C75:db_trace:kso.c@4093:ksonfy(): [10420:27:0] kso: new process: pid=15364 osp_idx=25 osp_ver=85912 osp_pg=0 (spawn #307507) 2025-06-21 10:05:30.602434 :A79E6C76:db_trace:kso.c@4099:ksonfy(): [10420:27:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-21 10:05:30.602434 :A79E6C77:db_trace:kso.c@4103:ksonfy(): [10420:27:0] kso: new process: pso_index=27 reservation=113 time=3476073782 2025-06-21 10:05:30.602435 :A79E6C78:db_trace:kso.c@4109:ksonfy(): [10420:27:0] kso: spawn diagnostics: queue time=0 secs 2025-06-21 10:05:30.602435 :A79E6C79:db_trace:kso.c@4111:ksonfy(): [10420:27:0] kso: spawn diagnostics: fork time=0 secs 2025-06-21 10:05:30.602436 :A79E6C7A:db_trace:kso.c@4113:ksonfy(): [10420:27:0] kso: spawn diagnostics: exec time=0 secs 2025-06-21 10:05:30.602436 :A79E6C7B:db_trace:kso.c@4115:ksonfy(): [10420:27:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-21 10:05:30.602436 :A79E6C7C:db_trace:kso.c@4117:ksonfy(): [10420:27:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-21 10:05:30.602938 :A79E6C7D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-21 10:05:30.602992 :A79E6C83:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-21 10:05:30.603069 :A79E6C8A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-06-21 10:05:30.607580 :A79E6CA8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-21 10:05:30.660317 :A79E6CB3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-21 10:05:30.662474 :A79E6CBB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-21 10:05:30.663734 :A79E6CC3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-21 10:05:30.664625 :A79E6CCB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-21 10:05:30.664659 :A79E6CCE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-06-21 10:05:30.664707 :A79E6CDA:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] KSL POST RCVD poster=18 loc='ksr2.h LINE:607 ID:ksrmdone' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-21 10:05:30.665725 :A79E6CE4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-21 10:05:30.665746 :A79E6CE7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-06-21 10:05:30.665776 :A79E6CF2:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] KSL POST RCVD poster=18 loc='ksr2.h LINE:607 ID:ksrmdone' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-21 10:05:30.666470 :A79E6CFC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-21 10:05:30.668825 :A79E6D04:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-21 10:05:30.674032 :A79E6D0C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-21 10:05:30.675186 :A79E6D14:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-21 10:05:30.680099 :A79E6D1C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-21 10:05:30.681432 :A79E6D24:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-21 10:05:30.684369 :A79E6D2C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-21 10:05:30.685536 :A79E6D34:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-21 10:05:30.685544 :A79E6D35:db_trace:ktur.c@3079:ktuabt(): [10444:27:219] ABORT TRANSACTION - xid: 0x0002.000.0000c397 2025-06-21 10:05:30.688782 :A79E6D3D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-06-21 10:05:30.688944 :A79E6D4C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=59 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-21 10:05:30.689145 :A79E6D57:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-21 10:05:30.689191 :A79E6D5A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:ktcc.c:879 2025-06-21 10:05:30.689206 :A79E6D5B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:ktcc.c:879 2025-06-21 10:05:30.692190 :A79E6D71:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-06-21 10:05:30.692289 :A79E6D80:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=59 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-21 10:05:30.692496 :A79E6D82:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-21 10:05:30.692544 :A79E6D85:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:ktcc.c:879 2025-06-21 10:05:30.692557 :A79E6D86:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:ktcc.c:879 2025-06-21 10:05:30.692739 :A79E6D8C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-21 10:05:30.692751 :A79E6D8F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-06-21 10:05:30.692773 :A79E6D9B:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] KSL POST RCVD poster=18 loc='ksr2.h LINE:607 ID:ksrmdone' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-21 10:05:30.694890 :A79E6DA5:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-21 10:05:30.809214 :A79E70FE:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-21 10:05:30.804 2025-06-21 10:05:30.809217 :A79E70FF:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=16080 pso_num=27 pso_serial#=234 2025-06-21 10:05:30.809368 :A79E7100:db_trace:kso.c@4093:ksonfy(): [10420:27:0] kso: new process: pid=16080 osp_idx=25 osp_ver=85913 osp_pg=0 (spawn #307510) 2025-06-21 10:05:30.809369 :A79E7101:db_trace:kso.c@4099:ksonfy(): [10420:27:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-21 10:05:30.809369 :A79E7102:db_trace:kso.c@4103:ksonfy(): [10420:27:0] kso: new process: pso_index=27 reservation=114 time=3476074000 2025-06-21 10:05:30.809370 :A79E7103:db_trace:kso.c@4109:ksonfy(): [10420:27:0] kso: spawn diagnostics: queue time=0 secs 2025-06-21 10:05:30.809370 :A79E7104:db_trace:kso.c@4111:ksonfy(): [10420:27:0] kso: spawn diagnostics: fork time=0 secs 2025-06-21 10:05:30.809371 :A79E7105:db_trace:kso.c@4113:ksonfy(): [10420:27:0] kso: spawn diagnostics: exec time=0 secs 2025-06-21 10:05:30.809371 :A79E7106:db_trace:kso.c@4115:ksonfy(): [10420:27:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-21 10:05:30.809372 :A79E7107:db_trace:kso.c@4117:ksonfy(): [10420:27:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-21 10:05:30.809882 :A79E710C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] 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 27 (osid: 16080, J002)