Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250815220521\orcl_j001_3328_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250815220521\orcl_j001_3328_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:35490M/63366M, Ph+PgF:40809M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 27 Windows thread id: 3328, image: ORACLE.EXE (J001) *** 2025-08-15 22:05:21.193 *** SESSION ID:(219.57557) 2025-08-15 22:05:21.193 *** 2025-08-15 22:05:21.193 Process diagnostic dump for ORACLE.EXE (J001), OS id=3328, pid: 27, proc_ser: 239, sid: 219, sess_ser: 57557 ------------------------------------------------------------------------------- current sql: <none> client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 3328 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J001) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=32 seq_num=33 snap_id=1 wait times: snap=0.110754 sec, exc=0.110754 sec, total=0.110754 sec wait times: max=0.500000 sec, heur=16.174437 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.000010 sec since current wait 0: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=31 seq_num=32 snap_id=1 wait times: snap=0.512348 sec, exc=0.512348 sec, total=0.512348 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=30 seq_num=31 snap_id=1 wait times: snap=0.499992 sec, exc=0.499992 sec, total=0.499992 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000011 sec of elapsed time 2: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=29 seq_num=30 snap_id=1 wait times: snap=0.499999 sec, exc=0.499999 sec, total=0.499999 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000011 sec of elapsed time 3: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=28 seq_num=29 snap_id=1 wait times: snap=0.499998 sec, exc=0.499998 sec, total=0.499998 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=27 seq_num=28 snap_id=1 wait times: snap=0.499992 sec, exc=0.499992 sec, total=0.499992 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000010 sec of elapsed time 5: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=26 seq_num=27 snap_id=1 wait times: snap=0.499999 sec, exc=0.499999 sec, total=0.499999 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000012 sec of elapsed time 6: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=25 seq_num=26 snap_id=1 wait times: snap=0.500158 sec, exc=0.500158 sec, total=0.500158 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 7: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=24 seq_num=25 snap_id=1 wait times: snap=0.499994 sec, exc=0.499994 sec, total=0.499994 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 sec of elapsed time 8: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=23 seq_num=24 snap_id=1 wait times: snap=0.512713 sec, exc=0.512713 sec, total=0.512713 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 sec of elapsed time 9: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=22 seq_num=23 snap_id=1 wait times: snap=0.499999 sec, exc=0.499999 sec, total=0.499999 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000007 sec of elapsed time Sampled Session History of session 219 serial 57557 --------------------------------------------------- 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 --------------------------------------------------- [17 samples, 22:05:05 - 22:05:21] idle wait at each sample [session created at: 22:05:05] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-08-15 22:05:21.193 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 27 (osid: 3328, J001) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-08-15 21:58:27.840307 :C0385E01:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-08-15 21:58:27.841120 :C0385E06:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-15 21:58:28.209016 :C0385E42:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-15 21:58:28.196 2025-08-15 21:58:28.209018 :C0385E43:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=20816 pso_num=27 pso_serial#=229 2025-08-15 21:58:28.209147 :C0385E44:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=20816 (legacy spawn) 2025-08-15 21:58:28.215577 :C0385E45:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 21:58:28.215745 :C0385E4A:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-08-15 21:58:28.216535 :C0385E4F:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-15 21:58:28.225294 :C0385E52:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-15 21:58:28.211 2025-08-15 21:58:28.225295 :C0385E53:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=20804 pso_num=27 pso_serial#=230 2025-08-15 21:58:28.225432 :C0385E54:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=20804 (legacy spawn) 2025-08-15 21:58:28.231963 :C0385E55:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 21:58:28.232126 :C0385E5E:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-08-15 21:58:28.232991 :C0385E5F:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-15 21:59:04.566162 :C0386A16:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-15 21:59:04.553 2025-08-15 21:59:04.566164 :C0386A17:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=20908 pso_num=27 pso_serial#=231 2025-08-15 21:59:04.566297 :C0386A18:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=20908 (legacy spawn) 2025-08-15 21:59:04.572816 :C0386A19:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 21:59:04.573009 :C0386A21:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-08-15 21:59:04.573840 :C0386A23:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-15 21:59:04.924984 :C0386A4B:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-15 21:59:04.912 2025-08-15 21:59:04.924986 :C0386A4C:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=20028 pso_num=27 pso_serial#=232 2025-08-15 21:59:04.925127 :C0386A4D:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=20028 (legacy spawn) 2025-08-15 21:59:04.931681 :C0386A59:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 21:59:04.931856 :C0386A62:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-08-15 21:59:04.932648 :C0386A63:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-15 21:59:28.972111 :C03871BF:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-15 21:59:28.959 2025-08-15 21:59:28.972113 :C03871C0:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=8140 pso_num=27 pso_serial#=233 2025-08-15 21:59:28.972248 :C03871C1:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=8140 (legacy spawn) 2025-08-15 21:59:28.978667 :C03871CD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 21:59:28.978839 :C03871D2:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-08-15 21:59:28.979608 :C03871D7:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-15 22:00:02.057005 :C0387E0E:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-15 22:00:02.046 2025-08-15 22:00:02.057007 :C0387E0F:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=18812 pso_num=27 pso_serial#=234 2025-08-15 22:00:02.057137 :C0387E10:db_trace:kso.c@4093:ksonfy(): [10420:27:0] kso: new process: pid=18812 osp_idx=25 osp_ver=290687 osp_pg=0 (spawn #492471) 2025-08-15 22:00:02.057137 :C0387E11:db_trace:kso.c@4099:ksonfy(): [10420:27:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-15 22:00:02.057138 :C0387E12:db_trace:kso.c@4103:ksonfy(): [10420:27:0] kso: new process: pso_index=27 reservation=60 time=3975871361 2025-08-15 22:00:02.057138 :C0387E13:db_trace:kso.c@4109:ksonfy(): [10420:27:0] kso: spawn diagnostics: queue time=0 secs 2025-08-15 22:00:02.057139 :C0387E14:db_trace:kso.c@4111:ksonfy(): [10420:27:0] kso: spawn diagnostics: fork time=0 secs 2025-08-15 22:00:02.057139 :C0387E15:db_trace:kso.c@4113:ksonfy(): [10420:27:0] kso: spawn diagnostics: exec time=0 secs 2025-08-15 22:00:02.057139 :C0387E16:db_trace:kso.c@4115:ksonfy(): [10420:27:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-15 22:00:02.057140 :C0387E17:db_trace:kso.c@4117:ksonfy(): [10420:27:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-15 22:00:02.057625 :C0387E1B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-15 22:00:02.062641 :C0387E49:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:02.062690 :C0387E4E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:jslv.c:9203 2025-08-15 22:00:02.066080 :C0387E71:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:02.449301 :C03881FA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:02.493341 :C0388216:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:02.509154 :C038821E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:02.567262 :C0388226:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:02.700567 :C0388236:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:02.817757 :C038823E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:02.828935 :C0388246:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:02.846604 :C038824E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:02.864047 :C0388256:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:02.882671 :C038825E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:02.893611 :C0388266:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:02.910249 :C038826E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:02.920240 :C0388276:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:02.936491 :C038827E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:02.946991 :C0388286:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:02.956905 :C038828E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:02.972745 :C0388296:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:02.982534 :C038829E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:02.998721 :C03882A6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:03.014777 :C03882AE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:03.030513 :C03882B6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:03.046303 :C03882BE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:03.056227 :C03882C6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:03.072058 :C03882CE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:03.081441 :C03882D6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:03.091680 :C03882DE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:03.107926 :C03882E6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:03.116742 :C03882EE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:03.132343 :C03882F6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:03.139455 :C03882FE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:03.148660 :C0388306:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:03.159059 :C038830E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:03.175579 :C0388316:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:03.191810 :C038831E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:03.202828 :C0388326:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:03.219348 :C038832E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:03.236063 :C0388336:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:03.245631 :C038833E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:03.258237 :C0388346:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:03.273803 :C038834E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:03.284066 :C0388356:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:03.293837 :C038835E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:03.303750 :C0388366:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:03.313805 :C038836E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:03.330112 :C0388376:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:03.337663 :C0388389:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:03.345336 :C0388391:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:03.352814 :C0388399:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:03.361219 :C03883A1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:03.369571 :C03883A9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:03.377860 :C03883B1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:03.386245 :C03883B9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:03.394515 :C03883C1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:03.402893 :C03883C9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:03.415416*:C03883DB:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000002B516918 estart=1755266402 eid=16777505 ctx=0x00000007831EA738 cwh=0x000000002B540248 cpu=15625 buffg=272 interb=114688 r=7 rb=114688 w=0 wb=0 2025-08-15 22:00:03.415416*:C03883DC:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000002B516918 curCtx=0x0000000057461CD0 pubTabIdxCnt=0 2025-08-15 22:00:03.415416*:C03883DD:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000002B516918 2025-08-15 22:00:03.415416*:C03883DE:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000002B516918 2025-08-15 22:00:03.415416*:C03883DF:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000028FFC288 estart=1755266401 eid=16777360 ctx=0x000000079F654AA8 cwh=0x0000000028FF0158 cpu=1312500 buffg=88342 interb=28016640 r=1431 rb=25706496 w=12 wb=2310144 2025-08-15 22:00:03.415416*:C03883E0:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000028FFC288 curCtx=0x0000000057484F98 pubTabIdxCnt=0 2025-08-15 22:00:03.415416*:C03883E1:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000028FFC288 2025-08-15 22:00:03.415416*:C03883E2:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000028FFC288 2025-08-15 22:00:03.962289*:C038856E:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000002B516918 curCtx=0x0000000057461CD0 xsc->flg4=65792 flags=1 2025-08-15 22:00:03.962289*:C038856F:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000002B516918 2025-08-15 22:00:04.562275 :C0388685:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:04.562732 :C038868D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:04.562732*:C0388695:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000028FFC288 curCtx=0x0000000057484F98 xsc->flg4=65792 flags=2 2025-08-15 22:00:04.562732*:C0388696:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000028FFC288 2025-08-15 22:00:04.562987 :C0388697:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:jslv.c:9203 2025-08-15 22:00:04.567374 :C03886B2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:00:04.567456 :C03886B5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 2025-08-15 22:00:34.651598 :C0389547:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-15 22:01:04.658400 :C0389F2F:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-15 22:01:04.646 2025-08-15 22:01:04.658402 :C0389F30:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=4764 pso_num=27 pso_serial#=235 2025-08-15 22:01:04.658523 :C0389F31:db_trace:kso.c@4093:ksonfy(): [10420:27:0] kso: new process: pid=4764 osp_idx=25 osp_ver=290688 osp_pg=0 (spawn #492481) 2025-08-15 22:01:04.658524 :C0389F32:db_trace:kso.c@4099:ksonfy(): [10420:27:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-15 22:01:04.658524 :C0389F33:db_trace:kso.c@4103:ksonfy(): [10420:27:0] kso: new process: pso_index=27 reservation=61 time=3975933954 2025-08-15 22:01:04.658524 :C0389F34:db_trace:kso.c@4109:ksonfy(): [10420:27:0] kso: spawn diagnostics: queue time=0 secs 2025-08-15 22:01:04.658525 :C0389F35:db_trace:kso.c@4111:ksonfy(): [10420:27:0] kso: spawn diagnostics: fork time=0 secs 2025-08-15 22:01:04.658525 :C0389F36:db_trace:kso.c@4113:ksonfy(): [10420:27:0] kso: spawn diagnostics: exec time=0 secs 2025-08-15 22:01:04.658525 :C0389F37:db_trace:kso.c@4115:ksonfy(): [10420:27:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-15 22:01:04.658526 :C0389F38:db_trace:kso.c@4117:ksonfy(): [10420:27:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-15 22:01:04.659037 :C0389F39:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-15 22:01:19.665896 :C038A432:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] KSL POST RCVD poster=59 loc='kkj.h LINE:914 ID:kkjpstnp' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-15 22:01:19.665928*:C038A433:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000028FEBB58 estart=1755266479 eid=17007974 ctx=0x000000077BD98A08 cwh=0x0000000027AC01B0 cpu=0 buffg=1 interb=0 r=0 rb=0 w=0 wb=0 2025-08-15 22:01:19.665928*:C038A434:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000028FEBB58 curCtx=0x0000000027ACF708 pubTabIdxCnt=0 2025-08-15 22:01:19.665928*:C038A435:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000028FEBB58 2025-08-15 22:01:19.665928*:C038A436:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000028FEBB58 2025-08-15 22:01:19.665928*:C038A437:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000028FEBB58 curCtx=0x0000000027ACF708 xsc->flg4=65792 flags=2 2025-08-15 22:01:19.665928*:C038A438:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000028FEBB58 2025-08-15 22:01:19.666512 :C038A439:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:01:19.672012 :C038A441:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:01:19.673016 :C038A449:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 22:01:19.673170 :C038A452:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-08-15 22:01:49.776425 :C038ADAE:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-15 22:02:04.736464 :C038B2B4:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-15 22:02:04.725 2025-08-15 22:02:04.736465 :C038B2B5:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=20260 pso_num=27 pso_serial#=236 2025-08-15 22:02:04.736580 :C038B2B6:db_trace:kso.c@4093:ksonfy(): [10420:27:0] kso: new process: pid=20260 osp_idx=25 osp_ver=290689 osp_pg=0 (spawn #492483) 2025-08-15 22:02:04.736581 :C038B2B7:db_trace:kso.c@4099:ksonfy(): [10420:27:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-15 22:02:04.736581 :C038B2B8:db_trace:kso.c@4103:ksonfy(): [10420:27:0] kso: new process: pso_index=27 reservation=62 time=3975994033 2025-08-15 22:02:04.736582 :C038B2B9:db_trace:kso.c@4109:ksonfy(): [10420:27:0] kso: spawn diagnostics: queue time=0 secs 2025-08-15 22:02:04.736582 :C038B2BA:db_trace:kso.c@4111:ksonfy(): [10420:27:0] kso: spawn diagnostics: fork time=0 secs 2025-08-15 22:02:04.736582 :C038B2BB:db_trace:kso.c@4113:ksonfy(): [10420:27:0] kso: spawn diagnostics: exec time=0 secs 2025-08-15 22:02:04.736583 :C038B2BC:db_trace:kso.c@4115:ksonfy(): [10420:27:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-15 22:02:04.736583 :C038B2BD:db_trace:kso.c@4117:ksonfy(): [10420:27:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-15 22:02:04.737128 :C038B2BE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-15 22:02:34.796620 :C038BC3D:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-15 22:03:04.821993 :C038C61D:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-15 22:03:04.811 2025-08-15 22:03:04.821994 :C038C61E:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=20968 pso_num=27 pso_serial#=237 2025-08-15 22:03:04.822120 :C038C61F:db_trace:kso.c@4093:ksonfy(): [10420:27:0] kso: new process: pid=20968 osp_idx=25 osp_ver=290690 osp_pg=0 (spawn #492485) 2025-08-15 22:03:04.822121 :C038C620:db_trace:kso.c@4099:ksonfy(): [10420:27:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-15 22:03:04.822121 :C038C621:db_trace:kso.c@4103:ksonfy(): [10420:27:0] kso: new process: pso_index=27 reservation=63 time=3976054126 2025-08-15 22:03:04.822122 :C038C622:db_trace:kso.c@4109:ksonfy(): [10420:27:0] kso: spawn diagnostics: queue time=0 secs 2025-08-15 22:03:04.822122 :C038C623:db_trace:kso.c@4111:ksonfy(): [10420:27:0] kso: spawn diagnostics: fork time=0 secs 2025-08-15 22:03:04.822122 :C038C624:db_trace:kso.c@4113:ksonfy(): [10420:27:0] kso: spawn diagnostics: exec time=0 secs 2025-08-15 22:03:04.822123 :C038C625:db_trace:kso.c@4115:ksonfy(): [10420:27:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-15 22:03:04.822123 :C038C626:db_trace:kso.c@4117:ksonfy(): [10420:27:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-15 22:03:04.822601 :C038C627:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-15 22:03:34.910970 :C038CFE0:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-15 22:04:04.931143 :C038D98A:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-15 22:04:04.920 2025-08-15 22:04:04.931145 :C038D98B:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=19176 pso_num=27 pso_serial#=238 2025-08-15 22:04:04.931257 :C038D98C:db_trace:kso.c@4093:ksonfy(): [10420:27:0] kso: new process: pid=19176 osp_idx=25 osp_ver=290691 osp_pg=0 (spawn #492487) 2025-08-15 22:04:04.931258 :C038D98D:db_trace:kso.c@4099:ksonfy(): [10420:27:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-15 22:04:04.931258 :C038D98E:db_trace:kso.c@4103:ksonfy(): [10420:27:0] kso: new process: pso_index=27 reservation=64 time=3976114236 2025-08-15 22:04:04.931258 :C038D98F:db_trace:kso.c@4109:ksonfy(): [10420:27:0] kso: spawn diagnostics: queue time=0 secs 2025-08-15 22:04:04.931259 :C038D990:db_trace:kso.c@4111:ksonfy(): [10420:27:0] kso: spawn diagnostics: fork time=0 secs 2025-08-15 22:04:04.931259 :C038D991:db_trace:kso.c@4113:ksonfy(): [10420:27:0] kso: spawn diagnostics: exec time=0 secs 2025-08-15 22:04:04.931259 :C038D992:db_trace:kso.c@4115:ksonfy(): [10420:27:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-15 22:04:04.931259 :C038D993:db_trace:kso.c@4117:ksonfy(): [10420:27:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-15 22:04:04.931783 :C038D994:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-15 22:04:34.989651 :C038E33A:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-15 22:05:05.018745 :C038ED02:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-15 22:05:05.007 2025-08-15 22:05:05.018747 :C038ED03:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=3328 pso_num=27 pso_serial#=239 2025-08-15 22:05:05.018875 :C038ED04:db_trace:kso.c@4093:ksonfy(): [10420:27:0] kso: new process: pid=3328 osp_idx=25 osp_ver=290692 osp_pg=0 (spawn #492489) 2025-08-15 22:05:05.018876 :C038ED05:db_trace:kso.c@4099:ksonfy(): [10420:27:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-15 22:05:05.018876 :C038ED06:db_trace:kso.c@4103:ksonfy(): [10420:27:0] kso: new process: pso_index=27 reservation=65 time=3976174314 2025-08-15 22:05:05.018877 :C038ED07:db_trace:kso.c@4109:ksonfy(): [10420:27:0] kso: spawn diagnostics: queue time=0 secs 2025-08-15 22:05:05.018877 :C038ED08:db_trace:kso.c@4111:ksonfy(): [10420:27:0] kso: spawn diagnostics: fork time=0 secs 2025-08-15 22:05:05.018878 :C038ED09:db_trace:kso.c@4113:ksonfy(): [10420:27:0] kso: spawn diagnostics: exec time=0 secs 2025-08-15 22:05:05.018878 :C038ED0A:db_trace:kso.c@4115:ksonfy(): [10420:27:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-15 22:05:05.018879 :C038ED0B:db_trace:kso.c@4117:ksonfy(): [10420:27:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-15 22:05:05.019363 :C038ED0C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] 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 27 (osid: 3328, J001)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de