Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250821080948\orcl_m002_21848_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250821080948\orcl_m002_21848_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:35326M/63366M, Ph+PgF:40524M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 25 Windows thread id: 21848, image: ORACLE.EXE (M002) *** 2025-08-21 08:09:49.026 *** SESSION ID:(201.24621) 2025-08-21 08:09:49.026 *** 2025-08-21 08:09:49.026 Process diagnostic dump for ORACLE.EXE (M002), OS id=21848, pid: 25, proc_ser: 215, sid: 201, sess_ser: 24621 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'control file sequential read' file#=0x0, block#=0x1b6, blocks=0x1 wait_id=1098 seq_num=1099 snap_id=1 wait times: snap=0.003459 sec, exc=0.003459 sec, total=0.003459 sec wait times: max=infinite, heur=0.003459 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.000006 sec since current wait 0: waited for 'control file sequential read' file#=0x0, block#=0x11, blocks=0x1 wait_id=1097 seq_num=1098 snap_id=1 wait times: snap=0.000054 sec, exc=0.000054 sec, total=0.000054 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000008 sec of elapsed time 1: waited for 'control file sequential read' file#=0x0, block#=0xf, blocks=0x1 wait_id=1096 seq_num=1097 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.000005 sec of elapsed time 2: waited for 'control file sequential read' file#=0x0, block#=0x1, blocks=0x1 wait_id=1095 seq_num=1096 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.000017 sec of elapsed time 3: waited for 'control file sequential read' file#=0x0, block#=0x11, blocks=0x1 wait_id=1094 seq_num=1095 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.000007 sec of elapsed time 4: waited for 'control file sequential read' file#=0x0, block#=0xf, blocks=0x1 wait_id=1093 seq_num=1094 snap_id=1 wait times: snap=0.000054 sec, exc=0.000054 sec, total=0.000054 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000004 sec of elapsed time 5: waited for 'control file sequential read' file#=0x1, block#=0x1, blocks=0x1 wait_id=1092 seq_num=1093 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.000003 sec of elapsed time 6: waited for 'control file sequential read' file#=0x0, block#=0x1, blocks=0x1 wait_id=1091 seq_num=1092 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.000043 sec of elapsed time 7: waited for 'Disk file operations I/O' FileOperation=0x5, fileno=0x2, filetype=0x2 wait_id=1090 seq_num=1091 snap_id=1 wait times: snap=0.000085 sec, exc=0.000085 sec, total=0.000085 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000001 sec of elapsed time 8: waited for 'Disk file operations I/O' FileOperation=0x2, fileno=0x2, filetype=0x2 wait_id=1089 seq_num=1090 snap_id=1 wait times: snap=0.000174 sec, exc=0.000174 sec, total=0.000174 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000004 sec of elapsed time 9: waited for 'Disk file operations I/O' FileOperation=0x2, fileno=0x2, filetype=0x2 wait_id=1088 seq_num=1089 snap_id=1 wait times: snap=0.000057 sec, exc=0.000057 sec, total=0.000057 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000028 sec of elapsed time Sampled Session History of session 201 serial 24621 --------------------------------------------------- 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, 08:09:49] idle wait at each sample [session created at: 08:09:48] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-08-21 08:09:49.026 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 25 (osid: 21848, M002) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-08-21 07:59:00.421171 :C29B2544:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-21 07:59:00.421171 :C29B2545:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=157 time=148842424 2025-08-21 07:59:00.421171 :C29B2546:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-21 07:59:00.421172 :C29B2547:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-21 07:59:00.421172 :C29B2548:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-21 07:59:00.421173 :C29B2549:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-21 07:59:00.421173 :C29B254A:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-21 07:59:00.421660 :C29B254B: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-08-21 07:59:30.502646 :C29B2EB6:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-21 08:00:00.520004 :C29B38A0:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-21 08:00:00.508 2025-08-21 08:00:00.520006 :C29B38A1:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=16664 pso_num=25 pso_serial#=202 2025-08-21 08:00:00.520124 :C29B38A2:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=16664 osp_idx=23 osp_ver=249194 osp_pg=0 (spawn #510540) 2025-08-21 08:00:00.520125 :C29B38A3:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-21 08:00:00.520125 :C29B38A4:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=158 time=148902518 2025-08-21 08:00:00.520126 :C29B38A5:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-21 08:00:00.520126 :C29B38A6:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-21 08:00:00.520126 :C29B38A7:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-21 08:00:00.520127 :C29B38A8:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-21 08:00:00.520127 :C29B38A9:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-21 08:00:00.520677 :C29B38AA: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-08-21 08:00:30.637368 :C29B42C3:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-21 08:00:51.992670 :C29B49DC:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-21 08:00:51.979 2025-08-21 08:00:51.992672 :C29B49DD:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=20828 pso_num=25 pso_serial#=203 2025-08-21 08:00:51.992849 :C29B49DE:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=20828 osp_idx=23 osp_ver=249195 osp_pg=0 (spawn #510542) 2025-08-21 08:00:51.992849 :C29B49DF:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-21 08:00:51.992850 :C29B49E0:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=159 time=148953987 2025-08-21 08:00:51.992850 :C29B49E1:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-21 08:00:51.992850 :C29B49E2:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-21 08:00:51.992851 :C29B49E3:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-21 08:00:51.992851 :C29B49E4:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-21 08:00:51.992852 :C29B49E5:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-21 08:00:51.993368 :C29B49E6: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-08-21 08:00:51.993417 :C29B49EC: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-08-21 08:00:52.001194 :C29B49FA: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-08-21 08:00:52.002333 :C29B4A02: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-08-21 08:00:52.002893 :C29B4A0A: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-08-21 08:00:52.003349 :C29B4A12: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-08-21 08:00:52.003777 :C29B4A1A: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-08-21 08:00:52.006490 :C29B4A22: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-08-21 08:00:52.007658 :C29B4A2A: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-08-21 08:00:52.060495 :C29B4A32: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-08-21 08:00:52.061412 :C29B4A3A: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-08-21 08:00:52.061664 :C29B4A42: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-08-21 08:00:52.061885 :C29B4A4A: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-08-21 08:00:52.063748 :C29B4A52:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-21 08:01:00.619293 :C29B4D29:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-21 08:01:00.608 2025-08-21 08:01:00.619295 :C29B4D2A:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=19808 pso_num=25 pso_serial#=204 2025-08-21 08:01:00.619424 :C29B4D2B:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=19808 osp_idx=23 osp_ver=249196 osp_pg=0 (spawn #510544) 2025-08-21 08:01:00.619425 :C29B4D2C:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-21 08:01:00.619427 :C29B4D2D:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=160 time=148962627 2025-08-21 08:01:00.619428 :C29B4D2E:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-21 08:01:00.619428 :C29B4D2F:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-21 08:01:00.619429 :C29B4D30:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-21 08:01:00.619429 :C29B4D31:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-21 08:01:00.619429 :C29B4D32:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-21 08:01:00.619894 :C29B4D33: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-08-21 08:01:30.690990 :C29B565A:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-21 08:02:00.732934 :C29B5FBD:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-21 08:02:00.721 2025-08-21 08:02:00.732935 :C29B5FBE:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=22152 pso_num=25 pso_serial#=205 2025-08-21 08:02:00.733062 :C29B5FBF:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=22152 osp_idx=23 osp_ver=249197 osp_pg=0 (spawn #510546) 2025-08-21 08:02:00.733063 :C29B5FC0:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-21 08:02:00.733063 :C29B5FC1:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=161 time=149022737 2025-08-21 08:02:00.733064 :C29B5FC2:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-21 08:02:00.733064 :C29B5FC3:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-21 08:02:00.733064 :C29B5FC4:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-21 08:02:00.733064 :C29B5FC5:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-21 08:02:00.733065 :C29B5FC6:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-21 08:02:00.733550 :C29B5FC7: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-08-21 08:02:30.802315 :C29B695B:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-21 08:03:00.811317 :C29B75A4:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-21 08:03:00.799 2025-08-21 08:03:00.811319 :C29B75A5:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=19812 pso_num=25 pso_serial#=206 2025-08-21 08:03:00.811453 :C29B75A6:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=19812 osp_idx=23 osp_ver=249198 osp_pg=0 (spawn #510548) 2025-08-21 08:03:00.811454 :C29B75A7:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-21 08:03:00.811454 :C29B75A8:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=162 time=149082815 2025-08-21 08:03:00.811455 :C29B75A9:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-21 08:03:00.811455 :C29B75AA:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-21 08:03:00.811456 :C29B75AB:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-21 08:03:00.811456 :C29B75AC:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-21 08:03:00.811456 :C29B75AD:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-21 08:03:00.811941 :C29B75AE: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-08-21 08:03:15.816942 :C29B7A61: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-08-21 08:03:45.926626 :C29B83ED:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-21 08:03:51.037210 :C29B85F6:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-21 08:03:51.035 2025-08-21 08:03:51.037211 :C29B85F7:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=20164 pso_num=25 pso_serial#=207 2025-08-21 08:03:51.037346 :C29B85F8:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=20164 osp_idx=23 osp_ver=249199 osp_pg=0 (spawn #510550) 2025-08-21 08:03:51.037347 :C29B85F9:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-21 08:03:51.037347 :C29B85FA:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=163 time=149133049 2025-08-21 08:03:51.037347 :C29B85FB:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-21 08:03:51.037348 :C29B85FC:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-21 08:03:51.037348 :C29B85FD:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-21 08:03:51.037349 :C29B85FE:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-21 08:03:51.037349 :C29B85FF:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-21 08:03:51.037865 :C29B8600: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-08-21 08:03:51.037913 :C29B8606: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-08-21 08:03:51.046538 :C29B862B:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-21 08:04:00.899272 :C29B894B:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-21 08:04:00.888 2025-08-21 08:04:00.899274 :C29B894C:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=22296 pso_num=25 pso_serial#=208 2025-08-21 08:04:00.899412 :C29B894D:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=22296 osp_idx=23 osp_ver=249200 osp_pg=0 (spawn #510552) 2025-08-21 08:04:00.899413 :C29B894E:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-21 08:04:00.899413 :C29B894F:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=164 time=149142908 2025-08-21 08:04:00.899413 :C29B8950:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-21 08:04:00.899414 :C29B8951:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-21 08:04:00.899414 :C29B8952:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-21 08:04:00.899414 :C29B8953:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-21 08:04:00.899415 :C29B8954:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-21 08:04:00.899886 :C29B8955: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-08-21 08:04:31.013640 :C29B93C0:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-21 08:05:00.986846 :C29B9D59:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-21 08:05:00.975 2025-08-21 08:05:00.986849 :C29B9D5A:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=20616 pso_num=25 pso_serial#=209 2025-08-21 08:05:00.986981 :C29B9D5B:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=20616 osp_idx=23 osp_ver=249201 osp_pg=0 (spawn #510554) 2025-08-21 08:05:00.986982 :C29B9D5C:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-21 08:05:00.986983 :C29B9D5D:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=165 time=149202987 2025-08-21 08:05:00.986983 :C29B9D5E:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-21 08:05:00.986984 :C29B9D5F:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-21 08:05:00.986985 :C29B9D60:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-21 08:05:00.986985 :C29B9D61:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-21 08:05:00.986985 :C29B9D62:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-21 08:05:00.987540 :C29B9D63: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-08-21 08:05:31.021599 :C29BA716:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-21 08:06:01.075442 :C29BB5E5:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-21 08:06:01.064 2025-08-21 08:06:01.075444 :C29BB5E6:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=20964 pso_num=25 pso_serial#=210 2025-08-21 08:06:01.075576 :C29BB5E7:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=20964 osp_idx=23 osp_ver=249202 osp_pg=0 (spawn #510556) 2025-08-21 08:06:01.075577 :C29BB5E8:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-21 08:06:01.075577 :C29BB5E9:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=166 time=149263080 2025-08-21 08:06:01.075578 :C29BB5EA:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-21 08:06:01.075578 :C29BB5EB:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-21 08:06:01.075578 :C29BB5EC:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-21 08:06:01.075579 :C29BB5ED:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-21 08:06:01.075579 :C29BB5EE:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-21 08:06:01.076099 :C29BB5EF: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-08-21 08:06:31.130935 :C29BBF63:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-21 08:07:01.169893 :C29BC8B6:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-21 08:07:01.159 2025-08-21 08:07:01.169895 :C29BC8B7:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=21000 pso_num=25 pso_serial#=211 2025-08-21 08:07:01.170011 :C29BC8B8:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=21000 osp_idx=23 osp_ver=249203 osp_pg=0 (spawn #510558) 2025-08-21 08:07:01.170012 :C29BC8B9:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-21 08:07:01.170012 :C29BC8BA:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=167 time=149323174 2025-08-21 08:07:01.170012 :C29BC8BB:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-21 08:07:01.170013 :C29BC8BC:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-21 08:07:01.170013 :C29BC8BD:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-21 08:07:01.170013 :C29BC8BE:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-21 08:07:01.170014 :C29BC8BF:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-21 08:07:01.170520 :C29BC8C0: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-08-21 08:07:31.246295 :C29BD28A:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-21 08:08:01.275611 :C29BDC68:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-21 08:08:01.264 2025-08-21 08:08:01.275613 :C29BDC69:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=16524 pso_num=25 pso_serial#=212 2025-08-21 08:08:01.275753 :C29BDC6A:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=16524 osp_idx=23 osp_ver=249204 osp_pg=0 (spawn #510561) 2025-08-21 08:08:01.275755 :C29BDC6B:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-21 08:08:01.275755 :C29BDC6C:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=168 time=149383283 2025-08-21 08:08:01.275755 :C29BDC6D:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-21 08:08:01.275756 :C29BDC6E:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-21 08:08:01.275756 :C29BDC6F:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-21 08:08:01.275756 :C29BDC70:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-21 08:08:01.275757 :C29BDC71:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-21 08:08:01.276262 :C29BDC72: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-08-21 08:08:31.389679 :C29BE60C:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-21 08:09:01.375651 :C29BEFEF:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-21 08:09:01.364 2025-08-21 08:09:01.375653 :C29BEFF0:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=21492 pso_num=25 pso_serial#=213 2025-08-21 08:09:01.375786 :C29BEFF1:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=21492 osp_idx=23 osp_ver=249205 osp_pg=0 (spawn #510563) 2025-08-21 08:09:01.375787 :C29BEFF2:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-21 08:09:01.375787 :C29BEFF3:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=169 time=149443377 2025-08-21 08:09:01.375787 :C29BEFF4:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-21 08:09:01.375788 :C29BEFF5:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-21 08:09:01.375789 :C29BEFF6:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-21 08:09:01.375789 :C29BEFF7:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-21 08:09:01.375789 :C29BEFF8:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-21 08:09:01.376261 :C29BEFF9: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-08-21 08:09:31.449169 :C29BF9C4:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-21 08:09:46.735934 :C29C37C7:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-21 08:09:46.727 2025-08-21 08:09:46.735936 :C29C37C8:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=21756 pso_num=25 pso_serial#=214 2025-08-21 08:09:46.736183 :C29C37C9:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=21756 osp_idx=23 osp_ver=249206 osp_pg=0 (spawn #510565) 2025-08-21 08:09:46.736184 :C29C37CA:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-21 08:09:46.736184 :C29C37CB:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=170 time=149488737 2025-08-21 08:09:46.736185 :C29C37CC:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-21 08:09:46.736185 :C29C37CD:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-21 08:09:46.736185 :C29C37CE:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-21 08:09:46.736185 :C29C37CF:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-21 08:09:46.736186 :C29C37D0:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-21 08:09:46.737085 :C29C37D1: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-08-21 08:09:46.737137 :C29C37D7: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-08-21 08:09:46.869855 :C29C3809:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-21 08:09:48.907445 :C29C391B:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-21 08:09:48.901 2025-08-21 08:09:48.907447 :C29C391C:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=21848 pso_num=25 pso_serial#=215 2025-08-21 08:09:48.907580 :C29C391D:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=21848 osp_idx=23 osp_ver=249207 osp_pg=0 (spawn #510567) 2025-08-21 08:09:48.907580 :C29C391E:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-21 08:09:48.907581 :C29C391F:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=171 time=149490908 2025-08-21 08:09:48.907581 :C29C3920:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-21 08:09:48.907581 :C29C3921:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-21 08:09:48.907582 :C29C3922:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-21 08:09:48.907582 :C29C3923:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-21 08:09:48.907582 :C29C3924:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-21 08:09:48.908059 :C29C3925: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-08-21 08:09:48.908105 :C29C392C: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: 21848, M002)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de