Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250820080902\orcl_m002_16692_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:35343M/63366M, Ph+PgF:40544M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 28 Windows thread id: 16692, image: ORACLE.EXE (M002) *** 2025-08-20 08:09:02.193 *** SESSION ID:(225.34399) 2025-08-20 08:09:02.193 *** 2025-08-20 08:09:02.193 Process diagnostic dump for ORACLE.EXE (M002), OS id=16692, pid: 28, proc_ser: 15, sid: 225, sess_ser: 34399 ------------------------------------------------------------------------------- current sql: Current Wait Stack: 0: waiting for 'db file sequential read' file#=0x2, block#=0xe5a, blocks=0x1 wait_id=1228 seq_num=1229 snap_id=1 wait times: snap=0.001134 sec, exc=0.001134 sec, total=0.001134 sec wait times: max=infinite, heur=0.001134 sec wait counts: calls=0 os=0 in_wait=1 iflags=0x5a0 Wait State: fixed_waits=0 flags=0x22 boundary=0x0000000000000000/-1 Session Wait History: elapsed time of 0.000439 sec since current wait 0: waited for 'db file sequential read' file#=0x2, block#=0xe1a, blocks=0x1 wait_id=1227 seq_num=1228 snap_id=1 wait times: snap=0.000050 sec, exc=0.000050 sec, total=0.000050 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000129 sec of elapsed time 1: waited for 'db file sequential read' file#=0x2, block#=0xe0a, blocks=0x1 wait_id=1226 seq_num=1227 snap_id=1 wait times: snap=0.000049 sec, exc=0.000049 sec, total=0.000049 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000467 sec of elapsed time 2: waited for 'db file sequential read' file#=0x2, block#=0xdca, blocks=0x1 wait_id=1225 seq_num=1226 snap_id=1 wait times: snap=0.000049 sec, exc=0.000049 sec, total=0.000049 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000469 sec of elapsed time 3: waited for 'db file sequential read' file#=0x2, block#=0xd7a, blocks=0x1 wait_id=1224 seq_num=1225 snap_id=1 wait times: snap=0.000049 sec, exc=0.000049 sec, total=0.000049 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000258 sec of elapsed time 4: waited for 'db file sequential read' file#=0x2, block#=0xd2a, blocks=0x1 wait_id=1223 seq_num=1224 snap_id=1 wait times: snap=0.000054 sec, exc=0.000054 sec, total=0.000054 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000146 sec of elapsed time 5: waited for 'db file sequential read' file#=0x2, block#=0xd1a, blocks=0x1 wait_id=1222 seq_num=1223 snap_id=1 wait times: snap=0.000053 sec, exc=0.000053 sec, total=0.000053 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000172 sec of elapsed time 6: waited for 'db file sequential read' file#=0x2, block#=0xd0a, blocks=0x1 wait_id=1221 seq_num=1222 snap_id=1 wait times: snap=0.000076 sec, exc=0.000076 sec, total=0.000076 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000909 sec of elapsed time 7: waited for 'db file sequential read' file#=0x2, block#=0xc82, blocks=0x1 wait_id=1220 seq_num=1221 snap_id=1 wait times: snap=0.000088 sec, exc=0.000088 sec, total=0.000088 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000951 sec of elapsed time 8: waited for 'db file sequential read' file#=0x2, block#=0xbf2, blocks=0x1 wait_id=1219 seq_num=1220 snap_id=1 wait times: snap=0.005708 sec, exc=0.005708 sec, total=0.005708 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000304 sec of elapsed time 9: waited for 'db file sequential read' file#=0x2, block#=0xbca, blocks=0x1 wait_id=1218 seq_num=1219 snap_id=1 wait times: snap=0.002429 sec, exc=0.002429 sec, total=0.002429 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000175 sec of elapsed time Sampled Session History of session 225 serial 34399 --------------------------------------------------- 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 --------------------------------------------------- [1 sample, 08:09:02] idle wait at each sample [session created at: 08:09:01] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-08-20 08:09:02.193 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 28 (osid: 16692, M002) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-08-20 01:57:18.455478 :C20EF3FF:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-20 01:57:21.458861 :C20EF4FE:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-20 01:57:21.450 2025-08-20 01:57:21.458863 :C20EF4FF:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=22240 pso_num=28 pso_serial#=249 2025-08-20 01:57:21.459002 :C20EF500:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=22240 (legacy spawn) 2025-08-20 01:57:21.465540 :C20EF501: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-20 01:57:21.465713 :C20EF506: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-20 01:57:21.466582 :C20EF50B:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-20 01:57:33.510506 :C20EF8B4:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-20 01:57:33.497 2025-08-20 01:57:33.510508 :C20EF8B5:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=9732 pso_num=28 pso_serial#=250 2025-08-20 01:57:33.510641 :C20EF8B6:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=9732 (legacy spawn) 2025-08-20 01:57:33.517070 :C20EF8B7: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-20 01:57:33.517247 :C20EF8BC: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-20 01:57:33.518043 :C20EF8C1:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-20 01:57:33.536492 :C20EF8C4:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-20 01:57:33.528 2025-08-20 01:57:33.536494 :C20EF8C5:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=19272 pso_num=28 pso_serial#=251 2025-08-20 01:57:33.536629 :C20EF8C6:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=19272 (legacy spawn) 2025-08-20 01:57:33.543151 :C20EF8C7: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-20 01:57:33.543316 :C20EF8D0: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-20 01:57:33.544109 :C20EF8D1:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-20 01:57:36.693481 :C20EFA10:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-20 01:57:36.679 2025-08-20 01:57:36.693484 :C20EFA11:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=21540 pso_num=28 pso_serial#=252 2025-08-20 01:57:36.693622 :C20EFA12:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=21540 (legacy spawn) 2025-08-20 01:57:36.700493 :C20EFA13: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-20 01:57:36.700670 :C20EFA18: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-20 01:57:36.701627 :C20EFA1D:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-20 01:57:36.710787 :C20EFA20:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-20 01:57:36.710 2025-08-20 01:57:36.710789 :C20EFA21:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=19980 pso_num=28 pso_serial#=253 2025-08-20 01:57:36.710933 :C20EFA22:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=19980 (legacy spawn) 2025-08-20 01:57:36.717781 :C20EFA23: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-20 01:57:36.717945 :C20EFA2C: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-20 01:57:36.718844 :C20EFA2D:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-20 01:58:23.677043 :C20F0A25:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-20 01:58:23.668 2025-08-20 01:58:23.677045 :C20F0A26:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=21660 pso_num=28 pso_serial#=254 2025-08-20 01:58:23.677184 :C20F0A27:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=21660 (legacy spawn) 2025-08-20 01:58:23.683737 :C20F0A28: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-20 01:58:23.683916 :C20F0A2D: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-20 01:58:23.684722 :C20F0A32:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-20 01:58:26.686345 :C20F0B19:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-20 01:58:26.677 2025-08-20 01:58:26.686347 :C20F0B1A:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=3328 pso_num=28 pso_serial#=255 2025-08-20 01:58:26.686481 :C20F0B1B:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=3328 (legacy spawn) 2025-08-20 01:58:26.692999 :C20F0B1C: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-20 01:58:26.693238 :C20F0B21: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-20 01:58:26.694196 :C20F0B26:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-20 01:58:36.310804 :C20F0E19:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-20 01:58:36.297 2025-08-20 01:58:36.310806 :C20F0E1A:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=22340 pso_num=28 pso_serial#=1 2025-08-20 01:58:36.310949 :C20F0E1B:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=22340 (legacy spawn) 2025-08-20 01:58:36.330713 :C20F0E1C: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-20 01:58:36.330882 :C20F0E22: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-20 01:58:36.331748 :C20F0E26:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-20 01:58:36.340486 :C20F0E29:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-20 01:58:36.329 2025-08-20 01:58:36.340488 :C20F0E2A:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=21600 pso_num=28 pso_serial#=2 2025-08-20 01:58:36.340625 :C20F0E2B:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=21600 (legacy spawn) 2025-08-20 01:58:36.347117 :C20F0E2C: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-20 01:58:36.347150 :C20F0E2F: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-20 01:58:36.347304 :C20F0E36: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-20 01:58:36.348082 :C20F0E43:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-20 01:59:22.593885 :C20F1DCF:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-20 01:59:22.580 2025-08-20 01:59:22.593887 :C20F1DD0:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=20536 pso_num=28 pso_serial#=3 2025-08-20 01:59:22.594023 :C20F1DD1:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=20536 (legacy spawn) 2025-08-20 01:59:22.600566 :C20F1DD2: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-20 01:59:22.600751 :C20F1DD7: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-20 01:59:22.601536 :C20F1DDC:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-20 01:59:22.610450 :C20F1DDF:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-20 01:59:22.611 2025-08-20 01:59:22.610452 :C20F1DE0:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=4492 pso_num=28 pso_serial#=4 2025-08-20 01:59:22.610593 :C20F1DE1:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=4492 (legacy spawn) 2025-08-20 01:59:22.617038 :C20F1DE2: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-20 01:59:22.617215 :C20F1DEA: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-20 01:59:22.618020 :C20F1DEB:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-20 01:59:25.792041 :C20F1EDD:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-20 01:59:25.777 2025-08-20 01:59:25.792043 :C20F1EDE:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=21812 pso_num=28 pso_serial#=5 2025-08-20 01:59:25.792188 :C20F1EDF:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=21812 (legacy spawn) 2025-08-20 01:59:25.799185 :C20F1EE0: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-20 01:59:25.799364 :C20F1EE5: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-20 01:59:25.800211 :C20F1EEA:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-20 01:59:25.809360 :C20F1EED:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-20 01:59:25.809 2025-08-20 01:59:25.809362 :C20F1EEE:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=19996 pso_num=28 pso_serial#=6 2025-08-20 01:59:25.809507 :C20F1EEF:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=19996 (legacy spawn) 2025-08-20 01:59:25.816172 :C20F1EF0: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-20 01:59:25.816363 :C20F1EF9: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-20 01:59:25.817249 :C20F1EFA:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-20 01:59:26.255076 :C20F1F10:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-20 01:59:26.246 2025-08-20 01:59:26.255078 :C20F1F11:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=20068 pso_num=28 pso_serial#=7 2025-08-20 01:59:26.255214 :C20F1F12:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=20068 (legacy spawn) 2025-08-20 01:59:26.261727 :C20F1F13: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-20 01:59:26.261895 :C20F1F1C: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-20 01:59:26.262732 :C20F1F1D:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-20 01:59:34.948423 :C20F21C5:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-20 01:59:34.938 2025-08-20 01:59:34.948426 :C20F21C6:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=19680 pso_num=28 pso_serial#=8 2025-08-20 01:59:34.948568 :C20F21C7:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=19680 (legacy spawn) 2025-08-20 01:59:34.955608 :C20F21C8: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-20 01:59:34.955789 :C20F21CD: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-20 01:59:34.956745 :C20F21D2:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-20 02:00:53.942971 :C20F3D83:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-20 02:00:53.939 2025-08-20 02:00:53.942973 :C20F3D84:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=19788 pso_num=28 pso_serial#=9 2025-08-20 02:00:53.943110 :C20F3D85:db_trace:kso.c@4093:ksonfy(): [10420:28:0] kso: new process: pid=19788 osp_idx=26 osp_ver=246387 osp_pg=0 (spawn #506382) 2025-08-20 02:00:53.943111 :C20F3D86: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-20 02:00:53.943111 :C20F3D87:db_trace:kso.c@4103:ksonfy(): [10420:28:0] kso: new process: pso_index=28 reservation=208 time=40955940 2025-08-20 02:00:53.943111 :C20F3D88:db_trace:kso.c@4109:ksonfy(): [10420:28:0] kso: spawn diagnostics: queue time=0 secs 2025-08-20 02:00:53.943112 :C20F3D89:db_trace:kso.c@4111:ksonfy(): [10420:28:0] kso: spawn diagnostics: fork time=0 secs 2025-08-20 02:00:53.943112 :C20F3D8A:db_trace:kso.c@4113:ksonfy(): [10420:28:0] kso: spawn diagnostics: exec time=0 secs 2025-08-20 02:00:53.943112 :C20F3D8B:db_trace:kso.c@4115:ksonfy(): [10420:28:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-20 02:00:53.943113 :C20F3D8C:db_trace:kso.c@4117:ksonfy(): [10420:28:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-20 02:00:53.943619 :C20F3D8D: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-20 02:00:53.943666 :C20F3D93: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-20 02:00:53.951252 :C20F3DA1: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-20 02:00:53.952337 :C20F3DA9: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-20 02:00:53.952901 :C20F3DB1: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-20 02:00:53.953365 :C20F3DB9: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-20 02:00:53.953796 :C20F3DC1: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-20 02:00:53.956325 :C20F3DC9: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-20 02:00:53.957403 :C20F3DD1: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-20 02:00:54.008055 :C20F3DD9: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-20 02:00:54.008950 :C20F3DE1: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-20 02:00:54.009178 :C20F3DE9: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-20 02:00:54.009419 :C20F3DF1: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-20 02:00:54.011205 :C20F3DF9:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-20 03:01:01.361113 :C213E3A1:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-20 03:01:01.361 2025-08-20 03:01:01.361115 :C213E3A2:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=22324 pso_num=28 pso_serial#=10 2025-08-20 03:01:01.361250 :C213E3A3:db_trace:kso.c@4093:ksonfy(): [10420:28:0] kso: new process: pid=22324 osp_idx=26 osp_ver=246388 osp_pg=0 (spawn #506521) 2025-08-20 03:01:01.361251 :C213E3A4: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-20 03:01:01.361251 :C213E3A5:db_trace:kso.c@4103:ksonfy(): [10420:28:0] kso: new process: pso_index=28 reservation=209 time=44563362 2025-08-20 03:01:01.361251 :C213E3A6:db_trace:kso.c@4109:ksonfy(): [10420:28:0] kso: spawn diagnostics: queue time=0 secs 2025-08-20 03:01:01.361252 :C213E3A7:db_trace:kso.c@4111:ksonfy(): [10420:28:0] kso: spawn diagnostics: fork time=0 secs 2025-08-20 03:01:01.361252 :C213E3A8:db_trace:kso.c@4113:ksonfy(): [10420:28:0] kso: spawn diagnostics: exec time=0 secs 2025-08-20 03:01:01.361252 :C213E3A9:db_trace:kso.c@4115:ksonfy(): [10420:28:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-20 03:01:01.361253 :C213E3AA:db_trace:kso.c@4117:ksonfy(): [10420:28:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-20 03:01:01.361754 :C213E3AB: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-20 03:01:01.361795 :C213E3B1: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-20 03:01:01.369090 :C213E3BF: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-20 03:01:01.370147 :C213E3C7: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-20 03:01:01.370706 :C213E3CF: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-20 03:01:01.371251 :C213E3D7: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-20 03:01:01.371707 :C213E3DF: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-20 03:01:01.374153 :C213E3E7: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-20 03:01:01.375313 :C213E3EF: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-20 03:01:01.426009 :C213E3F7: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-20 03:01:01.426879 :C213E3FF: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-20 03:01:01.427116 :C213E407: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-20 03:01:01.427328 :C213E40F: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-20 03:01:01.429067 :C213E417:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-20 03:40:47.145093 :C216FEBA:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-20 03:40:47.135 2025-08-20 03:40:47.145095 :C216FEBB:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=22104 pso_num=28 pso_serial#=11 2025-08-20 03:40:47.145260 :C216FEBC:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=22104 (legacy spawn) 2025-08-20 03:40:47.151865 :C216FEBD: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-20 03:40:47.152040 :C216FEC3: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-20 03:40:47.152875 :C216FEC7:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-20 03:41:01.393736 :C2170309:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-20 03:41:01.385 2025-08-20 03:41:01.393738 :C217030A:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=22092 pso_num=28 pso_serial#=12 2025-08-20 03:41:01.393878 :C217030B:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=22092 (legacy spawn) 2025-08-20 03:41:01.400582 :C217030C: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-20 03:41:01.400779 :C2170312: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-20 03:41:01.401630 :C2170316:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-20 08:08:59.621784 :C22C1FE9:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-20 08:08:59.621 2025-08-20 08:08:59.621786 :C22C1FEA:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=18616 pso_num=28 pso_serial#=13 2025-08-20 08:08:59.621942 :C22C1FEB:db_trace:kso.c@4093:ksonfy(): [10420:28:0] kso: new process: pid=18616 osp_idx=26 osp_ver=246391 osp_pg=0 (spawn #507233) 2025-08-20 08:08:59.621942 :C22C1FEC: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-20 08:08:59.621943 :C22C1FED:db_trace:kso.c@4103:ksonfy(): [10420:28:0] kso: new process: pso_index=28 reservation=210 time=63041627 2025-08-20 08:08:59.621943 :C22C1FEE:db_trace:kso.c@4109:ksonfy(): [10420:28:0] kso: spawn diagnostics: queue time=0 secs 2025-08-20 08:08:59.621944 :C22C1FEF:db_trace:kso.c@4111:ksonfy(): [10420:28:0] kso: spawn diagnostics: fork time=0 secs 2025-08-20 08:08:59.621944 :C22C1FF0:db_trace:kso.c@4113:ksonfy(): [10420:28:0] kso: spawn diagnostics: exec time=0 secs 2025-08-20 08:08:59.621945 :C22C1FF1:db_trace:kso.c@4115:ksonfy(): [10420:28:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-20 08:08:59.621945 :C22C1FF2:db_trace:kso.c@4117:ksonfy(): [10420:28:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-20 08:08:59.622888 :C22C1FF3: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-20 08:08:59.622933 :C22C1FF9: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-20 08:08:59.727610 :C22C202B:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-20 08:09:01.093236 :C22C2078:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-20 08:09:01.084 2025-08-20 08:09:01.093239 :C22C2079:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=21804 pso_num=28 pso_serial#=14 2025-08-20 08:09:01.093385 :C22C207A:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=21804 (legacy spawn) 2025-08-20 08:09:01.100468 :C22C207B: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-20 08:09:01.100637 :C22C2080: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-20 08:09:01.101511 :C22C2085:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-20 08:09:01.850084 :C22C2145:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-20 08:09:01.850 2025-08-20 08:09:01.850086 :C22C2146:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=16692 pso_num=28 pso_serial#=15 2025-08-20 08:09:01.850217 :C22C2147:db_trace:kso.c@4093:ksonfy(): [10420:28:0] kso: new process: pid=16692 osp_idx=26 osp_ver=246393 osp_pg=0 (spawn #507235) 2025-08-20 08:09:01.850217 :C22C2148: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-20 08:09:01.850218 :C22C2149:db_trace:kso.c@4103:ksonfy(): [10420:28:0] kso: new process: pso_index=28 reservation=211 time=63043846 2025-08-20 08:09:01.850218 :C22C214A:db_trace:kso.c@4109:ksonfy(): [10420:28:0] kso: spawn diagnostics: queue time=0 secs 2025-08-20 08:09:01.850218 :C22C214B:db_trace:kso.c@4111:ksonfy(): [10420:28:0] kso: spawn diagnostics: fork time=0 secs 2025-08-20 08:09:01.850219 :C22C214C:db_trace:kso.c@4113:ksonfy(): [10420:28:0] kso: spawn diagnostics: exec time=0 secs 2025-08-20 08:09:01.850219 :C22C214D:db_trace:kso.c@4115:ksonfy(): [10420:28:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-20 08:09:01.850219 :C22C214E:db_trace:kso.c@4117:ksonfy(): [10420:28:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-20 08:09:01.850729 :C22C214F: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-20 08:09:01.850770 :C22C2155: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 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 28 (osid: 16692, M002)