Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250831180707\orcl_w000_23152_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250831180707\orcl_w000_23152_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:35068M/63366M, Ph+PgF:40002M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 22 Windows thread id: 23152, image: ORACLE.EXE (W000) *** 2025-08-31 18:07:07.638 *** SESSION ID:(177.13519) 2025-08-31 18:07:07.638 *** 2025-08-31 18:07:07.638 Process diagnostic dump for ORACLE.EXE (W000), OS id=23152, pid: 22, proc_ser: 16, sid: 177, sess_ser: 13519 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=90 seq_num=91 snap_id=1 wait times: snap=0.802452 sec, exc=0.802452 sec, total=0.802452 sec wait times: max=5.000000 sec, heur=7 min 26 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.000038 sec since current wait 0: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=89 seq_num=90 snap_id=1 wait times: snap=5.004644 sec, exc=5.004644 sec, total=5.004644 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000029 sec of elapsed time 1: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=88 seq_num=89 snap_id=1 wait times: snap=5.007205 sec, exc=5.007205 sec, total=5.007205 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000034 sec of elapsed time 2: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=87 seq_num=88 snap_id=1 wait times: snap=5.001217 sec, exc=5.001217 sec, total=5.001217 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000038 sec of elapsed time 3: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=86 seq_num=87 snap_id=1 wait times: snap=5.015458 sec, exc=5.015458 sec, total=5.015458 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000037 sec of elapsed time 4: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=85 seq_num=86 snap_id=1 wait times: snap=5.003404 sec, exc=5.003404 sec, total=5.003404 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000034 sec of elapsed time 5: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=84 seq_num=85 snap_id=1 wait times: snap=5.014726 sec, exc=5.014726 sec, total=5.014726 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000029 sec of elapsed time 6: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=83 seq_num=84 snap_id=1 wait times: snap=5.004596 sec, exc=5.004596 sec, total=5.004596 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000037 sec of elapsed time 7: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=82 seq_num=83 snap_id=1 wait times: snap=5.009708 sec, exc=5.009708 sec, total=5.009708 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000034 sec of elapsed time 8: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=81 seq_num=82 snap_id=1 wait times: snap=5.003216 sec, exc=5.003216 sec, total=5.003216 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=80 seq_num=81 snap_id=1 wait times: snap=5.000314 sec, exc=5.000314 sec, total=5.000314 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000031 sec of elapsed time Sampled Session History of session 177 serial 13519 --------------------------------------------------- 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, 18:05:07 - 18:07:07] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-08-31 18:07:07.638 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 22 (osid: 23152, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-08-31 15:19:22.371276 :C724506F: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-31 15:23:42.558513 :C724A622: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-31 15:29:23.521550 :C725166D: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-31 15:39:24.247018 :C725DD23:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-31 15:39:24.642336 :C725DD68:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-31 15:39:24.637 2025-08-31 15:39:24.642338 :C725DD69:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=20224 pso_num=22 pso_serial#=3 2025-08-31 15:39:24.642479 :C725DD6A:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=20224 osp_idx=0 osp_ver=558015 osp_pg=0 (spawn #544952) 2025-08-31 15:39:24.642479 :C725DD6B: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-31 15:39:24.642480 :C725DD6C:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=36 time=1040415940 2025-08-31 15:39:24.642480 :C725DD6D:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-31 15:39:24.642480 :C725DD6E:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-31 15:39:24.642481 :C725DD6F:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-31 15:39:24.642481 :C725DD70:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-31 15:39:24.642482 :C725DD71:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-31 15:39:24.643022 :C725DD72: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-31 15:39:24.643064 :C725DD7A: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-31 15:49:25.464248 :C726A3E7:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-31 15:49:25.890981 :C726A421:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-31 15:49:25.886 2025-08-31 15:49:25.890983 :C726A422:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=17352 pso_num=22 pso_serial#=4 2025-08-31 15:49:25.891132 :C726A423:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=17352 osp_idx=0 osp_ver=558016 osp_pg=0 (spawn #544975) 2025-08-31 15:49:25.891133 :C726A424: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-31 15:49:25.891134 :C726A425:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=37 time=1041017190 2025-08-31 15:49:25.891134 :C726A426:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-31 15:49:25.891134 :C726A427:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-31 15:49:25.891135 :C726A428:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-31 15:49:25.891135 :C726A429:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-31 15:49:25.891135 :C726A42A:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-31 15:49:25.891703 :C726A42B: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-31 15:49:25.891754 :C726A434: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-31 15:59:26.740246 :C72769E9:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-31 15:59:27.089059 :C7276A30:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-31 15:59:27.084 2025-08-31 15:59:27.089061 :C7276A31:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=11336 pso_num=22 pso_serial#=5 2025-08-31 15:59:27.089199 :C7276A32:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=11336 osp_idx=0 osp_ver=558017 osp_pg=0 (spawn #544997) 2025-08-31 15:59:27.089200 :C7276A33: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-31 15:59:27.089200 :C7276A34:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=38 time=1041618393 2025-08-31 15:59:27.089200 :C7276A35:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-31 15:59:27.089201 :C7276A36:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-31 15:59:27.089201 :C7276A37:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-31 15:59:27.089201 :C7276A38:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-31 15:59:27.089202 :C7276A39:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-31 15:59:27.089682 :C7276A3A: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-31 15:59:27.089729 :C7276A41: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-31 16:09:27.895083 :C72838D2:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-31 16:09:28.290474 :C7283930:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-31 16:09:28.285 2025-08-31 16:09:28.290476 :C7283931:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=21904 pso_num=22 pso_serial#=6 2025-08-31 16:09:28.290615 :C7283932:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=21904 osp_idx=0 osp_ver=558018 osp_pg=0 (spawn #545024) 2025-08-31 16:09:28.290615 :C7283933: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-31 16:09:28.290616 :C7283934:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=39 time=1042219596 2025-08-31 16:09:28.290616 :C7283935:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-31 16:09:28.290616 :C7283936:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-31 16:09:28.290617 :C7283937:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-31 16:09:28.290617 :C7283938:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-31 16:09:28.290618 :C7283939:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-31 16:09:28.291108 :C728393A: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-31 16:09:28.291163 :C7283940: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-31 16:19:29.111969 :C72902A8:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-31 16:19:29.413458 :C7290313:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-31 16:19:29.408 2025-08-31 16:19:29.413461 :C7290314:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=12488 pso_num=22 pso_serial#=7 2025-08-31 16:19:29.413595 :C7290315:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=12488 osp_idx=0 osp_ver=558019 osp_pg=0 (spawn #545047) 2025-08-31 16:19:29.413596 :C7290316: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-31 16:19:29.413597 :C7290317:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=40 time=1042820721 2025-08-31 16:19:29.413597 :C7290318:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-31 16:19:29.413597 :C7290319:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-31 16:19:29.413598 :C729031A:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-31 16:19:29.413598 :C729031B:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-31 16:19:29.413599 :C729031C:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-31 16:19:29.414079 :C729031D: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-31 16:19:29.414126 :C7290324: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-31 16:29:30.300719 :C729C95A:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-31 16:29:30.633686 :C729C994:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-31 16:29:30.629 2025-08-31 16:29:30.633688 :C729C995:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=22672 pso_num=22 pso_serial#=8 2025-08-31 16:29:30.633825 :C729C996:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=22672 osp_idx=0 osp_ver=558020 osp_pg=0 (spawn #545069) 2025-08-31 16:29:30.633825 :C729C997: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-31 16:29:30.633826 :C729C998:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=41 time=1043421940 2025-08-31 16:29:30.633826 :C729C999:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-31 16:29:30.633827 :C729C99A:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-31 16:29:30.633827 :C729C99B:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-31 16:29:30.633827 :C729C99C:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-31 16:29:30.633828 :C729C99D:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-31 16:29:30.634316 :C729C99E: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-31 16:29:30.634363 :C729C9A5: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-31 16:39:31.546056 :C72A9071:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-31 16:39:31.847695 :C72A90B7:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-31 16:39:31.842 2025-08-31 16:39:31.847697 :C72A90B8:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=22872 pso_num=22 pso_serial#=9 2025-08-31 16:39:31.847832 :C72A90B9:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=22872 osp_idx=0 osp_ver=558021 osp_pg=0 (spawn #545092) 2025-08-31 16:39:31.847833 :C72A90BA: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-31 16:39:31.847833 :C72A90BB:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=42 time=1044023158 2025-08-31 16:39:31.847833 :C72A90BC:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-31 16:39:31.847834 :C72A90BD:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-31 16:39:31.847834 :C72A90BE:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-31 16:39:31.847834 :C72A90BF:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-31 16:39:31.847835 :C72A90C0:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-31 16:39:31.848346 :C72A90C1: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-31 16:39:31.848388 :C72A90CA: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-31 16:49:32.652531 :C72B56BE:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-31 16:49:32.954278 :C72B56EF:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-31 16:49:32.949 2025-08-31 16:49:32.954280 :C72B56F0:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=20224 pso_num=22 pso_serial#=10 2025-08-31 16:49:32.954419 :C72B56F1:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=20224 osp_idx=0 osp_ver=558022 osp_pg=0 (spawn #545115) 2025-08-31 16:49:32.954420 :C72B56F2: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-31 16:49:32.954420 :C72B56F3:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=43 time=1044624252 2025-08-31 16:49:32.954421 :C72B56F4:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-31 16:49:32.954421 :C72B56F5:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-31 16:49:32.954421 :C72B56F6:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-31 16:49:32.954422 :C72B56F7:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-31 16:49:32.954422 :C72B56F8:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-31 16:49:32.954915 :C72B56F9: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-31 16:49:32.954960 :C72B5700: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-31 16:59:33.696199 :C72C1D39:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-31 16:59:34.076062 :C72C1D7F:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-31 16:59:34.071 2025-08-31 16:59:34.076065 :C72C1D80:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=22300 pso_num=22 pso_serial#=11 2025-08-31 16:59:34.076210 :C72C1D81:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=22300 osp_idx=0 osp_ver=558023 osp_pg=0 (spawn #545137) 2025-08-31 16:59:34.076211 :C72C1D82: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-31 16:59:34.076211 :C72C1D83:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=44 time=1045225377 2025-08-31 16:59:34.076212 :C72C1D84:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-31 16:59:34.076212 :C72C1D85:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-31 16:59:34.076213 :C72C1D86:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-31 16:59:34.076213 :C72C1D87:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-31 16:59:34.076213 :C72C1D88:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-31 16:59:34.076715 :C72C1D89: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-31 16:59:34.076758 :C72C1D91: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-31 17:09:34.791483 :C72CEC8C:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-31 17:09:35.108841 :C72CECC2:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-31 17:09:35.103 2025-08-31 17:09:35.108842 :C72CECC3:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=22460 pso_num=22 pso_serial#=12 2025-08-31 17:09:35.108984 :C72CECC4:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=22460 osp_idx=0 osp_ver=558024 osp_pg=0 (spawn #545163) 2025-08-31 17:09:35.108984 :C72CECC5: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-31 17:09:35.108984 :C72CECC6:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=45 time=1045826408 2025-08-31 17:09:35.108984 :C72CECC7:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-31 17:09:35.108985 :C72CECC8:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-31 17:09:35.108985 :C72CECC9:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-31 17:09:35.108985 :C72CECCA:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-31 17:09:35.108986 :C72CECCB:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-31 17:09:35.109498 :C72CECCC: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-31 17:09:35.109541 :C72CECD4: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-31 17:19:35.936094 :C72DB6F1:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-31 17:19:36.284685 :C72DB72B:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-31 17:19:36.279 2025-08-31 17:19:36.284687 :C72DB72C:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=19808 pso_num=22 pso_serial#=13 2025-08-31 17:19:36.284828 :C72DB72D:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=19808 osp_idx=0 osp_ver=558025 osp_pg=0 (spawn #545186) 2025-08-31 17:19:36.284828 :C72DB72E: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-31 17:19:36.284829 :C72DB72F:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=46 time=1046427596 2025-08-31 17:19:36.284829 :C72DB730:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-31 17:19:36.284830 :C72DB731:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-31 17:19:36.284830 :C72DB732:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-31 17:19:36.284831 :C72DB733:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-31 17:19:36.284831 :C72DB734:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-31 17:19:36.285320 :C72DB735: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-31 17:19:36.285365 :C72DB73F: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-31 17:28:43.330679 :C72E6C25: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-31 17:29:37.531746 :C72E7DED: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-31 17:39:38.269011 :C72F44D5:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-31 17:39:38.742405 :C72F451B:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-31 17:39:38.743 2025-08-31 17:39:38.742407 :C72F451C:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16392 pso_num=22 pso_serial#=14 2025-08-31 17:39:38.742546 :C72F451D:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=16392 osp_idx=0 osp_ver=558026 osp_pg=0 (spawn #545230) 2025-08-31 17:39:38.742547 :C72F451E: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-31 17:39:38.742548 :C72F451F:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=47 time=1047630049 2025-08-31 17:39:38.742548 :C72F4520:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-31 17:39:38.742549 :C72F4521:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-31 17:39:38.742549 :C72F4522:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-31 17:39:38.742549 :C72F4523:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-31 17:39:38.742550 :C72F4524:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-31 17:39:38.743040 :C72F4525: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-31 17:39:38.743082 :C72F452C: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-31 17:49:39.660804 :C7300BF5:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-31 17:49:39.993659 :C7300C30:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-31 17:49:39.988 2025-08-31 17:49:39.993660 :C7300C31:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=18848 pso_num=22 pso_serial#=15 2025-08-31 17:49:39.993805 :C7300C32:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=18848 osp_idx=0 osp_ver=558027 osp_pg=0 (spawn #545253) 2025-08-31 17:49:39.993805 :C7300C33: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-31 17:49:39.993806 :C7300C34:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=48 time=1048231299 2025-08-31 17:49:39.993806 :C7300C35:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-31 17:49:39.993806 :C7300C36:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-31 17:49:39.993807 :C7300C37:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-31 17:49:39.993807 :C7300C38:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-31 17:49:39.993807 :C7300C39:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-31 17:49:39.994316 :C7300C3A: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-31 17:49:39.994361 :C7300C42: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-31 17:59:40.792065 :C730D35E:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-31 17:59:41.265450 :C730D3B6:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-31 17:59:41.261 2025-08-31 17:59:41.265452 :C730D3B7:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=23152 pso_num=22 pso_serial#=16 2025-08-31 17:59:41.265589 :C730D3B8:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=23152 osp_idx=0 osp_ver=558028 osp_pg=0 (spawn #545275) 2025-08-31 17:59:41.265590 :C730D3B9: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-31 17:59:41.265590 :C730D3BA:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=49 time=1048832565 2025-08-31 17:59:41.265591 :C730D3BB:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-31 17:59:41.265591 :C730D3BC:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-31 17:59:41.265591 :C730D3BD:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-31 17:59:41.265592 :C730D3BE:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-31 17:59:41.265592 :C730D3BF:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-31 17:59:41.266083 :C730D3C0: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-31 17:59:41.266132 :C730D3C7: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: 23152, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de