Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250911220008\orcl_j000_23480_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250911220008\orcl_j000_23480_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:34853M/63366M, Ph+PgF:39561M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 24 Windows thread id: 23480, image: ORACLE.EXE (J000) *** 2025-09-11 22:00:08.490 *** SESSION ID:(193.5855) 2025-09-11 22:00:08.490 *** 2025-09-11 22:00:08.490 Process diagnostic dump for ORACLE.EXE (J000), OS id=23480, pid: 24, proc_ser: 118, sid: 193, sess_ser: 5855 ------------------------------------------------------------------------------- current sql: <none> client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 23480 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J000) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=8 seq_num=9 snap_id=1 wait times: snap=0.473852 sec, exc=0.473852 sec, total=0.473852 sec wait times: max=0.500000 sec, heur=4.480515 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.000011 sec since current wait 0: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=7 seq_num=8 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 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=6 seq_num=7 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.000007 sec of elapsed time 2: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=5 seq_num=6 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.000005 sec of elapsed time 3: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=4 seq_num=5 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 4: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=3 seq_num=4 snap_id=1 wait times: snap=0.510109 sec, exc=0.510109 sec, total=0.510109 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000011 sec of elapsed time 5: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=2 seq_num=3 snap_id=1 wait times: snap=0.500003 sec, exc=0.500003 sec, total=0.500003 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000006 sec of elapsed time 6: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=1 seq_num=2 snap_id=1 wait times: snap=0.500005 sec, exc=0.500005 sec, total=0.500005 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000007 sec of elapsed time 7: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=0 seq_num=1 snap_id=1 wait times: snap=0.486381 sec, exc=0.486381 sec, total=0.486381 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 193 serial 5855 --------------------------------------------------- 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 --------------------------------------------------- [5 samples, 22:00:04 - 22:00:08] 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-09-11 22:00:08.490 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 24 (osid: 23480, J000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-09-11 21:56:14.026943 :CC23F9B1:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=25060 (legacy spawn) 2025-09-11 21:56:14.033656 :CC23F9B2: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-09-11 21:56:14.033843 :CC23F9BB: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-09-11 21:56:14.034652 :CC23F9BC:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-11 21:56:34.582798 :CC23FFFA:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-11 21:56:34.574 2025-09-11 21:56:34.582800 :CC23FFFB:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=24588 pso_num=24 pso_serial#=105 2025-09-11 21:56:34.582945 :CC23FFFC:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=24588 (legacy spawn) 2025-09-11 21:56:34.589484 :CC23FFFD: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-09-11 21:56:34.589664 :CC240002: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-09-11 21:56:34.590505 :CC240007:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-11 21:56:34.599336 :CC24000A:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-11 21:56:34.590 2025-09-11 21:56:34.599338 :CC24000B:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=24176 pso_num=24 pso_serial#=106 2025-09-11 21:56:34.599475 :CC24000C:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=24176 (legacy spawn) 2025-09-11 21:56:34.606153 :CC24000D: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-09-11 21:56:34.606382 :CC240016: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-09-11 21:56:34.607204 :CC240017:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-11 21:56:35.095822 :CC240045:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-11 21:56:35.090 2025-09-11 21:56:35.095824 :CC240046:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=24012 pso_num=24 pso_serial#=107 2025-09-11 21:56:35.095967 :CC240047:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=24012 osp_idx=22 osp_ver=879956 osp_pg=0 (spawn #582490) 2025-09-11 21:56:35.095967 :CC240048:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-11 21:56:35.095968 :CC240049:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=225 time=2013446393 2025-09-11 21:56:35.095968 :CC24004A:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-09-11 21:56:35.095968 :CC24004B:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-09-11 21:56:35.095969 :CC24004C:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-09-11 21:56:35.095969 :CC24004D:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-11 21:56:35.095969 :CC24004E:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-11 21:56:35.096462 :CC24004F: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-09-11 21:56:35.097121 :CC240064: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-09-11 21:56:35.108206 :CC240080:db_trace:kwqid.c@2146:kwqidrdq(): [10960:24:193] kwqidrdq: Error: 1403 occured in OCI execute 2025-09-11 21:56:35.108680 :CC240081:db_trace:kwqid.c@2146:kwqidrdq(): [10960:24:193] kwqidrdq: Error: 1403 occured in OCI execute 2025-09-11 21:56:35.111083 :CC240082:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-09-11 21:56:35.111412 :CC240083: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-09-11 21:56:35.111448 :CC240086:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-09-11 21:56:35.112335 :CC24008C: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-09-11 21:56:35.112455 :CC240095: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-09-11 21:57:05.201498 :CC240A17:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-11 21:57:10.793313 :CC240BE3:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-11 21:57:10.778 2025-09-11 21:57:10.793314 :CC240BE4:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=23384 pso_num=24 pso_serial#=108 2025-09-11 21:57:10.793448 :CC240BE5:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=23384 (legacy spawn) 2025-09-11 21:57:10.799894 :CC240BE6: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-09-11 21:57:10.800064 :CC240BEF: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-09-11 21:57:10.800875 :CC240BF0:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-11 21:57:10.818606 :CC240BF3:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-11 21:57:10.809 2025-09-11 21:57:10.818608 :CC240BF4:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=24568 pso_num=24 pso_serial#=109 2025-09-11 21:57:10.818742 :CC240BF5:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=24568 (legacy spawn) 2025-09-11 21:57:10.825168 :CC240BF6: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-09-11 21:57:10.825355 :CC240BFE: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-09-11 21:57:10.826182 :CC240C00:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-11 21:57:14.103151 :CC240CE0:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-11 21:57:14.101 2025-09-11 21:57:14.103153 :CC240CE1:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=21588 pso_num=24 pso_serial#=110 2025-09-11 21:57:14.103286 :CC240CE2:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=21588 (legacy spawn) 2025-09-11 21:57:14.109760 :CC240CE3: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-09-11 21:57:14.109927 :CC240CE9: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-09-11 21:57:14.110690 :CC240CED:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-11 21:57:14.119552 :CC240CF0:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-11 21:57:14.116 2025-09-11 21:57:14.119554 :CC240CF1:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=22312 pso_num=24 pso_serial#=111 2025-09-11 21:57:14.119695 :CC240CF2:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=22312 (legacy spawn) 2025-09-11 21:57:14.126148 :CC240CF3: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-09-11 21:57:14.126310 :CC240CFC: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-09-11 21:57:14.127108 :CC240CFD:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-11 21:57:20.820830 :CC240EE6:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-11 21:57:20.813 2025-09-11 21:57:20.820832 :CC240EE7:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=21728 pso_num=24 pso_serial#=112 2025-09-11 21:57:20.820975 :CC240EE8:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=21728 (legacy spawn) 2025-09-11 21:57:20.827487 :CC240EE9: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-09-11 21:57:20.827661 :CC240EF1: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-09-11 21:57:20.828485 :CC240EF3:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-11 21:57:22.119613 :CC240F81:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-11 21:57:22.118 2025-09-11 21:57:22.119615 :CC240F82:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=23064 pso_num=24 pso_serial#=113 2025-09-11 21:57:22.119755 :CC240F83:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=23064 (legacy spawn) 2025-09-11 21:57:22.126292 :CC240F84: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-09-11 21:57:22.126456 :CC240F89: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-09-11 21:57:22.127306 :CC240F8E:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-11 21:57:35.164589 :CC241399:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-11 21:57:35.158 2025-09-11 21:57:35.164591 :CC24139A:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=7572 pso_num=24 pso_serial#=114 2025-09-11 21:57:35.164769 :CC24139B:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=7572 osp_idx=22 osp_ver=879963 osp_pg=0 (spawn #582492) 2025-09-11 21:57:35.164770 :CC24139C:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-11 21:57:35.164771 :CC24139D:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=226 time=2013506471 2025-09-11 21:57:35.164771 :CC24139E:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-09-11 21:57:35.164772 :CC24139F:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-09-11 21:57:35.164773 :CC2413A0:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-09-11 21:57:35.164773 :CC2413A1:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-11 21:57:35.164773 :CC2413A2:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-11 21:57:35.165308 :CC2413A3: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-09-11 21:57:35.165962 :CC2413B8: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-09-11 21:57:35.173533 :CC2413D5:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-09-11 21:57:35.173892 :CC2413D6: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-09-11 21:57:35.173930 :CC2413D9:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-09-11 21:57:35.174785 :CC2413DF: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-09-11 21:57:35.174899 :CC2413E8: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-09-11 21:58:05.285556 :CC241E84:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-11 21:58:06.731134 :CC241F11:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-11 21:58:06.722 2025-09-11 21:58:06.731137 :CC241F12:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=25428 pso_num=24 pso_serial#=115 2025-09-11 21:58:06.731273 :CC241F13:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=25428 (legacy spawn) 2025-09-11 21:58:06.737753 :CC241F14: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-09-11 21:58:06.737926 :CC241F19: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-09-11 21:58:06.738735 :CC241F1E:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-11 21:58:20.257315 :CC24231B:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-11 21:58:20.251 2025-09-11 21:58:20.257317 :CC24231C:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=23784 pso_num=24 pso_serial#=116 2025-09-11 21:58:20.257452 :CC24231D:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=23784 osp_idx=22 osp_ver=879965 osp_pg=0 (spawn #582494) 2025-09-11 21:58:20.257453 :CC24231E:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-11 21:58:20.257453 :CC24231F:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=227 time=2013551565 2025-09-11 21:58:20.257454 :CC242320:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-09-11 21:58:20.257454 :CC242321:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-09-11 21:58:20.257455 :CC242322:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-09-11 21:58:20.257455 :CC242323:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-11 21:58:20.257455 :CC242324:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-11 21:58:20.257940 :CC242325: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-09-11 21:58:20.258625 :CC24233A: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-09-11 21:58:20.264073 :CC242356: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-09-11 21:58:20.265023 :CC24235E: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-09-11 21:58:20.265151 :CC242367: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-09-11 21:58:35.270855 :CC24283D: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-09-11 21:59:05.384639 :CC24322D:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-11 21:59:08.931166 :CC243324:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-11 21:59:08.922 2025-09-11 21:59:08.931168 :CC243325:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=21444 pso_num=24 pso_serial#=117 2025-09-11 21:59:08.931310 :CC243326:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=21444 (legacy spawn) 2025-09-11 21:59:08.937887 :CC243327: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-09-11 21:59:08.938062 :CC24332C: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-09-11 21:59:08.938921 :CC243331:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-09-11 21:59:35.373185 :CC243B67:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 09-11 21:59:35.367 2025-09-11 21:59:35.373187 :CC243B68:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=23480 pso_num=24 pso_serial#=118 2025-09-11 21:59:35.373337 :CC243B69:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=23480 osp_idx=22 osp_ver=879967 osp_pg=0 (spawn #582497) 2025-09-11 21:59:35.373338 :CC243B6A:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-11 21:59:35.373338 :CC243B6B:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=228 time=2013626674 2025-09-11 21:59:35.373339 :CC243B6C:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-09-11 21:59:35.373339 :CC243B6D:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-09-11 21:59:35.373340 :CC243B6E:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-09-11 21:59:35.373340 :CC243B6F:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-11 21:59:35.373340 :CC243B70:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-11 21:59:35.373929 :CC243B71: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-09-11 21:59:35.374599 :CC243B86: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-09-11 21:59:35.382247 :CC243BA2:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-09-11 21:59:35.382731 :CC243BA3: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-09-11 21:59:35.382767 :CC243BA6:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-09-11 21:59:35.383700 :CC243BAC: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-09-11 21:59:35.383822 :CC243BB5: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-09-11 22:00:00.414000 :CC244520: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-09-11 22:00:00.414000*:CC24454B:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000024D5C718 estart=1757599199 eid=16787807 ctx=0x000000077FD6A000 cwh=0x0000000024D50068 cpu=0 buffg=1 interb=0 r=0 rb=0 w=0 wb=0 2025-09-11 22:00:00.414000*:CC24454C:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000024D5C718 curCtx=0x0000000024D58938 pubTabIdxCnt=0 2025-09-11 22:00:00.414000*:CC24454D:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000024D5C718 2025-09-11 22:00:00.414000*:CC24454E:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000024D5C718 2025-09-11 22:00:00.414000*:CC244564:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000024D5C718 curCtx=0x0000000024D58938 xsc->flg4=65792 flags=2 2025-09-11 22:00:00.414000*:CC244565:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000024D5C718 2025-09-11 22:00:00.420843 :CC244566: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-09-11 22:00:00.420915 :CC244569:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:jslv.c:9203 2025-09-11 22:00:00.432304 :CC2445F6: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-09-11 22:00:00.437137 :CC244725: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-09-11 22:00:00.437872 :CC244737: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-09-11 22:00:00.443291 :CC244747:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-09-11 22:00:00.443445 :CC244756:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-11 22:00:00.444264 :CC24475F: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-09-11 22:00:00.444478 :CC244767:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:jslv.c:9203 2025-09-11 22:00:00.445748 :CC244779: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-09-11 22:00:00.445780 :CC24477C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 2025-09-11 22:00:00.445843 :CC244789: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-09-11 22:00:00.538565 :CC24485C: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-09-11 22:00:00.540700 :CC244860: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-09-11 22:00:00.540738 :CC244863:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:jslv.c:9203 2025-09-11 22:00:00.543187 :CC244869:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:jslv.c:9203 2025-09-11 22:00:00.546574 :CC24486A: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-09-11 22:00:00.546654 :CC24486D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 2025-09-11 22:00:00.546743 :CC24487A: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-09-11 22:00:04.001777 :CC244D60: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-09-11 22:00:04.001777*:CC244D63:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000024D5C718 estart=1757599203 eid=16787812 ctx=0x000000077FD6A000 cwh=0x0000000024D50068 cpu=0 buffg=1 interb=0 r=0 rb=0 w=0 wb=0 2025-09-11 22:00:04.001777*:CC244D64:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000024D5C718 curCtx=0x0000000024D58938 pubTabIdxCnt=0 2025-09-11 22:00:04.001777*:CC244D65:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000024D5C718 2025-09-11 22:00:04.001777*:CC244D66:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000024D5C718 2025-09-11 22:00:04.001777*:CC244D67:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000024D5C718 curCtx=0x0000000024D58938 xsc->flg4=65792 flags=2 2025-09-11 22:00:04.001777*:CC244D68:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000024D5C718 2025-09-11 22:00:04.003933 :CC244D69: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-09-11 22:00:04.003972 :CC244D6C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:jslv.c:9203 2025-09-11 22:00:04.010540 :CC244D72: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-09-11 22:00:04.011268 :CC244D7A: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-09-11 22:00:04.011978 :CC244D82: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-09-11 22:00:04.012237 :CC244D8A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:jslv.c:9203 2025-09-11 22:00:04.013679 :CC244D8B: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-09-11 22:00:04.013729 :CC244D8E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 2025-09-11 22:00:04.013817 :CC244D9B: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: 23480, J000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de