Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250821080948\orcl_w000_20800_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250821080948\orcl_w000_20800_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:35326M/63366M, Ph+PgF:40529M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 22 Windows thread id: 20800, image: ORACLE.EXE (W000) *** 2025-08-21 08:09:49.010 *** SESSION ID:(177.33891) 2025-08-21 08:09:49.010 *** 2025-08-21 08:09:49.010 Process diagnostic dump for ORACLE.EXE (W000), OS id=20800, pid: 22, proc_ser: 149, sid: 177, sess_ser: 33891 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=27 seq_num=28 snap_id=1 wait times: snap=3.149224 sec, exc=3.149224 sec, total=3.149224 sec wait times: max=5.000000 sec, heur=2 min 13 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.000021 sec since current wait 0: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=26 seq_num=27 snap_id=1 wait times: snap=5.001257 sec, exc=5.001257 sec, total=5.001257 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000021 sec of elapsed time 1: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=25 seq_num=26 snap_id=1 wait times: snap=5.011705 sec, exc=5.011705 sec, total=5.011705 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000023 sec of elapsed time 2: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=24 seq_num=25 snap_id=1 wait times: snap=5.015256 sec, exc=5.015256 sec, total=5.015256 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000022 sec of elapsed time 3: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=23 seq_num=24 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.000025 sec of elapsed time 4: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=22 seq_num=23 snap_id=1 wait times: snap=5.004641 sec, exc=5.004641 sec, total=5.004641 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000027 sec of elapsed time 5: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=21 seq_num=22 snap_id=1 wait times: snap=5.004642 sec, exc=5.004642 sec, total=5.004642 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=20 seq_num=21 snap_id=1 wait times: snap=5.015260 sec, exc=5.015260 sec, total=5.015260 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000021 sec of elapsed time 7: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=19 seq_num=20 snap_id=1 wait times: snap=5.003467 sec, exc=5.003467 sec, total=5.003467 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000021 sec of elapsed time 8: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=18 seq_num=19 snap_id=1 wait times: snap=5.010270 sec, exc=5.010270 sec, total=5.010270 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000021 sec of elapsed time 9: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=17 seq_num=18 snap_id=1 wait times: snap=5.010390 sec, exc=5.010390 sec, total=5.010390 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000027 sec of elapsed time Sampled Session History of session 177 serial 33891 --------------------------------------------------- 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:07:49 - 08:09:49] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-08-21 08:09:49.010 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 22 (osid: 20800, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-08-21 05:37:15.983683 :C2905A2C:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=19660 pso_num=22 pso_serial#=136 2025-08-21 05:37:15.983826 :C2905A2D:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=19660 osp_idx=0 osp_ver=538768 osp_pg=0 (spawn #510212) 2025-08-21 05:37:15.983827 :C2905A2E: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-21 05:37:15.983827 :C2905A2F:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=91 time=140337987 2025-08-21 05:37:15.983829 :C2905A30:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-21 05:37:15.983830 :C2905A31:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-21 05:37:15.983830 :C2905A32:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-21 05:37:15.983830 :C2905A33:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-21 05:37:15.983831 :C2905A34:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-21 05:37:15.984318 :C2905A35: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-21 05:37:15.984366 :C2905A3D: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-21 05:38:31.131391 :C2907277:db_trace:ksl2.c@2477:kslwtbctx(): [10005:22:177] KSL WAIT BEG [latch free] 136537728/0x8236680 259/0x103 0/0x0 wait_id=16 seq_num=17 snap_id=1 2025-08-21 05:38:31.131409 :C290728C:db_trace:ksl2.c@2611:kslwtectx(): [10005:22:177] KSL WAIT END [latch free] 136537728/0x8236680 259/0x103 0/0x0 wait_id=16 seq_num=17 snap_id=1 2025-08-21 05:38:31.131410 :C290728D:db_trace:ksl2.c@2619:kslwtectx(): [10005:22:177] KSL WAIT END wait times (usecs) - snap=18, exc=18, tot=18 2025-08-21 05:47:16.952173 :C2911C45:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-21 05:47:17.191395 :C2911CA1:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-21 05:47:17.186 2025-08-21 05:47:17.191397 :C2911CA2:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16028 pso_num=22 pso_serial#=137 2025-08-21 05:47:17.191534 :C2911CA3:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=16028 osp_idx=0 osp_ver=538769 osp_pg=0 (spawn #510235) 2025-08-21 05:47:17.191535 :C2911CA4: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-21 05:47:17.191535 :C2911CA5:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=92 time=140939205 2025-08-21 05:47:17.191536 :C2911CA6:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-21 05:47:17.191536 :C2911CA7:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-21 05:47:17.191537 :C2911CA8:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-21 05:47:17.191537 :C2911CA9:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-21 05:47:17.191537 :C2911CAA:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-21 05:47:17.192037 :C2911CAB: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-21 05:47:17.192094 :C2911CB1: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-21 05:50:49.429955 :C29160F3: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-21 05:57:18.447269 :C291DDFF: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-21 06:07:19.306113 :C292AA7F:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-21 06:07:19.654436 :C292AADE:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-21 06:07:19.649 2025-08-21 06:07:19.654438 :C292AADF:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=20164 pso_num=22 pso_serial#=138 2025-08-21 06:07:19.654579 :C292AAE0:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=20164 osp_idx=0 osp_ver=538770 osp_pg=0 (spawn #510282) 2025-08-21 06:07:19.654580 :C292AAE1: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-21 06:07:19.654580 :C292AAE2:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=93 time=142141658 2025-08-21 06:07:19.654581 :C292AAE3:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-21 06:07:19.654581 :C292AAE4:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-21 06:07:19.654581 :C292AAE5:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-21 06:07:19.654582 :C292AAE6:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-21 06:07:19.654582 :C292AAE7:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-21 06:07:19.655078 :C292AAE8: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-21 06:07:19.655127 :C292AAEF: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-21 06:17:20.530617 :C2936B55:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-21 06:17:20.910457 :C2936BB5:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-21 06:17:20.905 2025-08-21 06:17:20.910459 :C2936BB6:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=20352 pso_num=22 pso_serial#=139 2025-08-21 06:17:20.910600 :C2936BB7:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=20352 osp_idx=0 osp_ver=538771 osp_pg=0 (spawn #510305) 2025-08-21 06:17:20.910600 :C2936BB8: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-21 06:17:20.910601 :C2936BB9:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=94 time=142742924 2025-08-21 06:17:20.910602 :C2936BBA:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-21 06:17:20.910602 :C2936BBB:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-21 06:17:20.910602 :C2936BBC:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-21 06:17:20.910603 :C2936BBD:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-21 06:17:20.910603 :C2936BBE:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-21 06:17:20.911117 :C2936BBF: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-21 06:17:20.911164 :C2936BC8: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-21 06:27:21.870262 :C2942D7D:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-21 06:27:22.203060 :C2942DF1:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-21 06:27:22.198 2025-08-21 06:27:22.203063 :C2942DF2:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=21508 pso_num=22 pso_serial#=140 2025-08-21 06:27:22.203211 :C2942DF3:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=21508 osp_idx=0 osp_ver=538772 osp_pg=0 (spawn #510327) 2025-08-21 06:27:22.203212 :C2942DF4: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-21 06:27:22.203212 :C2942DF5:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=95 time=143344205 2025-08-21 06:27:22.203212 :C2942DF6:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-21 06:27:22.203213 :C2942DF7:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-21 06:27:22.203213 :C2942DF8:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-21 06:27:22.203214 :C2942DF9:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-21 06:27:22.203214 :C2942DFA:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-21 06:27:22.203716 :C2942DFB: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-21 06:27:22.203760 :C2942E03: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-21 06:37:23.177113 :C294EFB0:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-21 06:37:23.572525 :C294F009:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-21 06:37:23.567 2025-08-21 06:37:23.572528 :C294F00A:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=20148 pso_num=22 pso_serial#=141 2025-08-21 06:37:23.572671 :C294F00B:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=20148 osp_idx=0 osp_ver=538773 osp_pg=0 (spawn #510350) 2025-08-21 06:37:23.572672 :C294F00C: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-21 06:37:23.572672 :C294F00D:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=96 time=143945580 2025-08-21 06:37:23.572673 :C294F00E:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-21 06:37:23.572673 :C294F00F:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-21 06:37:23.572674 :C294F010:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-21 06:37:23.572674 :C294F011:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-21 06:37:23.572674 :C294F012:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-21 06:37:23.573156 :C294F013: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-21 06:37:23.573201 :C294F01A: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-21 06:47:24.500578 :C295B257:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-21 06:47:24.911683 :C295B2C0:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-21 06:47:24.906 2025-08-21 06:47:24.911685 :C295B2C1:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=18400 pso_num=22 pso_serial#=142 2025-08-21 06:47:24.911827 :C295B2C2:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=18400 osp_idx=0 osp_ver=538774 osp_pg=0 (spawn #510373) 2025-08-21 06:47:24.911828 :C295B2C3: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-21 06:47:24.911828 :C295B2C4:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=97 time=144546924 2025-08-21 06:47:24.911829 :C295B2C5:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-21 06:47:24.911829 :C295B2C6:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-21 06:47:24.911829 :C295B2C7:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-21 06:47:24.911830 :C295B2C8:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-21 06:47:24.911830 :C295B2C9:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-21 06:47:24.912329 :C295B2CA: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-21 06:47:24.912375 :C295B2D2: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-21 06:57:25.799747 :C29673AA:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-21 06:57:26.223156 :C2967409:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-21 06:57:26.218 2025-08-21 06:57:26.223158 :C296740A:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=20496 pso_num=22 pso_serial#=143 2025-08-21 06:57:26.223295 :C296740B:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=20496 osp_idx=0 osp_ver=538775 osp_pg=0 (spawn #510395) 2025-08-21 06:57:26.223296 :C296740C: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-21 06:57:26.223296 :C296740D:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=98 time=145148237 2025-08-21 06:57:26.223297 :C296740E:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-21 06:57:26.223297 :C296740F:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-21 06:57:26.223298 :C2967410:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-21 06:57:26.223298 :C2967411:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-21 06:57:26.223298 :C2967412:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-21 06:57:26.223785 :C2967413: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-21 06:57:26.223832 :C296741C: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-21 07:07:27.101858 :C2974049:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-21 07:07:27.554104 :C29740B3:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-21 07:07:27.549 2025-08-21 07:07:27.554106 :C29740B4:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=22448 pso_num=22 pso_serial#=144 2025-08-21 07:07:27.554238 :C29740B5:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=22448 osp_idx=0 osp_ver=538776 osp_pg=0 (spawn #510421) 2025-08-21 07:07:27.554239 :C29740B6: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-21 07:07:27.554239 :C29740B7:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=99 time=145749565 2025-08-21 07:07:27.554240 :C29740B8:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-21 07:07:27.554240 :C29740B9:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-21 07:07:27.554241 :C29740BA:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-21 07:07:27.554241 :C29740BB:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-21 07:07:27.554241 :C29740BC:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-21 07:07:27.554728 :C29740BD: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-21 07:07:27.554771 :C29740C5: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-21 07:17:28.457867 :C29801F6:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-21 07:17:29.009545 :C2980260:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-21 07:17:29.004 2025-08-21 07:17:29.009547 :C2980261:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=22364 pso_num=22 pso_serial#=145 2025-08-21 07:17:29.009683 :C2980262:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=22364 osp_idx=0 osp_ver=538777 osp_pg=0 (spawn #510444) 2025-08-21 07:17:29.009684 :C2980263: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-21 07:17:29.009684 :C2980264:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=100 time=146351018 2025-08-21 07:17:29.009685 :C2980265:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-21 07:17:29.009685 :C2980266:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-21 07:17:29.009685 :C2980267:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-21 07:17:29.009686 :C2980268:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-21 07:17:29.009686 :C2980269:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-21 07:17:29.010189 :C298026A: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-21 07:17:29.010235 :C2980272: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-21 07:27:29.878825 :C298C40B:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-21 07:27:30.336894 :C298C464:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-21 07:27:30.331 2025-08-21 07:27:30.336896 :C298C465:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=19836 pso_num=22 pso_serial#=146 2025-08-21 07:27:30.337029 :C298C466:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=19836 osp_idx=0 osp_ver=538778 osp_pg=0 (spawn #510466) 2025-08-21 07:27:30.337030 :C298C467: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-21 07:27:30.337030 :C298C468:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=101 time=146952346 2025-08-21 07:27:30.337030 :C298C469:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-21 07:27:30.337031 :C298C46A:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-21 07:27:30.337031 :C298C46B:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-21 07:27:30.337031 :C298C46C:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-21 07:27:30.337032 :C298C46D:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-21 07:27:30.337516 :C298C46E: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-21 07:27:30.337573 :C298C474: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-21 07:37:31.244353 :C2998615:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-21 07:37:31.686579 :C2998677:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-21 07:37:31.681 2025-08-21 07:37:31.686581 :C2998678:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=22292 pso_num=22 pso_serial#=147 2025-08-21 07:37:31.686717 :C2998679:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=22292 osp_idx=0 osp_ver=538779 osp_pg=0 (spawn #510489) 2025-08-21 07:37:31.686717 :C299867A: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-21 07:37:31.686718 :C299867B:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=102 time=147553690 2025-08-21 07:37:31.686718 :C299867C:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-21 07:37:31.686719 :C299867D:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-21 07:37:31.686719 :C299867E:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-21 07:37:31.686719 :C299867F:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-21 07:37:31.686719 :C2998680:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-21 07:37:31.687205 :C2998681: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-21 07:37:31.687248 :C2998689: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-21 07:47:32.603722 :C29A4808:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-21 07:47:32.921062 :C29A485E:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-21 07:47:32.916 2025-08-21 07:47:32.921064 :C29A485F:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=22380 pso_num=22 pso_serial#=148 2025-08-21 07:47:32.921207 :C29A4860:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=22380 osp_idx=0 osp_ver=538780 osp_pg=0 (spawn #510512) 2025-08-21 07:47:32.921207 :C29A4861: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-21 07:47:32.921208 :C29A4862:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=103 time=148154924 2025-08-21 07:47:32.921208 :C29A4863:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-21 07:47:32.921209 :C29A4864:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-21 07:47:32.921209 :C29A4865:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-21 07:47:32.921209 :C29A4866:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-21 07:47:32.921210 :C29A4867:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-21 07:47:32.921712 :C29A4868: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-21 07:47:32.921757 :C29A4870: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-21 07:52:57.509027 :C29AAFF5: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-21 07:57:34.346663 :C29B0921: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-21 08:07:35.218282 :C29BD3B1:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-21 08:07:35.676062 :C29BD40B:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-21 08:07:35.670 2025-08-21 08:07:35.676064 :C29BD40C:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=20800 pso_num=22 pso_serial#=149 2025-08-21 08:07:35.676208 :C29BD40D:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=20800 osp_idx=0 osp_ver=538781 osp_pg=0 (spawn #510559) 2025-08-21 08:07:35.676208 :C29BD40E: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-21 08:07:35.676209 :C29BD40F:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=104 time=149357690 2025-08-21 08:07:35.676209 :C29BD410:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-21 08:07:35.676210 :C29BD411:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-21 08:07:35.676210 :C29BD412:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-21 08:07:35.676210 :C29BD413:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-21 08:07:35.676211 :C29BD414:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-21 08:07:35.676723 :C29BD415: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-21 08:07:35.676771 :C29BD41D: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: 20800, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de