Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250630220006\orcl_j005_8032_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250630220006\orcl_j005_8032_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:36708M/63366M, Ph+PgF:42768M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 31 Windows thread id: 8032, image: ORACLE.EXE (J005) *** 2025-06-30 22:00:06.129 *** SESSION ID:(249.1243) 2025-06-30 22:00:06.129 *** 2025-06-30 22:00:06.129 Process diagnostic dump for ORACLE.EXE (J005), OS id=8032, pid: 31, proc_ser: 95, sid: 249, sess_ser: 1243 ------------------------------------------------------------------------------- current sql: <none> client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 8032 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J005) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=9 seq_num=10 snap_id=1 wait times: snap=0.016113 sec, exc=0.016113 sec, total=0.016113 sec wait times: max=0.500000 sec, heur=4.527475 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.000019 sec since current wait 0: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=8 seq_num=9 snap_id=1 wait times: snap=0.510102 sec, exc=0.510102 sec, total=0.510102 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000010 sec of elapsed time 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=7 seq_num=8 snap_id=1 wait times: snap=0.500000 sec, exc=0.500000 sec, total=0.500000 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000013 sec of elapsed time 2: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=6 seq_num=7 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.000009 sec of elapsed time 3: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=5 seq_num=6 snap_id=1 wait times: snap=0.499996 sec, exc=0.499996 sec, total=0.499996 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000012 sec of elapsed time 4: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=4 seq_num=5 snap_id=1 wait times: snap=0.500000 sec, exc=0.500000 sec, total=0.500000 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000011 sec of elapsed time 5: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=3 seq_num=4 snap_id=1 wait times: snap=0.499996 sec, exc=0.499996 sec, total=0.499996 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 6: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=2 seq_num=3 snap_id=1 wait times: snap=0.505091 sec, exc=0.505091 sec, total=0.505091 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 sec of elapsed time 7: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=1 seq_num=2 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.000013 sec of elapsed time 8: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=0 seq_num=1 snap_id=1 wait times: snap=0.496082 sec, exc=0.496082 sec, total=0.496082 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 249 serial 1243 --------------------------------------------------- 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 --------------------------------------------------- [5 samples, 22:00:01 - 22:00:06] idle wait at each sample [session created at: 22:00:01] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-06-30 22:00:06.129 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 31 (osid: 8032, J005) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-06-28 23:59:07.624034 :AAFAC19C:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-28 23:59:07.624856 :AAFAC19D:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-28 23:59:10.084465 :AAFAC277:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-28 23:59:10.073 2025-06-28 23:59:10.084467 :AAFAC278:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=12636 pso_num=31 pso_serial#=80 2025-06-28 23:59:10.084607 :AAFAC279:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=12636 (legacy spawn) 2025-06-28 23:59:10.099302 :AAFAC27A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 23:59:13.289580 :AAFAC396:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 23:59:13.289744 :AAFAC39F:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-28 23:59:13.291099 :AAFAC3A0:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-28 23:59:13.540771 :AAFAC3CB:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-28 23:59:13.538 2025-06-28 23:59:13.540773 :AAFAC3CC:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=16320 pso_num=31 pso_serial#=81 2025-06-28 23:59:13.540921 :AAFAC3CD:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=16320 (legacy spawn) 2025-06-28 23:59:13.555738 :AAFAC3CE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 23:59:46.823554 :AAFACFD8:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-28 23:59:51.586013 :AAFAD17D:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-28 23:59:51.586 2025-06-28 23:59:51.586016 :AAFAD17E:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=16604 pso_num=31 pso_serial#=82 2025-06-28 23:59:51.586183 :AAFAD17F:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=16604 (legacy spawn) 2025-06-28 23:59:51.601227 :AAFAD180:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 23:59:54.866285 :AAFAD2C2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-28 23:59:54.866455 :AAFAD2CB:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-28 23:59:54.867761 :AAFAD2CC:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-28 23:59:55.119322 :AAFAD2E6:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-28 23:59:55.113 2025-06-28 23:59:55.119324 :AAFAD2E7:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=17844 pso_num=31 pso_serial#=83 2025-06-28 23:59:55.119457 :AAFAD2E8:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=17844 (legacy spawn) 2025-06-28 23:59:55.134182 :AAFAD2E9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 00:00:28.311646 :AAFAE185:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-29 06:00:02.044734 :AB170613:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-29 06:00:02.037 2025-06-29 06:00:02.044735 :AB170614:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=12024 pso_num=31 pso_serial#=84 2025-06-29 06:00:02.044891 :AB170616:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=12024 osp_idx=29 osp_ver=593 osp_pg=0 (spawn #333624) 2025-06-29 06:00:02.044891 :AB170617:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-29 06:00:02.044892 :AB170618:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=179 time=4152545235 2025-06-29 06:00:02.044893 :AB170619:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-06-29 06:00:02.044894 :AB17061A:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-06-29 06:00:02.044894 :AB17061B:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-06-29 06:00:02.044895 :AB17061C:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-29 06:00:02.044895 :AB17061D:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-29 06:00:02.045506 :AB170626:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-29 06:00:32.098293 :AB171805:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-29 14:00:05.545919 :AB3D1498:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-29 14:00:05.536 2025-06-29 14:00:05.545921 :AB3D1499:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=17680 pso_num=31 pso_serial#=85 2025-06-29 14:00:05.546060 :AB3D149A:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=17680 osp_idx=29 osp_ver=594 osp_pg=0 (spawn #334736) 2025-06-29 14:00:05.546061 :AB3D149B:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-29 14:00:05.546061 :AB3D149C:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=180 time=4181348735 2025-06-29 14:00:05.546062 :AB3D149D:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-06-29 14:00:05.546062 :AB3D149E:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-06-29 14:00:05.546063 :AB3D149F:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-06-29 14:00:05.546063 :AB3D14A0:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-29 14:00:05.546063 :AB3D14A1:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-29 14:00:05.546579 :AB3D14A2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-29 14:00:05.546621 :AB3D14A8:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-29 14:00:05.555845 :AB3D14CD:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-29 15:00:13.208788 :AB41C87C:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-29 15:00:13.198 2025-06-29 15:00:13.208789 :AB41C87D:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=15492 pso_num=31 pso_serial#=86 2025-06-29 15:00:13.208933 :AB41C87E:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=15492 osp_idx=29 osp_ver=595 osp_pg=0 (spawn #334874) 2025-06-29 15:00:13.208934 :AB41C87F:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-29 15:00:13.208934 :AB41C880:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=181 time=4184956391 2025-06-29 15:00:13.208935 :AB41C881:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-06-29 15:00:13.208935 :AB41C882:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-06-29 15:00:13.208935 :AB41C883:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-06-29 15:00:13.208936 :AB41C884:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-29 15:00:13.208936 :AB41C885:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-29 15:00:13.209459 :AB41C886:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-29 15:00:13.209510 :AB41C88C:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-29 15:00:13.218372 :AB41C8B1:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-29 16:00:20.570215 :AB46746D:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-29 16:00:20.567 2025-06-29 16:00:20.570216 :AB46746E:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=13592 pso_num=31 pso_serial#=87 2025-06-29 16:00:20.570353 :AB46746F:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=13592 osp_idx=29 osp_ver=596 osp_pg=0 (spawn #335011) 2025-06-29 16:00:20.570354 :AB467470:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-29 16:00:20.570354 :AB467471:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=182 time=4188563750 2025-06-29 16:00:20.570355 :AB467472:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-06-29 16:00:20.570355 :AB467473:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-06-29 16:00:20.570355 :AB467474:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-06-29 16:00:20.570356 :AB467475:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-29 16:00:20.570356 :AB467476:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-29 16:00:20.570855 :AB46747B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-29 16:00:20.570899 :AB467481:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-29 16:00:20.576503 :AB46749A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 16:00:20.601354 :AB4674CA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 16:00:20.616302 :AB4674D2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 16:00:20.645424 :AB4674DA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 16:00:20.649224 :AB4674E2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 16:00:20.652924 :AB4674EA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 16:00:20.657235 :AB4674FD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 16:00:20.658399 :AB467505:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 16:00:20.684897 :AB46750D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=16 loc='ktm.h LINE:583 ID:ktmpsm' id1=0 id2=0 name= type=0 2025-06-29 16:00:20.696138 :AB46761B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] 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-06-29 16:00:20.704691 :AB4676DA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 16:00:20.704702 :AB4676DB:db_trace:ktur.c@3079:ktuabt(): [10444:31:249] ABORT TRANSACTION - xid: 0x000a.009.00170690 2025-06-29 16:00:20.705044 :AB4676E3:db_trace:ktu.c@4871:ktuaex1r(): [10442:31:249] Extension usn 10, ext 1, nex 4 2025-06-29 16:00:20.705051 :AB4676E4:db_trace:ktusm.c@2117:ktusmasp(): [10445:31:249] des1:tsn:1 rdba:0x008159ed where: ktspbwh1: ktspfsrch 2025-06-29 16:00:21.780793*:AB467758:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000002DC74678 estart=1751184020 eid=16779586 ctx=0x000000077BA4B1C8 cwh=0x000000002DCA1530 cpu=484375 buffg=0 interb=0 r=0 rb=0 w=0 wb=0 2025-06-29 16:00:21.780793*:AB467759:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000002DC74678 curCtx=0x000000002DCAAFE8 pubTabIdxCnt=0 2025-06-29 16:00:21.780793*:AB46775A:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000002DC74678 2025-06-29 16:00:21.780793*:AB46775B:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000002DC74678 2025-06-29 16:00:21.780793*:AB46775C:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000002DCBDA98 estart=1751184020 eid=16779572 ctx=0x0000000787AD5BF0 cwh=0x000000002DC60AA0 cpu=484375 buffg=0 interb=0 r=0 rb=0 w=0 wb=0 2025-06-29 16:00:21.780793*:AB46775D:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000002DCBDA98 curCtx=0x0000000029960EB8 pubTabIdxCnt=0 2025-06-29 16:00:21.780793*:AB46775E:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000002DCBDA98 2025-06-29 16:00:21.780793*:AB46775F:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000002DCBDA98 2025-06-29 16:00:21.843291*:AB467760:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000002DC74678 curCtx=0x000000002DCAAFE8 xsc->flg4=65792 flags=1 2025-06-29 16:00:21.843291*:AB467761:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000002DC74678 2025-06-29 16:00:21.843291*:AB467762:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000002DCBDA98 curCtx=0x0000000029960EB8 xsc->flg4=65792 flags=2 2025-06-29 16:00:21.843291*:AB467763:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000002DCBDA98 2025-06-29 16:00:21.920601 :AB467764:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 16:00:21.956518 :AB467778:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 16:00:21.956840 :AB467780:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 16:00:21.957119 :AB467788:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 16:00:21.957136 :AB46778B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=18 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 16:00:21.957195 :AB467799:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-29 16:00:21.959855 :AB4677A5:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-29 19:00:43.438726 :AB547EAF:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-29 19:00:43.427 2025-06-29 19:00:43.438728 :AB547EB0:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=6984 pso_num=31 pso_serial#=88 2025-06-29 19:00:43.438882 :AB547EB1:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=6984 osp_idx=29 osp_ver=597 osp_pg=0 (spawn #335424) 2025-06-29 19:00:43.438883 :AB547EB2:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-29 19:00:43.438883 :AB547EB3:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=183 time=4199386625 2025-06-29 19:00:43.438884 :AB547EB4:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-06-29 19:00:43.438885 :AB547EB5:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-06-29 19:00:43.438885 :AB547EB6:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-06-29 19:00:43.438886 :AB547EB7:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-29 19:00:43.438886 :AB547EB8:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-29 19:00:43.439380 :AB547EBC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-29 19:00:43.439424 :AB547EC2:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-29 19:00:43.448524 :AB547ED4:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-29 20:00:50.457736 :AB592BB6:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-29 20:00:50.448 2025-06-29 20:00:50.457739 :AB592BB7:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=18080 pso_num=31 pso_serial#=89 2025-06-29 20:00:50.457879 :AB592BB8:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=18080 osp_idx=29 osp_ver=598 osp_pg=0 (spawn #335562) 2025-06-29 20:00:50.457880 :AB592BB9:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-29 20:00:50.457881 :AB592BBA:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=184 time=4202993641 2025-06-29 20:00:50.457881 :AB592BBB:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-06-29 20:00:50.457882 :AB592BBC:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-06-29 20:00:50.457882 :AB592BBD:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-06-29 20:00:50.457882 :AB592BBE:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-29 20:00:50.457883 :AB592BBF:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-29 20:00:50.458406 :AB592BC0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-29 20:00:50.458444 :AB592BC6:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-29 20:00:50.467353 :AB592BDB:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-29 21:00:57.902278 :AB5DD6C8:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-29 21:00:57.892 2025-06-29 21:00:57.902280 :AB5DD6C9:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=14108 pso_num=31 pso_serial#=90 2025-06-29 21:00:57.902424 :AB5DD6CA:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=14108 osp_idx=29 osp_ver=599 osp_pg=0 (spawn #335700) 2025-06-29 21:00:57.902425 :AB5DD6CB:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-29 21:00:57.902426 :AB5DD6CC:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=185 time=4206601094 2025-06-29 21:00:57.902426 :AB5DD6CD:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-06-29 21:00:57.902426 :AB5DD6CE:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-06-29 21:00:57.902427 :AB5DD6CF:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-06-29 21:00:57.902427 :AB5DD6D0:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-29 21:00:57.902427 :AB5DD6D1:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-29 21:00:57.903016 :AB5DD6D5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-29 21:00:57.903058 :AB5DD6DB:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-29 21:00:57.912306 :AB5DD6F8:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-29 23:59:10.077800 :AB6BD7E2:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-29 23:59:10.068 2025-06-29 23:59:10.077802 :AB6BD7E3:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=16012 pso_num=31 pso_serial#=91 2025-06-29 23:59:10.077947 :AB6BD7E4:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=16012 (legacy spawn) 2025-06-29 23:59:10.092533 :AB6BD7E5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 23:59:13.185062 :AB6BD91C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 23:59:13.185243 :AB6BD921:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-29 23:59:13.186436 :AB6BD926:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-29 23:59:13.351015 :AB6BD929:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-29 23:59:13.349 2025-06-29 23:59:13.351016 :AB6BD92A:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=6652 pso_num=31 pso_serial#=92 2025-06-29 23:59:13.351160 :AB6BD92B:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=6652 (legacy spawn) 2025-06-29 23:59:13.365489 :AB6BD92C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 23:59:46.545072 :AB6BE50A:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-29 23:59:55.028845 :AB6BE864:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-29 23:59:55.018 2025-06-29 23:59:55.028847 :AB6BE865:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=1168 pso_num=31 pso_serial#=93 2025-06-29 23:59:55.028987 :AB6BE866:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=1168 (legacy spawn) 2025-06-29 23:59:55.042650 :AB6BE867:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 23:59:58.179731 :AB6BE956:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 23:59:58.179920 :AB6BE95B:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-29 23:59:58.181092 :AB6BE960:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-29 23:59:58.400486 :AB6BE964:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-29 23:59:58.393 2025-06-29 23:59:58.400488 :AB6BE965:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=7880 pso_num=31 pso_serial#=94 2025-06-29 23:59:58.400628 :AB6BE966:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=7880 (legacy spawn) 2025-06-29 23:59:58.415004 :AB6BE967:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-30 00:06:18.380043 :AB6C746A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-30 00:06:18.380215 :AB6C746F:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-30 00:06:18.381314 :AB6C7474:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-30 22:00:01.601197 :ABD35203:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-30 22:00:01.598 2025-06-30 22:00:01.601197 :ABD35204:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=8032 pso_num=31 pso_serial#=95 2025-06-30 22:00:01.601326 :ABD35205:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=8032 osp_idx=29 osp_ver=604 osp_pg=0 (spawn #339177) 2025-06-30 22:00:01.601327 :ABD35206:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-30 22:00:01.601328 :ABD35207:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=186 time=1577486 2025-06-30 22:00:01.601328 :ABD35208:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-06-30 22:00:01.601328 :ABD35209:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-06-30 22:00:01.601329 :ABD3520A:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-06-30 22:00:01.601329 :ABD3520B:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-30 22:00:01.601330 :ABD3520C:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-30 22:00:01.601857 :ABD3521E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] 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 31 (osid: 8032, J005)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de