Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250709220006\orcl_w000_18072_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250709220006\orcl_w000_18072_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:36485M/63366M, Ph+PgF:42569M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 25 Windows thread id: 18072, image: ORACLE.EXE (W000) *** 2025-07-09 22:00:06.862 *** SESSION ID:(201.24819) 2025-07-09 22:00:06.862 *** 2025-07-09 22:00:06.862 Process diagnostic dump for ORACLE.EXE (W000), OS id=18072, pid: 25, proc_ser: 15, sid: 201, sess_ser: 24819 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=14 seq_num=15 snap_id=1 wait times: snap=0.192794 sec, exc=0.192794 sec, total=0.192794 sec wait times: max=5.000000 sec, heur=1 min 5 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.000024 sec since current wait 0: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=13 seq_num=14 snap_id=1 wait times: snap=5.012825 sec, exc=5.012825 sec, total=5.012825 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000021 sec of elapsed time 1: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=12 seq_num=13 snap_id=1 wait times: snap=5.001524 sec, exc=5.001524 sec, total=5.001524 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000023 sec of elapsed time 2: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=11 seq_num=12 snap_id=1 wait times: snap=5.004635 sec, exc=5.004635 sec, total=5.004635 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000024 sec of elapsed time 3: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=10 seq_num=11 snap_id=1 wait times: snap=5.014727 sec, exc=5.014727 sec, total=5.014727 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000020 sec of elapsed time 4: 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.015240 sec, exc=5.015240 sec, total=5.015240 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000032 sec of elapsed time 5: 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.003300 sec, exc=5.003300 sec, total=5.003300 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000020 sec of elapsed time 6: 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.000270 sec, exc=5.000270 sec, total=5.000270 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000023 sec of elapsed time 7: 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.014577 sec, exc=5.014577 sec, total=5.014577 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=5 seq_num=6 snap_id=1 wait times: snap=5.008767 sec, exc=5.008767 sec, total=5.008767 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000025 sec of elapsed time 9: 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.004640 sec, exc=5.004640 sec, total=5.004640 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000022 sec of elapsed time Sampled Session History of session 201 serial 24819 --------------------------------------------------- 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 --------------------------------------------------- [66 samples, 21:59:01 - 22:00:06] idle wait at each sample [session created at: 21:59:01] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-07-09 22:00:06.862 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 25 (osid: 18072, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-07-09 19:38:42.685030 :AFC9D605:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=15736 pso_num=25 pso_serial#=1 2025-07-09 19:38:42.685168 :AFC9D606:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=15736 osp_idx=23 osp_ver=189068 osp_pg=0 (spawn #368825) 2025-07-09 19:38:42.685168 :AFC9D607:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-09 19:38:42.685169 :AFC9D608:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=175 time=770698579 2025-07-09 19:38:42.685169 :AFC9D609:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-09 19:38:42.685170 :AFC9D60A:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-09 19:38:42.685170 :AFC9D60B:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-09 19:38:42.685170 :AFC9D60C:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-09 19:38:42.685171 :AFC9D60D:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-09 19:38:42.685662 :AFC9D60E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-09 19:38:42.685708 :AFC9D616:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-07-09 19:48:43.657926 :AFCA9ED7:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-09 19:48:44.068834 :AFCA9F17:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-09 19:48:44.064 2025-07-09 19:48:44.068836 :AFCA9F18:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=9420 pso_num=25 pso_serial#=2 2025-07-09 19:48:44.068972 :AFCA9F19:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=9420 osp_idx=23 osp_ver=189069 osp_pg=0 (spawn #368849) 2025-07-09 19:48:44.068973 :AFCA9F1A:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-09 19:48:44.068973 :AFCA9F1B:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=176 time=771299970 2025-07-09 19:48:44.068973 :AFCA9F1C:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-09 19:48:44.068974 :AFCA9F1D:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-09 19:48:44.068974 :AFCA9F1E:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-09 19:48:44.068975 :AFCA9F1F:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-09 19:48:44.068975 :AFCA9F20:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-09 19:48:44.069464 :AFCA9F21:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-09 19:48:44.069508 :AFCA9F29:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-07-09 19:58:44.939688 :AFCB672D:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-09 19:58:45.329471 :AFCB6766:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-09 19:58:45.325 2025-07-09 19:58:45.329472 :AFCB6767:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=17540 pso_num=25 pso_serial#=3 2025-07-09 19:58:45.329607 :AFCB6768:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=17540 osp_idx=23 osp_ver=189070 osp_pg=0 (spawn #368871) 2025-07-09 19:58:45.329607 :AFCB6769:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-09 19:58:45.329608 :AFCB676A:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=177 time=771901220 2025-07-09 19:58:45.329608 :AFCB676B:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-09 19:58:45.329608 :AFCB676C:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-09 19:58:45.329609 :AFCB676D:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-09 19:58:45.329609 :AFCB676E:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-09 19:58:45.329609 :AFCB676F:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-09 19:58:45.330088 :AFCB6770:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-09 19:58:45.330136 :AFCB6778:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-07-09 20:08:46.373339 :AFCC38A4:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-09 20:08:46.643709 :AFCC38DE:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-09 20:08:46.639 2025-07-09 20:08:46.643711 :AFCC38DF:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=2648 pso_num=25 pso_serial#=4 2025-07-09 20:08:46.643849 :AFCC38E0:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=2648 osp_idx=23 osp_ver=189071 osp_pg=0 (spawn #368897) 2025-07-09 20:08:46.643850 :AFCC38E1:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-09 20:08:46.643850 :AFCC38E2:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=178 time=772502533 2025-07-09 20:08:46.643850 :AFCC38E3:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-09 20:08:46.643851 :AFCC38E4:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-09 20:08:46.643851 :AFCC38E5:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-09 20:08:46.643852 :AFCC38E6:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-09 20:08:46.643852 :AFCC38E7:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-09 20:08:46.644358 :AFCC38E8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-09 20:08:46.644407 :AFCC38EF:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-07-09 20:18:47.545221 :AFCD0449:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-09 20:18:47.741619 :AFCD044C:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-09 20:18:47.733 2025-07-09 20:18:47.741621 :AFCD044D:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=15244 pso_num=25 pso_serial#=5 2025-07-09 20:18:47.741762 :AFCD044E:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=15244 (legacy spawn) 2025-07-09 20:18:47.748314 :AFCD044F: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-09 20:18:47.748478 :AFCD0454: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-09 20:18:47.749276 :AFCD0459:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-09 20:18:47.878188 :AFCD0497:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-09 20:18:47.873 2025-07-09 20:18:47.878190 :AFCD0498:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=16424 pso_num=25 pso_serial#=6 2025-07-09 20:18:47.878328 :AFCD0499:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=16424 osp_idx=23 osp_ver=189073 osp_pg=0 (spawn #368920) 2025-07-09 20:18:47.878328 :AFCD049A:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-09 20:18:47.878329 :AFCD049B:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=179 time=773103767 2025-07-09 20:18:47.878329 :AFCD049C:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-09 20:18:47.878330 :AFCD049D:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-09 20:18:47.878330 :AFCD049E:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-09 20:18:47.878330 :AFCD049F:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-09 20:18:47.878331 :AFCD04A0:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-09 20:18:47.878828 :AFCD04A1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-09 20:18:47.878875 :AFCD04AA:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-07-09 20:28:48.831668 :AFCDCC3E:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-09 20:28:49.227077 :AFCDCC83:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-09 20:28:49.222 2025-07-09 20:28:49.227079 :AFCDCC84:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=17592 pso_num=25 pso_serial#=7 2025-07-09 20:28:49.227216 :AFCDCC85:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=17592 osp_idx=23 osp_ver=189074 osp_pg=0 (spawn #368942) 2025-07-09 20:28:49.227217 :AFCDCC86:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-09 20:28:49.227217 :AFCDCC87:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=180 time=773705126 2025-07-09 20:28:49.227217 :AFCDCC88:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-09 20:28:49.227218 :AFCDCC89:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-09 20:28:49.227218 :AFCDCC8A:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-09 20:28:49.227219 :AFCDCC8B:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-09 20:28:49.227219 :AFCDCC8C:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-09 20:28:49.227706 :AFCDCC8D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-09 20:28:49.227751 :AFCDCC93:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-07-09 20:38:16.897261 :AFCE8AC5:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-07-09 20:38:50.543116 :AFCE9676:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-07-09 20:48:51.428126 :AFCF642C:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-09 20:48:51.932917 :AFCF647E:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-09 20:48:51.928 2025-07-09 20:48:51.932919 :AFCF647F:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=10320 pso_num=25 pso_serial#=8 2025-07-09 20:48:51.933089 :AFCF6480:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=10320 osp_idx=23 osp_ver=189075 osp_pg=0 (spawn #368987) 2025-07-09 20:48:51.933090 :AFCF6481:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-09 20:48:51.933090 :AFCF6482:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=181 time=774907829 2025-07-09 20:48:51.933090 :AFCF6483:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-09 20:48:51.933091 :AFCF6484:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-09 20:48:51.933091 :AFCF6485:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-09 20:48:51.933092 :AFCF6486:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-09 20:48:51.933092 :AFCF6487:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-09 20:48:51.933587 :AFCF6488:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-09 20:48:51.933630 :AFCF6491:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-07-09 20:58:52.781335 :AFD02D1E:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-09 20:58:53.254759 :AFD02D60:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-09 20:58:53.250 2025-07-09 20:58:53.254761 :AFD02D61:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=6652 pso_num=25 pso_serial#=9 2025-07-09 20:58:53.254901 :AFD02D62:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=6652 osp_idx=23 osp_ver=189076 osp_pg=0 (spawn #369009) 2025-07-09 20:58:53.254902 :AFD02D63:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-09 20:58:53.254902 :AFD02D64:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=182 time=775509142 2025-07-09 20:58:53.254903 :AFD02D65:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-09 20:58:53.254903 :AFD02D66:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-09 20:58:53.254904 :AFD02D67:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-09 20:58:53.254904 :AFD02D68:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-09 20:58:53.254904 :AFD02D69:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-09 20:58:53.255419 :AFD02D6A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-09 20:58:53.255474 :AFD02D74:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-07-09 21:08:54.176952 :AFD0FD37:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-09 21:08:54.634789 :AFD0FD79:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-09 21:08:54.630 2025-07-09 21:08:54.634791 :AFD0FD7A:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=9372 pso_num=25 pso_serial#=10 2025-07-09 21:08:54.634922 :AFD0FD7B:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=9372 osp_idx=23 osp_ver=189077 osp_pg=0 (spawn #369033) 2025-07-09 21:08:54.634922 :AFD0FD7C:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-09 21:08:54.634923 :AFD0FD7D:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=183 time=776110533 2025-07-09 21:08:54.634923 :AFD0FD7E:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-09 21:08:54.634923 :AFD0FD7F:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-09 21:08:54.634926 :AFD0FD80:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-09 21:08:54.634926 :AFD0FD81:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-09 21:08:54.634926 :AFD0FD82:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-09 21:08:54.635402 :AFD0FD83:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-09 21:08:54.635447 :AFD0FD8B:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-07-09 21:18:55.507475 :AFD1C93F:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-09 21:18:56.043433 :AFD1C98D:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-09 21:18:56.039 2025-07-09 21:18:56.043435 :AFD1C98E:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=15964 pso_num=25 pso_serial#=11 2025-07-09 21:18:56.043577 :AFD1C98F:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=15964 osp_idx=23 osp_ver=189078 osp_pg=0 (spawn #369056) 2025-07-09 21:18:56.043578 :AFD1C990:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-09 21:18:56.043578 :AFD1C991:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=184 time=776711939 2025-07-09 21:18:56.043578 :AFD1C992:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-09 21:18:56.043579 :AFD1C993:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-09 21:18:56.043579 :AFD1C994:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-09 21:18:56.043579 :AFD1C995:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-09 21:18:56.043580 :AFD1C996:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-09 21:18:56.044072 :AFD1C997:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-09 21:18:56.044128 :AFD1C99D:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-07-09 21:28:56.898139 :AFD291F0:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-09 21:28:57.449740 :AFD29241:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-09 21:28:57.445 2025-07-09 21:28:57.449742 :AFD29242:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=16720 pso_num=25 pso_serial#=12 2025-07-09 21:28:57.449879 :AFD29243:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=16720 osp_idx=23 osp_ver=189079 osp_pg=0 (spawn #369078) 2025-07-09 21:28:57.449880 :AFD29244:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-09 21:28:57.449881 :AFD29245:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=185 time=777313345 2025-07-09 21:28:57.449881 :AFD29246:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-09 21:28:57.449881 :AFD29247:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-09 21:28:57.449882 :AFD29248:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-09 21:28:57.449882 :AFD29249:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-09 21:28:57.449882 :AFD2924A:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-09 21:28:57.450408 :AFD2924B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-09 21:28:57.450466 :AFD29255:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-07-09 21:38:58.389696 :AFD35B6B:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-09 21:38:58.832183 :AFD35BB8:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-09 21:38:58.827 2025-07-09 21:38:58.832185 :AFD35BB9:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=16840 pso_num=25 pso_serial#=13 2025-07-09 21:38:58.832334 :AFD35BBA:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=16840 osp_idx=23 osp_ver=189080 osp_pg=0 (spawn #369101) 2025-07-09 21:38:58.832335 :AFD35BBB:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-09 21:38:58.832335 :AFD35BBC:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=186 time=777914720 2025-07-09 21:38:58.832336 :AFD35BBD:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-09 21:38:58.832336 :AFD35BBE:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-09 21:38:58.832337 :AFD35BBF:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-09 21:38:58.832337 :AFD35BC0:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-09 21:38:58.832337 :AFD35BC1:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-09 21:38:58.832844 :AFD35BC2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-09 21:38:58.832893 :AFD35BCA:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-07-09 21:48:59.798232 :AFD4253C:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-09 21:49:00.219418 :AFD42581:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-09 21:49:00.214 2025-07-09 21:49:00.219420 :AFD42582:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=10888 pso_num=25 pso_serial#=14 2025-07-09 21:49:00.219560 :AFD42583:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=10888 osp_idx=23 osp_ver=189081 osp_pg=0 (spawn #369124) 2025-07-09 21:49:00.219561 :AFD42584:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-09 21:49:00.219561 :AFD42585:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=187 time=778516111 2025-07-09 21:49:00.219562 :AFD42586:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-09 21:49:00.219562 :AFD42587:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-09 21:49:00.219562 :AFD42588:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-09 21:49:00.219563 :AFD42589:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-09 21:49:00.219563 :AFD4258A:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-09 21:49:00.220065 :AFD4258B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-09 21:49:00.220106 :AFD42593:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-07-09 21:59:01.092907 :AFD4EDC5:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-09 21:59:01.582035 :AFD4EE11:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-09 21:59:01.577 2025-07-09 21:59:01.582037 :AFD4EE12:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=18072 pso_num=25 pso_serial#=15 2025-07-09 21:59:01.582172 :AFD4EE13:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=18072 osp_idx=23 osp_ver=189082 osp_pg=0 (spawn #369146) 2025-07-09 21:59:01.582173 :AFD4EE14:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-09 21:59:01.582173 :AFD4EE15:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=188 time=779117470 2025-07-09 21:59:01.582174 :AFD4EE16:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-09 21:59:01.582174 :AFD4EE17:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-09 21:59:01.582174 :AFD4EE18:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-09 21:59:01.582175 :AFD4EE19:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-09 21:59:01.582175 :AFD4EE1A:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-09 21:59:01.582670 :AFD4EE1B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-09 21:59:01.582715 :AFD4EE23:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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 25 (osid: 18072, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de