Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250428220007\orcl_j000_10828_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250428220007\orcl_j000_10828_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:37541M/63366M, Ph+PgF:45143M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 26 Windows thread id: 10828, image: ORACLE.EXE (J000) *** 2025-04-28 22:00:07.666 *** SESSION ID:(209.30349) 2025-04-28 22:00:07.666 *** 2025-04-28 22:00:07.666 Process diagnostic dump for ORACLE.EXE (J000), OS id=10828, pid: 26, proc_ser: 88, sid: 209, sess_ser: 30349 ------------------------------------------------------------------------------- current sql: <none> client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 10828 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J000) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=7 seq_num=8 snap_id=1 wait times: snap=0.151010 sec, exc=0.151010 sec, total=0.151010 sec wait times: max=0.500000 sec, heur=3.652248 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.000007 sec since current wait 0: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=6 seq_num=7 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 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=5 seq_num=6 snap_id=1 wait times: snap=0.510106 sec, exc=0.510106 sec, total=0.510106 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=4 seq_num=5 snap_id=1 wait times: snap=0.499995 sec, exc=0.499995 sec, total=0.499995 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000012 sec of elapsed time 3: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=3 seq_num=4 snap_id=1 wait times: snap=0.505096 sec, exc=0.505096 sec, total=0.505096 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 sec of elapsed time 4: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=2 seq_num=3 snap_id=1 wait times: snap=0.499997 sec, exc=0.499997 sec, total=0.499997 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=1 seq_num=2 snap_id=1 wait times: snap=0.499995 sec, exc=0.499995 sec, total=0.499995 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000011 sec of elapsed time 6: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=0 seq_num=1 snap_id=1 wait times: snap=0.485990 sec, exc=0.485990 sec, total=0.485990 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 209 serial 30349 --------------------------------------------------- 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 --------------------------------------------------- [4 samples, 22:00:04 - 22:00:07] idle wait at each sample [session created at: 22:00:04] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-04-28 22:00:07.666 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 26 (osid: 10828, J000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-04-28 21:56:22.204290 :9015E073:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-04-28 21:56:22.205096 :9015E078:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-04-28 21:56:23.195954 :9015E126:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 04-28 21:56:23.185 2025-04-28 21:56:23.195956 :9015E127:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=1192 pso_num=26 pso_serial#=68 2025-04-28 21:56:23.196089 :9015E128:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=1192 (legacy spawn) 2025-04-28 21:56:23.202570 :9015E129:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 21:56:23.202740 :9015E132:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-04-28 21:56:23.203528 :9015E133:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-04-28 21:56:23.212152 :9015E136:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 04-28 21:56:23.200 2025-04-28 21:56:23.212155 :9015E137:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=316 pso_num=26 pso_serial#=69 2025-04-28 21:56:23.212290 :9015E138:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=316 (legacy spawn) 2025-04-28 21:56:23.218733 :9015E139:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 21:56:23.218899 :9015E142:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-04-28 21:56:23.219725 :9015E143:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-04-28 21:56:24.147197 :9015E169:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 04-28 21:56:24.138 2025-04-28 21:56:24.147199 :9015E16A:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=4864 pso_num=26 pso_serial#=70 2025-04-28 21:56:24.147333 :9015E16B:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=4864 (legacy spawn) 2025-04-28 21:56:24.153754 :9015E16C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 21:56:24.153953 :9015E171:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-04-28 21:56:24.154753 :9015E176:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-04-28 21:56:26.330436 :9015E246:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 04-28 21:56:26.317 2025-04-28 21:56:26.330438 :9015E247:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=1112 pso_num=26 pso_serial#=71 2025-04-28 21:56:26.330578 :9015E248:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=1112 (legacy spawn) 2025-04-28 21:56:26.337034 :9015E249:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 21:56:26.337065 :9015E24C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 21:56:26.337235 :9015E24F:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-04-28 21:56:26.338032 :9015E260:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-04-28 21:56:26.346619 :9015E263:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 04-28 21:56:26.333 2025-04-28 21:56:26.346621 :9015E264:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=8620 pso_num=26 pso_serial#=72 2025-04-28 21:56:26.346755 :9015E265:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=8620 (legacy spawn) 2025-04-28 21:56:26.365843 :9015E266:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 21:56:26.366015 :9015E26F:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-04-28 21:56:26.366857 :9015E270:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-04-28 21:56:27.559841 :9015E292:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 04-28 21:56:27.552 2025-04-28 21:56:27.559843 :9015E293:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=10812 pso_num=26 pso_serial#=73 2025-04-28 21:56:27.560025 :9015E294:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=10812 (legacy spawn) 2025-04-28 21:56:27.566400 :9015E295:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 21:56:27.566571 :9015E29E:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-04-28 21:56:27.567380 :9015E29F:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-04-28 21:57:29.744658 :9015F6FF:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 04-28 21:57:29.736 2025-04-28 21:57:29.744660 :9015F700:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=10224 pso_num=26 pso_serial#=74 2025-04-28 21:57:29.744799 :9015F701:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=10224 (legacy spawn) 2025-04-28 21:57:29.751331 :9015F702:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 21:57:29.751505 :9015F70A:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-04-28 21:57:29.752327 :9015F70C:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-04-28 21:57:32.265330 :9015F81B:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 04-28 21:57:32.256 2025-04-28 21:57:32.265332 :9015F81C:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=3232 pso_num=26 pso_serial#=75 2025-04-28 21:57:32.265469 :9015F81D:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=3232 (legacy spawn) 2025-04-28 21:57:32.271940 :9015F81E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 21:57:32.272111 :9015F823:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-04-28 21:57:32.272885 :9015F828:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-04-28 21:57:35.997521 :9015F92C:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 04-28 21:57:35.983 2025-04-28 21:57:35.997523 :9015F92D:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=10796 pso_num=26 pso_serial#=76 2025-04-28 21:57:35.997656 :9015F92E:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=10796 (legacy spawn) 2025-04-28 21:57:36.004040 :9015F92F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 21:57:36.004212 :9015F934:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-04-28 21:57:36.005013 :9015F938:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-04-28 21:57:36.013608 :9015F93B:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 04-28 21:57:35.998 2025-04-28 21:57:36.013610 :9015F93C:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=10620 pso_num=26 pso_serial#=77 2025-04-28 21:57:36.013740 :9015F93D:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=10620 (legacy spawn) 2025-04-28 21:57:36.020182 :9015F93E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 21:57:36.020347 :9015F947:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-04-28 21:57:36.021128 :9015F948:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-04-28 21:57:39.121091 :9015FA37:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 04-28 21:57:39.108 2025-04-28 21:57:39.121093 :9015FA38:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=10120 pso_num=26 pso_serial#=78 2025-04-28 21:57:39.121228 :9015FA39:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=10120 (legacy spawn) 2025-04-28 21:57:39.127644 :9015FA3A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 21:57:39.127818 :9015FA43:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-04-28 21:57:39.128621 :9015FA44:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-04-28 21:57:39.137169 :9015FA47:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 04-28 21:57:39.123 2025-04-28 21:57:39.137171 :9015FA48:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=7940 pso_num=26 pso_serial#=79 2025-04-28 21:57:39.137309 :9015FA49:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=7940 (legacy spawn) 2025-04-28 21:57:39.156439 :9015FA4A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 21:57:39.156615 :9015FA53:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-04-28 21:57:39.157479 :9015FA54:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-04-28 21:58:31.932467 :90160B15:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 04-28 21:58:31.924 2025-04-28 21:58:31.932470 :90160B16:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=9288 pso_num=26 pso_serial#=80 2025-04-28 21:58:31.932603 :90160B17:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=9288 (legacy spawn) 2025-04-28 21:58:31.939023 :90160B18:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 21:58:31.939198 :90160B1D:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-04-28 21:58:31.940024 :90160B22:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-04-28 21:58:32.366145 :90160B9D:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 04-28 21:58:32.361 2025-04-28 21:58:32.366147 :90160B9E:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=3632 pso_num=26 pso_serial#=81 2025-04-28 21:58:32.366287 :90160B9F:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=3632 osp_idx=24 osp_ver=178070 osp_pg=0 (spawn #128381) 2025-04-28 21:58:32.366288 :90160BA0:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-28 21:58:32.366289 :90160BA1:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=242 time=3148301843 2025-04-28 21:58:32.366289 :90160BA2:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-04-28 21:58:32.366289 :90160BA3:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-04-28 21:58:32.366290 :90160BA4:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-04-28 21:58:32.366290 :90160BA5:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-28 21:58:32.366290 :90160BA6:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-28 21:58:32.366801 :90160BA7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-04-28 21:58:32.366851 :90160BAD:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-04-28 21:58:32.386132 :90160BE6:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-04-28 21:58:40.551511 :90160DE8:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 04-28 21:58:40.542 2025-04-28 21:58:40.551513 :90160DE9:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=9900 pso_num=26 pso_serial#=82 2025-04-28 21:58:40.551661 :90160DEA:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=9900 (legacy spawn) 2025-04-28 21:58:40.558326 :90160DEB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 21:58:40.558512 :90160DF0:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-04-28 21:58:40.559387 :90160DF5:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-04-28 21:59:24.908550 :90161D33:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 04-28 21:59:24.894 2025-04-28 21:59:24.908552 :90161D34:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=10252 pso_num=26 pso_serial#=83 2025-04-28 21:59:24.908695 :90161D35:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=10252 (legacy spawn) 2025-04-28 21:59:24.915148 :90161D36:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 21:59:24.915322 :90161D3C:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-04-28 21:59:24.916095 :90161D40:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-04-28 21:59:24.924629 :90161D43:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 04-28 21:59:24.909 2025-04-28 21:59:24.924631 :90161D44:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=10384 pso_num=26 pso_serial#=84 2025-04-28 21:59:24.924762 :90161D45:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=10384 (legacy spawn) 2025-04-28 21:59:24.931281 :90161D46:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 21:59:24.931442 :90161D4E:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-04-28 21:59:24.932251 :90161D50:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-04-28 21:59:28.234295 :90161E4C:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 04-28 21:59:28.226 2025-04-28 21:59:28.234297 :90161E4D:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=10284 pso_num=26 pso_serial#=85 2025-04-28 21:59:28.234430 :90161E4E:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=10284 (legacy spawn) 2025-04-28 21:59:28.240857 :90161E4F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 21:59:28.241029 :90161E54:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-04-28 21:59:28.241829 :90161E59:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-04-28 21:59:28.250410 :90161E6A:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 04-28 21:59:28.242 2025-04-28 21:59:28.250412 :90161E6B:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=9340 pso_num=26 pso_serial#=86 2025-04-28 21:59:28.250544 :90161E6C:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=9340 (legacy spawn) 2025-04-28 21:59:28.256990 :90161E6D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 21:59:28.257156 :90161E76:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-04-28 21:59:28.257976 :90161E77:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-04-28 21:59:34.125136 :9016204B:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 04-28 21:59:34.116 2025-04-28 21:59:34.125138 :9016204C:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=9796 pso_num=26 pso_serial#=87 2025-04-28 21:59:34.125268 :9016204D:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=9796 (legacy spawn) 2025-04-28 21:59:34.131705 :9016204E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 21:59:34.131885 :90162053:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-04-28 21:59:34.132780 :90162058:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-04-28 22:00:01.420186 :90162A20:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 04-28 22:00:01.414 2025-04-28 22:00:01.420188 :90162A21:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=10828 pso_num=26 pso_serial#=88 2025-04-28 22:00:01.420318 :90162A22:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=10828 osp_idx=24 osp_ver=178077 osp_pg=0 (spawn #128386) 2025-04-28 22:00:01.420319 :90162A23:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-28 22:00:01.420319 :90162A24:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=243 time=3148390906 2025-04-28 22:00:01.420320 :90162A25:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-04-28 22:00:01.420320 :90162A26:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-04-28 22:00:01.420320 :90162A27:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-04-28 22:00:01.420321 :90162A28:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-28 22:00:01.420321 :90162A29:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-28 22:00:01.420787 :90162A2A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-04-28 22:00:01.426474 :90162A56:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 22:00:01.426518 :90162A5A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:jslv.c:9203 2025-04-28 22:00:01.437754 :90162AB7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 22:00:01.443722 :90162AF5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 22:00:01.448647 :90162B08:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='kcrf.h LINE:3299 ID:kcrfw_redo_gen: wake LGWR after redo copy' id1=0 id2=0 name= type=0 2025-04-28 22:00:01.449366 :90162B1A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-04-28 22:00:01.449508 :90162B29:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=59 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 22:00:01.450306 :90162B3C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 22:00:01.450505 :90162B44:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:jslv.c:9203 2025-04-28 22:00:01.451981 :90162B91:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 22:00:01.452018 :90162BAE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 2025-04-28 22:00:01.452138 :90162BE7:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-04-28 22:00:01.555801 :90162D9C:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=59 loc='kkj.h LINE:914 ID:kkjpstnp' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-04-28 22:00:01.558122 :90162D9F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 22:00:01.558164 :90162DA2:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:jslv.c:9203 2025-04-28 22:00:01.560570 :90162DA8:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:jslv.c:9203 2025-04-28 22:00:01.563915 :90162DA9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 22:00:01.563995 :90162DAC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 2025-04-28 22:00:01.564092 :90162DB9:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-04-28 22:00:04.011336 :90163369:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=59 loc='kkj.h LINE:914 ID:kkjpstnp' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-04-28 22:00:04.011336*:9016336E:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x00000000271EC718 estart=1745848803 eid=16779455 ctx=0x000000077FD6A000 cwh=0x00000000271E0068 cpu=0 buffg=1 interb=0 r=0 rb=0 w=0 wb=0 2025-04-28 22:00:04.011336*:9016336F:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x00000000271EC718 curCtx=0x00000000271E8938 pubTabIdxCnt=0 2025-04-28 22:00:04.011336*:90163370:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x00000000271EC718 2025-04-28 22:00:04.011336*:90163371:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x00000000271EC718 2025-04-28 22:00:04.011336*:90163372:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x00000000271EC718 curCtx=0x00000000271E8938 xsc->flg4=65792 flags=2 2025-04-28 22:00:04.011336*:90163373:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x00000000271EC718 2025-04-28 22:00:04.013548 :90163374:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 22:00:04.013587 :90163377:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:jslv.c:9203 2025-04-28 22:00:04.020273 :9016337D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 22:00:04.021005 :90163385:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 22:00:04.021725 :9016338D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 22:00:04.021922 :90163395:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:jslv.c:9203 2025-04-28 22:00:04.022361 :90163396:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 22:00:04.023645 :9016339E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-28 22:00:04.023691 :901633A1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 2025-04-28 22:00:04.023783 :901633AD:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 26 (osid: 10828, J000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de