Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250627080245\orcl_j000_12668_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250627080245\orcl_j000_12668_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:36315M/63366M, Ph+PgF:42431M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 24 Windows thread id: 12668, image: ORACLE.EXE (J000) *** 2025-06-27 08:02:45.593 *** SESSION ID:(193.36671) 2025-06-27 08:02:45.593 *** 2025-06-27 08:02:45.593 Process diagnostic dump for ORACLE.EXE (J000), OS id=12668, pid: 24, proc_ser: 193, sid: 193, sess_ser: 36671 ------------------------------------------------------------------------------- current sql: <none> client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 12668 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.001037 sec, exc=0.001037 sec, total=0.001037 sec wait times: max=0.500000 sec, heur=16.048565 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=31 seq_num=32 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.000012 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.500127 sec, exc=0.500127 sec, total=0.500127 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=29 seq_num=30 snap_id=1 wait times: snap=0.499958 sec, exc=0.499958 sec, total=0.499958 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000019 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.500021 sec, exc=0.500021 sec, total=0.500021 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.499989 sec, exc=0.499989 sec, total=0.499989 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000010 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.500009 sec, exc=0.500009 sec, total=0.500009 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=25 seq_num=26 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.000009 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.506239 sec, exc=0.506239 sec, total=0.506239 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 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.500154 sec, exc=0.500154 sec, total=0.500154 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000005 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.499995 sec, exc=0.499995 sec, total=0.499995 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000007 sec of elapsed time Sampled Session History of session 193 serial 36671 --------------------------------------------------- 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:02:29 - 08:02:45] idle wait at each sample [session created at: 08:02:29] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-06-27 08:02:45.593 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 24 (osid: 12668, J000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-06-27 08:00:20.927799 :AA3D14D4:db_trace:ktu.c@4871:ktuaex1r(): [10442:24:193] Extension usn 6, ext 2, nex 4 2025-06-27 08:00:20.927807 :AA3D14D5:db_trace:ktusm.c@2117:ktusmasp(): [10445:24:193] des1:tsn:1 rdba:0x00812ac6 where: kdiwh22: kdifind 2025-06-27 08:00:20.928674 :AA3D14D6: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-06-27 08:00:20.957545 :AA3D14DE: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-06-27 08:00:20.961263 :AA3D14E6: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-06-27 08:00:20.964920 :AA3D14EE: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-06-27 08:00:20.969058 :AA3D14F6: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-06-27 08:00:20.970145 :AA3D14FE: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-06-27 08:00:21.956225*:AA3D1512:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000023253CD0 estart=1750982420 eid=16779529 ctx=0x000000077BA4B1C8 cwh=0x0000000023240BE8 cpu=359375 buffg=0 interb=0 r=0 rb=0 w=0 wb=0 2025-06-27 08:00:21.956225*:AA3D1513:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000023253CD0 curCtx=0x0000000024D5F580 pubTabIdxCnt=0 2025-06-27 08:00:21.956225*:AA3D1514:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000023253CD0 2025-06-27 08:00:21.956225*:AA3D1515:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000023253CD0 2025-06-27 08:00:21.956225*:AA3D1516:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000002329FCB8 estart=1750982420 eid=16779516 ctx=0x0000000787AD5BF0 cwh=0x00000000232408C0 cpu=359375 buffg=0 interb=0 r=0 rb=0 w=0 wb=0 2025-06-27 08:00:21.956225*:AA3D1517:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000002329FCB8 curCtx=0x0000000023291948 pubTabIdxCnt=0 2025-06-27 08:00:21.956225*:AA3D1518:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000002329FCB8 2025-06-27 08:00:21.956225*:AA3D1519:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000002329FCB8 2025-06-27 08:00:22.143730*:AA3D152E:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000023253CD0 curCtx=0x0000000024D5F580 xsc->flg4=65792 flags=1 2025-06-27 08:00:22.143730*:AA3D152F:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000023253CD0 2025-06-27 08:00:22.143730*:AA3D1530:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000002329FCB8 curCtx=0x0000000023291948 xsc->flg4=65792 flags=2 2025-06-27 08:00:22.143730*:AA3D1531:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000002329FCB8 2025-06-27 08:00:22.221585 :AA3D1532: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-06-27 08:00:22.254673 :AA3D153A: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-06-27 08:00:22.254991 :AA3D1542: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-06-27 08:00:22.255269 :AA3D154A: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-06-27 08:00:22.255286 :AA3D154D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=18 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-27 08:00:22.255348 :AA3D155B: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-06-27 08:00:22.258634 :AA3D1567:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-27 08:00:22.282203 :AA3D15C0:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-27 08:00:22.269 2025-06-27 08:00:22.282205 :AA3D15C1:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=12172 pso_num=24 pso_serial#=182 2025-06-27 08:00:22.282334 :AA3D15C2:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=12172 (legacy spawn) 2025-06-27 08:00:22.288873 :AA3D15C3: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-06-27 08:00:22.289031 :AA3D15CB: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-06-27 08:00:22.289901 :AA3D15CD:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-27 08:00:22.298684 :AA3D15D0:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-27 08:00:22.284 2025-06-27 08:00:22.298687 :AA3D15D1:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=13240 pso_num=24 pso_serial#=183 2025-06-27 08:00:22.298827 :AA3D15D2:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=13240 (legacy spawn) 2025-06-27 08:00:22.305343 :AA3D15D3: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-06-27 08:00:22.305515 :AA3D15DA: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-06-27 08:00:22.306305 :AA3D15DD:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-27 08:00:25.671892 :AA3D16F5:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-27 08:00:25.663 2025-06-27 08:00:25.671894 :AA3D16F6:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=17392 pso_num=24 pso_serial#=184 2025-06-27 08:00:25.672037 :AA3D16F7:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=17392 (legacy spawn) 2025-06-27 08:00:25.678546 :AA3D16F8: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-06-27 08:00:25.678725 :AA3D16FD: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-06-27 08:00:25.679571 :AA3D1718:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-27 08:00:29.325549 :AA3D185A:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-27 08:00:29.320 2025-06-27 08:00:29.325550 :AA3D185B:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=4556 pso_num=24 pso_serial#=185 2025-06-27 08:00:29.325698 :AA3D185C:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=4556 osp_idx=22 osp_ver=472455 osp_pg=0 (spawn #327217) 2025-06-27 08:00:29.325699 :AA3D185D:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-27 08:00:29.325699 :AA3D185E:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=180 time=3986972516 2025-06-27 08:00:29.325700 :AA3D185F:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-06-27 08:00:29.325700 :AA3D1860:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-06-27 08:00:29.325700 :AA3D1861:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-06-27 08:00:29.325701 :AA3D1862:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-27 08:00:29.325701 :AA3D1863:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-27 08:00:29.326213 :AA3D1864: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-06-27 08:00:29.326890 :AA3D1879: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-06-27 08:00:29.337997 :AA3D1895:db_trace:kwqid.c@2146:kwqidrdq(): [10960:24:193] kwqidrdq: Error: 1403 occured in OCI execute 2025-06-27 08:00:29.338472 :AA3D1896:db_trace:kwqid.c@2146:kwqidrdq(): [10960:24:193] kwqidrdq: Error: 1403 occured in OCI execute 2025-06-27 08:00:29.340884 :AA3D1897:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-06-27 08:00:29.341226 :AA3D1898: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-06-27 08:00:29.341266 :AA3D189B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-06-27 08:00:29.344109 :AA3D18A1: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-06-27 08:00:29.344923 :AA3D18A9: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-06-27 08:00:29.346514 :AA3D18B1: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-06-27 08:00:29.350665 :AA3D18B9: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-06-27 08:00:29.354214 :AA3D18C1: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-06-27 08:00:29.358190 :AA3D18C9: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-06-27 08:00:29.362119 :AA3D18D1: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-06-27 08:00:29.362750 :AA3D18D9: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-06-27 08:00:29.368576 :AA3D18E1: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-06-27 08:00:29.368868 :AA3D18E9: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-06-27 08:00:29.373158 :AA3D18F1: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-06-27 08:00:29.373638 :AA3D18F9: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-06-27 08:00:29.377149 :AA3D1901: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-06-27 08:00:29.378144 :AA3D1909:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-06-27 08:00:29.378411 :AA3D190A: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-06-27 08:00:29.378441 :AA3D190D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-06-27 08:00:29.378449 :AA3D190E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-06-27 08:00:29.378579 :AA3D1914: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-06-27 08:00:29.378597 :AA3D1917:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-06-27 08:00:29.378602 :AA3D1918:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-06-27 08:00:29.378703 :AA3D191E: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-06-27 08:00:29.378718 :AA3D1921:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-06-27 08:00:29.378724 :AA3D1922:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-06-27 08:00:29.378816 :AA3D1928: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-06-27 08:00:29.378831 :AA3D192B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-06-27 08:00:29.378836 :AA3D192C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-06-27 08:00:29.378932 :AA3D1932: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-06-27 08:00:29.378950 :AA3D1935:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-06-27 08:00:29.378955 :AA3D1936:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-06-27 08:00:29.379047 :AA3D193C: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-06-27 08:00:29.379063 :AA3D193F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-06-27 08:00:29.379587 :AA3D1945:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-06-27 08:00:29.379711 :AA3D1946: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-06-27 08:00:29.379730 :AA3D1949:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-06-27 08:00:29.383687 :AA3D194F: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-06-27 08:00:29.383765 :AA3D1952:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-06-27 08:00:29.384014 :AA3D1958: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-06-27 08:00:29.384036 :AA3D195B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-06-27 08:00:29.386211 :AA3D1961: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-06-27 08:00:29.386362 :AA3D196A: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-06-27 08:00:59.481278 :AA3D236B:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-27 08:01:27.819446 :AA3D2C83:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-27 08:01:27.812 2025-06-27 08:01:27.819448 :AA3D2C84:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=7996 pso_num=24 pso_serial#=186 2025-06-27 08:01:27.819586 :AA3D2C85:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=7996 (legacy spawn) 2025-06-27 08:01:27.826137 :AA3D2C86: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-06-27 08:01:27.826174 :AA3D2C89: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-06-27 08:01:27.826325 :AA3D2C8C: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-06-27 08:01:27.827151 :AA3D2C9D:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-27 08:01:29.431211 :AA3D2D1E:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-27 08:01:29.426 2025-06-27 08:01:29.431213 :AA3D2D1F:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=15304 pso_num=24 pso_serial#=187 2025-06-27 08:01:29.431358 :AA3D2D20:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=15304 osp_idx=22 osp_ver=472457 osp_pg=0 (spawn #327220) 2025-06-27 08:01:29.431359 :AA3D2D21:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-27 08:01:29.431359 :AA3D2D22:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=181 time=3987032625 2025-06-27 08:01:29.431360 :AA3D2D23:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-06-27 08:01:29.431360 :AA3D2D24:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-06-27 08:01:29.431360 :AA3D2D25:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-06-27 08:01:29.431360 :AA3D2D26:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-27 08:01:29.431361 :AA3D2D27:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-27 08:01:29.431871 :AA3D2D28: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-06-27 08:01:29.432503 :AA3D2D3D: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-06-27 08:01:29.440031 :AA3D2D59:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-06-27 08:01:29.440413 :AA3D2D5A: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-06-27 08:01:29.440447 :AA3D2D5D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-06-27 08:01:29.441288 :AA3D2D63: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-06-27 08:01:29.441405 :AA3D2D6C: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-06-27 08:01:59.510055 :AA3D377C:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-27 08:02:04.250256 :AA3D38EA:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-27 08:02:04.242 2025-06-27 08:02:04.250257 :AA3D38EB:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=10400 pso_num=24 pso_serial#=188 2025-06-27 08:02:04.250438 :AA3D38EC:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=10400 (legacy spawn) 2025-06-27 08:02:04.256811 :AA3D38ED: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-06-27 08:02:04.256839 :AA3D38F0: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-06-27 08:02:04.256991 :AA3D38F3: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-06-27 08:02:04.257839 :AA3D3904:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-27 08:02:07.997799 :AA3D3A0D:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-27 08:02:07.983 2025-06-27 08:02:07.997801 :AA3D3A0E:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=11488 pso_num=24 pso_serial#=189 2025-06-27 08:02:07.997934 :AA3D3A0F:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=11488 (legacy spawn) 2025-06-27 08:02:08.004331 :AA3D3A10: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-06-27 08:02:08.004504 :AA3D3A15: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-06-27 08:02:08.005320 :AA3D3A1A:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-27 08:02:08.023537 :AA3D3A1D:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-27 08:02:08.015 2025-06-27 08:02:08.023539 :AA3D3A1E:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=17364 pso_num=24 pso_serial#=190 2025-06-27 08:02:08.023676 :AA3D3A1F:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=17364 (legacy spawn) 2025-06-27 08:02:08.030038 :AA3D3A20: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-06-27 08:02:08.030208 :AA3D3A29: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-06-27 08:02:08.031035 :AA3D3A2A:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-27 08:02:11.199881 :AA3D3B25:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-27 08:02:11.187 2025-06-27 08:02:11.199883 :AA3D3B26:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=16444 pso_num=24 pso_serial#=191 2025-06-27 08:02:11.200019 :AA3D3B27:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=16444 (legacy spawn) 2025-06-27 08:02:11.206468 :AA3D3B33: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-06-27 08:02:11.206653 :AA3D3B38: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-06-27 08:02:11.207419 :AA3D3B3D:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-27 08:02:11.216190 :AA3D3B40:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-27 08:02:11.204 2025-06-27 08:02:11.216192 :AA3D3B41:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=16980 pso_num=24 pso_serial#=192 2025-06-27 08:02:11.216331 :AA3D3B42:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=16980 (legacy spawn) 2025-06-27 08:02:11.222774 :AA3D3B43: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-06-27 08:02:11.222944 :AA3D3B4C: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-06-27 08:02:11.223759 :AA3D3B4D:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-27 08:02:29.527831 :AA3D412E:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-27 08:02:29.522 2025-06-27 08:02:29.527834 :AA3D412F:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=12668 pso_num=24 pso_serial#=193 2025-06-27 08:02:29.527977 :AA3D4130:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=12668 osp_idx=22 osp_ver=472463 osp_pg=0 (spawn #327222) 2025-06-27 08:02:29.527977 :AA3D4131:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-27 08:02:29.527978 :AA3D4132:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=182 time=3987092719 2025-06-27 08:02:29.527978 :AA3D4133:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-06-27 08:02:29.527979 :AA3D4134:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-06-27 08:02:29.527979 :AA3D4135:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-06-27 08:02:29.527979 :AA3D4136:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-27 08:02:29.527980 :AA3D4137:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-27 08:02:29.528477 :AA3D4138: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-06-27 08:02:29.529128 :AA3D414D: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-06-27 08:02:29.540097 :AA3D4169:db_trace:kwqid.c@2146:kwqidrdq(): [10960:24:193] kwqidrdq: Error: 1403 occured in OCI execute 2025-06-27 08:02:29.540560 :AA3D416A:db_trace:kwqid.c@2146:kwqidrdq(): [10960:24:193] kwqidrdq: Error: 1403 occured in OCI execute 2025-06-27 08:02:29.542845 :AA3D416B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-06-27 08:02:29.543185 :AA3D416C: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-06-27 08:02:29.543222 :AA3D416F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-06-27 08:02:29.544178 :AA3D4175: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-06-27 08:02:29.544303 :AA3D417E: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: 12668, J000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de