Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250907100611\orcl_w000_24308_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250907100611\orcl_w000_24308_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:34942M/63366M, Ph+PgF:39749M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 26 Windows thread id: 24308, image: ORACLE.EXE (W000) *** 2025-09-07 10:06:11.791 *** SESSION ID:(209.41023) 2025-09-07 10:06:11.791 *** 2025-09-07 10:06:11.791 Process diagnostic dump for ORACLE.EXE (W000), OS id=24308, pid: 26, proc_ser: 145, sid: 209, sess_ser: 41023 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=91 seq_num=92 snap_id=1 wait times: snap=2.749100 sec, exc=2.749100 sec, total=2.749100 sec wait times: max=5.000000 sec, heur=7 min 33 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.000025 sec since current wait 0: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=90 seq_num=91 snap_id=1 wait times: snap=5.000940 sec, exc=5.000940 sec, total=5.000940 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000026 sec of elapsed time 1: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=89 seq_num=90 snap_id=1 wait times: snap=5.004633 sec, exc=5.004633 sec, total=5.004633 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000020 sec of elapsed time 2: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=88 seq_num=89 snap_id=1 wait times: snap=5.007247 sec, exc=5.007247 sec, total=5.007247 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000024 sec of elapsed time 3: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=87 seq_num=88 snap_id=1 wait times: snap=5.001289 sec, exc=5.001289 sec, total=5.001289 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000026 sec of elapsed time 4: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=86 seq_num=87 snap_id=1 wait times: snap=5.000577 sec, exc=5.000577 sec, total=5.000577 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000032 sec of elapsed time 5: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=85 seq_num=86 snap_id=1 wait times: snap=5.000416 sec, exc=5.000416 sec, total=5.000416 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000027 sec of elapsed time 6: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=84 seq_num=85 snap_id=1 wait times: snap=5.014476 sec, exc=5.014476 sec, total=5.014476 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000026 sec of elapsed time 7: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=83 seq_num=84 snap_id=1 wait times: snap=5.004621 sec, exc=5.004621 sec, total=5.004621 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000024 sec of elapsed time 8: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=82 seq_num=83 snap_id=1 wait times: snap=5.014762 sec, exc=5.014762 sec, total=5.014762 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000026 sec of elapsed time 9: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=81 seq_num=82 snap_id=1 wait times: snap=5.004644 sec, exc=5.004644 sec, total=5.004644 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000022 sec of elapsed time Sampled Session History of session 209 serial 41023 --------------------------------------------------- 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 --------------------------------------------------- [121 samples, 10:04:11 - 10:06:11] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-09-07 10:06:11.791 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 26 (osid: 24308, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-09-07 08:46:36.074313 :CA21B4A5:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-09-07 08:46:36.075128 :CA21B4A6:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-07 08:46:36.077437 :CA21B4A9:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-07 08:46:36.075 2025-09-07 08:46:36.077439 :CA21B4AA:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12108 pso_num=26 pso_serial#=125 2025-09-07 08:46:36.077574 :CA21B4AB:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=12108 (legacy spawn) 2025-09-07 08:46:36.084163 :CA21B4AC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 08:46:36.084341 :CA21B4B5:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-09-07 08:46:36.085315 :CA21B4B6:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-07 08:46:36.094406 :CA21B4B9:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-07 08:46:36.090 2025-09-07 08:46:36.094408 :CA21B4BA:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=22564 pso_num=26 pso_serial#=126 2025-09-07 08:46:36.094553 :CA21B4BB:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=22564 (legacy spawn) 2025-09-07 08:46:36.107715 :CA21B4BC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 08:46:36.107890 :CA21B4C5:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-09-07 08:46:36.108842 :CA21B4C6:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-07 08:46:39.198249 :CA21B5B0:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-07 08:46:39.185 2025-09-07 08:46:39.198250 :CA21B5B1:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=23876 pso_num=26 pso_serial#=127 2025-09-07 08:46:39.198389 :CA21B5B2:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=23876 (legacy spawn) 2025-09-07 08:46:39.204909 :CA21B5B3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 08:46:39.205077 :CA21B5BC:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-09-07 08:46:39.205888 :CA21B5BD:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-07 08:46:39.214636 :CA21B5C0:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-07 08:46:39.200 2025-09-07 08:46:39.214638 :CA21B5C1:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=20984 pso_num=26 pso_serial#=128 2025-09-07 08:46:39.214774 :CA21B5C2:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=20984 (legacy spawn) 2025-09-07 08:46:39.221464 :CA21B5C3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 08:46:39.221625 :CA21B5CC:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-09-07 08:46:39.222586 :CA21B5CD:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-07 08:46:46.654450 :CA21B81C:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-07 08:46:46.646 2025-09-07 08:46:46.654452 :CA21B81D:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=17604 pso_num=26 pso_serial#=129 2025-09-07 08:46:46.654578 :CA21B81E:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=17604 (legacy spawn) 2025-09-07 08:46:46.661720 :CA21B81F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 08:46:46.661887 :CA21B824:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-09-07 08:46:46.662688 :CA21B829:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-07 08:47:44.256717 :CA21CA91:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-07 08:47:44.247 2025-09-07 08:47:44.256719 :CA21CA92:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=24208 pso_num=26 pso_serial#=130 2025-09-07 08:47:44.256862 :CA21CA93:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=24208 (legacy spawn) 2025-09-07 08:47:44.263701 :CA21CAA0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 08:47:44.263894 :CA21CAA5:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-09-07 08:47:44.264757 :CA21CAAA:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-07 08:47:48.498840 :CA21CBE8:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-07 08:47:48.484 2025-09-07 08:47:48.498842 :CA21CBE9:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=24216 pso_num=26 pso_serial#=131 2025-09-07 08:47:48.498981 :CA21CBEA:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=24216 (legacy spawn) 2025-09-07 08:47:48.505432 :CA21CBEB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 08:47:48.505613 :CA21CBF4:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-09-07 08:47:48.506404 :CA21CBF5:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-07 08:47:48.515062 :CA21CBF8:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-07 08:47:48.499 2025-09-07 08:47:48.515064 :CA21CBF9:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=7652 pso_num=26 pso_serial#=132 2025-09-07 08:47:48.515192 :CA21CBFA:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=7652 (legacy spawn) 2025-09-07 08:47:48.521706 :CA21CC22:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 08:47:48.521867 :CA21CC2B:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-09-07 08:47:48.522696 :CA21CC2C:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-07 08:47:48.837167 :CA21CC2F:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-07 08:47:48.828 2025-09-07 08:47:48.837169 :CA21CC30:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=22972 pso_num=26 pso_serial#=133 2025-09-07 08:47:48.837314 :CA21CC31:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=22972 (legacy spawn) 2025-09-07 08:47:48.844057 :CA21CC32:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 08:47:48.844223 :CA21CC37:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-09-07 08:47:48.845138 :CA21CC3C:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-07 08:47:51.684985 :CA21CD2C:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-07 08:47:51.672 2025-09-07 08:47:51.684987 :CA21CD2D:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=23072 pso_num=26 pso_serial#=134 2025-09-07 08:47:51.685132 :CA21CD2E:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=23072 (legacy spawn) 2025-09-07 08:47:51.704885 :CA21CD2F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 08:47:51.705054 :CA21CD34:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-09-07 08:47:51.705959 :CA21CD39:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-07 08:47:51.714666 :CA21CD3C:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-07 08:47:51.703 2025-09-07 08:47:51.714667 :CA21CD3D:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=23680 pso_num=26 pso_serial#=135 2025-09-07 08:47:51.714805 :CA21CD3E:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=23680 (legacy spawn) 2025-09-07 08:47:51.721348 :CA21CD3F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 08:47:51.721508 :CA21CD48:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-09-07 08:47:51.722319 :CA21CD49:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-07 08:48:28.113114 :CA21D90A:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-07 08:48:28.100 2025-09-07 08:48:28.113116 :CA21D90B:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=21304 pso_num=26 pso_serial#=136 2025-09-07 08:48:28.113253 :CA21D90C:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=21304 (legacy spawn) 2025-09-07 08:48:28.119739 :CA21D90D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 08:48:28.119935 :CA21D912:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-09-07 08:48:28.120754 :CA21D917:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-07 08:48:28.129402 :CA21D91A:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-07 08:48:28.115 2025-09-07 08:48:28.129404 :CA21D91B:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=23064 pso_num=26 pso_serial#=137 2025-09-07 08:48:28.129538 :CA21D91C:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=23064 (legacy spawn) 2025-09-07 08:48:28.135977 :CA21D91D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 08:48:28.136139 :CA21D926:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-09-07 08:48:28.136940 :CA21D927:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-07 08:48:30.043419 :CA21D9EF:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-07 08:48:30.039 2025-09-07 08:48:30.043421 :CA21D9F0:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=23716 pso_num=26 pso_serial#=138 2025-09-07 08:48:30.043562 :CA21D9F1:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=23716 osp_idx=24 osp_ver=804928 osp_pg=0 (spawn #567339) 2025-09-07 08:48:30.043563 :CA21D9F2:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-07 08:48:30.043563 :CA21D9F3:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=38 time=1620561346 2025-09-07 08:48:30.043564 :CA21D9F4:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-09-07 08:48:30.043564 :CA21D9F5:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-09-07 08:48:30.043564 :CA21D9F6:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-09-07 08:48:30.043565 :CA21D9F7:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-07 08:48:30.043565 :CA21D9F8:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-07 08:48:30.044069 :CA21D9F9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-07 08:48:30.044116 :CA21DA00:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-09-07 08:58:30.781328 :CA229E84:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-07 08:58:31.192361 :CA229EDB:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-07 08:58:31.188 2025-09-07 08:58:31.192363 :CA229EDC:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=24416 pso_num=26 pso_serial#=139 2025-09-07 08:58:31.192516 :CA229EDD:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=24416 osp_idx=24 osp_ver=804929 osp_pg=0 (spawn #567363) 2025-09-07 08:58:31.192519 :CA229EDE:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-07 08:58:31.192519 :CA229EDF:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=39 time=1621162502 2025-09-07 08:58:31.192519 :CA229EE0:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-09-07 08:58:31.192520 :CA229EE1:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-09-07 08:58:31.192520 :CA229EE2:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-09-07 08:58:31.192520 :CA229EE3:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-07 08:58:31.192521 :CA229EE4:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-07 08:58:31.193029 :CA229EE5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-07 08:58:31.193075 :CA229EEC:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-09-07 09:08:32.091625 :CA236D9B:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-07 09:08:32.115294 :CA236D9E:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-07 09:08:32.107 2025-09-07 09:08:32.115297 :CA236D9F:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=24088 pso_num=26 pso_serial#=140 2025-09-07 09:08:32.115434 :CA236DA0:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=24088 (legacy spawn) 2025-09-07 09:08:32.121905 :CA236DA1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 09:08:32.122076 :CA236DA6:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-09-07 09:08:32.122883 :CA236DAB:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-07 09:08:32.361979 :CA236DE9:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-07 09:08:32.357 2025-09-07 09:08:32.361981 :CA236DEA:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=18680 pso_num=26 pso_serial#=141 2025-09-07 09:08:32.362120 :CA236DEB:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=18680 osp_idx=24 osp_ver=804931 osp_pg=0 (spawn #567389) 2025-09-07 09:08:32.362120 :CA236DEC:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-07 09:08:32.362121 :CA236DED:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=40 time=1621763674 2025-09-07 09:08:32.362121 :CA236DEE:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-09-07 09:08:32.362122 :CA236DEF:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-09-07 09:08:32.362122 :CA236DF0:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-09-07 09:08:32.362122 :CA236DF1:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-07 09:08:32.362123 :CA236DF2:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-07 09:08:32.362722 :CA236DF3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-07 09:08:32.362768 :CA236DFA:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-09-07 09:18:33.184216 :CA24330E:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-07 09:18:33.485807 :CA243348:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-07 09:18:33.480 2025-09-07 09:18:33.485809 :CA243349:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=22072 pso_num=26 pso_serial#=142 2025-09-07 09:18:33.485971 :CA24334A:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=22072 osp_idx=24 osp_ver=804932 osp_pg=0 (spawn #567411) 2025-09-07 09:18:33.485971 :CA24334B:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-07 09:18:33.485972 :CA24334C:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=41 time=1622364783 2025-09-07 09:18:33.485972 :CA24334D:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-09-07 09:18:33.485973 :CA24334E:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-09-07 09:18:33.485973 :CA24334F:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-09-07 09:18:33.485973 :CA243350:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-07 09:18:33.485973 :CA243351:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-07 09:18:33.486473 :CA243352:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-07 09:18:33.486516 :CA24335B:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-09-07 09:19:48.577119 :CA244EB8:db_trace:ksl2.c@2477:kslwtbctx(): [10005:26:209] KSL WAIT BEG [latch free] 136537728/0x8236680 259/0x103 0/0x0 wait_id=16 seq_num=17 snap_id=1 2025-09-07 09:19:48.577157 :CA244EBD:db_trace:ksl2.c@2611:kslwtectx(): [10005:26:209] KSL WAIT END [latch free] 136537728/0x8236680 259/0x103 0/0x0 wait_id=16 seq_num=17 snap_id=1 2025-09-07 09:19:48.577159 :CA244EBE:db_trace:ksl2.c@2619:kslwtectx(): [10005:26:209] KSL WAIT END wait times (usecs) - snap=39, exc=39, tot=39 2025-09-07 09:28:34.350120 :CA24FAF8:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-07 09:28:34.698699 :CA24FB35:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-07 09:28:34.694 2025-09-07 09:28:34.698701 :CA24FB36:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=22040 pso_num=26 pso_serial#=143 2025-09-07 09:28:34.698844 :CA24FB37:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=22040 osp_idx=24 osp_ver=804933 osp_pg=0 (spawn #567434) 2025-09-07 09:28:34.698845 :CA24FB38:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-07 09:28:34.698845 :CA24FB39:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=42 time=1622966002 2025-09-07 09:28:34.698845 :CA24FB3A:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-09-07 09:28:34.698846 :CA24FB3B:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-09-07 09:28:34.698846 :CA24FB3C:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-09-07 09:28:34.698846 :CA24FB3D:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-07 09:28:34.698847 :CA24FB3E:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-07 09:28:34.699361 :CA24FB3F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-07 09:28:34.699405 :CA24FB48:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-09-07 09:38:35.524687 :CA25C269:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-07 09:38:35.945892 :CA25C2C9:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-07 09:38:35.940 2025-09-07 09:38:35.945894 :CA25C2CA:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=21176 pso_num=26 pso_serial#=144 2025-09-07 09:38:35.946045 :CA25C2CB:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=21176 osp_idx=24 osp_ver=804934 osp_pg=0 (spawn #567457) 2025-09-07 09:38:35.946046 :CA25C2CC:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-07 09:38:35.946046 :CA25C2CD:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=43 time=1623567252 2025-09-07 09:38:35.946046 :CA25C2CE:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-09-07 09:38:35.946047 :CA25C2CF:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-09-07 09:38:35.946047 :CA25C2D0:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-09-07 09:38:35.946047 :CA25C2D1:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-07 09:38:35.946048 :CA25C2D2:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-07 09:38:35.946560 :CA25C2D3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-07 09:38:35.946605 :CA25C2DB:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-09-07 09:39:14.928016 :CA25CFCB:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=16 loc='ksl2.h LINE:2165 ID:kslpsr' id1=255 id2=0 name=EV type=0 fac#=0 facpost=1 2025-09-07 09:48:37.255272 :CA268B8E:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=23 loc='ksl2.h LINE:2165 ID:kslpsr' id1=255 id2=0 name=EV type=0 fac#=0 facpost=1 2025-09-07 09:58:37.968335 :CA27515D:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-07 09:58:38.488656 :CA2751C1:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-07 09:58:38.484 2025-09-07 09:58:38.488658 :CA2751C2:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=24308 pso_num=26 pso_serial#=145 2025-09-07 09:58:38.488797 :CA2751C3:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=24308 osp_idx=24 osp_ver=804935 osp_pg=0 (spawn #567501) 2025-09-07 09:58:38.488798 :CA2751C4:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-07 09:58:38.488798 :CA2751C5:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=44 time=1624769799 2025-09-07 09:58:38.488798 :CA2751C6:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-09-07 09:58:38.488799 :CA2751C7:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-09-07 09:58:38.488799 :CA2751C8:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-09-07 09:58:38.488800 :CA2751C9:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-07 09:58:38.488800 :CA2751CA:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-07 09:58:38.489295 :CA2751CB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-07 09:58:38.489341 :CA2751D1:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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 26 (osid: 24308, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de