Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250609220010\orcl_j000_15428_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250609220010\orcl_j000_15428_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:36790M/63366M, Ph+PgF:43373M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 24 Windows thread id: 15428, image: ORACLE.EXE (J000) *** 2025-06-09 22:00:10.421 *** SESSION ID:(193.13253) 2025-06-09 22:00:10.421 *** 2025-06-09 22:00:10.421 Process diagnostic dump for ORACLE.EXE (J000), OS id=15428, pid: 24, proc_ser: 163, sid: 193, sess_ser: 13253 ------------------------------------------------------------------------------- current sql: <none> client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 15428 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J000) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=12 seq_num=13 snap_id=1 wait times: snap=0.205335 sec, exc=0.205335 sec, total=0.205335 sec wait times: max=0.500000 sec, heur=6.221740 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.000010 sec since current wait 0: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=11 seq_num=12 snap_id=1 wait times: snap=0.499996 sec, exc=0.499996 sec, total=0.499996 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=10 seq_num=11 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.000007 sec of elapsed time 2: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=9 seq_num=10 snap_id=1 wait times: snap=0.499997 sec, exc=0.499997 sec, total=0.499997 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=8 seq_num=9 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.000009 sec of elapsed time 4: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=7 seq_num=8 snap_id=1 wait times: snap=0.510098 sec, exc=0.510098 sec, total=0.510098 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 5: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=6 seq_num=7 snap_id=1 wait times: snap=0.500006 sec, exc=0.500006 sec, total=0.500006 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000010 sec of elapsed time 6: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=5 seq_num=6 snap_id=1 wait times: snap=0.499999 sec, exc=0.499999 sec, total=0.499999 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000011 sec of elapsed time 7: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=4 seq_num=5 snap_id=1 wait times: snap=0.510088 sec, exc=0.510088 sec, total=0.510088 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000013 sec of elapsed time 8: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=3 seq_num=4 snap_id=1 wait times: snap=0.499998 sec, exc=0.499998 sec, total=0.499998 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 sec of elapsed time 9: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=2 seq_num=3 snap_id=1 wait times: snap=0.500002 sec, exc=0.500002 sec, total=0.500002 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000007 sec of elapsed time Sampled Session History of session 193 serial 13253 --------------------------------------------------- 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 --------------------------------------------------- [7 samples, 22:00:04 - 22:00:10] idle wait at each sample [session created at: 22:00:04] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-06-09 22:00:10.421 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 24 (osid: 15428, J000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-06-09 21:56:53.699420 :A28E7D7E: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-09 21:56:53.710512 :A28E7DA9:db_trace:kwqid.c@2146:kwqidrdq(): [10960:24:193] kwqidrdq: Error: 1403 occured in OCI execute 2025-06-09 21:56:53.710979 :A28E7DAA:db_trace:kwqid.c@2146:kwqidrdq(): [10960:24:193] kwqidrdq: Error: 1403 occured in OCI execute 2025-06-09 21:56:53.713391 :A28E7DAB:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-06-09 21:56:53.713746 :A28E7DAC: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-09 21:56:53.713787 :A28E7DAF:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-06-09 21:56:53.714659 :A28E7DB5: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-09 21:56:53.714782 :A28E7DBE: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-09 21:57:23.777975 :A28E874E:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-09 21:57:28.732664 :A28E88A9:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-09 21:57:28.724 2025-06-09 21:57:28.732667 :A28E88AA:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=13668 pso_num=24 pso_serial#=151 2025-06-09 21:57:28.732808 :A28E88AB:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=13668 (legacy spawn) 2025-06-09 21:57:28.739303 :A28E88AC: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-09 21:57:28.739480 :A28E88B1: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-09 21:57:28.740330 :A28E88C4:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-09 21:57:29.207431 :A28E8923:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-09 21:57:29.192 2025-06-09 21:57:29.207433 :A28E8924:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=12684 pso_num=24 pso_serial#=152 2025-06-09 21:57:29.207572 :A28E8925:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=12684 (legacy spawn) 2025-06-09 21:57:29.214069 :A28E8926: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-09 21:57:29.214244 :A28E892F: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-09 21:57:29.215035 :A28E8930:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-09 21:57:29.223775 :A28E8933:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-09 21:57:29.208 2025-06-09 21:57:29.223777 :A28E8934:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=16260 pso_num=24 pso_serial#=153 2025-06-09 21:57:29.223923 :A28E8935:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=16260 (legacy spawn) 2025-06-09 21:57:29.230468 :A28E8936: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-09 21:57:29.230626 :A28E893D: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-09 21:57:29.231476 :A28E893F:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-09 21:57:32.502137 :A28E8A2B:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-09 21:57:32.491 2025-06-09 21:57:32.502140 :A28E8A2C:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=12156 pso_num=24 pso_serial#=154 2025-06-09 21:57:32.502277 :A28E8A2D:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=12156 (legacy spawn) 2025-06-09 21:57:32.508857 :A28E8A2E: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-09 21:57:32.509037 :A28E8A33: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-09 21:57:32.509876 :A28E8A38:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-09 21:57:32.518566 :A28E8A3B:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-09 21:57:32.506 2025-06-09 21:57:32.518569 :A28E8A3C:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=14424 pso_num=24 pso_serial#=155 2025-06-09 21:57:32.518704 :A28E8A3D:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=14424 (legacy spawn) 2025-06-09 21:57:32.525224 :A28E8A3E: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-09 21:57:32.525401 :A28E8A47: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-09 21:57:32.526214 :A28E8A48:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-09 21:57:44.288769 :A28E8DD9:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-09 21:57:44.275 2025-06-09 21:57:44.288771 :A28E8DDA:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=15196 pso_num=24 pso_serial#=156 2025-06-09 21:57:44.288912 :A28E8DDB:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=15196 (legacy spawn) 2025-06-09 21:57:44.295482 :A28E8DDC: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-09 21:57:44.295657 :A28E8DE1: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-09 21:57:44.296466 :A28E8DE6:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-09 21:57:44.305162 :A28E8DE9:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-09 21:57:44.291 2025-06-09 21:57:44.305165 :A28E8DEA:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=12232 pso_num=24 pso_serial#=157 2025-06-09 21:57:44.305343 :A28E8DEB:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=12232 (legacy spawn) 2025-06-09 21:57:44.311791 :A28E8DEC: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-09 21:57:44.311967 :A28E8DF5: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-09 21:57:44.312777 :A28E8DF6:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-09 21:57:51.136002 :A28E8FE7:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-09 21:57:51.128 2025-06-09 21:57:51.136004 :A28E8FE8:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=15484 pso_num=24 pso_serial#=158 2025-06-09 21:57:51.136148 :A28E8FE9:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=15484 (legacy spawn) 2025-06-09 21:57:51.142596 :A28E8FEA: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-09 21:57:51.142785 :A28E8FF3: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-09 21:57:51.143618 :A28E8FF4:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-09 21:57:53.784415 :A28E90E1:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-09 21:57:53.779 2025-06-09 21:57:53.784417 :A28E90E2:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=4856 pso_num=24 pso_serial#=159 2025-06-09 21:57:53.784558 :A28E90E3:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=4856 osp_idx=22 osp_ver=378598 osp_pg=0 (spawn #269144) 2025-06-09 21:57:53.784558 :A28E90E4: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-09 21:57:53.784560 :A28E90E5:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=52 time=2482016969 2025-06-09 21:57:53.784561 :A28E90E6:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-06-09 21:57:53.784561 :A28E90E7:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-06-09 21:57:53.784562 :A28E90E8:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-06-09 21:57:53.784562 :A28E90E9:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-09 21:57:53.784562 :A28E90EA:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-09 21:57:53.785047 :A28E90EB: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-09 21:57:53.785727 :A28E9100: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-09 21:57:53.793304 :A28E911C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-06-09 21:57:53.793660 :A28E911D: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-09 21:57:53.793694 :A28E9120:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-06-09 21:57:53.794641 :A28E9126: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-09 21:57:53.794775 :A28E912F: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-09 21:58:18.819027 :A28E99A7: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-06-09 21:58:18.819059*:A28E99AA:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000002494BB58 estart=1749477498 eid=16901666 ctx=0x000000077BD98A08 cwh=0x00000000232802A0 cpu=0 buffg=1 interb=0 r=0 rb=0 w=0 wb=0 2025-06-09 21:58:18.819059*:A28E99AB:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000002494BB58 curCtx=0x000000002328F300 pubTabIdxCnt=0 2025-06-09 21:58:18.819059*:A28E99AC:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000002494BB58 2025-06-09 21:58:18.819059*:A28E99AD:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000002494BB58 2025-06-09 21:58:18.819059*:A28E99AE:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000002494BB58 curCtx=0x000000002328F300 xsc->flg4=65792 flags=2 2025-06-09 21:58:18.819059*:A28E99AF:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000002494BB58 2025-06-09 21:58:18.819675 :A28E99B0: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-09 21:58:18.825074 :A28E99B8: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-09 21:58:18.825887 :A28E99C0: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-09 21:58:18.826007 :A28E99C9: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-09 21:58:48.914709 :A28EA341:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-09 21:58:53.888204 :A28EA4BB:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-09 21:58:53.882 2025-06-09 21:58:53.888206 :A28EA4BC:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=11908 pso_num=24 pso_serial#=160 2025-06-09 21:58:53.888345 :A28EA4BD:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=11908 osp_idx=22 osp_ver=378599 osp_pg=0 (spawn #269146) 2025-06-09 21:58:53.888346 :A28EA4BE: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-09 21:58:53.888346 :A28EA4BF:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=53 time=2482077079 2025-06-09 21:58:53.888346 :A28EA4C0:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-06-09 21:58:53.888347 :A28EA4C1:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-06-09 21:58:53.888347 :A28EA4C2:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-06-09 21:58:53.888348 :A28EA4C3:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-09 21:58:53.888348 :A28EA4C4:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-09 21:58:53.888908 :A28EA4C5: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-09 21:58:53.889562 :A28EA4DA: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-09 21:58:53.900578 :A28EA4F6:db_trace:kwqid.c@2146:kwqidrdq(): [10960:24:193] kwqidrdq: Error: 1403 occured in OCI execute 2025-06-09 21:58:53.901115 :A28EA4F7:db_trace:kwqid.c@2146:kwqidrdq(): [10960:24:193] kwqidrdq: Error: 1403 occured in OCI execute 2025-06-09 21:58:53.903454 :A28EA4F8:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-06-09 21:58:53.903789 :A28EA4F9: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-09 21:58:53.903826 :A28EA4FC:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-06-09 21:58:53.904671 :A28EA502: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-09 21:58:53.904796 :A28EA50B: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-09 21:59:23.980605 :A28EAE9D:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-09 21:59:24.395121 :A28EAEB3:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-09 21:59:24.387 2025-06-09 21:59:24.395123 :A28EAEB4:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=15712 pso_num=24 pso_serial#=161 2025-06-09 21:59:24.395263 :A28EAEB5:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=15712 (legacy spawn) 2025-06-09 21:59:24.401702 :A28EAEB6: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-09 21:59:24.401731 :A28EAEB9: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-09 21:59:24.401880 :A28EAEC0: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-09 21:59:24.402692 :A28EAECD:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-09 21:59:45.145392 :A28EB54A:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-09 21:59:45.135 2025-06-09 21:59:45.145395 :A28EB54B:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=10976 pso_num=24 pso_serial#=162 2025-06-09 21:59:45.145530 :A28EB54C:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=10976 (legacy spawn) 2025-06-09 21:59:45.152130 :A28EB54D: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-09 21:59:45.152300 :A28EB556: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-09 21:59:45.153108 :A28EB557:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-09 21:59:53.972074 :A28EB814:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-09 21:59:53.966 2025-06-09 21:59:53.972076 :A28EB815:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=15428 pso_num=24 pso_serial#=163 2025-06-09 21:59:53.972217 :A28EB816:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=15428 osp_idx=22 osp_ver=378602 osp_pg=0 (spawn #269149) 2025-06-09 21:59:53.972218 :A28EB817: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-09 21:59:53.972218 :A28EB818:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=54 time=2482137157 2025-06-09 21:59:53.972219 :A28EB819:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-06-09 21:59:53.972219 :A28EB81A:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-06-09 21:59:53.972220 :A28EB81B:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-06-09 21:59:53.972220 :A28EB81C:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-09 21:59:53.972220 :A28EB81D:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-09 21:59:53.972711 :A28EB81E: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-09 21:59:53.973369 :A28EB833: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-09 21:59:53.980867 :A28EB84F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-06-09 21:59:53.981228 :A28EB850: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-09 21:59:53.981264 :A28EB853:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-06-09 21:59:53.982091 :A28EB859: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-09 21:59:53.982205 :A28EB862: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-09 22:00:02.140725 :A28EBC59: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-06-09 22:00:02.140725*:A28EBC7B:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000002495C718 estart=1749477601 eid=16782034 ctx=0x000000077FD6A000 cwh=0x0000000024950068 cpu=0 buffg=1 interb=0 r=0 rb=0 w=0 wb=0 2025-06-09 22:00:02.140725*:A28EBC7C:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000002495C718 curCtx=0x0000000024958938 pubTabIdxCnt=0 2025-06-09 22:00:02.140725*:A28EBC7D:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000002495C718 2025-06-09 22:00:02.140725*:A28EBC7E:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000002495C718 2025-06-09 22:00:02.140725*:A28EBC9A:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000002495C718 curCtx=0x0000000024958938 xsc->flg4=65792 flags=2 2025-06-09 22:00:02.140725*:A28EBC9D:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000002495C718 2025-06-09 22:00:02.147612 :A28EBC9E: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-09 22:00:02.147669 :A28EBCA1:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:jslv.c:9203 2025-06-09 22:00:02.159166 :A28EBD2E: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-09 22:00:02.164471 :A28EBE59: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-09 22:00:02.165221 :A28EBE6B: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-09 22:00:02.170821 :A28EBE7C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-06-09 22:00:02.171014 :A28EBE7F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-09 22:00:02.171836 :A28EBE93: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-09 22:00:02.172048 :A28EBE9B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:jslv.c:9203 2025-06-09 22:00:02.173439 :A28EBEAB: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-09 22:00:02.173476 :A28EBEAE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 2025-06-09 22:00:02.173545 :A28EBEBB: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-09 22:00:02.265749 :A28EBFDA: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-06-09 22:00:02.268102 :A28EBFDD: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-09 22:00:02.268147 :A28EBFE0:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:jslv.c:9203 2025-06-09 22:00:02.270762 :A28EBFE6:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:jslv.c:9203 2025-06-09 22:00:02.274360 :A28EBFE7: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-09 22:00:02.274449 :A28EBFEA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 2025-06-09 22:00:02.274526 :A28EBFF7: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-09 22:00:04.187649 :A28EC3F4: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-06-09 22:00:04.187649*:A28EC3F9:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000002495C718 estart=1749477603 eid=16782039 ctx=0x000000077FD6A000 cwh=0x0000000024950068 cpu=0 buffg=1 interb=0 r=0 rb=0 w=0 wb=0 2025-06-09 22:00:04.187649*:A28EC3FA:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000002495C718 curCtx=0x0000000024958938 pubTabIdxCnt=0 2025-06-09 22:00:04.187649*:A28EC3FB:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000002495C718 2025-06-09 22:00:04.187649*:A28EC3FC:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000002495C718 2025-06-09 22:00:04.187649*:A28EC3FD:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000002495C718 curCtx=0x0000000024958938 xsc->flg4=65792 flags=2 2025-06-09 22:00:04.187649*:A28EC3FE:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000002495C718 2025-06-09 22:00:04.189903 :A28EC3FF: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-09 22:00:04.189944 :A28EC402:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:jslv.c:9203 2025-06-09 22:00:04.196664 :A28EC408: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-09 22:00:04.197428 :A28EC410: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-09 22:00:04.198220 :A28EC418: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-09 22:00:04.198437 :A28EC420:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:jslv.c:9203 2025-06-09 22:00:04.199881 :A28EC421: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-09 22:00:04.199922 :A28EC424:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 2025-06-09 22:00:04.200002 :A28EC431: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: 15428, J000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de