Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250524140111\orcl_j002_14172_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250524140111\orcl_j002_14172_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:37284M/63366M, Ph+PgF:44327M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 28 Windows thread id: 14172, image: ORACLE.EXE (J002) *** 2025-05-24 14:01:11.453 *** SESSION ID:(225.17975) 2025-05-24 14:01:11.453 *** 2025-05-24 14:01:11.453 Process diagnostic dump for ORACLE.EXE (J002), OS id=14172, pid: 28, proc_ser: 167, sid: 225, sess_ser: 17975 ------------------------------------------------------------------------------- current sql: <none> client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 14172 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J002) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=14 seq_num=15 snap_id=1 wait times: snap=0.298382 sec, exc=0.298382 sec, total=0.298382 sec wait times: max=0.500000 sec, heur=7.312938 sec wait counts: calls=1 os=1 in_wait=1 iflags=0x5a8 Wait State: fixed_waits=0 flags=0x22 boundary=0x0000000000000000/-1 Session Wait History: elapsed time of 0.000009 sec since current wait 0: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=13 seq_num=14 snap_id=1 wait times: snap=0.499991 sec, exc=0.499991 sec, total=0.499991 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 sec of elapsed time 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=12 seq_num=13 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.000009 sec of elapsed time 2: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=11 seq_num=12 snap_id=1 wait times: snap=0.500190 sec, exc=0.500190 sec, total=0.500190 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000010 sec of elapsed time 3: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=10 seq_num=11 snap_id=1 wait times: snap=0.499989 sec, exc=0.499989 sec, total=0.499989 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000015 sec of elapsed time 4: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=9 seq_num=10 snap_id=1 wait times: snap=0.500146 sec, exc=0.500146 sec, total=0.500146 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 5: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=8 seq_num=9 snap_id=1 wait times: snap=0.510093 sec, exc=0.510093 sec, total=0.510093 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 6: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=7 seq_num=8 snap_id=1 wait times: snap=0.499996 sec, exc=0.499996 sec, total=0.499996 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 sec of elapsed time 7: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=6 seq_num=7 snap_id=1 wait times: snap=0.499993 sec, exc=0.499993 sec, total=0.499993 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000011 sec of elapsed time 8: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=5 seq_num=6 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.000007 sec of elapsed time 9: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=4 seq_num=5 snap_id=1 wait times: snap=0.499991 sec, exc=0.499991 sec, total=0.499991 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 sec of elapsed time Sampled Session History of session 225 serial 17975 --------------------------------------------------- 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 --------------------------------------------------- [8 samples, 14:01:04 - 14:01:11] idle wait at each sample [session created at: 14:01:04] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-05-24 14:01:11.453 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 28 (osid: 14172, J002) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-24 13:57:43.585078 :9B63A766:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-24 13:57:43.585908 :9B63A767:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-05-24 13:57:44.363686 :9B63A781:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 05-24 13:57:44.355 2025-05-24 13:57:44.363688 :9B63A782:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=11856 pso_num=28 pso_serial#=148 2025-05-24 13:57:44.363823 :9B63A783:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=11856 (legacy spawn) 2025-05-24 13:57:44.370315 :9B63A784:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 13:57:44.370497 :9B63A789:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-24 13:57:44.371298 :9B63A78E:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-05-24 13:58:03.133558 :9B63AD1B:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 05-24 13:58:03.121 2025-05-24 13:58:03.133560 :9B63AD1C:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=12976 pso_num=28 pso_serial#=149 2025-05-24 13:58:03.133697 :9B63AD1D:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=12976 (legacy spawn) 2025-05-24 13:58:03.140205 :9B63AD1E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 13:58:03.140389 :9B63AD23:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-24 13:58:03.141233 :9B63AD28:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-05-24 13:58:48.826826 :9B63BC4B:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 05-24 13:58:48.812 2025-05-24 13:58:48.826828 :9B63BC4C:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=11912 pso_num=28 pso_serial#=150 2025-05-24 13:58:48.826962 :9B63BC4D:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=11912 (legacy spawn) 2025-05-24 13:58:48.833409 :9B63BC4E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 13:58:48.833588 :9B63BC57:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-24 13:58:48.834388 :9B63BC58:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-05-24 13:58:48.843075 :9B63BC5B:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 05-24 13:58:48.828 2025-05-24 13:58:48.843077 :9B63BC5C:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=13628 pso_num=28 pso_serial#=151 2025-05-24 13:58:48.843217 :9B63BC5D:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=13628 (legacy spawn) 2025-05-24 13:58:48.849652 :9B63BC5E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 13:58:48.849817 :9B63BC67:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-24 13:58:48.850636 :9B63BC68:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-05-24 13:58:52.048150 :9B63BD60:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 05-24 13:58:52.035 2025-05-24 13:58:52.048153 :9B63BD61:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=10416 pso_num=28 pso_serial#=152 2025-05-24 13:58:52.048296 :9B63BD62:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=10416 (legacy spawn) 2025-05-24 13:58:52.054767 :9B63BD63:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 13:58:52.054935 :9B63BD68:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-24 13:58:52.055768 :9B63BD6D:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-05-24 13:58:52.064350 :9B63BD70:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 05-24 13:58:52.050 2025-05-24 13:58:52.064352 :9B63BD71:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=13080 pso_num=28 pso_serial#=153 2025-05-24 13:58:52.064485 :9B63BD72:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=13080 (legacy spawn) 2025-05-24 13:58:52.071187 :9B63BD73:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 13:58:52.071354 :9B63BD7C:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-24 13:58:52.072149 :9B63BD7D:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-05-24 13:58:52.465623 :9B63BD80:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 05-24 13:58:52.456 2025-05-24 13:58:52.465625 :9B63BD81:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=12400 pso_num=28 pso_serial#=154 2025-05-24 13:58:52.465760 :9B63BD82:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=12400 (legacy spawn) 2025-05-24 13:58:52.472108 :9B63BD83:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 13:58:52.472275 :9B63BD8C:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-24 13:58:52.473154 :9B63BD8D:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-05-24 13:59:05.328896 :9B63C177:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 05-24 13:59:05.316 2025-05-24 13:59:05.328898 :9B63C178:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=14216 pso_num=28 pso_serial#=155 2025-05-24 13:59:05.329079 :9B63C179:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=14216 (legacy spawn) 2025-05-24 13:59:05.335559 :9B63C17A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 13:59:05.335738 :9B63C17F:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-24 13:59:05.336587 :9B63C184:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-05-24 13:59:36.444013 :9B63CBCF:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 05-24 13:59:36.435 2025-05-24 13:59:36.444015 :9B63CBD0:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=6832 pso_num=28 pso_serial#=156 2025-05-24 13:59:36.444153 :9B63CBD1:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=6832 (legacy spawn) 2025-05-24 13:59:36.450635 :9B63CBD2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 13:59:36.450802 :9B63CBDB:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-24 13:59:36.451621 :9B63CBDC:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-05-24 14:00:00.803920 :9B63D369:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 05-24 14:00:00.790 2025-05-24 14:00:00.803921 :9B63D36A:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=6428 pso_num=28 pso_serial#=157 2025-05-24 14:00:00.804054 :9B63D36B:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=6428 (legacy spawn) 2025-05-24 14:00:00.810541 :9B63D36C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 14:00:00.810726 :9B63D374:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-24 14:00:00.811549 :9B63D376:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-05-24 14:00:01.460343 :9B63D3B6:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 05-24 14:00:01.446 2025-05-24 14:00:01.460345 :9B63D3B7:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=13436 pso_num=28 pso_serial#=158 2025-05-24 14:00:01.460478 :9B63D3B8:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=13436 (legacy spawn) 2025-05-24 14:00:01.466901 :9B63D3B9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 14:00:01.467071 :9B63D3BE:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-24 14:00:01.467850 :9B63D3C3:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-05-24 14:00:01.476633 :9B63D3C6:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 05-24 14:00:01.462 2025-05-24 14:00:01.476636 :9B63D3C7:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=12328 pso_num=28 pso_serial#=159 2025-05-24 14:00:01.476778 :9B63D3C8:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=12328 (legacy spawn) 2025-05-24 14:00:01.483290 :9B63D3C9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 14:00:01.483454 :9B63D3D1:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-24 14:00:01.484279 :9B63D3D2:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-05-24 14:00:03.827227 :9B63D4B9:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 05-24 14:00:03.822 2025-05-24 14:00:03.827229 :9B63D4BA:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=12604 pso_num=28 pso_serial#=160 2025-05-24 14:00:03.827368 :9B63D4BB:db_trace:kso.c@4093:ksonfy(): [10420:28:0] kso: new process: pid=12604 osp_idx=26 osp_ver=139898 osp_pg=0 (spawn #214725) 2025-05-24 14:00:03.827368 :9B63D4BC:db_trace:kso.c@4099:ksonfy(): [10420:28:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-24 14:00:03.827369 :9B63D4BD:db_trace:kso.c@4103:ksonfy(): [10420:28:0] kso: new process: pso_index=28 reservation=73 time=1070976079 2025-05-24 14:00:03.827369 :9B63D4BE:db_trace:kso.c@4109:ksonfy(): [10420:28:0] kso: spawn diagnostics: queue time=0 secs 2025-05-24 14:00:03.827369 :9B63D4BF:db_trace:kso.c@4111:ksonfy(): [10420:28:0] kso: spawn diagnostics: fork time=0 secs 2025-05-24 14:00:03.827370 :9B63D4C0:db_trace:kso.c@4113:ksonfy(): [10420:28:0] kso: spawn diagnostics: exec time=0 secs 2025-05-24 14:00:03.827370 :9B63D4C1:db_trace:kso.c@4115:ksonfy(): [10420:28:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-24 14:00:03.827371 :9B63D4C2:db_trace:kso.c@4117:ksonfy(): [10420:28:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-24 14:00:03.827888 :9B63D4C3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-24 14:00:03.827935 :9B63D4C9:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-24 14:00:03.832286 :9B63D4DC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 14:00:03.854812 :9B63D4E4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 14:00:03.866726 :9B63D4EC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 14:00:03.866739 :9B63D4ED:db_trace:ktur.c@3079:ktuabt(): [10444:28:225] ABORT TRANSACTION - xid: 0x0005.009.0000c194 2025-05-24 14:00:03.867328 :9B63D4F5:db_trace:ktu.c@4871:ktuaex1r(): [10442:28:225] Extension usn 5, ext 2, nex 4 2025-05-24 14:00:03.867334 :9B63D4F6:db_trace:ktusm.c@2117:ktusmasp(): [10445:28:225] des1:tsn:1 rdba:0x00812d1e where: kdiwh133: kdisdelete 2025-05-24 14:00:03.869703 :9B63D4F7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 14:00:03.897445 :9B63D4FF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 14:00:03.901217 :9B63D507:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 14:00:03.904907 :9B63D50F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 14:00:03.909015 :9B63D517:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 14:00:03.910101 :9B63D51F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 14:00:05.147966*:9B63D57B:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x00000000290F3670 estart=1748066404 eid=16778706 ctx=0x0000000787AA9BF0 cwh=0x00000000290E07D0 cpu=15625 buffg=8 interb=0 r=0 rb=0 w=0 wb=0 2025-05-24 14:00:05.147966*:9B63D57C:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x00000000290F3670 curCtx=0x00000000292BAF18 pubTabIdxCnt=0 2025-05-24 14:00:05.147966*:9B63D57D:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x00000000290F3670 2025-05-24 14:00:05.147966*:9B63D57E:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x00000000290F3670 2025-05-24 14:00:05.147966*:9B63D57F:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x00000000290F3670 curCtx=0x00000000292BAF18 xsc->flg4=65792 flags=2 2025-05-24 14:00:05.147966*:9B63D580:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x00000000290F3670 2025-05-24 14:00:05.155083 :9B63D581:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 14:00:05.182776 :9B63D589:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 14:00:05.183106 :9B63D591:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 14:00:05.183371 :9B63D599:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 14:00:05.183387 :9B63D59C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=18 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 14:00:05.183456 :9B63D5AC:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-24 14:00:05.186983 :9B63D5B6:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-05-24 14:00:37.842033 :9B63E253:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 05-24 14:00:37.827 2025-05-24 14:00:37.842034 :9B63E254:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=11800 pso_num=28 pso_serial#=161 2025-05-24 14:00:37.842167 :9B63E255:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=11800 (legacy spawn) 2025-05-24 14:00:37.848613 :9B63E256:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 14:00:37.848799 :9B63E25B:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-24 14:00:37.849663 :9B63E260:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-05-24 14:00:37.858354 :9B63E263:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 05-24 14:00:37.843 2025-05-24 14:00:37.858356 :9B63E264:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=11376 pso_num=28 pso_serial#=162 2025-05-24 14:00:37.858495 :9B63E265:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=11376 (legacy spawn) 2025-05-24 14:00:37.865056 :9B63E266:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 14:00:37.865219 :9B63E26F:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-24 14:00:37.866025 :9B63E270:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-05-24 14:00:38.633218 :9B63E2B3:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 05-24 14:00:38.624 2025-05-24 14:00:38.633220 :9B63E2B4:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=9412 pso_num=28 pso_serial#=163 2025-05-24 14:00:38.633365 :9B63E2B5:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=9412 (legacy spawn) 2025-05-24 14:00:38.640205 :9B63E2B6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 14:00:38.640378 :9B63E2BB:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-24 14:00:38.641267 :9B63E2C0:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-05-24 14:00:40.929720 :9B63E36D:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 05-24 14:00:40.921 2025-05-24 14:00:40.929722 :9B63E36E:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=12720 pso_num=28 pso_serial#=164 2025-05-24 14:00:40.929862 :9B63E36F:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=12720 (legacy spawn) 2025-05-24 14:00:40.936335 :9B63E370:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 14:00:40.936507 :9B63E375:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-24 14:00:40.937379 :9B63E37A:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-05-24 14:00:40.945967 :9B63E37D:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 05-24 14:00:40.937 2025-05-24 14:00:40.945969 :9B63E37E:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=10584 pso_num=28 pso_serial#=165 2025-05-24 14:00:40.946111 :9B63E37F:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=10584 (legacy spawn) 2025-05-24 14:00:40.952578 :9B63E394:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-24 14:00:40.952730 :9B63E39D:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-24 14:00:40.953601 :9B63E3B2:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-05-24 14:01:03.938554 :9B63EAC2:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 05-24 14:01:03.933 2025-05-24 14:01:03.938556 :9B63EAC3:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=10972 pso_num=28 pso_serial#=166 2025-05-24 14:01:03.938688 :9B63EAC4:db_trace:kso.c@4093:ksonfy(): [10420:28:0] kso: new process: pid=10972 osp_idx=26 osp_ver=139904 osp_pg=0 (spawn #214729) 2025-05-24 14:01:03.938689 :9B63EAC5:db_trace:kso.c@4099:ksonfy(): [10420:28:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-24 14:01:03.938689 :9B63EAC6:db_trace:kso.c@4103:ksonfy(): [10420:28:0] kso: new process: pso_index=28 reservation=74 time=1071036188 2025-05-24 14:01:03.938690 :9B63EAC7:db_trace:kso.c@4109:ksonfy(): [10420:28:0] kso: spawn diagnostics: queue time=0 secs 2025-05-24 14:01:03.938690 :9B63EAC8:db_trace:kso.c@4111:ksonfy(): [10420:28:0] kso: spawn diagnostics: fork time=0 secs 2025-05-24 14:01:03.938690 :9B63EAC9:db_trace:kso.c@4113:ksonfy(): [10420:28:0] kso: spawn diagnostics: exec time=0 secs 2025-05-24 14:01:03.938691 :9B63EACA:db_trace:kso.c@4115:ksonfy(): [10420:28:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-24 14:01:03.938691 :9B63EACB:db_trace:kso.c@4117:ksonfy(): [10420:28:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-24 14:01:03.939189 :9B63EACC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-24 14:01:03.939238 :9B63EAD2:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-24 14:01:03.943371 :9B63EAE9:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:kelt.c:517 2025-05-24 14:01:03.943423 :9B63EAEA:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:kelt.c:517 2025-05-24 14:01:03.943758 :9B63EAEB:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:kelt.c:517 2025-05-24 14:01:03.943775 :9B63EAEC:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:kelt.c:517 2025-05-24 14:01:03.943996 :9B63EAED:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:kelt.c:517 2025-05-24 14:01:03.944009 :9B63EAEE:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:kelt.c:517 2025-05-24 14:01:03.944227 :9B63EAEF:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:kelt.c:517 2025-05-24 14:01:03.944240 :9B63EAF0:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:kelt.c:517 2025-05-24 14:01:03.944453 :9B63EAF1:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:kelt.c:517 2025-05-24 14:01:03.944465 :9B63EAF2:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:kelt.c:517 2025-05-24 14:01:03.944681 :9B63EAF3:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:kelt.c:517 2025-05-24 14:01:03.944695 :9B63EAF4:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:kelt.c:517 2025-05-24 14:01:03.947150 :9B63EB19:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-05-24 14:01:04.141410 :9B63EF63:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 05-24 14:01:04.136 2025-05-24 14:01:04.141411 :9B63EF64:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=14172 pso_num=28 pso_serial#=167 2025-05-24 14:01:04.141609 :9B63EF65:db_trace:kso.c@4093:ksonfy(): [10420:28:0] kso: new process: pid=14172 osp_idx=26 osp_ver=139905 osp_pg=0 (spawn #214732) 2025-05-24 14:01:04.141610 :9B63EF66:db_trace:kso.c@4099:ksonfy(): [10420:28:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-24 14:01:04.141610 :9B63EF67:db_trace:kso.c@4103:ksonfy(): [10420:28:0] kso: new process: pso_index=28 reservation=75 time=1071036391 2025-05-24 14:01:04.141611 :9B63EF68:db_trace:kso.c@4109:ksonfy(): [10420:28:0] kso: spawn diagnostics: queue time=0 secs 2025-05-24 14:01:04.141612 :9B63EF69:db_trace:kso.c@4111:ksonfy(): [10420:28:0] kso: spawn diagnostics: fork time=0 secs 2025-05-24 14:01:04.141612 :9B63EF6A:db_trace:kso.c@4113:ksonfy(): [10420:28:0] kso: spawn diagnostics: exec time=0 secs 2025-05-24 14:01:04.141612 :9B63EF6B:db_trace:kso.c@4115:ksonfy(): [10420:28:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-24 14:01:04.141613 :9B63EF6C:db_trace:kso.c@4117:ksonfy(): [10420:28:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-24 14:01:04.142112 :9B63EF73:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 28 (osid: 14172, J002)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de