Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250708080852\orcl_j000_15316_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250708080852\orcl_j000_15316_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:36545M/63366M, Ph+PgF:42618M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 24 Windows thread id: 15316, image: ORACLE.EXE (J000) *** 2025-07-08 08:08:53.016 *** SESSION ID:(193.55281) 2025-07-08 08:08:53.016 *** 2025-07-08 08:08:53.016 Process diagnostic dump for ORACLE.EXE (J000), OS id=15316, pid: 24, proc_ser: 234, sid: 193, sess_ser: 55281 ------------------------------------------------------------------------------- current sql: <none> client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 15316 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J000) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=32 seq_num=33 snap_id=1 wait times: snap=0.142899 sec, exc=0.142899 sec, total=0.142899 sec wait times: max=0.500000 sec, heur=16.213466 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.000009 sec since current wait 0: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=31 seq_num=32 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 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=30 seq_num=31 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.000009 sec of elapsed time 2: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=29 seq_num=30 snap_id=1 wait times: snap=0.499982 sec, exc=0.499982 sec, total=0.499982 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000016 sec of elapsed time 3: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=28 seq_num=29 snap_id=1 wait times: snap=0.500002 sec, exc=0.500002 sec, total=0.500002 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=27 seq_num=28 snap_id=1 wait times: snap=0.508122 sec, exc=0.508122 sec, total=0.508122 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=26 seq_num=27 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 6: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=25 seq_num=26 snap_id=1 wait times: snap=0.499996 sec, exc=0.499996 sec, total=0.499996 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 7: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=24 seq_num=25 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.000011 sec of elapsed time 8: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=23 seq_num=24 snap_id=1 wait times: snap=0.510112 sec, exc=0.510112 sec, total=0.510112 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=22 seq_num=23 snap_id=1 wait times: snap=0.510094 sec, exc=0.510094 sec, total=0.510094 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000007 sec of elapsed time Sampled Session History of session 193 serial 55281 --------------------------------------------------- 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 --------------------------------------------------- [17 samples, 08:08:36 - 08:08:53] idle wait at each sample [session created at: 08:08:36] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-07-08 08:08:53.016 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 24 (osid: 15316, J000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-07-08 08:05:11.489935 :AF1FAF1F:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-08 08:05:11.489936 :AF1FAF20:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=255 time=642687376 2025-07-08 08:05:11.489936 :AF1FAF21:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-07-08 08:05:11.489936 :AF1FAF22:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-07-08 08:05:11.489937 :AF1FAF23:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-07-08 08:05:11.489937 :AF1FAF24:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-08 08:05:11.489937 :AF1FAF25:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-08 08:05:11.490446 :AF1FAF26:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-08 08:05:11.491109 :AF1FAF3B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-08 08:05:11.498872 :AF1FAF57:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-07-08 08:05:11.499232 :AF1FAF58:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-08 08:05:11.499267 :AF1FAF5B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-07-08 08:05:11.500206 :AF1FAF61:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-08 08:05:11.500333 :AF1FAF6A:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-07-08 08:05:41.557905 :AF1FBEAB:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-08 08:05:47.805720 :AF1FC087:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-08 08:05:47.801 2025-07-08 08:05:47.805722 :AF1FC088:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=4904 pso_num=24 pso_serial#=216 2025-07-08 08:05:47.805866 :AF1FC089:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=4904 (legacy spawn) 2025-07-08 08:05:47.812935 :AF1FC08A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-08 08:05:47.813115 :AF1FC08F:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-07-08 08:05:47.814001 :AF1FC094:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-08 08:05:57.850394 :AF1FC3E0:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-08 08:05:57.836 2025-07-08 08:05:57.850396 :AF1FC3E1:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=12656 pso_num=24 pso_serial#=217 2025-07-08 08:05:57.850540 :AF1FC3E2:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=12656 (legacy spawn) 2025-07-08 08:05:57.869672 :AF1FC3E3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-08 08:05:57.869844 :AF1FC3E8:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-07-08 08:05:57.870651 :AF1FC3ED:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-08 08:05:57.879368 :AF1FC3F0:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-08 08:05:57.867 2025-07-08 08:05:57.879370 :AF1FC3F1:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=18072 pso_num=24 pso_serial#=218 2025-07-08 08:05:57.879511 :AF1FC3F2:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=18072 (legacy spawn) 2025-07-08 08:05:57.886231 :AF1FC3F3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-08 08:05:57.886394 :AF1FC3FA:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-07-08 08:05:57.887223 :AF1FC3FD:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-08 08:05:59.761263 :AF1FC469:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-08 08:05:59.752 2025-07-08 08:05:59.761265 :AF1FC46A:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=9724 pso_num=24 pso_serial#=219 2025-07-08 08:05:59.761403 :AF1FC46B:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=9724 (legacy spawn) 2025-07-08 08:05:59.767977 :AF1FC46C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-08 08:05:59.768136 :AF1FC471:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-07-08 08:05:59.768990 :AF1FC476:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-08 08:06:01.105644 :AF1FC526:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-08 08:06:01.093 2025-07-08 08:06:01.105645 :AF1FC527:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=16484 pso_num=24 pso_serial#=220 2025-07-08 08:06:01.105777 :AF1FC528:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=16484 (legacy spawn) 2025-07-08 08:06:01.112316 :AF1FC529:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-08 08:06:01.112490 :AF1FC532:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-07-08 08:06:01.113307 :AF1FC533:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-08 08:06:01.122084 :AF1FC536:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-08 08:06:01.108 2025-07-08 08:06:01.122085 :AF1FC537:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=11728 pso_num=24 pso_serial#=221 2025-07-08 08:06:01.122224 :AF1FC538:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=11728 (legacy spawn) 2025-07-08 08:06:01.128781 :AF1FC539:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-08 08:06:01.128944 :AF1FC542:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-07-08 08:06:01.129745 :AF1FC543:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-08 08:06:11.596647 :AF1FC87E:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-08 08:06:11.590 2025-07-08 08:06:11.596649 :AF1FC87F:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=7572 pso_num=24 pso_serial#=222 2025-07-08 08:06:11.596782 :AF1FC880:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=7572 osp_idx=22 osp_ver=535987 osp_pg=0 (spawn #363913) 2025-07-08 08:06:11.596783 :AF1FC881:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-08 08:06:11.596783 :AF1FC882:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=0 time=642747486 2025-07-08 08:06:11.596783 :AF1FC883:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-07-08 08:06:11.596783 :AF1FC884:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-07-08 08:06:11.596784 :AF1FC885:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-07-08 08:06:11.596784 :AF1FC886:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-08 08:06:11.596784 :AF1FC887:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-08 08:06:11.597384 :AF1FC888:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-08 08:06:11.598046 :AF1FC89D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-08 08:06:11.609319 :AF1FC8B9:db_trace:kwqid.c@2146:kwqidrdq(): [10960:24:193] kwqidrdq: Error: 1403 occured in OCI execute 2025-07-08 08:06:11.609790 :AF1FC8BA:db_trace:kwqid.c@2146:kwqidrdq(): [10960:24:193] kwqidrdq: Error: 1403 occured in OCI execute 2025-07-08 08:06:11.612260 :AF1FC8BB:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-07-08 08:06:11.612622 :AF1FC8BC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-08 08:06:11.612657 :AF1FC8BF:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-07-08 08:06:11.613630 :AF1FC8C5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-08 08:06:11.613757 :AF1FC8CE:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-07-08 08:06:41.723102 :AF1FD2A7:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-08 08:06:48.201293 :AF1FD48E:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-08 08:06:48.193 2025-07-08 08:06:48.201295 :AF1FD48F:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=17612 pso_num=24 pso_serial#=223 2025-07-08 08:06:48.201436 :AF1FD490:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=17612 (legacy spawn) 2025-07-08 08:06:48.208116 :AF1FD491:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-08 08:06:48.208301 :AF1FD496:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-07-08 08:06:48.209117 :AF1FD49B:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-08 08:07:08.052184 :AF1FDB01:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-08 08:07:08.043 2025-07-08 08:07:08.052185 :AF1FDB02:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=8732 pso_num=24 pso_serial#=224 2025-07-08 08:07:08.052327 :AF1FDB03:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=8732 (legacy spawn) 2025-07-08 08:07:08.058888 :AF1FDB04:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-08 08:07:08.059052 :AF1FDB09:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-07-08 08:07:08.059844 :AF1FDB0E:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-08 08:07:10.914757 :AF1FDBF7:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-08 08:07:10.899 2025-07-08 08:07:10.914759 :AF1FDBF8:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=14320 pso_num=24 pso_serial#=225 2025-07-08 08:07:10.914937 :AF1FDBF9:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=14320 (legacy spawn) 2025-07-08 08:07:10.921503 :AF1FDBFA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-08 08:07:10.921536 :AF1FDBFD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-08 08:07:10.921689 :AF1FDC04:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-07-08 08:07:10.922506 :AF1FDC11:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-08 08:07:10.931682 :AF1FDC14:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-08 08:07:10.930 2025-07-08 08:07:10.931685 :AF1FDC15:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=17820 pso_num=24 pso_serial#=226 2025-07-08 08:07:10.931832 :AF1FDC16:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=17820 (legacy spawn) 2025-07-08 08:07:10.938434 :AF1FDC17:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-08 08:07:10.938631 :AF1FDC20:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-07-08 08:07:10.939492 :AF1FDC21:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-08 08:07:11.686331 :AF1FDC48:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-08 08:07:11.680 2025-07-08 08:07:11.686333 :AF1FDC49:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=15416 pso_num=24 pso_serial#=227 2025-07-08 08:07:11.686469 :AF1FDC4A:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=15416 osp_idx=22 osp_ver=535992 osp_pg=0 (spawn #363916) 2025-07-08 08:07:11.686470 :AF1FDC4B:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-08 08:07:11.686470 :AF1FDC4C:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=1 time=642807579 2025-07-08 08:07:11.686471 :AF1FDC4D:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-07-08 08:07:11.686471 :AF1FDC4E:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-07-08 08:07:11.686472 :AF1FDC4F:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-07-08 08:07:11.686472 :AF1FDC50:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-08 08:07:11.686472 :AF1FDC51:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-08 08:07:11.687021 :AF1FDC52:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-08 08:07:11.687697 :AF1FDC67:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-08 08:07:11.695480 :AF1FDC83:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-07-08 08:07:11.695865 :AF1FDC84:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-08 08:07:11.695906 :AF1FDC87:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-07-08 08:07:11.696786 :AF1FDC8D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-08 08:07:11.696913 :AF1FDC96:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-07-08 08:07:41.766957 :AF1FE65E:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-08 08:07:42.148089 :AF1FE661:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-08 08:07:42.138 2025-07-08 08:07:42.148092 :AF1FE662:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=15740 pso_num=24 pso_serial#=228 2025-07-08 08:07:42.148234 :AF1FE663:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=15740 (legacy spawn) 2025-07-08 08:07:42.154821 :AF1FE664:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-08 08:07:42.154988 :AF1FE669:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-07-08 08:07:42.155785 :AF1FE66E:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-08 08:07:47.197446 :AF1FE83B:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-08 08:07:47.183 2025-07-08 08:07:47.197448 :AF1FE83C:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=8928 pso_num=24 pso_serial#=229 2025-07-08 08:07:47.197590 :AF1FE83D:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=8928 (legacy spawn) 2025-07-08 08:07:47.204131 :AF1FE83E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-08 08:07:47.204297 :AF1FE847:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-07-08 08:07:47.205075 :AF1FE848:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-08 08:07:47.222913 :AF1FE84B:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-08 08:07:47.214 2025-07-08 08:07:47.222915 :AF1FE84C:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=14024 pso_num=24 pso_serial#=230 2025-07-08 08:07:47.223060 :AF1FE84D:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=14024 (legacy spawn) 2025-07-08 08:07:47.229664 :AF1FE857:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-08 08:07:47.229843 :AF1FE862:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-07-08 08:07:47.230683 :AF1FE863:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-08 08:07:50.290579 :AF1FE94C:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-08 08:07:50.277 2025-07-08 08:07:50.290581 :AF1FE94D:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=10124 pso_num=24 pso_serial#=231 2025-07-08 08:07:50.290725 :AF1FE94E:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=10124 (legacy spawn) 2025-07-08 08:07:50.297664 :AF1FE94F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-08 08:07:50.297845 :AF1FE954:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-07-08 08:07:50.298784 :AF1FE959:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-08 08:07:50.308098 :AF1FE95C:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-08 08:07:50.308 2025-07-08 08:07:50.308100 :AF1FE95D:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=12936 pso_num=24 pso_serial#=232 2025-07-08 08:07:50.308248 :AF1FE95E:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=12936 (legacy spawn) 2025-07-08 08:07:50.315245 :AF1FE95F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-08 08:07:50.315428 :AF1FE968:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-07-08 08:07:50.316374 :AF1FE969:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-08 08:07:52.221725 :AF1FE9FF:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-08 08:07:52.215 2025-07-08 08:07:52.221727 :AF1FEA00:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=11564 pso_num=24 pso_serial#=233 2025-07-08 08:07:52.221868 :AF1FEA01:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=11564 (legacy spawn) 2025-07-08 08:07:52.228393 :AF1FEA02:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-08 08:07:52.228578 :AF1FEA07:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-07-08 08:07:52.229378 :AF1FEA1A:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-08 08:08:11.758296 :AF1FF01F:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-08 08:08:11.752 2025-07-08 08:08:11.758298 :AF1FF020:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=15316 pso_num=24 pso_serial#=234 2025-07-08 08:08:11.758436 :AF1FF021:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=15316 osp_idx=22 osp_ver=535999 osp_pg=0 (spawn #363918) 2025-07-08 08:08:11.758437 :AF1FF022:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-08 08:08:11.758437 :AF1FF023:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=2 time=642867658 2025-07-08 08:08:11.758437 :AF1FF024:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-07-08 08:08:11.758438 :AF1FF025:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-07-08 08:08:11.758438 :AF1FF026:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-07-08 08:08:11.758439 :AF1FF027:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-08 08:08:11.758439 :AF1FF028:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-08 08:08:11.758960 :AF1FF029:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-08 08:08:11.759720 :AF1FF03E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-08 08:08:11.770883 :AF1FF05A:db_trace:kwqid.c@2146:kwqidrdq(): [10960:24:193] kwqidrdq: Error: 1403 occured in OCI execute 2025-07-08 08:08:11.771397 :AF1FF05B:db_trace:kwqid.c@2146:kwqidrdq(): [10960:24:193] kwqidrdq: Error: 1403 occured in OCI execute 2025-07-08 08:08:11.773872 :AF1FF05C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-07-08 08:08:11.774225 :AF1FF05D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-08 08:08:11.774261 :AF1FF060:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-07-08 08:08:11.775149 :AF1FF066:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-08 08:08:11.775294 :AF1FF06F:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-07-08 08:08:36.796604 :AF1FF89E:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=59 loc='kkj.h LINE:914 ID:kkjpstnp' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-07-08 08:08:36.796627*:AF1FF8A0:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000024D4BB58 estart=1751933315 eid=16946766 ctx=0x000000077BD98A08 cwh=0x00000000232802A0 cpu=0 buffg=1 interb=0 r=0 rb=0 w=0 wb=0 2025-07-08 08:08:36.796627*:AF1FF8A1:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000024D4BB58 curCtx=0x000000002328F300 pubTabIdxCnt=0 2025-07-08 08:08:36.796627*:AF1FF8A2:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000024D4BB58 2025-07-08 08:08:36.796627*:AF1FF8A3:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000024D4BB58 2025-07-08 08:08:36.796627*:AF1FF8A4:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000024D4BB58 curCtx=0x000000002328F300 xsc->flg4=65792 flags=2 2025-07-08 08:08:36.796627*:AF1FF8A5:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000024D4BB58 2025-07-08 08:08:36.797177 :AF1FF8A6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-08 08:08:36.802525 :AF1FF8AE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-08 08:08:36.803343 :AF1FF8B6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-08 08:08:36.803482 :AF1FF8BF:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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 24 (osid: 15316, J000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de