Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250725222232\orcl_m002_18556_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250725222232\orcl_m002_18556_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:36064M/63366M, Ph+PgF:41846M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 25 Windows thread id: 18556, image: ORACLE.EXE (M002) *** 2025-07-25 22:22:32.140 *** SESSION ID:(201.9417) 2025-07-25 22:22:32.140 *** 2025-07-25 22:22:32.140 Process diagnostic dump for ORACLE.EXE (M002), OS id=18556, pid: 25, proc_ser: 82, sid: 201, sess_ser: 9417 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'db file sequential read' file#=0x2, block#=0x8a1a, blocks=0x1 wait_id=1668 seq_num=1669 snap_id=1 wait times: snap=0.001691 sec, exc=0.001691 sec, total=0.001691 sec wait times: max=infinite, heur=0.001691 sec wait counts: calls=0 os=0 in_wait=1 iflags=0x5a0 Wait State: fixed_waits=0 flags=0x22 boundary=0x0000000000000000/-1 Session Wait History: elapsed time of 0.000266 sec since current wait 0: waited for 'db file sequential read' file#=0x2, block#=0x78e2, blocks=0x1 wait_id=1667 seq_num=1668 snap_id=1 wait times: snap=0.000056 sec, exc=0.000056 sec, total=0.000056 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000175 sec of elapsed time 1: waited for 'db file sequential read' file#=0x2, block#=0x78d2, blocks=0x1 wait_id=1666 seq_num=1667 snap_id=1 wait times: snap=0.000087 sec, exc=0.000087 sec, total=0.000087 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000356 sec of elapsed time 2: waited for 'db file sequential read' file#=0x2, block#=0xea42, blocks=0x1 wait_id=1665 seq_num=1666 snap_id=1 wait times: snap=0.006381 sec, exc=0.006381 sec, total=0.006381 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000163 sec of elapsed time 3: waited for 'db file sequential read' file#=0x2, block#=0x85b2, blocks=0x1 wait_id=1664 seq_num=1665 snap_id=1 wait times: snap=0.000074 sec, exc=0.000074 sec, total=0.000074 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000347 sec of elapsed time 4: waited for 'db file sequential read' file#=0x2, block#=0x844a, blocks=0x1 wait_id=1663 seq_num=1664 snap_id=1 wait times: snap=0.003325 sec, exc=0.003325 sec, total=0.003325 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000378 sec of elapsed time 5: waited for 'db file sequential read' file#=0x2, block#=0x7ffa, blocks=0x1 wait_id=1662 seq_num=1663 snap_id=1 wait times: snap=0.005727 sec, exc=0.005727 sec, total=0.005727 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000258 sec of elapsed time 6: waited for 'db file sequential read' file#=0x2, block#=0x7fda, blocks=0x1 wait_id=1661 seq_num=1662 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.000142 sec of elapsed time 7: waited for 'db file sequential read' file#=0x2, block#=0x7fea, blocks=0x1 wait_id=1660 seq_num=1661 snap_id=1 wait times: snap=0.000047 sec, exc=0.000047 sec, total=0.000047 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000141 sec of elapsed time 8: waited for 'db file sequential read' file#=0x2, block#=0x8022, blocks=0x1 wait_id=1659 seq_num=1660 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.000271 sec of elapsed time 9: waited for 'db file sequential read' file#=0x2, block#=0x8042, blocks=0x1 wait_id=1658 seq_num=1659 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.000146 sec of elapsed time Sampled Session History of session 201 serial 9417 --------------------------------------------------- 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:22:31] waited for 'db file sequential read', seq_num: 1521 p1: 'file#'=0x2 p2: 'block#'=0x4872 p3: 'blocks'=0x1 time_waited: >= 0 sec (still in wait) [1 sample, 22:22:30] idle wait at each sample [session created at: 22:22:31] --------------------------------------------------- Sampled Session History Summary: longest_non_idle_wait: 'db file sequential read' [1 sample, 22:22:31 ] time_waited: >= 0 sec (still in wait) --------------------------------------------------- ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-07-25 22:22:32.140 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 25 (osid: 18556, M002) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-07-25 22:10:48.041954 :B6F35BE5:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-25 22:10:48.041954 :B6F35BE6:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=218 time=2162223923 2025-07-25 22:10:48.041954 :B6F35BE7:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-25 22:10:48.041954 :B6F35BE8:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-25 22:10:48.041955 :B6F35BE9:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-25 22:10:48.041955 :B6F35BEA:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-25 22:10:48.041955 :B6F35BEB:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-25 22:10:48.042432 :B6F35BEC: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-07-25 22:11:18.118418 :B6F36615:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-25 22:11:48.120368 :B6F37014:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-25 22:11:48.108 2025-07-25 22:11:48.120370 :B6F37015:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=17340 pso_num=25 pso_serial#=66 2025-07-25 22:11:48.120495 :B6F37016:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=17340 osp_idx=23 osp_ver=211828 osp_pg=0 (spawn #422517) 2025-07-25 22:11:48.120496 :B6F37017:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-25 22:11:48.120496 :B6F37018:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=219 time=2162284001 2025-07-25 22:11:48.120497 :B6F37019:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-25 22:11:48.120497 :B6F3701A:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-25 22:11:48.120498 :B6F3701B:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-25 22:11:48.120498 :B6F3701C:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-25 22:11:48.120498 :B6F3701D:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-25 22:11:48.120981 :B6F3701E: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-07-25 22:12:18.204862 :B6F379F9:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-25 22:12:48.172277 :B6F3842F:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-25 22:12:48.161 2025-07-25 22:12:48.172279 :B6F38430:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=16876 pso_num=25 pso_serial#=67 2025-07-25 22:12:48.172425 :B6F38431:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=16876 osp_idx=23 osp_ver=211829 osp_pg=0 (spawn #422520) 2025-07-25 22:12:48.172425 :B6F38432:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-25 22:12:48.172426 :B6F38433:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=220 time=2162344064 2025-07-25 22:12:48.172426 :B6F38434:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-25 22:12:48.172427 :B6F38435:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-25 22:12:48.172427 :B6F38436:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-25 22:12:48.172427 :B6F38437:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-25 22:12:48.172428 :B6F38438:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-25 22:12:48.172932 :B6F38439: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-07-25 22:13:18.236220 :B6F38EEE:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-25 22:13:48.236043 :B6F398F4:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-25 22:13:48.224 2025-07-25 22:13:48.236045 :B6F398F5:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=16136 pso_num=25 pso_serial#=68 2025-07-25 22:13:48.236175 :B6F398F6:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=16136 osp_idx=23 osp_ver=211830 osp_pg=0 (spawn #422522) 2025-07-25 22:13:48.236175 :B6F398F7:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-25 22:13:48.236176 :B6F398F8:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=221 time=2162404126 2025-07-25 22:13:48.236176 :B6F398F9:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-25 22:13:48.236176 :B6F398FA:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-25 22:13:48.236176 :B6F398FB:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-25 22:13:48.236177 :B6F398FC:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-25 22:13:48.236177 :B6F398FD:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-25 22:13:48.236692 :B6F398FE: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-07-25 22:14:18.298040 :B6F3A2EE:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-25 22:14:48.326322 :B6F3AD05:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-25 22:14:48.315 2025-07-25 22:14:48.326324 :B6F3AD06:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=18628 pso_num=25 pso_serial#=69 2025-07-25 22:14:48.326503 :B6F3AD07:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=18628 osp_idx=23 osp_ver=211831 osp_pg=0 (spawn #422524) 2025-07-25 22:14:48.326503 :B6F3AD08:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-25 22:14:48.326504 :B6F3AD09:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=222 time=2162464220 2025-07-25 22:14:48.326504 :B6F3AD0A:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-25 22:14:48.326504 :B6F3AD0B:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-25 22:14:48.326505 :B6F3AD0C:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-25 22:14:48.326505 :B6F3AD0D:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-25 22:14:48.326505 :B6F3AD0E:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-25 22:14:48.326978 :B6F3AD0F: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-07-25 22:15:18.389340 :B6F3B735:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-25 22:15:48.390468 :B6F3C14D:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-25 22:15:48.379 2025-07-25 22:15:48.390470 :B6F3C14E:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=14056 pso_num=25 pso_serial#=70 2025-07-25 22:15:48.390608 :B6F3C14F:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=14056 osp_idx=23 osp_ver=211832 osp_pg=0 (spawn #422526) 2025-07-25 22:15:48.390609 :B6F3C150:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-25 22:15:48.390609 :B6F3C151:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=223 time=2162524283 2025-07-25 22:15:48.390610 :B6F3C152:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-25 22:15:48.390611 :B6F3C153:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-25 22:15:48.390611 :B6F3C154:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-25 22:15:48.390611 :B6F3C155:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-25 22:15:48.390612 :B6F3C156:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-25 22:15:48.391094 :B6F3C157: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-07-25 22:16:18.495136 :B6F3CBA7:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-25 22:16:48.487990 :B6F3D59D:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-25 22:16:48.477 2025-07-25 22:16:48.487991 :B6F3D59E:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=18624 pso_num=25 pso_serial#=71 2025-07-25 22:16:48.488118 :B6F3D59F:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=18624 osp_idx=23 osp_ver=211833 osp_pg=0 (spawn #422528) 2025-07-25 22:16:48.488119 :B6F3D5A0:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-25 22:16:48.488119 :B6F3D5A1:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=224 time=2162584376 2025-07-25 22:16:48.488120 :B6F3D5A2:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-25 22:16:48.488120 :B6F3D5A3:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-25 22:16:48.488121 :B6F3D5A4:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-25 22:16:48.488121 :B6F3D5A5:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-25 22:16:48.488121 :B6F3D5A6:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-25 22:16:48.488600 :B6F3D5A7: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-07-25 22:17:18.572535 :B6F3DF9D:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-25 22:17:48.602332 :B6F3E99A:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-25 22:17:48.600 2025-07-25 22:17:48.602334 :B6F3E99B:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=14712 pso_num=25 pso_serial#=72 2025-07-25 22:17:48.602470 :B6F3E99C:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=14712 osp_idx=23 osp_ver=211834 osp_pg=0 (spawn #422530) 2025-07-25 22:17:48.602471 :B6F3E99D:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-25 22:17:48.602471 :B6F3E99E:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=225 time=2162644486 2025-07-25 22:17:48.602471 :B6F3E99F:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-25 22:17:48.602472 :B6F3E9A0:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-25 22:17:48.602472 :B6F3E9A1:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-25 22:17:48.602473 :B6F3E9A2:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-25 22:17:48.602473 :B6F3E9A3:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-25 22:17:48.602950 :B6F3E9A4: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-07-25 22:18:13.636733 :B6F3F27F:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=59 loc='kkj.h LINE:914 ID:kkjpstnp' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-07-25 22:18:43.699764 :B6F3FC48:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-25 22:18:48.680789 :B6F3FDE3:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-25 22:18:48.669 2025-07-25 22:18:48.680791 :B6F3FDE4:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=19380 pso_num=25 pso_serial#=73 2025-07-25 22:18:48.680919 :B6F3FDE5:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=19380 osp_idx=23 osp_ver=211835 osp_pg=0 (spawn #422532) 2025-07-25 22:18:48.680920 :B6F3FDE6:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-25 22:18:48.680920 :B6F3FDE7:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=226 time=2162704564 2025-07-25 22:18:48.680921 :B6F3FDE8:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-25 22:18:48.680921 :B6F3FDE9:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-25 22:18:48.680922 :B6F3FDEA:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-25 22:18:48.680922 :B6F3FDEB:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-25 22:18:48.680922 :B6F3FDEC:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-25 22:18:48.681459 :B6F3FDED: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-07-25 22:19:18.734694 :B6F407F9:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-25 22:19:48.754955 :B6F41216:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-25 22:19:48.744 2025-07-25 22:19:48.754957 :B6F41217:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=19292 pso_num=25 pso_serial#=74 2025-07-25 22:19:48.755074 :B6F41218:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=19292 osp_idx=23 osp_ver=211836 osp_pg=0 (spawn #422535) 2025-07-25 22:19:48.755075 :B6F41219:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-25 22:19:48.755076 :B6F4121A:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=227 time=2162764642 2025-07-25 22:19:48.755076 :B6F4121B:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-25 22:19:48.755076 :B6F4121C:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-25 22:19:48.755077 :B6F4121D:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-25 22:19:48.755077 :B6F4121E:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-25 22:19:48.755077 :B6F4121F:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-25 22:19:48.755536 :B6F41220: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-07-25 22:20:18.838075 :B6F41C0A:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-25 22:20:48.827950 :B6F42680:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-25 22:20:48.816 2025-07-25 22:20:48.827953 :B6F42681:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=17424 pso_num=25 pso_serial#=75 2025-07-25 22:20:48.828088 :B6F42682:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=17424 osp_idx=23 osp_ver=211837 osp_pg=0 (spawn #422537) 2025-07-25 22:20:48.828088 :B6F42683:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-25 22:20:48.828089 :B6F42684:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=228 time=2162824720 2025-07-25 22:20:48.828089 :B6F42685:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-25 22:20:48.828090 :B6F42686:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-25 22:20:48.828090 :B6F42687:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-25 22:20:48.828090 :B6F42688:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-25 22:20:48.828091 :B6F42689:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-25 22:20:48.828590 :B6F4268A: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-07-25 22:21:18.877178 :B6F43098:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-25 22:21:48.887958 :B6F43A4A:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-25 22:21:48.876 2025-07-25 22:21:48.887961 :B6F43A4B:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=13880 pso_num=25 pso_serial#=76 2025-07-25 22:21:48.888098 :B6F43A4C:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=13880 osp_idx=23 osp_ver=211838 osp_pg=0 (spawn #422539) 2025-07-25 22:21:48.888099 :B6F43A4D:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-25 22:21:48.888099 :B6F43A4E:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=229 time=2162884783 2025-07-25 22:21:48.888100 :B6F43A4F:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-25 22:21:48.888100 :B6F43A50:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-25 22:21:48.888100 :B6F43A51:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-25 22:21:48.888100 :B6F43A52:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-25 22:21:48.888101 :B6F43A53:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-25 22:21:48.888560 :B6F43A54: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-07-25 22:22:18.940133 :B6F44474:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-25 22:22:26.818122 :B6F47D08:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-25 22:22:26.814 2025-07-25 22:22:26.818125 :B6F47D09:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=16636 pso_num=25 pso_serial#=77 2025-07-25 22:22:26.818268 :B6F47D0A:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=16636 (legacy spawn) 2025-07-25 22:22:26.825071 :B6F47D0B: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-07-25 22:22:26.825569 :B6F47D14: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-07-25 22:22:26.826482 :B6F47D15:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-25 22:22:26.835882 :B6F47D18:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-25 22:22:26.830 2025-07-25 22:22:26.835885 :B6F47D19:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=4696 pso_num=25 pso_serial#=78 2025-07-25 22:22:26.836031 :B6F47D1A:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=4696 (legacy spawn) 2025-07-25 22:22:26.842855 :B6F47D1B: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-07-25 22:22:26.843194 :B6F47D24: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-07-25 22:22:26.844101 :B6F47D25:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-25 22:22:29.947063 :B6F481AE:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-25 22:22:29.944 2025-07-25 22:22:29.947066 :B6F481AF:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=6744 pso_num=25 pso_serial#=79 2025-07-25 22:22:29.947240 :B6F481B0:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=6744 osp_idx=23 osp_ver=211841 osp_pg=0 (spawn #422543) 2025-07-25 22:22:29.947241 :B6F481B1:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-25 22:22:29.947241 :B6F481B2:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=230 time=2162925829 2025-07-25 22:22:29.947241 :B6F481B3:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-25 22:22:29.947241 :B6F481B4:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-25 22:22:29.947242 :B6F481B5:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-25 22:22:29.947242 :B6F481B6:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-25 22:22:29.947242 :B6F481B7:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-25 22:22:29.948470 :B6F481B8: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-07-25 22:22:29.948518 :B6F481BE: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-07-25 22:22:30.066075 :B6F48229:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-25 22:22:30.084500 :B6F4822C:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-25 22:22:30.078 2025-07-25 22:22:30.084502 :B6F4822D:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=8240 pso_num=25 pso_serial#=80 2025-07-25 22:22:30.084694 :B6F4822E:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=8240 (legacy spawn) 2025-07-25 22:22:30.095384 :B6F4822F: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-07-25 22:22:30.095556 :B6F48238: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-07-25 22:22:30.096393 :B6F48239:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-25 22:22:30.099256 :B6F4823C:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-25 22:22:30.093 2025-07-25 22:22:30.099259 :B6F4823D:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=16136 pso_num=25 pso_serial#=81 2025-07-25 22:22:30.099403 :B6F4823E:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=16136 (legacy spawn) 2025-07-25 22:22:30.105979 :B6F4823F: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-07-25 22:22:30.106133 :B6F48248: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-07-25 22:22:30.106979 :B6F48249:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-25 22:22:31.269390 :B6F482B3:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-25 22:22:31.265 2025-07-25 22:22:31.269392 :B6F482B4:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=18556 pso_num=25 pso_serial#=82 2025-07-25 22:22:31.269524 :B6F482B5:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=18556 osp_idx=23 osp_ver=211844 osp_pg=0 (spawn #422545) 2025-07-25 22:22:31.269525 :B6F482B6:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-25 22:22:31.269526 :B6F482B7:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=231 time=2162927142 2025-07-25 22:22:31.269526 :B6F482B8:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-25 22:22:31.269526 :B6F482B9:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-25 22:22:31.269526 :B6F482BA:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-25 22:22:31.269527 :B6F482BB:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-25 22:22:31.269527 :B6F482BC:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-25 22:22:31.270023 :B6F482BD: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-07-25 22:22:31.270073 :B6F482C3: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 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 25 (osid: 18556, M002)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de