Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250518100016\orcl_j000_6572_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250518100016\orcl_j000_6572_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:37396M/63366M, Ph+PgF:44611M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 25 Windows thread id: 6572, image: ORACLE.EXE (J000) *** 2025-05-18 10:00:16.509 *** SESSION ID:(201.34411) 2025-05-18 10:00:16.509 *** 2025-05-18 10:00:16.509 Process diagnostic dump for ORACLE.EXE (J000), OS id=6572, pid: 25, proc_ser: 5, sid: 201, sess_ser: 34411 ------------------------------------------------------------------------------- current sql: <none> client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 6572 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J000) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=62 seq_num=63 snap_id=1 wait times: snap=0.425747 sec, exc=0.425747 sec, total=0.425747 sec wait times: max=0.500000 sec, heur=31.416486 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=61 seq_num=62 snap_id=1 wait times: snap=0.505108 sec, exc=0.505108 sec, total=0.505108 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000013 sec of elapsed time 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=60 seq_num=61 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.000009 sec of elapsed time 2: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=59 seq_num=60 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.000010 sec of elapsed time 3: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=58 seq_num=59 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.000011 sec of elapsed time 4: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=57 seq_num=58 snap_id=1 wait times: snap=0.500014 sec, exc=0.500014 sec, total=0.500014 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000007 sec of elapsed time 5: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=56 seq_num=57 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.000009 sec of elapsed time 6: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=55 seq_num=56 snap_id=1 wait times: snap=0.502083 sec, exc=0.502083 sec, total=0.502083 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=54 seq_num=55 snap_id=1 wait times: snap=0.499156 sec, exc=0.499156 sec, total=0.499156 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000010 sec of elapsed time 8: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=53 seq_num=54 snap_id=1 wait times: snap=0.407086 sec, exc=0.407086 sec, total=0.407086 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000007 sec of elapsed time 9: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=52 seq_num=53 snap_id=1 wait times: snap=0.500000 sec, exc=0.500000 sec, total=0.500000 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time Sampled Session History of session 201 serial 34411 --------------------------------------------------- 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 --------------------------------------------------- [32 samples, 09:59:45 - 10:00:16] idle wait at each sample [session created at: 09:59:45] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-05-18 10:00:16.509 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 25 (osid: 6572, J000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-18 09:57:17.432081 :98AFC50F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-18 09:57:17.432246 :98AFC518:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-18 09:57:17.433106 :98AFC519:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-18 09:57:20.528679 :98AFC633:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-18 09:57:20.515 2025-05-18 09:57:20.528681 :98AFC634:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=13580 pso_num=25 pso_serial#=242 2025-05-18 09:57:20.528812 :98AFC635:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=13580 (legacy spawn) 2025-05-18 09:57:20.535321 :98AFC636:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-18 09:57:20.535493 :98AFC63B:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-18 09:57:20.536283 :98AFC640:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-18 09:57:20.544878 :98AFC643:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-18 09:57:20.531 2025-05-18 09:57:20.544880 :98AFC644:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=13924 pso_num=25 pso_serial#=243 2025-05-18 09:57:20.545014 :98AFC645:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=13924 (legacy spawn) 2025-05-18 09:57:20.551390 :98AFC646:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-18 09:57:20.551558 :98AFC64F:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-18 09:57:20.552367 :98AFC650:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-18 09:57:35.269000 :98AFCAD5:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-18 09:57:35.256 2025-05-18 09:57:35.269002 :98AFCAD6:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=9628 pso_num=25 pso_serial#=244 2025-05-18 09:57:35.269141 :98AFCAD7:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=9628 (legacy spawn) 2025-05-18 09:57:35.275705 :98AFCAD8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-18 09:57:35.275877 :98AFCADD:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-18 09:57:35.276683 :98AFCAE2:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-18 09:57:39.844045 :98AFCCBE:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-18 09:57:39.838 2025-05-18 09:57:39.844046 :98AFCCBF:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=11580 pso_num=25 pso_serial#=245 2025-05-18 09:57:39.844182 :98AFCCC0:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=11580 osp_idx=23 osp_ver=103519 osp_pg=0 (spawn #194165) 2025-05-18 09:57:39.844182 :98AFCCC1:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-18 09:57:39.844183 :98AFCCC2:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=91 time=538069719 2025-05-18 09:57:39.844183 :98AFCCC3:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-18 09:57:39.844183 :98AFCCC4:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-18 09:57:39.844183 :98AFCCC5:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-18 09:57:39.844184 :98AFCCC6:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-18 09:57:39.844184 :98AFCCC7:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-18 09:57:39.844665 :98AFCCC8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-18 09:57:39.845220 :98AFCCDD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-18 09:57:39.850612 :98AFCCFA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-18 09:57:39.851597 :98AFCD02:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-18 09:57:39.851691 :98AFCD0B:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-18 09:57:44.842040 :98AFCE95:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=59 loc='kkj.h LINE:914 ID:kkjpstnp' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-18 09:57:44.842062*:98AFCE98:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000024DCBB58 estart=1747533464 eid=16865970 ctx=0x000000077BD98A08 cwh=0x0000000024D802A0 cpu=0 buffg=1 interb=0 r=0 rb=0 w=0 wb=0 2025-05-18 09:57:44.842062*:98AFCE99:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000024DCBB58 curCtx=0x0000000024D8F300 pubTabIdxCnt=0 2025-05-18 09:57:44.842062*:98AFCE9A:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000024DCBB58 2025-05-18 09:57:44.842062*:98AFCE9B:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000024DCBB58 2025-05-18 09:57:44.842062*:98AFCE9C:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000024DCBB58 curCtx=0x0000000024D8F300 xsc->flg4=65792 flags=2 2025-05-18 09:57:44.842062*:98AFCE9D:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000024DCBB58 2025-05-18 09:57:44.842608 :98AFCE9E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-18 09:57:44.850807 :98AFCEA6:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:psdpgi.c:2235 2025-05-18 09:57:44.851205 :98AFCEA7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-18 09:57:44.851244 :98AFCEAA:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:psdpgi.c:2235 2025-05-18 09:57:44.852154 :98AFCEB0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-18 09:57:44.852286 :98AFCEB9:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-18 09:58:14.935855 :98AFD88D:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-18 09:58:16.695907 :98AFD8F7:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-18 09:58:16.685 2025-05-18 09:58:16.695909 :98AFD8F8:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=14208 pso_num=25 pso_serial#=246 2025-05-18 09:58:16.696036 :98AFD8F9:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=14208 (legacy spawn) 2025-05-18 09:58:16.702794 :98AFD8FA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-18 09:58:16.702968 :98AFD8FF:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-18 09:58:16.703806 :98AFD904:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-18 09:58:29.919497 :98AFDD4B:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-18 09:58:29.905 2025-05-18 09:58:29.919499 :98AFDD4C:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=12524 pso_num=25 pso_serial#=247 2025-05-18 09:58:29.919632 :98AFDD4D:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=12524 (legacy spawn) 2025-05-18 09:58:29.926038 :98AFDD4E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-18 09:58:29.926204 :98AFDD53:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-18 09:58:29.926982 :98AFDD58:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-18 09:58:29.935863 :98AFDD5B:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-18 09:58:29.920 2025-05-18 09:58:29.935865 :98AFDD5C:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=9168 pso_num=25 pso_serial#=248 2025-05-18 09:58:29.936004 :98AFDD5D:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=9168 (legacy spawn) 2025-05-18 09:58:29.942443 :98AFDD6B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-18 09:58:29.942637 :98AFDD74:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-18 09:58:29.943482 :98AFDD75:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-18 09:58:33.000358 :98AFDE5E:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-18 09:58:32.987 2025-05-18 09:58:33.000360 :98AFDE5F:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=13336 pso_num=25 pso_serial#=249 2025-05-18 09:58:33.000495 :98AFDE60:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=13336 (legacy spawn) 2025-05-18 09:58:33.007000 :98AFDE61:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-18 09:58:33.007178 :98AFDE66:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-18 09:58:33.007951 :98AFDE6B:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-18 09:58:33.025140 :98AFDE6E:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-18 09:58:33.019 2025-05-18 09:58:33.025142 :98AFDE6F:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=12732 pso_num=25 pso_serial#=250 2025-05-18 09:58:33.025276 :98AFDE70:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=12732 (legacy spawn) 2025-05-18 09:58:33.031690 :98AFDE71:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-18 09:58:33.031858 :98AFDE7A:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-18 09:58:33.032669 :98AFDE7B:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-18 09:58:43.452646 :98AFE19F:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-18 09:58:43.444 2025-05-18 09:58:43.452648 :98AFE1A0:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=13212 pso_num=25 pso_serial#=251 2025-05-18 09:58:43.452786 :98AFE1A1:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=13212 (legacy spawn) 2025-05-18 09:58:43.459275 :98AFE1A2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-18 09:58:43.459453 :98AFE1AB:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-18 09:58:43.460281 :98AFE1AC:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-18 09:58:43.889029 :98AFE1BB:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-18 09:58:43.881 2025-05-18 09:58:43.889031 :98AFE1BC:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=10684 pso_num=25 pso_serial#=252 2025-05-18 09:58:43.889170 :98AFE1BD:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=10684 (legacy spawn) 2025-05-18 09:58:43.913913 :98AFE1BE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-18 09:58:43.914085 :98AFE1C7:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-18 09:58:43.914941 :98AFE1C8:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-18 09:58:44.981244 :98AFE265:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-18 09:58:44.975 2025-05-18 09:58:44.981247 :98AFE266:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=12044 pso_num=25 pso_serial#=253 2025-05-18 09:58:44.981384 :98AFE267:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=12044 osp_idx=23 osp_ver=103527 osp_pg=0 (spawn #194167) 2025-05-18 09:58:44.981385 :98AFE268:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-18 09:58:44.981386 :98AFE269:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=92 time=538134844 2025-05-18 09:58:44.981386 :98AFE26A:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-18 09:58:44.981386 :98AFE26B:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-18 09:58:44.981387 :98AFE26C:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-18 09:58:44.981387 :98AFE26D:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-18 09:58:44.981387 :98AFE26E:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-18 09:58:44.981904 :98AFE26F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-18 09:58:44.982561 :98AFE284:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-18 09:58:44.996728 :98AFE2A0:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:psdpgi.c:2235 2025-05-18 09:58:44.996811 :98AFE2A1:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:psdpgi.c:2235 2025-05-18 09:58:44.997682 :98AFE2A2:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:psdpgi.c:2235 2025-05-18 09:58:44.998026 :98AFE2A3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-18 09:58:44.998066 :98AFE2A6:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:psdpgi.c:2235 2025-05-18 09:58:45.005925 :98AFE2AC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-18 09:58:45.005992 :98AFE2AF:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:ktcc.c:879 2025-05-18 09:58:45.006031 :98AFE2B0:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:ktcc.c:879 2025-05-18 09:58:45.006414 :98AFE2B6:db_trace:kwqid.c@2146:kwqidrdq(): [10960:25:201] kwqidrdq: Error: 1403 occured in OCI execute 2025-05-18 09:58:45.006815 :98AFE2B7:db_trace:kwqid.c@2146:kwqidrdq(): [10960:25:201] kwqidrdq: Error: 1403 occured in OCI execute 2025-05-18 09:58:45.007007 :98AFE2B8:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:psdpgi.c:2235 2025-05-18 09:58:45.007234 :98AFE2B9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-18 09:58:45.007259 :98AFE2BC:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:psdpgi.c:2235 2025-05-18 09:58:45.008833 :98AFE2C2:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:psdpgi.c:2235 2025-05-18 09:58:45.009056 :98AFE2C3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-18 09:58:45.009086 :98AFE2C6:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:psdpgi.c:2235 2025-05-18 09:58:45.010074 :98AFE2CC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-18 09:58:45.010201 :98AFE2D5:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-18 09:59:15.094035 :98AFEC9E:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-18 09:59:17.556545 :98AFED09:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-18 09:59:17.548 2025-05-18 09:59:17.556547 :98AFED0A:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=13020 pso_num=25 pso_serial#=254 2025-05-18 09:59:17.556713 :98AFED0B:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=13020 (legacy spawn) 2025-05-18 09:59:17.563042 :98AFED0C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-18 09:59:17.563349 :98AFED14:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-18 09:59:17.564237 :98AFED22:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-18 09:59:18.853153 :98AFEDE2:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-18 09:59:18.845 2025-05-18 09:59:18.853155 :98AFEDE3:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=12316 pso_num=25 pso_serial#=255 2025-05-18 09:59:18.853290 :98AFEDE4:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=12316 (legacy spawn) 2025-05-18 09:59:18.859737 :98AFEDE5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-18 09:59:18.859915 :98AFEDEA:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-18 09:59:18.860760 :98AFEDEF:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-18 09:59:31.920480 :98AFF20A:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-18 09:59:31.907 2025-05-18 09:59:31.920482 :98AFF20B:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=12068 pso_num=25 pso_serial#=1 2025-05-18 09:59:31.920617 :98AFF20C:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=12068 (legacy spawn) 2025-05-18 09:59:31.927021 :98AFF20D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-18 09:59:31.927211 :98AFF214:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-18 09:59:31.928009 :98AFF217:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-18 09:59:31.936804 :98AFF21A:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-18 09:59:31.923 2025-05-18 09:59:31.936806 :98AFF21B:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=14088 pso_num=25 pso_serial#=2 2025-05-18 09:59:31.936945 :98AFF21C:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=14088 (legacy spawn) 2025-05-18 09:59:31.943397 :98AFF21D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-18 09:59:31.943567 :98AFF226:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-18 09:59:31.944372 :98AFF227:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-18 09:59:42.620505 :98AFF5A5:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-18 09:59:42.606 2025-05-18 09:59:42.620507 :98AFF5A6:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=10716 pso_num=25 pso_serial#=3 2025-05-18 09:59:42.620654 :98AFF5A7:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=10716 (legacy spawn) 2025-05-18 09:59:42.627204 :98AFF5A8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-18 09:59:42.627379 :98AFF5AD:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-18 09:59:42.628201 :98AFF5B2:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-18 09:59:42.636720 :98AFF5B5:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-18 09:59:42.622 2025-05-18 09:59:42.636722 :98AFF5B6:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=14188 pso_num=25 pso_serial#=4 2025-05-18 09:59:42.636862 :98AFF5B7:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=14188 (legacy spawn) 2025-05-18 09:59:42.643383 :98AFF5C3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-18 09:59:42.643558 :98AFF5CC:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-18 09:59:42.644357 :98AFF5CD:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-18 09:59:45.085776 :98AFF690:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-18 09:59:45.080 2025-05-18 09:59:45.085778 :98AFF691:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=6572 pso_num=25 pso_serial#=5 2025-05-18 09:59:45.085913 :98AFF692:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=6572 osp_idx=23 osp_ver=103534 osp_pg=0 (spawn #194170) 2025-05-18 09:59:45.085914 :98AFF693:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-18 09:59:45.085914 :98AFF694:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=93 time=538194954 2025-05-18 09:59:45.085914 :98AFF695:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-18 09:59:45.085914 :98AFF696:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-18 09:59:45.085915 :98AFF697:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-18 09:59:45.085915 :98AFF698:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-18 09:59:45.085916 :98AFF699:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-18 09:59:45.086414 :98AFF69A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-18 09:59:45.087053 :98AFF6AF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-18 09:59:45.094573 :98AFF6CB:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:psdpgi.c:2235 2025-05-18 09:59:45.094936 :98AFF6CC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-18 09:59:45.094971 :98AFF6CF:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:psdpgi.c:2235 2025-05-18 09:59:45.095826 :98AFF6D5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-18 09:59:45.095948 :98AFF6DE:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-18 10:00:12.080752 :98B001D3:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=59 loc='kkj.h LINE:914 ID:kkjpstnp' id1=0 id2=0 name= type=0 fac#=0 facpost=1 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 25 (osid: 6572, J000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de