Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250829220005\orcl_j003_21800_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250829220005\orcl_j003_21800_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:35128M/63366M, Ph+PgF:40133M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 29 Windows thread id: 21800, image: ORACLE.EXE (J003) *** 2025-08-29 22:00:05.947 *** SESSION ID:(233.33351) 2025-08-29 22:00:05.947 *** 2025-08-29 22:00:05.947 Process diagnostic dump for ORACLE.EXE (J003), OS id=21800, pid: 29, proc_ser: 30, sid: 233, sess_ser: 33351 ------------------------------------------------------------------------------- current sql: call dbms_stats.gather_database_stats_job_proc ( ) client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 21800 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J003) application name: DBMS_SCHEDULER, hash value=2478762354 action name: ORA$AT_OS_OPT_SY_12991, hash value=2949287655 Current Wait Stack: Not in wait; last wait ended 2.832672 sec ago Wait State: fixed_waits=0 flags=0x21 boundary=0x0000000000000000/-1 Session Wait History: elapsed time of 2.832701 sec since last wait 0: waited for 'Disk file operations I/O' FileOperation=0x2, fileno=0xc9, filetype=0x2 wait_id=39 seq_num=40 snap_id=1 wait times: snap=0.000180 sec, exc=0.000180 sec, total=0.000180 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.067264 sec of elapsed time 1: waited for 'asynch descriptor resize' outstanding #aio=0x0, current aio limit=0xffffffff, new aio limit=0x82 wait_id=38 seq_num=39 snap_id=1 wait times: snap=0.000010 sec, exc=0.000010 sec, total=0.000010 sec wait times: max=307445734561 min 49 sec wait counts: calls=0 os=0 occurred after 0.763686 sec of elapsed time 2: waited for 'asynch descriptor resize' outstanding #aio=0x0, current aio limit=0xffffffff, new aio limit=0x82 wait_id=37 seq_num=38 snap_id=1 wait times: snap=0.000005 sec, exc=0.000005 sec, total=0.000005 sec wait times: max=307445734561 min 49 sec wait counts: calls=0 os=0 occurred after 0.027109 sec of elapsed time 3: waited for 'asynch descriptor resize' outstanding #aio=0x0, current aio limit=0xffffffff, new aio limit=0x82 wait_id=36 seq_num=37 snap_id=1 wait times: snap=0.000005 sec, exc=0.000005 sec, total=0.000005 sec wait times: max=307445734561 min 49 sec wait counts: calls=0 os=0 occurred after 0.013097 sec of elapsed time 4: waited for 'db file sequential read' file#=0x2, block#=0x78fa, blocks=0x1 wait_id=35 seq_num=36 snap_id=1 wait times: snap=0.000063 sec, exc=0.000063 sec, total=0.000063 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.050677 sec of elapsed time 5: waited for 'db file sequential read' file#=0x2, block#=0x1e5a, blocks=0x1 wait_id=34 seq_num=35 snap_id=1 wait times: snap=0.007994 sec, exc=0.007994 sec, total=0.007994 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.007987 sec of elapsed time 6: waited for 'db file sequential read' file#=0x1, block#=0x2d00, blocks=0x1 wait_id=33 seq_num=34 snap_id=1 wait times: snap=0.000067 sec, exc=0.000067 sec, total=0.000067 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.263048 sec of elapsed time 7: waited for 'db file sequential read' file#=0x1, block#=0x130, blocks=0x1 wait_id=32 seq_num=33 snap_id=1 wait times: snap=0.005015 sec, exc=0.005015 sec, total=0.005015 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000320 sec of elapsed time 8: waited for 'db file sequential read' file#=0x1, block#=0xc8, blocks=0x1 wait_id=31 seq_num=32 snap_id=1 wait times: snap=0.000136 sec, exc=0.000136 sec, total=0.000136 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.008852 sec of elapsed time 9: waited for 'asynch descriptor resize' outstanding #aio=0x0, current aio limit=0xffffffff, new aio limit=0x82 wait_id=30 seq_num=31 snap_id=1 wait times: snap=0.000001 sec, exc=0.000001 sec, total=0.000001 sec wait times: max=307445734561 min 49 sec wait counts: calls=0 os=0 occurred after 0.000080 sec of elapsed time Sampled Session History of session 233 serial 33351 --------------------------------------------------- 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:05] not in wait at each sample [1 sample, 22:00:00] 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-08-29 22:00:05.947 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 29 (osid: 21800, J003) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-08-29 00:38:57.585193 :C5FBA306:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-08-29 00:38:57.585193 :C5FBA307:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-29 00:38:57.585193 :C5FBA308:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-29 00:38:57.585697 :C5FBA309:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-29 00:38:57.585742 :C5FBA30F:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-08-29 00:38:57.589864 :C5FBA328:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-08-29 00:38:57.589907 :C5FBA329:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-08-29 00:38:57.590172 :C5FBA32A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-08-29 00:38:57.590189 :C5FBA32B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-08-29 00:38:57.590406 :C5FBA32C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-08-29 00:38:57.590420 :C5FBA32D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-08-29 00:38:57.590628 :C5FBA32E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-08-29 00:38:57.590641 :C5FBA32F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-08-29 00:38:57.590843 :C5FBA330:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-08-29 00:38:57.590856 :C5FBA331:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-08-29 00:38:57.591062 :C5FBA332:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-08-29 00:38:57.591075 :C5FBA333:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-08-29 00:38:57.593429 :C5FBA334:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-08-29 01:00:14.394478 :C5FD4BC6:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 08-29 01:00:14.379 2025-08-29 01:00:14.394480 :C5FD4BC7:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=20856 pso_num=29 pso_serial#=21 2025-08-29 01:00:14.394626 :C5FD4BC8:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=20856 (legacy spawn) 2025-08-29 01:00:14.401465 :C5FD4BC9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 01:00:14.401639 :C5FD4BCE:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-08-29 01:00:14.402547 :C5FD4BD3:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-08-29 01:00:14.411728 :C5FD4BD6:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 08-29 01:00:14.410 2025-08-29 01:00:14.411731 :C5FD4BD7:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=22264 pso_num=29 pso_serial#=22 2025-08-29 01:00:14.411872 :C5FD4BD8:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=22264 (legacy spawn) 2025-08-29 01:00:14.418745 :C5FD4BD9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 01:00:14.418920 :C5FD4BE2:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-08-29 01:00:14.419858 :C5FD4BE3:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-08-29 01:00:17.600238 :C5FD4CDF:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 08-29 01:00:17.587 2025-08-29 01:00:17.600240 :C5FD4CE0:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=7196 pso_num=29 pso_serial#=23 2025-08-29 01:00:17.600378 :C5FD4CE1:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=7196 (legacy spawn) 2025-08-29 01:00:17.606960 :C5FD4CE2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 01:00:17.607136 :C5FD4CE7:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-08-29 01:00:17.607944 :C5FD4CEC:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-08-29 01:00:17.624971 :C5FD4CEF:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 08-29 01:00:17.618 2025-08-29 01:00:17.624973 :C5FD4CF0:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=16120 pso_num=29 pso_serial#=24 2025-08-29 01:00:17.625110 :C5FD4CF1:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=16120 (legacy spawn) 2025-08-29 01:00:17.631544 :C5FD4CF2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 01:00:17.631717 :C5FD4CFB:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-08-29 01:00:17.632518 :C5FD4CFC:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-08-29 01:00:27.897142 :C5FD5023:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 08-29 01:00:27.888 2025-08-29 01:00:27.897144 :C5FD5024:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=22572 pso_num=29 pso_serial#=25 2025-08-29 01:00:27.897282 :C5FD5025:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=22572 (legacy spawn) 2025-08-29 01:00:27.904035 :C5FD5026:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 01:00:27.904214 :C5FD502B:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-08-29 01:00:27.905076 :C5FD5030:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-08-29 01:01:01.949779 :C5FD5CF4:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 08-29 01:01:01.942 2025-08-29 01:01:01.949781 :C5FD5CF5:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=23512 pso_num=29 pso_serial#=26 2025-08-29 01:01:01.949914 :C5FD5CF6:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=23512 osp_idx=27 osp_ver=16600 osp_pg=0 (spawn #536235) 2025-08-29 01:01:01.949914 :C5FD5CF7:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-29 01:01:01.949915 :C5FD5CF8:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=255 time=814913252 2025-08-29 01:01:01.949915 :C5FD5CF9:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-08-29 01:01:01.949916 :C5FD5CFA:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-08-29 01:01:01.949916 :C5FD5CFB:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-08-29 01:01:01.949916 :C5FD5CFC:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-29 01:01:01.949917 :C5FD5CFD:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-29 01:01:01.950405 :C5FD5CFE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-29 01:01:01.950450 :C5FD5D04:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-08-29 01:01:01.957924 :C5FD5D12:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 01:01:01.959040 :C5FD5D1A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 01:01:01.959632 :C5FD5D22:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 01:01:01.960108 :C5FD5D2A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 01:01:01.960539 :C5FD5D32:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 01:01:01.962991 :C5FD5D3A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 01:01:01.964123 :C5FD5D42:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 01:01:02.015597 :C5FD5D4A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 01:01:02.016546 :C5FD5D52:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 01:01:02.016787 :C5FD5D5A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 01:01:02.017010 :C5FD5D62:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 01:01:02.018759 :C5FD5D6A:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-08-29 01:09:01.627762 :C5FE0579:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 08-29 01:09:01.615 2025-08-29 01:09:01.627764 :C5FE057A:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=17956 pso_num=29 pso_serial#=27 2025-08-29 01:09:01.627899 :C5FE057B:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=17956 osp_idx=27 osp_ver=16601 osp_pg=0 (spawn #536255) 2025-08-29 01:09:01.627900 :C5FE057C:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-29 01:09:01.627902 :C5FE057D:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=0 time=815392924 2025-08-29 01:09:01.627902 :C5FE057E:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-08-29 01:09:01.627903 :C5FE057F:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-08-29 01:09:01.627903 :C5FE0580:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-08-29 01:09:01.627903 :C5FE0581:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-29 01:09:01.627904 :C5FE0582:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-29 01:09:01.628400 :C5FE0583:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-29 01:09:01.628439 :C5FE0589:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-08-29 01:09:01.632555 :C5FE05A2:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-08-29 01:09:01.632597 :C5FE05A3:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-08-29 01:09:01.632849 :C5FE05A4:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-08-29 01:09:01.632864 :C5FE05A5:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-08-29 01:09:01.633078 :C5FE05A6:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-08-29 01:09:01.633091 :C5FE05A7:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-08-29 01:09:01.633302 :C5FE05A8:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-08-29 01:09:01.633316 :C5FE05A9:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-08-29 01:09:01.633520 :C5FE05AA:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-08-29 01:09:01.633533 :C5FE05AB:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-08-29 01:09:01.633734 :C5FE05AC:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-08-29 01:09:01.633747 :C5FE05AD:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-08-29 01:09:01.636090 :C5FE05AE:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-08-29 08:16:38.585824 :C61FC78D:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 08-29 08:16:38.574 2025-08-29 08:16:38.585826 :C61FC78E:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=23212 pso_num=29 pso_serial#=28 2025-08-29 08:16:38.588259 :C61FC78F:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=23212 osp_idx=27 osp_ver=16602 osp_pg=0 (spawn #537238) 2025-08-29 08:16:38.588260 :C61FC790:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-29 08:16:38.588261 :C61FC791:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=1 time=841049862 2025-08-29 08:16:38.588262 :C61FC792:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-08-29 08:16:38.588262 :C61FC793:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-08-29 08:16:38.588263 :C61FC794:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-08-29 08:16:38.588263 :C61FC795:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-29 08:16:38.588263 :C61FC796:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-29 08:16:38.589100 :C61FC797:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-29 08:16:38.589147 :C61FC79D:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-08-29 08:16:38.589611 :C61FC79E:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-08-29 08:16:40.780533 :C61FC886:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 08-29 08:16:40.778 2025-08-29 08:16:40.780535 :C61FC887:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=19676 pso_num=29 pso_serial#=29 2025-08-29 08:16:40.780691 :C61FC888:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=19676 osp_idx=27 osp_ver=16603 osp_pg=0 (spawn #537240) 2025-08-29 08:16:40.780692 :C61FC889:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-29 08:16:40.780693 :C61FC88A:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=2 time=841052065 2025-08-29 08:16:40.780694 :C61FC88B:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-08-29 08:16:40.780694 :C61FC88C:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-08-29 08:16:40.780694 :C61FC88D:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-08-29 08:16:40.780695 :C61FC88E:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-29 08:16:40.780695 :C61FC88F:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-29 08:16:40.781330 :C61FC890:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-29 08:16:40.781381 :C61FC896:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-08-29 08:16:40.781848 :C61FC897:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-08-29 22:00:01.297443 :C660854D:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 08-29 22:00:01.291 2025-08-29 22:00:01.297444 :C660854E:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=21800 pso_num=29 pso_serial#=30 2025-08-29 22:00:01.297563 :C660854F:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=21800 osp_idx=27 osp_ver=16604 osp_pg=0 (spawn #539145) 2025-08-29 22:00:01.297564 :C6608550:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-29 22:00:01.297565 :C6608551:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=3 time=890452596 2025-08-29 22:00:01.297565 :C6608552:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-08-29 22:00:01.297566 :C6608553:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-08-29 22:00:01.297566 :C6608554:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-08-29 22:00:01.297567 :C6608555:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-29 22:00:01.297567 :C6608556:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-29 22:00:01.298076 :C6608557:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-29 22:00:01.303307 :C6608578:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 22:00:01.303371 :C6608581:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:jslv.c:9203 2025-08-29 22:00:01.321304 :C660873A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 22:00:01.321539 :C6608742:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 22:00:01.321713 :C660874A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 22:00:01.321893 :C6608752:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 22:00:01.322374 :C660875A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 22:00:01.322605 :C6608762:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 22:00:01.322771 :C660876A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 22:00:01.323048 :C6608772:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 22:00:01.323309 :C660877A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 22:00:01.323555 :C6608782:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 22:00:01.324191 :C660878A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 22:00:01.324421 :C6608792:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 22:00:01.324687 :C660879A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 22:00:01.324846 :C66087A2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 22:00:01.324997 :C66087AA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 22:00:01.325245 :C66087B2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 22:00:01.325399 :C66087BA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 22:00:01.325546 :C66087C2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 22:00:01.325715 :C66087CA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 22:00:01.325880 :C66087D2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 22:00:01.326026 :C66087DA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 22:00:01.326173 :C66087E2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 22:00:01.326322 :C66087EA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 22:00:01.326484 :C66087F2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 22:00:01.326638 :C66087FA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 22:00:01.326791 :C6608802:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 22:00:01.354024 :C6608816:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 22:00:03.039872 :C6608AC5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 22:00:03.063045 :C6608AD6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 22:00:03.065371 :C6608ADE:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:psdpgi.c:2235 2025-08-29 22:00:03.065621 :C6608ADF:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:psdpgi.c:2235 2025-08-29 22:00:03.066645 :C6608AE0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 22:00:03.066752 :C6608AE3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 22:00:03.067723 :C6608AF5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 22:00:03.069527 :C6608AFD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 22:00:03.069859 :C6608B05:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 22:00:03.134086*:SQL_Analyze:qksan.c@3402:qksanAnalyzeSql(begin): qksanAnalyzeSql(enter): goal=15 options=16778048 pgadep=0 binds#=0 byPos=0 timeLim=0 timeFired=0 2025-08-29 22:00:03.134086*:SQL_Analyze:qksan.c@936:qksanBindSql(begin): binding for SQL analyze 2025-08-29 22:00:03.134086*:SQL_Analyze:qksan.c@1344:qksanBindSql(end): Done binding: status=0 ret=0 bind#=0 byPos=1 wasBoundP=0x0000000000000000 bindIndP=0x0000000000000000 2025-08-29 22:00:03.134086*:SQL_Analyze:qksan.c@6338:qksanAvgExecStats(): The number of total executions: 1 and execution count: 0 2025-08-29 22:00:03.134086*:SQL_Analyze:qksan.c@4776:qksanPostAnalyzeDump(begin): qksanPostAnalyzeDump(): Dumping analyze context after compilation qksanStatus=SUCCESS ecode=0 2025-08-29 22:00:03.134086*:SQL_Analyze:qksan.c@4800:qksanPostAnalyzeDump(end): 2025-08-29 22:00:03.134086*:SQL_Analyze:qksan.c@3690:qksanAnalyzeSql(end): exit: ecode=0 status=0 2025-08-29 22:00:03.210613 :C6608BE9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 22:00:05.094973 :C6608D32:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-29 22:00:05.094984 :C6608D33:db_trace:ktur.c@3079:ktuabt(): [10444:29:233] ABORT TRANSACTION - xid: 0x0009.016.0001dbda ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 29 (osid: 21800, J003)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de