Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250716220009\orcl_j000_17148_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250716220009\orcl_j000_17148_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:36286M/63366M, Ph+PgF:42258M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 24 Windows thread id: 17148, image: ORACLE.EXE (J000) *** 2025-07-16 22:00:09.844 *** SESSION ID:(193.20121) 2025-07-16 22:00:09.844 *** 2025-07-16 22:00:09.844 Process diagnostic dump for ORACLE.EXE (J000), OS id=17148, pid: 24, proc_ser: 15, sid: 193, sess_ser: 20121 ------------------------------------------------------------------------------- current sql: <none> client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 17148 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J000) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=11 seq_num=12 snap_id=1 wait times: snap=0.315713 sec, exc=0.315713 sec, total=0.315713 sec wait times: max=0.500000 sec, heur=5.816678 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.000008 sec since current wait 0: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=10 seq_num=11 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 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=9 seq_num=10 snap_id=1 wait times: snap=0.500112 sec, exc=0.500112 sec, total=0.500112 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=8 seq_num=9 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 3: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=7 seq_num=8 snap_id=1 wait times: snap=0.500001 sec, exc=0.500001 sec, total=0.500001 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000010 sec of elapsed time 4: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=6 seq_num=7 snap_id=1 wait times: snap=0.499985 sec, exc=0.499985 sec, total=0.499985 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000007 sec of elapsed time 5: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=5 seq_num=6 snap_id=1 wait times: snap=0.500010 sec, exc=0.500010 sec, total=0.500010 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=4 seq_num=5 snap_id=1 wait times: snap=0.514094 sec, exc=0.514094 sec, total=0.514094 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=3 seq_num=4 snap_id=1 wait times: snap=0.500292 sec, exc=0.500292 sec, total=0.500292 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000007 sec of elapsed time 8: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=2 seq_num=3 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.000014 sec of elapsed time 9: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=1 seq_num=2 snap_id=1 wait times: snap=0.500002 sec, exc=0.500002 sec, total=0.500002 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time Sampled Session History of session 193 serial 20121 --------------------------------------------------- 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 --------------------------------------------------- [6 samples, 22:00:04 - 22:00:09] 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-07-16 22:00:09.844 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 24 (osid: 17148, J000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-07-16 21:57:20.313814 :B2EE5703:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-16 21:57:20.299 2025-07-16 21:57:20.313817 :B2EE5704:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=13760 pso_num=24 pso_serial#=254 2025-07-16 21:57:20.313954 :B2EE5705:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=13760 (legacy spawn) 2025-07-16 21:57:20.320369 :B2EE5706:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-16 21:57:20.320548 :B2EE570F:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-16 21:57:20.321371 :B2EE5710:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-16 21:57:20.330109 :B2EE5713:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-16 21:57:20.314 2025-07-16 21:57:20.330111 :B2EE5714:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=16824 pso_num=24 pso_serial#=255 2025-07-16 21:57:20.330254 :B2EE5715:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=16824 (legacy spawn) 2025-07-16 21:57:20.336672 :B2EE5716:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-16 21:57:20.336836 :B2EE571F:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-16 21:57:20.337610 :B2EE5720:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-16 21:57:23.452829 :B2EE5817:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-16 21:57:23.440 2025-07-16 21:57:23.452830 :B2EE5818:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=4904 pso_num=24 pso_serial#=1 2025-07-16 21:57:23.452970 :B2EE5819:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=4904 (legacy spawn) 2025-07-16 21:57:23.459425 :B2EE581A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-16 21:57:23.459601 :B2EE5820:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-16 21:57:23.460386 :B2EE5824:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-16 21:57:23.469068 :B2EE5827:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-16 21:57:23.455 2025-07-16 21:57:23.469071 :B2EE5828:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=16960 pso_num=24 pso_serial#=2 2025-07-16 21:57:23.469206 :B2EE5829:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=16960 (legacy spawn) 2025-07-16 21:57:23.475641 :B2EE582A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-16 21:57:23.475803 :B2EE5833:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-16 21:57:23.476595 :B2EE5834:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-16 21:57:37.578654 :B2EE5C88:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-16 21:57:37.572 2025-07-16 21:57:37.578656 :B2EE5C89:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=11176 pso_num=24 pso_serial#=3 2025-07-16 21:57:37.578792 :B2EE5C8A:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=11176 osp_idx=22 osp_ver=577078 osp_pg=0 (spawn #392495) 2025-07-16 21:57:37.578793 :B2EE5C8B:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-16 21:57:37.578793 :B2EE5C8C:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=76 time=1383833470 2025-07-16 21:57:37.578794 :B2EE5C8D:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-07-16 21:57:37.578794 :B2EE5C8E:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-07-16 21:57:37.578794 :B2EE5C8F:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-07-16 21:57:37.578795 :B2EE5C90:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-16 21:57:37.578795 :B2EE5C91:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-16 21:57:37.579299 :B2EE5C92:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-16 21:57:37.580055 :B2EE5CA7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-16 21:57:37.587629 :B2EE5CC4:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-07-16 21:57:37.588098 :B2EE5CC5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-16 21:57:37.588170 :B2EE5CC8:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-07-16 21:57:37.589064 :B2EE5CCE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-16 21:57:37.589188 :B2EE5CD7:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-16 21:58:02.596305 :B2EE6576:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=59 loc='kkj.h LINE:914 ID:kkjpstnp' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-07-16 21:58:32.683478 :B2EE6EE0:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-16 21:58:33.015540 :B2EE6EEF:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-16 21:58:33.011 2025-07-16 21:58:33.015542 :B2EE6EF0:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=16340 pso_num=24 pso_serial#=4 2025-07-16 21:58:33.015694 :B2EE6EF1:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=16340 (legacy spawn) 2025-07-16 21:58:33.022362 :B2EE6EF2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-16 21:58:33.022559 :B2EE6EF7:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-16 21:58:33.023418 :B2EE6EFC:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-16 21:58:33.032379 :B2EE6EFF:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-16 21:58:33.027 2025-07-16 21:58:33.032381 :B2EE6F00:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=16496 pso_num=24 pso_serial#=5 2025-07-16 21:58:33.032526 :B2EE6F01:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=16496 (legacy spawn) 2025-07-16 21:58:33.039297 :B2EE6F02:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-16 21:58:33.039475 :B2EE6F0B:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-16 21:58:33.040318 :B2EE6F0C:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-16 21:58:36.090168 :B2EE6FF3:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-16 21:58:36.077 2025-07-16 21:58:36.090170 :B2EE6FF4:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=18132 pso_num=24 pso_serial#=6 2025-07-16 21:58:36.090308 :B2EE6FF5:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=18132 (legacy spawn) 2025-07-16 21:58:36.096865 :B2EE6FF6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-16 21:58:36.097052 :B2EE6FFB:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-16 21:58:36.097863 :B2EE7000:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-16 21:58:36.106534 :B2EE7003:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-16 21:58:36.093 2025-07-16 21:58:36.106536 :B2EE7004:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=15536 pso_num=24 pso_serial#=7 2025-07-16 21:58:36.106671 :B2EE7005:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=15536 (legacy spawn) 2025-07-16 21:58:36.113231 :B2EE7006:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-16 21:58:36.113399 :B2EE700F:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-16 21:58:36.114228 :B2EE7010:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-16 21:58:37.645279 :B2EE709E:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-16 21:58:37.639 2025-07-16 21:58:37.645281 :B2EE709F:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=15496 pso_num=24 pso_serial#=8 2025-07-16 21:58:37.645426 :B2EE70A0:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=15496 osp_idx=22 osp_ver=577083 osp_pg=0 (spawn #392497) 2025-07-16 21:58:37.645427 :B2EE70A1:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-16 21:58:37.645427 :B2EE70A2:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=77 time=1383893533 2025-07-16 21:58:37.645427 :B2EE70A3:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-07-16 21:58:37.645428 :B2EE70A4:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-07-16 21:58:37.645428 :B2EE70A5:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-07-16 21:58:37.645428 :B2EE70A6:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-16 21:58:37.645429 :B2EE70A7:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-16 21:58:37.645945 :B2EE70A8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-16 21:58:37.646586 :B2EE70BD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-16 21:58:37.657569 :B2EE70D9:db_trace:kwqid.c@2146:kwqidrdq(): [10960:24:193] kwqidrdq: Error: 1403 occured in OCI execute 2025-07-16 21:58:37.658034 :B2EE70DA:db_trace:kwqid.c@2146:kwqidrdq(): [10960:24:193] kwqidrdq: Error: 1403 occured in OCI execute 2025-07-16 21:58:37.660316 :B2EE70DB:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-07-16 21:58:37.660644 :B2EE70DC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-16 21:58:37.660679 :B2EE70DF:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-07-16 21:58:37.661674 :B2EE70E5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-16 21:58:37.661813 :B2EE70EE:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-16 21:59:07.752887 :B2EE7A5F:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-16 21:59:09.382406 :B2EE7AC6:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-16 21:59:09.367 2025-07-16 21:59:09.382408 :B2EE7AC7:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=13728 pso_num=24 pso_serial#=9 2025-07-16 21:59:09.382555 :B2EE7AC8:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=13728 (legacy spawn) 2025-07-16 21:59:09.389172 :B2EE7AC9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-16 21:59:09.389364 :B2EE7ACE:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-16 21:59:09.390236 :B2EE7AD3:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-16 21:59:09.399199 :B2EE7AD6:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-16 21:59:09.398 2025-07-16 21:59:09.399201 :B2EE7AD7:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=11784 pso_num=24 pso_serial#=10 2025-07-16 21:59:09.399346 :B2EE7AD8:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=11784 (legacy spawn) 2025-07-16 21:59:09.405924 :B2EE7AD9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-16 21:59:09.406108 :B2EE7AE2:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-16 21:59:09.406978 :B2EE7AE3:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-16 21:59:11.344886 :B2EE7BC0:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-16 21:59:11.336 2025-07-16 21:59:11.344888 :B2EE7BC1:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=1388 pso_num=24 pso_serial#=11 2025-07-16 21:59:11.345026 :B2EE7BC2:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=1388 (legacy spawn) 2025-07-16 21:59:11.351549 :B2EE7BC3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-16 21:59:11.351738 :B2EE7BC8:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-16 21:59:11.352528 :B2EE7BCD:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-16 21:59:12.578302 :B2EE7C02:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-16 21:59:12.565 2025-07-16 21:59:12.578304 :B2EE7C03:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=15328 pso_num=24 pso_serial#=12 2025-07-16 21:59:12.578435 :B2EE7C04:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=15328 (legacy spawn) 2025-07-16 21:59:12.584930 :B2EE7C05:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-16 21:59:12.585109 :B2EE7C0E:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-16 21:59:12.585927 :B2EE7C0F:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-16 21:59:12.594556 :B2EE7C12:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-16 21:59:12.580 2025-07-16 21:59:12.594558 :B2EE7C13:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=17604 pso_num=24 pso_serial#=13 2025-07-16 21:59:12.594698 :B2EE7C14:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=17604 (legacy spawn) 2025-07-16 21:59:12.601167 :B2EE7C15:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-16 21:59:12.601324 :B2EE7C1E:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-16 21:59:12.602097 :B2EE7C1F:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-16 21:59:30.326201 :B2EE81AC:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-16 21:59:30.311 2025-07-16 21:59:30.326203 :B2EE81AD:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=10744 pso_num=24 pso_serial#=14 2025-07-16 21:59:30.326345 :B2EE81AE:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=10744 (legacy spawn) 2025-07-16 21:59:30.332733 :B2EE81AF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-16 21:59:30.332918 :B2EE81B4:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-16 21:59:30.333713 :B2EE81B9:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-16 21:59:37.751950 :B2EE8425:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-16 21:59:37.746 2025-07-16 21:59:37.751952 :B2EE8426:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=17148 pso_num=24 pso_serial#=15 2025-07-16 21:59:37.752147 :B2EE8427:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=17148 osp_idx=22 osp_ver=577090 osp_pg=0 (spawn #392499) 2025-07-16 21:59:37.752148 :B2EE8428:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-16 21:59:37.752148 :B2EE8429:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=78 time=1383953642 2025-07-16 21:59:37.752149 :B2EE842A:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-07-16 21:59:37.752149 :B2EE842B:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-07-16 21:59:37.752150 :B2EE842C:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-07-16 21:59:37.752150 :B2EE842D:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-16 21:59:37.752151 :B2EE842E:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-16 21:59:37.752657 :B2EE842F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-16 21:59:37.753338 :B2EE8444:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-16 21:59:37.760875 :B2EE8460:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-07-16 21:59:37.761242 :B2EE8461:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-16 21:59:37.761281 :B2EE8464:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-07-16 21:59:37.762131 :B2EE846A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-16 21:59:37.762251 :B2EE8473:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-16 22:00:02.045716 :B2EE8DCB:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=59 loc='kkj.h LINE:914 ID:kkjpstnp' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-07-16 22:00:02.045716*:B2EE8DDD:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000024D5C718 estart=1752674401 eid=16784303 ctx=0x000000077FD6A000 cwh=0x0000000024D50068 cpu=0 buffg=1 interb=0 r=0 rb=0 w=0 wb=0 2025-07-16 22:00:02.045716*:B2EE8DDE:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000024D5C718 curCtx=0x0000000024D58938 pubTabIdxCnt=0 2025-07-16 22:00:02.045716*:B2EE8DDF:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000024D5C718 2025-07-16 22:00:02.045716*:B2EE8DE0:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000024D5C718 2025-07-16 22:00:02.045716*:B2EE8DE1:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000024D5C718 curCtx=0x0000000024D58938 xsc->flg4=65792 flags=2 2025-07-16 22:00:02.045716*:B2EE8DE2:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000024D5C718 2025-07-16 22:00:02.051303 :B2EE8DED:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-16 22:00:02.051348 :B2EE8DF0:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:jslv.c:9203 2025-07-16 22:00:02.063108 :B2EE8F98:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-16 22:00:02.068246 :B2EE8FD7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-16 22:00:02.068961 :B2EE8FF2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-16 22:00:02.074627 :B2EE9046:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-07-16 22:00:02.074784 :B2EE905D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-16 22:00:02.075023 :B2EE9070:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] 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-07-16 22:00:02.075544 :B2EE908F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-16 22:00:02.075726 :B2EE909F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:jslv.c:9203 2025-07-16 22:00:02.077190 :B2EE90DB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] 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-07-16 22:00:02.077234 :B2EE90DD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-16 22:00:02.077266 :B2EE90E5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 2025-07-16 22:00:02.077358 :B2EE90F6:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-16 22:00:02.170775 :B2EE9153:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=59 loc='kkj.h LINE:914 ID:kkjpstnp' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-07-16 22:00:02.173000 :B2EE9156:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-16 22:00:02.173043 :B2EE9159:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:jslv.c:9203 2025-07-16 22:00:02.175640 :B2EE915F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:jslv.c:9203 2025-07-16 22:00:02.179111 :B2EE9160:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-16 22:00:02.179196 :B2EE9163:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 2025-07-16 22:00:02.179273 :B2EE9170:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-16 22:00:04.017520 :B2EE9553:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=59 loc='kkj.h LINE:914 ID:kkjpstnp' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-07-16 22:00:04.019652 :B2EE955D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-16 22:00:04.019684 :B2EE9560:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:jslv.c:9203 2025-07-16 22:00:04.026331 :B2EE9566:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-16 22:00:04.026992 :B2EE956E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-16 22:00:04.027748 :B2EE9576:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-16 22:00:04.027940 :B2EE957E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:jslv.c:9203 2025-07-16 22:00:04.029399 :B2EE957F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-16 22:00:04.029439 :B2EE9582:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 2025-07-16 22:00:04.029527 :B2EE958F:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 24 (osid: 17148, J000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de