Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250801220006\orcl_j000_11804_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250801220006\orcl_j000_11804_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:35842M/63366M, Ph+PgF:41417M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 22 Windows thread id: 11804, image: ORACLE.EXE (J000) *** 2025-08-01 22:00:07.002 *** SESSION ID:(177.11591) 2025-08-01 22:00:07.002 *** 2025-08-01 22:00:07.002 Process diagnostic dump for ORACLE.EXE (J000), OS id=11804, pid: 22, proc_ser: 29, sid: 177, sess_ser: 11591 ------------------------------------------------------------------------------- current sql: <none> client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 11804 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J000) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=5 seq_num=6 snap_id=1 wait times: snap=0.469288 sec, exc=0.469288 sec, total=0.469288 sec wait times: max=0.500000 sec, heur=2.979068 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.000013 sec since current wait 0: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=4 seq_num=5 snap_id=1 wait times: snap=0.510104 sec, exc=0.510104 sec, total=0.510104 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000014 sec of elapsed time 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=3 seq_num=4 snap_id=1 wait times: snap=0.499982 sec, exc=0.499982 sec, total=0.499982 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000019 sec of elapsed time 2: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=2 seq_num=3 snap_id=1 wait times: snap=0.500004 sec, exc=0.500004 sec, total=0.500004 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 3: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=1 seq_num=2 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.000013 sec of elapsed time 4: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=0 seq_num=1 snap_id=1 wait times: snap=0.499629 sec, exc=0.499629 sec, total=0.499629 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000000 sec of elapsed time Sampled Session History of session 177 serial 11591 --------------------------------------------------- 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 --------------------------------------------------- [3 samples, 22:00:04 - 22:00:07] 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-08-01 22:00:07.002 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 22 (osid: 11804, J000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-08-01 21:57:55.194861 :BA0E0DA2: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-08-01 21:57:55.194898 :BA0E0DA5:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-08-01 21:57:55.195764 :BA0E0DAB: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-08-01 21:57:55.195902 :BA0E0DB4: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-08-01 21:58:25.260453 :BA0E1759:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-01 21:58:41.937316 :BA0E1C9C:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-01 21:58:41.932 2025-08-01 21:58:41.937318 :BA0E1C9D:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=20468 pso_num=22 pso_serial#=21 2025-08-01 21:58:41.937463 :BA0E1C9E:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=20468 osp_idx=0 osp_ver=473628 osp_pg=0 (spawn #445794) 2025-08-01 21:58:41.937464 :BA0E1C9F:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-01 21:58:41.937464 :BA0E1CA0:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=162 time=2766191236 2025-08-01 21:58:41.937465 :BA0E1CA1:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-01 21:58:41.937465 :BA0E1CA2:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-01 21:58:41.937466 :BA0E1CA3:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-01 21:58:41.937466 :BA0E1CA4:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-01 21:58:41.937466 :BA0E1CA5:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-01 21:58:41.937977 :BA0E1CA6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-01 21:58:41.938024 :BA0E1CAC:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=18 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-01 21:58:41.957164 :BA0E1CBD:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-01 21:58:44.910527 :BA0E1D5A:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-01 21:58:44.895 2025-08-01 21:58:44.910530 :BA0E1D5B:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=15600 pso_num=22 pso_serial#=22 2025-08-01 21:58:44.910675 :BA0E1D5C:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=15600 (legacy spawn) 2025-08-01 21:58:44.917583 :BA0E1D5D: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-08-01 21:58:44.917764 :BA0E1D62: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-08-01 21:58:44.918654 :BA0E1D67:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-01 21:58:44.928084 :BA0E1D6A:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-01 21:58:44.926 2025-08-01 21:58:44.928086 :BA0E1D6B:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=18948 pso_num=22 pso_serial#=23 2025-08-01 21:58:44.928232 :BA0E1D6C:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=18948 (legacy spawn) 2025-08-01 21:58:44.935211 :BA0E1D6D: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-08-01 21:58:44.935399 :BA0E1D76: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-08-01 21:58:44.936303 :BA0E1D77:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-01 21:58:48.188305 :BA0E1EBF:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-01 21:58:48.175 2025-08-01 21:58:48.188307 :BA0E1EC0:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=13660 pso_num=22 pso_serial#=24 2025-08-01 21:58:48.188452 :BA0E1EC1:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=13660 (legacy spawn) 2025-08-01 21:58:48.195143 :BA0E1EC2: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-08-01 21:58:48.195318 :BA0E1ECB: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-08-01 21:58:48.196114 :BA0E1ECC:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-01 21:58:48.215390 :BA0E1ECF:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-01 21:58:48.206 2025-08-01 21:58:48.215392 :BA0E1ED0:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=11816 pso_num=22 pso_serial#=25 2025-08-01 21:58:48.215529 :BA0E1ED1:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=11816 (legacy spawn) 2025-08-01 21:58:48.222061 :BA0E1ED2: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-08-01 21:58:48.222222 :BA0E1EDB: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-08-01 21:58:48.223066 :BA0E1EDC:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-01 21:58:48.839435 :BA0E1F01:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-01 21:58:48.831 2025-08-01 21:58:48.839437 :BA0E1F02:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=11720 pso_num=22 pso_serial#=26 2025-08-01 21:58:48.839575 :BA0E1F03:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=11720 (legacy spawn) 2025-08-01 21:58:48.846014 :BA0E1F04: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-08-01 21:58:48.846188 :BA0E1F09: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-08-01 21:58:48.846975 :BA0E1F0E:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-01 21:58:55.248688 :BA0E211D:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-01 21:58:55.242 2025-08-01 21:58:55.248690 :BA0E211E:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=8004 pso_num=22 pso_serial#=27 2025-08-01 21:58:55.248833 :BA0E211F:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=8004 osp_idx=0 osp_ver=473634 osp_pg=0 (spawn #445795) 2025-08-01 21:58:55.248834 :BA0E2120:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-01 21:58:55.248835 :BA0E2121:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=163 time=2766204548 2025-08-01 21:58:55.248835 :BA0E2122:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-01 21:58:55.248835 :BA0E2123:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-01 21:58:55.248836 :BA0E2124:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-01 21:58:55.248836 :BA0E2125:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-01 21:58:55.248837 :BA0E2126:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-01 21:58:55.249347 :BA0E2127: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-08-01 21:58:55.249992 :BA0E213C: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-08-01 21:58:55.264548 :BA0E2158:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-08-01 21:58:55.264638 :BA0E2159:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-08-01 21:58:55.284802 :BA0E215A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-08-01 21:58:55.284862 :BA0E215B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-08-01 21:58:55.285104 :BA0E215C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-08-01 21:58:55.285140 :BA0E215D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-08-01 21:58:55.285188 :BA0E215E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-08-01 21:58:55.285517 :BA0E215F: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-08-01 21:58:55.285554 :BA0E2162:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-08-01 21:58:55.296216 :BA0E2168: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-08-01 21:58:55.296288 :BA0E216B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:ktcc.c:879 2025-08-01 21:58:55.296324 :BA0E216C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:ktcc.c:879 2025-08-01 21:58:55.298266 :BA0E2172:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-08-01 21:58:55.298311 :BA0E2173:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-08-01 21:58:55.298791 :BA0E2174:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-08-01 21:58:55.299023 :BA0E2175: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-08-01 21:58:55.299059 :BA0E2178:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-08-01 21:58:55.304045 :BA0E217E: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-08-01 21:58:55.304105 :BA0E2181:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:ktcc.c:879 2025-08-01 21:58:55.304138 :BA0E2182:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:ktcc.c:879 2025-08-01 21:58:55.304412 :BA0E2188:db_trace:kwqid.c@2146:kwqidrdq(): [10960:22:177] kwqidrdq: Error: 1403 occured in OCI execute 2025-08-01 21:58:55.304727 :BA0E2189:db_trace:kwqid.c@2146:kwqidrdq(): [10960:22:177] kwqidrdq: Error: 1403 occured in OCI execute 2025-08-01 21:58:55.304899 :BA0E218A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-08-01 21:58:55.305204 :BA0E218B: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-08-01 21:58:55.305227 :BA0E218E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-08-01 21:58:55.306820 :BA0E2194:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-08-01 21:58:55.307050 :BA0E2195: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-08-01 21:58:55.307078 :BA0E2198:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-08-01 21:58:55.307950 :BA0E219E: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-08-01 21:58:55.308042 :BA0E21A7: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-08-01 21:59:25.393025 :BA0E2B89:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-01 21:59:32.671138 :BA0E2DC4:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-01 21:59:32.663 2025-08-01 21:59:32.671140 :BA0E2DC5:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=20320 pso_num=22 pso_serial#=28 2025-08-01 21:59:32.671283 :BA0E2DC6:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=20320 (legacy spawn) 2025-08-01 21:59:32.677751 :BA0E2DC7: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-08-01 21:59:32.677935 :BA0E2DD0: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-08-01 21:59:32.678780 :BA0E2DD1:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-01 21:59:55.327328 :BA0E34E0:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-01 21:59:55.322 2025-08-01 21:59:55.327331 :BA0E34E1:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=11804 pso_num=22 pso_serial#=29 2025-08-01 21:59:55.327477 :BA0E34E2:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=11804 osp_idx=0 osp_ver=473636 osp_pg=0 (spawn #445798) 2025-08-01 21:59:55.327477 :BA0E34E3:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-01 21:59:55.327478 :BA0E34E4:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=164 time=2766264626 2025-08-01 21:59:55.327478 :BA0E34E5:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-01 21:59:55.327478 :BA0E34E6:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-01 21:59:55.327479 :BA0E34E7:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-01 21:59:55.327479 :BA0E34E8:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-01 21:59:55.327480 :BA0E34E9:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-01 21:59:55.327982 :BA0E34EA: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-08-01 21:59:55.328634 :BA0E34FF: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-08-01 21:59:55.336254 :BA0E351B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-08-01 21:59:55.336622 :BA0E351C: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-08-01 21:59:55.336661 :BA0E351F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-08-01 21:59:55.337645 :BA0E3525: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-08-01 21:59:55.337774 :BA0E352E: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-08-01 22:00:00.316885 :BA0E3852: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-08-01 22:00:00.316885*:BA0E386B:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000000FCDB898 estart=1754056799 eid=16785284 ctx=0x000000077FD6A000 cwh=0x000000000FCD0068 cpu=0 buffg=1 interb=0 r=0 rb=0 w=0 wb=0 2025-08-01 22:00:00.316885*:BA0E386C:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000000FCDB898 curCtx=0x000000000FCD7AB8 pubTabIdxCnt=0 2025-08-01 22:00:00.316885*:BA0E386D:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000000FCDB898 2025-08-01 22:00:00.316885*:BA0E386E:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000000FCDB898 2025-08-01 22:00:00.316885*:BA0E386F:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000000FCDB898 curCtx=0x000000000FCD7AB8 xsc->flg4=65792 flags=2 2025-08-01 22:00:00.316885*:BA0E3870:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000000FCDB898 2025-08-01 22:00:00.322885 :BA0E387B: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-08-01 22:00:00.322931 :BA0E387E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:jslv.c:9203 2025-08-01 22:00:00.332782 :BA0E38C9:KFNU:kfn.c@2200:kfnPrepareASM(): kfnPrepareASM force=0 state_kfnsg=0x7 2025-08-01 22:00:00.333374 :BA0E38CA:db_trace:kcc.c@13684:kccwbp(): [10021:22:177:1] 0115000000000000 0115000000000000 7467120000000000 2025-08-01 22:00:00.335157 :BA0E38CF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=15 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-08-01 22:00:00.335245 :BA0E38E5:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=15 loc='ksr2.h LINE:607 ID:ksrmdone' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-01 22:00:00.335255 :BA0E38EA:db_trace:ksb.c@6610:ksbcic_int(): [10254:22:177] KSBCIC: (USER) starting cic on opcode KSBCIRCO [1] with args (1 8397264 1) 2025-08-01 22:00:00.335258 :BA0E38EB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=15 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-01 22:00:00.335287 :BA0E38F7:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=15 loc='ksa2.h LINE:286 ID:ksasnr' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-01 22:00:00.336092 :BA0E3919:db_trace:ksb.c@6610:ksbcic_int(): [10254:22:177] KSBCIC: (USER) starting cic on opcode KSBCICKP [2] with args (4 0 233155633) 2025-08-01 22:00:00.336097 :BA0E391A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=15 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-01 22:00:00.336121 :BA0E3925:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=15 loc='ksa2.h LINE:286 ID:ksasnr' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-01 22:00:00.336128 :BA0E3932:db_trace:ksb.c@6610:ksbcic_int(): [10254:22:177] KSBCIC: (USER) starting cic on opcode KSBCICKP [2] with args (6 65558 1) 2025-08-01 22:00:00.336131 :BA0E3936:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=15 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-01 22:00:00.336160 :BA0E3944:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=15 loc='ksa2.h LINE:286 ID:ksasnr' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-01 22:00:00.336164 :BA0E394D:db_trace:ksb.c@6610:ksbcic_int(): [10254:22:177] KSBCIC: (USER) starting cic on opcode KSBCICKP [2] with args (1 2 65558) 2025-08-01 22:00:00.336166 :BA0E3952:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=15 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-01 22:00:00.336217 :BA0E3970:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=15 loc='ksa2.h LINE:286 ID:ksasnr' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-01 22:00:00.337277 :BA0E3A23:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=15 loc='ksq.h LINE:1877 ID:ksqrcl' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-01 22:00:00.337293 :BA0E3A24:KFNU:kfn.c@2200:kfnPrepareASM(): kfnPrepareASM force=0 state_kfnsg=0x7 2025-08-01 22:00:00.338126 :BA0E3A33:db_trace:kcc.c@13684:kccwbp(): [10021:22:177:1] 0115000000000000 0115000000000000 7567120000000000 2025-08-01 22:00:00.338485 :BA0E3A37:db_trace:ksb.c@6610:ksbcic_int(): [10254:22:177] KSBCIC: (USER) starting cic on opcode KSBCIBBS [20] with args (2 0 233155633) 2025-08-01 22:00:00.338491 :BA0E3A38:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=15 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-01 22:00:00.338517 :BA0E3A43:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=15 loc='ksa2.h LINE:286 ID:ksasnr' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-01 22:00:00.347266 :BA0E3AB7:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:jslv.c:9203 2025-08-01 22:00:00.348816 :BA0E3B13: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-08-01 22:00:00.348858 :BA0E3B18:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 2025-08-01 22:00:00.348909 :BA0E3B27: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-08-01 22:00:00.441559 :BA0E3BCC: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-08-01 22:00:00.443783 :BA0E3BD0: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-08-01 22:00:00.443825 :BA0E3BD3:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:jslv.c:9203 2025-08-01 22:00:00.446456 :BA0E3BD9:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:jslv.c:9203 2025-08-01 22:00:00.450032 :BA0E3BDA: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-08-01 22:00:00.450128 :BA0E3BDD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 2025-08-01 22:00:00.450225 :BA0E3BE9: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-08-01 22:00:04.013613 :BA0E4166: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-08-01 22:00:04.013613*:BA0E4169:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000000FCDC718 estart=1754056803 eid=16785289 ctx=0x000000077FD6A000 cwh=0x000000000FCD0068 cpu=0 buffg=1 interb=0 r=0 rb=0 w=0 wb=0 2025-08-01 22:00:04.013613*:BA0E416A:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000000FCDC718 curCtx=0x000000000FCD8938 pubTabIdxCnt=0 2025-08-01 22:00:04.013613*:BA0E416B:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000000FCDC718 2025-08-01 22:00:04.013613*:BA0E416C:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000000FCDC718 2025-08-01 22:00:04.013613*:BA0E416D:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000000FCDC718 curCtx=0x000000000FCD8938 xsc->flg4=65792 flags=2 2025-08-01 22:00:04.013613*:BA0E416E:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000000FCDC718 2025-08-01 22:00:04.015725 :BA0E416F: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-08-01 22:00:04.015763 :BA0E4172:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:jslv.c:9203 2025-08-01 22:00:04.024735 :BA0E4178: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-08-01 22:00:04.025497 :BA0E4180: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-08-01 22:00:04.026244 :BA0E4188: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-08-01 22:00:04.026442 :BA0E4190:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:jslv.c:9203 2025-08-01 22:00:04.027798 :BA0E4191: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-08-01 22:00:04.027835 :BA0E4194:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 2025-08-01 22:00:04.027915 :BA0E41A1: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: 11804, J000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de