Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250906180414\orcl_j000_17424_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250906180414\orcl_j000_17424_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:34994M/63366M, Ph+PgF:39840M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 25 Windows thread id: 17424, image: ORACLE.EXE (J000) *** 2025-09-06 18:04:15.052 *** SESSION ID:(201.36417) 2025-09-06 18:04:15.052 *** 2025-09-06 18:04:15.052 Process diagnostic dump for ORACLE.EXE (J000), OS id=17424, pid: 25, proc_ser: 105, sid: 201, sess_ser: 36417 ------------------------------------------------------------------------------- current sql: call dbms_stats.gather_database_stats_job_proc ( ) client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 17424 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J000) application name: DBMS_SCHEDULER, hash value=2478762354 action name: ORA$AT_OS_OPT_SY_13038, hash value=3553074211 Current Wait Stack: Not in wait; last wait ended 2.643141 sec ago Wait State: fixed_waits=0 flags=0x21 boundary=0x0000000000000000/-1 Session Wait History: elapsed time of 2.643166 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.000174 sec, exc=0.000174 sec, total=0.000174 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.054822 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.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.753016 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.025129 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.012851 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.000116 sec, exc=0.000116 sec, total=0.000116 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.049151 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.006286 sec, exc=0.006286 sec, total=0.006286 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.007830 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.000118 sec, exc=0.000118 sec, total=0.000118 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.261458 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.004258 sec, exc=0.004258 sec, total=0.004258 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000510 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.000098 sec, exc=0.000098 sec, total=0.000098 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.009459 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.000000 sec, exc=0.000000 sec, total=0.000000 sec wait times: max=307445734561 min 49 sec wait counts: calls=0 os=0 occurred after 0.000081 sec of elapsed time Sampled Session History of session 201 serial 36417 --------------------------------------------------- The sampled session history is constructed by sampling the target session every 1 second. The sampling process captures at each sample if the session is in a non-idle wait, an idle wait, or not in a wait. If the session is in a non-idle wait then one interval is shown for all the samples the session was in the same non-idle wait. If the session is in an idle wait or not in a wait for consecutive samples then one interval is shown for all the consecutive samples. Though we display these consecutive samples in a single interval the session may NOT be continuously idle or not in a wait (the sampling process does not know). The history is displayed in reverse chronological order. sample interval: 1 sec, max history 120 sec --------------------------------------------------- [4 samples, 18:04:11 - 18:04:14] not in wait at each sample [1 sample, 18:04:10] idle wait at each sample [session created at: 18:04:10] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-09-06 18:04:15.052 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 25 (osid: 17424, J000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-09-06 18:01:45.793632 :C9DC5520: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-09-06 18:01:45.794616 :C9DC5521:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-06 18:01:45.813388 :C9DC5524:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-06 18:01:45.803 2025-09-06 18:01:45.813390 :C9DC5525:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=19584 pso_num=25 pso_serial#=90 2025-09-06 18:01:45.813543 :C9DC5526:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=19584 (legacy spawn) 2025-09-06 18:01:45.820816 :C9DC5527: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-09-06 18:01:45.820999 :C9DC5530: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-09-06 18:01:45.821926 :C9DC5531:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-06 18:02:06.145012 :C9DC5B3F:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-06 18:02:06.134 2025-09-06 18:02:06.145015 :C9DC5B40:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=22460 pso_num=25 pso_serial#=91 2025-09-06 18:02:06.145177 :C9DC5B41:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=22460 (legacy spawn) 2025-09-06 18:02:06.152390 :C9DC5B42: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-09-06 18:02:06.152611 :C9DC5B49: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-09-06 18:02:06.153583 :C9DC5B4C:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-06 18:02:10.519370 :C9DC5CC7:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-06 18:02:10.514 2025-09-06 18:02:10.519372 :C9DC5CC8:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=20932 pso_num=25 pso_serial#=92 2025-09-06 18:02:10.519508 :C9DC5CC9:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=20932 osp_idx=23 osp_ver=283155 osp_pg=0 (spawn #565276) 2025-09-06 18:02:10.519508 :C9DC5CCA:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-06 18:02:10.519509 :C9DC5CCB:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=187 time=1567381830 2025-09-06 18:02:10.519509 :C9DC5CCC:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-06 18:02:10.519510 :C9DC5CCD:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-06 18:02:10.519510 :C9DC5CCE:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-06 18:02:10.519510 :C9DC5CCF:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-06 18:02:10.519511 :C9DC5CD0:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-06 18:02:10.520005 :C9DC5CD1: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-09-06 18:02:10.520643 :C9DC5CE6: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-09-06 18:02:10.534967 :C9DC5D15:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:psdpgi.c:2235 2025-09-06 18:02:10.535051 :C9DC5D16:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:psdpgi.c:2235 2025-09-06 18:02:10.535892 :C9DC5D17:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:psdpgi.c:2235 2025-09-06 18:02:10.536221 :C9DC5D18: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-09-06 18:02:10.536263 :C9DC5D1B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:psdpgi.c:2235 2025-09-06 18:02:10.544174 :C9DC5D21: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-09-06 18:02:10.544243 :C9DC5D24:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:ktcc.c:879 2025-09-06 18:02:10.544280 :C9DC5D25:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:ktcc.c:879 2025-09-06 18:02:10.544673 :C9DC5D2B:db_trace:kwqid.c@2146:kwqidrdq(): [10960:25:201] kwqidrdq: Error: 1403 occured in OCI execute 2025-09-06 18:02:10.545038 :C9DC5D2C:db_trace:kwqid.c@2146:kwqidrdq(): [10960:25:201] kwqidrdq: Error: 1403 occured in OCI execute 2025-09-06 18:02:10.545234 :C9DC5D2D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:psdpgi.c:2235 2025-09-06 18:02:10.545481 :C9DC5D2E: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-09-06 18:02:10.545507 :C9DC5D31:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:psdpgi.c:2235 2025-09-06 18:02:10.547191 :C9DC5D37:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:psdpgi.c:2235 2025-09-06 18:02:10.547449 :C9DC5D38: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-09-06 18:02:10.547480 :C9DC5D3B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:psdpgi.c:2235 2025-09-06 18:02:10.548409 :C9DC5D41: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-09-06 18:02:10.548542 :C9DC5D4A: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-09-06 18:02:40.645727 :C9DC66FC:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-06 18:02:46.999492 :C9DC68D8:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-06 18:02:46.991 2025-09-06 18:02:46.999494 :C9DC68D9:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=24236 pso_num=25 pso_serial#=93 2025-09-06 18:02:46.999628 :C9DC68DA:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=24236 (legacy spawn) 2025-09-06 18:02:47.006137 :C9DC68DB: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-09-06 18:02:47.006312 :C9DC68E4: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-09-06 18:02:47.007156 :C9DC68E5:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-06 18:02:55.404324 :C9DC6E6C:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-06 18:02:55.390 2025-09-06 18:02:55.404326 :C9DC6E6D:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=20004 pso_num=25 pso_serial#=94 2025-09-06 18:02:55.404468 :C9DC6E6E:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=20004 (legacy spawn) 2025-09-06 18:02:55.410995 :C9DC6E6F: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-09-06 18:02:55.411171 :C9DC6E78: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-09-06 18:02:55.411959 :C9DC6E79:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-06 18:02:55.429911 :C9DC6E7C:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-06 18:02:55.421 2025-09-06 18:02:55.429913 :C9DC6E7D:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=24140 pso_num=25 pso_serial#=95 2025-09-06 18:02:55.430046 :C9DC6E7E:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=24140 (legacy spawn) 2025-09-06 18:02:55.436605 :C9DC6E7F: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-09-06 18:02:55.436768 :C9DC6E87: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-09-06 18:02:55.437577 :C9DC6E89:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-06 18:02:58.490991 :C9DC6F82:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-06 18:02:58.478 2025-09-06 18:02:58.490993 :C9DC6F83:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=21620 pso_num=25 pso_serial#=96 2025-09-06 18:02:58.491133 :C9DC6F84:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=21620 (legacy spawn) 2025-09-06 18:02:58.497682 :C9DC6F85: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-09-06 18:02:58.497861 :C9DC6F8A: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-09-06 18:02:58.498657 :C9DC6F8F:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-06 18:02:58.507425 :C9DC6F92:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-06 18:02:58.494 2025-09-06 18:02:58.507427 :C9DC6F93:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=20476 pso_num=25 pso_serial#=97 2025-09-06 18:02:58.507607 :C9DC6F94:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=20476 (legacy spawn) 2025-09-06 18:02:58.514073 :C9DC6F95: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-09-06 18:02:58.514247 :C9DC6F9E: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-09-06 18:02:58.515078 :C9DC6F9F:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-06 18:03:10.607562 :C9DC7366:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-06 18:03:10.601 2025-09-06 18:03:10.607564 :C9DC7367:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=23876 pso_num=25 pso_serial#=98 2025-09-06 18:03:10.607704 :C9DC7368:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=23876 osp_idx=23 osp_ver=283161 osp_pg=0 (spawn #565278) 2025-09-06 18:03:10.607704 :C9DC7369:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-06 18:03:10.607705 :C9DC736A:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=188 time=1567441908 2025-09-06 18:03:10.607705 :C9DC736B:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-06 18:03:10.607706 :C9DC736C:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-06 18:03:10.607706 :C9DC736D:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-06 18:03:10.607706 :C9DC736E:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-06 18:03:10.607707 :C9DC736F:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-06 18:03:10.608237 :C9DC7370: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-09-06 18:03:10.608889 :C9DC7385: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-09-06 18:03:10.616436 :C9DC739C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:psdpgi.c:2235 2025-09-06 18:03:10.616808 :C9DC739D: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-09-06 18:03:10.616837 :C9DC739E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:psdpgi.c:2235 2025-09-06 18:03:10.631588 :C9DC73AB: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-09-06 18:03:40.702890 :C9DC7D0F:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-06 18:03:48.252369 :C9DC7F45:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-06 18:03:48.243 2025-09-06 18:03:48.252371 :C9DC7F46:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=23016 pso_num=25 pso_serial#=99 2025-09-06 18:03:48.252506 :C9DC7F47:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=23016 (legacy spawn) 2025-09-06 18:03:48.258991 :C9DC7F48: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-09-06 18:03:48.259160 :C9DC7F4D: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-09-06 18:03:48.259951 :C9DC7F52:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-06 18:03:49.158367 :C9DC7F96:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-06 18:03:49.150 2025-09-06 18:03:49.158369 :C9DC7F97:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=24036 pso_num=25 pso_serial#=100 2025-09-06 18:03:49.158508 :C9DC7F98:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=24036 (legacy spawn) 2025-09-06 18:03:49.165508 :C9DC7F99: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-09-06 18:03:49.165696 :C9DC7F9E: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-09-06 18:03:49.166599 :C9DC7FA3:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-06 18:03:56.458545 :C9DC81BC:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-06 18:03:56.450 2025-09-06 18:03:56.458547 :C9DC81BD:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=17500 pso_num=25 pso_serial#=101 2025-09-06 18:03:56.458683 :C9DC81BE:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=17500 (legacy spawn) 2025-09-06 18:03:56.465121 :C9DC81BF: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-09-06 18:03:56.465306 :C9DC81C8: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-09-06 18:03:56.466115 :C9DC81C9:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-06 18:04:07.996767 :C9DC8546:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-06 18:04:07.985 2025-09-06 18:04:07.996770 :C9DC8547:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=22484 pso_num=25 pso_serial#=102 2025-09-06 18:04:07.996920 :C9DC8548:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=22484 (legacy spawn) 2025-09-06 18:04:08.003962 :C9DC8549: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-09-06 18:04:08.004168 :C9DC8551: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-09-06 18:04:08.005086 :C9DC8552:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-06 18:04:08.014351 :C9DC8555:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-06 18:04:08.001 2025-09-06 18:04:08.014354 :C9DC8556:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=23784 pso_num=25 pso_serial#=103 2025-09-06 18:04:08.014513 :C9DC8557:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=23784 (legacy spawn) 2025-09-06 18:04:08.021657 :C9DC8558: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-09-06 18:04:08.021834 :C9DC8561: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-09-06 18:04:08.022847 :C9DC8562:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-06 18:04:10.521404 :C9DC8630:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-06 18:04:10.516 2025-09-06 18:04:10.521407 :C9DC8631:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=22608 pso_num=25 pso_serial#=104 2025-09-06 18:04:10.521548 :C9DC8632:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=22608 osp_idx=23 osp_ver=283167 osp_pg=0 (spawn #565280) 2025-09-06 18:04:10.521549 :C9DC8633:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-06 18:04:10.521550 :C9DC8634:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=189 time=1567501830 2025-09-06 18:04:10.521550 :C9DC8635:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-06 18:04:10.521550 :C9DC8636:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-06 18:04:10.521551 :C9DC8637:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-06 18:04:10.521551 :C9DC8638:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-06 18:04:10.521551 :C9DC8639:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-06 18:04:10.522108 :C9DC863A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-06 18:04:10.522157 :C9DC8640:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-09-06 18:04:10.543748 :C9DC86C6:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-06 18:04:10.635073 :C9DC87C5:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-06 18:04:10.625 2025-09-06 18:04:10.635075 :C9DC87C6:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=17424 pso_num=25 pso_serial#=105 2025-09-06 18:04:10.635674 :C9DC87C7:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=17424 osp_idx=23 osp_ver=283168 osp_pg=0 (spawn #565284) 2025-09-06 18:04:10.635676 :C9DC87C8:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-06 18:04:10.635677 :C9DC87C9:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=190 time=1567501940 2025-09-06 18:04:10.635678 :C9DC87CA:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-06 18:04:10.635679 :C9DC87CB:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-06 18:04:10.635679 :C9DC87CC:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-06 18:04:10.635679 :C9DC87CD:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-06 18:04:10.635681 :C9DC87CE:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-06 18:04:10.636683 :C9DC87CF: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-09-06 18:04:10.642194 :C9DC87EE: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-09-06 18:04:10.642250 :C9DC87F1:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:jslv.c:9203 2025-09-06 18:04:10.660261 :C9DC8807: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-09-06 18:04:10.660480 :C9DC880F: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-09-06 18:04:10.660644 :C9DC8817: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-09-06 18:04:10.660799 :C9DC881F: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-09-06 18:04:10.661015 :C9DC8827: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-09-06 18:04:10.661253 :C9DC882F: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-09-06 18:04:10.661397 :C9DC8837: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-09-06 18:04:10.661731 :C9DC883F: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-09-06 18:04:10.661970 :C9DC8847: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-09-06 18:04:10.662293 :C9DC884F: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-09-06 18:04:10.662440 :C9DC8857: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-09-06 18:04:10.662593 :C9DC885F: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-09-06 18:04:10.681556 :C9DC8867: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-09-06 18:04:12.331995 :C9DC8AF7: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-09-06 18:04:12.338890 :C9DC8B07: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-09-06 18:04:12.359947 :C9DC8B29: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-09-06 18:04:12.361947 :C9DC8B31:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:psdpgi.c:2235 2025-09-06 18:04:12.362180 :C9DC8B32:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:psdpgi.c:2235 2025-09-06 18:04:12.363107 :C9DC8B33: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-09-06 18:04:12.363205 :C9DC8B36: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-09-06 18:04:12.364088 :C9DC8B48: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-09-06 18:04:12.365689 :C9DC8B50: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-09-06 18:04:12.365974 :C9DC8B58: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-09-06 18:04:12.416663*:SQL_Analyze:qksan.c@3402:qksanAnalyzeSql(begin): qksanAnalyzeSql(enter): goal=15 options=16778048 pgadep=0 binds#=0 byPos=0 timeLim=0 timeFired=0 2025-09-06 18:04:12.416663*:SQL_Analyze:qksan.c@936:qksanBindSql(begin): binding for SQL analyze 2025-09-06 18:04:12.416663*:SQL_Analyze:qksan.c@1344:qksanBindSql(end): Done binding: status=0 ret=0 bind#=0 byPos=1 wasBoundP=0x0000000000000000 bindIndP=0x0000000000000000 2025-09-06 18:04:12.463538*:SQL_Analyze:qksan.c@6338:qksanAvgExecStats(): The number of total executions: 1 and execution count: 0 2025-09-06 18:04:12.463538*:SQL_Analyze:qksan.c@4776:qksanPostAnalyzeDump(begin): qksanPostAnalyzeDump(): Dumping analyze context after compilation qksanStatus=SUCCESS ecode=0 2025-09-06 18:04:12.463538*:SQL_Analyze:qksan.c@4800:qksanPostAnalyzeDump(end): 2025-09-06 18:04:12.463538*:SQL_Analyze:qksan.c@3690:qksanAnalyzeSql(end): exit: ecode=0 status=0 2025-09-06 18:04:12.527772 :C9DC8BE3: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-09-06 18:04:14.483859 :C9DC8C8C: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-09-06 18:04:14.483873 :C9DC8C8D:db_trace:ktur.c@3079:ktuabt(): [10444:25:201] ABORT TRANSACTION - xid: 0x000a.006.0017b8a2 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 25 (osid: 17424, J000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de