Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250426060007\orcl_j005_10360_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:37579M/63366M, Ph+PgF:45251M/72582M 
Instance name: orcl
Redo thread mounted by this instance: 1
Oracle process number: 31
Windows thread id: 10360, image: ORACLE.EXE (J005)


*** 2025-04-26 06:00:07.374
*** SESSION ID:(249.461) 2025-04-26 06:00:07.374
 

*** 2025-04-26 06:00:07.374
Process diagnostic dump for ORACLE.EXE (J005), OS id=10360,
pid: 31, proc_ser: 223, sid: 249, sess_ser: 461 
-------------------------------------------------------------------------------
current sql: <none>
client details:
  O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 10360
  machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J005)
Current Wait Stack:
 0: waiting for 'jobq slave wait'
    =0x0, =0x0, =0x0
    wait_id=14 seq_num=15 snap_id=1
    wait times: snap=0.113099 sec, exc=0.113099 sec, total=0.113099 sec
    wait times: max=0.500000 sec, heur=7.133085 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.000008 sec since current wait
 0: waited for 'jobq slave wait'
    =0x0, =0x0, =0x0
    wait_id=13 seq_num=14 snap_id=1
    wait times: snap=0.499989 sec, exc=0.499989 sec, total=0.499989 sec
    wait times: max=0.500000 sec
    wait counts: calls=1 os=1
    occurred after 0.000010 sec of elapsed time
 1: waited for 'jobq slave wait'
    =0x0, =0x0, =0x0
    wait_id=12 seq_num=13 snap_id=1
    wait times: snap=0.500050 sec, exc=0.500050 sec, total=0.500050 sec
    wait times: max=0.500000 sec
    wait counts: calls=1 os=1
    occurred after 0.000008 sec of elapsed time
 2: waited for 'jobq slave wait'
    =0x0, =0x0, =0x0
    wait_id=11 seq_num=12 snap_id=1
    wait times: snap=0.500068 sec, exc=0.500068 sec, total=0.500068 sec
    wait times: max=0.500000 sec
    wait counts: calls=1 os=1
    occurred after 0.000011 sec of elapsed time
 3: waited for 'jobq slave wait'
    =0x0, =0x0, =0x0
    wait_id=10 seq_num=11 snap_id=1
    wait times: snap=0.499985 sec, exc=0.499985 sec, total=0.499985 sec
    wait times: max=0.500000 sec
    wait counts: calls=1 os=1
    occurred after 0.000007 sec of elapsed time
 4: waited for 'jobq slave wait'
    =0x0, =0x0, =0x0
    wait_id=9 seq_num=10 snap_id=1
    wait times: snap=0.500010 sec, exc=0.500010 sec, total=0.500010 sec
    wait times: max=0.500000 sec
    wait counts: calls=1 os=1
    occurred after 0.000012 sec of elapsed time
 5: waited for 'jobq slave wait'
    =0x0, =0x0, =0x0
    wait_id=8 seq_num=9 snap_id=1
    wait times: snap=0.499995 sec, exc=0.499995 sec, total=0.499995 sec
    wait times: max=0.500000 sec
    wait counts: calls=1 os=1
    occurred after 0.000008 sec of elapsed time
 6: waited for 'jobq slave wait'
    =0x0, =0x0, =0x0
    wait_id=7 seq_num=8 snap_id=1
    wait times: snap=0.508022 sec, exc=0.508022 sec, total=0.508022 sec
    wait times: max=0.500000 sec
    wait counts: calls=1 os=1
    occurred after 0.000012 sec of elapsed time
 7: waited for 'jobq slave wait'
    =0x0, =0x0, =0x0
    wait_id=6 seq_num=7 snap_id=1
    wait times: snap=0.510113 sec, exc=0.510113 sec, total=0.510113 sec
    wait times: max=0.500000 sec
    wait counts: calls=1 os=1
    occurred after 0.000009 sec of elapsed time
 8: waited for 'jobq slave wait'
    =0x0, =0x0, =0x0
    wait_id=5 seq_num=6 snap_id=1
    wait times: snap=0.499993 sec, exc=0.499993 sec, total=0.499993 sec
    wait times: max=0.500000 sec
    wait counts: calls=1 os=1
    occurred after 0.000010 sec of elapsed time
 9: waited for 'jobq slave wait'
    =0x0, =0x0, =0x0
    wait_id=4 seq_num=5 snap_id=1
    wait times: snap=0.500001 sec, exc=0.500001 sec, total=0.500001 sec
    wait times: max=0.500000 sec
    wait counts: calls=1 os=1
    occurred after 0.000010 sec of elapsed time
Sampled Session History of session 249 serial 461
---------------------------------------------------
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
---------------------------------------------------
  [8 samples,                                              06:00:00 - 06:00:07]
    idle wait at each sample
  [session created at: 06:00:00]
-------------------------------------------------------------------------------
Process diagnostic dump actual duration=0.000000 sec
  (max dump time=30.000000 sec)

*** 2025-04-26 06:00:07.374
 
-------------------------------------------------------------------------------
Trace Bucket Dump Begin: default bucket for process 31 (osid: 10360, J005)
TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA
-------------------------------------------------------------------------------
2025-04-21 23:59:15.878408 :8CFCF615:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:31:249] atxpop:psdpgi.c:2235
2025-04-21 23:59:15.879484 :8CFCF61B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name=   type=0
2025-04-21 23:59:15.879770 :8CFCF624:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-04-21 23:59:45.971951 :8CFD0174:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted
2025-04-21 23:59:55.422699 :8CFD04CD:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 04-21 23:59:55.415
2025-04-21 23:59:55.422701 :8CFD04CE:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=8476 pso_num=31 pso_serial#=200
2025-04-21 23:59:55.422902 :8CFD04CF:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=8476 (legacy spawn)
2025-04-21 23:59:55.436709 :8CFD04D0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name=   type=0
2025-04-22 00:00:28.466792 :8CFD1209:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted
2025-04-22 22:00:02.072905 :8D641732:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 04-22 22:00:02.070
2025-04-22 22:00:02.072907 :8D641733:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=10060 pso_num=31 pso_serial#=201
2025-04-22 22:00:02.073044 :8D641734:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=10060 osp_idx=29 osp_ver=200 osp_pg=0 (spawn #107763)
2025-04-22 22:00:02.073044 :8D641735:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A
2025-04-22 22:00:02.073045 :8D641736:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=73 time=2630003859
2025-04-22 22:00:02.073046 :8D641737:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs
2025-04-22 22:00:02.073046 :8D641738:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs
2025-04-22 22:00:02.073047 :8D641739:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs
2025-04-22 22:00:02.073047 :8D64173A:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs
2025-04-22 22:00:02.073047 :8D64173B:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs
2025-04-22 22:00:02.073688 :8D64174D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name=   type=0
2025-04-22 22:00:32.155886 :8D642B22:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted
2025-04-22 23:59:18.009049 :8D6D82EA:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 04-22 23:59:17.996
2025-04-22 23:59:18.009051 :8D6D82EB:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=1248 pso_num=31 pso_serial#=202
2025-04-22 23:59:18.009195 :8D6D82EC:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=1248 (legacy spawn)
2025-04-22 23:59:18.023156 :8D6D82ED:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name=   type=0
2025-04-22 23:59:51.191859 :8D6D8F65:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted
2025-04-22 23:59:51.198561 :8D6D8F68:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 04-22 23:59:51.188
2025-04-22 23:59:51.198567 :8D6D8F69:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=6428 pso_num=31 pso_serial#=203
2025-04-22 23:59:51.198762 :8D6D8F6A:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=6428 (legacy spawn)
2025-04-22 23:59:51.210468 :8D6D8F6B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name=   type=0
2025-04-22 23:59:51.210777 :8D6D8F70:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-04-22 23:59:51.212214 :8D6D8F75:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted
2025-04-22 23:59:54.851289 :8D6D90B6:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 04-22 23:59:54.839
2025-04-22 23:59:54.851291 :8D6D90B7:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=9960 pso_num=31 pso_serial#=204
2025-04-22 23:59:54.851432 :8D6D90B8:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=9960 (legacy spawn)
2025-04-22 23:59:54.865706 :8D6D90B9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name=   type=0
2025-04-23 00:00:28.026527 :8D6D9E4B:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted
2025-04-23 08:12:38.161097 :8D944E8E:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 04-23 08:12:38.167
2025-04-23 08:12:38.161099 :8D944E8F:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=10752 pso_num=31 pso_serial#=205
2025-04-23 08:12:38.161241 :8D944E90:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=10752 osp_idx=29 osp_ver=204 osp_pg=0 (spawn #109270)
2025-04-23 08:12:38.161242 :8D944E91:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A
2025-04-23 08:12:38.161242 :8D944E92:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=74 time=2666759953
2025-04-23 08:12:38.161242 :8D944E93:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs
2025-04-23 08:12:38.161243 :8D944E94:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs
2025-04-23 08:12:38.161243 :8D944E95:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs
2025-04-23 08:12:38.161244 :8D944E96:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs
2025-04-23 08:12:38.161244 :8D944E97:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs
2025-04-23 08:12:38.161763 :8D944E98:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name=   type=0
2025-04-23 08:12:38.161802 :8D944E9F:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-04-23 08:12:38.167948 :8D944EAB:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted
2025-04-23 22:00:02.067962 :8DD4AACF:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 04-23 22:00:02.065
2025-04-23 22:00:02.067963 :8DD4AAD0:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=11024 pso_num=31 pso_serial#=206
2025-04-23 22:00:02.068087 :8DD4AAD1:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=11024 osp_idx=29 osp_ver=205 osp_pg=0 (spawn #111293)
2025-04-23 22:00:02.068088 :8DD4AAD2:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A
2025-04-23 22:00:02.068088 :8DD4AAD3:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=75 time=2716403843
2025-04-23 22:00:02.068089 :8DD4AAD4:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs
2025-04-23 22:00:02.068089 :8DD4AAD5:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs
2025-04-23 22:00:02.068089 :8DD4AAD6:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs
2025-04-23 22:00:02.068090 :8DD4AAD7:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs
2025-04-23 22:00:02.068090 :8DD4AAD8:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs
2025-04-23 22:00:02.068602 :8DD4AAD9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name=   type=0
2025-04-23 22:00:32.160645 :8DD4BE2D:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted
2025-04-23 23:59:18.217211 :8DDE0C0B:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 04-23 23:59:18.212
2025-04-23 23:59:18.217213 :8DDE0C0C:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=8700 pso_num=31 pso_serial#=207
2025-04-23 23:59:18.217350 :8DDE0C0D:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=8700 (legacy spawn)
2025-04-23 23:59:18.232137 :8DDE0C0E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name=   type=0
2025-04-23 23:59:51.266346 :8DDE185D:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted
2025-04-23 23:59:55.115843 :8DDE1969:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 04-23 23:59:55.102
2025-04-23 23:59:55.115845 :8DDE196A:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=9024 pso_num=31 pso_serial#=208
2025-04-23 23:59:55.115979 :8DDE196B:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=9024 (legacy spawn)
2025-04-23 23:59:55.130131 :8DDE196C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name=   type=0
2025-04-24 00:00:28.157971 :8DDE2448:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted
2025-04-24 22:00:02.072767 :8E481C2D:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 04-24 22:00:02.065
2025-04-24 22:00:02.072768 :8E481C2E:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=9668 pso_num=31 pso_serial#=209
2025-04-24 22:00:02.072889 :8E481C2F:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=9668 osp_idx=29 osp_ver=208 osp_pg=0 (spawn #114814)
2025-04-24 22:00:02.072890 :8E481C30:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A
2025-04-24 22:00:02.072891 :8E481C31:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=76 time=2802803859
2025-04-24 22:00:02.072891 :8E481C32:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs
2025-04-24 22:00:02.072891 :8E481C33:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs
2025-04-24 22:00:02.072892 :8E481C34:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs
2025-04-24 22:00:02.072892 :8E481C35:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs
2025-04-24 22:00:02.072892 :8E481C36:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs
2025-04-24 22:00:02.073432 :8E481C37:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name=   type=0
2025-04-24 22:00:32.135048 :8E482F74:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted
2025-04-24 23:59:05.972049 :8E5280C9:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 04-24 23:59:05.964
2025-04-24 23:59:05.972051 :8E5280CA:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=7696 pso_num=31 pso_serial#=210
2025-04-24 23:59:05.972186 :8E5280CB:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=7696 (legacy spawn)
2025-04-24 23:59:05.978899 :8E5280CC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name=   type=0
2025-04-24 23:59:05.979066 :8E5280D4:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-04-24 23:59:05.979879 :8E5280D6:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted
2025-04-24 23:59:06.586686 :8E5280E5:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 04-24 23:59:06.573
2025-04-24 23:59:06.586688 :8E5280E6:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=6532 pso_num=31 pso_serial#=211
2025-04-24 23:59:06.586824 :8E5280E7:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=6532 (legacy spawn)
2025-04-24 23:59:06.593271 :8E5280E8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name=   type=0
2025-04-24 23:59:06.593446 :8E5280ED:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-04-24 23:59:06.594216 :8E5280F2:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted
2025-04-24 23:59:06.602861 :8E5280F5:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 04-24 23:59:06.589
2025-04-24 23:59:06.602863 :8E5280F6:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=11212 pso_num=31 pso_serial#=212
2025-04-24 23:59:06.602997 :8E5280F7:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=11212 (legacy spawn)
2025-04-24 23:59:06.609492 :8E5280F8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name=   type=0
2025-04-24 23:59:06.609664 :8E528101:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-04-24 23:59:06.610441 :8E528102:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted
2025-04-24 23:59:09.371495 :8E52820D:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 04-24 23:59:09.363
2025-04-24 23:59:09.371497 :8E52820E:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=2896 pso_num=31 pso_serial#=213
2025-04-24 23:59:09.371640 :8E52820F:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=2896 (legacy spawn)
2025-04-24 23:59:09.378463 :8E528210:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name=   type=0
2025-04-24 23:59:09.378630 :8E528219:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-04-24 23:59:09.756295 :8E528228:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted
2025-04-24 23:59:10.078749 :8E528237:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 04-24 23:59:10.066
2025-04-24 23:59:10.078752 :8E528238:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=9012 pso_num=31 pso_serial#=214
2025-04-24 23:59:10.078933 :8E528239:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=9012 (legacy spawn)
2025-04-24 23:59:10.092945 :8E52823A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name=   type=0
2025-04-24 23:59:43.218823 :8E528E57:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted
2025-04-24 23:59:46.894623 :8E528F6E:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 04-24 23:59:46.894
2025-04-24 23:59:46.894626 :8E528F6F:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=9012 pso_num=31 pso_serial#=215
2025-04-24 23:59:46.894820 :8E528F70:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=9012 (legacy spawn)
2025-04-24 23:59:46.908645 :8E528F71:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name=   type=0
2025-04-25 00:00:20.049118 :8E529BDD:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted
2025-04-25 22:00:02.057869 :8EBBE53D:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 04-25 22:00:02.050
2025-04-25 22:00:02.057870 :8EBBE53E:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=11084 pso_num=31 pso_serial#=216
2025-04-25 22:00:02.057994 :8EBBE53F:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=11084 osp_idx=29 osp_ver=215 osp_pg=0 (spawn #118197)
2025-04-25 22:00:02.057994 :8EBBE540:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A
2025-04-25 22:00:02.057994 :8EBBE541:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=77 time=2889203843
2025-04-25 22:00:02.057995 :8EBBE542:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs
2025-04-25 22:00:02.057995 :8EBBE543:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs
2025-04-25 22:00:02.057996 :8EBBE544:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs
2025-04-25 22:00:02.057996 :8EBBE545:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs
2025-04-25 22:00:02.057996 :8EBBE546:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs
2025-04-25 22:00:02.058528 :8EBBE547:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name=   type=0
2025-04-25 22:00:32.155748 :8EBBF778:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted
2025-04-25 22:14:10.117067 :8EBD5647:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 04-25 22:14:10.123
2025-04-25 22:14:10.117069 :8EBD5648:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=2676 pso_num=31 pso_serial#=217
2025-04-25 22:14:10.117200 :8EBD5649:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=2676 osp_idx=29 osp_ver=216 osp_pg=0 (spawn #118242)
2025-04-25 22:14:10.117201 :8EBD564A:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A
2025-04-25 22:14:10.117201 :8EBD564B:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=78 time=2890051906
2025-04-25 22:14:10.117202 :8EBD564C:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs
2025-04-25 22:14:10.117202 :8EBD564D:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs
2025-04-25 22:14:10.117202 :8EBD564E:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs
2025-04-25 22:14:10.117203 :8EBD564F:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs
2025-04-25 22:14:10.117204 :8EBD5650:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs
2025-04-25 22:14:10.117797 :8EBD5651:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name=   type=0
2025-04-25 22:14:10.117838 :8EBD5658:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-04-25 22:14:10.125566 :8EBD566A:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted
2025-04-25 23:59:09.993251 :8EC5DBFF:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 04-25 23:59:09.984
2025-04-25 23:59:09.993254 :8EC5DC00:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=9484 pso_num=31 pso_serial#=218
2025-04-25 23:59:09.993385 :8EC5DC01:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=9484 (legacy spawn)
2025-04-25 23:59:10.007279 :8EC5DC02:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name=   type=0
2025-04-25 23:59:13.250433 :8EC5DD0F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name=   type=0
2025-04-25 23:59:13.250464 :8EC5DD12:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name=   type=0
2025-04-25 23:59:13.250610 :8EC5DD15:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-04-25 23:59:13.251846 :8EC5DD26:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted
2025-04-25 23:59:13.507968 :8EC5DD7A:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 04-25 23:59:13.501
2025-04-25 23:59:13.507971 :8EC5DD7B:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=11244 pso_num=31 pso_serial#=219
2025-04-25 23:59:13.508105 :8EC5DD7C:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=11244 (legacy spawn)
2025-04-25 23:59:13.522345 :8EC5DD7D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name=   type=0
2025-04-25 23:59:46.554433 :8EC5E965:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted
2025-04-25 23:59:46.623694 :8EC5E968:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 04-25 23:59:46.614
2025-04-25 23:59:46.623697 :8EC5E969:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=10972 pso_num=31 pso_serial#=220
2025-04-25 23:59:46.623836 :8EC5E96A:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=10972 (legacy spawn)
2025-04-25 23:59:46.630779 :8EC5E96B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name=   type=0
2025-04-25 23:59:46.630961 :8EC5E974:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-04-25 23:59:46.631987 :8EC5E975:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted
2025-04-25 23:59:46.818544 :8EC5E978:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 04-25 23:59:46.817
2025-04-25 23:59:46.818546 :8EC5E979:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=11040 pso_num=31 pso_serial#=221
2025-04-25 23:59:46.818692 :8EC5E97A:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=11040 (legacy spawn)
2025-04-25 23:59:46.832709 :8EC5E97B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name=   type=0
2025-04-25 23:59:50.062568 :8EC5EA90:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name=   type=0
2025-04-25 23:59:50.062750 :8EC5EA95:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-04-25 23:59:50.063967 :8EC5EA9A:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted
2025-04-25 23:59:50.312969 :8EC5EAB0:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 04-25 23:59:50.306
2025-04-25 23:59:50.312971 :8EC5EAB1:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=1120 pso_num=31 pso_serial#=222
2025-04-25 23:59:50.313107 :8EC5EAB2:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=1120 (legacy spawn)
2025-04-25 23:59:50.327417 :8EC5EAB3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name=   type=0
2025-04-26 00:00:23.365520 :8EC5F697:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted
2025-04-26 06:00:00.244401 :8EE280C4:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 04-26 06:00:00.236
2025-04-26 06:00:00.244402 :8EE280C5:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=10360 pso_num=31 pso_serial#=223
2025-04-26 06:00:00.244541 :8EE280D1:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=10360 osp_idx=29 osp_ver=222 osp_pg=0 (spawn #119338)
2025-04-26 06:00:00.244542 :8EE280D2:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A
2025-04-26 06:00:00.244542 :8EE280D3:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=79 time=2918002031
2025-04-26 06:00:00.244543 :8EE280D4:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs
2025-04-26 06:00:00.244543 :8EE280D5:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs
2025-04-26 06:00:00.244544 :8EE280D6:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs
2025-04-26 06:00:00.244544 :8EE280D7:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs
2025-04-26 06:00:00.244545 :8EE280D8:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs
2025-04-26 06:00:00.245251 :8EE280E1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name=   type=0
-------------------------------------------------------------------------------
Trace Bucket Dump End: default bucket for process 31 (osid: 10360, J005)