Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250802220651\orcl_w000_19792_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250802220651\orcl_w000_19792_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:35819M/63366M, Ph+PgF:41461M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 22 Windows thread id: 19792, image: ORACLE.EXE (W000) *** 2025-08-02 22:06:51.283 *** SESSION ID:(177.19685) 2025-08-02 22:06:51.283 *** 2025-08-02 22:06:51.283 Process diagnostic dump for ORACLE.EXE (W000), OS id=19792, pid: 22, proc_ser: 153, sid: 177, sess_ser: 19685 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=59 seq_num=60 snap_id=1 wait times: snap=3.198761 sec, exc=3.198761 sec, total=3.198761 sec wait times: max=5.000000 sec, heur=4 min 53 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.000042 sec since current wait 0: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=58 seq_num=59 snap_id=1 wait times: snap=5.014733 sec, exc=5.014733 sec, total=5.014733 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000032 sec of elapsed time 1: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=57 seq_num=58 snap_id=1 wait times: snap=5.004657 sec, exc=5.004657 sec, total=5.004657 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000037 sec of elapsed time 2: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=56 seq_num=57 snap_id=1 wait times: snap=5.008313 sec, exc=5.008313 sec, total=5.008313 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000036 sec of elapsed time 3: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=55 seq_num=56 snap_id=1 wait times: snap=5.000265 sec, exc=5.000265 sec, total=5.000265 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000041 sec of elapsed time 4: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=54 seq_num=55 snap_id=1 wait times: snap=5.000433 sec, exc=5.000433 sec, total=5.000433 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000033 sec of elapsed time 5: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=53 seq_num=54 snap_id=1 wait times: snap=5.005746 sec, exc=5.005746 sec, total=5.005746 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000034 sec of elapsed time 6: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=52 seq_num=53 snap_id=1 wait times: snap=5.009152 sec, exc=5.009152 sec, total=5.009152 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000030 sec of elapsed time 7: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=51 seq_num=52 snap_id=1 wait times: snap=5.004616 sec, exc=5.004616 sec, total=5.004616 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000036 sec of elapsed time 8: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=50 seq_num=51 snap_id=1 wait times: snap=5.010668 sec, exc=5.010668 sec, total=5.010668 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000036 sec of elapsed time 9: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=49 seq_num=50 snap_id=1 wait times: snap=5.000595 sec, exc=5.000595 sec, total=5.000595 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000038 sec of elapsed time Sampled Session History of session 177 serial 19685 --------------------------------------------------- The sampled session history is constructed by sampling the target session every 1 second. The sampling process captures at each sample if the session is in a non-idle wait, an idle wait, or not in a wait. If the session is in a non-idle wait then one interval is shown for all the samples the session was in the same non-idle wait. If the session is in an idle wait or not in a wait for consecutive samples then one interval is shown for all the consecutive samples. Though we display these consecutive samples in a single interval the session may NOT be continuously idle or not in a wait (the sampling process does not know). The history is displayed in reverse chronological order. sample interval: 1 sec, max history 120 sec --------------------------------------------------- [121 samples, 22:04:51 - 22:06:51] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-08-02 22:06:51.283 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 22 (osid: 19792, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-08-02 19:41:41.131181 :BA750DD2:db_trace:ksl2.c@2477:kslwtbctx(): [10005:22:177] KSL WAIT BEG [latch free] 136537728/0x8236680 259/0x103 0/0x0 wait_id=123 seq_num=124 snap_id=1 2025-08-02 19:41:41.131190 :BA750DD7:db_trace:ksl2.c@2611:kslwtectx(): [10005:22:177] KSL WAIT END [latch free] 136537728/0x8236680 259/0x103 0/0x0 wait_id=123 seq_num=124 snap_id=1 2025-08-02 19:41:41.131190 :BA750DD8:db_trace:ksl2.c@2619:kslwtectx(): [10005:22:177] KSL WAIT END wait times (usecs) - snap=8, exc=8, tot=8 2025-08-02 19:51:41.963839 :BA75D3FC:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-02 19:51:42.328008 :BA75D445:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-02 19:51:42.323 2025-08-02 19:51:42.328010 :BA75D446:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=6024 pso_num=22 pso_serial#=139 2025-08-02 19:51:42.328145 :BA75D447:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=6024 osp_idx=0 osp_ver=477061 osp_pg=0 (spawn #448848) 2025-08-02 19:51:42.328146 :BA75D448:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-02 19:51:42.328146 :BA75D449:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=54 time=2844971642 2025-08-02 19:51:42.328147 :BA75D44A:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-02 19:51:42.328147 :BA75D44B:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-02 19:51:42.328148 :BA75D44C:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-02 19:51:42.328148 :BA75D44D:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-02 19:51:42.328148 :BA75D44E:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-02 19:51:42.328644 :BA75D44F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-02 19:51:42.328690 :BA75D456:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-02 20:01:43.060175 :BA769E35:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-02 20:01:43.471244 :BA769E68:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-02 20:01:43.466 2025-08-02 20:01:43.471246 :BA769E69:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=13284 pso_num=22 pso_serial#=140 2025-08-02 20:01:43.471382 :BA769E6A:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=13284 osp_idx=0 osp_ver=477062 osp_pg=0 (spawn #448874) 2025-08-02 20:01:43.471383 :BA769E6B:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-02 20:01:43.471384 :BA769E6C:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=55 time=2845572783 2025-08-02 20:01:43.471384 :BA769E6D:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-02 20:01:43.471385 :BA769E6E:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-02 20:01:43.471385 :BA769E6F:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-02 20:01:43.471385 :BA769E70:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-02 20:01:43.471386 :BA769E71:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-02 20:01:43.471879 :BA769E72:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-02 20:01:43.471924 :BA769E79:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-02 20:11:44.286102 :BA776BB4:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-02 20:11:44.712767 :BA776BF7:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-02 20:11:44.707 2025-08-02 20:11:44.712769 :BA776BF8:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=19484 pso_num=22 pso_serial#=141 2025-08-02 20:11:44.712905 :BA776BF9:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=19484 osp_idx=0 osp_ver=477063 osp_pg=0 (spawn #448897) 2025-08-02 20:11:44.712905 :BA776BFA:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-02 20:11:44.712905 :BA776BFB:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=56 time=2846174017 2025-08-02 20:11:44.712905 :BA776BFC:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-02 20:11:44.712906 :BA776BFD:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-02 20:11:44.712906 :BA776BFE:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-02 20:11:44.712907 :BA776BFF:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-02 20:11:44.712907 :BA776C00:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-02 20:11:44.713415 :BA776C01:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-02 20:11:44.713459 :BA776C08:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-02 20:21:45.559636 :BA783579:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-02 20:21:45.939477 :BA7835B2:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-02 20:21:45.934 2025-08-02 20:21:45.939479 :BA7835B3:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=14620 pso_num=22 pso_serial#=142 2025-08-02 20:21:45.939615 :BA7835B4:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=14620 osp_idx=0 osp_ver=477064 osp_pg=0 (spawn #448920) 2025-08-02 20:21:45.939616 :BA7835B5:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-02 20:21:45.939616 :BA7835B6:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=57 time=2846775251 2025-08-02 20:21:45.939617 :BA7835B7:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-02 20:21:45.939617 :BA7835B8:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-02 20:21:45.939617 :BA7835B9:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-02 20:21:45.939618 :BA7835BA:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-02 20:21:45.939618 :BA7835BB:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-02 20:21:45.940111 :BA7835BC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-02 20:21:45.940158 :BA7835C2:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-02 20:31:46.812552 :BA78FC2B:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-02 20:31:47.114199 :BA78FC5F:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-02 20:31:47.110 2025-08-02 20:31:47.114201 :BA78FC60:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=11816 pso_num=22 pso_serial#=143 2025-08-02 20:31:47.114345 :BA78FC61:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=11816 osp_idx=0 osp_ver=477065 osp_pg=0 (spawn #448943) 2025-08-02 20:31:47.114346 :BA78FC62:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-02 20:31:47.114346 :BA78FC63:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=58 time=2847376423 2025-08-02 20:31:47.114347 :BA78FC64:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-02 20:31:47.114347 :BA78FC65:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-02 20:31:47.114347 :BA78FC66:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-02 20:31:47.114348 :BA78FC67:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-02 20:31:47.114348 :BA78FC68:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-02 20:31:47.114857 :BA78FC69:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-02 20:31:47.114901 :BA78FC71:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-02 20:41:47.964442 :BA79C34C:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-02 20:41:48.318321 :BA79C37F:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-02 20:41:48.313 2025-08-02 20:41:48.318323 :BA79C380:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=5028 pso_num=22 pso_serial#=144 2025-08-02 20:41:48.318483 :BA79C381:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=5028 osp_idx=0 osp_ver=477066 osp_pg=0 (spawn #448965) 2025-08-02 20:41:48.318484 :BA79C382:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-02 20:41:48.318485 :BA79C383:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=59 time=2847977626 2025-08-02 20:41:48.318485 :BA79C384:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-02 20:41:48.318485 :BA79C385:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-02 20:41:48.318486 :BA79C386:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-02 20:41:48.318486 :BA79C387:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-02 20:41:48.318487 :BA79C388:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-02 20:41:48.319084 :BA79C389:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-02 20:41:48.319139 :BA79C390:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-02 20:51:49.137520 :BA7A8998:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-02 20:51:49.522408 :BA7A89FE:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-02 20:51:49.517 2025-08-02 20:51:49.522410 :BA7A89FF:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=19020 pso_num=22 pso_serial#=145 2025-08-02 20:51:49.522550 :BA7A8A00:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=19020 osp_idx=0 osp_ver=477067 osp_pg=0 (spawn #448988) 2025-08-02 20:51:49.522550 :BA7A8A01:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-02 20:51:49.522551 :BA7A8A02:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=60 time=2848578829 2025-08-02 20:51:49.522553 :BA7A8A03:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-02 20:51:49.522553 :BA7A8A04:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-02 20:51:49.522554 :BA7A8A05:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-02 20:51:49.522554 :BA7A8A06:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-02 20:51:49.522554 :BA7A8A07:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-02 20:51:49.523050 :BA7A8A08:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-02 20:51:49.523099 :BA7A8A12:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-02 21:01:50.405326 :BA7B537D:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-02 21:01:50.660243 :BA7B53E1:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-02 21:01:50.655 2025-08-02 21:01:50.660245 :BA7B53E2:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=4428 pso_num=22 pso_serial#=146 2025-08-02 21:01:50.660391 :BA7B53E3:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=4428 osp_idx=0 osp_ver=477068 osp_pg=0 (spawn #449013) 2025-08-02 21:01:50.660392 :BA7B53E4:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-02 21:01:50.660392 :BA7B53E5:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=61 time=2849179970 2025-08-02 21:01:50.660392 :BA7B53E6:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-02 21:01:50.660393 :BA7B53E7:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-02 21:01:50.660393 :BA7B53E8:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-02 21:01:50.660394 :BA7B53E9:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-02 21:01:50.660394 :BA7B53EA:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-02 21:01:50.660901 :BA7B53EB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-02 21:01:50.660948 :BA7B53F3:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-02 21:11:51.485987 :BA7C215C:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-02 21:11:51.686534 :BA7C215F:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-02 21:11:51.673 2025-08-02 21:11:51.686537 :BA7C2160:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=19176 pso_num=22 pso_serial#=147 2025-08-02 21:11:51.686672 :BA7C2161:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=19176 (legacy spawn) 2025-08-02 21:11:51.693214 :BA7C2162:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-02 21:11:51.693392 :BA7C2168:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-08-02 21:11:51.694191 :BA7C216C:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-02 21:11:51.702810 :BA7C216F:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-02 21:11:51.689 2025-08-02 21:11:51.702812 :BA7C2170:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=15216 pso_num=22 pso_serial#=148 2025-08-02 21:11:51.702944 :BA7C2171:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=15216 (legacy spawn) 2025-08-02 21:11:51.709470 :BA7C2172:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-02 21:11:51.709642 :BA7C217B:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-08-02 21:11:51.710451 :BA7C217C:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-02 21:11:51.912360 :BA7C21B2:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-02 21:11:51.908 2025-08-02 21:11:51.912363 :BA7C21B3:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=3388 pso_num=22 pso_serial#=149 2025-08-02 21:11:51.912545 :BA7C21B4:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=3388 osp_idx=0 osp_ver=477071 osp_pg=0 (spawn #449036) 2025-08-02 21:11:51.912545 :BA7C21B5:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-02 21:11:51.912546 :BA7C21B6:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=62 time=2849781220 2025-08-02 21:11:51.912546 :BA7C21B7:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-02 21:11:51.912546 :BA7C21B8:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-02 21:11:51.912547 :BA7C21B9:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-02 21:11:51.912547 :BA7C21BA:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-02 21:11:51.912548 :BA7C21BB:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-02 21:11:51.913046 :BA7C21BC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-02 21:11:51.913096 :BA7C21C4:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-02 21:21:52.670433 :BA7CEAE1:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-02 21:21:53.034498 :BA7CEB22:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-02 21:21:53.029 2025-08-02 21:21:53.034500 :BA7CEB23:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=19464 pso_num=22 pso_serial#=150 2025-08-02 21:21:53.034638 :BA7CEB24:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=19464 osp_idx=0 osp_ver=477072 osp_pg=0 (spawn #449059) 2025-08-02 21:21:53.034639 :BA7CEB25:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-02 21:21:53.034639 :BA7CEB26:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=63 time=2850382345 2025-08-02 21:21:53.034640 :BA7CEB27:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-02 21:21:53.034640 :BA7CEB28:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-02 21:21:53.034640 :BA7CEB29:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-02 21:21:53.034641 :BA7CEB2A:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-02 21:21:53.034641 :BA7CEB2B:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-02 21:21:53.035140 :BA7CEB2C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-02 21:21:53.035187 :BA7CEB33:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-02 21:31:53.794367 :BA7DB21D:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-02 21:31:54.223154 :BA7DB253:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-02 21:31:54.218 2025-08-02 21:31:54.223156 :BA7DB254:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=20388 pso_num=22 pso_serial#=151 2025-08-02 21:31:54.223296 :BA7DB255:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=20388 osp_idx=0 osp_ver=477073 osp_pg=0 (spawn #449082) 2025-08-02 21:31:54.223297 :BA7DB256:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-02 21:31:54.223297 :BA7DB257:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=64 time=2850983533 2025-08-02 21:31:54.223298 :BA7DB258:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-02 21:31:54.223298 :BA7DB259:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-02 21:31:54.223299 :BA7DB25A:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-02 21:31:54.223299 :BA7DB25B:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-02 21:31:54.223299 :BA7DB25C:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-02 21:31:54.223809 :BA7DB25D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-02 21:31:54.223857 :BA7DB265:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-02 21:39:51.508568 :BA7E50A2:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=16 loc='ksl2.h LINE:2165 ID:kslpsr' id1=255 id2=0 name=EV type=0 fac#=0 facpost=1 2025-08-02 21:41:55.395447 :BA7E79B5:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksl2.h LINE:2165 ID:kslpsr' id1=255 id2=0 name=EV type=0 fac#=0 facpost=1 2025-08-02 21:51:56.226526 :BA7F4017:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-02 21:51:56.559251 :BA7F404F:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-02 21:51:56.555 2025-08-02 21:51:56.559253 :BA7F4050:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=15516 pso_num=22 pso_serial#=152 2025-08-02 21:51:56.559397 :BA7F4051:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=15516 osp_idx=0 osp_ver=477074 osp_pg=0 (spawn #449128) 2025-08-02 21:51:56.559398 :BA7F4052:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-02 21:51:56.559399 :BA7F4053:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=65 time=2852185861 2025-08-02 21:51:56.559399 :BA7F4054:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-02 21:51:56.559399 :BA7F4055:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-02 21:51:56.559400 :BA7F4056:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-02 21:51:56.559400 :BA7F4057:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-02 21:51:56.559400 :BA7F4058:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-02 21:51:56.559906 :BA7F4059:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-02 21:51:56.559953 :BA7F4061:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-02 22:01:57.433549 :BA8008C0:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-02 22:01:57.766312 :BA8008F8:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-02 22:01:57.762 2025-08-02 22:01:57.766314 :BA8008F9:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=19792 pso_num=22 pso_serial#=153 2025-08-02 22:01:57.766457 :BA8008FA:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=19792 osp_idx=0 osp_ver=477075 osp_pg=0 (spawn #449153) 2025-08-02 22:01:57.766458 :BA8008FB:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-02 22:01:57.766458 :BA8008FC:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=66 time=2852787079 2025-08-02 22:01:57.766459 :BA8008FD:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-02 22:01:57.766459 :BA8008FE:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-02 22:01:57.766460 :BA8008FF:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-02 22:01:57.766460 :BA800900:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-02 22:01:57.766461 :BA800901:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-02 22:01:57.766952 :BA800902:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-02 22:01:57.766996 :BA80090A: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: 19792, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de