Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250905222022\orcl_w000_22696_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250905222022\orcl_w000_22696_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:35036M/63366M, Ph+PgF:39898M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 22 Windows thread id: 22696, image: ORACLE.EXE (W000) *** 2025-09-05 22:20:22.303 *** SESSION ID:(177.65187) 2025-09-05 22:20:22.303 *** 2025-09-05 22:20:22.303 Process diagnostic dump for ORACLE.EXE (W000), OS id=22696, pid: 22, proc_ser: 6, sid: 177, sess_ser: 65187 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=72 seq_num=73 snap_id=1 wait times: snap=2.710465 sec, exc=2.710465 sec, total=2.710465 sec wait times: max=5.000000 sec, heur=5 min 58 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.000032 sec since current wait 0: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=71 seq_num=72 snap_id=1 wait times: snap=5.001367 sec, exc=5.001367 sec, total=5.001367 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000031 sec of elapsed time 1: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=70 seq_num=71 snap_id=1 wait times: snap=5.004629 sec, exc=5.004629 sec, total=5.004629 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000036 sec of elapsed time 2: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=69 seq_num=70 snap_id=1 wait times: snap=5.004606 sec, exc=5.004606 sec, total=5.004606 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000037 sec of elapsed time 3: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=68 seq_num=69 snap_id=1 wait times: snap=5.001697 sec, exc=5.001697 sec, total=5.001697 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000032 sec of elapsed time 4: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=67 seq_num=68 snap_id=1 wait times: snap=5.001130 sec, exc=5.001130 sec, total=5.001130 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000038 sec of elapsed time 5: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=66 seq_num=67 snap_id=1 wait times: snap=5.000458 sec, exc=5.000458 sec, total=5.000458 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000031 sec of elapsed time 6: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=65 seq_num=66 snap_id=1 wait times: snap=5.000387 sec, exc=5.000387 sec, total=5.000387 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000035 sec of elapsed time 7: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=64 seq_num=65 snap_id=1 wait times: snap=5.000950 sec, exc=5.000950 sec, total=5.000950 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000038 sec of elapsed time 8: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=63 seq_num=64 snap_id=1 wait times: snap=5.012424 sec, exc=5.012424 sec, total=5.012424 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=62 seq_num=63 snap_id=1 wait times: snap=5.014723 sec, exc=5.014723 sec, total=5.014723 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000029 sec of elapsed time Sampled Session History of session 177 serial 65187 --------------------------------------------------- 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, 22:18:22 - 22:20:22] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-09-05 22:20:22.303 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 22 (osid: 22696, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-09-05 19:54:06.983700 :C97420C7:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-05 19:54:06.983701 :C97420C8:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-05 19:54:06.984231 :C97420C9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-05 19:54:06.984282 :C97420D2:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-05 20:04:07.840082 :C974EB79:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-09-05 20:04:08.188680 :C974EBBF:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 09-05 20:04:08.183 2025-09-05 20:04:08.188682 :C974EBC0:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=21560 pso_num=22 pso_serial#=247 2025-09-05 20:04:08.188819 :C974EBC1:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=21560 osp_idx=0 osp_ver=579934 osp_pg=0 (spawn #562215) 2025-09-05 20:04:08.188819 :C974EBC2:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-05 20:04:08.188820 :C974EBC3:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=162 time=1488299487 2025-09-05 20:04:08.188820 :C974EBC4:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-09-05 20:04:08.188821 :C974EBC5:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-09-05 20:04:08.188821 :C974EBC6:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-09-05 20:04:08.188821 :C974EBC7:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-05 20:04:08.188821 :C974EBC8:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-05 20:04:08.189345 :C974EBC9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-05 20:04:08.189398 :C974EBD3:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-05 20:14:09.089095 :C975BEA1:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-09-05 20:14:09.406309 :C975BED6:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 09-05 20:14:09.401 2025-09-05 20:14:09.406311 :C975BED7:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=22264 pso_num=22 pso_serial#=248 2025-09-05 20:14:09.406448 :C975BED8:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=22264 osp_idx=0 osp_ver=579935 osp_pg=0 (spawn #562237) 2025-09-05 20:14:09.406449 :C975BED9:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-05 20:14:09.406449 :C975BEDA:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=163 time=1488900705 2025-09-05 20:14:09.406450 :C975BEDB:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-09-05 20:14:09.406450 :C975BEDC:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-09-05 20:14:09.406450 :C975BEDD:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-09-05 20:14:09.406451 :C975BEDE:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-05 20:14:09.406451 :C975BEDF:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-05 20:14:09.406941 :C975BEE0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-05 20:14:09.406988 :C975BEE9:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-05 20:24:10.192844 :C976868D:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-09-05 20:24:10.525753 :C97686D0:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 09-05 20:24:10.521 2025-09-05 20:24:10.525755 :C97686D1:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=7572 pso_num=22 pso_serial#=249 2025-09-05 20:24:10.525889 :C97686D2:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=7572 osp_idx=0 osp_ver=579936 osp_pg=0 (spawn #562260) 2025-09-05 20:24:10.525889 :C97686D3:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-05 20:24:10.525890 :C97686D4:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=164 time=1489501830 2025-09-05 20:24:10.525890 :C97686D5:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-09-05 20:24:10.525890 :C97686D6:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-09-05 20:24:10.525891 :C97686D7:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-09-05 20:24:10.525891 :C97686D8:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-05 20:24:10.525892 :C97686D9:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-05 20:24:10.526364 :C97686DA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-05 20:24:10.526407 :C97686E2:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-05 20:34:11.248491 :C9774FC6:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-09-05 20:34:11.706297 :C9774FF8:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 09-05 20:34:11.701 2025-09-05 20:34:11.706299 :C9774FF9:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=23432 pso_num=22 pso_serial#=250 2025-09-05 20:34:11.706433 :C9774FFA:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=23432 osp_idx=0 osp_ver=579937 osp_pg=0 (spawn #562283) 2025-09-05 20:34:11.706434 :C9774FFB:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-05 20:34:11.706435 :C9774FFC:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=165 time=1490103018 2025-09-05 20:34:11.706436 :C9774FFD:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-09-05 20:34:11.706436 :C9774FFE:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-09-05 20:34:11.706436 :C9774FFF:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-09-05 20:34:11.706437 :C9775000:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-05 20:34:11.706437 :C9775001:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-05 20:34:11.706974 :C9775002:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-05 20:34:11.707019 :C9775009:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-05 20:44:12.505861 :C9781900:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-09-05 20:44:12.948460 :C9781947:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 09-05 20:44:12.943 2025-09-05 20:44:12.948462 :C9781948:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=23280 pso_num=22 pso_serial#=251 2025-09-05 20:44:12.948607 :C9781949:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=23280 osp_idx=0 osp_ver=579938 osp_pg=0 (spawn #562305) 2025-09-05 20:44:12.948608 :C978194A:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-05 20:44:12.948609 :C978194B:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=166 time=1490704252 2025-09-05 20:44:12.948609 :C978194C:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-09-05 20:44:12.948610 :C978194D:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-09-05 20:44:12.948610 :C978194E:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-09-05 20:44:12.948611 :C978194F:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-05 20:44:12.948611 :C9781950:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-05 20:44:12.949151 :C9781951:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-05 20:44:12.949203 :C978195B:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-05 20:54:13.777857 :C978E20C:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-09-05 20:54:14.188834 :C978E248:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 09-05 20:54:14.183 2025-09-05 20:54:14.188838 :C978E249:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=22768 pso_num=22 pso_serial#=252 2025-09-05 20:54:14.188972 :C978E24A:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=22768 osp_idx=0 osp_ver=579939 osp_pg=0 (spawn #562329) 2025-09-05 20:54:14.188972 :C978E24B:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-05 20:54:14.188972 :C978E24C:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=167 time=1491305487 2025-09-05 20:54:14.188973 :C978E24D:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-09-05 20:54:14.188973 :C978E24E:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-09-05 20:54:14.188973 :C978E24F:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-09-05 20:54:14.188974 :C978E250:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-05 20:54:14.188974 :C978E251:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-05 20:54:14.189458 :C978E252:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-05 20:54:14.189506 :C978E259:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-05 21:04:15.050683 :C979AD9E:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-09-05 21:04:15.189420 :C979ADA1:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 09-05 21:04:15.175 2025-09-05 21:04:15.189423 :C979ADA2:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=6020 pso_num=22 pso_serial#=253 2025-09-05 21:04:15.189570 :C979ADA3:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=6020 (legacy spawn) 2025-09-05 21:04:15.196337 :C979ADA4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-05 21:04:15.196505 :C979ADA9:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-05 21:04:15.197358 :C979ADAE:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-09-05 21:04:15.206686 :C979ADB1:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 09-05 21:04:15.207 2025-09-05 21:04:15.206688 :C979ADB2:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=18748 pso_num=22 pso_serial#=254 2025-09-05 21:04:15.206838 :C979ADB3:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=18748 (legacy spawn) 2025-09-05 21:04:15.213781 :C979ADB4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-05 21:04:15.213954 :C979ADBC:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-05 21:04:15.214872 :C979ADBE:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-09-05 21:04:15.477247 :C979ADF9:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 09-05 21:04:15.472 2025-09-05 21:04:15.477249 :C979ADFA:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=21936 pso_num=22 pso_serial#=255 2025-09-05 21:04:15.477388 :C979ADFB:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=21936 osp_idx=0 osp_ver=579942 osp_pg=0 (spawn #562355) 2025-09-05 21:04:15.477388 :C979ADFC:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-05 21:04:15.477389 :C979ADFD:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=168 time=1491906783 2025-09-05 21:04:15.477389 :C979ADFE:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-09-05 21:04:15.477390 :C979ADFF:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-09-05 21:04:15.477390 :C979AE00:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-09-05 21:04:15.477390 :C979AE01:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-05 21:04:15.477391 :C979AE02:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-05 21:04:15.477883 :C979AE03:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-05 21:04:15.477929 :C979AE0B:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-05 21:14:16.283095 :C97A7BB8:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-09-05 21:14:16.756588 :C97A7C0C:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 09-05 21:14:16.752 2025-09-05 21:14:16.756589 :C97A7C0D:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=23428 pso_num=22 pso_serial#=1 2025-09-05 21:14:16.756721 :C97A7C0E:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=23428 osp_idx=0 osp_ver=579943 osp_pg=0 (spawn #562377) 2025-09-05 21:14:16.756721 :C97A7C0F:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-05 21:14:16.756722 :C97A7C10:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=169 time=1492508065 2025-09-05 21:14:16.756722 :C97A7C11:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-09-05 21:14:16.756723 :C97A7C12:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-09-05 21:14:16.756723 :C97A7C13:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-09-05 21:14:16.756723 :C97A7C14:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-05 21:14:16.756724 :C97A7C15:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-05 21:14:16.757208 :C97A7C16:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-05 21:14:16.757261 :C97A7C20:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-05 21:20:33.307714 :C97AF9FC:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-05 21:24:17.970365 :C97B4729:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-05 21:34:18.684588 :C97C0FCA:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-09-05 21:34:19.158124 :C97C1026:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 09-05 21:34:19.153 2025-09-05 21:34:19.158126 :C97C1027:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=22064 pso_num=22 pso_serial#=2 2025-09-05 21:34:19.158326 :C97C1028:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=22064 osp_idx=0 osp_ver=579944 osp_pg=0 (spawn #562422) 2025-09-05 21:34:19.158327 :C97C1029:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-05 21:34:19.158327 :C97C102A:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=170 time=1493710455 2025-09-05 21:34:19.158328 :C97C102B:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-09-05 21:34:19.158328 :C97C102C:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-09-05 21:34:19.158328 :C97C102D:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-09-05 21:34:19.158329 :C97C102E:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-05 21:34:19.158329 :C97C102F:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-05 21:34:19.158838 :C97C1030:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-05 21:34:19.158889 :C97C103A:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-05 21:44:20.048125 :C97CD8A8:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-09-05 21:44:20.318511 :C97CD8E5:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 09-05 21:44:20.313 2025-09-05 21:44:20.318514 :C97CD8E6:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=22672 pso_num=22 pso_serial#=3 2025-09-05 21:44:20.318653 :C97CD8E7:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=22672 osp_idx=0 osp_ver=579945 osp_pg=0 (spawn #562444) 2025-09-05 21:44:20.318653 :C97CD8E8:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-05 21:44:20.318654 :C97CD8E9:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=171 time=1494311627 2025-09-05 21:44:20.318654 :C97CD8EA:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-09-05 21:44:20.318655 :C97CD8EB:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-09-05 21:44:20.318655 :C97CD8EC:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-09-05 21:44:20.318655 :C97CD8ED:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-05 21:44:20.318656 :C97CD8EE:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-05 21:44:20.319147 :C97CD8EF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-05 21:44:20.319194 :C97CD8F8:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-05 21:54:21.085459 :C97DA0EC:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-09-05 21:54:21.559400 :C97DA152:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 09-05 21:54:21.554 2025-09-05 21:54:21.559401 :C97DA153:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=19336 pso_num=22 pso_serial#=4 2025-09-05 21:54:21.559543 :C97DA154:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=19336 osp_idx=0 osp_ver=579946 osp_pg=0 (spawn #562467) 2025-09-05 21:54:21.559544 :C97DA155:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-05 21:54:21.559544 :C97DA156:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=172 time=1494912862 2025-09-05 21:54:21.559545 :C97DA157:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-09-05 21:54:21.559545 :C97DA158:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-09-05 21:54:21.559545 :C97DA159:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-09-05 21:54:21.559546 :C97DA15A:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-05 21:54:21.559546 :C97DA15B:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-05 21:54:21.560139 :C97DA15C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-05 21:54:21.560193 :C97DA166:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-05 22:04:22.290959 :C97E7619:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-09-05 22:04:22.826919 :C97E767B:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 09-05 22:04:22.822 2025-09-05 22:04:22.826921 :C97E767C:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=20068 pso_num=22 pso_serial#=5 2025-09-05 22:04:22.827061 :C97E767D:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=20068 osp_idx=0 osp_ver=579947 osp_pg=0 (spawn #562497) 2025-09-05 22:04:22.827062 :C97E767E:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-05 22:04:22.827062 :C97E767F:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=173 time=1495514127 2025-09-05 22:04:22.827063 :C97E7680:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-09-05 22:04:22.827063 :C97E7681:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-09-05 22:04:22.827064 :C97E7682:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-09-05 22:04:22.827064 :C97E7683:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-05 22:04:22.827064 :C97E7684:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-05 22:04:22.827565 :C97E7685:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-05 22:04:22.827610 :C97E768C:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-05 22:14:23.647704 :C97F47CA:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-09-05 22:14:24.053139 :C97F480E:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 09-05 22:14:24.049 2025-09-05 22:14:24.053141 :C97F480F:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=22696 pso_num=22 pso_serial#=6 2025-09-05 22:14:24.053278 :C97F4810:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=22696 osp_idx=0 osp_ver=579948 osp_pg=0 (spawn #562519) 2025-09-05 22:14:24.053279 :C97F4811:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-05 22:14:24.053279 :C97F4812:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=174 time=1496115362 2025-09-05 22:14:24.053279 :C97F4813:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-09-05 22:14:24.053280 :C97F4814:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-09-05 22:14:24.053280 :C97F4815:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-09-05 22:14:24.053280 :C97F4816:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-05 22:14:24.053281 :C97F4817:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-05 22:14:24.053777 :C97F4818:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-05 22:14:24.053822 :C97F481F:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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 22 (osid: 22696, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de