Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250518220546\orcl_m002_13392

Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250518220546\orcl_m002_13392_bucket.trc

Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250518220546\orcl_m002_13392_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:37396M/63366M, Ph+PgF:44606M/72582M 
Instance name: orcl
Redo thread mounted by this instance: 1
Oracle process number: 25
Windows thread id: 13392, image: ORACLE.EXE (M002)

*** 2025-05-18 22:05:47.024
*** SESSION ID:(201.42991) 2025-05-18 22:05:47.024

*** 2025-05-18 22:05:47.024
Process diagnostic dump for ORACLE.EXE (M002), OS id=13392,
pid: 25, proc_ser: 122, sid: 201, sess_ser: 42991 
-------------------------------------------------------------------------------
current sql: <none>
Current Wait Stack:
 0: waiting for 'ADR block file read'
     =0x0,  =0x0,  =0x0
    wait_id=428 seq_num=429 snap_id=1
    wait times: snap=0.003174 sec, exc=0.003174 sec, total=0.003174 sec
    wait times: max=infinite, heur=0.376409 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.000015 sec since current wait
 0: waited for 'ADR block file read'
     =0x0,  =0x0,  =0x0
    wait_id=427 seq_num=428 snap_id=1
    wait times: snap=0.002141 sec, exc=0.002141 sec, total=0.002141 sec
    wait times: max=infinite
    wait counts: calls=0 os=0
    occurred after 0.000017 sec of elapsed time
 1: waited for 'ADR block file read'
     =0x0,  =0x0,  =0x0
    wait_id=426 seq_num=427 snap_id=1
    wait times: snap=0.001898 sec, exc=0.001898 sec, total=0.001898 sec
    wait times: max=infinite
    wait counts: calls=0 os=0
    occurred after 0.000016 sec of elapsed time
 2: waited for 'ADR block file read'
     =0x0,  =0x0,  =0x0
    wait_id=425 seq_num=426 snap_id=1
    wait times: snap=0.006470 sec, exc=0.006470 sec, total=0.006470 sec
    wait times: max=infinite
    wait counts: calls=0 os=0
    occurred after 0.000018 sec of elapsed time
 3: waited for 'ADR block file read'
     =0x0,  =0x0,  =0x0
    wait_id=424 seq_num=425 snap_id=1
    wait times: snap=0.006227 sec, exc=0.006227 sec, total=0.006227 sec
    wait times: max=infinite
    wait counts: calls=0 os=0
    occurred after 0.000022 sec of elapsed time
 4: waited for 'ADR block file read'
     =0x0,  =0x0,  =0x0
    wait_id=423 seq_num=424 snap_id=1
    wait times: snap=0.005635 sec, exc=0.005635 sec, total=0.005635 sec
    wait times: max=infinite
    wait counts: calls=0 os=0
    occurred after 0.000018 sec of elapsed time
 5: waited for 'ADR block file read'
     =0x0,  =0x0,  =0x0
    wait_id=422 seq_num=423 snap_id=1
    wait times: snap=0.006379 sec, exc=0.006379 sec, total=0.006379 sec
    wait times: max=infinite
    wait counts: calls=0 os=0
    occurred after 0.000008 sec of elapsed time
 6: waited for 'ADR block file read'
     =0x0,  =0x0,  =0x0
    wait_id=421 seq_num=422 snap_id=1
    wait times: snap=0.000136 sec, exc=0.000136 sec, total=0.000136 sec
    wait times: max=infinite
    wait counts: calls=0 os=0
    occurred after 0.000020 sec of elapsed time
 7: waited for 'ADR block file read'
     =0x0,  =0x0,  =0x0
    wait_id=420 seq_num=421 snap_id=1
    wait times: snap=0.005847 sec, exc=0.005847 sec, total=0.005847 sec
    wait times: max=infinite
    wait counts: calls=0 os=0
    occurred after 0.000009 sec of elapsed time
 8: waited for 'ADR block file read'
     =0x0,  =0x0,  =0x0
    wait_id=419 seq_num=420 snap_id=1
    wait times: snap=0.000518 sec, exc=0.000518 sec, total=0.000518 sec
    wait times: max=infinite
    wait counts: calls=0 os=0
    occurred after 0.000018 sec of elapsed time
 9: waited for 'ADR block file read'
     =0x0,  =0x0,  =0x0
    wait_id=418 seq_num=419 snap_id=1
    wait times: snap=0.002017 sec, exc=0.002017 sec, total=0.002017 sec
    wait times: max=infinite
    wait counts: calls=0 os=0
    occurred after 0.000007 sec of elapsed time
Sampled Session History of session 201 serial 42991
---------------------------------------------------
The sampled session history is constructed by sampling
the target session every 1 second. The sampling process
captures at each sample if the session is in a non-idle wait,
an idle wait, or not in a wait. If the session is in a
non-idle wait then one interval is shown for all the samples
the session was in the same non-idle wait. If the
session is in an idle wait or not in a wait for
consecutive samples then one interval is shown for all
the consecutive samples. Though we display these consecutive
samples  in a single interval the session may NOT be continuously
idle or not in a wait (the sampling process does not know).
 
The history is displayed in reverse chronological order.
 
sample interval: 1 sec, max history 120 sec
---------------------------------------------------
  [1 sample,                                                          22:05:46]
    waited for 'ADR block file read', seq_num: 380
      p1: ' '=0x0
      p2: ' '=0x0
      p3: ' '=0x0
      time_waited: >= 0 sec (still in wait)
  [1 sample,                                                          22:05:45]
    idle wait at each sample
  [session created at: 22:05:46]
---------------------------------------------------
Sampled Session History Summary:
  longest_non_idle_wait: 'ADR block file read'
  [1 sample, 22:05:46 ]
      time_waited: >= 0 sec (still in wait)
---------------------------------------------------
-------------------------------------------------------------------------------
Process diagnostic dump actual duration=0.000000 sec
  (max dump time=30.000000 sec)

*** 2025-05-18 22:05:47.024
 
-------------------------------------------------------------------------------
Trace Bucket Dump Begin: default bucket for process 25 (osid: 13392, M002)
TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA
-------------------------------------------------------------------------------
2025-05-18 22:00:55.742214 :98E93460:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs
2025-05-18 22:00:55.742700 :98E93469: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-05-18 22:01:25.824538 :98E93F80:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted
2025-05-18 22:01:49.997275 :98E947DC:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-18 22:01:49.985
2025-05-18 22:01:49.997276 :98E947DD:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=12152 pso_num=25 pso_serial#=116
2025-05-18 22:01:49.997417 :98E947DE:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=12152 osp_idx=23 osp_ver=107215 osp_pg=0 (spawn #195847)
2025-05-18 22:01:49.997418 :98E947DF:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A
2025-05-18 22:01:49.997419 :98E947E0:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=123 time=581519860
2025-05-18 22:01:49.997419 :98E947E1:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs
2025-05-18 22:01:49.997419 :98E947E2:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs
2025-05-18 22:01:49.997420 :98E947E3:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs
2025-05-18 22:01:49.997420 :98E947E4:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs
2025-05-18 22:01:49.997421 :98E947E5:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs
2025-05-18 22:01:49.997953 :98E947E6: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-05-18 22:01:49.997999 :98E947EC: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-05-18 22:01:49.998067 :98E947F6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name=   type=0
2025-05-18 22:01:50.002666 :98E9480D: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-05-18 22:01:50.053783 :98E9483A: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-05-18 22:01:50.057445 :98E94842: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-05-18 22:01:50.058139 :98E9484A: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-05-18 22:01:50.058161 :98E9484D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name=   type=0
2025-05-18 22:01:50.058204 :98E94858:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=18 loc='ksr2.h LINE:607 ID:ksrmdone' id1=0 id2=0 name=   type=0 fac#=0 facpost=1
2025-05-18 22:01:50.059170 :98E94863: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-05-18 22:01:50.059190 :98E94866:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name=   type=0
2025-05-18 22:01:50.059219 :98E94871:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=18 loc='ksr2.h LINE:607 ID:ksrmdone' id1=0 id2=0 name=   type=0 fac#=0 facpost=1
2025-05-18 22:01:50.059652 :98E9487C: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-05-18 22:01:50.062174 :98E94884: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-05-18 22:01:50.067258 :98E9488C: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-05-18 22:01:50.072660 :98E94894: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-05-18 22:01:50.073953 :98E9489C: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-05-18 22:01:50.076908 :98E948A4: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-05-18 22:01:50.078003 :98E948AC: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-05-18 22:01:50.078012 :98E948AD:db_trace:ktur.c@3079:ktuabt(): [10444:25:201] ABORT TRANSACTION - xid: 0x000a.006.00169ac0
2025-05-18 22:01:50.081307 :98E948B5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name=   type=0
2025-05-18 22:01:50.081457 :98E948C4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name=   type=0
2025-05-18 22:01:50.081710 :98E948CF: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-05-18 22:01:50.081758 :98E948D2:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:ktcc.c:879
2025-05-18 22:01:50.081773 :98E948D3:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:ktcc.c:879
2025-05-18 22:01:50.084591 :98E948E9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name=   type=0
2025-05-18 22:01:50.084690 :98E948F8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name=   type=0
2025-05-18 22:01:50.084875 :98E948FA: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-05-18 22:01:50.084923 :98E948FD:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:ktcc.c:879
2025-05-18 22:01:50.084937 :98E948FE:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:ktcc.c:879
2025-05-18 22:01:50.085120 :98E94904: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-05-18 22:01:50.085132 :98E94907:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name=   type=0
2025-05-18 22:01:50.085154 :98E94913:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=18 loc='ksr2.h LINE:607 ID:ksrmdone' id1=0 id2=0 name=   type=0 fac#=0 facpost=1
2025-05-18 22:01:50.087112 :98E9491D:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted
2025-05-18 22:01:50.093828 :98E9493F:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-18 22:01:50.079
2025-05-18 22:01:50.093829 :98E94940:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=10076 pso_num=25 pso_serial#=117
2025-05-18 22:01:50.093958 :98E94941:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=10076 osp_idx=23 osp_ver=107216 osp_pg=0 (spawn #195850)
2025-05-18 22:01:50.093959 :98E94942:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A
2025-05-18 22:01:50.093959 :98E94943:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=124 time=581519954
2025-05-18 22:01:50.093959 :98E94944:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs
2025-05-18 22:01:50.093960 :98E94945:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs
2025-05-18 22:01:50.093960 :98E94946:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs
2025-05-18 22:01:50.093961 :98E94947:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs
2025-05-18 22:01:50.093961 :98E94948:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs
2025-05-18 22:01:50.094593 :98E94950: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-05-18 22:01:50.204452 :98E94C92: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-05-18 22:01:50.209526 :98E94CAA: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-05-18 22:01:50.209578 :98E94CAD:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:jslv.c:9203
2025-05-18 22:01:50.213535 :98E94CBD: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-05-18 22:01:50.332803 :98E94CD0: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-05-18 22:01:50.460980 :98E94CD8: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-05-18 22:01:50.587825 :98E94CE0: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-05-18 22:01:51.709339 :98E94D29: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-05-18 22:01:51.710297 :98E94D31: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-05-18 22:01:51.712042 :98E94D39: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-05-18 22:01:51.713510 :98E94D41: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-05-18 22:01:51.716987 :98E94D49: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-05-18 22:01:51.718471 :98E94D51: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-05-18 22:01:51.720923 :98E94D59: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-05-18 22:01:51.735306 :98E94D61: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-05-18 22:01:51.736060 :98E94D69: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-05-18 22:01:51.736671 :98E94D71: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-05-18 22:01:51.737200 :98E94D79: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-05-18 22:01:51.739843 :98E94D81: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-05-18 22:01:51.740775 :98E94D89:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:psdpgi.c:2235
2025-05-18 22:01:51.741570 :98E94D8A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:psdpgi.c:2235
2025-05-18 22:01:51.742325 :98E94D8B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:psdpgi.c:2235
2025-05-18 22:01:51.742730 :98E94D8C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:psdpgi.c:2235
2025-05-18 22:01:51.742737 :98E94D8D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:psdpgi.c:2235
2025-05-18 22:01:51.743320 :98E94D8E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:psdpgi.c:2235
2025-05-18 22:01:51.743909 :98E94D8F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:psdpgi.c:2235
2025-05-18 22:01:51.744220 :98E94D90:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:psdpgi.c:2235
2025-05-18 22:01:51.745297 :98E94D91:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:psdpgi.c:2235
2025-05-18 22:01:51.780143 :98E94D92: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-05-18 22:01:51.780198 :98E94D95:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:psdpgi.c:2235
2025-05-18 22:01:51.781204 :98E94D9B: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-05-18 22:01:51.782126 :98E94DA3:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:psdpgi.c:2235
2025-05-18 22:01:51.782609 :98E94DA4: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-05-18 22:01:51.803036 :98E94DB6: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-05-18 22:01:51.803091 :98E94DB9:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:psdpgi.c:2235
2025-05-18 22:01:51.804105 :98E94DBF: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-05-18 22:01:51.815914 :98E94DEE:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:psdpgi.c:2235
2025-05-18 22:01:51.816387 :98E94DEF: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-05-18 22:01:51.837073 :98E94E07: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-05-18 22:01:51.837124 :98E94E0A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:psdpgi.c:2235
2025-05-18 22:01:51.838002 :98E94E10: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-05-18 22:01:51.838827 :98E94E18:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:psdpgi.c:2235
2025-05-18 22:01:51.839252 :98E94E19: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-05-18 22:01:51.860699 :98E94E21: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-05-18 22:01:51.860753 :98E94E24:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:psdpgi.c:2235
2025-05-18 22:01:51.861696 :98E94E2A: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-05-18 22:01:51.862643 :98E94E32:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:psdpgi.c:2235
2025-05-18 22:01:51.863125 :98E94E33: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-05-18 22:01:51.881769 :98E94E3B: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-05-18 22:01:51.881822 :98E94E3E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:psdpgi.c:2235
2025-05-18 22:01:51.882690 :98E94E44: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-05-18 22:01:51.883533 :98E94E4C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:psdpgi.c:2235
2025-05-18 22:01:51.883963 :98E94E4D: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-05-18 22:01:51.904207 :98E94E55: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-05-18 22:01:51.904262 :98E94E58:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:psdpgi.c:2235
2025-05-18 22:01:51.905161 :98E94E5E: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-05-18 22:01:51.905620 :98E94E66: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-05-18 22:01:51.905963 :98E94E6E: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-05-18 22:01:51.906142 :98E94E76: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-05-18 22:01:51.906287 :98E94E7E: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-05-18 22:01:51.906436 :98E94E86:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:jslv.c:9203
2025-05-18 22:01:51.910692 :98E94E87: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-05-18 22:01:51.910795 :98E94E8A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name=   type=0
2025-05-18 22:01:51.910919 :98E94E97: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-05-18 22:01:55.834565 :98E95076: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-05-18 22:02:25.889283 :98E95CF9:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted
2025-05-18 22:02:55.992311 :98E96702:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-18 22:02:55.981
2025-05-18 22:02:55.992313 :98E96703:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=12076 pso_num=25 pso_serial#=118
2025-05-18 22:02:55.992450 :98E96704:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=12076 osp_idx=23 osp_ver=107217 osp_pg=0 (spawn #195853)
2025-05-18 22:02:55.992451 :98E96705:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A
2025-05-18 22:02:55.992451 :98E96706:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=125 time=581585860
2025-05-18 22:02:55.992452 :98E96707:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs
2025-05-18 22:02:55.992452 :98E96708:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs
2025-05-18 22:02:55.992452 :98E96709:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs
2025-05-18 22:02:55.992453 :98E9670A:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs
2025-05-18 22:02:55.992453 :98E9670B:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs
2025-05-18 22:02:55.992930 :98E9670C: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-05-18 22:03:26.081426 :98E9720C:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted
2025-05-18 22:03:56.092506 :98E97C2D:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-18 22:03:56.081
2025-05-18 22:03:56.092508 :98E97C2E:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=8780 pso_num=25 pso_serial#=119
2025-05-18 22:03:56.092681 :98E97C2F:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=8780 osp_idx=23 osp_ver=107218 osp_pg=0 (spawn #195855)
2025-05-18 22:03:56.092682 :98E97C30:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A
2025-05-18 22:03:56.092682 :98E97C31:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=126 time=581645954
2025-05-18 22:03:56.092682 :98E97C32:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs
2025-05-18 22:03:56.092683 :98E97C33:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs
2025-05-18 22:03:56.092683 :98E97C34:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs
2025-05-18 22:03:56.092684 :98E97C35:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs
2025-05-18 22:03:56.092684 :98E97C36:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs
2025-05-18 22:03:56.093158 :98E97C37: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-05-18 22:04:26.200256 :98E9863A:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted
2025-05-18 22:04:56.186077 :98E99042:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-18 22:04:56.175
2025-05-18 22:04:56.186078 :98E99043:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=14056 pso_num=25 pso_serial#=120
2025-05-18 22:04:56.186217 :98E99044:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=14056 osp_idx=23 osp_ver=107219 osp_pg=0 (spawn #195857)
2025-05-18 22:04:56.186218 :98E99045:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A
2025-05-18 22:04:56.186218 :98E99046:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=127 time=581706047
2025-05-18 22:04:56.186219 :98E99047:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs
2025-05-18 22:04:56.186219 :98E99048:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs
2025-05-18 22:04:56.186220 :98E99049:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs
2025-05-18 22:04:56.186220 :98E9904A:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs
2025-05-18 22:04:56.186220 :98E9904B:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs
2025-05-18 22:04:56.186710 :98E9904C: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-05-18 22:05:26.252720 :98E99A6B:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted
2025-05-18 22:05:45.273089 :98E9DACE:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-18 22:05:45.264
2025-05-18 22:05:45.273091 :98E9DACF:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=9168 pso_num=25 pso_serial#=121
2025-05-18 22:05:45.273255 :98E9DAD0:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=9168 osp_idx=23 osp_ver=107220 osp_pg=0 (spawn #195859)
2025-05-18 22:05:45.273255 :98E9DAD1:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A
2025-05-18 22:05:45.273256 :98E9DAD2:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=128 time=581755141
2025-05-18 22:05:45.273257 :98E9DAD3:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs
2025-05-18 22:05:45.273257 :98E9DAD4:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs
2025-05-18 22:05:45.273257 :98E9DAD5:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs
2025-05-18 22:05:45.273258 :98E9DAD6:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs
2025-05-18 22:05:45.273258 :98E9DAD7:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs
2025-05-18 22:05:45.274141 :98E9DAD8: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-05-18 22:05:45.274191 :98E9DADE: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-05-18 22:05:45.400383 :98E9DB23:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted
2025-05-18 22:05:46.567199 :98E9DB5F:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-18 22:05:46.555
2025-05-18 22:05:46.567201 :98E9DB60:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=13392 pso_num=25 pso_serial#=122
2025-05-18 22:05:46.567374 :98E9DB61:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=13392 osp_idx=23 osp_ver=107221 osp_pg=0 (spawn #195861)
2025-05-18 22:05:46.567375 :98E9DB62:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A
2025-05-18 22:05:46.567375 :98E9DB63:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=129 time=581756438
2025-05-18 22:05:46.567376 :98E9DB64:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs
2025-05-18 22:05:46.567376 :98E9DB65:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs
2025-05-18 22:05:46.567376 :98E9DB66:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs
2025-05-18 22:05:46.567376 :98E9DB67:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs
2025-05-18 22:05:46.567377 :98E9DB68:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs
2025-05-18 22:05:46.567884 :98E9DB69: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-05-18 22:05:46.567933 :98E9DB6F: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: 13392, M002)

Ms-Dos/Windows Unix Write backup

jsp File Browser version 1.2 by www.vonloesch.de