Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250504100104\orcl_j002_11952_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250504100104\orcl_j002_11952_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:37590M/63366M, Ph+PgF:45132M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 29 Windows thread id: 11952, image: ORACLE.EXE (J002) *** 2025-05-04 10:01:05.092 *** SESSION ID:(233.20645) 2025-05-04 10:01:05.092 *** 2025-05-04 10:01:05.092 Process diagnostic dump for ORACLE.EXE (J002), OS id=11952, pid: 29, proc_ser: 101, sid: 233, sess_ser: 20645 ------------------------------------------------------------------------------- current sql: <none> client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 11952 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J002) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=14 seq_num=15 snap_id=1 wait times: snap=0.401634 sec, exc=0.401634 sec, total=0.401634 sec wait times: max=0.500000 sec, heur=7.417034 sec wait counts: calls=1 os=1 in_wait=1 iflags=0x5a8 Wait State: fixed_waits=0 flags=0x22 boundary=0x0000000000000000/-1 Session Wait History: elapsed time of 0.000022 sec since current wait 0: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=13 seq_num=14 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.000014 sec of elapsed time 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=12 seq_num=13 snap_id=1 wait times: snap=0.515211 sec, exc=0.515211 sec, total=0.515211 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000012 sec of elapsed time 2: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=11 seq_num=12 snap_id=1 wait times: snap=0.499992 sec, exc=0.499992 sec, total=0.499992 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000013 sec of elapsed time 3: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=10 seq_num=11 snap_id=1 wait times: snap=0.499976 sec, exc=0.499976 sec, total=0.499976 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000027 sec of elapsed time 4: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=9 seq_num=10 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.000011 sec of elapsed time 5: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=8 seq_num=9 snap_id=1 wait times: snap=0.500007 sec, exc=0.500007 sec, total=0.500007 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000007 sec of elapsed time 6: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=7 seq_num=8 snap_id=1 wait times: snap=0.499986 sec, exc=0.499986 sec, total=0.499986 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000014 sec of elapsed time 7: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=6 seq_num=7 snap_id=1 wait times: snap=0.503171 sec, exc=0.503171 sec, total=0.503171 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=5 seq_num=6 snap_id=1 wait times: snap=0.499998 sec, exc=0.499998 sec, total=0.499998 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 9: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=4 seq_num=5 snap_id=1 wait times: snap=0.499993 sec, exc=0.499993 sec, total=0.499993 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000012 sec of elapsed time Sampled Session History of session 233 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 --------------------------------------------------- [8 samples, 10:00:57 - 10:01:05] idle wait at each sample [session created at: 10:00:57] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-05-04 10:01:05.092 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 29 (osid: 11952, J002) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-04 07:30:37.848256 :9279A264:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-04 07:30:37.848269 :9279A265:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-04 07:30:37.855858 :9279A269:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-04 08:00:41.999213 :927BF582:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-04 08:00:41.990 2025-05-04 08:00:41.999214 :927BF583:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=10296 pso_num=29 pso_serial#=91 2025-05-04 08:00:41.999355 :927BF584:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=10296 osp_idx=27 osp_ver=10290 osp_pg=0 (spawn #146755) 2025-05-04 08:00:41.999356 :927BF585:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-04 08:00:41.999357 :927BF586:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=48 time=3616419156 2025-05-04 08:00:41.999357 :927BF587:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-04 08:00:41.999358 :927BF588:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-04 08:00:41.999358 :927BF589:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-04 08:00:41.999359 :927BF58A:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-04 08:00:41.999359 :927BF58B:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-04 08:00:41.999882 :927BF58C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-04 08:00:41.999924 :927BF593:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-05-04 08:00:42.008765 :927BF5A7:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-04 08:01:12.067799 :927C011D:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-04 08:01:12.062 2025-05-04 08:01:12.067801 :927C011E:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=9960 pso_num=29 pso_serial#=92 2025-05-04 08:01:12.067939 :927C011F:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=9960 osp_idx=27 osp_ver=10291 osp_pg=0 (spawn #146760) 2025-05-04 08:01:12.067939 :927C0120:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-04 08:01:12.067940 :927C0121:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=49 time=3616449234 2025-05-04 08:01:12.067940 :927C0122:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-04 08:01:12.067941 :927C0123:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-04 08:01:12.067941 :927C0124:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-04 08:01:12.067941 :927C0125:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-04 08:01:12.067942 :927C0126:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-04 08:01:12.068431 :927C0127:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-04 08:01:12.068480 :927C012F:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-05-04 08:01:12.074932 :927C013B:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-04 08:20:18.092924 :927DC071:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-04 08:20:18.085 2025-05-04 08:20:18.092926 :927DC072:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=11596 pso_num=29 pso_serial#=93 2025-05-04 08:20:18.093053 :927DC073:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=11596 (legacy spawn) 2025-05-04 08:20:18.099545 :927DC07C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-04 08:20:18.099703 :927DC086:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-05-04 08:20:18.100552 :927DC11C:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-04 08:20:21.723298 :927DF19A:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-04 08:20:21.720 2025-05-04 08:20:21.723300 :927DF19B:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=3740 pso_num=29 pso_serial#=94 2025-05-04 08:20:21.723468 :927DF19C:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=3740 osp_idx=27 osp_ver=10293 osp_pg=0 (spawn #146804) 2025-05-04 08:20:21.723469 :927DF19D:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-04 08:20:21.723469 :927DF19E:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=50 time=3617598875 2025-05-04 08:20:21.723469 :927DF19F:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-04 08:20:21.723470 :927DF1A0:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-04 08:20:21.723470 :927DF1A1:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-04 08:20:21.723470 :927DF1A2:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-04 08:20:21.723471 :927DF1A3:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-04 08:20:21.724900 :927DF1A4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-04 08:20:21.724943 :927DF1AA:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-05-04 08:20:21.846197 :927DF1DC:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-04 08:20:23.961075 :927DF2A3:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-04 08:20:23.959 2025-05-04 08:20:23.961077 :927DF2A4:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=9360 pso_num=29 pso_serial#=95 2025-05-04 08:20:23.961205 :927DF2A5:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=9360 osp_idx=27 osp_ver=10294 osp_pg=0 (spawn #146806) 2025-05-04 08:20:23.961206 :927DF2A6:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-04 08:20:23.961207 :927DF2A7:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=51 time=3617601109 2025-05-04 08:20:23.961207 :927DF2A8:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-04 08:20:23.961208 :927DF2A9:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-04 08:20:23.961208 :927DF2AA:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-04 08:20:23.961208 :927DF2AB:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-04 08:20:23.961208 :927DF2AC:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-04 08:20:23.961721 :927DF2AD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-04 08:20:23.961765 :927DF2B3:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-05-04 08:20:25.867804 :927DF889:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-04 08:20:26.656754 :927DF936:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-04 08:20:26.651 2025-05-04 08:20:26.656757 :927DF937:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=10900 pso_num=29 pso_serial#=96 2025-05-04 08:20:26.656897 :927DF938:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=10900 osp_idx=27 osp_ver=10295 osp_pg=0 (spawn #146808) 2025-05-04 08:20:26.656898 :927DF939:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-04 08:20:26.656898 :927DF93A:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=52 time=3617603828 2025-05-04 08:20:26.656899 :927DF93B:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-04 08:20:26.656899 :927DF93C:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-04 08:20:26.656900 :927DF93D:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-04 08:20:26.656900 :927DF93E:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-04 08:20:26.656900 :927DF93F:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-04 08:20:26.657402 :927DF940:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-04 08:20:26.657453 :927DF947:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-05-04 08:20:26.654880 :927DF95E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-04 08:20:26.655266 :927DF971:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-04 08:30:45.922512 :927EF28E:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-04 08:30:45.910 2025-05-04 08:30:45.922514 :927EF28F:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=11400 pso_num=29 pso_serial#=97 2025-05-04 08:30:45.922647 :927EF290:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=11400 osp_idx=27 osp_ver=10296 osp_pg=0 (spawn #146833) 2025-05-04 08:30:45.922647 :927EF291:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-04 08:30:45.922648 :927EF292:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=53 time=3618223078 2025-05-04 08:30:45.922648 :927EF293:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-04 08:30:45.922649 :927EF294:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-04 08:30:45.922649 :927EF295:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-04 08:30:45.922649 :927EF296:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-04 08:30:45.922649 :927EF297:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-04 08:30:45.923217 :927EF298:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-04 08:30:45.923272 :927EF29E:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-05-04 08:30:45.927383 :927EF2B6:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-04 08:30:45.927449 :927EF2B7:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-04 08:30:45.927725 :927EF2B8:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-04 08:30:45.927743 :927EF2B9:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-04 08:30:45.927966 :927EF2BA:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-04 08:30:45.927980 :927EF2BB:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-04 08:30:45.928202 :927EF2BC:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-04 08:30:45.928215 :927EF2BD:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-04 08:30:45.928430 :927EF2BE:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-04 08:30:45.928442 :927EF2BF:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-04 08:30:45.928647 :927EF2C0:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-04 08:30:45.928659 :927EF2C1:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-04 08:30:45.931066 :927EF2C2:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-04 09:00:49.786242 :92814843:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-04 09:00:49.776 2025-05-04 09:00:49.786243 :92814844:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=10368 pso_num=29 pso_serial#=98 2025-05-04 09:00:49.786393 :92814845:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=10368 osp_idx=27 osp_ver=10297 osp_pg=0 (spawn #146903) 2025-05-04 09:00:49.786393 :92814846:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-04 09:00:49.786394 :92814847:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=54 time=3620026953 2025-05-04 09:00:49.786394 :92814848:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-04 09:00:49.786395 :92814849:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-04 09:00:49.786395 :9281484A:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-04 09:00:49.786396 :9281484B:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-04 09:00:49.786396 :9281484C:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-04 09:00:49.786906 :9281484D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-04 09:00:49.786947 :92814853:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-05-04 09:00:49.795314 :92814878:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-04 09:20:28.310759 :9282DF7D:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-04 09:20:28.305 2025-05-04 09:20:28.310761 :9282DF7E:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=8232 pso_num=29 pso_serial#=99 2025-05-04 09:20:28.310901 :9282DF7F:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=8232 osp_idx=27 osp_ver=10298 osp_pg=0 (spawn #146949) 2025-05-04 09:20:28.310902 :9282DF80:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-04 09:20:28.310902 :9282DF81:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=55 time=3621205468 2025-05-04 09:20:28.310903 :9282DF82:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-04 09:20:28.310903 :9282DF83:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-04 09:20:28.310904 :9282DF84:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-04 09:20:28.310904 :9282DF85:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-04 09:20:28.310904 :9282DF86:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-04 09:20:28.311408 :9282DF87:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-04 09:20:28.311454 :9282DF8E:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-05-04 09:20:28.317898 :9282DF9B:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-04 10:00:57.553014 :92860015:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-04 10:00:57.542 2025-05-04 10:00:57.553015 :92860016:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=10368 pso_num=29 pso_serial#=100 2025-05-04 10:00:57.553156 :92860019:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=10368 osp_idx=27 osp_ver=10299 osp_pg=0 (spawn #147043) 2025-05-04 10:00:57.553156 :9286001A:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-04 10:00:57.553157 :9286001B:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=56 time=3623634718 2025-05-04 10:00:57.553157 :9286001C:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-04 10:00:57.553158 :9286001D:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-04 10:00:57.553158 :9286001E:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-04 10:00:57.553159 :9286001F:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-04 10:00:57.553159 :92860020:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-04 10:00:57.553682 :92860021:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-04 10:00:57.553724 :92860027:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-05-04 10:00:57.553810 :92860032:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-05-04 10:00:57.558885 :9286003B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-04 10:00:57.613492 :92860093:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-04 10:00:57.615704 :9286009B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-04 10:00:57.617539 :928600A3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-04 10:00:57.617944 :928600AD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-04 10:00:57.617969 :928600B0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-05-04 10:00:57.618017 :928600BB:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=18 loc='ksr2.h LINE:607 ID:ksrmdone' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-04 10:00:57.618979 :928600C6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-04 10:00:57.618995 :928600C9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-05-04 10:00:57.619020 :928600D4:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=18 loc='ksr2.h LINE:607 ID:ksrmdone' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-04 10:00:57.619470 :928600DF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-04 10:00:57.622171 :928600EF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-04 10:00:57.627374 :928600FF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-04 10:00:57.628480 :92860116:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-04 10:00:57.631351 :92860192:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] 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-05-04 10:00:57.633172 :928601D1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-04 10:00:57.634559 :928601D9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-04 10:00:57.637579 :928601E1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-04 10:00:57.638723 :928601E9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-04 10:00:57.638733 :928601EA:db_trace:ktur.c@3079:ktuabt(): [10444:29:233] ABORT TRANSACTION - xid: 0x000a.016.00167596 2025-05-04 10:00:57.642114 :928601F2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-05-04 10:00:57.642281 :92860201:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=59 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-04 10:00:57.642504 :92860209:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-04 10:00:57.642563 :9286020C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:ktcc.c:879 2025-05-04 10:00:57.642579 :9286020D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:ktcc.c:879 2025-05-04 10:00:57.645617 :92860213:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-05-04 10:00:57.645901 :92860222:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-04 10:00:57.645948 :92860225:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:ktcc.c:879 2025-05-04 10:00:57.645961 :92860226:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:ktcc.c:879 2025-05-04 10:00:57.646134 :9286022C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-04 10:00:57.646146 :9286022F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-05-04 10:00:57.646169 :9286023B:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=18 loc='ksr2.h LINE:607 ID:ksrmdone' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-04 10:00:57.648275 :92860245:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-04 10:00:57.684612 :928602EA:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-04 10:00:57.682 2025-05-04 10:00:57.684612 :928602EB:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=11952 pso_num=29 pso_serial#=101 2025-05-04 10:00:57.684752 :928602F1:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=11952 osp_idx=27 osp_ver=10300 osp_pg=0 (spawn #147047) 2025-05-04 10:00:57.684753 :928602F2:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-04 10:00:57.684753 :928602F3:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=57 time=3623634843 2025-05-04 10:00:57.684754 :928602F4:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-04 10:00:57.684755 :928602F5:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-04 10:00:57.684756 :928602F6:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-04 10:00:57.684756 :928602F7:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-04 10:00:57.684757 :928602F8:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-04 10:00:57.685299 :928602F9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 29 (osid: 11952, J002)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de