Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250625220006\orcl_j000_16656_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250625220006\orcl_j000_16656_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:36352M/63366M, Ph+PgF:42527M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 25 Windows thread id: 16656, image: ORACLE.EXE (J000) *** 2025-06-25 22:00:06.865 *** SESSION ID:(201.46427) 2025-06-25 22:00:06.865 *** 2025-06-25 22:00:06.865 Process diagnostic dump for ORACLE.EXE (J000), OS id=16656, pid: 25, proc_ser: 188, sid: 201, sess_ser: 46427 ------------------------------------------------------------------------------- current sql: <none> client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 16656 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J000) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=5 seq_num=6 snap_id=1 wait times: snap=0.349408 sec, exc=0.349408 sec, total=0.349408 sec wait times: max=0.500000 sec, heur=2.836206 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=4 seq_num=5 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.000010 sec of elapsed time 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=3 seq_num=4 snap_id=1 wait times: snap=0.500106 sec, exc=0.500106 sec, total=0.500106 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=2 seq_num=3 snap_id=1 wait times: snap=0.500008 sec, exc=0.500008 sec, total=0.500008 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 3: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=1 seq_num=2 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.000011 sec of elapsed time 4: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=0 seq_num=1 snap_id=1 wait times: snap=0.486647 sec, exc=0.486647 sec, total=0.486647 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 201 serial 46427 --------------------------------------------------- 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 --------------------------------------------------- [3 samples, 22:00:04 - 22:00:06] 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-06-25 22:00:06.865 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 25 (osid: 16656, J000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-06-25 21:49:31.297941 :A99AC0E0:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=8564 pso_num=25 pso_serial#=177 2025-06-25 21:49:31.298135 :A99AC0E1:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=8564 osp_idx=23 osp_ver=168589 osp_pg=0 (spawn #322465) 2025-06-25 21:49:31.298136 :A99AC0E2:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-25 21:49:31.298138 :A99AC0E3:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=161 time=3863914485 2025-06-25 21:49:31.298139 :A99AC0E4:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-25 21:49:31.298139 :A99AC0E5:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-25 21:49:31.298139 :A99AC0E6:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-25 21:49:31.298140 :A99AC0E7:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-25 21:49:31.298140 :A99AC0E8:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-25 21:49:31.298635 :A99AC0E9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-25 21:50:01.356647 :A99ACA96:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-25 21:50:31.385090 :A99AD528:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-25 21:50:31.374 2025-06-25 21:50:31.385093 :A99AD529:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=732 pso_num=25 pso_serial#=178 2025-06-25 21:50:31.385226 :A99AD52A:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=732 osp_idx=23 osp_ver=168590 osp_pg=0 (spawn #322467) 2025-06-25 21:50:31.385226 :A99AD52B:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-25 21:50:31.385227 :A99AD52C:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=162 time=3863974563 2025-06-25 21:50:31.385227 :A99AD52D:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-25 21:50:31.385228 :A99AD52E:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-25 21:50:31.385228 :A99AD52F:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-25 21:50:31.385228 :A99AD530:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-25 21:50:31.385229 :A99AD531:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-25 21:50:31.385788 :A99AD532:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-25 21:51:01.491927 :A99ADFC2:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-25 21:51:01.598670 :A99ADFC5:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-25 21:51:01.586 2025-06-25 21:51:01.598672 :A99ADFC6:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=18312 pso_num=25 pso_serial#=179 2025-06-25 21:51:01.598807 :A99ADFC7:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=18312 (legacy spawn) 2025-06-25 21:51:01.606010 :A99ADFCB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-25 21:51:01.606190 :A99ADFD0:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-25 21:51:01.607014 :A99ADFD5:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-25 21:51:31.486247 :A99AE998:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-25 21:51:31.475 2025-06-25 21:51:31.486249 :A99AE999:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=13352 pso_num=25 pso_serial#=180 2025-06-25 21:51:31.486386 :A99AE99A:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=13352 osp_idx=23 osp_ver=168592 osp_pg=0 (spawn #322469) 2025-06-25 21:51:31.486387 :A99AE99B:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-25 21:51:31.486387 :A99AE99C:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=163 time=3864034672 2025-06-25 21:51:31.486388 :A99AE99D:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-25 21:51:31.486388 :A99AE99E:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-25 21:51:31.486389 :A99AE99F:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-25 21:51:31.486389 :A99AE9A0:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-25 21:51:31.486389 :A99AE9A1:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-25 21:51:31.486865 :A99AE9A2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-25 21:51:56.518026 :A99AF188:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=59 loc='kkj.h LINE:914 ID:kkjpstnp' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-25 21:52:26.596367 :A99AFB3E:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-25 21:52:31.575370 :A99AFD30:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-25 21:52:31.564 2025-06-25 21:52:31.575373 :A99AFD31:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=8296 pso_num=25 pso_serial#=181 2025-06-25 21:52:31.575537 :A99AFD32:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=8296 osp_idx=23 osp_ver=168593 osp_pg=0 (spawn #322471) 2025-06-25 21:52:31.575537 :A99AFD33:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-25 21:52:31.575538 :A99AFD34:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=164 time=3864094766 2025-06-25 21:52:31.575538 :A99AFD35:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-25 21:52:31.575539 :A99AFD36:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-25 21:52:31.575539 :A99AFD37:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-25 21:52:31.575540 :A99AFD38:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-25 21:52:31.575540 :A99AFD39:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-25 21:52:31.576037 :A99AFD3A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-25 21:53:01.639271 :A99B06F5:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-25 21:53:31.647365 :A99B10CD:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-25 21:53:31.636 2025-06-25 21:53:31.647367 :A99B10CE:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=7348 pso_num=25 pso_serial#=182 2025-06-25 21:53:31.647511 :A99B10CF:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=7348 osp_idx=23 osp_ver=168594 osp_pg=0 (spawn #322473) 2025-06-25 21:53:31.647512 :A99B10D0:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-25 21:53:31.647512 :A99B10D1:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=165 time=3864154829 2025-06-25 21:53:31.647513 :A99B10D2:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-25 21:53:31.647513 :A99B10D3:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-25 21:53:31.647514 :A99B10D4:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-25 21:53:31.647514 :A99B10D5:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-25 21:53:31.647514 :A99B10D6:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-25 21:53:31.648019 :A99B10D7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-25 21:54:01.721547 :A99B1AD3:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-25 21:54:31.730253 :A99B24C5:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-25 21:54:31.719 2025-06-25 21:54:31.730255 :A99B24C6:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=17540 pso_num=25 pso_serial#=183 2025-06-25 21:54:31.730376 :A99B24C7:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=17540 osp_idx=23 osp_ver=168595 osp_pg=0 (spawn #322475) 2025-06-25 21:54:31.730377 :A99B24C8:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-25 21:54:31.730377 :A99B24C9:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=166 time=3864214907 2025-06-25 21:54:31.730377 :A99B24CA:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-25 21:54:31.730378 :A99B24CB:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-25 21:54:31.730379 :A99B24CC:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-25 21:54:31.730379 :A99B24CD:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-25 21:54:31.730379 :A99B24CE:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-25 21:54:31.730870 :A99B24CF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-25 21:55:01.835903 :A99B2E9E:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-25 21:55:31.803093 :A99B38B8:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-25 21:55:31.791 2025-06-25 21:55:31.803095 :A99B38B9:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=4528 pso_num=25 pso_serial#=184 2025-06-25 21:55:31.803215 :A99B38BA:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=4528 osp_idx=23 osp_ver=168596 osp_pg=0 (spawn #322477) 2025-06-25 21:55:31.803216 :A99B38BB:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-25 21:55:31.803216 :A99B38BC:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=167 time=3864274985 2025-06-25 21:55:31.803217 :A99B38BD:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-25 21:55:31.803217 :A99B38BE:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-25 21:55:31.803217 :A99B38BF:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-25 21:55:31.803218 :A99B38C0:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-25 21:55:31.803218 :A99B38C1:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-25 21:55:31.803733 :A99B38C2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-25 21:56:01.890462 :A99B4356:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-25 21:56:31.906483 :A99B4D3B:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-25 21:56:31.896 2025-06-25 21:56:31.906485 :A99B4D3C:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=8156 pso_num=25 pso_serial#=185 2025-06-25 21:56:31.906634 :A99B4D3D:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=8156 osp_idx=23 osp_ver=168597 osp_pg=0 (spawn #322480) 2025-06-25 21:56:31.906635 :A99B4D3E:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-25 21:56:31.906636 :A99B4D3F:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=168 time=3864335094 2025-06-25 21:56:31.906636 :A99B4D40:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-25 21:56:31.906636 :A99B4D41:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-25 21:56:31.906637 :A99B4D42:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-25 21:56:31.906637 :A99B4D43:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-25 21:56:31.906637 :A99B4D44:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-25 21:56:31.907134 :A99B4D45:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-25 21:57:01.942568 :A99B56E3:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-25 21:57:31.964264 :A99B60D3:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-25 21:57:31.952 2025-06-25 21:57:31.964266 :A99B60D4:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=15492 pso_num=25 pso_serial#=186 2025-06-25 21:57:31.964405 :A99B60D5:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=15492 osp_idx=23 osp_ver=168598 osp_pg=0 (spawn #322482) 2025-06-25 21:57:31.964406 :A99B60D6:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-25 21:57:31.964406 :A99B60D7:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=169 time=3864395141 2025-06-25 21:57:31.964407 :A99B60D8:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-25 21:57:31.964407 :A99B60D9:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-25 21:57:31.964408 :A99B60DA:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-25 21:57:31.964408 :A99B60DB:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-25 21:57:31.964408 :A99B60DC:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-25 21:57:31.964937 :A99B60DD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-25 21:58:02.032361 :A99B6AA6:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-25 21:58:32.064612 :A99B74AE:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-25 21:58:32.053 2025-06-25 21:58:32.064614 :A99B74AF:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=16748 pso_num=25 pso_serial#=187 2025-06-25 21:58:32.064746 :A99B74B0:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=16748 osp_idx=23 osp_ver=168599 osp_pg=0 (spawn #322484) 2025-06-25 21:58:32.064747 :A99B74B1:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-25 21:58:32.064747 :A99B74B2:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=170 time=3864455250 2025-06-25 21:58:32.064748 :A99B74B3:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-25 21:58:32.064748 :A99B74B4:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-25 21:58:32.064749 :A99B74B5:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-25 21:58:32.064749 :A99B74B6:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-25 21:58:32.064749 :A99B74B7:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-25 21:58:32.065267 :A99B74B8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-25 21:59:02.161670 :A99B7EE4:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-25 21:59:32.123173 :A99B890A:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-25 21:59:32.117 2025-06-25 21:59:32.123174 :A99B890B:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=16656 pso_num=25 pso_serial#=188 2025-06-25 21:59:32.123313 :A99B890C:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=16656 osp_idx=23 osp_ver=168600 osp_pg=0 (spawn #322486) 2025-06-25 21:59:32.123314 :A99B890D:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-25 21:59:32.123315 :A99B890E:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=171 time=3864515313 2025-06-25 21:59:32.123315 :A99B890F:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-25 21:59:32.123316 :A99B8910:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-25 21:59:32.123317 :A99B8911:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-25 21:59:32.123317 :A99B8912:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-25 21:59:32.123317 :A99B8913:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-25 21:59:32.123808 :A99B8917:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-25 21:59:32.124389 :A99B892C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-25 21:59:32.132346 :A99B8949:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:psdpgi.c:2235 2025-06-25 21:59:32.132726 :A99B894A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-25 21:59:32.132760 :A99B894D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:psdpgi.c:2235 2025-06-25 21:59:32.133611 :A99B8953:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-25 21:59:32.133825 :A99B895C:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-25 22:00:02.022672 :A99B943B:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=59 loc='kkj.h LINE:914 ID:kkjpstnp' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-25 22:00:02.022672*:A99B945E:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000026BEC718 estart=1750860001 eid=16783012 ctx=0x000000077FD6A000 cwh=0x0000000026BE0068 cpu=0 buffg=1 interb=0 r=0 rb=0 w=0 wb=0 2025-06-25 22:00:02.022672*:A99B945F:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000026BEC718 curCtx=0x0000000026BE8938 pubTabIdxCnt=0 2025-06-25 22:00:02.022672*:A99B9461:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000026BEC718 2025-06-25 22:00:02.022672*:A99B9462:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000026BEC718 2025-06-25 22:00:02.022672*:A99B9476:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000026BEC718 curCtx=0x0000000026BE8938 xsc->flg4=65792 flags=2 2025-06-25 22:00:02.022672*:A99B9477:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000026BEC718 2025-06-25 22:00:02.029478 :A99B947F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-25 22:00:02.029533 :A99B9482:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:jslv.c:9203 2025-06-25 22:00:02.040785 :A99B94E0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-25 22:00:02.045983 :A99B9507:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-25 22:00:02.046870 :A99B950F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-25 22:00:02.052665 :A99B9658:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-06-25 22:00:02.052815 :A99B9667:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-25 22:00:02.053636 :A99B966F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-25 22:00:02.053874 :A99B9677:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:jslv.c:9203 2025-06-25 22:00:02.055570 :A99B9678:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-25 22:00:02.055623 :A99B967B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 2025-06-25 22:00:02.055733 :A99B9688:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-25 22:00:02.147627 :A99B9780:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=59 loc='kkj.h LINE:914 ID:kkjpstnp' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-25 22:00:02.149817 :A99B9784:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-25 22:00:02.149857 :A99B9787:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:jslv.c:9203 2025-06-25 22:00:02.152391 :A99B978D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:jslv.c:9203 2025-06-25 22:00:02.155954 :A99B978E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-25 22:00:02.156031 :A99B9791:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 2025-06-25 22:00:02.156114 :A99B979E:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-25 22:00:04.022663 :A99B9B4B:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=59 loc='kkj.h LINE:914 ID:kkjpstnp' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-25 22:00:04.022663*:A99B9B4E:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000026BEC718 estart=1750860003 eid=16783017 ctx=0x000000077FD6A000 cwh=0x0000000026BE0068 cpu=0 buffg=1 interb=0 r=0 rb=0 w=0 wb=0 2025-06-25 22:00:04.022663*:A99B9B4F:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000026BEC718 curCtx=0x0000000026BE8938 pubTabIdxCnt=0 2025-06-25 22:00:04.022663*:A99B9B50:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000026BEC718 2025-06-25 22:00:04.022663*:A99B9B51:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000026BEC718 2025-06-25 22:00:04.022663*:A99B9B52:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000026BEC718 curCtx=0x0000000026BE8938 xsc->flg4=65792 flags=2 2025-06-25 22:00:04.022663*:A99B9B53:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000026BEC718 2025-06-25 22:00:04.024763 :A99B9B54:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-25 22:00:04.024799 :A99B9B57:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:jslv.c:9203 2025-06-25 22:00:04.031242 :A99B9B5D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-25 22:00:04.031909 :A99B9B69:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] 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-25 22:00:04.031943 :A99B9B6B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-25 22:00:04.032646 :A99B9B7D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-25 22:00:04.032882 :A99B9B85:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:jslv.c:9203 2025-06-25 22:00:04.034329 :A99B9B86:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-25 22:00:04.034370 :A99B9B89:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 2025-06-25 22:00:04.034455 :A99B9B96:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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 25 (osid: 16656, J000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de