Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250517180806\orcl_w000_14288_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250517180806\orcl_w000_14288_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:37382M/63366M, Ph+PgF:44611M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 26 Windows thread id: 14288, image: ORACLE.EXE (W000) *** 2025-05-17 18:08:06.676 *** SESSION ID:(209.46841) 2025-05-17 18:08:06.676 *** 2025-05-17 18:08:06.676 Process diagnostic dump for ORACLE.EXE (W000), OS id=14288, pid: 26, proc_ser: 84, sid: 209, sess_ser: 46841 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=10 seq_num=11 snap_id=1 wait times: snap=3.906191 sec, exc=3.906191 sec, total=3.906191 sec wait times: max=5.000000 sec, heur=49.000614 sec wait counts: calls=1 os=1 in_wait=1 iflags=0x5a8 Wait State: fixed_waits=0 flags=0x22 boundary=0x0000000000000000/-1 Session Wait History: elapsed time of 0.000016 sec since current wait 0: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=9 seq_num=10 snap_id=1 wait times: snap=5.013835 sec, exc=5.013835 sec, total=5.013835 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000025 sec of elapsed time 1: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=8 seq_num=9 snap_id=1 wait times: snap=5.010111 sec, exc=5.010111 sec, total=5.010111 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000028 sec of elapsed time 2: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=7 seq_num=8 snap_id=1 wait times: snap=5.014704 sec, exc=5.014704 sec, total=5.014704 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000027 sec of elapsed time 3: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=6 seq_num=7 snap_id=1 wait times: snap=5.014747 sec, exc=5.014747 sec, total=5.014747 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000023 sec of elapsed time 4: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=5 seq_num=6 snap_id=1 wait times: snap=5.004610 sec, exc=5.004610 sec, total=5.004610 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000027 sec of elapsed time 5: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=4 seq_num=5 snap_id=1 wait times: snap=5.015238 sec, exc=5.015238 sec, total=5.015238 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000024 sec of elapsed time 6: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=3 seq_num=4 snap_id=1 wait times: snap=5.003375 sec, exc=5.003375 sec, total=5.003375 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000022 sec of elapsed time 7: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=2 seq_num=3 snap_id=1 wait times: snap=5.012677 sec, exc=5.012677 sec, total=5.012677 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000022 sec of elapsed time 8: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=1 seq_num=2 snap_id=1 wait times: snap=5.004912 sec, exc=5.004912 sec, total=5.004912 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.004034 sec of elapsed time 9: waited for 'class slave wait' slave id=0x11aee070, =0x0, =0x0 wait_id=0 seq_num=1 snap_id=1 wait times: snap=0.000037 sec, exc=0.000037 sec, total=0.000037 sec wait times: max=infinite wait counts: calls=1 os=1 occurred after 0.000000 sec of elapsed time Sampled Session History of session 209 serial 46841 --------------------------------------------------- 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 --------------------------------------------------- [49 samples, 18:07:17 - 18:08:06] idle wait at each sample [session created at: 18:07:17] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-05-17 18:08:06.676 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 26 (osid: 14288, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-17 15:46:58.112803 :9857F7FD:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=13012 osp_idx=24 osp_ver=284394 osp_pg=0 (spawn #191635) 2025-05-17 15:46:58.112804 :9857F7FE:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-17 15:46:58.112804 :9857F7FF:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=11 time=472627985 2025-05-17 15:46:58.112805 :9857F800:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-17 15:46:58.112805 :9857F801:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-17 15:46:58.112805 :9857F802:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-17 15:46:58.112806 :9857F803:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-17 15:46:58.112806 :9857F804:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-17 15:46:58.113353 :9857F805:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-17 15:46:58.113401 :9857F80C:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-17 15:56:59.105454 :9858C1C4:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-17 15:56:59.500741 :9858C35A:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-17 15:56:59.496 2025-05-17 15:56:59.500744 :9858C35B:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=13316 pso_num=26 pso_serial#=71 2025-05-17 15:56:59.500887 :9858C35C:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=13316 osp_idx=24 osp_ver=284395 osp_pg=0 (spawn #191658) 2025-05-17 15:56:59.500887 :9858C35D:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-17 15:56:59.500888 :9858C35E:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=12 time=473229375 2025-05-17 15:56:59.500888 :9858C35F:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-17 15:56:59.500888 :9858C360:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-17 15:56:59.500889 :9858C361:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-17 15:56:59.500889 :9858C362:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-17 15:56:59.500889 :9858C363:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-17 15:56:59.501402 :9858C364:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-17 15:56:59.501448 :9858C36C:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-17 16:07:00.460940 :9859960C:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-17 16:07:00.965730 :98599645:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-17 16:07:00.961 2025-05-17 16:07:00.965732 :98599646:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=3448 pso_num=26 pso_serial#=72 2025-05-17 16:07:00.965877 :98599647:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=3448 osp_idx=24 osp_ver=284396 osp_pg=0 (spawn #191685) 2025-05-17 16:07:00.965878 :98599648:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-17 16:07:00.965878 :98599649:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=13 time=473830829 2025-05-17 16:07:00.965879 :9859964A:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-17 16:07:00.965879 :9859964B:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-17 16:07:00.965879 :9859964C:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-17 16:07:00.965880 :9859964D:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-17 16:07:00.965880 :9859964E:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-17 16:07:00.966387 :9859964F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-17 16:07:00.966435 :98599657:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-17 16:17:01.839587 :985A6489:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-17 16:17:02.403228 :985A64CC:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-17 16:17:02.403 2025-05-17 16:17:02.403231 :985A64CD:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=11620 pso_num=26 pso_serial#=73 2025-05-17 16:17:02.403370 :985A64CE:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=11620 osp_idx=24 osp_ver=284397 osp_pg=0 (spawn #191707) 2025-05-17 16:17:02.403370 :985A64CF:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-17 16:17:02.403371 :985A64D0:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=14 time=474432266 2025-05-17 16:17:02.403371 :985A64D1:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-17 16:17:02.403372 :985A64D2:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-17 16:17:02.403372 :985A64D3:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-17 16:17:02.403372 :985A64D4:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-17 16:17:02.403372 :985A64D5:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-17 16:17:02.403899 :985A64D6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-17 16:17:02.403957 :985A64DD:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-17 16:27:03.297476 :985B3182:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-17 16:27:03.859120 :985B31BF:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-17 16:27:03.854 2025-05-17 16:27:03.859123 :985B31C0:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=13912 pso_num=26 pso_serial#=74 2025-05-17 16:27:03.859259 :985B31C1:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=13912 osp_idx=24 osp_ver=284398 osp_pg=0 (spawn #191730) 2025-05-17 16:27:03.859259 :985B31C2:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-17 16:27:03.859260 :985B31C3:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=15 time=475033735 2025-05-17 16:27:03.859260 :985B31C4:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-17 16:27:03.859261 :985B31C5:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-17 16:27:03.859261 :985B31C6:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-17 16:27:03.859262 :985B31C7:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-17 16:27:03.859262 :985B31C8:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-17 16:27:03.859749 :985B31C9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-17 16:27:03.859792 :985B31D0:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-17 16:37:04.785766 :985BFF29:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-17 16:37:05.306042 :985BFF71:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-17 16:37:05.301 2025-05-17 16:37:05.306044 :985BFF72:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=2752 pso_num=26 pso_serial#=75 2025-05-17 16:37:05.306179 :985BFF73:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=2752 osp_idx=24 osp_ver=284399 osp_pg=0 (spawn #191753) 2025-05-17 16:37:05.306180 :985BFF74:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-17 16:37:05.306180 :985BFF75:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=16 time=475635172 2025-05-17 16:37:05.306181 :985BFF76:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-17 16:37:05.306181 :985BFF77:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-17 16:37:05.306182 :985BFF78:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-17 16:37:05.306182 :985BFF79:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-17 16:37:05.306182 :985BFF7A:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-17 16:37:05.306680 :985BFF7B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-17 16:37:05.306732 :985BFF81:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-17 16:47:06.240679 :985CCBD5:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-17 16:47:06.776656 :985CCC1E:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-17 16:47:06.771 2025-05-17 16:47:06.776658 :985CCC1F:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=14148 pso_num=26 pso_serial#=76 2025-05-17 16:47:06.776794 :985CCC20:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=14148 osp_idx=24 osp_ver=284400 osp_pg=0 (spawn #191775) 2025-05-17 16:47:06.776795 :985CCC21:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-17 16:47:06.776795 :985CCC22:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=17 time=476236641 2025-05-17 16:47:06.776795 :985CCC23:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-17 16:47:06.776796 :985CCC24:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-17 16:47:06.776796 :985CCC25:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-17 16:47:06.776797 :985CCC26:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-17 16:47:06.776797 :985CCC27:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-17 16:47:06.777284 :985CCC28:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-17 16:47:06.777331 :985CCC2F:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-17 16:57:07.771340 :985D99D9:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-17 16:57:08.229164 :985D9A15:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-17 16:57:08.224 2025-05-17 16:57:08.229168 :985D9A16:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=14064 pso_num=26 pso_serial#=77 2025-05-17 16:57:08.229303 :985D9A17:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=14064 osp_idx=24 osp_ver=284401 osp_pg=0 (spawn #191798) 2025-05-17 16:57:08.229304 :985D9A18:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-17 16:57:08.229304 :985D9A19:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=18 time=476838094 2025-05-17 16:57:08.229305 :985D9A1A:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-17 16:57:08.229305 :985D9A1B:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-17 16:57:08.229307 :985D9A1C:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-17 16:57:08.229307 :985D9A1D:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-17 16:57:08.229308 :985D9A1E:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-17 16:57:08.229819 :985D9A1F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-17 16:57:08.229873 :985D9A29:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-17 17:07:09.170583 :985E6F42:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-17 17:07:09.659705 :985E6FB4:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-17 17:07:09.655 2025-05-17 17:07:09.659708 :985E6FB5:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12924 pso_num=26 pso_serial#=78 2025-05-17 17:07:09.659877 :985E6FB6:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=12924 osp_idx=24 osp_ver=284402 osp_pg=0 (spawn #191824) 2025-05-17 17:07:09.659877 :985E6FB7:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-17 17:07:09.659878 :985E6FB8:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=19 time=477439532 2025-05-17 17:07:09.659878 :985E6FB9:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-17 17:07:09.659878 :985E6FBA:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-17 17:07:09.659879 :985E6FBB:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-17 17:07:09.659880 :985E6FBC:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-17 17:07:09.659880 :985E6FBD:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-17 17:07:09.660378 :985E6FBE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-17 17:07:09.660420 :985E6FC5:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-17 17:17:10.566665 :985F3F40:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-17 17:17:11.024380 :985F3FA5:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-17 17:17:11.020 2025-05-17 17:17:11.024383 :985F3FA6:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=14052 pso_num=26 pso_serial#=79 2025-05-17 17:17:11.024544 :985F3FA7:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=14052 osp_idx=24 osp_ver=284403 osp_pg=0 (spawn #191846) 2025-05-17 17:17:11.024544 :985F3FA8:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-17 17:17:11.024545 :985F3FA9:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=20 time=478040891 2025-05-17 17:17:11.024545 :985F3FAA:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-17 17:17:11.024545 :985F3FAB:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-17 17:17:11.024546 :985F3FAC:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-17 17:17:11.024546 :985F3FAD:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-17 17:17:11.024546 :985F3FAE:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-17 17:17:11.025053 :985F3FAF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-17 17:17:11.025105 :985F3FB6:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-17 17:20:21.597312 :985F80F0:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=16 loc='ksl2.h LINE:2165 ID:kslpsr' id1=255 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-17 17:27:12.378759 :98600C15:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=23 loc='ksl2.h LINE:2165 ID:kslpsr' id1=255 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-17 17:37:13.322781 :9860D838:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-17 17:37:13.717830 :9860D8A9:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-17 17:37:13.713 2025-05-17 17:37:13.717832 :9860D8AA:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=14180 pso_num=26 pso_serial#=80 2025-05-17 17:37:13.717964 :9860D8AB:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=14180 osp_idx=24 osp_ver=284404 osp_pg=0 (spawn #191891) 2025-05-17 17:37:13.717965 :9860D8AC:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-17 17:37:13.717965 :9860D8AD:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=21 time=479243594 2025-05-17 17:37:13.717965 :9860D8AE:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-17 17:37:13.717966 :9860D8AF:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-17 17:37:13.717966 :9860D8B0:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-17 17:37:13.717966 :9860D8B1:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-17 17:37:13.717967 :9860D8B2:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-17 17:37:13.718461 :9860D8B3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-17 17:37:13.718505 :9860D8BB:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-17 17:47:14.735459 :9861A237:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-17 17:47:15.021464 :9861A297:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-17 17:47:15.016 2025-05-17 17:47:15.021466 :9861A298:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=10780 pso_num=26 pso_serial#=81 2025-05-17 17:47:15.021603 :9861A299:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=10780 osp_idx=24 osp_ver=284405 osp_pg=0 (spawn #191913) 2025-05-17 17:47:15.021603 :9861A29A:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-17 17:47:15.021604 :9861A29B:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=22 time=479844891 2025-05-17 17:47:15.021604 :9861A29C:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-17 17:47:15.021604 :9861A29D:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-17 17:47:15.021605 :9861A29E:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-17 17:47:15.021605 :9861A29F:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-17 17:47:15.021606 :9861A2A0:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-17 17:47:15.022164 :9861A2A1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-17 17:47:15.022207 :9861A2A8:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-17 17:57:15.992811 :98626D24:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-17 17:57:16.235380 :98626D27:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-17 17:57:16.227 2025-05-17 17:57:16.235382 :98626D28:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=9376 pso_num=26 pso_serial#=82 2025-05-17 17:57:16.235520 :98626D29:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=9376 (legacy spawn) 2025-05-17 17:57:16.242023 :98626D2A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 17:57:16.242194 :98626D2F:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-17 17:57:16.243020 :98626D34:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-17 17:57:16.357000 :98626D69:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-17 17:57:16.352 2025-05-17 17:57:16.357002 :98626D6A:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=7912 pso_num=26 pso_serial#=83 2025-05-17 17:57:16.357141 :98626D6B:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=7912 osp_idx=24 osp_ver=284407 osp_pg=0 (spawn #191936) 2025-05-17 17:57:16.357141 :98626D6C:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-17 17:57:16.357142 :98626D6D:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=23 time=480446219 2025-05-17 17:57:16.357142 :98626D6E:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-17 17:57:16.357142 :98626D6F:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-17 17:57:16.357143 :98626D70:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-17 17:57:16.357143 :98626D71:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-17 17:57:16.357144 :98626D72:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-17 17:57:16.357649 :98626D73:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-17 17:57:16.357694 :98626D7A:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-17 18:07:17.299220 :98633EE9:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-17 18:07:17.678952 :98633F2F:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-17 18:07:17.674 2025-05-17 18:07:17.678954 :98633F30:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=14288 pso_num=26 pso_serial#=84 2025-05-17 18:07:17.679092 :98633F31:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=14288 osp_idx=24 osp_ver=284408 osp_pg=0 (spawn #191962) 2025-05-17 18:07:17.679092 :98633F32:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-17 18:07:17.679093 :98633F33:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=24 time=481047547 2025-05-17 18:07:17.679093 :98633F34:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-17 18:07:17.679093 :98633F35:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-17 18:07:17.679094 :98633F36:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-17 18:07:17.679094 :98633F37:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-17 18:07:17.679094 :98633F38:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-17 18:07:17.679578 :98633F39:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-17 18:07:17.679619 :98633F41:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=23 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 26 (osid: 14288, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de