Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250805082851\orcl_w000_14620_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250805082851\orcl_w000_14620_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:35714M/63366M, Ph+PgF:41261M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 25 Windows thread id: 14620, image: ORACLE.EXE (W000) *** 2025-08-05 08:28:51.906 *** SESSION ID:(201.45711) 2025-08-05 08:28:51.906 *** 2025-08-05 08:28:51.906 Process diagnostic dump for ORACLE.EXE (W000), OS id=14620, pid: 25, proc_ser: 57, sid: 201, sess_ser: 45711 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=121 seq_num=122 snap_id=1 wait times: snap=2.798394 sec, exc=2.798394 sec, total=2.798394 sec wait times: max=5.000000 sec, heur=2.798394 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.002087 sec since current wait 0: waited for 'Disk file operations I/O' FileOperation=0x2, fileno=0x1, filetype=0x2 wait_id=120 seq_num=121 snap_id=1 wait times: snap=0.000105 sec, exc=0.000105 sec, total=0.000105 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000188 sec of elapsed time 1: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=119 seq_num=120 snap_id=1 wait times: snap=3.876230 sec, exc=3.876230 sec, total=3.876230 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000028 sec of elapsed time 2: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=118 seq_num=119 snap_id=1 wait times: snap=5.001720 sec, exc=5.001720 sec, total=5.001720 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000029 sec of elapsed time 3: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=117 seq_num=118 snap_id=1 wait times: snap=5.001335 sec, exc=5.001335 sec, total=5.001335 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000028 sec of elapsed time 4: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=116 seq_num=117 snap_id=1 wait times: snap=5.000335 sec, exc=5.000335 sec, total=5.000335 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000023 sec of elapsed time 5: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=115 seq_num=116 snap_id=1 wait times: snap=5.007529 sec, exc=5.007529 sec, total=5.007529 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=114 seq_num=115 snap_id=1 wait times: snap=5.014730 sec, exc=5.014730 sec, total=5.014730 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000023 sec of elapsed time 7: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=113 seq_num=114 snap_id=1 wait times: snap=5.010147 sec, exc=5.010147 sec, total=5.010147 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000022 sec of elapsed time 8: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=112 seq_num=113 snap_id=1 wait times: snap=5.014741 sec, exc=5.014741 sec, total=5.014741 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000022 sec of elapsed time 9: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=111 seq_num=112 snap_id=1 wait times: snap=5.004655 sec, exc=5.004655 sec, total=5.004655 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000022 sec of elapsed time Sampled Session History of session 201 serial 45711 --------------------------------------------------- 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:26:51 - 08:28:51] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-08-05 08:28:51.906 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 25 (osid: 14620, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-08-05 06:07:37.432999 :BB8C089B:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=8216 osp_idx=23 osp_ver=228635 osp_pg=0 (spawn #456955) 2025-08-05 06:07:37.433000 :BB8C089C:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-05 06:07:37.433000 :BB8C089D:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=31 time=3054726736 2025-08-05 06:07:37.433001 :BB8C089E:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-05 06:07:37.433001 :BB8C089F:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-05 06:07:37.433002 :BB8C08A0:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-05 06:07:37.433002 :BB8C08A1:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-05 06:07:37.433002 :BB8C08A2:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-05 06:07:37.433587 :BB8C08A3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-05 06:08:07.513649 :BB8C12B2:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-05 06:08:37.822810 :BB8C1D1A:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-05 06:08:37.818 2025-08-05 06:08:37.822812 :BB8C1D1B:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=19904 pso_num=25 pso_serial#=44 2025-08-05 06:08:37.822951 :BB8C1D1C:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=19904 osp_idx=23 osp_ver=228636 osp_pg=0 (spawn #456959) 2025-08-05 06:08:37.822952 :BB8C1D1D:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-05 06:08:37.822952 :BB8C1D1E:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=32 time=3054787126 2025-08-05 06:08:37.822953 :BB8C1D1F:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-05 06:08:37.822953 :BB8C1D20:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-05 06:08:37.822953 :BB8C1D21:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-05 06:08:37.822954 :BB8C1D22:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-05 06:08:37.822954 :BB8C1D23:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-05 06:08:37.823461 :BB8C1D24: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-08-05 06:08:37.823510 :BB8C1D2C: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-08-05 06:18:38.623806 :BB8CE7AC:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-05 06:18:39.138570 :BB8CE7F9:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-05 06:18:39.134 2025-08-05 06:18:39.138573 :BB8CE7FA:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=20056 pso_num=25 pso_serial#=45 2025-08-05 06:18:39.138708 :BB8CE7FB:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=20056 osp_idx=23 osp_ver=228637 osp_pg=0 (spawn #456981) 2025-08-05 06:18:39.138709 :BB8CE7FC:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-05 06:18:39.138709 :BB8CE7FD:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=33 time=3055388439 2025-08-05 06:18:39.138710 :BB8CE7FE:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-05 06:18:39.138710 :BB8CE7FF:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-05 06:18:39.138711 :BB8CE800:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-05 06:18:39.138711 :BB8CE801:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-05 06:18:39.138711 :BB8CE802:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-05 06:18:39.139209 :BB8CE803: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-08-05 06:18:39.139254 :BB8CE80B: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-08-05 06:27:35.532999 :BB8D9A32: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-08-05 06:28:40.303130 :BB8DB0DC: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-08-05 06:38:41.035161 :BB8E7ACA:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-05 06:38:41.617723 :BB8E7B0E:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-05 06:38:41.613 2025-08-05 06:38:41.617725 :BB8E7B0F:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=12948 pso_num=25 pso_serial#=46 2025-08-05 06:38:41.617869 :BB8E7B10:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=12948 osp_idx=23 osp_ver=228638 osp_pg=0 (spawn #457026) 2025-08-05 06:38:41.617869 :BB8E7B11:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-05 06:38:41.617870 :BB8E7B12:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=34 time=3056590923 2025-08-05 06:38:41.617870 :BB8E7B13:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-05 06:38:41.617871 :BB8E7B14:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-05 06:38:41.617871 :BB8E7B15:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-05 06:38:41.617871 :BB8E7B16:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-05 06:38:41.617871 :BB8E7B17:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-05 06:38:41.618372 :BB8E7B18: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-08-05 06:38:41.618424 :BB8E7B20: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-08-05 06:48:42.346943 :BB8F445E:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-05 06:48:42.851851 :BB8F44B3:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-05 06:48:42.847 2025-08-05 06:48:42.851853 :BB8F44B4:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=14108 pso_num=25 pso_serial#=47 2025-08-05 06:48:42.851999 :BB8F44B5:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=14108 osp_idx=23 osp_ver=228639 osp_pg=0 (spawn #457048) 2025-08-05 06:48:42.852000 :BB8F44B6:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-05 06:48:42.852000 :BB8F44B7:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=35 time=3057192158 2025-08-05 06:48:42.852001 :BB8F44B8:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-05 06:48:42.852001 :BB8F44B9:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-05 06:48:42.852002 :BB8F44BA:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-05 06:48:42.852002 :BB8F44BB:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-05 06:48:42.852002 :BB8F44BC:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-05 06:48:42.852525 :BB8F44BD: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-08-05 06:48:42.852575 :BB8F44C5: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-08-05 06:58:43.659681 :BB900D49:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-05 06:58:44.195572 :BB900D8E:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-05 06:58:44.191 2025-08-05 06:58:44.195574 :BB900D8F:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=18448 pso_num=25 pso_serial#=48 2025-08-05 06:58:44.195715 :BB900D90:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=18448 osp_idx=23 osp_ver=228640 osp_pg=0 (spawn #457071) 2025-08-05 06:58:44.195715 :BB900D91:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-05 06:58:44.195716 :BB900D92:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=36 time=3057793501 2025-08-05 06:58:44.195716 :BB900D93:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-05 06:58:44.195717 :BB900D94:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-05 06:58:44.195717 :BB900D95:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-05 06:58:44.195718 :BB900D96:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-05 06:58:44.195718 :BB900D97:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-05 06:58:44.196211 :BB900D98: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-08-05 06:58:44.196255 :BB900DA1: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-08-05 07:08:45.024700 :BB90E1CE:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-05 07:08:45.586451 :BB90E20D:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-05 07:08:45.581 2025-08-05 07:08:45.586454 :BB90E20E:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=6464 pso_num=25 pso_serial#=49 2025-08-05 07:08:45.586624 :BB90E20F:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=6464 osp_idx=23 osp_ver=228641 osp_pg=0 (spawn #457097) 2025-08-05 07:08:45.586625 :BB90E210:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-05 07:08:45.586626 :BB90E211:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=37 time=3058394892 2025-08-05 07:08:45.586627 :BB90E212:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-05 07:08:45.586627 :BB90E213:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-05 07:08:45.586627 :BB90E214:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-05 07:08:45.586628 :BB90E215:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-05 07:08:45.586628 :BB90E216:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-05 07:08:45.587143 :BB90E217: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-08-05 07:08:45.587187 :BB90E220: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-08-05 07:18:46.335599 :BB91AA53:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-05 07:18:46.855989 :BB91AAA0:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-05 07:18:46.851 2025-08-05 07:18:46.855991 :BB91AAA1:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=16340 pso_num=25 pso_serial#=50 2025-08-05 07:18:46.856129 :BB91AAA2:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=16340 osp_idx=23 osp_ver=228642 osp_pg=0 (spawn #457119) 2025-08-05 07:18:46.856130 :BB91AAA3:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-05 07:18:46.856131 :BB91AAA4:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=38 time=3058996158 2025-08-05 07:18:46.856131 :BB91AAA5:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-05 07:18:46.856131 :BB91AAA6:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-05 07:18:46.856132 :BB91AAA7:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-05 07:18:46.856132 :BB91AAA8:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-05 07:18:46.856132 :BB91AAA9:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-05 07:18:46.856642 :BB91AAAA: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-08-05 07:18:46.856691 :BB91AAB2: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-08-05 07:28:47.691109 :BB92727C:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-05 07:28:48.211781 :BB9272CA:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-05 07:28:48.207 2025-08-05 07:28:48.211783 :BB9272CB:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=19316 pso_num=25 pso_serial#=51 2025-08-05 07:28:48.211920 :BB9272CC:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=19316 osp_idx=23 osp_ver=228643 osp_pg=0 (spawn #457142) 2025-08-05 07:28:48.211920 :BB9272CD:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-05 07:28:48.211921 :BB9272CE:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=39 time=3059597517 2025-08-05 07:28:48.211921 :BB9272CF:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-05 07:28:48.211921 :BB9272D0:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-05 07:28:48.211922 :BB9272D1:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-05 07:28:48.211922 :BB9272D2:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-05 07:28:48.211922 :BB9272D3:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-05 07:28:48.212411 :BB9272D4: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-08-05 07:28:48.212454 :BB9272DC: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-08-05 07:38:48.997611 :BB933BA4:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-05 07:38:49.424312 :BB933BE3:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-05 07:38:49.420 2025-08-05 07:38:49.424314 :BB933BE4:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=1020 pso_num=25 pso_serial#=52 2025-08-05 07:38:49.424455 :BB933BE5:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=1020 osp_idx=23 osp_ver=228644 osp_pg=0 (spawn #457165) 2025-08-05 07:38:49.424456 :BB933BE6:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-05 07:38:49.424456 :BB933BE7:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=40 time=3060198736 2025-08-05 07:38:49.424457 :BB933BE8:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-05 07:38:49.424457 :BB933BE9:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-05 07:38:49.424458 :BB933BEA:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-05 07:38:49.424458 :BB933BEB:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-05 07:38:49.424458 :BB933BEC:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-05 07:38:49.424960 :BB933BED: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-08-05 07:38:49.425006 :BB933BF4: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-08-05 07:48:50.190024 :BB9404AE:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-05 07:48:50.585420 :BB9404FF:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-05 07:48:50.581 2025-08-05 07:48:50.585422 :BB940500:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=12076 pso_num=25 pso_serial#=53 2025-08-05 07:48:50.585556 :BB940501:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=12076 osp_idx=23 osp_ver=228645 osp_pg=0 (spawn #457187) 2025-08-05 07:48:50.585557 :BB940502:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-05 07:48:50.585557 :BB940503:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=41 time=3060799892 2025-08-05 07:48:50.585558 :BB940504:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-05 07:48:50.585558 :BB940505:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-05 07:48:50.585558 :BB940506:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-05 07:48:50.585558 :BB940507:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-05 07:48:50.585559 :BB940508:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-05 07:48:50.586061 :BB940509: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-08-05 07:48:50.586106 :BB940513: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-08-05 07:58:51.327742 :BB94CD9B:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-05 07:58:51.649074 :BB94CDAB:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-05 07:58:51.640 2025-08-05 07:58:51.649076 :BB94CDAC:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=20416 pso_num=25 pso_serial#=54 2025-08-05 07:58:51.649224 :BB94CDAD:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=20416 (legacy spawn) 2025-08-05 07:58:51.655727 :BB94CDAE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-05 07:58:51.655891 :BB94CDB3:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-08-05 07:58:51.656698 :BB94CDB8:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-05 07:58:51.910571 :BB94CDFB:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-05 07:58:51.905 2025-08-05 07:58:51.910572 :BB94CDFC:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=19116 pso_num=25 pso_serial#=55 2025-08-05 07:58:51.910709 :BB94CDFD:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=19116 osp_idx=23 osp_ver=228647 osp_pg=0 (spawn #457211) 2025-08-05 07:58:51.910710 :BB94CDFE:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-05 07:58:51.910710 :BB94CDFF:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=42 time=3061401220 2025-08-05 07:58:51.910710 :BB94CE00:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-05 07:58:51.910711 :BB94CE01:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-05 07:58:51.910711 :BB94CE02:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-05 07:58:51.910711 :BB94CE03:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-05 07:58:51.910712 :BB94CE04:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-05 07:58:51.911204 :BB94CE05: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-08-05 07:58:51.911249 :BB94CE0F: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-08-05 08:08:52.694259 :BB95A130:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-05 08:08:53.120973 :BB95A174:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-05 08:08:53.115 2025-08-05 08:08:53.120975 :BB95A175:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=19716 pso_num=25 pso_serial#=56 2025-08-05 08:08:53.121111 :BB95A176:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=19716 osp_idx=23 osp_ver=228648 osp_pg=0 (spawn #457237) 2025-08-05 08:08:53.121112 :BB95A177:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-05 08:08:53.121112 :BB95A178:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=43 time=3062002423 2025-08-05 08:08:53.121113 :BB95A179:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-05 08:08:53.121113 :BB95A17A:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-05 08:08:53.121113 :BB95A17B:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-05 08:08:53.121114 :BB95A17C:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-05 08:08:53.121114 :BB95A17D:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-05 08:08:53.121593 :BB95A17E: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-08-05 08:08:53.121643 :BB95A186: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-08-05 08:18:54.018461 :BB966964:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-05 08:18:54.368986 :BB9669B3:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-05 08:18:54.364 2025-08-05 08:18:54.368987 :BB9669B4:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=14620 pso_num=25 pso_serial#=57 2025-08-05 08:18:54.369122 :BB9669B5:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=14620 osp_idx=23 osp_ver=228649 osp_pg=0 (spawn #457259) 2025-08-05 08:18:54.369123 :BB9669B6:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-05 08:18:54.369123 :BB9669B7:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=44 time=3062603673 2025-08-05 08:18:54.369124 :BB9669B8:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-05 08:18:54.369124 :BB9669B9:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-05 08:18:54.369124 :BB9669BA:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-05 08:18:54.369125 :BB9669BB:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-05 08:18:54.369125 :BB9669BC:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-05 08:18:54.369655 :BB9669BD: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-08-05 08:18:54.369698 :BB9669C5: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-08-05 08:28:49.111156 :BB9769D9: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 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 25 (osid: 14620, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de