Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250519220638\orcl_m002_13040_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250519220638\orcl_m002_13040_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:37378M/63366M, Ph+PgF:44537M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 29 Windows thread id: 13040, image: ORACLE.EXE (M002) *** 2025-05-19 22:06:38.605 *** SESSION ID:(233.22661) 2025-05-19 22:06:38.605 *** 2025-05-19 22:06:38.605 Process diagnostic dump for ORACLE.EXE (M002), OS id=13040, pid: 29, proc_ser: 84, sid: 233, sess_ser: 22661 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: Not in wait; last wait ended 0.000480 sec ago Wait State: fixed_waits=0 flags=0x21 boundary=0x0000000000000000/-1 Session Wait History: elapsed time of 0.000505 sec since last wait 0: waited for 'db file sequential read' file#=0x2, block#=0xc82, blocks=0x1 wait_id=1314 seq_num=1315 snap_id=1 wait times: snap=0.000084 sec, exc=0.000084 sec, total=0.000084 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000768 sec of elapsed time 1: waited for 'db file sequential read' file#=0x2, block#=0xbf2, blocks=0x1 wait_id=1313 seq_num=1314 snap_id=1 wait times: snap=0.001419 sec, exc=0.001419 sec, total=0.001419 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000340 sec of elapsed time 2: waited for 'db file sequential read' file#=0x2, block#=0xbca, blocks=0x1 wait_id=1312 seq_num=1313 snap_id=1 wait times: snap=0.004129 sec, exc=0.004129 sec, total=0.004129 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000132 sec of elapsed time 3: waited for 'db file sequential read' file#=0x2, block#=0xbaa, blocks=0x1 wait_id=1311 seq_num=1312 snap_id=1 wait times: snap=0.000049 sec, exc=0.000049 sec, total=0.000049 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000138 sec of elapsed time 4: waited for 'db file sequential read' file#=0x2, block#=0xb92, blocks=0x1 wait_id=1310 seq_num=1311 snap_id=1 wait times: snap=0.000051 sec, exc=0.000051 sec, total=0.000051 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000597 sec of elapsed time 5: waited for 'db file sequential read' file#=0x2, block#=0xb02, blocks=0x1 wait_id=1309 seq_num=1310 snap_id=1 wait times: snap=0.000050 sec, exc=0.000050 sec, total=0.000050 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000431 sec of elapsed time 6: waited for 'db file sequential read' file#=0x2, block#=0xa9a, blocks=0x1 wait_id=1308 seq_num=1309 snap_id=1 wait times: snap=0.000052 sec, exc=0.000052 sec, total=0.000052 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000491 sec of elapsed time 7: waited for 'db file sequential read' file#=0x2, block#=0xa22, blocks=0x1 wait_id=1307 seq_num=1308 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.000386 sec of elapsed time 8: waited for 'db file sequential read' file#=0x2, block#=0x9fa, blocks=0x1 wait_id=1306 seq_num=1307 snap_id=1 wait times: snap=0.000868 sec, exc=0.000868 sec, total=0.000868 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000163 sec of elapsed time 9: waited for 'db file sequential read' file#=0x2, block#=0x9ea, blocks=0x1 wait_id=1305 seq_num=1306 snap_id=1 wait times: snap=0.000048 sec, exc=0.000048 sec, total=0.000048 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000137 sec of elapsed time Sampled Session History of session 233 serial 22661 --------------------------------------------------- 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 --------------------------------------------------- [1 sample, 22:06:38] idle wait at each sample [session created at: 22:06:38] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-05-19 22:06:38.605 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 29 (osid: 13040, M002) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-19 01:22:17.380478 :98F9D9E6:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-19 01:22:17.382832 :98F9D9E7:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-19 01:52:21.350541 :98FC3CAA:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-19 01:52:21.338 2025-05-19 01:52:21.350543 :98FC3CAB:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=4728 pso_num=29 pso_serial#=75 2025-05-19 01:52:21.350677 :98FC3CAC:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=4728 osp_idx=27 osp_ver=11294 osp_pg=0 (spawn #196386) 2025-05-19 01:52:21.350677 :98FC3CAD:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-19 01:52:21.350678 :98FC3CAE:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=195 time=595351219 2025-05-19 01:52:21.350678 :98FC3CAF:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-19 01:52:21.350679 :98FC3CB0:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-19 01:52:21.350679 :98FC3CB1:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-19 01:52:21.350679 :98FC3CB2:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-19 01:52:21.350680 :98FC3CB3:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-19 01:52:21.351197 :98FC3CB4: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-05-19 01:52:21.351239 :98FC3CBA: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-05-19 01:52:21.355402 :98FC3CD3:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-19 01:52:21.355447 :98FC3CD4:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-19 01:52:21.355697 :98FC3CD5:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-19 01:52:21.355713 :98FC3CD6:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-19 01:52:21.355921 :98FC3CD7:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-19 01:52:21.355934 :98FC3CD8:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-19 01:52:21.356215 :98FC3CD9:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-19 01:52:21.356228 :98FC3CDA:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-19 01:52:21.356438 :98FC3CDB:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-19 01:52:21.356451 :98FC3CDC:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-19 01:52:21.356664 :98FC3CDD:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-19 01:52:21.356677 :98FC3CDE:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-19 01:52:21.359075 :98FC3CDF:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-19 16:00:17.225702 :993F54B2:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-19 16:00:17.211 2025-05-19 16:00:17.225704 :993F54B3:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=13560 pso_num=29 pso_serial#=76 2025-05-19 16:00:17.225836 :993F54B4:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=13560 osp_idx=27 osp_ver=11295 osp_pg=0 (spawn #198345) 2025-05-19 16:00:17.225836 :993F54B5:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-19 16:00:17.225836 :993F54B6:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=196 time=646227079 2025-05-19 16:00:17.225837 :993F54B7:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-19 16:00:17.225837 :993F54B8:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-19 16:00:17.225837 :993F54B9:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-19 16:00:17.225838 :993F54BA:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-19 16:00:17.225838 :993F54BB:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-19 16:00:17.226280 :993F54BC: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-05-19 16:00:17.226309 :993F54C4: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-05-19 16:00:17.233236 :993F54D0: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-05-19 16:00:17.234210 :993F54D8: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-05-19 16:00:17.234770 :993F54E0: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-05-19 16:00:17.235285 :993F54E8: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-05-19 16:00:17.235787 :993F54F0: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-05-19 16:00:17.238110 :993F54F8: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-05-19 16:00:17.239115 :993F5500: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-05-19 16:00:17.280041 :993F5508: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-05-19 16:00:17.280850 :993F5510: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-05-19 16:00:17.281083 :993F5518: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-05-19 16:00:17.281310 :993F5520: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-05-19 16:00:17.282705 :993F5528:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-19 22:00:00.452260 :995BCF2A:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-19 22:00:00.446 2025-05-19 22:00:00.452261 :995BCF2B:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=13224 pso_num=29 pso_serial#=77 2025-05-19 22:00:00.452403 :995BCF30:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=13224 osp_idx=27 osp_ver=11296 osp_pg=0 (spawn #199177) 2025-05-19 22:00:00.452404 :995BCF31:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-19 22:00:00.452405 :995BCF32:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=197 time=667810313 2025-05-19 22:00:00.452405 :995BCF33:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-19 22:00:00.452406 :995BCF34:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-19 22:00:00.452406 :995BCF35:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-19 22:00:00.452407 :995BCF36:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-19 22:00:00.452407 :995BCF37:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-19 22:00:00.452935 :995BCF3D: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-05-19 22:00:00.457918 :995BCF5A: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-05-19 22:00:00.457968 :995BCF5D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:jslv.c:9203 2025-05-19 22:00:00.475801 :995BD12A: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-05-19 22:00:00.476013 :995BD132: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-05-19 22:00:00.476188 :995BD13A: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-05-19 22:00:00.476351 :995BD142: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-05-19 22:00:00.476516 :995BD14A: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-05-19 22:00:00.476676 :995BD152: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-05-19 22:00:00.476837 :995BD15A: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-05-19 22:00:00.477009 :995BD162: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-05-19 22:00:00.477174 :995BD16A: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-05-19 22:00:00.477324 :995BD172: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-05-19 22:00:00.477481 :995BD17A: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-05-19 22:00:00.477638 :995BD182: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-05-19 22:00:00.477791 :995BD18A: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-05-19 22:00:00.477951 :995BD192: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-05-19 22:00:00.478124 :995BD19A: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-05-19 22:00:00.478289 :995BD1A2: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-05-19 22:00:00.478451 :995BD1AA: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-05-19 22:00:00.478624 :995BD1B2: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-05-19 22:00:00.478857 :995BD1BA: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-05-19 22:00:00.479020 :995BD1C2: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-05-19 22:00:00.479178 :995BD1CA: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-05-19 22:00:00.479347 :995BD1D2: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-05-19 22:00:00.479509 :995BD1DA: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-05-19 22:00:00.479662 :995BD1E2: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-05-19 22:00:00.480311 :995BD1EA: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-05-19 22:00:00.507594 :995BD1F2: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-05-19 22:00:01.471427*:995BD36F:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000002DC03AD0 estart=1747663201 eid=18595769 ctx=0x0000000777968158 cwh=0x000000003D620158 cpu=0 buffg=2 interb=0 r=0 rb=0 w=0 wb=0 2025-05-19 22:00:01.471427*:995BD370:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000002DC03AD0 curCtx=0x000000003D521BF8 pubTabIdxCnt=0 2025-05-19 22:00:01.471427*:995BD371:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000002DC03AD0 2025-05-19 22:00:01.471427*:995BD372:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000002DC03AD0 2025-05-19 22:00:01.471427*:995BD373:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000002DC7B6F0 estart=1747663200 eid=16777336 ctx=0x000000077B54EAC8 cwh=0x000000002DC70068 cpu=796875 buffg=45038 interb=196608 r=24 rb=196608 w=0 wb=0 2025-05-19 22:00:01.471427*:995BD374:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000002DC7B6F0 curCtx=0x000000003D517FD8 pubTabIdxCnt=0 2025-05-19 22:00:01.471427*:995BD375:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000002DC7B6F0 2025-05-19 22:00:01.471427*:995BD376:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000002DC7B6F0 2025-05-19 22:00:01.471427*:995BD377:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000002DC03AD0 curCtx=0x000000003D521BF8 xsc->flg4=65792 flags=1 2025-05-19 22:00:01.471427*:995BD378:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000002DC03AD0 2025-05-19 22:00:02.158956*:995BD529:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000002DC7B6F0 curCtx=0x000000003D517FD8 xsc->flg4=65792 flags=2 2025-05-19 22:00:02.158956*:995BD52A:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000002DC7B6F0 2025-05-19 22:00:02.163298 :995BD52B: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-05-19 22:00:02.184953 :995BD54F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:psdpgi.c:2235 2025-05-19 22:00:02.185140 :995BD550:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:psdpgi.c:2235 2025-05-19 22:00:02.185972 :995BD551: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-05-19 22:00:02.186060 :995BD554: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-05-19 22:00:02.186990 :995BD566: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-05-19 22:00:02.188444 :995BD56E: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-05-19 22:00:02.188714 :995BD576: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-05-19 22:00:02.252730*: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-19 22:00:02.252730*:SQL_Analyze:qksan.c@936:qksanBindSql(begin): binding for SQL analyze 2025-05-19 22:00:02.252730*:SQL_Analyze:qksan.c@1344:qksanBindSql(end): Done binding: status=0 ret=0 bind#=0 byPos=1 wasBoundP=0x0000000000000000 bindIndP=0x0000000000000000 2025-05-19 22:00:02.252730*:SQL_Analyze:qksan.c@6338:qksanAvgExecStats(): The number of total executions: 1 and execution count: 0 2025-05-19 22:00:02.252730*:SQL_Analyze:qksan.c@4776:qksanPostAnalyzeDump(begin): qksanPostAnalyzeDump(): Dumping analyze context after compilation qksanStatus=SUCCESS ecode=0 2025-05-19 22:00:02.252730*:SQL_Analyze:qksan.c@4800:qksanPostAnalyzeDump(end): 2025-05-19 22:00:02.252730*:SQL_Analyze:qksan.c@3690:qksanAnalyzeSql(end): exit: ecode=0 status=0 2025-05-19 22:00:02.328169 :995BD5F7: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-05-19 22:00:04.208417 :995BD759: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-05-19 22:00:04.208430 :995BD75A:db_trace:ktur.c@3079:ktuabt(): [10444:29:233] ABORT TRANSACTION - xid: 0x0008.018.0000c9f2 2025-05-19 22:00:06.655427 :995BD9C8: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-05-19 22:00:06.657027 :995BD9D0: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-05-19 22:00:06.667267 :995BD9D8: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-05-19 22:00:06.690656 :995BD9E0: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-05-19 22:00:07.842855 :995BDB7D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:jslv.c:9203 2025-05-19 22:00:07.855219 :995BDB7E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:0] KSL POST SENT postee=59 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-19 22:00:07.857026 :995BDB86:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-19 22:00:08.368895 :995BDC39:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-19 22:00:08.360 2025-05-19 22:00:08.368897 :995BDC3A:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=13460 pso_num=29 pso_serial#=78 2025-05-19 22:00:08.369032 :995BDC3B:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=13460 (legacy spawn) 2025-05-19 22:00:08.377789 :995BDC3C: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-05-19 22:00:08.377963 :995BDC42: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-05-19 22:00:08.378747 :995BDC46:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-19 22:00:21.014392 :995BE152:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-19 22:00:21.000 2025-05-19 22:00:21.014394 :995BE153:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=10296 pso_num=29 pso_serial#=79 2025-05-19 22:00:21.014535 :995BE154:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=10296 (legacy spawn) 2025-05-19 22:00:21.020932 :995BE155: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-05-19 22:00:21.020962 :995BE158: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-05-19 22:00:21.021113 :995BE15B: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-05-19 22:00:21.021891 :995BE16C:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-19 22:00:21.030568 :995BE16F:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-19 22:00:21.016 2025-05-19 22:00:21.030569 :995BE170:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=13156 pso_num=29 pso_serial#=80 2025-05-19 22:00:21.030703 :995BE171:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=13156 (legacy spawn) 2025-05-19 22:00:21.037142 :995BE172: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-05-19 22:00:21.037317 :995BE17B: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-05-19 22:00:21.038125 :995BE17C:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-19 22:00:24.114103 :995BE267:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-19 22:00:24.101 2025-05-19 22:00:24.114105 :995BE268:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=13512 pso_num=29 pso_serial#=81 2025-05-19 22:00:24.114239 :995BE269:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=13512 (legacy spawn) 2025-05-19 22:00:24.134114 :995BE26A: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-05-19 22:00:24.134295 :995BE26F: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-05-19 22:00:24.135142 :995BE274:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-19 22:00:24.143806 :995BE277:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-19 22:00:24.132 2025-05-19 22:00:24.143808 :995BE278:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=11616 pso_num=29 pso_serial#=82 2025-05-19 22:00:24.143946 :995BE279:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=11616 (legacy spawn) 2025-05-19 22:00:24.150460 :995BE27A: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-05-19 22:00:24.150641 :995BE283: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-05-19 22:00:24.151443 :995BE284:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-19 22:06:36.964167 :995CA23C:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-19 22:06:36.955 2025-05-19 22:06:36.964168 :995CA23D:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=9288 pso_num=29 pso_serial#=83 2025-05-19 22:06:36.964335 :995CA246:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=9288 osp_idx=27 osp_ver=11302 osp_pg=0 (spawn #199197) 2025-05-19 22:06:36.964336 :995CA247:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-19 22:06:36.964337 :995CA248:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=198 time=668206829 2025-05-19 22:06:36.964337 :995CA249:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-19 22:06:36.964337 :995CA24A:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-19 22:06:36.964338 :995CA24B:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-19 22:06:36.964338 :995CA24C:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-19 22:06:36.964338 :995CA24D:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-19 22:06:36.965727 :995CA283: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-05-19 22:06:36.965769 :995CA28B: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-05-19 22:06:37.071784 :995CA5FB:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-19 22:06:38.276013 :995CA658:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-19 22:06:38.262 2025-05-19 22:06:38.276016 :995CA659:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=13040 pso_num=29 pso_serial#=84 2025-05-19 22:06:38.276147 :995CA65A:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=13040 osp_idx=27 osp_ver=11303 osp_pg=0 (spawn #199199) 2025-05-19 22:06:38.276148 :995CA65B:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-19 22:06:38.276148 :995CA65C:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=199 time=668208141 2025-05-19 22:06:38.276148 :995CA65D:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-19 22:06:38.276148 :995CA65E:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-19 22:06:38.276149 :995CA65F:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-19 22:06:38.276149 :995CA660:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-19 22:06:38.276149 :995CA661:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-19 22:06:38.276685 :995CA662: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-05-19 22:06:38.276739 :995CA668: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 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 29 (osid: 13040, M002)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de