Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250824060010\orcl_j001_21508_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250824060010\orcl_j001_21508_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:35270M/63366M, Ph+PgF:40407M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 25 Windows thread id: 21508, image: ORACLE.EXE (J001) *** 2025-08-24 06:00:10.101 *** SESSION ID:(201.43707) 2025-08-24 06:00:10.101 *** 2025-08-24 06:00:10.101 Process diagnostic dump for ORACLE.EXE (J001), OS id=21508, pid: 25, proc_ser: 150, sid: 201, sess_ser: 43707 ------------------------------------------------------------------------------- current sql: <none> client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 21508 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J001) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=15 seq_num=16 snap_id=1 wait times: snap=0.414674 sec, exc=0.414674 sec, total=0.414674 sec wait times: max=0.500000 sec, heur=7.945440 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.000007 sec since current wait 0: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=14 seq_num=15 snap_id=1 wait times: snap=0.500006 sec, exc=0.500006 sec, total=0.500006 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 sec of elapsed time 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=13 seq_num=14 snap_id=1 wait times: snap=0.510100 sec, exc=0.510100 sec, total=0.510100 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 2: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=12 seq_num=13 snap_id=1 wait times: snap=0.499997 sec, exc=0.499997 sec, total=0.499997 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 3: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=11 seq_num=12 snap_id=1 wait times: snap=0.499999 sec, exc=0.499999 sec, total=0.499999 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000012 sec of elapsed time 4: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=10 seq_num=11 snap_id=1 wait times: snap=0.499995 sec, exc=0.499995 sec, total=0.499995 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 sec of elapsed time 5: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=9 seq_num=10 snap_id=1 wait times: snap=0.499995 sec, exc=0.499995 sec, total=0.499995 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 6: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=8 seq_num=9 snap_id=1 wait times: snap=0.510103 sec, exc=0.510103 sec, total=0.510103 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000006 sec of elapsed time 7: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=7 seq_num=8 snap_id=1 wait times: snap=0.510099 sec, exc=0.510099 sec, total=0.510099 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000012 sec of elapsed time 8: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=6 seq_num=7 snap_id=1 wait times: snap=0.499994 sec, exc=0.499994 sec, total=0.499994 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000011 sec of elapsed time 9: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=5 seq_num=6 snap_id=1 wait times: snap=0.500000 sec, exc=0.500000 sec, total=0.500000 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time Sampled Session History of session 201 serial 43707 --------------------------------------------------- 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 --------------------------------------------------- [8 samples, 06:00:02 - 06:00:10] idle wait at each sample [session created at: 06:00:02] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-08-24 06:00:10.101 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 25 (osid: 21508, J001) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-08-24 05:49:26.526160 :C3E2E290:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-24 05:49:26.515 2025-08-24 05:49:26.526163 :C3E2E291:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=6020 pso_num=25 pso_serial#=139 2025-08-24 05:49:26.526296 :C3E2E292:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=6020 osp_idx=23 osp_ver=257546 osp_pg=0 (spawn #520240) 2025-08-24 05:49:26.526297 :C3E2E293:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-24 05:49:26.526298 :C3E2E294:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=62 time=400268533 2025-08-24 05:49:26.526298 :C3E2E295:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-24 05:49:26.526299 :C3E2E296:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-24 05:49:26.526299 :C3E2E297:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-24 05:49:26.526299 :C3E2E298:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-24 05:49:26.526300 :C3E2E299:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-24 05:49:26.526778 :C3E2E29A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-24 05:49:41.537839 :C3E2E7F7:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=59 loc='kkj.h LINE:914 ID:kkjpstnp' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-24 05:50:11.659151 :C3E2F1E7:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-24 05:50:26.616914 :C3E2F68C:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-24 05:50:26.606 2025-08-24 05:50:26.616916 :C3E2F68D:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=4492 pso_num=25 pso_serial#=140 2025-08-24 05:50:26.617056 :C3E2F68E:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=4492 osp_idx=23 osp_ver=257547 osp_pg=0 (spawn #520242) 2025-08-24 05:50:26.617057 :C3E2F68F:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-24 05:50:26.617057 :C3E2F690:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=63 time=400328627 2025-08-24 05:50:26.617057 :C3E2F691:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-24 05:50:26.617058 :C3E2F692:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-24 05:50:26.617059 :C3E2F693:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-24 05:50:26.617059 :C3E2F694:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-24 05:50:26.617059 :C3E2F695:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-24 05:50:26.617550 :C3E2F696:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-24 05:50:56.683941 :C3E3004D:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-24 05:51:26.686865 :C3E30A30:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-24 05:51:26.676 2025-08-24 05:51:26.686868 :C3E30A31:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=19356 pso_num=25 pso_serial#=141 2025-08-24 05:51:26.686990 :C3E30A32:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=19356 osp_idx=23 osp_ver=257548 osp_pg=0 (spawn #520244) 2025-08-24 05:51:26.686991 :C3E30A33:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-24 05:51:26.686991 :C3E30A34:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=64 time=400388690 2025-08-24 05:51:26.686992 :C3E30A35:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-24 05:51:26.686992 :C3E30A36:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-24 05:51:26.686992 :C3E30A37:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-24 05:51:26.686993 :C3E30A38:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-24 05:51:26.686993 :C3E30A39:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-24 05:51:26.687491 :C3E30A3A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-24 05:51:56.791771 :C3E3146B:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-24 05:52:26.793378 :C3E31E40:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-24 05:52:26.782 2025-08-24 05:52:26.793380 :C3E31E41:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=12612 pso_num=25 pso_serial#=142 2025-08-24 05:52:26.793499 :C3E31E42:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=12612 osp_idx=23 osp_ver=257549 osp_pg=0 (spawn #520246) 2025-08-24 05:52:26.793500 :C3E31E43:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-24 05:52:26.793501 :C3E31E44:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=65 time=400448799 2025-08-24 05:52:26.793501 :C3E31E45:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-24 05:52:26.793501 :C3E31E46:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-24 05:52:26.793502 :C3E31E47:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-24 05:52:26.793502 :C3E31E48:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-24 05:52:26.793502 :C3E31E49:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-24 05:52:26.793994 :C3E31E4A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-24 05:52:56.878167 :C3E32830:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-24 05:53:02.999665 :C3E32AA5:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-24 05:53:02.987 2025-08-24 05:53:02.999666 :C3E32AA6:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=20896 pso_num=25 pso_serial#=143 2025-08-24 05:53:02.999802 :C3E32AA7:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=20896 osp_idx=23 osp_ver=257550 osp_pg=0 (spawn #520248) 2025-08-24 05:53:02.999802 :C3E32AA8:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-24 05:53:02.999803 :C3E32AA9:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=66 time=400485002 2025-08-24 05:53:02.999803 :C3E32AAA:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-24 05:53:02.999803 :C3E32AAB:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-24 05:53:02.999804 :C3E32AAC:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-24 05:53:02.999804 :C3E32AAD:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-24 05:53:02.999805 :C3E32AAE:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-24 05:53:03.000316 :C3E32AAF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-24 05:53:03.000356 :C3E32AB5:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=18 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-24 05:53:03.004458 :C3E32ADE:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:kelt.c:517 2025-08-24 05:53:03.004504 :C3E32ADF:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:kelt.c:517 2025-08-24 05:53:03.004773 :C3E32AE0:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:kelt.c:517 2025-08-24 05:53:03.004790 :C3E32AE1:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:kelt.c:517 2025-08-24 05:53:03.005010 :C3E32AE2:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:kelt.c:517 2025-08-24 05:53:03.005025 :C3E32AE3:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:kelt.c:517 2025-08-24 05:53:03.005231 :C3E32AE4:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:kelt.c:517 2025-08-24 05:53:03.005244 :C3E32AE5:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:kelt.c:517 2025-08-24 05:53:03.005447 :C3E32AE6:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:kelt.c:517 2025-08-24 05:53:03.005464 :C3E32AE7:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:kelt.c:517 2025-08-24 05:53:03.005670 :C3E32AE8:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:kelt.c:517 2025-08-24 05:53:03.005683 :C3E32AE9:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:kelt.c:517 2025-08-24 05:53:03.007904 :C3E32AEA:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-24 05:53:26.872694 :C3E33293:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-24 05:53:26.861 2025-08-24 05:53:26.872697 :C3E33294:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=20684 pso_num=25 pso_serial#=144 2025-08-24 05:53:26.872866 :C3E33295:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=20684 osp_idx=23 osp_ver=257551 osp_pg=0 (spawn #520250) 2025-08-24 05:53:26.872867 :C3E33296:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-24 05:53:26.872868 :C3E33297:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=67 time=400508877 2025-08-24 05:53:26.872868 :C3E33298:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-24 05:53:26.872869 :C3E33299:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-24 05:53:26.872869 :C3E3329A:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-24 05:53:26.872869 :C3E3329B:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-24 05:53:26.872870 :C3E3329C:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-24 05:53:26.873364 :C3E3329D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-24 05:53:56.957851 :C3E33C5D:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-24 05:54:26.942867 :C3E3465B:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-24 05:54:26.931 2025-08-24 05:54:26.942869 :C3E3465C:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=22476 pso_num=25 pso_serial#=145 2025-08-24 05:54:26.943003 :C3E3465D:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=22476 osp_idx=23 osp_ver=257552 osp_pg=0 (spawn #520252) 2025-08-24 05:54:26.943004 :C3E3465E:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-24 05:54:26.943005 :C3E3465F:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=68 time=400568940 2025-08-24 05:54:26.943005 :C3E34660:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-24 05:54:26.943006 :C3E34661:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-24 05:54:26.943006 :C3E34662:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-24 05:54:26.943007 :C3E34663:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-24 05:54:26.943007 :C3E34664:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-24 05:54:26.943471 :C3E34665:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-24 05:54:57.013935 :C3E3502E:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-24 05:55:27.040252 :C3E359D9:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-24 05:55:27.031 2025-08-24 05:55:27.040254 :C3E359DA:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=21604 pso_num=25 pso_serial#=146 2025-08-24 05:55:27.040397 :C3E359DB:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=21604 osp_idx=23 osp_ver=257553 osp_pg=0 (spawn #520254) 2025-08-24 05:55:27.040398 :C3E359DC:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-24 05:55:27.040399 :C3E359DD:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=69 time=400629049 2025-08-24 05:55:27.040399 :C3E359DE:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-24 05:55:27.040399 :C3E359DF:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-24 05:55:27.040400 :C3E359E0:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-24 05:55:27.040400 :C3E359E1:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-24 05:55:27.040400 :C3E359E2:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-24 05:55:27.040901 :C3E359E3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-24 05:55:57.109294 :C3E36398:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-24 05:56:27.139706 :C3E36D9B:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-24 05:56:27.128 2025-08-24 05:56:27.139708 :C3E36D9C:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=15096 pso_num=25 pso_serial#=147 2025-08-24 05:56:27.139828 :C3E36D9D:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=15096 osp_idx=23 osp_ver=257554 osp_pg=0 (spawn #520256) 2025-08-24 05:56:27.139829 :C3E36D9E:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-24 05:56:27.139829 :C3E36D9F:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=70 time=400689143 2025-08-24 05:56:27.139830 :C3E36DA0:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-24 05:56:27.139830 :C3E36DA1:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-24 05:56:27.139830 :C3E36DA2:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-24 05:56:27.139831 :C3E36DA3:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-24 05:56:27.139831 :C3E36DA4:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-24 05:56:27.140325 :C3E36DA5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-24 05:56:57.221229 :C3E37928:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-24 05:57:27.218225 :C3E38301:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-24 05:57:27.206 2025-08-24 05:57:27.218227 :C3E38302:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=15056 pso_num=25 pso_serial#=148 2025-08-24 05:57:27.218365 :C3E38303:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=15056 osp_idx=23 osp_ver=257555 osp_pg=0 (spawn #520259) 2025-08-24 05:57:27.218366 :C3E38304:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-24 05:57:27.218366 :C3E38305:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=71 time=400749221 2025-08-24 05:57:27.218367 :C3E38306:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-24 05:57:27.218367 :C3E38307:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-24 05:57:27.218368 :C3E38308:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-24 05:57:27.218368 :C3E38309:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-24 05:57:27.218368 :C3E3830A:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-24 05:57:27.218877 :C3E3830B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-24 05:57:57.313650 :C3E38CED:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-24 05:58:27.340688 :C3E396A4:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-24 05:58:27.329 2025-08-24 05:58:27.340690 :C3E396A5:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=21088 pso_num=25 pso_serial#=149 2025-08-24 05:58:27.340819 :C3E396A6:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=21088 osp_idx=23 osp_ver=257556 osp_pg=0 (spawn #520261) 2025-08-24 05:58:27.340819 :C3E396A7:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-24 05:58:27.340820 :C3E396A8:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=72 time=400809346 2025-08-24 05:58:27.340821 :C3E396A9:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-24 05:58:27.340821 :C3E396AA:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-24 05:58:27.340822 :C3E396AB:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-24 05:58:27.340822 :C3E396AC:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-24 05:58:27.340822 :C3E396AD:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-24 05:58:27.341317 :C3E396AE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-24 05:58:57.403038 :C3E3A0CC:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-24 05:59:27.423609 :C3E3AA9E:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-24 05:59:27.412 2025-08-24 05:59:27.423611 :C3E3AA9F:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=21508 pso_num=25 pso_serial#=150 2025-08-24 05:59:27.423726 :C3E3AAA0:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=21508 osp_idx=23 osp_ver=257557 osp_pg=0 (spawn #520263) 2025-08-24 05:59:27.423727 :C3E3AAA1:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-24 05:59:27.423727 :C3E3AAA2:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=73 time=400869424 2025-08-24 05:59:27.423728 :C3E3AAA3:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-24 05:59:27.423728 :C3E3AAA4:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-24 05:59:27.423729 :C3E3AAA5:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-24 05:59:27.423729 :C3E3AAA6:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-24 05:59:27.423729 :C3E3AAA7:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-24 05:59:27.424258 :C3E3AAA8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-24 05:59:42.447337 :C3E3AFB4:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=59 loc='kkj.h LINE:914 ID:kkjpstnp' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-24 06:00:02.030016 :C3E3B7E4:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=59 loc='kkj.h LINE:914 ID:kkjpstnp' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-24 06:00:02.030016*:C3E3B7F2:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000026BEC718 estart=1755986401 eid=16786663 ctx=0x000000077FD6A000 cwh=0x0000000026BE0068 cpu=0 buffg=1 interb=0 r=0 rb=0 w=0 wb=0 2025-08-24 06:00:02.030016*:C3E3B7F3:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000026BEC718 curCtx=0x0000000026BE8938 pubTabIdxCnt=0 2025-08-24 06:00:02.030016*:C3E3B7F4:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000026BEC718 2025-08-24 06:00:02.030016*:C3E3B7F5:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000026BEC718 2025-08-24 06:00:02.030016*:C3E3B7F6:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000026BEC718 curCtx=0x0000000026BE8938 xsc->flg4=65792 flags=2 2025-08-24 06:00:02.030016*:C3E3B7F7:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000026BEC718 2025-08-24 06:00:02.035650 :C3E3B802:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-24 06:00:02.035692 :C3E3B806:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:jslv.c:9203 2025-08-24 06:00:02.047203 :C3E3B872:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-24 06:00:02.052090 :C3E3B891:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-24 06:00:02.052533 :C3E3B89C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='kcrf.h LINE:3299 ID:kcrfw_redo_gen: wake LGWR after redo copy' id1=0 id2=0 name= type=0 2025-08-24 06:00:02.052852 :C3E3B8AE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-24 06:00:02.058683 :C3E3BA4A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-08-24 06:00:02.058829 :C3E3BA59:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-24 06:00:02.059682 :C3E3BA61:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-24 06:00:02.059883 :C3E3BA69:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:jslv.c:9203 2025-08-24 06:00:02.061462 :C3E3BA6A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-24 06:00:02.061506 :C3E3BA6D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 2025-08-24 06:00:02.061586 :C3E3BA7A:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-08-24 06:00:02.154914 :C3E3BB20:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=59 loc='kkj.h LINE:914 ID:kkjpstnp' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-24 06:00:02.157040 :C3E3BB24:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-24 06:00:02.157085 :C3E3BB27:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:jslv.c:9203 2025-08-24 06:00:02.159556 :C3E3BB2D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:jslv.c:9203 2025-08-24 06:00:02.162916 :C3E3BB2E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-24 06:00:02.162997 :C3E3BB31:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 2025-08-24 06:00:02.163096 :C3E3BB3E:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 25 (osid: 21508, J001)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de