Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250503100743\orcl_w000_8096_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250503100743\orcl_w000_8096_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:37612M/63366M, Ph+PgF:45179M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 22 Windows thread id: 8096, image: ORACLE.EXE (W000) *** 2025-05-03 10:07:43.125 *** SESSION ID:(177.20645) 2025-05-03 10:07:43.125 *** 2025-05-03 10:07:43.125 Process diagnostic dump for ORACLE.EXE (W000), OS id=8096, pid: 22, proc_ser: 1, sid: 177, sess_ser: 20645 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=75 seq_num=76 snap_id=1 wait times: snap=2.820009 sec, exc=2.820009 sec, total=2.820009 sec wait times: max=5.000000 sec, heur=6 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.000033 sec since current wait 0: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=74 seq_num=75 snap_id=1 wait times: snap=5.009973 sec, exc=5.009973 sec, total=5.009973 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000027 sec of elapsed time 1: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=73 seq_num=74 snap_id=1 wait times: snap=5.000864 sec, exc=5.000864 sec, total=5.000864 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=72 seq_num=73 snap_id=1 wait times: snap=5.010143 sec, exc=5.010143 sec, total=5.010143 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000023 sec of elapsed time 3: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=71 seq_num=72 snap_id=1 wait times: snap=5.014741 sec, exc=5.014741 sec, total=5.014741 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000031 sec of elapsed time 4: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=70 seq_num=71 snap_id=1 wait times: snap=5.004619 sec, exc=5.004619 sec, total=5.004619 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000021 sec of elapsed time 5: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=69 seq_num=70 snap_id=1 wait times: snap=5.001753 sec, exc=5.001753 sec, total=5.001753 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000022 sec of elapsed time 6: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=68 seq_num=69 snap_id=1 wait times: snap=5.001247 sec, exc=5.001247 sec, total=5.001247 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000024 sec of elapsed time 7: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=67 seq_num=68 snap_id=1 wait times: snap=5.010380 sec, exc=5.010380 sec, total=5.010380 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000027 sec of elapsed time 8: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=66 seq_num=67 snap_id=1 wait times: snap=5.006451 sec, exc=5.006451 sec, total=5.006451 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000023 sec of elapsed time 9: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=65 seq_num=66 snap_id=1 wait times: snap=5.009215 sec, exc=5.009215 sec, total=5.009215 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000028 sec of elapsed time Sampled Session History of session 177 serial 20645 --------------------------------------------------- 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, 10:05:43 - 10:07:43] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-05-03 10:07:43.125 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 22 (osid: 8096, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-03 07:31:09.838653 :92062D73:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-03 07:31:09.838654 :92062D74:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-03 07:31:09.839161 :92062D75: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-05-03 07:31:09.839206 :92062D7C: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-05-03 07:41:10.723332 :9206F815:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-03 07:41:11.165495 :9206F85D:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-03 07:41:11.160 2025-05-03 07:41:11.165497 :9206F85E:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=10900 pso_num=22 pso_serial#=243 2025-05-03 07:41:11.165630 :9206F85F:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=10900 osp_idx=0 osp_ver=149928 osp_pg=0 (spawn #143309) 2025-05-03 07:41:11.165630 :9206F860:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-03 07:41:11.165631 :9206F861:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=114 time=3528860640 2025-05-03 07:41:11.165631 :9206F862:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-05-03 07:41:11.165632 :9206F863:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-05-03 07:41:11.165632 :9206F864:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-05-03 07:41:11.165632 :9206F865:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-03 07:41:11.165633 :9206F866:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-03 07:41:11.166183 :9206F867: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-05-03 07:41:11.166228 :9206F870: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-05-03 07:51:12.118704 :9207C2E3:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-03 07:51:12.404611 :9207C320:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-03 07:51:12.400 2025-05-03 07:51:12.404613 :9207C321:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=3780 pso_num=22 pso_serial#=244 2025-05-03 07:51:12.404750 :9207C322:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=3780 osp_idx=0 osp_ver=149929 osp_pg=0 (spawn #143332) 2025-05-03 07:51:12.404751 :9207C323:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-03 07:51:12.404751 :9207C324:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=115 time=3529461890 2025-05-03 07:51:12.404751 :9207C325:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-05-03 07:51:12.404752 :9207C326:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-05-03 07:51:12.404752 :9207C327:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-05-03 07:51:12.404753 :9207C328:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-03 07:51:12.404753 :9207C329:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-03 07:51:12.405253 :9207C32A: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-05-03 07:51:12.405298 :9207C332: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-05-03 08:01:13.235088 :92088EF8:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-03 08:01:13.661617 :92088F33:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-03 08:01:13.656 2025-05-03 08:01:13.661619 :92088F34:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=12124 pso_num=22 pso_serial#=245 2025-05-03 08:01:13.661751 :92088F35:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=12124 osp_idx=0 osp_ver=149930 osp_pg=0 (spawn #143359) 2025-05-03 08:01:13.661752 :92088F36:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-03 08:01:13.661752 :92088F37:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=116 time=3530063140 2025-05-03 08:01:13.661752 :92088F38:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-05-03 08:01:13.661753 :92088F39:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-05-03 08:01:13.661753 :92088F3A:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-05-03 08:01:13.661753 :92088F3B:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-03 08:01:13.661754 :92088F3C:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-03 08:01:13.662308 :92088F3D: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-05-03 08:01:13.662353 :92088F46: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-05-03 08:11:14.518571 :9209634C:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-03 08:11:14.929551 :92096387:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-03 08:11:14.924 2025-05-03 08:11:14.929553 :92096388:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=10344 pso_num=22 pso_serial#=246 2025-05-03 08:11:14.929703 :92096389:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=10344 osp_idx=0 osp_ver=149931 osp_pg=0 (spawn #143382) 2025-05-03 08:11:14.929705 :9209638A:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-03 08:11:14.929706 :9209638B:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=117 time=3530664406 2025-05-03 08:11:14.929706 :9209638C:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-05-03 08:11:14.929707 :9209638D:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-05-03 08:11:14.929708 :9209638E:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-05-03 08:11:14.929709 :9209638F:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-03 08:11:14.929710 :92096390:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-03 08:11:14.930201 :92096391: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-05-03 08:11:14.930244 :9209639B: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-05-03 08:21:15.888820 :920A30D1:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-03 08:21:16.268463 :920A3118:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-03 08:21:16.264 2025-05-03 08:21:16.268464 :920A3119:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=9780 pso_num=22 pso_serial#=247 2025-05-03 08:21:16.268598 :920A311A:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=9780 osp_idx=0 osp_ver=149932 osp_pg=0 (spawn #143405) 2025-05-03 08:21:16.268598 :920A311B:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-03 08:21:16.268599 :920A311C:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=118 time=3531265750 2025-05-03 08:21:16.268599 :920A311D:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-05-03 08:21:16.268600 :920A311E:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-05-03 08:21:16.268600 :920A311F:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-05-03 08:21:16.268600 :920A3120:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-03 08:21:16.268601 :920A3121:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-03 08:21:16.269082 :920A3122: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-05-03 08:21:16.269131 :920A312A: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-05-03 08:30:18.525233 :920AE8C3: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-05-03 08:31:17.598253 :920AFC82: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-05-03 08:41:18.425798 :920BC89A:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-03 08:41:18.884600 :920BC8E2:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-03 08:41:18.880 2025-05-03 08:41:18.884602 :920BC8E3:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=6572 pso_num=22 pso_serial#=248 2025-05-03 08:41:18.884772 :920BC8E4:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=6572 osp_idx=0 osp_ver=149933 osp_pg=0 (spawn #143449) 2025-05-03 08:41:18.884773 :920BC8E5:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-03 08:41:18.884773 :920BC8E6:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=119 time=3532468359 2025-05-03 08:41:18.884774 :920BC8E7:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-05-03 08:41:18.884774 :920BC8E8:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-05-03 08:41:18.884775 :920BC8E9:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-05-03 08:41:18.884775 :920BC8EA:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-03 08:41:18.884775 :920BC8EB:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-03 08:41:18.885312 :920BC8EC: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-05-03 08:41:18.885358 :920BC8F4: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-05-03 08:51:19.704090 :920C944D:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-03 08:51:20.255593 :920C94B0:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-03 08:51:20.250 2025-05-03 08:51:20.255594 :920C94B1:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=11216 pso_num=22 pso_serial#=249 2025-05-03 08:51:20.255727 :920C94B2:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=11216 osp_idx=0 osp_ver=149934 osp_pg=0 (spawn #143473) 2025-05-03 08:51:20.255728 :920C94B3:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-03 08:51:20.255728 :920C94B4:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=120 time=3533069734 2025-05-03 08:51:20.255728 :920C94B5:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-05-03 08:51:20.255729 :920C94B6:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-05-03 08:51:20.255729 :920C94B7:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-05-03 08:51:20.255729 :920C94B8:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-03 08:51:20.255730 :920C94B9:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-03 08:51:20.256218 :920C94BA: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-05-03 08:51:20.256271 :920C94C4: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-05-03 09:01:21.082346 :920D6347:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-03 09:01:21.644009 :920D63C0:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-03 09:01:21.639 2025-05-03 09:01:21.644011 :920D63C1:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=11084 pso_num=22 pso_serial#=250 2025-05-03 09:01:21.644145 :920D63C2:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=11084 osp_idx=0 osp_ver=149935 osp_pg=0 (spawn #143500) 2025-05-03 09:01:21.644145 :920D63C3:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-03 09:01:21.644146 :920D63C4:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=121 time=3533671125 2025-05-03 09:01:21.644146 :920D63C5:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-05-03 09:01:21.644146 :920D63C6:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-05-03 09:01:21.644147 :920D63C7:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-05-03 09:01:21.644147 :920D63C8:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-03 09:01:21.644147 :920D63C9:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-03 09:01:21.644643 :920D63CA: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-05-03 09:01:21.644689 :920D63D2: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-05-03 09:11:22.527007 :920E355F:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-03 09:11:23.031673 :920E35CE:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-03 09:11:23.027 2025-05-03 09:11:23.031674 :920E35CF:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=10604 pso_num=22 pso_serial#=251 2025-05-03 09:11:23.031810 :920E35D0:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=10604 osp_idx=0 osp_ver=149936 osp_pg=0 (spawn #143523) 2025-05-03 09:11:23.031811 :920E35D1:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-03 09:11:23.031811 :920E35D2:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=122 time=3534272515 2025-05-03 09:11:23.031812 :920E35D3:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-05-03 09:11:23.031812 :920E35D4:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-05-03 09:11:23.031813 :920E35D5:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-05-03 09:11:23.031813 :920E35D6:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-03 09:11:23.031813 :920E35D7:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-03 09:11:23.032298 :920E35D8: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-05-03 09:11:23.032343 :920E35DF: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-05-03 09:21:23.931443 :920F03E9:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-03 09:21:24.404882 :920F0425:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-03 09:21:24.399 2025-05-03 09:21:24.404884 :920F0426:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=9808 pso_num=22 pso_serial#=252 2025-05-03 09:21:24.405017 :920F0427:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=9808 osp_idx=0 osp_ver=149937 osp_pg=0 (spawn #143546) 2025-05-03 09:21:24.405018 :920F0428:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-03 09:21:24.405019 :920F0429:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=123 time=3534873890 2025-05-03 09:21:24.405019 :920F042A:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-05-03 09:21:24.405020 :920F042B:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-05-03 09:21:24.405020 :920F042C:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-05-03 09:21:24.405020 :920F042D:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-03 09:21:24.405021 :920F042E:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-03 09:21:24.405512 :920F042F: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-05-03 09:21:24.405557 :920F0437: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-05-03 09:31:25.269759 :920FCF5D:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-03 09:31:25.758761 :920FCFA5:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-03 09:31:25.754 2025-05-03 09:31:25.758763 :920FCFA6:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=9384 pso_num=22 pso_serial#=253 2025-05-03 09:31:25.758941 :920FCFA7:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=9384 osp_idx=0 osp_ver=149938 osp_pg=0 (spawn #143569) 2025-05-03 09:31:25.758942 :920FCFA8:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-03 09:31:25.758943 :920FCFA9:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=124 time=3535475234 2025-05-03 09:31:25.758943 :920FCFAA:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-05-03 09:31:25.758944 :920FCFAB:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-05-03 09:31:25.758944 :920FCFAC:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-05-03 09:31:25.758944 :920FCFAD:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-03 09:31:25.758945 :920FCFAE:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-03 09:31:25.759463 :920FCFAF: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-05-03 09:31:25.759509 :920FCFB6: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-05-03 09:41:26.660936 :92109BA6:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-03 09:41:27.149999 :92109BE0:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-03 09:41:27.145 2025-05-03 09:41:27.150000 :92109BE1:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=580 pso_num=22 pso_serial#=254 2025-05-03 09:41:27.150137 :92109BE2:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=580 osp_idx=0 osp_ver=149939 osp_pg=0 (spawn #143591) 2025-05-03 09:41:27.150137 :92109BE3:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-03 09:41:27.150138 :92109BE4:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=125 time=3536076625 2025-05-03 09:41:27.150138 :92109BE5:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-05-03 09:41:27.150139 :92109BE6:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-05-03 09:41:27.150139 :92109BE7:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-05-03 09:41:27.150139 :92109BE8:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-03 09:41:27.150140 :92109BE9:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-03 09:41:27.150627 :92109BEA: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-05-03 09:41:27.150671 :92109BF2: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-05-03 09:51:28.102309 :921166DC:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-03 09:51:28.450762 :92116723:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-03 09:51:28.446 2025-05-03 09:51:28.450765 :92116724:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=9104 pso_num=22 pso_serial#=255 2025-05-03 09:51:28.450911 :92116725:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=9104 osp_idx=0 osp_ver=149940 osp_pg=0 (spawn #143614) 2025-05-03 09:51:28.450912 :92116726:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-03 09:51:28.450912 :92116727:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=126 time=3536677937 2025-05-03 09:51:28.450913 :92116728:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-05-03 09:51:28.450913 :92116729:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-05-03 09:51:28.450913 :9211672A:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-05-03 09:51:28.450914 :9211672B:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-03 09:51:28.450914 :9211672C:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-03 09:51:28.451408 :9211672D: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-05-03 09:51:28.451452 :92116734: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-05-03 10:01:29.291094 :921234A9:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-03 10:01:29.733378 :921234E4:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-03 10:01:29.728 2025-05-03 10:01:29.733380 :921234E5:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=8096 pso_num=22 pso_serial#=1 2025-05-03 10:01:29.733519 :921234E6:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=8096 osp_idx=0 osp_ver=149941 osp_pg=0 (spawn #143641) 2025-05-03 10:01:29.733520 :921234E7:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-03 10:01:29.733520 :921234E8:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=127 time=3537279218 2025-05-03 10:01:29.733521 :921234E9:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-05-03 10:01:29.733521 :921234EA:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-05-03 10:01:29.733522 :921234EB:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-05-03 10:01:29.733522 :921234EC:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-03 10:01:29.733522 :921234ED:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-03 10:01:29.734020 :921234EE: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-05-03 10:01:29.734067 :921234F8: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: 8096, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de