Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250502220007\orcl_j002_8612_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250502220007\orcl_j002_8612_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:37547M/63366M, Ph+PgF:45065M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 27 Windows thread id: 8612, image: ORACLE.EXE (J002) *** 2025-05-02 22:00:07.744 *** SESSION ID:(219.15459) 2025-05-02 22:00:07.744 *** 2025-05-02 22:00:07.744 Process diagnostic dump for ORACLE.EXE (J002), OS id=8612, pid: 27, proc_ser: 171, sid: 219, sess_ser: 15459 ------------------------------------------------------------------------------- current sql: call dbms_stats.gather_database_stats_job_proc ( ) client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 8612 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J002) application name: DBMS_SCHEDULER, hash value=2478762354 action name: ORA$AT_OS_OPT_SY_12362, hash value=1050146501 Current Wait Stack: Not in wait; last wait ended 0.773851 sec ago Wait State: fixed_waits=0 flags=0x21 boundary=0x0000000000000000/-1 Session Wait History: elapsed time of 0.773877 sec since last wait 0: waited for 'Disk file operations I/O' FileOperation=0x5, fileno=0x0, filetype=0x3 wait_id=144 seq_num=145 snap_id=1 wait times: snap=0.000290 sec, exc=0.000290 sec, total=0.000290 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000004 sec of elapsed time 1: waited for 'log file sequential read' log#=0x2767, block#=0x0, blocks=0x0 wait_id=143 seq_num=144 snap_id=1 wait times: snap=0.000004 sec, exc=0.000004 sec, total=0.000004 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.031185 sec of elapsed time 2: waited for 'log file sequential read' log#=0x2767, block#=0x0, blocks=0x0 wait_id=142 seq_num=143 snap_id=1 wait times: snap=0.000018 sec, exc=0.000018 sec, total=0.000018 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.373321 sec of elapsed time 3: waited for 'log file sequential read' log#=0x0, block#=0x3000, blocks=0x800 wait_id=141 seq_num=142 snap_id=1 wait times: snap=0.000282 sec, exc=0.000282 sec, total=0.000282 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000004 sec of elapsed time 4: waited for 'log file sequential read' log#=0x0, block#=0x2800, blocks=0x800 wait_id=140 seq_num=141 snap_id=1 wait times: snap=0.000273 sec, exc=0.000273 sec, total=0.000273 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000049 sec of elapsed time 5: waited for 'log file sequential read' log#=0x0, block#=0x2000, blocks=0x800 wait_id=139 seq_num=140 snap_id=1 wait times: snap=0.000287 sec, exc=0.000287 sec, total=0.000287 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.013036 sec of elapsed time 6: waited for 'log file sequential read' log#=0x2767, block#=0x800, blocks=0x800 wait_id=138 seq_num=139 snap_id=1 wait times: snap=0.000210 sec, exc=0.000210 sec, total=0.000210 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.115257 sec of elapsed time 7: waited for 'log file sequential read' log#=0x2767, block#=0x0, blocks=0x0 wait_id=137 seq_num=138 snap_id=1 wait times: snap=0.000001 sec, exc=0.000001 sec, total=0.000001 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000146 sec of elapsed time 8: waited for 'log file sequential read' log#=0x2767, block#=0x2, blocks=0x7fe wait_id=136 seq_num=137 snap_id=1 wait times: snap=0.000200 sec, exc=0.000200 sec, total=0.000200 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000166 sec of elapsed time 9: waited for 'log file sequential read' log#=0x0, block#=0x1, blocks=0x1 wait_id=135 seq_num=136 snap_id=1 wait times: snap=0.000053 sec, exc=0.000053 sec, total=0.000053 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000005 sec of elapsed time Sampled Session History of session 219 serial 15459 --------------------------------------------------- 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 --------------------------------------------------- [7 samples, 22:00:01 - 22:00:07] 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-05-02 22:00:07.744 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 27 (osid: 8612, J002) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-02 21:19:03.294832 :91D506F8:db_trace:kso.c@4111:ksonfy(): [10420:27:0] kso: spawn diagnostics: fork time=0 secs 2025-05-02 21:19:03.294832 :91D506F9:db_trace:kso.c@4113:ksonfy(): [10420:27:0] kso: spawn diagnostics: exec time=0 secs 2025-05-02 21:19:03.294832 :91D506FA:db_trace:kso.c@4115:ksonfy(): [10420:27:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-02 21:19:03.294833 :91D506FB:db_trace:kso.c@4117:ksonfy(): [10420:27:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-02 21:19:03.295323 :91D506FC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-02 21:19:03.295367 :91D50704:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-05-02 21:19:03.301606 :91D50710:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-05-02 21:25:55.156464 :91D58F3A:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 05-02 21:25:55.144 2025-05-02 21:25:55.156466 :91D58F3B:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=11420 pso_num=27 pso_serial#=168 2025-05-02 21:25:55.156597 :91D58F3C:db_trace:kso.c@4093:ksonfy(): [10420:27:0] kso: new process: pid=11420 osp_idx=25 osp_ver=40457 osp_pg=0 (spawn #141847) 2025-05-02 21:25:55.156598 :91D58F3D:db_trace:kso.c@4099:ksonfy(): [10420:27:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-02 21:25:55.156598 :91D58F3E:db_trace:kso.c@4103:ksonfy(): [10420:27:0] kso: new process: pso_index=27 reservation=240 time=3491944625 2025-05-02 21:25:55.156599 :91D58F3F:db_trace:kso.c@4109:ksonfy(): [10420:27:0] kso: spawn diagnostics: queue time=0 secs 2025-05-02 21:25:55.156599 :91D58F40:db_trace:kso.c@4111:ksonfy(): [10420:27:0] kso: spawn diagnostics: fork time=0 secs 2025-05-02 21:25:55.156599 :91D58F41:db_trace:kso.c@4113:ksonfy(): [10420:27:0] kso: spawn diagnostics: exec time=0 secs 2025-05-02 21:25:55.156600 :91D58F42:db_trace:kso.c@4115:ksonfy(): [10420:27:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-02 21:25:55.156600 :91D58F43:db_trace:kso.c@4117:ksonfy(): [10420:27:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-02 21:25:55.157099 :91D58F44:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-02 21:25:55.157137 :91D58F4A:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-05-02 21:25:55.161235 :91D58F63:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:kelt.c:517 2025-05-02 21:25:55.161277 :91D58F64:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:kelt.c:517 2025-05-02 21:25:55.161526 :91D58F65:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:kelt.c:517 2025-05-02 21:25:55.161541 :91D58F66:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:kelt.c:517 2025-05-02 21:25:55.161745 :91D58F67:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:kelt.c:517 2025-05-02 21:25:55.161758 :91D58F68:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:kelt.c:517 2025-05-02 21:25:55.161964 :91D58F69:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:kelt.c:517 2025-05-02 21:25:55.161979 :91D58F6A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:kelt.c:517 2025-05-02 21:25:55.162183 :91D58F6B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:kelt.c:517 2025-05-02 21:25:55.162196 :91D58F6C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:kelt.c:517 2025-05-02 21:25:55.162395 :91D58F6D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:kelt.c:517 2025-05-02 21:25:55.162408 :91D58F6E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:kelt.c:517 2025-05-02 21:25:55.164813 :91D58F6F:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-05-02 21:55:59.464412 :91D7E5DD:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 05-02 21:55:59.452 2025-05-02 21:55:59.464414 :91D7E5DE:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=11624 pso_num=27 pso_serial#=169 2025-05-02 21:55:59.464552 :91D7E5DF:db_trace:kso.c@4093:ksonfy(): [10420:27:0] kso: new process: pid=11624 osp_idx=25 osp_ver=40458 osp_pg=0 (spawn #141915) 2025-05-02 21:55:59.464552 :91D7E5E0:db_trace:kso.c@4099:ksonfy(): [10420:27:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-02 21:55:59.464553 :91D7E5E1:db_trace:kso.c@4103:ksonfy(): [10420:27:0] kso: new process: pso_index=27 reservation=241 time=3493748937 2025-05-02 21:55:59.464553 :91D7E5E2:db_trace:kso.c@4109:ksonfy(): [10420:27:0] kso: spawn diagnostics: queue time=0 secs 2025-05-02 21:55:59.464553 :91D7E5E3:db_trace:kso.c@4111:ksonfy(): [10420:27:0] kso: spawn diagnostics: fork time=0 secs 2025-05-02 21:55:59.464554 :91D7E5E4:db_trace:kso.c@4113:ksonfy(): [10420:27:0] kso: spawn diagnostics: exec time=0 secs 2025-05-02 21:55:59.464554 :91D7E5E5:db_trace:kso.c@4115:ksonfy(): [10420:27:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-02 21:55:59.464554 :91D7E5E6:db_trace:kso.c@4117:ksonfy(): [10420:27:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-02 21:55:59.465124 :91D7E5E7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-02 21:55:59.465163 :91D7E5ED:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-05-02 21:55:59.469140 :91D7E616:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:kelt.c:517 2025-05-02 21:55:59.469201 :91D7E617:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:kelt.c:517 2025-05-02 21:55:59.469488 :91D7E618:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:kelt.c:517 2025-05-02 21:55:59.469504 :91D7E619:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:kelt.c:517 2025-05-02 21:55:59.469726 :91D7E61A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:kelt.c:517 2025-05-02 21:55:59.469740 :91D7E61B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:kelt.c:517 2025-05-02 21:55:59.469953 :91D7E61C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:kelt.c:517 2025-05-02 21:55:59.469967 :91D7E61D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:kelt.c:517 2025-05-02 21:55:59.470180 :91D7E61E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:kelt.c:517 2025-05-02 21:55:59.470193 :91D7E61F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:kelt.c:517 2025-05-02 21:55:59.470395 :91D7E620:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:kelt.c:517 2025-05-02 21:55:59.470409 :91D7E621:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:kelt.c:517 2025-05-02 21:55:59.472653 :91D7E622:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-05-02 22:00:00.041313 :91D834C5:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 05-02 22:00:00.031 2025-05-02 22:00:00.041316 :91D834C6:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=2860 pso_num=27 pso_serial#=170 2025-05-02 22:00:00.041459 :91D834C7:db_trace:kso.c@4093:ksonfy(): [10420:27:0] kso: new process: pid=2860 osp_idx=25 osp_ver=40459 osp_pg=0 (spawn #141926) 2025-05-02 22:00:00.041459 :91D834C8:db_trace:kso.c@4099:ksonfy(): [10420:27:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-02 22:00:00.041460 :91D834C9:db_trace:kso.c@4103:ksonfy(): [10420:27:0] kso: new process: pso_index=27 reservation=242 time=3493989515 2025-05-02 22:00:00.041460 :91D834CA:db_trace:kso.c@4109:ksonfy(): [10420:27:0] kso: spawn diagnostics: queue time=0 secs 2025-05-02 22:00:00.041460 :91D834CB:db_trace:kso.c@4111:ksonfy(): [10420:27:0] kso: spawn diagnostics: fork time=0 secs 2025-05-02 22:00:00.041461 :91D834CC:db_trace:kso.c@4113:ksonfy(): [10420:27:0] kso: spawn diagnostics: exec time=0 secs 2025-05-02 22:00:00.041461 :91D834CD:db_trace:kso.c@4115:ksonfy(): [10420:27:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-02 22:00:00.041461 :91D834CE:db_trace:kso.c@4117:ksonfy(): [10420:27:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-02 22:00:00.041974 :91D834CF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-02 22:00:00.042020 :91D834D6:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-05-02 22:00:00.042099 :91D834E9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-05-02 22:00:00.045955 :91D834F8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:00.047156 :91D83500:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:00.047180 :91D83503:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-05-02 22:00:00.047229 :91D8350F:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] KSL POST RCVD poster=18 loc='ksr2.h LINE:607 ID:ksrmdone' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-02 22:00:00.049832 :91D83519:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:00.049875 :91D8351C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-05-02 22:00:00.049945 :91D83528:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] KSL POST RCVD poster=18 loc='ksr2.h LINE:607 ID:ksrmdone' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-02 22:00:00.050626 :91D83532:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:00.053355 :91D8353A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:00.058671 :91D83542:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:00.064158 :91D8354A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:00.065784 :91D83552:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:00.066636 :91D8355A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:00.069254 :91D83562:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:00.070519 :91D8356A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:00.073685 :91D83572:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:00.077126 :91D8357A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-05-02 22:00:00.077479 :91D83589:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:00.077526 :91D8358C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:ktcc.c:879 2025-05-02 22:00:00.077539 :91D8358D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:ktcc.c:879 2025-05-02 22:00:00.079532 :91D83593:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:00.079576 :91D83596:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:ktcc.c:879 2025-05-02 22:00:00.079589 :91D83597:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:ktcc.c:879 2025-05-02 22:00:00.081584 :91D8359D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:00.081630 :91D835A0:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:ktcc.c:879 2025-05-02 22:00:00.081641 :91D835A1:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:ktcc.c:879 2025-05-02 22:00:00.081817 :91D835A7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:00.081832 :91D835AA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-05-02 22:00:00.081878 :91D835B6:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] KSL POST RCVD poster=18 loc='ksr2.h LINE:607 ID:ksrmdone' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-02 22:00:00.083315 :91D835C0:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-05-02 22:00:01.234060 :91D83617:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 05-02 22:00:01.229 2025-05-02 22:00:01.234062 :91D83618:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=8612 pso_num=27 pso_serial#=171 2025-05-02 22:00:01.234210 :91D8361B:db_trace:kso.c@4093:ksonfy(): [10420:27:0] kso: new process: pid=8612 osp_idx=25 osp_ver=40460 osp_pg=0 (spawn #141927) 2025-05-02 22:00:01.234211 :91D8361C:db_trace:kso.c@4099:ksonfy(): [10420:27:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-02 22:00:01.234212 :91D8361D:db_trace:kso.c@4103:ksonfy(): [10420:27:0] kso: new process: pso_index=27 reservation=243 time=3493990718 2025-05-02 22:00:01.234213 :91D8361E:db_trace:kso.c@4109:ksonfy(): [10420:27:0] kso: spawn diagnostics: queue time=0 secs 2025-05-02 22:00:01.234213 :91D8361F:db_trace:kso.c@4111:ksonfy(): [10420:27:0] kso: spawn diagnostics: fork time=0 secs 2025-05-02 22:00:01.234214 :91D83620:db_trace:kso.c@4113:ksonfy(): [10420:27:0] kso: spawn diagnostics: exec time=0 secs 2025-05-02 22:00:01.234215 :91D83621:db_trace:kso.c@4115:ksonfy(): [10420:27:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-02 22:00:01.234215 :91D83622:db_trace:kso.c@4117:ksonfy(): [10420:27:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-02 22:00:01.234794 :91D83623:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-02 22:00:01.239956 :91D83652:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:01.239996 :91D83657:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:jslv.c:9203 2025-05-02 22:00:01.257269 :91D838C8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:01.257477 :91D838D0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:01.257715 :91D838D8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:01.257936 :91D838E0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:01.258118 :91D838E8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:01.258287 :91D838F0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:01.258448 :91D838F8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:01.258605 :91D83900:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:01.258780 :91D83908:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:01.258941 :91D83910:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:01.259324 :91D83918:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:01.259605 :91D83920:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:01.259769 :91D83928:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:01.259925 :91D83930:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:01.260079 :91D83938:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:01.260236 :91D83940:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:01.260387 :91D83956:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:01.260538 :91D83966:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:01.260691 :91D8396E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:01.260837 :91D83978:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:01.260987 :91D83980:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:01.261139 :91D83988:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:01.261290 :91D83990:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:01.261446 :91D839A5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:01.261593 :91D839AE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:01.288645 :91D839C7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:02.988451*:91D83CE4:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000002B453AD0 estart=1746194402 eid=17983692 ctx=0x0000000777968158 cwh=0x0000000038510158 cpu=0 buffg=2 interb=0 r=0 rb=0 w=0 wb=0 2025-05-02 22:00:02.988451*:91D83CE5:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000002B453AD0 curCtx=0x0000000038411BF8 pubTabIdxCnt=0 2025-05-02 22:00:02.988451*:91D83CE6:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000002B453AD0 2025-05-02 22:00:02.988451*:91D83CEA:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000002B453AD0 2025-05-02 22:00:02.988451*:91D83CEC:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000002B4CB6F0 estart=1746194400 eid=16777295 ctx=0x000000077B54EAC8 cwh=0x000000002B4C0068 cpu=1500000 buffg=76213 interb=204800 r=25 rb=204800 w=0 wb=0 2025-05-02 22:00:02.988451*:91D83CED:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000002B4CB6F0 curCtx=0x0000000034667FD8 pubTabIdxCnt=0 2025-05-02 22:00:02.988451*:91D83CEE:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000002B4CB6F0 2025-05-02 22:00:02.988451*:91D83CEF:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000002B4CB6F0 2025-05-02 22:00:02.988451*:91D83CF0:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000002B453AD0 curCtx=0x0000000038411BF8 xsc->flg4=65792 flags=1 2025-05-02 22:00:02.988451*:91D83CF1:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000002B453AD0 2025-05-02 22:00:03.067035*:91D83D5E:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000002B4CB6F0 curCtx=0x0000000034667FD8 xsc->flg4=65792 flags=2 2025-05-02 22:00:03.067035*:91D83D5F:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000002B4CB6F0 2025-05-02 22:00:03.078632 :91D83D60:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:03.099625 :91D83D89:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:03.101639 :91D83D91:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:psdpgi.c:2235 2025-05-02 22:00:03.101831 :91D83D92:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:psdpgi.c:2235 2025-05-02 22:00:03.102776 :91D83D93:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:03.102865 :91D83D96:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:03.103705 :91D83DA9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:03.105202 :91D83DC7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:03.105477 :91D83DCF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:03.160781*:SQL_Analyze:qksan.c@3402:qksanAnalyzeSql(begin): qksanAnalyzeSql(enter): goal=15 options=16778048 pgadep=0 binds#=0 byPos=0 timeLim=0 timeFired=0 2025-05-02 22:00:03.160781*:SQL_Analyze:qksan.c@936:qksanBindSql(begin): binding for SQL analyze 2025-05-02 22:00:03.160781*:SQL_Analyze:qksan.c@1344:qksanBindSql(end): Done binding: status=0 ret=0 bind#=0 byPos=1 wasBoundP=0x0000000000000000 bindIndP=0x0000000000000000 2025-05-02 22:00:03.160781*:SQL_Analyze:qksan.c@6338:qksanAvgExecStats(): The number of total executions: 1 and execution count: 0 2025-05-02 22:00:03.160781*:SQL_Analyze:qksan.c@4776:qksanPostAnalyzeDump(begin): qksanPostAnalyzeDump(): Dumping analyze context after compilation qksanStatus=SUCCESS ecode=0 2025-05-02 22:00:03.160781*:SQL_Analyze:qksan.c@4800:qksanPostAnalyzeDump(end): 2025-05-02 22:00:03.160781*:SQL_Analyze:qksan.c@3690:qksanAnalyzeSql(end): exit: ecode=0 status=0 2025-05-02 22:00:03.229290 :91D83E18:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:05.104779 :91D83F3B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:05.104794 :91D83F3C:db_trace:ktur.c@3079:ktuabt(): [10444:27:219] ABORT TRANSACTION - xid: 0x0009.00f.0001c491 2025-05-02 22:00:07.409966*:91D84143:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000002B4CBB08 estart=1746194407 eid=16777374 ctx=0x000000077F58CBF8 cwh=0x0000000028BE0428 cpu=0 buffg=3 interb=0 r=0 rb=0 w=0 wb=0 2025-05-02 22:00:07.409966*:91D84144:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000002B4CBB08 curCtx=0x000000003844E7B8 pubTabIdxCnt=0 2025-05-02 22:00:07.409966*:91D84145:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000002B4CBB08 2025-05-02 22:00:07.409966*:91D84146:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000002B4CBB08 2025-05-02 22:00:07.409966*:91D84147:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000002B4CBB08 curCtx=0x000000003844E7B8 xsc->flg4=65792 flags=1 2025-05-02 22:00:07.409966*:91D84148:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000002B4CBB08 2025-05-02 22:00:07.414597 :91D84149:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:07.415934 :91D84151:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:07.425988 :91D84159:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 22:00:07.448230 :91D84161:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 27 (osid: 8612, J002)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de