Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250506082202\orcl_j000_11172_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250506082202\orcl_j000_11172_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:37457M/63366M, Ph+PgF:44933M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 24 Windows thread id: 11172, image: ORACLE.EXE (J000) *** 2025-05-06 08:22:02.293 *** SESSION ID:(193.15147) 2025-05-06 08:22:02.293 *** 2025-05-06 08:22:02.293 Process diagnostic dump for ORACLE.EXE (J000), OS id=11172, pid: 24, proc_ser: 214, sid: 193, sess_ser: 15147 ------------------------------------------------------------------------------- current sql: <none> client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 11172 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J000) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=55 seq_num=56 snap_id=1 wait times: snap=0.014271 sec, exc=0.014271 sec, total=0.014271 sec wait times: max=0.500000 sec, heur=27.629985 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=54 seq_num=55 snap_id=1 wait times: snap=0.509592 sec, exc=0.509592 sec, total=0.509592 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=53 seq_num=54 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.000007 sec of elapsed time 2: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=52 seq_num=53 snap_id=1 wait times: snap=0.500110 sec, exc=0.500110 sec, total=0.500110 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=51 seq_num=52 snap_id=1 wait times: snap=0.499994 sec, exc=0.499994 sec, total=0.499994 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=50 seq_num=51 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 5: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=49 seq_num=50 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.000009 sec of elapsed time 6: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=48 seq_num=49 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.000012 sec of elapsed time 7: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=47 seq_num=48 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.000008 sec of elapsed time 8: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=46 seq_num=47 snap_id=1 wait times: snap=0.500107 sec, exc=0.500107 sec, total=0.500107 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 9: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=45 seq_num=46 snap_id=1 wait times: snap=0.510804 sec, exc=0.510804 sec, total=0.510804 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000010 sec of elapsed time Sampled Session History of session 193 serial 15147 --------------------------------------------------- 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 --------------------------------------------------- [28 samples, 08:21:34 - 08:22:02] idle wait at each sample [session created at: 08:21:34] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-05-06 08:22:02.293 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 24 (osid: 11172, J000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-06 08:17:34.302390 :9360BA7B: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-05-06 08:17:34.302521 :9360BA84: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-05-06 08:18:04.421558 :9360C401:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-06 08:18:33.066453 :9360CCEA:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-06 08:18:33.053 2025-05-06 08:18:33.066455 :9360CCEB:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=11924 pso_num=24 pso_serial#=196 2025-05-06 08:18:33.066587 :9360CCEC:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=11924 (legacy spawn) 2025-05-06 08:18:33.072982 :9360CCED: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-05-06 08:18:33.073158 :9360CCF6: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-05-06 08:18:33.073976 :9360CCF7:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-06 08:18:34.386900 :9360CD29:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-06 08:18:34.381 2025-05-06 08:18:34.386903 :9360CD2A:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=11416 pso_num=24 pso_serial#=197 2025-05-06 08:18:34.387096 :9360CD2B:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=11416 osp_idx=22 osp_ver=233266 osp_pg=0 (spawn #153579) 2025-05-06 08:18:34.387097 :9360CD2C:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-06 08:18:34.387098 :9360CD2D:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=252 time=3790291546 2025-05-06 08:18:34.387099 :9360CD2E:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-05-06 08:18:34.387099 :9360CD2F:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-05-06 08:18:34.387099 :9360CD30:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-05-06 08:18:34.387100 :9360CD31:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-06 08:18:34.387100 :9360CD32:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-06 08:18:34.387606 :9360CD33: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-05-06 08:18:34.388254 :9360CD48: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-05-06 08:18:34.399317 :9360CD64:db_trace:kwqid.c@2146:kwqidrdq(): [10960:24:193] kwqidrdq: Error: 1403 occured in OCI execute 2025-05-06 08:18:34.399785 :9360CD65:db_trace:kwqid.c@2146:kwqidrdq(): [10960:24:193] kwqidrdq: Error: 1403 occured in OCI execute 2025-05-06 08:18:34.402069 :9360CD66:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-06 08:18:34.402415 :9360CD67: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-05-06 08:18:34.402451 :9360CD6A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-06 08:18:34.403351 :9360CD70: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-05-06 08:18:34.403477 :9360CD79: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-05-06 08:19:04.480951 :9360D70A:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-06 08:19:07.086663 :9360D7E2:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-06 08:19:07.074 2025-05-06 08:19:07.086665 :9360D7E3:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=2936 pso_num=24 pso_serial#=198 2025-05-06 08:19:07.086801 :9360D7E4:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=2936 (legacy spawn) 2025-05-06 08:19:07.093410 :9360D7E5: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-05-06 08:19:07.093591 :9360D7EB: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-05-06 08:19:07.094384 :9360D7EF:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-06 08:19:11.519804 :9360D9A4:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-06 08:19:11.505 2025-05-06 08:19:11.519806 :9360D9A5:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=10604 pso_num=24 pso_serial#=199 2025-05-06 08:19:11.519947 :9360D9A6:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=10604 (legacy spawn) 2025-05-06 08:19:11.541321 :9360D9A7: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-05-06 08:19:11.541486 :9360D9B0: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-05-06 08:19:11.542314 :9360D9B1:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-06 08:19:11.550880 :9360D9B4:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-06 08:19:11.536 2025-05-06 08:19:11.550882 :9360D9B5:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=8644 pso_num=24 pso_serial#=200 2025-05-06 08:19:11.551017 :9360D9B6:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=8644 (legacy spawn) 2025-05-06 08:19:11.557478 :9360D9B7: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-05-06 08:19:11.557638 :9360D9BE: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-05-06 08:19:11.558415 :9360D9C1:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-06 08:19:14.631354 :9360DAA9:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-06 08:19:14.618 2025-05-06 08:19:14.631356 :9360DAAA:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=2292 pso_num=24 pso_serial#=201 2025-05-06 08:19:14.631487 :9360DAAB:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=2292 (legacy spawn) 2025-05-06 08:19:14.640400 :9360DAAC: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-05-06 08:19:14.640589 :9360DAB1: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-05-06 08:19:14.641334 :9360DAB6:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-06 08:19:14.649678 :9360DAB9:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-06 08:19:14.649 2025-05-06 08:19:14.649686 :9360DABA:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=11544 pso_num=24 pso_serial#=202 2025-05-06 08:19:14.649848 :9360DABB:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=11544 (legacy spawn) 2025-05-06 08:19:14.656296 :9360DABC: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-05-06 08:19:14.656458 :9360DAC5: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-05-06 08:19:14.657255 :9360DAC6:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-06 08:19:17.740745 :9360DBB5:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-06 08:19:17.732 2025-05-06 08:19:17.740747 :9360DBB6:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=12280 pso_num=24 pso_serial#=203 2025-05-06 08:19:17.740883 :9360DBB7:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=12280 (legacy spawn) 2025-05-06 08:19:17.747243 :9360DBB8: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-05-06 08:19:17.747425 :9360DBBD: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-05-06 08:19:17.748236 :9360DBC2:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-06 08:19:34.459480 :9360E099:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-06 08:19:34.459 2025-05-06 08:19:34.459482 :9360E09A:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=11372 pso_num=24 pso_serial#=204 2025-05-06 08:19:34.459624 :9360E09B:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=11372 osp_idx=22 osp_ver=233273 osp_pg=0 (spawn #153581) 2025-05-06 08:19:34.459625 :9360E09C:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-06 08:19:34.459626 :9360E09D:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=253 time=3790351625 2025-05-06 08:19:34.459626 :9360E09E:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-05-06 08:19:34.459626 :9360E09F:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-05-06 08:19:34.459627 :9360E0A0:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-05-06 08:19:34.459627 :9360E0A1:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-06 08:19:34.459627 :9360E0A2:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-06 08:19:34.460125 :9360E0A3: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-05-06 08:19:34.460743 :9360E0B8: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-05-06 08:19:34.468303 :9360E0D4:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-06 08:19:34.468658 :9360E0D5: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-05-06 08:19:34.468694 :9360E0D8:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-06 08:19:34.469514 :9360E0DE: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-05-06 08:19:34.469624 :9360E0E7: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-05-06 08:20:04.543180 :9360EA8F:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-06 08:20:15.701701 :9360EE0A:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-06 08:20:15.700 2025-05-06 08:20:15.701703 :9360EE0B:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=11552 pso_num=24 pso_serial#=205 2025-05-06 08:20:15.701842 :9360EE0C:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=11552 (legacy spawn) 2025-05-06 08:20:15.708221 :9360EE0D: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-05-06 08:20:15.708386 :9360EE15: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-05-06 08:20:15.709184 :9360EE17:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-06 08:20:19.921677 :9360EF28:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-06 08:20:19.913 2025-05-06 08:20:19.921679 :9360EF29:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=11528 pso_num=24 pso_serial#=206 2025-05-06 08:20:19.921814 :9360EF2A:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=11528 (legacy spawn) 2025-05-06 08:20:19.928184 :9360EF2B: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-05-06 08:20:19.928370 :9360EF30: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-05-06 08:20:19.929172 :9360EF35:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-06 08:20:24.319359 :9360F0CA:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-06 08:20:24.305 2025-05-06 08:20:24.319360 :9360F0CB:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=3624 pso_num=24 pso_serial#=207 2025-05-06 08:20:24.319494 :9360F0CC:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=3624 (legacy spawn) 2025-05-06 08:20:24.325908 :9360F0CD: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-05-06 08:20:24.326100 :9360F0D6: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-05-06 08:20:24.326934 :9360F0D7:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-06 08:20:24.335479 :9360F0DA:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-06 08:20:24.321 2025-05-06 08:20:24.335482 :9360F0DB:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=12236 pso_num=24 pso_serial#=208 2025-05-06 08:20:24.335658 :9360F0DC:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=12236 (legacy spawn) 2025-05-06 08:20:24.342006 :9360F0DD: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-05-06 08:20:24.342176 :9360F0E5: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-05-06 08:20:24.342983 :9360F0E7:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-06 08:20:27.512696 :9360F1D5:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-06 08:20:27.500 2025-05-06 08:20:27.512698 :9360F1D6:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=11056 pso_num=24 pso_serial#=209 2025-05-06 08:20:27.512828 :9360F1D7:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=11056 (legacy spawn) 2025-05-06 08:20:27.519274 :9360F1D8: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-05-06 08:20:27.519446 :9360F1DD: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-05-06 08:20:27.520257 :9360F1E2:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-06 08:20:27.528839 :9360F1E5:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-06 08:20:27.516 2025-05-06 08:20:27.528842 :9360F1E6:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=11680 pso_num=24 pso_serial#=210 2025-05-06 08:20:27.528978 :9360F1E7:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=11680 (legacy spawn) 2025-05-06 08:20:27.535488 :9360F1E8: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-05-06 08:20:27.535653 :9360F1F0: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-05-06 08:20:27.536460 :9360F1F2:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-06 08:20:29.563117 :9360F2D2:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-06 08:20:29.557 2025-05-06 08:20:29.563119 :9360F2D3:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=11320 pso_num=24 pso_serial#=211 2025-05-06 08:20:29.563249 :9360F2D4:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=11320 osp_idx=22 osp_ver=233280 osp_pg=0 (spawn #153583) 2025-05-06 08:20:29.563250 :9360F2D5:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-06 08:20:29.563250 :9360F2D6:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=254 time=3790406734 2025-05-06 08:20:29.563251 :9360F2D7:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-05-06 08:20:29.563251 :9360F2D8:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-05-06 08:20:29.563251 :9360F2D9:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-05-06 08:20:29.563252 :9360F2DA:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-06 08:20:29.563252 :9360F2DB:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-06 08:20:29.563808 :9360F2DC: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-05-06 08:20:29.564447 :9360F2F1: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-05-06 08:20:29.569923 :9360F30D: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-05-06 08:20:29.570987 :9360F315: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-05-06 08:20:29.571111 :9360F31E: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-05-06 08:20:34.573596 :9360F430: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-05-06 08:20:34.573616*:9360F433:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000000FD4BB58 estart=1746490833 eid=16846825 ctx=0x000000077BD98A08 cwh=0x000000000FD002A0 cpu=0 buffg=1 interb=0 r=0 rb=0 w=0 wb=0 2025-05-06 08:20:34.573616*:9360F434:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000000FD4BB58 curCtx=0x000000000FD0F300 pubTabIdxCnt=0 2025-05-06 08:20:34.573616*:9360F435:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000000FD4BB58 2025-05-06 08:20:34.573616*:9360F436:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000000FD4BB58 2025-05-06 08:20:34.573616*:9360F437:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000000FD4BB58 curCtx=0x000000000FD0F300 xsc->flg4=65792 flags=2 2025-05-06 08:20:34.573616*:9360F438:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000000FD4BB58 2025-05-06 08:20:34.574123 :9360F439: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-05-06 08:20:34.584947 :9360F441:db_trace:kwqid.c@2146:kwqidrdq(): [10960:24:193] kwqidrdq: Error: 1403 occured in OCI execute 2025-05-06 08:20:34.585403 :9360F442:db_trace:kwqid.c@2146:kwqidrdq(): [10960:24:193] kwqidrdq: Error: 1403 occured in OCI execute 2025-05-06 08:20:34.587849 :9360F44E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-06 08:20:34.588190 :9360F44F: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-05-06 08:20:34.588225 :9360F452:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-06 08:20:34.589067 :9360F458: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-05-06 08:20:34.589189 :9360F461: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-05-06 08:21:04.691959 :9360FDD7:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-06 08:21:22.101194 :9361033E:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-06 08:21:22.093 2025-05-06 08:21:22.101196 :9361033F:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=9452 pso_num=24 pso_serial#=212 2025-05-06 08:21:22.101337 :93610340:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=9452 (legacy spawn) 2025-05-06 08:21:22.107757 :93610341: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-05-06 08:21:22.107927 :93610346: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-05-06 08:21:22.108748 :9361034B:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-06 08:21:23.680926 :93610403:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-06 08:21:23.671 2025-05-06 08:21:23.680928 :93610404:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=356 pso_num=24 pso_serial#=213 2025-05-06 08:21:23.681065 :93610405:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=356 (legacy spawn) 2025-05-06 08:21:23.687545 :93610406: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-05-06 08:21:23.687715 :9361040B: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-05-06 08:21:23.688481 :93610410:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-06 08:21:34.666044 :93610714:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-06 08:21:34.660 2025-05-06 08:21:34.666046 :93610715:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=11172 pso_num=24 pso_serial#=214 2025-05-06 08:21:34.666176 :93610716:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=11172 osp_idx=22 osp_ver=233283 osp_pg=0 (spawn #153586) 2025-05-06 08:21:34.666177 :93610717:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-06 08:21:34.666177 :93610718:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=255 time=3790471828 2025-05-06 08:21:34.666178 :93610719:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-05-06 08:21:34.666178 :9361071A:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-05-06 08:21:34.666179 :9361071B:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-05-06 08:21:34.666179 :9361071C:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-06 08:21:34.666179 :9361071D:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-06 08:21:34.666674 :9361071E: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-05-06 08:21:34.667290 :93610733: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-05-06 08:21:34.674832 :9361074F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-06 08:21:34.675196 :93610750: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-05-06 08:21:34.675231 :93610753:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-06 08:21:34.676145 :93610759: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-05-06 08:21:34.676263 :93610762: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: 11172, J000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de