Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250614220630\orcl_w000_17192_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250614220630\orcl_w000_17192_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:36653M/63366M, Ph+PgF:43101M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 22 Windows thread id: 17192, image: ORACLE.EXE (W000) *** 2025-06-14 22:06:30.890 *** SESSION ID:(177.8657) 2025-06-14 22:06:30.890 *** 2025-06-14 22:06:30.890 Process diagnostic dump for ORACLE.EXE (W000), OS id=17192, pid: 22, proc_ser: 215, sid: 177, sess_ser: 8657 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=33 seq_num=34 snap_id=1 wait times: snap=1.286296 sec, exc=1.286296 sec, total=1.286296 sec wait times: max=5.000000 sec, heur=2 min 41 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.000023 sec since current wait 0: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=32 seq_num=33 snap_id=1 wait times: snap=5.005881 sec, exc=5.005881 sec, total=5.005881 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000019 sec of elapsed time 1: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=31 seq_num=32 snap_id=1 wait times: snap=5.000310 sec, exc=5.000310 sec, total=5.000310 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000026 sec of elapsed time 2: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=30 seq_num=31 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.000024 sec of elapsed time 3: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=29 seq_num=30 snap_id=1 wait times: snap=5.014718 sec, exc=5.014718 sec, total=5.014718 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=28 seq_num=29 snap_id=1 wait times: snap=5.014760 sec, exc=5.014760 sec, total=5.014760 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000022 sec of elapsed time 5: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=27 seq_num=28 snap_id=1 wait times: snap=5.005158 sec, exc=5.005158 sec, total=5.005158 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000017 sec of elapsed time 6: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=26 seq_num=27 snap_id=1 wait times: snap=5.003440 sec, exc=5.003440 sec, total=5.003440 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000028 sec of elapsed time 7: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=25 seq_num=26 snap_id=1 wait times: snap=5.002135 sec, exc=5.002135 sec, total=5.002135 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000025 sec of elapsed time 8: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=24 seq_num=25 snap_id=1 wait times: snap=5.008901 sec, exc=5.008901 sec, total=5.008901 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000033 sec of elapsed time 9: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=23 seq_num=24 snap_id=1 wait times: snap=5.004599 sec, exc=5.004599 sec, total=5.004599 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000037 sec of elapsed time Sampled Session History of session 177 serial 8657 --------------------------------------------------- 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:04:30 - 22:06:30] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-06-14 22:06:30.890 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 22 (osid: 17192, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-06-14 19:43:31.468584 :A4B32F97:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-14 19:43:31.905277 :A4B32FF4:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-14 19:43:31.900 2025-06-14 19:43:31.905279 :A4B32FF5:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=17392 pso_num=22 pso_serial#=202 2025-06-14 19:43:31.905418 :A4B32FF6:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=17392 osp_idx=0 osp_ver=306019 osp_pg=0 (spawn #285504) 2025-06-14 19:43:31.905419 :A4B32FF7:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-14 19:43:31.905420 :A4B32FF8:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=93 time=2905955094 2025-06-14 19:43:31.905420 :A4B32FF9:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-14 19:43:31.905420 :A4B32FFA:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-14 19:43:31.905421 :A4B32FFB:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-14 19:43:31.905421 :A4B32FFC:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-14 19:43:31.905421 :A4B32FFD:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-14 19:43:31.905918 :A4B32FFE: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-06-14 19:43:31.905965 :A4B33006: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-06-14 19:53:32.755622 :A4B3F996:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-14 19:53:33.229151 :A4B3F9DF:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-14 19:53:33.224 2025-06-14 19:53:33.229152 :A4B3F9E0:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16448 pso_num=22 pso_serial#=203 2025-06-14 19:53:33.229293 :A4B3F9E1:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=16448 osp_idx=0 osp_ver=306020 osp_pg=0 (spawn #285527) 2025-06-14 19:53:33.229294 :A4B3F9E2:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-14 19:53:33.229294 :A4B3F9E3:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=94 time=2906556422 2025-06-14 19:53:33.229295 :A4B3F9E4:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-14 19:53:33.229295 :A4B3F9E5:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-14 19:53:33.229296 :A4B3F9E6:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-14 19:53:33.229296 :A4B3F9E7:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-14 19:53:33.229296 :A4B3F9E8:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-14 19:53:33.229813 :A4B3F9E9: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-06-14 19:53:33.229864 :A4B3F9F0: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-06-14 20:03:34.029708 :A4B4C4CA:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-14 20:03:34.518875 :A4B4C507:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-14 20:03:34.514 2025-06-14 20:03:34.518878 :A4B4C508:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=8812 pso_num=22 pso_serial#=204 2025-06-14 20:03:34.519017 :A4B4C509:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=8812 osp_idx=0 osp_ver=306021 osp_pg=0 (spawn #285553) 2025-06-14 20:03:34.519017 :A4B4C50A:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-14 20:03:34.519018 :A4B4C50B:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=95 time=2907157704 2025-06-14 20:03:34.519018 :A4B4C50C:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-14 20:03:34.519019 :A4B4C50D:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-14 20:03:34.519019 :A4B4C50E:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-14 20:03:34.519020 :A4B4C50F:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-14 20:03:34.519020 :A4B4C510:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-14 20:03:34.519535 :A4B4C511: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-06-14 20:03:34.519586 :A4B4C518: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-06-14 20:13:35.304824 :A4B5974B:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-14 20:13:35.887950 :A4B5978F:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-14 20:13:35.883 2025-06-14 20:13:35.887952 :A4B59790:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16996 pso_num=22 pso_serial#=205 2025-06-14 20:13:35.888098 :A4B59791:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=16996 osp_idx=0 osp_ver=306022 osp_pg=0 (spawn #285575) 2025-06-14 20:13:35.888099 :A4B59792:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-14 20:13:35.888099 :A4B59793:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=96 time=2907759079 2025-06-14 20:13:35.888100 :A4B59794:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-14 20:13:35.888100 :A4B59795:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-14 20:13:35.888101 :A4B59796:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-14 20:13:35.888101 :A4B59797:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-14 20:13:35.888101 :A4B59798:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-14 20:13:35.888625 :A4B59799: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-06-14 20:13:35.888671 :A4B597A3: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-06-14 20:23:36.732966 :A4B660F5:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-14 20:23:37.253270 :A4B6613A:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-14 20:23:37.249 2025-06-14 20:23:37.253272 :A4B6613B:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16860 pso_num=22 pso_serial#=206 2025-06-14 20:23:37.253408 :A4B6613C:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=16860 osp_idx=0 osp_ver=306023 osp_pg=0 (spawn #285598) 2025-06-14 20:23:37.253408 :A4B6613D:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-14 20:23:37.253409 :A4B6613E:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=97 time=2908360438 2025-06-14 20:23:37.253409 :A4B6613F:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-14 20:23:37.253410 :A4B66140:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-14 20:23:37.253410 :A4B66141:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-14 20:23:37.253410 :A4B66142:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-14 20:23:37.253411 :A4B66143:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-14 20:23:37.253942 :A4B66144: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-06-14 20:23:37.253988 :A4B6614C: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-06-14 20:33:38.036931 :A4B72BCB:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-14 20:33:38.479263 :A4B72C24:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-14 20:33:38.474 2025-06-14 20:33:38.479265 :A4B72C25:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=13244 pso_num=22 pso_serial#=207 2025-06-14 20:33:38.479400 :A4B72C26:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=13244 osp_idx=0 osp_ver=306024 osp_pg=0 (spawn #285621) 2025-06-14 20:33:38.479400 :A4B72C27:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-14 20:33:38.479401 :A4B72C28:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=98 time=2908961672 2025-06-14 20:33:38.479401 :A4B72C29:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-14 20:33:38.479402 :A4B72C2A:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-14 20:33:38.479402 :A4B72C2B:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-14 20:33:38.479402 :A4B72C2C:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-14 20:33:38.479402 :A4B72C2D:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-14 20:33:38.479887 :A4B72C2E: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-06-14 20:33:38.479934 :A4B72C36: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-06-14 20:43:39.245865 :A4B7F45A:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-14 20:43:39.703799 :A4B7F495:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-14 20:43:39.699 2025-06-14 20:43:39.703801 :A4B7F496:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16680 pso_num=22 pso_serial#=208 2025-06-14 20:43:39.703941 :A4B7F497:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=16680 osp_idx=0 osp_ver=306025 osp_pg=0 (spawn #285643) 2025-06-14 20:43:39.703941 :A4B7F498:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-14 20:43:39.703942 :A4B7F499:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=99 time=2909562891 2025-06-14 20:43:39.703942 :A4B7F49A:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-14 20:43:39.703943 :A4B7F49B:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-14 20:43:39.703943 :A4B7F49C:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-14 20:43:39.703943 :A4B7F49D:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-14 20:43:39.703944 :A4B7F49E:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-14 20:43:39.704452 :A4B7F49F: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-06-14 20:43:39.704496 :A4B7F4A6: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-06-14 20:53:40.514210 :A4B8BCC5:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-14 20:53:40.972171 :A4B8BD0B:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-14 20:53:40.967 2025-06-14 20:53:40.972173 :A4B8BD0C:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=15972 pso_num=22 pso_serial#=209 2025-06-14 20:53:40.972313 :A4B8BD0D:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=15972 osp_idx=0 osp_ver=306026 osp_pg=0 (spawn #285666) 2025-06-14 20:53:40.972314 :A4B8BD0E:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-14 20:53:40.972314 :A4B8BD0F:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=100 time=2910164157 2025-06-14 20:53:40.972314 :A4B8BD10:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-14 20:53:40.972315 :A4B8BD11:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-14 20:53:40.972315 :A4B8BD12:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-14 20:53:40.972315 :A4B8BD13:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-14 20:53:40.972316 :A4B8BD14:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-14 20:53:40.972836 :A4B8BD15: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-06-14 20:53:40.972890 :A4B8BD1F: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-06-14 21:03:41.889701 :A4B98B1D:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-14 21:03:42.206836 :A4B98B56:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-14 21:03:42.202 2025-06-14 21:03:42.206838 :A4B98B57:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16700 pso_num=22 pso_serial#=210 2025-06-14 21:03:42.206976 :A4B98B58:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=16700 osp_idx=0 osp_ver=306027 osp_pg=0 (spawn #285692) 2025-06-14 21:03:42.206976 :A4B98B59:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-14 21:03:42.206977 :A4B98B5A:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=101 time=2910765391 2025-06-14 21:03:42.206977 :A4B98B5B:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-14 21:03:42.206977 :A4B98B5C:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-14 21:03:42.206978 :A4B98B5D:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-14 21:03:42.206978 :A4B98B5E:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-14 21:03:42.206979 :A4B98B5F:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-14 21:03:42.207478 :A4B98B60: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-06-14 21:03:42.207524 :A4B98B68: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-06-14 21:04:27.270054 :A4B99B4F:db_trace:ksl2.c@2477:kslwtbctx(): [10005:22:177] KSL WAIT BEG [latch free] 136537728/0x8236680 259/0x103 0/0x0 wait_id=10 seq_num=11 snap_id=1 2025-06-14 21:04:27.270074 :A4B99B54:db_trace:ksl2.c@2611:kslwtectx(): [10005:22:177] KSL WAIT END [latch free] 136537728/0x8236680 259/0x103 0/0x0 wait_id=10 seq_num=11 snap_id=1 2025-06-14 21:04:27.270075 :A4B99B55:db_trace:ksl2.c@2619:kslwtectx(): [10005:22:177] KSL WAIT END wait times (usecs) - snap=19, exc=19, tot=19 2025-06-14 21:13:43.071609 :A4BA59EB:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-14 21:13:43.391923 :A4BA5A26:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-14 21:13:43.387 2025-06-14 21:13:43.391925 :A4BA5A27:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16256 pso_num=22 pso_serial#=211 2025-06-14 21:13:43.392064 :A4BA5A28:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=16256 osp_idx=0 osp_ver=306028 osp_pg=0 (spawn #285714) 2025-06-14 21:13:43.392065 :A4BA5A29:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-14 21:13:43.392065 :A4BA5A2A:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=102 time=2911366579 2025-06-14 21:13:43.392066 :A4BA5A2B:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-14 21:13:43.392066 :A4BA5A2C:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-14 21:13:43.392067 :A4BA5A2D:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-14 21:13:43.392067 :A4BA5A2E:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-14 21:13:43.392067 :A4BA5A2F:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-14 21:13:43.392560 :A4BA5A30: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-06-14 21:13:43.392606 :A4BA5A39: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-06-14 21:15:40.885936 :A4BA81B5: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-06-14 21:23:44.563887 :A4BB238C: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-06-14 21:33:45.392447 :A4BBED50:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-14 21:33:45.787672 :A4BBED99:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-14 21:33:45.782 2025-06-14 21:33:45.787675 :A4BBED9A:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=15368 pso_num=22 pso_serial#=212 2025-06-14 21:33:45.787818 :A4BBED9B:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=15368 osp_idx=0 osp_ver=306029 osp_pg=0 (spawn #285759) 2025-06-14 21:33:45.787818 :A4BBED9C:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-14 21:33:45.787819 :A4BBED9D:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=103 time=2912568985 2025-06-14 21:33:45.787819 :A4BBED9E:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-14 21:33:45.787819 :A4BBED9F:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-14 21:33:45.787820 :A4BBEDA0:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-14 21:33:45.787820 :A4BBEDA1:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-14 21:33:45.787820 :A4BBEDA2:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-14 21:33:45.788315 :A4BBEDA3: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-06-14 21:33:45.788361 :A4BBEDAB: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-06-14 21:43:46.694712 :A4BCB7B3:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-14 21:43:46.970203 :A4BCB7EF:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-14 21:43:46.965 2025-06-14 21:43:46.970205 :A4BCB7F0:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=17072 pso_num=22 pso_serial#=213 2025-06-14 21:43:46.970339 :A4BCB7F1:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=17072 osp_idx=0 osp_ver=306030 osp_pg=0 (spawn #285781) 2025-06-14 21:43:46.970339 :A4BCB7F2:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-14 21:43:46.970340 :A4BCB7F3:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=104 time=2913170157 2025-06-14 21:43:46.970340 :A4BCB7F4:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-14 21:43:46.970340 :A4BCB7F5:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-14 21:43:46.970341 :A4BCB7F6:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-14 21:43:46.970341 :A4BCB7F7:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-14 21:43:46.970341 :A4BCB7F8:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-14 21:43:46.970823 :A4BCB7F9: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-06-14 21:43:46.970871 :A4BCB801: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-06-14 21:53:47.933072 :A4BD8048:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-14 21:53:48.187951 :A4BD80A4:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-14 21:53:48.183 2025-06-14 21:53:48.187953 :A4BD80A5:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16912 pso_num=22 pso_serial#=214 2025-06-14 21:53:48.188093 :A4BD80A6:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=16912 osp_idx=0 osp_ver=306031 osp_pg=0 (spawn #285804) 2025-06-14 21:53:48.188094 :A4BD80A7:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-14 21:53:48.188094 :A4BD80A8:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=105 time=2913771375 2025-06-14 21:53:48.188095 :A4BD80A9:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-14 21:53:48.188095 :A4BD80AA:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-14 21:53:48.188096 :A4BD80AB:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-14 21:53:48.188096 :A4BD80AC:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-14 21:53:48.188096 :A4BD80AD:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-14 21:53:48.188602 :A4BD80AE: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-06-14 21:53:48.188646 :A4BD80B5: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-06-14 22:03:49.146571 :A4BE4F67:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-14 22:03:49.354453 :A4BE4FCF:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-14 22:03:49.349 2025-06-14 22:03:49.354455 :A4BE4FD0:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=17192 pso_num=22 pso_serial#=215 2025-06-14 22:03:49.354589 :A4BE4FD1:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=17192 osp_idx=0 osp_ver=306032 osp_pg=0 (spawn #285830) 2025-06-14 22:03:49.354589 :A4BE4FD2:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-14 22:03:49.354590 :A4BE4FD3:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=106 time=2914372547 2025-06-14 22:03:49.354590 :A4BE4FD4:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-14 22:03:49.354591 :A4BE4FD5:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-14 22:03:49.354591 :A4BE4FD6:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-14 22:03:49.354591 :A4BE4FD7:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-14 22:03:49.354592 :A4BE4FD8:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-14 22:03:49.355070 :A4BE4FD9: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-06-14 22:03:49.355113 :A4BE4FE1: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: 17192, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de