Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250803140845\orcl_w000_20120_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250803140845\orcl_w000_20120_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:35783M/63366M, Ph+PgF:41431M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 22 Windows thread id: 20120, image: ORACLE.EXE (W000) *** 2025-08-03 14:08:45.585 *** SESSION ID:(177.20021) 2025-08-03 14:08:45.585 *** 2025-08-03 14:08:45.585 Process diagnostic dump for ORACLE.EXE (W000), OS id=20120, pid: 22, proc_ser: 53, sid: 177, sess_ser: 20021 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=182 seq_num=183 snap_id=1 wait times: snap=4.069761 sec, exc=4.069761 sec, total=4.069761 sec wait times: max=5.000000 sec, heur=13 min 0 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.000028 sec since current wait 0: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=181 seq_num=182 snap_id=1 wait times: snap=5.009564 sec, exc=5.009564 sec, total=5.009564 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000032 sec of elapsed time 1: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=180 seq_num=181 snap_id=1 wait times: snap=5.002714 sec, exc=5.002714 sec, total=5.002714 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000022 sec of elapsed time 2: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=179 seq_num=180 snap_id=1 wait times: snap=5.004641 sec, exc=5.004641 sec, total=5.004641 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000025 sec of elapsed time 3: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=178 seq_num=179 snap_id=1 wait times: snap=5.004630 sec, exc=5.004630 sec, total=5.004630 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=177 seq_num=178 snap_id=1 wait times: snap=5.004772 sec, exc=5.004772 sec, total=5.004772 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000020 sec of elapsed time 5: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=176 seq_num=177 snap_id=1 wait times: snap=5.001731 sec, exc=5.001731 sec, total=5.001731 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000025 sec of elapsed time 6: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=175 seq_num=176 snap_id=1 wait times: snap=5.001120 sec, exc=5.001120 sec, total=5.001120 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=174 seq_num=175 snap_id=1 wait times: snap=5.005592 sec, exc=5.005592 sec, total=5.005592 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000020 sec of elapsed time 8: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=173 seq_num=174 snap_id=1 wait times: snap=5.000056 sec, exc=5.000056 sec, total=5.000056 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=172 seq_num=173 snap_id=1 wait times: snap=5.004624 sec, exc=5.004624 sec, total=5.004624 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000026 sec of elapsed time Sampled Session History of session 177 serial 20021 --------------------------------------------------- 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, 14:06:45 - 14:08:45] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-08-03 14:08:45.585 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 22 (osid: 20120, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-08-03 11:43:34.317705 :BAC1EA2E:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-03 11:43:34.619322 :BAC1EA6E:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-03 11:43:34.614 2025-08-03 11:43:34.619324 :BAC1EA6F:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=636 pso_num=22 pso_serial#=39 2025-08-03 11:43:34.619458 :BAC1EA70:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=636 osp_idx=0 osp_ver=477216 osp_pg=0 (spawn #451062) 2025-08-03 11:43:34.619458 :BAC1EA71:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-03 11:43:34.619458 :BAC1EA72:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=151 time=2902083923 2025-08-03 11:43:34.619459 :BAC1EA73:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-03 11:43:34.619460 :BAC1EA74:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-03 11:43:34.619460 :BAC1EA75:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-03 11:43:34.619460 :BAC1EA76:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-03 11:43:34.619461 :BAC1EA77:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-03 11:43:34.619949 :BAC1EA78: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-08-03 11:43:34.619994 :BAC1EA80: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-08-03 11:53:35.442396 :BAC2B40C:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-03 11:53:35.775242 :BAC2B44A:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-03 11:53:35.770 2025-08-03 11:53:35.775244 :BAC2B44B:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=10676 pso_num=22 pso_serial#=40 2025-08-03 11:53:35.775380 :BAC2B44C:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=10676 osp_idx=0 osp_ver=477217 osp_pg=0 (spawn #451085) 2025-08-03 11:53:35.775381 :BAC2B44D:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-03 11:53:35.775381 :BAC2B44E:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=152 time=2902685079 2025-08-03 11:53:35.775381 :BAC2B44F:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-03 11:53:35.775382 :BAC2B450:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-03 11:53:35.775382 :BAC2B451:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-03 11:53:35.775383 :BAC2B452:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-03 11:53:35.775383 :BAC2B453:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-03 11:53:35.775873 :BAC2B454: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-08-03 11:53:35.775920 :BAC2B45C: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-08-03 11:55:44.425925 :BAC2DF20: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-08-03 11:55:44.428100 :BAC2DF22: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-08-03 12:03:36.941352 :BAC38163: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-08-03 12:13:37.756536 :BAC45130:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-03 12:13:38.224578 :BAC451B1:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-03 12:13:38.219 2025-08-03 12:13:38.224581 :BAC451B2:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=19864 pso_num=22 pso_serial#=41 2025-08-03 12:13:38.224722 :BAC451B3:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=19864 osp_idx=0 osp_ver=477218 osp_pg=0 (spawn #451132) 2025-08-03 12:13:38.224723 :BAC451B4:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-03 12:13:38.224724 :BAC451B5:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=153 time=2903887533 2025-08-03 12:13:38.224724 :BAC451B6:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-03 12:13:38.224725 :BAC451B7:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-03 12:13:38.224725 :BAC451B8:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-03 12:13:38.224725 :BAC451B9:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-03 12:13:38.224726 :BAC451BA:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-03 12:13:38.225284 :BAC451BB: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-08-03 12:13:38.225333 :BAC451C3: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-08-03 12:23:39.122821 :BAC51E86:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-03 12:23:39.283845 :BAC51EE7:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-03 12:23:39.278 2025-08-03 12:23:39.283847 :BAC51EE8:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=20072 pso_num=22 pso_serial#=42 2025-08-03 12:23:39.283982 :BAC51EE9:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=20072 osp_idx=0 osp_ver=477219 osp_pg=0 (spawn #451155) 2025-08-03 12:23:39.283983 :BAC51EEA:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-03 12:23:39.283984 :BAC51EEB:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=154 time=2904488595 2025-08-03 12:23:39.283984 :BAC51EEC:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-03 12:23:39.283986 :BAC51EED:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-03 12:23:39.283986 :BAC51EEE:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-03 12:23:39.283987 :BAC51EEF:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-03 12:23:39.283987 :BAC51EF0:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-03 12:23:39.284470 :BAC51EF1: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-08-03 12:23:39.284513 :BAC51EF8: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-08-03 12:33:40.128564 :BAC5EA23:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-03 12:33:40.523782 :BAC5EA7B:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-03 12:33:40.519 2025-08-03 12:33:40.523784 :BAC5EA7C:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=19264 pso_num=22 pso_serial#=43 2025-08-03 12:33:40.523917 :BAC5EA7D:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=19264 osp_idx=0 osp_ver=477220 osp_pg=0 (spawn #451178) 2025-08-03 12:33:40.523918 :BAC5EA7E:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-03 12:33:40.523918 :BAC5EA7F:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=155 time=2905089829 2025-08-03 12:33:40.523918 :BAC5EA80:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-03 12:33:40.523919 :BAC5EA81:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-03 12:33:40.523919 :BAC5EA82:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-03 12:33:40.523919 :BAC5EA83:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-03 12:33:40.523920 :BAC5EA84:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-03 12:33:40.524449 :BAC5EA85: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-08-03 12:33:40.524497 :BAC5EA8C: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-08-03 12:43:41.407368 :BAC6B4F0:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-03 12:43:41.740213 :BAC6B541:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-03 12:43:41.735 2025-08-03 12:43:41.740215 :BAC6B542:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=19208 pso_num=22 pso_serial#=44 2025-08-03 12:43:41.740352 :BAC6B543:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=19208 osp_idx=0 osp_ver=477221 osp_pg=0 (spawn #451200) 2025-08-03 12:43:41.740353 :BAC6B544:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-03 12:43:41.740354 :BAC6B545:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=156 time=2905691048 2025-08-03 12:43:41.740354 :BAC6B546:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-03 12:43:41.740355 :BAC6B547:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-03 12:43:41.740355 :BAC6B548:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-03 12:43:41.740356 :BAC6B549:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-03 12:43:41.740356 :BAC6B54A:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-03 12:43:41.740830 :BAC6B54B: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-08-03 12:43:41.740876 :BAC6B554: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-08-03 12:53:42.522800 :BAC77FDF:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-03 12:53:42.904696 :BAC78036:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-03 12:53:42.900 2025-08-03 12:53:42.904698 :BAC78037:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=13804 pso_num=22 pso_serial#=45 2025-08-03 12:53:42.904837 :BAC78038:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=13804 osp_idx=0 osp_ver=477222 osp_pg=0 (spawn #451223) 2025-08-03 12:53:42.904838 :BAC78039:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-03 12:53:42.904838 :BAC7803A:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=157 time=2906292204 2025-08-03 12:53:42.904838 :BAC7803B:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-03 12:53:42.904839 :BAC7803C:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-03 12:53:42.904839 :BAC7803D:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-03 12:53:42.904840 :BAC7803E:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-03 12:53:42.904840 :BAC7803F:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-03 12:53:42.905339 :BAC78040: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-08-03 12:53:42.905386 :BAC7804A: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-08-03 13:03:43.819055 :BAC84E11:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-03 13:03:44.214647 :BAC84E5E:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-03 13:03:44.209 2025-08-03 13:03:44.214649 :BAC84E5F:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=19376 pso_num=22 pso_serial#=46 2025-08-03 13:03:44.214791 :BAC84E60:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=19376 osp_idx=0 osp_ver=477223 osp_pg=0 (spawn #451249) 2025-08-03 13:03:44.214791 :BAC84E61:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-03 13:03:44.214792 :BAC84E62:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=158 time=2906893517 2025-08-03 13:03:44.214792 :BAC84E63:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-03 13:03:44.214793 :BAC84E64:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-03 13:03:44.214793 :BAC84E65:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-03 13:03:44.214794 :BAC84E66:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-03 13:03:44.214794 :BAC84E67:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-03 13:03:44.215284 :BAC84E68: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-08-03 13:03:44.215332 :BAC84E70: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-08-03 13:13:45.036312 :BAC9222E:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-03 13:13:45.332386 :BAC92278:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-03 13:13:45.327 2025-08-03 13:13:45.332388 :BAC92279:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=18360 pso_num=22 pso_serial#=47 2025-08-03 13:13:45.332521 :BAC9227A:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=18360 osp_idx=0 osp_ver=477224 osp_pg=0 (spawn #451272) 2025-08-03 13:13:45.332522 :BAC9227B:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-03 13:13:45.332522 :BAC9227C:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=159 time=2907494642 2025-08-03 13:13:45.332523 :BAC9227D:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-03 13:13:45.332523 :BAC9227E:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-03 13:13:45.332523 :BAC9227F:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-03 13:13:45.332523 :BAC92280:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-03 13:13:45.332524 :BAC92281:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-03 13:13:45.333052 :BAC92282: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-08-03 13:13:45.333096 :BAC92289: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-08-03 13:23:46.179729 :BAC9ECAD:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-03 13:23:46.453577 :BAC9ECB0:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-03 13:23:46.445 2025-08-03 13:23:46.453578 :BAC9ECB1:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=7532 pso_num=22 pso_serial#=48 2025-08-03 13:23:46.453718 :BAC9ECB2:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=7532 (legacy spawn) 2025-08-03 13:23:46.460195 :BAC9ECB3: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-08-03 13:23:46.460383 :BAC9ECB8: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-08-03 13:23:46.461204 :BAC9ECBD:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-03 13:23:46.512483 :BAC9ED07:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-03 13:23:46.508 2025-08-03 13:23:46.512485 :BAC9ED08:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=7996 pso_num=22 pso_serial#=49 2025-08-03 13:23:46.512621 :BAC9ED09:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=7996 osp_idx=0 osp_ver=477226 osp_pg=0 (spawn #451295) 2025-08-03 13:23:46.512621 :BAC9ED0A:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-03 13:23:46.512622 :BAC9ED0B:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=160 time=2908095814 2025-08-03 13:23:46.512622 :BAC9ED0C:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-03 13:23:46.512623 :BAC9ED0D:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-03 13:23:46.512623 :BAC9ED0E:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-03 13:23:46.512624 :BAC9ED0F:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-03 13:23:46.512624 :BAC9ED10:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-03 13:23:46.513181 :BAC9ED11: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-08-03 13:23:46.513228 :BAC9ED18: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-08-03 13:33:47.413131 :BACAB756:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-03 13:33:47.698916 :BACAB793:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-03 13:33:47.694 2025-08-03 13:33:47.698918 :BACAB794:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=14924 pso_num=22 pso_serial#=50 2025-08-03 13:33:47.699085 :BACAB795:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=14924 osp_idx=0 osp_ver=477227 osp_pg=0 (spawn #451318) 2025-08-03 13:33:47.699086 :BACAB796:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-03 13:33:47.699086 :BACAB797:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=161 time=2908697001 2025-08-03 13:33:47.699086 :BACAB798:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-03 13:33:47.699087 :BACAB799:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-03 13:33:47.699087 :BACAB79A:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-03 13:33:47.699088 :BACAB79B:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-03 13:33:47.699088 :BACAB79C:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-03 13:33:47.699589 :BACAB79D: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-08-03 13:33:47.699636 :BACAB7A5: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-08-03 13:43:48.510708 :BACB814E:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-03 13:43:48.780967 :BACB8184:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-03 13:43:48.776 2025-08-03 13:43:48.780970 :BACB8185:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16876 pso_num=22 pso_serial#=51 2025-08-03 13:43:48.781106 :BACB8186:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=16876 osp_idx=0 osp_ver=477228 osp_pg=0 (spawn #451340) 2025-08-03 13:43:48.781107 :BACB8187:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-03 13:43:48.781107 :BACB8188:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=162 time=2909298095 2025-08-03 13:43:48.781108 :BACB8189:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-03 13:43:48.781108 :BACB818A:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-03 13:43:48.781109 :BACB818B:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-03 13:43:48.781109 :BACB818C:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-03 13:43:48.781109 :BACB818D:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-03 13:43:48.781645 :BACB818E: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-08-03 13:43:48.781693 :BACB8197: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-08-03 13:53:49.509328 :BACC4B53:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-03 13:53:49.861222 :BACC4B63:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-03 13:53:49.853 2025-08-03 13:53:49.861224 :BACC4B64:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=19812 pso_num=22 pso_serial#=52 2025-08-03 13:53:49.861362 :BACC4B65:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=19812 (legacy spawn) 2025-08-03 13:53:49.867830 :BACC4B66: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-08-03 13:53:49.868001 :BACC4B6B: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-08-03 13:53:49.868787 :BACC4B70:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-03 13:53:49.920206 :BACC4BAC:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-03 13:53:49.916 2025-08-03 13:53:49.920209 :BACC4BAD:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=20120 pso_num=22 pso_serial#=53 2025-08-03 13:53:49.920341 :BACC4BAE:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=20120 osp_idx=0 osp_ver=477230 osp_pg=0 (spawn #451363) 2025-08-03 13:53:49.920342 :BACC4BAF:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-03 13:53:49.920342 :BACC4BB0:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=163 time=2909899220 2025-08-03 13:53:49.920343 :BACC4BB1:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-03 13:53:49.920343 :BACC4BB2:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-03 13:53:49.920343 :BACC4BB3:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-03 13:53:49.920344 :BACC4BB4:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-03 13:53:49.920344 :BACC4BB5:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-03 13:53:49.920828 :BACC4BB6: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-08-03 13:53:49.920876 :BACC4BBD: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-08-03 13:55:45.151665 :BACC723D: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-08-03 14:03:51.107093 :BACD18C7: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 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 22 (osid: 20120, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de