Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250605082045\orcl_j000_13380_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250605082045\orcl_j000_13380_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:36923M/63366M, Ph+PgF:43630M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 22 Windows thread id: 13380, image: ORACLE.EXE (J000) *** 2025-06-05 08:20:45.394 *** SESSION ID:(177.40835) 2025-06-05 08:20:45.394 *** 2025-06-05 08:20:45.394 Process diagnostic dump for ORACLE.EXE (J000), OS id=13380, pid: 22, proc_ser: 16, sid: 177, sess_ser: 40835 ------------------------------------------------------------------------------- current sql: <none> client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 13380 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J000) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=44 seq_num=45 snap_id=1 wait times: snap=0.271651 sec, exc=0.271651 sec, total=0.271651 sec wait times: max=0.500000 sec, heur=22.298447 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.000008 sec since current wait 0: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=43 seq_num=44 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.000010 sec of elapsed time 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=42 seq_num=43 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.000009 sec of elapsed time 2: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=41 seq_num=42 snap_id=1 wait times: snap=0.499990 sec, exc=0.499990 sec, total=0.499990 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=40 seq_num=41 snap_id=1 wait times: snap=0.510123 sec, exc=0.510123 sec, total=0.510123 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=39 seq_num=40 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.000009 sec of elapsed time 5: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=38 seq_num=39 snap_id=1 wait times: snap=0.500001 sec, exc=0.500001 sec, total=0.500001 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000011 sec of elapsed time 6: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=37 seq_num=38 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.000010 sec of elapsed time 7: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=36 seq_num=37 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 8: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=35 seq_num=36 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 9: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=34 seq_num=35 snap_id=1 wait times: snap=0.510101 sec, exc=0.510101 sec, total=0.510101 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 177 serial 40835 --------------------------------------------------- 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 --------------------------------------------------- [23 samples, 08:20:23 - 08:20:45] idle wait at each sample [session created at: 08:20:23] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-06-05 08:20:45.394 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 22 (osid: 13380, J000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-06-05 08:17:03.181155 :A08CF9C7:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=14128 (legacy spawn) 2025-06-05 08:17:03.187537 :A08CF9C8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-05 08:17:03.187719 :A08CF9D1:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-05 08:17:03.188545 :A08CF9D2:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-05 08:17:08.938950 :A08CFBAD:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-05 08:17:08.925 2025-06-05 08:17:08.938952 :A08CFBAE:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=13632 pso_num=22 pso_serial#=253 2025-06-05 08:17:08.939091 :A08CFBAF:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=13632 (legacy spawn) 2025-06-05 08:17:08.945542 :A08CFBB0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-05 08:17:08.945719 :A08CFBB9:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-05 08:17:08.946512 :A08CFBBA:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-05 08:17:08.954991 :A08CFBBD:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-05 08:17:08.941 2025-06-05 08:17:08.954993 :A08CFBBE:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=14216 pso_num=22 pso_serial#=254 2025-06-05 08:17:08.955163 :A08CFBBF:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=14216 (legacy spawn) 2025-06-05 08:17:08.961610 :A08CFBC0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-05 08:17:08.961782 :A08CFBC9:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-05 08:17:08.962578 :A08CFBCA:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-05 08:17:12.141993 :A08CFCB3:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-05 08:17:12.128 2025-06-05 08:17:12.141995 :A08CFCB4:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16348 pso_num=22 pso_serial#=255 2025-06-05 08:17:12.142154 :A08CFCB5:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=16348 (legacy spawn) 2025-06-05 08:17:12.148609 :A08CFCB6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-05 08:17:12.148776 :A08CFCBB:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-05 08:17:12.149612 :A08CFCC0:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-05 08:17:12.158217 :A08CFCC3:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-05 08:17:12.144 2025-06-05 08:17:12.158219 :A08CFCC4:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16312 pso_num=22 pso_serial#=1 2025-06-05 08:17:12.158363 :A08CFCC5:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=16312 (legacy spawn) 2025-06-05 08:17:12.164950 :A08CFCC6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-05 08:17:12.165129 :A08CFCCF:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-05 08:17:12.166001 :A08CFCD0:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-05 08:17:22.814037 :A08CFFF3:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-05 08:17:22.808 2025-06-05 08:17:22.814040 :A08CFFF4:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=14472 pso_num=22 pso_serial#=2 2025-06-05 08:17:22.814184 :A08CFFF5:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=14472 osp_idx=0 osp_ver=264254 osp_pg=0 (spawn #253912) 2025-06-05 08:17:22.814185 :A08CFFF6:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-05 08:17:22.814185 :A08CFFF7:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=161 time=2087201454 2025-06-05 08:17:22.814185 :A08CFFF8:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-05 08:17:22.814186 :A08CFFF9:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-05 08:17:22.814186 :A08CFFFA:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-05 08:17:22.814186 :A08CFFFB:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-05 08:17:22.814187 :A08CFFFC:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-05 08:17:22.814706 :A08CFFFD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-05 08:17:22.815382 :A08D0012:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-05 08:17:22.823126 :A08D002E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-06-05 08:17:22.823517 :A08D002F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-05 08:17:22.823586 :A08D0032:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-06-05 08:17:22.824464 :A08D0038:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-05 08:17:22.824584 :A08D0041:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-05 08:17:52.877000 :A08D0A32:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-05 08:18:11.387725 :A08D0FF1:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-05 08:18:11.374 2025-06-05 08:18:11.387727 :A08D0FF2:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=15560 pso_num=22 pso_serial#=3 2025-06-05 08:18:11.387890 :A08D0FF3:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=15560 (legacy spawn) 2025-06-05 08:18:11.394296 :A08D0FF4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-05 08:18:11.394465 :A08D0FF9:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-05 08:18:11.395280 :A08D0FFE:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-05 08:18:21.738793 :A08D1329:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-05 08:18:21.725 2025-06-05 08:18:21.738796 :A08D132A:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16144 pso_num=22 pso_serial#=4 2025-06-05 08:18:21.738935 :A08D132B:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=16144 (legacy spawn) 2025-06-05 08:18:21.745321 :A08D132C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-05 08:18:21.745498 :A08D1332:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-05 08:18:21.746276 :A08D1336:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-05 08:18:21.754921 :A08D1339:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-05 08:18:21.740 2025-06-05 08:18:21.754923 :A08D133A:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=15756 pso_num=22 pso_serial#=5 2025-06-05 08:18:21.755059 :A08D133B:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=15756 (legacy spawn) 2025-06-05 08:18:21.761432 :A08D133C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-05 08:18:21.761593 :A08D1345:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-05 08:18:21.762405 :A08D1346:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-05 08:18:22.888423 :A08D13A0:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-05 08:18:22.883 2025-06-05 08:18:22.888426 :A08D13A1:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=15784 pso_num=22 pso_serial#=6 2025-06-05 08:18:22.888560 :A08D13A2:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=15784 osp_idx=0 osp_ver=264258 osp_pg=0 (spawn #253914) 2025-06-05 08:18:22.888561 :A08D13A3:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-05 08:18:22.888561 :A08D13A4:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=162 time=2087261532 2025-06-05 08:18:22.888561 :A08D13A5:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-05 08:18:22.888562 :A08D13A6:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-05 08:18:22.888562 :A08D13A7:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-05 08:18:22.888562 :A08D13A8:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-05 08:18:22.888563 :A08D13A9:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-05 08:18:22.889045 :A08D13AA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-05 08:18:22.889669 :A08D13BF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-05 08:18:22.900708 :A08D13DC:db_trace:kwqid.c@2146:kwqidrdq(): [10960:22:177] kwqidrdq: Error: 1403 occured in OCI execute 2025-06-05 08:18:22.901175 :A08D13DD:db_trace:kwqid.c@2146:kwqidrdq(): [10960:22:177] kwqidrdq: Error: 1403 occured in OCI execute 2025-06-05 08:18:22.903609 :A08D13DE:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-06-05 08:18:22.903951 :A08D13DF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-05 08:18:22.903988 :A08D13E2:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-06-05 08:18:22.904845 :A08D13E8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-05 08:18:22.904959 :A08D13F1:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-05 08:18:52.989006 :A08D1E13:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-05 08:18:56.563938 :A08D1F33:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-05 08:18:56.551 2025-06-05 08:18:56.563940 :A08D1F34:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=12576 pso_num=22 pso_serial#=7 2025-06-05 08:18:56.564080 :A08D1F35:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=12576 (legacy spawn) 2025-06-05 08:18:56.570497 :A08D1F4B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-05 08:18:56.570664 :A08D1F50:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-05 08:18:56.571493 :A08D1F55:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-05 08:18:57.962577 :A08D1FCC:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-05 08:18:57.957 2025-06-05 08:18:57.962579 :A08D1FCD:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16344 pso_num=22 pso_serial#=8 2025-06-05 08:18:57.962715 :A08D1FCE:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=16344 osp_idx=0 osp_ver=264260 osp_pg=0 (spawn #253918) 2025-06-05 08:18:57.962715 :A08D1FCF:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-05 08:18:57.962716 :A08D1FD0:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=163 time=2087296610 2025-06-05 08:18:57.962716 :A08D1FD1:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-05 08:18:57.962716 :A08D1FD2:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-05 08:18:57.962717 :A08D1FD3:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-05 08:18:57.962717 :A08D1FD4:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-05 08:18:57.962717 :A08D1FD5:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-05 08:18:57.963199 :A08D1FD6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-05 08:18:57.963821 :A08D1FEB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-05 08:18:57.969253 :A08D2008:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-05 08:18:57.970304 :A08D2010:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-05 08:18:57.970430 :A08D2019:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-05 08:19:23.005011 :A08D2826:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-05 08:19:23.005034*:A08D2829:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000000FCCBB58 estart=1749082762 eid=16894418 ctx=0x000000077BD98A08 cwh=0x000000000FC802A0 cpu=0 buffg=1 interb=0 r=0 rb=0 w=0 wb=0 2025-06-05 08:19:23.005034*:A08D282A:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000000FCCBB58 curCtx=0x000000000FC8F300 pubTabIdxCnt=0 2025-06-05 08:19:23.005034*:A08D282B:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000000FCCBB58 2025-06-05 08:19:23.005034*:A08D282C:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000000FCCBB58 2025-06-05 08:19:23.005034*:A08D282D:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000000FCCBB58 curCtx=0x000000000FC8F300 xsc->flg4=65792 flags=2 2025-06-05 08:19:23.005034*:A08D282E:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000000FCCBB58 2025-06-05 08:19:23.005573 :A08D282F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-05 08:19:23.012972 :A08D2837:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-06-05 08:19:23.013377 :A08D2838:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-05 08:19:23.013414 :A08D283B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-06-05 08:19:23.014229 :A08D2841:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-05 08:19:23.014344 :A08D284A:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-05 08:19:53.107989 :A08D3277:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-05 08:19:53.574344 :A08D32B5:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-05 08:19:53.561 2025-06-05 08:19:53.574347 :A08D32B6:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=15396 pso_num=22 pso_serial#=9 2025-06-05 08:19:53.574487 :A08D32B7:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=15396 (legacy spawn) 2025-06-05 08:19:53.581173 :A08D32B8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-05 08:19:53.581360 :A08D32BD:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-05 08:19:53.582229 :A08D32C2:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-05 08:19:58.792550 :A08D346E:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-05 08:19:58.784 2025-06-05 08:19:58.792552 :A08D346F:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=2828 pso_num=22 pso_serial#=10 2025-06-05 08:19:58.792684 :A08D3470:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=2828 (legacy spawn) 2025-06-05 08:19:58.799174 :A08D3471:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-05 08:19:58.799353 :A08D3476:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-05 08:19:58.800242 :A08D347B:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-05 08:20:05.166905 :A08D3659:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-05 08:20:05.159 2025-06-05 08:20:05.166907 :A08D365A:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=15240 pso_num=22 pso_serial#=11 2025-06-05 08:20:05.167041 :A08D365B:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=15240 (legacy spawn) 2025-06-05 08:20:05.173449 :A08D365C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-05 08:20:05.173628 :A08D3661:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-05 08:20:05.174465 :A08D3666:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-05 08:20:11.062897 :A08D383E:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-05 08:20:11.049 2025-06-05 08:20:11.062899 :A08D383F:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=10888 pso_num=22 pso_serial#=12 2025-06-05 08:20:11.063087 :A08D3840:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=10888 (legacy spawn) 2025-06-05 08:20:11.069424 :A08D3841:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-05 08:20:11.069591 :A08D3846:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-05 08:20:11.070429 :A08D384B:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-05 08:20:11.079045 :A08D384E:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-05 08:20:11.064 2025-06-05 08:20:11.079046 :A08D384F:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16280 pso_num=22 pso_serial#=13 2025-06-05 08:20:11.079184 :A08D3850:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=16280 (legacy spawn) 2025-06-05 08:20:11.085578 :A08D3851:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-05 08:20:11.085752 :A08D385A:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-05 08:20:11.086539 :A08D385B:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-05 08:20:14.150070 :A08D3954:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-05 08:20:14.137 2025-06-05 08:20:14.150072 :A08D3955:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16316 pso_num=22 pso_serial#=14 2025-06-05 08:20:14.150212 :A08D3956:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=16316 (legacy spawn) 2025-06-05 08:20:14.156638 :A08D3957:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-05 08:20:14.156802 :A08D395C:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-05 08:20:14.157639 :A08D3961:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-05 08:20:14.166388 :A08D3964:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-05 08:20:14.153 2025-06-05 08:20:14.166391 :A08D3965:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=14056 pso_num=22 pso_serial#=15 2025-06-05 08:20:14.166536 :A08D3966:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=14056 (legacy spawn) 2025-06-05 08:20:14.172951 :A08D3967:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-05 08:20:14.173115 :A08D3970:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-05 08:20:14.173934 :A08D3971:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-05 08:20:23.084444 :A08D3C48:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-05 08:20:23.078 2025-06-05 08:20:23.084447 :A08D3C49:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=13380 pso_num=22 pso_serial#=16 2025-06-05 08:20:23.084583 :A08D3C4A:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=13380 osp_idx=0 osp_ver=264268 osp_pg=0 (spawn #253920) 2025-06-05 08:20:23.084584 :A08D3C4B:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-05 08:20:23.084584 :A08D3C4C:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=164 time=2087381735 2025-06-05 08:20:23.084585 :A08D3C4D:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-05 08:20:23.084585 :A08D3C4E:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-05 08:20:23.084585 :A08D3C4F:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-05 08:20:23.084586 :A08D3C50:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-05 08:20:23.084586 :A08D3C51:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-05 08:20:23.085068 :A08D3C52:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-05 08:20:23.085707 :A08D3C67:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-05 08:20:23.096677 :A08D3C83:db_trace:kwqid.c@2146:kwqidrdq(): [10960:22:177] kwqidrdq: Error: 1403 occured in OCI execute 2025-06-05 08:20:23.097154 :A08D3C84:db_trace:kwqid.c@2146:kwqidrdq(): [10960:22:177] kwqidrdq: Error: 1403 occured in OCI execute 2025-06-05 08:20:23.099555 :A08D3C85:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-06-05 08:20:23.099880 :A08D3C86:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-05 08:20:23.099915 :A08D3C89:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-06-05 08:20:23.100754 :A08D3C8F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-05 08:20:23.100869 :A08D3C98:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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 22 (osid: 13380, J000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de