Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250504140138\orcl_w000_9836_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250504140138\orcl_w000_9836_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:37581M/63366M, Ph+PgF:45123M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 25 Windows thread id: 9836, image: ORACLE.EXE (W000) *** 2025-05-04 14:01:38.160 *** SESSION ID:(201.35009) 2025-05-04 14:01:38.160 *** 2025-05-04 14:01:38.160 Process diagnostic dump for ORACLE.EXE (W000), OS id=9836, pid: 25, proc_ser: 125, sid: 201, sess_ser: 35009 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=78 seq_num=79 snap_id=1 wait times: snap=4.850831 sec, exc=4.850831 sec, total=4.850831 sec wait times: max=5.000000 sec, heur=6 min 30 sec wait counts: calls=1 os=1 in_wait=1 iflags=0x5a8 Wait State: fixed_waits=0 flags=0x22 boundary=0x0000000000000000/-1 Session Wait History: elapsed time of 0.000032 sec since current wait 0: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=77 seq_num=78 snap_id=1 wait times: snap=5.004613 sec, exc=5.004613 sec, total=5.004613 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000034 sec of elapsed time 1: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=76 seq_num=77 snap_id=1 wait times: snap=5.014714 sec, exc=5.014714 sec, total=5.014714 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000033 sec of elapsed time 2: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=75 seq_num=76 snap_id=1 wait times: snap=5.003028 sec, exc=5.003028 sec, total=5.003028 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000039 sec of elapsed time 3: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=74 seq_num=75 snap_id=1 wait times: snap=5.013604 sec, exc=5.013604 sec, total=5.013604 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000034 sec of elapsed time 4: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=73 seq_num=74 snap_id=1 wait times: snap=5.014771 sec, exc=5.014771 sec, total=5.014771 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000025 sec of elapsed time 5: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=72 seq_num=73 snap_id=1 wait times: snap=5.014723 sec, exc=5.014723 sec, total=5.014723 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000035 sec of elapsed time 6: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=71 seq_num=72 snap_id=1 wait times: snap=5.004613 sec, exc=5.004613 sec, total=5.004613 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000038 sec of elapsed time 7: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=70 seq_num=71 snap_id=1 wait times: snap=5.004612 sec, exc=5.004612 sec, total=5.004612 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000038 sec of elapsed time 8: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=69 seq_num=70 snap_id=1 wait times: snap=5.001663 sec, exc=5.001663 sec, total=5.001663 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000079 sec of elapsed time 9: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=68 seq_num=69 snap_id=1 wait times: snap=5.001275 sec, exc=5.001275 sec, total=5.001275 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000034 sec of elapsed time Sampled Session History of session 201 serial 35009 --------------------------------------------------- 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, 13:59:38 - 14:01:38] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-05-04 14:01:38.160 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 25 (osid: 9836, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-04 11:24:48.265645 :928C9309:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-04 11:24:48.266148 :928C930A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-04 11:24:48.266195 :928C9311:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-05-04 11:34:49.141614 :928D5933:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-04 11:34:49.552361 :928D599A:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-04 11:34:49.547 2025-05-04 11:34:49.552363 :928D599B:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=11460 pso_num=25 pso_serial#=112 2025-05-04 11:34:49.552502 :928D599C:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=11460 osp_idx=23 osp_ver=74571 osp_pg=0 (spawn #147267) 2025-05-04 11:34:49.552503 :928D599D:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-04 11:34:49.552503 :928D599E:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=249 time=3629266718 2025-05-04 11:34:49.552503 :928D599F:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-04 11:34:49.552504 :928D59A0:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-04 11:34:49.552504 :928D59A1:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-04 11:34:49.552504 :928D59A2:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-04 11:34:49.552504 :928D59A3:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-04 11:34:49.552999 :928D59A4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-04 11:34:49.553047 :928D59AB:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-05-04 11:44:50.538819 :928E1EF0:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-04 11:44:51.027363 :928E1F52:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-04 11:44:51.023 2025-05-04 11:44:51.027365 :928E1F53:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=996 pso_num=25 pso_serial#=113 2025-05-04 11:44:51.027508 :928E1F54:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=996 osp_idx=23 osp_ver=74572 osp_pg=0 (spawn #147289) 2025-05-04 11:44:51.027509 :928E1F55:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-04 11:44:51.027510 :928E1F56:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=250 time=3629868187 2025-05-04 11:44:51.027510 :928E1F57:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-04 11:44:51.027510 :928E1F58:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-04 11:44:51.027511 :928E1F59:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-04 11:44:51.027511 :928E1F5A:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-04 11:44:51.027511 :928E1F5B:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-04 11:44:51.028017 :928E1F5C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-04 11:44:51.028062 :928E1F63:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-05-04 11:54:51.953996 :928EE41B:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-04 11:54:52.328032 :928EE491:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-04 11:54:52.323 2025-05-04 11:54:52.328034 :928EE492:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=10276 pso_num=25 pso_serial#=114 2025-05-04 11:54:52.328173 :928EE493:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=10276 osp_idx=23 osp_ver=74573 osp_pg=0 (spawn #147312) 2025-05-04 11:54:52.328174 :928EE494:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-04 11:54:52.328176 :928EE495:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=251 time=3630469500 2025-05-04 11:54:52.328177 :928EE496:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-04 11:54:52.328177 :928EE497:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-04 11:54:52.328177 :928EE498:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-04 11:54:52.328178 :928EE499:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-04 11:54:52.328178 :928EE49A:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-04 11:54:52.328684 :928EE49B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-04 11:54:52.328732 :928EE4A2:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-05-04 12:04:53.219721 :928FAE14:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-04 12:04:53.677480 :928FAE58:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-04 12:04:53.673 2025-05-04 12:04:53.677482 :928FAE59:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=9980 pso_num=25 pso_serial#=115 2025-05-04 12:04:53.677615 :928FAE5A:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=9980 osp_idx=23 osp_ver=74574 osp_pg=0 (spawn #147340) 2025-05-04 12:04:53.677616 :928FAE5B:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-04 12:04:53.677616 :928FAE5C:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=252 time=3631070843 2025-05-04 12:04:53.677616 :928FAE5D:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-04 12:04:53.677617 :928FAE5E:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-04 12:04:53.677617 :928FAE5F:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-04 12:04:53.677617 :928FAE60:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-04 12:04:53.677618 :928FAE61:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-04 12:04:53.678175 :928FAE62:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-04 12:04:53.678231 :928FAE68:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-05-04 12:14:54.612215 :929078EC:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-04 12:14:54.976053 :9290792E:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-04 12:14:54.972 2025-05-04 12:14:54.976055 :9290792F:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=6600 pso_num=25 pso_serial#=116 2025-05-04 12:14:54.976180 :92907930:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=6600 osp_idx=23 osp_ver=74575 osp_pg=0 (spawn #147362) 2025-05-04 12:14:54.976181 :92907931:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-04 12:14:54.976181 :92907932:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=253 time=3631672140 2025-05-04 12:14:54.976182 :92907933:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-04 12:14:54.976182 :92907934:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-04 12:14:54.976182 :92907935:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-04 12:14:54.976183 :92907936:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-04 12:14:54.976183 :92907937:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-04 12:14:54.976659 :92907938:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-04 12:14:54.979932 :92907942:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-05-04 12:24:55.944428 :92913EB7:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-04 12:24:56.323869 :92913EEF:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-04 12:24:56.319 2025-05-04 12:24:56.323871 :92913EF0:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=10992 pso_num=25 pso_serial#=117 2025-05-04 12:24:56.324006 :92913EF1:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=10992 osp_idx=23 osp_ver=74576 osp_pg=0 (spawn #147385) 2025-05-04 12:24:56.324007 :92913EF2:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-04 12:24:56.324007 :92913EF3:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=254 time=3632273484 2025-05-04 12:24:56.324008 :92913EF4:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-04 12:24:56.324008 :92913EF5:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-04 12:24:56.324008 :92913EF6:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-04 12:24:56.324009 :92913EF7:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-04 12:24:56.324009 :92913EF8:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-04 12:24:56.324499 :92913EF9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-04 12:24:56.324543 :92913F00:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-05-04 12:34:57.191997 :929204E8:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-04 12:34:57.477948 :92920529:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-04 12:34:57.473 2025-05-04 12:34:57.477950 :9292052A:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=8072 pso_num=25 pso_serial#=118 2025-05-04 12:34:57.478090 :9292052B:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=8072 osp_idx=23 osp_ver=74577 osp_pg=0 (spawn #147408) 2025-05-04 12:34:57.478091 :9292052C:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-04 12:34:57.478091 :9292052D:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=255 time=3632874640 2025-05-04 12:34:57.478091 :9292052E:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-04 12:34:57.478092 :9292052F:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-04 12:34:57.478092 :92920530:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-04 12:34:57.478093 :92920531:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-04 12:34:57.478093 :92920532:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-04 12:34:57.478603 :92920533:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-04 12:34:57.478647 :9292053A:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-05-04 12:44:58.416180 :9292CA9A:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-04 12:44:58.717620 :9292CAD7:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-04 12:44:58.712 2025-05-04 12:44:58.717622 :9292CAD8:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=1112 pso_num=25 pso_serial#=119 2025-05-04 12:44:58.717753 :9292CAD9:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=1112 osp_idx=23 osp_ver=74578 osp_pg=0 (spawn #147430) 2025-05-04 12:44:58.717754 :9292CADA:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-04 12:44:58.717754 :9292CADB:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=0 time=3633475890 2025-05-04 12:44:58.717754 :9292CADC:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-04 12:44:58.717754 :9292CADD:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-04 12:44:58.717755 :9292CADE:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-04 12:44:58.717755 :9292CADF:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-04 12:44:58.717755 :9292CAE0:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-04 12:44:58.718252 :9292CAE1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-04 12:44:58.718297 :9292CAE9:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-05-04 12:54:59.655301 :92939001:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-04 12:55:00.019449 :92939039:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-04 12:55:00.014 2025-05-04 12:55:00.019451 :9293903A:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=580 pso_num=25 pso_serial#=120 2025-05-04 12:55:00.019595 :9293903B:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=580 osp_idx=23 osp_ver=74579 osp_pg=0 (spawn #147453) 2025-05-04 12:55:00.019596 :9293903C:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-04 12:55:00.019596 :9293903D:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=1 time=3634077187 2025-05-04 12:55:00.019596 :9293903E:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-04 12:55:00.019597 :9293903F:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-04 12:55:00.019597 :92939040:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-04 12:55:00.019598 :92939041:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-04 12:55:00.019598 :92939042:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-04 12:55:00.020100 :92939043:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-04 12:55:00.020147 :9293904D:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-05-04 12:56:33.150849 :9293AEA2:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-05-04 13:05:01.233362 :9294599A:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-05-04 13:15:02.322926 :929527DF:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-04 13:15:02.561631 :92952814:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-04 13:15:02.557 2025-05-04 13:15:02.561634 :92952815:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=9932 pso_num=25 pso_serial#=121 2025-05-04 13:15:02.561768 :92952816:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=9932 osp_idx=23 osp_ver=74580 osp_pg=0 (spawn #147502) 2025-05-04 13:15:02.561769 :92952817:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-04 13:15:02.561769 :92952818:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=2 time=3635279734 2025-05-04 13:15:02.561769 :92952819:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-04 13:15:02.561770 :9295281A:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-04 13:15:02.561770 :9295281B:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-04 13:15:02.561771 :9295281C:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-04 13:15:02.561771 :9295281D:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-04 13:15:02.562267 :9295281E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-04 13:15:02.562311 :92952826:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-05-04 13:25:03.431036 :9295EDA9:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-04 13:25:03.826220 :9295EDEA:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-04 13:25:03.822 2025-05-04 13:25:03.826222 :9295EDEB:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=11116 pso_num=25 pso_serial#=122 2025-05-04 13:25:03.826357 :9295EDEC:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=11116 osp_idx=23 osp_ver=74581 osp_pg=0 (spawn #147525) 2025-05-04 13:25:03.826357 :9295EDED:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-04 13:25:03.826357 :9295EDEE:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=3 time=3635881000 2025-05-04 13:25:03.826358 :9295EDEF:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-04 13:25:03.826358 :9295EDF0:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-04 13:25:03.826358 :9295EDF1:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-04 13:25:03.826359 :9295EDF2:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-04 13:25:03.826359 :9295EDF3:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-04 13:25:03.826913 :9295EDF4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-04 13:25:03.826956 :9295EDFB:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-05-04 13:35:04.606684 :9296B3C3:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-04 13:35:05.158118 :9296B44F:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-04 13:35:05.154 2025-05-04 13:35:05.158120 :9296B450:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=11816 pso_num=25 pso_serial#=123 2025-05-04 13:35:05.158256 :9296B451:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=11816 osp_idx=23 osp_ver=74582 osp_pg=0 (spawn #147548) 2025-05-04 13:35:05.158256 :9296B452:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-04 13:35:05.158257 :9296B453:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=4 time=3636482328 2025-05-04 13:35:05.158257 :9296B454:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-04 13:35:05.158257 :9296B455:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-04 13:35:05.158257 :9296B456:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-04 13:35:05.158258 :9296B457:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-04 13:35:05.158258 :9296B458:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-04 13:35:05.158745 :9296B459:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-04 13:35:05.158792 :9296B461:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-05-04 13:45:06.082458 :929779C4:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-04 13:45:06.446406 :92977A27:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-04 13:45:06.442 2025-05-04 13:45:06.446409 :92977A28:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=9344 pso_num=25 pso_serial#=124 2025-05-04 13:45:06.446544 :92977A29:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=9344 osp_idx=23 osp_ver=74583 osp_pg=0 (spawn #147570) 2025-05-04 13:45:06.446545 :92977A2A:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-04 13:45:06.446545 :92977A2B:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=5 time=3637083609 2025-05-04 13:45:06.446545 :92977A2C:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-04 13:45:06.446545 :92977A2D:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-04 13:45:06.446546 :92977A2E:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-04 13:45:06.446546 :92977A2F:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-04 13:45:06.446546 :92977A30:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-04 13:45:06.447048 :92977A31:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-04 13:45:06.447093 :92977A37:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-05-04 13:55:07.372051 :92983E7F:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-04 13:55:07.751779 :92983EE9:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-04 13:55:07.746 2025-05-04 13:55:07.751781 :92983EEA:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=9836 pso_num=25 pso_serial#=125 2025-05-04 13:55:07.751923 :92983EEB:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=9836 osp_idx=23 osp_ver=74584 osp_pg=0 (spawn #147593) 2025-05-04 13:55:07.751925 :92983EEC:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-04 13:55:07.751925 :92983EED:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=6 time=3637684921 2025-05-04 13:55:07.751926 :92983EEE:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-04 13:55:07.751926 :92983EEF:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-04 13:55:07.751927 :92983EF0:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-04 13:55:07.751927 :92983EF1:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-04 13:55:07.751927 :92983EF2:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-04 13:55:07.752420 :92983EF3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-04 13:55:07.752463 :92983EFA:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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 25 (osid: 9836, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de