Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250802100521\orcl_j002_18856_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:35828M/63366M, Ph+PgF:41490M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 28 Windows thread id: 18856, image: ORACLE.EXE (J002) *** 2025-08-02 10:05:21.300 *** SESSION ID:(225.51053) 2025-08-02 10:05:21.300 *** 2025-08-02 10:05:21.300 Process diagnostic dump for ORACLE.EXE (J002), OS id=18856, pid: 28, proc_ser: 221, sid: 225, sess_ser: 51053 ------------------------------------------------------------------------------- current sql: client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 18856 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.067727 sec, exc=0.067727 sec, total=0.067727 sec wait times: max=0.500000 sec, heur=4.081403 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.000006 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.510103 sec, exc=0.510103 sec, total=0.510103 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=6 seq_num=7 snap_id=1 wait times: snap=0.499995 sec, exc=0.499995 sec, total=0.499995 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000011 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.499998 sec, exc=0.499998 sec, total=0.499998 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 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.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 4: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=3 seq_num=4 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.000008 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.500008 sec, exc=0.500008 sec, total=0.500008 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 6: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=1 seq_num=2 snap_id=1 wait times: snap=0.510090 sec, exc=0.510090 sec, total=0.510090 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000006 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.493429 sec, exc=0.493429 sec, total=0.493429 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 51053 --------------------------------------------------- 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, 10:05:17 - 10:05:21] idle wait at each sample [session created at: 10:05:17] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-08-02 10:05:21.300 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 28 (osid: 18856, J002) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-08-02 10:00:57.914435 :BA477BC8:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-02 10:01:08.665185 :BA477F3A:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-02 10:01:08.657 2025-08-02 10:01:08.665188 :BA477F3B:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=20368 pso_num=28 pso_serial#=197 2025-08-02 10:01:08.665326 :BA477F3C:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=20368 (legacy spawn) 2025-08-02 10:01:08.671794 :BA477F3D: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-02 10:01:08.671965 :BA477F42: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-02 10:01:08.672799 :BA477F47:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-02 10:02:03.431191 :BA4790CA:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-02 10:02:03.422 2025-08-02 10:02:03.431193 :BA4790CB:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=19432 pso_num=28 pso_serial#=198 2025-08-02 10:02:03.431333 :BA4790CC:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=19432 (legacy spawn) 2025-08-02 10:02:03.457222 :BA4790CD: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-02 10:02:03.457393 :BA4790D2: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-02 10:02:03.458253 :BA4790D7:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-02 10:02:07.595072 :BA47921C:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-02 10:02:07.580 2025-08-02 10:02:07.595074 :BA47921D:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=19960 pso_num=28 pso_serial#=199 2025-08-02 10:02:07.595218 :BA47921E:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=19960 (legacy spawn) 2025-08-02 10:02:07.601656 :BA47921F: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-02 10:02:07.601832 :BA479228: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-02 10:02:07.602630 :BA479229:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-02 10:02:07.611240 :BA47922C:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-02 10:02:07.596 2025-08-02 10:02:07.611242 :BA47922D:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=20140 pso_num=28 pso_serial#=200 2025-08-02 10:02:07.611406 :BA47922E:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=20140 (legacy spawn) 2025-08-02 10:02:07.617928 :BA47922F: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-02 10:02:07.618101 :BA479238: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-02 10:02:07.618906 :BA479239:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-02 10:02:10.687820 :BA47933F:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-02 10:02:10.674 2025-08-02 10:02:10.687823 :BA479340:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=19192 pso_num=28 pso_serial#=201 2025-08-02 10:02:10.688013 :BA479341:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=19192 (legacy spawn) 2025-08-02 10:02:10.694724 :BA479365: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-02 10:02:10.694754 :BA479368: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-02 10:02:10.694897 :BA47936F: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-02 10:02:10.695834 :BA47937C:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-02 10:02:10.704378 :BA47937F:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-02 10:02:10.690 2025-08-02 10:02:10.704380 :BA479380:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=11336 pso_num=28 pso_serial#=202 2025-08-02 10:02:10.704519 :BA479381:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=11336 (legacy spawn) 2025-08-02 10:02:10.711234 :BA479382: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-02 10:02:10.711399 :BA47938B: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-02 10:02:10.712177 :BA47938C:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-02 10:02:10.838860 :BA47938F:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-02 10:02:10.830 2025-08-02 10:02:10.838862 :BA479390:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=13028 pso_num=28 pso_serial#=203 2025-08-02 10:02:10.838994 :BA479391:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=13028 (legacy spawn) 2025-08-02 10:02:10.845439 :BA479392: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-02 10:02:10.845601 :BA47939B: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-02 10:02:10.846450 :BA47939C:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-02 10:03:11.919971 :BA47A84A:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-02 10:03:11.911 2025-08-02 10:03:11.919973 :BA47A84B:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=1812 pso_num=28 pso_serial#=204 2025-08-02 10:03:11.920113 :BA47A84C:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=1812 (legacy spawn) 2025-08-02 10:03:11.926722 :BA47A84D: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-02 10:03:11.926891 :BA47A852: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-02 10:03:11.927707 :BA47A857:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-02 10:03:13.043840 :BA47A87F:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-02 10:03:13.036 2025-08-02 10:03:13.043842 :BA47A880:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=19280 pso_num=28 pso_serial#=205 2025-08-02 10:03:13.043980 :BA47A881:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=19280 (legacy spawn) 2025-08-02 10:03:13.050407 :BA47A882: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-02 10:03:13.050585 :BA47A887: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-02 10:03:13.051384 :BA47A88C:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-02 10:03:19.996232 :BA47AAEE:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-02 10:03:19.993 2025-08-02 10:03:19.996234 :BA47AAEF:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=15536 pso_num=28 pso_serial#=206 2025-08-02 10:03:19.996369 :BA47AAF0:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=15536 (legacy spawn) 2025-08-02 10:03:20.026734 :BA47AAFF: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-02 10:03:20.026932 :BA47AB05: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-02 10:03:20.027865 :BA47AB09:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-02 10:03:20.037441 :BA47AB0C:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-02 10:03:20.024 2025-08-02 10:03:20.037443 :BA47AB0D:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=9844 pso_num=28 pso_serial#=207 2025-08-02 10:03:20.037584 :BA47AB0E:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=9844 (legacy spawn) 2025-08-02 10:03:20.044605 :BA47AB0F: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-02 10:03:20.044795 :BA47AB17: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-02 10:03:20.045738 :BA47AB19:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-02 10:03:23.179756 :BA47AC0C:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-02 10:03:23.167 2025-08-02 10:03:23.179759 :BA47AC0D:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=17272 pso_num=28 pso_serial#=208 2025-08-02 10:03:23.179890 :BA47AC0E:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=17272 (legacy spawn) 2025-08-02 10:03:23.186345 :BA47AC0F: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-02 10:03:23.186513 :BA47AC15: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-02 10:03:23.187366 :BA47AC19:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-02 10:03:23.196054 :BA47AC1C:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-02 10:03:23.182 2025-08-02 10:03:23.196056 :BA47AC1D:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=20048 pso_num=28 pso_serial#=209 2025-08-02 10:03:23.196194 :BA47AC1E:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=20048 (legacy spawn) 2025-08-02 10:03:23.202743 :BA47AC1F: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-02 10:03:23.202905 :BA47AC28: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-02 10:03:23.203710 :BA47AC29:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-02 10:03:56.506178 :BA47B6EB:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-02 10:03:56.492 2025-08-02 10:03:56.506181 :BA47B6EC:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=20464 pso_num=28 pso_serial#=210 2025-08-02 10:03:56.506317 :BA47B6ED:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=20464 (legacy spawn) 2025-08-02 10:03:56.512998 :BA47B6EE: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-02 10:03:56.513164 :BA47B6F3: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-02 10:03:56.514118 :BA47B6F8:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-02 10:03:56.522677 :BA47B6FB:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-02 10:03:56.507 2025-08-02 10:03:56.522679 :BA47B6FC:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=11772 pso_num=28 pso_serial#=211 2025-08-02 10:03:56.522812 :BA47B6FD:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=11772 (legacy spawn) 2025-08-02 10:03:56.529326 :BA47B6FE: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-02 10:03:56.529487 :BA47B707: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-02 10:03:56.530292 :BA47B708:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-02 10:03:59.694445 :BA47B822:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-02 10:03:59.681 2025-08-02 10:03:59.694447 :BA47B823:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=20064 pso_num=28 pso_serial#=212 2025-08-02 10:03:59.694584 :BA47B824:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=20064 (legacy spawn) 2025-08-02 10:03:59.701070 :BA47B825: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-02 10:03:59.701263 :BA47B82A: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-02 10:03:59.702049 :BA47B82F:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-02 10:03:59.710727 :BA47B832:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-02 10:03:59.697 2025-08-02 10:03:59.710729 :BA47B833:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=10368 pso_num=28 pso_serial#=213 2025-08-02 10:03:59.710861 :BA47B834:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=10368 (legacy spawn) 2025-08-02 10:03:59.730084 :BA47B835: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-02 10:03:59.730263 :BA47B83E: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-02 10:03:59.731136 :BA47B83F:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-02 10:04:15.200491 :BA47BD16:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-02 10:04:15.192 2025-08-02 10:04:15.200494 :BA47BD17:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=19096 pso_num=28 pso_serial#=214 2025-08-02 10:04:15.200638 :BA47BD18:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=19096 (legacy spawn) 2025-08-02 10:04:15.207114 :BA47BD19: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-02 10:04:15.207295 :BA47BD1E: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-02 10:04:15.208125 :BA47BD23:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-02 10:04:19.840715 :BA47BE71:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-02 10:04:19.825 2025-08-02 10:04:19.840717 :BA47BE72:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=7280 pso_num=28 pso_serial#=215 2025-08-02 10:04:19.840857 :BA47BE73:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=7280 (legacy spawn) 2025-08-02 10:04:19.847474 :BA47BE74: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-02 10:04:19.847647 :BA47BE7D: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-02 10:04:19.848537 :BA47BE7E:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-02 10:05:09.499145 :BA47CEBA:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-02 10:05:09.484 2025-08-02 10:05:09.499147 :BA47CEBB:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=4556 pso_num=28 pso_serial#=216 2025-08-02 10:05:09.499286 :BA47CEBC:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=4556 (legacy spawn) 2025-08-02 10:05:09.505763 :BA47CEBD: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-02 10:05:09.505939 :BA47CEC2: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-02 10:05:09.506746 :BA47CEC7:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-02 10:05:09.515415 :BA47CECA:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-02 10:05:09.500 2025-08-02 10:05:09.515417 :BA47CECB:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=19464 pso_num=28 pso_serial#=217 2025-08-02 10:05:09.515556 :BA47CECC:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=19464 (legacy spawn) 2025-08-02 10:05:09.521988 :BA47CECD: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-02 10:05:09.522157 :BA47CED6: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-02 10:05:09.522955 :BA47CED7:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-02 10:05:12.617289 :BA47CFCC:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-02 10:05:12.604 2025-08-02 10:05:12.617291 :BA47CFCD:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=10612 pso_num=28 pso_serial#=218 2025-08-02 10:05:12.617432 :BA47CFCE:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=10612 (legacy spawn) 2025-08-02 10:05:12.624055 :BA47CFCF: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-02 10:05:12.624233 :BA47CFD4: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-02 10:05:12.625051 :BA47CFD9:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-02 10:05:12.634055 :BA47CFDC:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-02 10:05:12.619 2025-08-02 10:05:12.634057 :BA47CFDD:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=19912 pso_num=28 pso_serial#=219 2025-08-02 10:05:12.634196 :BA47CFDE:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=19912 (legacy spawn) 2025-08-02 10:05:12.640920 :BA47CFDF: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-02 10:05:12.641088 :BA47CFE8: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-02 10:05:12.641904 :BA47CFE9:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-02 10:05:17.019298 :BA47D16C:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-02 10:05:17.014 2025-08-02 10:05:17.019300 :BA47D16D:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=16608 pso_num=28 pso_serial#=220 2025-08-02 10:05:17.019439 :BA47D16E:db_trace:kso.c@4093:ksonfy(): [10420:28:0] kso: new process: pid=16608 osp_idx=26 osp_ver=189223 osp_pg=0 (spawn #447493) 2025-08-02 10:05:17.019439 :BA47D16F: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-02 10:05:17.019440 :BA47D170:db_trace:kso.c@4103:ksonfy(): [10420:28:0] kso: new process: pso_index=28 reservation=76 time=2809786329 2025-08-02 10:05:17.019440 :BA47D171:db_trace:kso.c@4109:ksonfy(): [10420:28:0] kso: spawn diagnostics: queue time=0 secs 2025-08-02 10:05:17.019441 :BA47D172:db_trace:kso.c@4111:ksonfy(): [10420:28:0] kso: spawn diagnostics: fork time=0 secs 2025-08-02 10:05:17.019441 :BA47D173:db_trace:kso.c@4113:ksonfy(): [10420:28:0] kso: spawn diagnostics: exec time=0 secs 2025-08-02 10:05:17.019441 :BA47D174:db_trace:kso.c@4115:ksonfy(): [10420:28:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-02 10:05:17.019442 :BA47D175:db_trace:kso.c@4117:ksonfy(): [10420:28:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-02 10:05:17.019940 :BA47D176: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-02 10:05:17.019985 :BA47D17C: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-02 10:05:17.024171 :BA47D18E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:kelt.c:517 2025-08-02 10:05:17.024214 :BA47D18F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:kelt.c:517 2025-08-02 10:05:17.024475 :BA47D190:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:kelt.c:517 2025-08-02 10:05:17.024492 :BA47D191:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:kelt.c:517 2025-08-02 10:05:17.024708 :BA47D192:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:kelt.c:517 2025-08-02 10:05:17.024721 :BA47D193:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:kelt.c:517 2025-08-02 10:05:17.024941 :BA47D194:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:kelt.c:517 2025-08-02 10:05:17.024954 :BA47D195:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:kelt.c:517 2025-08-02 10:05:17.025165 :BA47D196:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:kelt.c:517 2025-08-02 10:05:17.025178 :BA47D197:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:kelt.c:517 2025-08-02 10:05:17.025407 :BA47D198:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:kelt.c:517 2025-08-02 10:05:17.025429 :BA47D199:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:kelt.c:517 2025-08-02 10:05:17.027820 :BA47D1C7:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-02 10:05:17.222944 :BA47D5DE:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-02 10:05:17.218 2025-08-02 10:05:17.222945 :BA47D5DF:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=18856 pso_num=28 pso_serial#=221 2025-08-02 10:05:17.223093 :BA47D5E0:db_trace:kso.c@4093:ksonfy(): [10420:28:0] kso: new process: pid=18856 osp_idx=26 osp_ver=189224 osp_pg=0 (spawn #447495) 2025-08-02 10:05:17.223094 :BA47D5E1: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-02 10:05:17.223094 :BA47D5E2:db_trace:kso.c@4103:ksonfy(): [10420:28:0] kso: new process: pso_index=28 reservation=77 time=2809786533 2025-08-02 10:05:17.223095 :BA47D5E3:db_trace:kso.c@4109:ksonfy(): [10420:28:0] kso: spawn diagnostics: queue time=0 secs 2025-08-02 10:05:17.223096 :BA47D5E4:db_trace:kso.c@4111:ksonfy(): [10420:28:0] kso: spawn diagnostics: fork time=0 secs 2025-08-02 10:05:17.223096 :BA47D5E5:db_trace:kso.c@4113:ksonfy(): [10420:28:0] kso: spawn diagnostics: exec time=0 secs 2025-08-02 10:05:17.223096 :BA47D5E6:db_trace:kso.c@4115:ksonfy(): [10420:28:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-02 10:05:17.223097 :BA47D5E7:db_trace:kso.c@4117:ksonfy(): [10420:28:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-02 10:05:17.223612 :BA47D5F1: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: 18856, J002)