Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250529220006\orcl_j004_11388_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250529220006\orcl_j004_11388_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:37263M/63366M, Ph+PgF:44179M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 30 Windows thread id: 11388, image: ORACLE.EXE (J004) *** 2025-05-29 22:00:06.165 *** SESSION ID:(241.2111) 2025-05-29 22:00:06.165 *** 2025-05-29 22:00:06.165 Process diagnostic dump for ORACLE.EXE (J004), OS id=11388, pid: 30, proc_ser: 248, sid: 241, sess_ser: 2111 ------------------------------------------------------------------------------- current sql: <none> client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 11388 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J004) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=4 seq_num=5 snap_id=1 wait times: snap=0.484258 sec, exc=0.484258 sec, total=0.484258 sec wait times: max=0.500000 sec, heur=2.480610 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.000003 sec since current wait 0: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=3 seq_num=4 snap_id=1 wait times: snap=0.499985 sec, exc=0.499985 sec, total=0.499985 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000004 sec of elapsed time 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=2 seq_num=3 snap_id=1 wait times: snap=0.510092 sec, exc=0.510092 sec, total=0.510092 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 2: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=1 seq_num=2 snap_id=1 wait times: snap=0.500023 sec, exc=0.500023 sec, total=0.500023 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=0 seq_num=1 snap_id=1 wait times: snap=0.486232 sec, exc=0.486232 sec, total=0.486232 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 241 serial 2111 --------------------------------------------------- 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:03 - 22:00:06] idle wait at each sample [session created at: 22:00:03] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.016000 sec (max dump time=30.000000 sec) *** 2025-05-29 22:00:06.180 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 30 (osid: 11388, J004) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-29 00:04:06.438133 :9D53C1D4:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-29 00:04:06.438914 :9D53C1D9:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-05-29 00:04:06.447449 :9D53C1DC:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 05-29 00:04:06.434 2025-05-29 00:04:06.447452 :9D53C1DD:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=9648 pso_num=30 pso_serial#=234 2025-05-29 00:04:06.447586 :9D53C1DE:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=9648 (legacy spawn) 2025-05-29 00:04:06.454064 :9D53C1EB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 00:04:06.454230 :9D53C1F4:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-29 00:04:06.455071 :9D53C1F5:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-05-29 00:04:16.578725 :9D53C524:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 05-29 00:04:16.569 2025-05-29 00:04:16.578727 :9D53C525:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=9660 pso_num=30 pso_serial#=235 2025-05-29 00:04:16.578867 :9D53C526:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=9660 (legacy spawn) 2025-05-29 00:04:16.585566 :9D53C527:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 00:04:16.585741 :9D53C52C:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-29 00:04:16.586609 :9D53C531:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-05-29 00:05:00.258828 :9D53D3A4:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 05-29 00:05:00.250 2025-05-29 00:05:00.258830 :9D53D3A5:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=11388 pso_num=30 pso_serial#=236 2025-05-29 00:05:00.258970 :9D53D3A6:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=11388 (legacy spawn) 2025-05-29 00:05:00.265504 :9D53D3A7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 00:05:00.265690 :9D53D3AC:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-29 00:05:00.266665 :9D53D3B1:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-05-29 00:05:16.271184 :9D53D8B2:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 05-29 00:05:16.257 2025-05-29 00:05:16.271186 :9D53D8B3:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=12988 pso_num=30 pso_serial#=237 2025-05-29 00:05:16.271331 :9D53D8B4:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=12988 (legacy spawn) 2025-05-29 00:05:16.277838 :9D53D8B5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 00:05:16.278011 :9D53D8BA:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-29 00:05:16.278848 :9D53D8BF:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-05-29 00:05:16.287632 :9D53D8C2:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 05-29 00:05:16.273 2025-05-29 00:05:16.287633 :9D53D8C3:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=14752 pso_num=30 pso_serial#=238 2025-05-29 00:05:16.287773 :9D53D8C4:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=14752 (legacy spawn) 2025-05-29 00:05:16.294289 :9D53D8C5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 00:05:16.294464 :9D53D8CE:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-29 00:05:16.295293 :9D53D8CF:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-05-29 00:05:19.434446 :9D53D9EC:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 05-29 00:05:19.421 2025-05-29 00:05:19.434448 :9D53D9ED:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=14972 pso_num=30 pso_serial#=239 2025-05-29 00:05:19.434587 :9D53D9EE:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=14972 (legacy spawn) 2025-05-29 00:05:19.441107 :9D53D9EF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 00:05:19.441291 :9D53D9F4:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-29 00:05:19.442081 :9D53D9F9:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-05-29 00:05:19.450723 :9D53D9FC:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 05-29 00:05:19.437 2025-05-29 00:05:19.450725 :9D53D9FD:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=14276 pso_num=30 pso_serial#=240 2025-05-29 00:05:19.450874 :9D53D9FE:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=14276 (legacy spawn) 2025-05-29 00:05:19.457353 :9D53D9FF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 00:05:19.457529 :9D53DA08:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-29 00:05:19.458320 :9D53DA09:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-05-29 00:05:52.727946 :9D53EAEC:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 05-29 00:05:52.714 2025-05-29 00:05:52.727948 :9D53EAED:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=13828 pso_num=30 pso_serial#=241 2025-05-29 00:05:52.728082 :9D53EAEE:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=13828 (legacy spawn) 2025-05-29 00:05:52.734506 :9D53EAEF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 00:05:52.734675 :9D53EAF6:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-29 00:05:52.735518 :9D53EAF9:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-05-29 00:05:52.744090 :9D53EAFC:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 05-29 00:05:52.729 2025-05-29 00:05:52.744092 :9D53EAFD:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=13668 pso_num=30 pso_serial#=242 2025-05-29 00:05:52.744221 :9D53EAFE:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=13668 (legacy spawn) 2025-05-29 00:05:52.750737 :9D53EAFF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 00:05:52.750904 :9D53EB08:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-29 00:05:52.751693 :9D53EB09:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-05-29 00:05:56.126812 :9D53ED6D:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 05-29 00:05:56.114 2025-05-29 00:05:56.126814 :9D53ED6E:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=15052 pso_num=30 pso_serial#=243 2025-05-29 00:05:56.126951 :9D53ED6F:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=15052 (legacy spawn) 2025-05-29 00:05:56.133386 :9D53ED70:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 00:05:56.133550 :9D53ED79:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-29 00:05:56.134329 :9D53ED7A:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-05-29 00:05:56.143051 :9D53ED7D:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 05-29 00:05:56.129 2025-05-29 00:05:56.143053 :9D53ED7E:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=12612 pso_num=30 pso_serial#=244 2025-05-29 00:05:56.143196 :9D53ED7F:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=12612 (legacy spawn) 2025-05-29 00:05:56.149725 :9D53ED80:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 00:05:56.149900 :9D53ED88:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-29 00:05:56.150723 :9D53ED8A:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-05-29 00:05:58.795975 :9D53EE6A:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 05-29 00:05:58.786 2025-05-29 00:05:58.795977 :9D53EE6B:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=8780 pso_num=30 pso_serial#=245 2025-05-29 00:05:58.796112 :9D53EE6C:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=8780 (legacy spawn) 2025-05-29 00:05:58.802585 :9D53EE6D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 00:05:58.802751 :9D53EE72:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-29 00:05:58.803546 :9D53EE77:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-05-29 00:06:02.419388 :9D53EFA5:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 05-29 00:06:02.411 2025-05-29 00:06:02.419391 :9D53EFA6:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=13620 pso_num=30 pso_serial#=246 2025-05-29 00:06:02.419537 :9D53EFA7:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=13620 (legacy spawn) 2025-05-29 00:06:02.426095 :9D53EFA8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 00:06:02.426269 :9D53EFB1:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-29 00:06:02.427200 :9D53EFD5:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-05-29 01:00:32.745257 :9D582EA8:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 05-29 01:00:32.734 2025-05-29 01:00:32.745259 :9D582EA9:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=13128 pso_num=30 pso_serial#=247 2025-05-29 01:00:32.745392 :9D582EAA:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=13128 osp_idx=28 osp_ver=1011 osp_pg=0 (spawn #229560) 2025-05-29 01:00:32.745393 :9D582EAB:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-29 01:00:32.745393 :9D582EAC:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=190 time=1456205000 2025-05-29 01:00:32.745394 :9D582EAD:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-05-29 01:00:32.745394 :9D582EAE:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-05-29 01:00:32.745394 :9D582EAF:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-05-29 01:00:32.745395 :9D582EB0:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-29 01:00:32.745395 :9D582EB1:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-29 01:00:32.745924 :9D582EB2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-29 01:00:32.746006 :9D582EB8:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] 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-05-29 01:00:32.754307 :9D582ECA:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-05-29 22:00:01.656264 :9DBACA74:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 05-29 22:00:01.645 2025-05-29 22:00:01.656266 :9DBACA75:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=11388 pso_num=30 pso_serial#=248 2025-05-29 22:00:01.656396 :9DBACA7A:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=11388 osp_idx=28 osp_ver=1012 osp_pg=0 (spawn #232476) 2025-05-29 22:00:01.656397 :9DBACA7B:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-29 22:00:01.656397 :9DBACA7C:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=191 time=1531762422 2025-05-29 22:00:01.656397 :9DBACA7D:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-05-29 22:00:01.656397 :9DBACA7E:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-05-29 22:00:01.656398 :9DBACA7F:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-05-29 22:00:01.656398 :9DBACA80:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-29 22:00:01.656398 :9DBACA81:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-29 22:00:01.656837 :9DBACA87:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-29 22:00:01.661692 :9DBACAAE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:01.661723 :9DBACAB1:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:jslv.c:9203 2025-05-29 22:00:02.024259 :9DBACECB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.064569 :9DBACEE7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.078499 :9DBACEEF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.127821 :9DBACEF7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.258679 :9DBACF27:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.374827 :9DBACF2F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.382187 :9DBACF37:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.394604 :9DBACF3F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.406194 :9DBACF47:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.418159 :9DBACF4F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.425414 :9DBACF57:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.432849 :9DBACF5F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.444373 :9DBACF67:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.456309 :9DBACF6F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.463632 :9DBACF77:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.470786 :9DBACF7F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.481061 :9DBACF87:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.487560 :9DBACF8F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.498189 :9DBACF97:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.508323 :9DBACF9F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.518533 :9DBACFA7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.523622 :9DBACFAF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.533727 :9DBACFB7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.540219 :9DBACFBF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.551224 :9DBACFC7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.557920 :9DBACFCF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.563920 :9DBACFD7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.573715 :9DBACFDF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.580377 :9DBACFE7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.586382 :9DBACFEF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.595852 :9DBACFF7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.602320 :9DBACFFF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.612493 :9DBAD007:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.621836 :9DBAD00F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.628310 :9DBAD017:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.635265 :9DBAD01F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.645358 :9DBAD027:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.654635 :9DBAD02F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.661478 :9DBAD037:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.668462 :9DBAD03F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.680040 :9DBAD047:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.687852 :9DBAD04F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.695067 :9DBAD057:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.706619 :9DBAD05F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.714064 :9DBAD067:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.719858 :9DBAD06F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.725600 :9DBAD077:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.731391 :9DBAD07F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.736752 :9DBAD087:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.742254 :9DBAD08F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.748308 :9DBAD097:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.753947 :9DBAD09F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.759163 :9DBAD0A7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:02.764820 :9DBAD0AF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:03.529703*:9DBAD284:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x00000000414901B8 estart=1748527202 eid=16791697 ctx=0x0000000783637648 cwh=0x0000000031F30248 cpu=15625 buffg=482 interb=0 r=0 rb=0 w=0 wb=0 2025-05-29 22:00:03.529703*:9DBAD285:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x00000000414901B8 curCtx=0x000000004147EED8 pubTabIdxCnt=0 2025-05-29 22:00:03.529703*:9DBAD286:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x00000000414901B8 2025-05-29 22:00:03.529703*:9DBAD287:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x00000000414901B8 2025-05-29 22:00:03.529703*:9DBAD288:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x00000000301FC288 estart=1748527201 eid=16777282 ctx=0x000000079F654AA8 cwh=0x00000000301F0158 cpu=1781250 buffg=164250 interb=45793280 r=2239 rb=41189376 w=24 wb=4603904 2025-05-29 22:00:03.529703*:9DBAD289:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x00000000301FC288 curCtx=0x000000004147E000 pubTabIdxCnt=0 2025-05-29 22:00:03.529703*:9DBAD28A:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x00000000301FC288 2025-05-29 22:00:03.529703*:9DBAD28B:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x00000000301FC288 2025-05-29 22:00:03.529703*:9DBAD28C:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x00000000414901B8 curCtx=0x000000004147EED8 xsc->flg4=65792 flags=0 2025-05-29 22:00:03.529703*:9DBAD28D:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x00000000414901B8 2025-05-29 22:00:03.587290 :9DBAD29A:db_trace:ktu.c@4871:ktuaex1r(): [10442:30:241] Extension usn 9, ext 2, nex 4 2025-05-29 22:00:03.587298 :9DBAD29B:db_trace:ktusm.c@2117:ktusmasp(): [10445:30:241] des1:tsn:1 rdba:0x0081a1e1 where: kduwh01: kdusru 2025-05-29 22:00:03.661950 :9DBAD2DF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:03.664256 :9DBAD2E7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:03.664467 :9DBAD2EF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:03.669640 :9DBAD2F7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:03.674996 :9DBAD2FF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:03.680181 :9DBAD307:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:03.686408 :9DBAD30F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:03.686685 :9DBAD317:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:03.686685*:9DBAD31A:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x00000000301FC288 curCtx=0x000000004147E000 xsc->flg4=65792 flags=2 2025-05-29 22:00:03.686685*:9DBAD31B:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x00000000301FC288 2025-05-29 22:00:03.686902 :9DBAD321:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:jslv.c:9203 2025-05-29 22:00:03.690784 :9DBAD322:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-29 22:00:03.690836 :9DBAD325:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 30 (osid: 11388, J004)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de