Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250622082943\orcl_w000_17704_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250622082943\orcl_w000_17704_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:36380M/63366M, Ph+PgF:42610M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 22 Windows thread id: 17704, image: ORACLE.EXE (W000) *** 2025-06-22 08:29:43.815 *** SESSION ID:(177.18745) 2025-06-22 08:29:43.815 *** 2025-06-22 08:29:43.815 Process diagnostic dump for ORACLE.EXE (W000), OS id=17704, pid: 22, proc_ser: 66, sid: 177, sess_ser: 18745 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=49 seq_num=50 snap_id=1 wait times: snap=2.014664 sec, exc=2.014664 sec, total=2.014664 sec wait times: max=5.000000 sec, heur=4 min 2 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=48 seq_num=49 snap_id=1 wait times: snap=5.014724 sec, exc=5.014724 sec, total=5.014724 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000033 sec of elapsed time 1: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=47 seq_num=48 snap_id=1 wait times: snap=5.010122 sec, exc=5.010122 sec, total=5.010122 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000035 sec of elapsed time 2: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=46 seq_num=47 snap_id=1 wait times: snap=5.008412 sec, exc=5.008412 sec, total=5.008412 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000038 sec of elapsed time 3: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=45 seq_num=46 snap_id=1 wait times: snap=5.007932 sec, exc=5.007932 sec, total=5.007932 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000037 sec of elapsed time 4: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=44 seq_num=45 snap_id=1 wait times: snap=5.014167 sec, exc=5.014167 sec, total=5.014167 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000021 sec of elapsed time 5: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=43 seq_num=44 snap_id=1 wait times: snap=5.004626 sec, exc=5.004626 sec, total=5.004626 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000026 sec of elapsed time 6: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=42 seq_num=43 snap_id=1 wait times: snap=5.009191 sec, exc=5.009191 sec, total=5.009191 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000022 sec of elapsed time 7: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=41 seq_num=42 snap_id=1 wait times: snap=5.010134 sec, exc=5.010134 sec, total=5.010134 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000024 sec of elapsed time 8: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=40 seq_num=41 snap_id=1 wait times: snap=5.014735 sec, exc=5.014735 sec, total=5.014735 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000027 sec of elapsed time 9: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=39 seq_num=40 snap_id=1 wait times: snap=5.015239 sec, exc=5.015239 sec, total=5.015239 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000024 sec of elapsed time Sampled Session History of session 177 serial 18745 --------------------------------------------------- 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, 08:27:43 - 08:29:43] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-06-22 08:29:43.815 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 22 (osid: 17704, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-06-22 06:05:23.532462 :A7FBD195:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-22 06:05:23.844009 :A7FBD1DA:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-22 06:05:23.839 2025-06-22 06:05:23.844011 :A7FBD1DB:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=14664 pso_num=22 pso_serial#=53 2025-06-22 06:05:23.844155 :A7FBD1DC:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=14664 osp_idx=0 osp_ver=338000 osp_pg=0 (spawn #310292) 2025-06-22 06:05:23.844156 :A7FBD1DD: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-22 06:05:23.844156 :A7FBD1DE:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=157 time=3548067032 2025-06-22 06:05:23.844157 :A7FBD1DF:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-22 06:05:23.844157 :A7FBD1E0:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-22 06:05:23.844157 :A7FBD1E1:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-22 06:05:23.844158 :A7FBD1E2:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-22 06:05:23.844158 :A7FBD1E3:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-22 06:05:23.844664 :A7FBD1E4: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-22 06:05:23.844710 :A7FBD1EE: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-22 06:15:24.655448 :A7FC9B50:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-22 06:15:25.003909 :A7FC9B93:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-22 06:15:24.999 2025-06-22 06:15:25.003911 :A7FC9B94:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=17836 pso_num=22 pso_serial#=54 2025-06-22 06:15:25.004049 :A7FC9B95:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=17836 osp_idx=0 osp_ver=338001 osp_pg=0 (spawn #310315) 2025-06-22 06:15:25.004050 :A7FC9B96: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-22 06:15:25.004050 :A7FC9B97:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=158 time=3548668188 2025-06-22 06:15:25.004051 :A7FC9B98:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-22 06:15:25.004051 :A7FC9B99:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-22 06:15:25.004051 :A7FC9B9A:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-22 06:15:25.004052 :A7FC9B9B:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-22 06:15:25.004052 :A7FC9B9C:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-22 06:15:25.004535 :A7FC9B9D: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-22 06:15:25.004583 :A7FC9BA3: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-22 06:25:25.886913 :A7FD60E5:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-22 06:25:26.219706 :A7FD6133:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-22 06:25:26.215 2025-06-22 06:25:26.219708 :A7FD6134:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=15520 pso_num=22 pso_serial#=55 2025-06-22 06:25:26.219897 :A7FD6135:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=15520 osp_idx=0 osp_ver=338002 osp_pg=0 (spawn #310338) 2025-06-22 06:25:26.219898 :A7FD6136: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-22 06:25:26.219899 :A7FD6137:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=159 time=3549269407 2025-06-22 06:25:26.219899 :A7FD6138:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-22 06:25:26.219900 :A7FD6139:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-22 06:25:26.219900 :A7FD613A:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-22 06:25:26.219900 :A7FD613B:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-22 06:25:26.219900 :A7FD613C:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-22 06:25:26.220419 :A7FD613D: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-22 06:25:26.220468 :A7FD6145: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-22 06:35:27.225415 :A7FE2726:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-22 06:35:27.495900 :A7FE2769:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-22 06:35:27.491 2025-06-22 06:35:27.495902 :A7FE276A:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=17172 pso_num=22 pso_serial#=56 2025-06-22 06:35:27.496062 :A7FE276B:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=17172 osp_idx=0 osp_ver=338003 osp_pg=0 (spawn #310360) 2025-06-22 06:35:27.496062 :A7FE276C: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-22 06:35:27.496063 :A7FE276D:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=160 time=3549870688 2025-06-22 06:35:27.496063 :A7FE276E:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-22 06:35:27.496063 :A7FE276F:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-22 06:35:27.496064 :A7FE2770:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-22 06:35:27.496064 :A7FE2771:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-22 06:35:27.496064 :A7FE2772:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-22 06:35:27.496614 :A7FE2773: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-22 06:35:27.496660 :A7FE277A: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-22 06:45:28.345397 :A7FEED2E:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-22 06:45:28.693938 :A7FEED80:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-22 06:45:28.689 2025-06-22 06:45:28.693940 :A7FEED81:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=18016 pso_num=22 pso_serial#=57 2025-06-22 06:45:28.694080 :A7FEED82:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=18016 osp_idx=0 osp_ver=338004 osp_pg=0 (spawn #310383) 2025-06-22 06:45:28.694080 :A7FEED83: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-22 06:45:28.694081 :A7FEED84:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=161 time=3550471891 2025-06-22 06:45:28.694081 :A7FEED85:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-22 06:45:28.694082 :A7FEED86:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-22 06:45:28.694082 :A7FEED87:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-22 06:45:28.694082 :A7FEED88:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-22 06:45:28.694083 :A7FEED89:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-22 06:45:28.694569 :A7FEED8A: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-22 06:45:28.694615 :A7FEED91: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-22 06:55:29.606752 :A7FFB30A:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-22 06:55:29.892753 :A7FFB34D:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-22 06:55:29.887 2025-06-22 06:55:29.892754 :A7FFB34E:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=17980 pso_num=22 pso_serial#=58 2025-06-22 06:55:29.892892 :A7FFB34F:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=17980 osp_idx=0 osp_ver=338005 osp_pg=0 (spawn #310406) 2025-06-22 06:55:29.892893 :A7FFB350: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-22 06:55:29.892893 :A7FFB351:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=162 time=3551073079 2025-06-22 06:55:29.892894 :A7FFB352:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-22 06:55:29.892894 :A7FFB353:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-22 06:55:29.892894 :A7FFB354:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-22 06:55:29.892895 :A7FFB355:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-22 06:55:29.892895 :A7FFB356:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-22 06:55:29.893383 :A7FFB357: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-22 06:55:29.893425 :A7FFB360: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-22 07:04:25.259514 :A8006408: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-22 07:05:31.197166 :A8008062: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-22 07:15:32.166838 :A8014884:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-22 07:15:32.452713 :A80148C8:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-22 07:15:32.448 2025-06-22 07:15:32.452714 :A80148C9:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=14744 pso_num=22 pso_serial#=59 2025-06-22 07:15:32.452884 :A80148CA:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=14744 osp_idx=0 osp_ver=338006 osp_pg=0 (spawn #310454) 2025-06-22 07:15:32.452885 :A80148CB: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-22 07:15:32.452885 :A80148CC:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=163 time=3552275641 2025-06-22 07:15:32.452885 :A80148CD:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-22 07:15:32.452886 :A80148CE:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-22 07:15:32.452887 :A80148CF:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-22 07:15:32.452887 :A80148D0:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-22 07:15:32.452887 :A80148D1:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-22 07:15:32.453412 :A80148D2: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-22 07:15:32.453458 :A80148DA: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-22 07:25:33.321830 :A8020F2F:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-22 07:25:33.732732 :A8020F82:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-22 07:25:33.728 2025-06-22 07:25:33.732734 :A8020F83:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=18056 pso_num=22 pso_serial#=60 2025-06-22 07:25:33.732883 :A8020F84:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=18056 osp_idx=0 osp_ver=338007 osp_pg=0 (spawn #310477) 2025-06-22 07:25:33.732884 :A8020F85: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-22 07:25:33.732884 :A8020F86:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=164 time=3552876922 2025-06-22 07:25:33.732884 :A8020F87:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-22 07:25:33.732885 :A8020F88:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-22 07:25:33.732885 :A8020F89:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-22 07:25:33.732885 :A8020F8A:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-22 07:25:33.732886 :A8020F8B:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-22 07:25:33.733395 :A8020F8C: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-22 07:25:33.733441 :A8020F92: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-22 07:35:34.667331 :A802D4AE:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-22 07:35:34.979035 :A802D51D:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-22 07:35:34.974 2025-06-22 07:35:34.979036 :A802D51E:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=13936 pso_num=22 pso_serial#=61 2025-06-22 07:35:34.979177 :A802D51F:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=13936 osp_idx=0 osp_ver=338008 osp_pg=0 (spawn #310499) 2025-06-22 07:35:34.979178 :A802D520: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-22 07:35:34.979179 :A802D521:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=165 time=3553478172 2025-06-22 07:35:34.979179 :A802D522:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-22 07:35:34.979180 :A802D523:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-22 07:35:34.979180 :A802D524:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-22 07:35:34.979180 :A802D525:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-22 07:35:34.979181 :A802D526:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-22 07:35:34.979681 :A802D527: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-22 07:35:34.979729 :A802D530: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-22 07:45:35.896814 :A80399D5:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-22 07:45:36.307727 :A8039A4E:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-22 07:45:36.303 2025-06-22 07:45:36.307729 :A8039A4F:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=17024 pso_num=22 pso_serial#=62 2025-06-22 07:45:36.307870 :A8039A50:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=17024 osp_idx=0 osp_ver=338009 osp_pg=0 (spawn #310522) 2025-06-22 07:45:36.307871 :A8039A51: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-22 07:45:36.307871 :A8039A52:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=166 time=3554079500 2025-06-22 07:45:36.307871 :A8039A53:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-22 07:45:36.307872 :A8039A54:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-22 07:45:36.307872 :A8039A55:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-22 07:45:36.307872 :A8039A56:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-22 07:45:36.307873 :A8039A57:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-22 07:45:36.308374 :A8039A58: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-22 07:45:36.308420 :A8039A5F: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-22 07:55:37.166707 :A8045DE2:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-22 07:55:37.546496 :A8045E27:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-22 07:55:37.541 2025-06-22 07:55:37.546498 :A8045E28:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16408 pso_num=22 pso_serial#=63 2025-06-22 07:55:37.546638 :A8045E29:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=16408 osp_idx=0 osp_ver=338010 osp_pg=0 (spawn #310545) 2025-06-22 07:55:37.546638 :A8045E2A: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-22 07:55:37.546639 :A8045E2B:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=167 time=3554680735 2025-06-22 07:55:37.546639 :A8045E2C:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-22 07:55:37.546639 :A8045E2D:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-22 07:55:37.546639 :A8045E2E:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-22 07:55:37.546640 :A8045E2F:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-22 07:55:37.546640 :A8045E30:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-22 07:55:37.547142 :A8045E31: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-22 07:55:37.547205 :A8045E37: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-22 07:56:37.611260 :A80471B4:db_trace:ksl2.c@2477:kslwtbctx(): [10005:22:177] KSL WAIT BEG [latch free] 136537728/0x8236680 259/0x103 0/0x0 wait_id=13 seq_num=14 snap_id=1 2025-06-22 07:56:37.611282 :A80471B9:db_trace:ksl2.c@2611:kslwtectx(): [10005:22:177] KSL WAIT END [latch free] 136537728/0x8236680 259/0x103 0/0x0 wait_id=13 seq_num=14 snap_id=1 2025-06-22 07:56:37.611285 :A80471BA:db_trace:ksl2.c@2619:kslwtectx(): [10005:22:177] KSL WAIT END wait times (usecs) - snap=20, exc=20, tot=20 2025-06-22 08:05:38.357520 :A8052A8F:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-22 08:05:38.831146 :A8052AE0:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-22 08:05:38.826 2025-06-22 08:05:38.831148 :A8052AE1:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16916 pso_num=22 pso_serial#=64 2025-06-22 08:05:38.831292 :A8052AE2:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=16916 osp_idx=0 osp_ver=338011 osp_pg=0 (spawn #310570) 2025-06-22 08:05:38.831293 :A8052AE3: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-22 08:05:38.831293 :A8052AE4:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=168 time=3555282016 2025-06-22 08:05:38.831294 :A8052AE5:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-22 08:05:38.831294 :A8052AE6:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-22 08:05:38.831294 :A8052AE7:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-22 08:05:38.831295 :A8052AE8:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-22 08:05:38.831295 :A8052AE9:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-22 08:05:38.831817 :A8052AEA: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-22 08:05:38.831868 :A8052AF2: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-22 08:15:39.803569 :A805F2F1:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-22 08:15:40.214461 :A805F349:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-22 08:15:40.209 2025-06-22 08:15:40.214462 :A805F34A:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16776 pso_num=22 pso_serial#=65 2025-06-22 08:15:40.214602 :A805F34B:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=16776 osp_idx=0 osp_ver=338012 osp_pg=0 (spawn #310593) 2025-06-22 08:15:40.214603 :A805F34C: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-22 08:15:40.214603 :A805F34D:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=169 time=3555883407 2025-06-22 08:15:40.214603 :A805F34E:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-22 08:15:40.214604 :A805F34F:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-22 08:15:40.214604 :A805F350:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-22 08:15:40.214604 :A805F351:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-22 08:15:40.214605 :A805F352:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-22 08:15:40.215092 :A805F353: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-22 08:15:40.215149 :A805F359: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-22 08:25:41.021852 :A806B7EC:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-22 08:25:41.432721 :A806B849:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-22 08:25:41.428 2025-06-22 08:25:41.432723 :A806B84A:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=17704 pso_num=22 pso_serial#=66 2025-06-22 08:25:41.432854 :A806B84B:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=17704 osp_idx=0 osp_ver=338013 osp_pg=0 (spawn #310616) 2025-06-22 08:25:41.432855 :A806B84C: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-22 08:25:41.432855 :A806B84D:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=170 time=3556484625 2025-06-22 08:25:41.432856 :A806B84E:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-22 08:25:41.432856 :A806B84F:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-22 08:25:41.432856 :A806B850:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-22 08:25:41.432857 :A806B851:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-22 08:25:41.432857 :A806B852:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-22 08:25:41.433391 :A806B853: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-22 08:25:41.433437 :A806B85C: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: 17704, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de