Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250703220008\orcl_w000_14500_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250703220008\orcl_w000_14500_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:36974M/63366M, Ph+PgF:42880M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 22 Windows thread id: 14500, image: ORACLE.EXE (W000) *** 2025-07-03 22:00:08.733 *** SESSION ID:(177.34763) 2025-07-03 22:00:08.733 *** 2025-07-03 22:00:08.733 Process diagnostic dump for ORACLE.EXE (W000), OS id=14500, pid: 22, proc_ser: 191, sid: 177, sess_ser: 34763 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=117 seq_num=118 snap_id=1 wait times: snap=2.094792 sec, exc=2.094792 sec, total=2.094792 sec wait times: max=5.000000 sec, heur=9 min 43 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.000022 sec since current wait 0: 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.014717 sec, exc=5.014717 sec, total=5.014717 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000023 sec of elapsed time 1: 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.007232 sec, exc=5.007232 sec, total=5.007232 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=114 seq_num=115 snap_id=1 wait times: snap=5.001246 sec, exc=5.001246 sec, total=5.001246 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000020 sec of elapsed time 3: 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.008428 sec, exc=5.008428 sec, total=5.008428 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=112 seq_num=113 snap_id=1 wait times: snap=5.003675 sec, exc=5.003675 sec, total=5.003675 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=111 seq_num=112 snap_id=1 wait times: snap=5.010152 sec, exc=5.010152 sec, total=5.010152 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000024 sec of elapsed time 6: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=110 seq_num=111 snap_id=1 wait times: snap=5.014713 sec, exc=5.014713 sec, total=5.014713 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=109 seq_num=110 snap_id=1 wait times: snap=5.009704 sec, exc=5.009704 sec, total=5.009704 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000039 sec of elapsed time 8: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=108 seq_num=109 snap_id=1 wait times: snap=5.003210 sec, exc=5.003210 sec, total=5.003210 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000038 sec of elapsed time 9: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=107 seq_num=108 snap_id=1 wait times: snap=5.000302 sec, exc=5.000302 sec, total=5.000302 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000032 sec of elapsed time Sampled Session History of session 177 serial 34763 --------------------------------------------------- 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, 21:58:08 - 22:00:08] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-07-03 22:00:08.733 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 22 (osid: 14500, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-07-03 19:20:06.339847 :AD163339:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-03 19:20:06.340356 :AD16333A: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-07-03 19:20:06.340404 :AD163343: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-07-03 19:30:07.143440 :AD16F5D0:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-03 19:30:07.565195 :AD16F616:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-03 19:30:07.559 2025-07-03 19:30:07.565197 :AD16F617:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=15420 pso_num=22 pso_serial#=178 2025-07-03 19:30:07.565341 :AD16F618:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=15420 osp_idx=0 osp_ver=372550 osp_pg=0 (spawn #348813) 2025-07-03 19:30:07.565341 :AD16F619:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-03 19:30:07.565342 :AD16F61A:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=229 time=251783454 2025-07-03 19:30:07.565342 :AD16F61B:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-03 19:30:07.565343 :AD16F61C:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-03 19:30:07.565343 :AD16F61D:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-03 19:30:07.565344 :AD16F61E:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-03 19:30:07.565344 :AD16F61F:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-03 19:30:07.565912 :AD16F620: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-07-03 19:30:07.565985 :AD16F62A: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-07-03 19:40:08.421463 :AD17B97D:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-03 19:40:08.920837 :AD17B9D2:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-03 19:40:08.915 2025-07-03 19:40:08.920839 :AD17B9D3:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=9276 pso_num=22 pso_serial#=179 2025-07-03 19:40:08.920982 :AD17B9D4:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=9276 osp_idx=0 osp_ver=372551 osp_pg=0 (spawn #348836) 2025-07-03 19:40:08.920983 :AD17B9D5:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-03 19:40:08.920983 :AD17B9D6:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=230 time=252384814 2025-07-03 19:40:08.920983 :AD17B9D7:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-03 19:40:08.920983 :AD17B9D8:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-03 19:40:08.920984 :AD17B9D9:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-03 19:40:08.920984 :AD17B9DA:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-03 19:40:08.920984 :AD17B9DB:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-03 19:40:08.921519 :AD17B9DC: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-07-03 19:40:08.921564 :AD17B9E4: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-07-03 19:50:09.731056 :AD187CBB:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-03 19:50:10.189126 :AD187D05:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-03 19:50:10.184 2025-07-03 19:50:10.189128 :AD187D06:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=17736 pso_num=22 pso_serial#=180 2025-07-03 19:50:10.189264 :AD187D07:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=17736 osp_idx=0 osp_ver=372552 osp_pg=0 (spawn #348859) 2025-07-03 19:50:10.189264 :AD187D08:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-03 19:50:10.189265 :AD187D09:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=231 time=252986079 2025-07-03 19:50:10.189265 :AD187D0A:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-03 19:50:10.189266 :AD187D0B:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-03 19:50:10.189266 :AD187D0C:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-03 19:50:10.189266 :AD187D0D:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-03 19:50:10.189266 :AD187D0E:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-03 19:50:10.189774 :AD187D0F: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-07-03 19:50:10.189819 :AD187D17: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-07-03 20:00:11.071616 :AD193F6D:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-03 20:00:11.529584 :AD193FBB:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-03 20:00:11.525 2025-07-03 20:00:11.529586 :AD193FBC:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16012 pso_num=22 pso_serial#=181 2025-07-03 20:00:11.529720 :AD193FBD:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=16012 osp_idx=0 osp_ver=372553 osp_pg=0 (spawn #348882) 2025-07-03 20:00:11.529721 :AD193FBE:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-03 20:00:11.529721 :AD193FBF:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=232 time=253587423 2025-07-03 20:00:11.529722 :AD193FC0:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-03 20:00:11.529722 :AD193FC1:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-03 20:00:11.529723 :AD193FC2:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-03 20:00:11.529723 :AD193FC3:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-03 20:00:11.529723 :AD193FC4:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-03 20:00:11.530255 :AD193FC5: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-07-03 20:00:11.530303 :AD193FCE: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-07-03 20:10:12.455870 :AD1A0C60:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-03 20:10:12.929404 :AD1A0CBD:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-03 20:10:12.924 2025-07-03 20:10:12.929406 :AD1A0CBE:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=6548 pso_num=22 pso_serial#=182 2025-07-03 20:10:12.929539 :AD1A0CBF:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=6548 osp_idx=0 osp_ver=372554 osp_pg=0 (spawn #348907) 2025-07-03 20:10:12.929540 :AD1A0CC0:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-03 20:10:12.929540 :AD1A0CC1:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=233 time=254188829 2025-07-03 20:10:12.929540 :AD1A0CC2:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-03 20:10:12.929541 :AD1A0CC3:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-03 20:10:12.929541 :AD1A0CC4:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-03 20:10:12.929541 :AD1A0CC5:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-03 20:10:12.929542 :AD1A0CC6:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-03 20:10:12.930046 :AD1A0CC7: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-07-03 20:10:12.930090 :AD1A0CCE: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-07-03 20:20:13.790807 :AD1AD323:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-03 20:20:14.248915 :AD1AD390:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-03 20:20:14.243 2025-07-03 20:20:14.248917 :AD1AD391:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=1400 pso_num=22 pso_serial#=183 2025-07-03 20:20:14.249059 :AD1AD392:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=1400 osp_idx=0 osp_ver=372555 osp_pg=0 (spawn #348930) 2025-07-03 20:20:14.249060 :AD1AD393:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-03 20:20:14.249060 :AD1AD394:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=234 time=254790142 2025-07-03 20:20:14.249061 :AD1AD395:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-03 20:20:14.249061 :AD1AD396:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-03 20:20:14.249062 :AD1AD397:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-03 20:20:14.249062 :AD1AD398:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-03 20:20:14.249062 :AD1AD399:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-03 20:20:14.249579 :AD1AD39A: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-07-03 20:20:14.249623 :AD1AD3A3: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-07-03 20:30:15.119993 :AD1B95F9:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-03 20:30:15.546722 :AD1B9677:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-03 20:30:15.541 2025-07-03 20:30:15.546724 :AD1B9678:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16504 pso_num=22 pso_serial#=184 2025-07-03 20:30:15.546865 :AD1B9679:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=16504 osp_idx=0 osp_ver=372556 osp_pg=0 (spawn #348953) 2025-07-03 20:30:15.546866 :AD1B967A:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-03 20:30:15.546866 :AD1B967B:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=235 time=255391439 2025-07-03 20:30:15.546867 :AD1B967C:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-03 20:30:15.546867 :AD1B967D:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-03 20:30:15.546867 :AD1B967E:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-03 20:30:15.546868 :AD1B967F:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-03 20:30:15.546868 :AD1B9680:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-03 20:30:15.547417 :AD1B9681: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-07-03 20:30:15.547466 :AD1B9687: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-07-03 20:34:11.225550 :AD1BE273: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-07-03 20:40:16.851374 :AD1C5A34: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-07-03 20:50:17.791401 :AD1D1CD5:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-03 20:50:18.077371 :AD1D1D44:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-03 20:50:18.073 2025-07-03 20:50:18.077372 :AD1D1D45:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=18256 pso_num=22 pso_serial#=185 2025-07-03 20:50:18.077509 :AD1D1D46:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=18256 osp_idx=0 osp_ver=372557 osp_pg=0 (spawn #348997) 2025-07-03 20:50:18.077510 :AD1D1D47:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-03 20:50:18.077510 :AD1D1D48:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=236 time=256593970 2025-07-03 20:50:18.077510 :AD1D1D49:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-03 20:50:18.077511 :AD1D1D4A:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-03 20:50:18.077511 :AD1D1D4B:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-03 20:50:18.077511 :AD1D1D4C:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-03 20:50:18.077512 :AD1D1D4D:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-03 20:50:18.078039 :AD1D1D4E: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-07-03 20:50:18.078089 :AD1D1D55: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-07-03 21:00:19.012990 :AD1DE0EC:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-03 21:00:19.361548 :AD1DE139:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-03 21:00:19.356 2025-07-03 21:00:19.361550 :AD1DE13A:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=9724 pso_num=22 pso_serial#=186 2025-07-03 21:00:19.361694 :AD1DE13B:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=9724 osp_idx=0 osp_ver=372558 osp_pg=0 (spawn #349020) 2025-07-03 21:00:19.361695 :AD1DE13C:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-03 21:00:19.361695 :AD1DE13D:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=237 time=257195251 2025-07-03 21:00:19.361696 :AD1DE13E:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-03 21:00:19.361696 :AD1DE13F:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-03 21:00:19.361697 :AD1DE140:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-03 21:00:19.361697 :AD1DE141:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-03 21:00:19.361697 :AD1DE142:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-03 21:00:19.362210 :AD1DE143: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-07-03 21:00:19.362259 :AD1DE14B: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-07-03 21:10:20.250997 :AD1EAB79:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-03 21:10:20.584215 :AD1EABC2:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-03 21:10:20.579 2025-07-03 21:10:20.584217 :AD1EABC3:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=17160 pso_num=22 pso_serial#=187 2025-07-03 21:10:20.584362 :AD1EABC4:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=17160 osp_idx=0 osp_ver=372559 osp_pg=0 (spawn #349045) 2025-07-03 21:10:20.584363 :AD1EABC5:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-03 21:10:20.584363 :AD1EABC6:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=238 time=257796470 2025-07-03 21:10:20.584364 :AD1EABC7:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-03 21:10:20.584364 :AD1EABC8:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-03 21:10:20.584364 :AD1EABC9:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-03 21:10:20.584364 :AD1EABCA:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-03 21:10:20.584364 :AD1EABCB:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-03 21:10:20.584889 :AD1EABCC: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-07-03 21:10:20.584935 :AD1EABD4: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-07-03 21:20:21.567833 :AD1F71A9:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-03 21:20:21.885065 :AD1F71EF:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-03 21:20:21.880 2025-07-03 21:20:21.885067 :AD1F71F0:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=11040 pso_num=22 pso_serial#=188 2025-07-03 21:20:21.885269 :AD1F71F1:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=11040 osp_idx=0 osp_ver=372560 osp_pg=0 (spawn #349068) 2025-07-03 21:20:21.885270 :AD1F71F2:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-03 21:20:21.885270 :AD1F71F3:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=239 time=258397783 2025-07-03 21:20:21.885270 :AD1F71F4:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-03 21:20:21.885271 :AD1F71F5:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-03 21:20:21.885271 :AD1F71F6:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-03 21:20:21.885272 :AD1F71F7:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-03 21:20:21.885272 :AD1F71F8:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-03 21:20:21.885819 :AD1F71F9: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-07-03 21:20:21.885868 :AD1F7201: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-07-03 21:30:22.835784 :AD203536:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-03 21:30:23.137629 :AD20358A:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-03 21:30:23.133 2025-07-03 21:30:23.137631 :AD20358B:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=2964 pso_num=22 pso_serial#=189 2025-07-03 21:30:23.137768 :AD20358C:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=2964 osp_idx=0 osp_ver=372561 osp_pg=0 (spawn #349093) 2025-07-03 21:30:23.137769 :AD20358D:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-03 21:30:23.137769 :AD20358E:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=240 time=258999033 2025-07-03 21:30:23.137769 :AD20358F:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-03 21:30:23.137770 :AD203590:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-03 21:30:23.137770 :AD203591:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-03 21:30:23.137770 :AD203592:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-03 21:30:23.137771 :AD203593:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-03 21:30:23.138280 :AD203594: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-07-03 21:30:23.138326 :AD20359C: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-07-03 21:40:24.064272 :AD20F970:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-03 21:40:24.438616 :AD20F9B7:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-03 21:40:24.433 2025-07-03 21:40:24.438619 :AD20F9B8:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16148 pso_num=22 pso_serial#=190 2025-07-03 21:40:24.438779 :AD20F9B9:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=16148 osp_idx=0 osp_ver=372562 osp_pg=0 (spawn #349113) 2025-07-03 21:40:24.438780 :AD20F9BA:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-03 21:40:24.438782 :AD20F9BB:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=241 time=259600329 2025-07-03 21:40:24.438782 :AD20F9BC:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-03 21:40:24.438782 :AD20F9BD:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-03 21:40:24.438783 :AD20F9BE:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-03 21:40:24.438783 :AD20F9BF:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-03 21:40:24.438783 :AD20F9C0:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-03 21:40:24.439377 :AD20F9C1: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-07-03 21:40:24.439427 :AD20F9C8: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-07-03 21:50:25.398700 :AD21BD05:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-03 21:50:25.669298 :AD21BD48:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-03 21:50:25.664 2025-07-03 21:50:25.669300 :AD21BD49:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=14500 pso_num=22 pso_serial#=191 2025-07-03 21:50:25.669478 :AD21BD4A:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=14500 osp_idx=0 osp_ver=372563 osp_pg=0 (spawn #349136) 2025-07-03 21:50:25.669479 :AD21BD4B:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-03 21:50:25.669480 :AD21BD4C:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=242 time=260201564 2025-07-03 21:50:25.669480 :AD21BD4D:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-03 21:50:25.669481 :AD21BD4E:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-03 21:50:25.669481 :AD21BD4F:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-03 21:50:25.669481 :AD21BD50:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-03 21:50:25.669482 :AD21BD51:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-03 21:50:25.670014 :AD21BD52: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-07-03 21:50:25.670065 :AD21BD59: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: 14500, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de