Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250913082356\orcl_j000_23332_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250913082356\orcl_j000_23332_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:34797M/63366M, Ph+PgF:39447M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 24 Windows thread id: 23332, image: ORACLE.EXE (J000) *** 2025-09-13 08:23:56.126 *** SESSION ID:(193.23395) 2025-09-13 08:23:56.126 *** 2025-09-13 08:23:56.126 Process diagnostic dump for ORACLE.EXE (J000), OS id=23332, pid: 24, proc_ser: 21, sid: 193, sess_ser: 23395 ------------------------------------------------------------------------------- current sql: <none> client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 23332 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J000) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=52 seq_num=53 snap_id=1 wait times: snap=0.077957 sec, exc=0.077957 sec, total=0.077957 sec wait times: max=0.500000 sec, heur=26.164305 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.000006 sec since current wait 0: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=51 seq_num=52 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.000011 sec of elapsed time 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=50 seq_num=51 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.000009 sec of elapsed time 2: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=49 seq_num=50 snap_id=1 wait times: snap=0.499963 sec, exc=0.499963 sec, total=0.499963 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000014 sec of elapsed time 3: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=48 seq_num=49 snap_id=1 wait times: snap=0.500023 sec, exc=0.500023 sec, total=0.500023 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 4: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=47 seq_num=48 snap_id=1 wait times: snap=0.500117 sec, exc=0.500117 sec, total=0.500117 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=46 seq_num=47 snap_id=1 wait times: snap=0.500178 sec, exc=0.500178 sec, total=0.500178 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000010 sec of elapsed time 6: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=45 seq_num=46 snap_id=1 wait times: snap=0.499988 sec, exc=0.499988 sec, total=0.499988 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000013 sec of elapsed time 7: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=44 seq_num=45 snap_id=1 wait times: snap=0.500008 sec, exc=0.500008 sec, total=0.500008 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000005 sec of elapsed time 8: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=43 seq_num=44 snap_id=1 wait times: snap=0.500003 sec, exc=0.500003 sec, total=0.500003 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=42 seq_num=43 snap_id=1 wait times: snap=0.499979 sec, exc=0.499979 sec, total=0.499979 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000013 sec of elapsed time Sampled Session History of session 193 serial 23395 --------------------------------------------------- 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 --------------------------------------------------- [27 samples, 08:23:29 - 08:23:56] idle wait at each sample [session created at: 08:23:29] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.015000 sec (max dump time=30.000000 sec) *** 2025-09-13 08:23:56.142 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 24 (osid: 23332, J000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-09-13 08:20:29.795434 :CCC6373D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-09-13 08:20:29.800980 :CCC63743: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-09-13 08:20:29.801041 :CCC63746:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:ktcc.c:879 2025-09-13 08:20:29.801073 :CCC63747:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:ktcc.c:879 2025-09-13 08:20:29.802803 :CCC6374D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-09-13 08:20:29.802847 :CCC6374E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-09-13 08:20:29.806050 :CCC6374F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-09-13 08:20:29.806298 :CCC63750: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-09-13 08:20:29.806333 :CCC63753:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-09-13 08:20:29.811244 :CCC63759: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-09-13 08:20:29.811326 :CCC6375C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:ktcc.c:879 2025-09-13 08:20:29.811371 :CCC6375D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:ktcc.c:879 2025-09-13 08:20:29.813237 :CCC63763:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-09-13 08:20:29.813282 :CCC63764:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-09-13 08:20:29.813898 :CCC63765:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-09-13 08:20:29.814118 :CCC63766: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-09-13 08:20:29.814152 :CCC63769:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-09-13 08:20:29.821460 :CCC6376F: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-09-13 08:20:29.821523 :CCC63772:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:ktcc.c:879 2025-09-13 08:20:29.821552 :CCC63773:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:ktcc.c:879 2025-09-13 08:20:29.821856 :CCC63779:db_trace:kwqid.c@2146:kwqidrdq(): [10960:24:193] kwqidrdq: Error: 1403 occured in OCI execute 2025-09-13 08:20:29.822191 :CCC6377A:db_trace:kwqid.c@2146:kwqidrdq(): [10960:24:193] kwqidrdq: Error: 1403 occured in OCI execute 2025-09-13 08:20:29.822312 :CCC6377B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-09-13 08:20:29.822542 :CCC6377C: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-09-13 08:20:29.822568 :CCC6377F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-09-13 08:20:29.824212 :CCC63785:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-09-13 08:20:29.824441 :CCC63786: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-09-13 08:20:29.824472 :CCC63789:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-09-13 08:20:29.825388 :CCC6378F: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-09-13 08:20:29.825505 :CCC63798: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-09-13 08:20:59.918201 :CCC64172:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-13 08:21:01.644851 :CCC6422F:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-13 08:21:01.637 2025-09-13 08:21:01.644854 :CCC64230:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=24288 pso_num=24 pso_serial#=7 2025-09-13 08:21:01.645005 :CCC64231:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=24288 (legacy spawn) 2025-09-13 08:21:01.672250 :CCC64232: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-09-13 08:21:01.672426 :CCC64237: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-09-13 08:21:01.673272 :CCC6423C:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-13 08:21:14.761025 :CCC64648:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-13 08:21:14.755 2025-09-13 08:21:14.761027 :CCC64649:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=20960 pso_num=24 pso_serial#=8 2025-09-13 08:21:14.761171 :CCC6464A:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=20960 osp_idx=22 osp_ver=887507 osp_pg=0 (spawn #587269) 2025-09-13 08:21:14.761172 :CCC6464B:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-13 08:21:14.761172 :CCC6464C:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=47 time=2137326065 2025-09-13 08:21:14.761173 :CCC6464D:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-09-13 08:21:14.761173 :CCC6464E:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-09-13 08:21:14.761174 :CCC6464F:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-09-13 08:21:14.761174 :CCC64650:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-13 08:21:14.761175 :CCC64651:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-13 08:21:14.761696 :CCC64652: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-09-13 08:21:14.762444 :CCC64667: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-09-13 08:21:14.767983 :CCC64683: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-09-13 08:21:14.769000 :CCC6468B: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-09-13 08:21:14.769126 :CCC64694: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-09-13 08:21:29.788984 :CCC64BB7: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-09-13 08:21:29.789003*:CCC64BBD:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000026B5BB58 estart=1757722888 eid=17053085 ctx=0x000000077BD98A08 cwh=0x0000000024D802A0 cpu=0 buffg=1 interb=0 r=0 rb=0 w=0 wb=0 2025-09-13 08:21:29.789003*:CCC64BBE:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000026B5BB58 curCtx=0x0000000024D8F300 pubTabIdxCnt=0 2025-09-13 08:21:29.789003*:CCC64BBF:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000026B5BB58 2025-09-13 08:21:29.789003*:CCC64BC0:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000026B5BB58 2025-09-13 08:21:29.789003*:CCC64BC1:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000026B5BB58 curCtx=0x0000000024D8F300 xsc->flg4=65792 flags=2 2025-09-13 08:21:29.789003*:CCC64BC2:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000026B5BB58 2025-09-13 08:21:29.789565 :CCC64BC3: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-09-13 08:21:29.797049 :CCC64BCB:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-09-13 08:21:29.797408 :CCC64BCC: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-09-13 08:21:29.797447 :CCC64BCF:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-09-13 08:21:29.798365 :CCC64BD5: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-09-13 08:21:29.798501 :CCC64BDE: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-09-13 08:21:59.899325 :CCC65576:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-13 08:22:01.771496 :CCC6563C:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-13 08:22:01.758 2025-09-13 08:22:01.771498 :CCC6563D:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=19212 pso_num=24 pso_serial#=9 2025-09-13 08:22:01.771646 :CCC6563E:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=19212 (legacy spawn) 2025-09-13 08:22:01.778160 :CCC6563F: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-09-13 08:22:01.778339 :CCC65644: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-09-13 08:22:01.779135 :CCC65649:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-13 08:22:01.787841 :CCC6564C:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-13 08:22:01.774 2025-09-13 08:22:01.787843 :CCC6564D:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=19728 pso_num=24 pso_serial#=10 2025-09-13 08:22:01.787987 :CCC6564E:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=19728 (legacy spawn) 2025-09-13 08:22:01.809345 :CCC6564F: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-09-13 08:22:01.809513 :CCC65658: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-09-13 08:22:01.810316 :CCC65659:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-13 08:22:03.640669 :CCC656E2:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-13 08:22:03.631 2025-09-13 08:22:03.640671 :CCC656E3:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=25460 pso_num=24 pso_serial#=11 2025-09-13 08:22:03.640823 :CCC656E4:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=25460 (legacy spawn) 2025-09-13 08:22:03.647348 :CCC656E5: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-09-13 08:22:03.647519 :CCC656EA: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-09-13 08:22:03.648311 :CCC656EE:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-13 08:22:03.796040 :CCC656FC:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-13 08:22:03.787 2025-09-13 08:22:03.796041 :CCC656FD:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=24872 pso_num=24 pso_serial#=12 2025-09-13 08:22:03.796175 :CCC656FE:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=24872 (legacy spawn) 2025-09-13 08:22:04.169144 :CCC65721: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-09-13 08:22:04.169315 :CCC6572A: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-09-13 08:22:04.170161 :CCC6572B:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-13 08:22:29.889391 :CCC65F34:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-13 08:22:29.883 2025-09-13 08:22:29.889393 :CCC65F35:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=24292 pso_num=24 pso_serial#=13 2025-09-13 08:22:29.889539 :CCC65F36:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=24292 osp_idx=22 osp_ver=887512 osp_pg=0 (spawn #587271) 2025-09-13 08:22:29.889540 :CCC65F37:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-13 08:22:29.889540 :CCC65F38:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=48 time=2137401190 2025-09-13 08:22:29.889541 :CCC65F39:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-09-13 08:22:29.889541 :CCC65F3A:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-09-13 08:22:29.889541 :CCC65F3B:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-09-13 08:22:29.889542 :CCC65F3C:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-13 08:22:29.889542 :CCC65F3D:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-13 08:22:29.890053 :CCC65F3E: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-09-13 08:22:29.890741 :CCC65F53: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-09-13 08:22:29.901959 :CCC65F6F:db_trace:kwqid.c@2146:kwqidrdq(): [10960:24:193] kwqidrdq: Error: 1403 occured in OCI execute 2025-09-13 08:22:29.902491 :CCC65F70:db_trace:kwqid.c@2146:kwqidrdq(): [10960:24:193] kwqidrdq: Error: 1403 occured in OCI execute 2025-09-13 08:22:29.905009 :CCC65F71:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-09-13 08:22:29.905391 :CCC65F72: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-09-13 08:22:29.905432 :CCC65F75:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-09-13 08:22:29.906335 :CCC65F7B: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-09-13 08:22:29.906482 :CCC65F83: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-09-13 08:22:59.983560 :CCC6697A:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-13 08:23:05.958755 :CCC66B56:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-13 08:23:05.951 2025-09-13 08:23:05.958757 :CCC66B57:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=21564 pso_num=24 pso_serial#=14 2025-09-13 08:23:05.958894 :CCC66B58:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=21564 (legacy spawn) 2025-09-13 08:23:05.965373 :CCC66B59: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-09-13 08:23:05.965547 :CCC66B62: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-09-13 08:23:05.966351 :CCC66B63:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-13 08:23:10.388628 :CCC66D06:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-13 08:23:10.383 2025-09-13 08:23:10.388629 :CCC66D07:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=25124 pso_num=24 pso_serial#=15 2025-09-13 08:23:10.388835 :CCC66D08:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=25124 osp_idx=22 osp_ver=887514 osp_pg=0 (spawn #587273) 2025-09-13 08:23:10.388836 :CCC66D09:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-13 08:23:10.388837 :CCC66D0A:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=49 time=2137441690 2025-09-13 08:23:10.388837 :CCC66D0B:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-09-13 08:23:10.388838 :CCC66D0C:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-09-13 08:23:10.388839 :CCC66D0D:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-09-13 08:23:10.388839 :CCC66D0E:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-13 08:23:10.388839 :CCC66D0F:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-13 08:23:10.389375 :CCC66D10:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-13 08:23:10.389434 :CCC66D16:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-09-13 08:23:10.411621 :CCC66D73:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-13 08:23:11.397837 :CCC66D8D:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-13 08:23:11.383 2025-09-13 08:23:11.397839 :CCC66D8E:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=22444 pso_num=24 pso_serial#=16 2025-09-13 08:23:11.397983 :CCC66D8F:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=22444 (legacy spawn) 2025-09-13 08:23:11.405062 :CCC66D90: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-09-13 08:23:11.405238 :CCC66D99: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-09-13 08:23:11.405965 :CCC66D9A:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-13 08:23:11.415874 :CCC66D9D:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-13 08:23:11.414 2025-09-13 08:23:11.415875 :CCC66D9E:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=19396 pso_num=24 pso_serial#=17 2025-09-13 08:23:11.415966 :CCC66D9F:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=19396 (legacy spawn) 2025-09-13 08:23:11.421951 :CCC66DA0: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-09-13 08:23:11.422120 :CCC66DA8: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-09-13 08:23:11.422909 :CCC66DAA:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-13 08:23:11.718031 :CCC66DC0:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-13 08:23:11.711 2025-09-13 08:23:11.718033 :CCC66DC1:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=24928 pso_num=24 pso_serial#=18 2025-09-13 08:23:11.718173 :CCC66DC2:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=24928 (legacy spawn) 2025-09-13 08:23:11.724784 :CCC66DC3: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-09-13 08:23:11.724958 :CCC66DCC: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-09-13 08:23:11.725821 :CCC66DCD:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-13 08:23:14.597335 :CCC66EA4:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-13 08:23:14.584 2025-09-13 08:23:14.597337 :CCC66EA5:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=18624 pso_num=24 pso_serial#=19 2025-09-13 08:23:14.597482 :CCC66EA6:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=18624 (legacy spawn) 2025-09-13 08:23:14.603938 :CCC66EBA: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-09-13 08:23:14.604113 :CCC66EC3: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-09-13 08:23:14.604900 :CCC66EC4:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-13 08:23:14.624064 :CCC66EC7:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-13 08:23:14.615 2025-09-13 08:23:14.624066 :CCC66EC8:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=24696 pso_num=24 pso_serial#=20 2025-09-13 08:23:14.624206 :CCC66EC9:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=24696 (legacy spawn) 2025-09-13 08:23:14.630675 :CCC66ECA: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-09-13 08:23:14.630850 :CCC66ED2: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-09-13 08:23:14.631658 :CCC66ED4:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-13 08:23:29.965311 :CCC673B5:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-13 08:23:29.960 2025-09-13 08:23:29.965314 :CCC673B6:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=23332 pso_num=24 pso_serial#=21 2025-09-13 08:23:29.965451 :CCC673B7:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=23332 osp_idx=22 osp_ver=887520 osp_pg=0 (spawn #587275) 2025-09-13 08:23:29.965452 :CCC673B8:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-13 08:23:29.965452 :CCC673B9:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=50 time=2137461268 2025-09-13 08:23:29.965453 :CCC673BA:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-09-13 08:23:29.965453 :CCC673BB:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-09-13 08:23:29.965453 :CCC673BC:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-09-13 08:23:29.965454 :CCC673BD:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-13 08:23:29.965454 :CCC673BE:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-13 08:23:29.965958 :CCC673BF: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-09-13 08:23:29.966595 :CCC673D4: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-09-13 08:23:29.974178 :CCC673F0:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-09-13 08:23:29.974553 :CCC673F1: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-09-13 08:23:29.974591 :CCC673F4:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-09-13 08:23:29.975559 :CCC673FA: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-09-13 08:23:29.975686 :CCC67403: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: 23332, J000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de