Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250808220010\orcl_w000_18288_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:35650M/63366M, Ph+PgF:41152M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 25 Windows thread id: 18288, image: ORACLE.EXE (W000) *** 2025-08-08 22:00:10.556 *** SESSION ID:(201.54759) 2025-08-08 22:00:10.556 *** 2025-08-08 22:00:10.556 Process diagnostic dump for ORACLE.EXE (W000), OS id=18288, pid: 25, proc_ser: 177, sid: 201, sess_ser: 54759 ------------------------------------------------------------------------------- current sql: Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=12 seq_num=13 snap_id=1 wait times: snap=4.065973 sec, exc=4.065973 sec, total=4.065973 sec wait times: max=5.000000 sec, heur=59.113689 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.000020 sec since current wait 0: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=11 seq_num=12 snap_id=1 wait times: snap=5.000295 sec, exc=5.000295 sec, total=5.000295 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000023 sec of elapsed time 1: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=10 seq_num=11 snap_id=1 wait times: snap=5.003005 sec, exc=5.003005 sec, total=5.003005 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000028 sec of elapsed time 2: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=9 seq_num=10 snap_id=1 wait times: snap=5.005274 sec, exc=5.005274 sec, total=5.005274 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000027 sec of elapsed time 3: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=8 seq_num=9 snap_id=1 wait times: snap=5.014719 sec, exc=5.014719 sec, total=5.014719 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000021 sec of elapsed time 4: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=7 seq_num=8 snap_id=1 wait times: snap=5.004622 sec, exc=5.004622 sec, total=5.004622 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000021 sec of elapsed time 5: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=6 seq_num=7 snap_id=1 wait times: snap=5.009715 sec, exc=5.009715 sec, total=5.009715 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000022 sec of elapsed time 6: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=5 seq_num=6 snap_id=1 wait times: snap=5.003228 sec, exc=5.003228 sec, total=5.003228 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000024 sec of elapsed time 7: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=4 seq_num=5 snap_id=1 wait times: snap=5.000453 sec, exc=5.000453 sec, total=5.000453 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000023 sec of elapsed time 8: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=3 seq_num=4 snap_id=1 wait times: snap=5.002457 sec, exc=5.002457 sec, total=5.002457 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000025 sec of elapsed time 9: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=2 seq_num=3 snap_id=1 wait times: snap=5.008956 sec, exc=5.008956 sec, total=5.008956 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000020 sec of elapsed time Sampled Session History of session 201 serial 54759 --------------------------------------------------- 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 --------------------------------------------------- [60 samples, 21:59:11 - 22:00:10] idle wait at each sample [session created at: 21:59:11] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-08-08 22:00:10.556 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 25 (osid: 18288, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-08-08 21:55:21.748511 :BD293DFF:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-08 21:55:26.893674 :BD293FAA:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-08 21:55:26.879 2025-08-08 21:55:26.893676 :BD293FAB:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=20760 pso_num=25 pso_serial#=150 2025-08-08 21:55:26.893813 :BD293FAC:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=20760 (legacy spawn) 2025-08-08 21:55:26.911916 :BD293FAD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-08 21:55:26.912090 :BD293FB6:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-08 21:55:26.912946 :BD293FB7:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-08 21:55:26.921780 :BD293FBA:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-08 21:55:26.910 2025-08-08 21:55:26.921782 :BD293FBB:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=19040 pso_num=25 pso_serial#=151 2025-08-08 21:55:26.921915 :BD293FBC:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=19040 (legacy spawn) 2025-08-08 21:55:26.928595 :BD293FBD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-08 21:55:26.928759 :BD293FC6:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-08 21:55:26.929573 :BD293FC7:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-08 21:55:28.090597 :BD293FE1:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-08 21:55:28.082 2025-08-08 21:55:28.090599 :BD293FE2:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=10320 pso_num=25 pso_serial#=152 2025-08-08 21:55:28.090739 :BD293FE3:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=10320 (legacy spawn) 2025-08-08 21:55:28.097245 :BD293FE4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-08 21:55:28.097416 :BD293FE9:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-08 21:55:28.098272 :BD293FEE:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-08 21:55:29.970454 :BD2940E6:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-08 21:55:29.957 2025-08-08 21:55:29.970456 :BD2940E7:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=20808 pso_num=25 pso_serial#=153 2025-08-08 21:55:29.970599 :BD2940E8:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=20808 (legacy spawn) 2025-08-08 21:55:29.977102 :BD2940E9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-08 21:55:29.977268 :BD2940EE:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-08 21:55:29.978068 :BD2940F3:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-08 21:55:29.994965 :BD2940F6:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-08 21:55:29.989 2025-08-08 21:55:29.994967 :BD2940F7:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=20232 pso_num=25 pso_serial#=154 2025-08-08 21:55:29.995107 :BD2940F8:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=20232 (legacy spawn) 2025-08-08 21:55:30.001660 :BD2940F9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-08 21:55:30.001827 :BD294102:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-08 21:55:30.002609 :BD294103:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-08 21:56:06.217883 :BD294C6A:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-08 21:56:06.205 2025-08-08 21:56:06.217885 :BD294C6B:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=208 pso_num=25 pso_serial#=155 2025-08-08 21:56:06.218051 :BD294C6C:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=208 (legacy spawn) 2025-08-08 21:56:06.224426 :BD294C6D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-08 21:56:06.224589 :BD294C72:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-08 21:56:06.225426 :BD294C77:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-08 21:56:06.234138 :BD294C7A:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-08 21:56:06.221 2025-08-08 21:56:06.234140 :BD294C7B:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=19488 pso_num=25 pso_serial#=156 2025-08-08 21:56:06.234277 :BD294C7C:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=19488 (legacy spawn) 2025-08-08 21:56:06.240807 :BD294C7D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-08 21:56:06.240973 :BD294C86:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-08 21:56:06.241807 :BD294C87:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-08 21:56:30.138763 :BD2953C6:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-08 21:56:30.129 2025-08-08 21:56:30.138765 :BD2953C7:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=13660 pso_num=25 pso_serial#=157 2025-08-08 21:56:30.138901 :BD2953C8:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=13660 (legacy spawn) 2025-08-08 21:56:30.145392 :BD2953C9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-08 21:56:30.145565 :BD2953CE:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-08 21:56:30.146352 :BD2953D3:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-08 21:56:30.277975 :BD2953D6:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-08 21:56:30.270 2025-08-08 21:56:30.277977 :BD2953D7:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=21096 pso_num=25 pso_serial#=158 2025-08-08 21:56:30.278114 :BD2953D8:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=21096 (legacy spawn) 2025-08-08 21:56:30.284633 :BD2953D9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-08 21:56:30.284797 :BD2953E2:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-08 21:56:30.285663 :BD2953E3:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-08 21:56:39.479929 :BD2956AB:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-08 21:56:39.465 2025-08-08 21:56:39.479931 :BD2956AC:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=16664 pso_num=25 pso_serial#=159 2025-08-08 21:56:39.480074 :BD2956AD:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=16664 (legacy spawn) 2025-08-08 21:56:39.486582 :BD2956AE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-08 21:56:39.486755 :BD2956B3:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-08 21:56:39.497394 :BD2956C4:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-08 21:56:39.506008 :BD2956C7:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-08 21:56:39.497 2025-08-08 21:56:39.506010 :BD2956C8:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=1852 pso_num=25 pso_serial#=160 2025-08-08 21:56:39.506141 :BD2956C9:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=1852 (legacy spawn) 2025-08-08 21:56:39.512651 :BD2956CA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-08 21:56:39.512819 :BD2956D1:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-08 21:56:39.513645 :BD2956D4:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-08 21:56:42.697388 :BD2957B3:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-08 21:56:42.684 2025-08-08 21:56:42.697390 :BD2957B4:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=21076 pso_num=25 pso_serial#=161 2025-08-08 21:56:42.697526 :BD2957B5:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=21076 (legacy spawn) 2025-08-08 21:56:42.703938 :BD2957B6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-08 21:56:42.704109 :BD2957BB:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-08 21:56:42.704878 :BD2957C0:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-08 21:56:42.713628 :BD2957C3:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-08 21:56:42.700 2025-08-08 21:56:42.713630 :BD2957C4:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=19824 pso_num=25 pso_serial#=162 2025-08-08 21:56:42.713767 :BD2957C5:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=19824 (legacy spawn) 2025-08-08 21:56:42.720234 :BD2957C6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-08 21:56:42.720396 :BD2957CF:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-08 21:56:42.721187 :BD2957D0:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-08 21:57:15.777705 :BD296242:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-08 21:57:15.763 2025-08-08 21:57:15.777707 :BD296243:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=12684 pso_num=25 pso_serial#=163 2025-08-08 21:57:15.777859 :BD296244:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=12684 (legacy spawn) 2025-08-08 21:57:15.784328 :BD296245:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-08 21:57:15.784359 :BD296248:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-08 21:57:15.784517 :BD29624B:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-08 21:57:15.785319 :BD29625C:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-08 21:57:15.794141 :BD29625F:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-08 21:57:15.794 2025-08-08 21:57:15.794142 :BD296260:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=19024 pso_num=25 pso_serial#=164 2025-08-08 21:57:15.794281 :BD296261:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=19024 (legacy spawn) 2025-08-08 21:57:15.800744 :BD296262:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-08 21:57:15.800911 :BD29626B:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-08 21:57:15.801687 :BD29626C:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-08 21:57:18.969112 :BD296344:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-08 21:57:18.955 2025-08-08 21:57:18.969115 :BD296345:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=20260 pso_num=25 pso_serial#=165 2025-08-08 21:57:18.969258 :BD296346:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=20260 (legacy spawn) 2025-08-08 21:57:18.988108 :BD296347:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-08 21:57:18.988286 :BD29634C:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-08 21:57:18.989220 :BD296351:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-08 21:57:18.998283 :BD296354:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-08 21:57:18.986 2025-08-08 21:57:18.998285 :BD296355:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=20460 pso_num=25 pso_serial#=166 2025-08-08 21:57:18.998426 :BD296356:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=20460 (legacy spawn) 2025-08-08 21:57:19.005114 :BD296357:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-08 21:57:19.005282 :BD296360:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-08 21:57:19.006108 :BD296361:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-08 21:57:32.451784 :BD29678C:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-08 21:57:32.443 2025-08-08 21:57:32.451786 :BD29678D:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=20872 pso_num=25 pso_serial#=167 2025-08-08 21:57:32.451934 :BD29678E:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=20872 (legacy spawn) 2025-08-08 21:57:32.458419 :BD29678F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-08 21:57:32.458589 :BD296798:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-08 21:57:32.459463 :BD296799:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-08 21:58:12.321117 :BD297472:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-08 21:58:12.312 2025-08-08 21:58:12.321119 :BD297473:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=2964 pso_num=25 pso_serial#=168 2025-08-08 21:58:12.321259 :BD297474:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=2964 (legacy spawn) 2025-08-08 21:58:12.327719 :BD297475:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-08 21:58:12.327883 :BD29747A:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-08 21:58:12.328695 :BD29747F:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-08 21:58:28.369667 :BD2978F3:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-08 21:58:28.354 2025-08-08 21:58:28.369669 :BD2978F4:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=3328 pso_num=25 pso_serial#=169 2025-08-08 21:58:28.369810 :BD2978F5:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=3328 (legacy spawn) 2025-08-08 21:58:28.376584 :BD2978F6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-08 21:58:28.376764 :BD2978FB:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-08 21:58:28.377583 :BD297900:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-08 21:58:28.386635 :BD297903:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-08 21:58:28.386 2025-08-08 21:58:28.386637 :BD297904:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=18744 pso_num=25 pso_serial#=170 2025-08-08 21:58:28.386785 :BD297905:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=18744 (legacy spawn) 2025-08-08 21:58:28.393516 :BD297906:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-08 21:58:28.393704 :BD29790F:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-08 21:58:28.394619 :BD297910:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-08 21:58:31.845628 :BD297A08:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-08 21:58:31.843 2025-08-08 21:58:31.845631 :BD297A09:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=7196 pso_num=25 pso_serial#=171 2025-08-08 21:58:31.845795 :BD297A0A:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=7196 (legacy spawn) 2025-08-08 21:58:31.852836 :BD297A0B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-08 21:58:31.853033 :BD297A10:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-08 21:58:31.853953 :BD297A15:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-08 21:58:31.863516 :BD297A18:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-08 21:58:31.859 2025-08-08 21:58:31.863517 :BD297A19:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=20792 pso_num=25 pso_serial#=172 2025-08-08 21:58:31.863657 :BD297A1A:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=20792 (legacy spawn) 2025-08-08 21:58:31.870669 :BD297A1B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-08 21:58:31.870702 :BD297A1E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-08 21:58:31.870853 :BD297A25:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-08 21:58:31.871769 :BD297A32:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-08 21:59:04.983347 :BD2984DB:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-08 21:59:04.968 2025-08-08 21:59:04.983348 :BD2984DC:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=21200 pso_num=25 pso_serial#=173 2025-08-08 21:59:04.983485 :BD2984DD:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=21200 (legacy spawn) 2025-08-08 21:59:04.990046 :BD2984DE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-08 21:59:04.990234 :BD2984E3:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-08 21:59:04.991106 :BD2984E8:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-08 21:59:05.007479 :BD2984EB:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-08 21:59:04.999 2025-08-08 21:59:05.007481 :BD2984EC:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=21092 pso_num=25 pso_serial#=174 2025-08-08 21:59:05.007623 :BD2984ED:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=21092 (legacy spawn) 2025-08-08 21:59:05.014454 :BD2984EE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-08 21:59:05.014628 :BD2984F7:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-08 21:59:05.015603 :BD2984F8:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-08 21:59:08.194770 :BD2985E8:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-08 21:59:08.181 2025-08-08 21:59:08.194772 :BD2985E9:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=20720 pso_num=25 pso_serial#=175 2025-08-08 21:59:08.194906 :BD2985EA:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=20720 (legacy spawn) 2025-08-08 21:59:08.201376 :BD2985EB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-08 21:59:08.201560 :BD2985F0:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-08 21:59:08.202321 :BD2985F5:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-08 21:59:08.211030 :BD2985F8:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-08 21:59:08.197 2025-08-08 21:59:08.211032 :BD2985F9:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=20336 pso_num=25 pso_serial#=176 2025-08-08 21:59:08.211167 :BD2985FA:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=20336 (legacy spawn) 2025-08-08 21:59:08.217629 :BD2985FB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-08 21:59:08.217794 :BD298604:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-08 21:59:08.218615 :BD298605:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-08 21:59:11.440438 :BD29873A:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-08 21:59:11.436 2025-08-08 21:59:11.440440 :BD29873B:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=18288 pso_num=25 pso_serial#=177 2025-08-08 21:59:11.440579 :BD29873C:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=18288 osp_idx=23 osp_ver=232849 osp_pg=0 (spawn #469142) 2025-08-08 21:59:11.440580 :BD29873D:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-08 21:59:11.440580 :BD29873E:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=88 time=3371020751 2025-08-08 21:59:11.440581 :BD29873F:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-08 21:59:11.440581 :BD298740:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-08 21:59:11.440582 :BD298741:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-08 21:59:11.440582 :BD298742:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-08 21:59:11.440582 :BD298743:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-08 21:59:11.441081 :BD298744:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-08 21:59:11.441138 :BD29874E:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=23 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 25 (osid: 18288, W000)