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


*** 2025-08-01 22:00:04.810
*** SESSION ID:(249.1555) 2025-08-01 22:00:04.810
 

*** 2025-08-01 22:00:04.810
Process diagnostic dump for ORACLE.EXE (J005), OS id=19460,
pid: 31, proc_ser: 248, sid: 249, sess_ser: 1555 
-------------------------------------------------------------------------------
current sql: <none>
client details:
  O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 19460
  machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J005)
Current Wait Stack:
 0: waiting for 'jobq slave wait'
    =0x0, =0x0, =0x0
    wait_id=8 seq_num=9 snap_id=1
    wait times: snap=0.472207 sec, exc=0.472207 sec, total=0.472207 sec
    wait times: max=0.500000 sec, heur=4.471206 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.000010 sec since current wait
 0: waited for 'jobq slave wait'
    =0x0, =0x0, =0x0
    wait_id=7 seq_num=8 snap_id=1
    wait times: snap=0.499997 sec, exc=0.499997 sec, total=0.499997 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=6 seq_num=7 snap_id=1
    wait times: snap=0.499999 sec, exc=0.499999 sec, total=0.499999 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=5 seq_num=6 snap_id=1
    wait times: snap=0.510111 sec, exc=0.510111 sec, total=0.510111 sec
    wait times: max=0.500000 sec
    wait counts: calls=1 os=1
    occurred after 0.000007 sec of elapsed time
 3: waited for 'jobq slave wait'
    =0x0, =0x0, =0x0
    wait_id=4 seq_num=5 snap_id=1
    wait times: snap=0.499987 sec, exc=0.499987 sec, total=0.499987 sec
    wait times: max=0.500000 sec
    wait counts: calls=1 os=1
    occurred after 0.000009 sec of elapsed time
 4: waited for 'jobq slave wait'
    =0x0, =0x0, =0x0
    wait_id=3 seq_num=4 snap_id=1
    wait times: snap=0.500003 sec, exc=0.500003 sec, total=0.500003 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=2 seq_num=3 snap_id=1
    wait times: snap=0.500003 sec, exc=0.500003 sec, total=0.500003 sec
    wait times: max=0.500000 sec
    wait counts: calls=1 os=1
    occurred after 0.000007 sec of elapsed time
 6: waited for 'jobq slave wait'
    =0x0, =0x0, =0x0
    wait_id=1 seq_num=2 snap_id=1
    wait times: snap=0.499996 sec, exc=0.499996 sec, total=0.499996 sec
    wait times: max=0.500000 sec
    wait counts: calls=1 os=1
    occurred after 0.000008 sec of elapsed time
 7: waited for 'jobq slave wait'
    =0x0, =0x0, =0x0
    wait_id=0 seq_num=1 snap_id=1
    wait times: snap=0.488832 sec, exc=0.488832 sec, total=0.488832 sec
    wait times: max=0.500000 sec
    wait counts: calls=1 os=1
    occurred after 0.000000 sec of elapsed time
Sampled Session History of session 249 serial 1555
---------------------------------------------------
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
---------------------------------------------------
  [5 samples,                                              22:00:00 - 22:00:04]
    idle wait at each sample
  [session created at: 22:00:00]
-------------------------------------------------------------------------------
Process diagnostic dump actual duration=0.000000 sec
  (max dump time=30.000000 sec)

*** 2025-08-01 22:00:04.810
 
-------------------------------------------------------------------------------
Trace Bucket Dump Begin: default bucket for process 31 (osid: 19460, J005)
TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA
-------------------------------------------------------------------------------
2025-07-26 06:00:00.325611 :B718D051:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs
2025-07-26 06:00:00.325611 :B718D052:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs
2025-07-26 06:00:00.325611 :B718D053:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs
2025-07-26 06:00:00.326179 :B718D065: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-07-26 06:00:30.394334 :B718E1AF:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted
2025-07-26 23:59:07.559632 :B76D423B:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 07-26 23:59:07.550
2025-07-26 23:59:07.559634 :B76D423C:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=17856 pso_num=31 pso_serial#=223
2025-07-26 23:59:07.559775 :B76D423D:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=17856 (legacy spawn)
2025-07-26 23:59:07.566582 :B76D423E: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-07-26 23:59:07.566746 :B76D4243: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-07-26 23:59:07.567621 :B76D4248:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted
2025-07-26 23:59:10.200911 :B76D433A:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 07-26 23:59:10.200
2025-07-26 23:59:10.200913 :B76D433B:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=16332 pso_num=31 pso_serial#=224
2025-07-26 23:59:10.201054 :B76D433C:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=16332 (legacy spawn)
2025-07-26 23:59:10.215876 :B76D433D: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-07-26 23:59:43.486308 :B76D4EDD:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted
2025-07-26 23:59:44.717783 :B76D4F53:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 07-26 23:59:44.703
2025-07-26 23:59:44.717784 :B76D4F54:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=18832 pso_num=31 pso_serial#=225
2025-07-26 23:59:44.717966 :B76D4F55:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=18832 (legacy spawn)
2025-07-26 23:59:44.731916 :B76D4F56: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-07-27 00:00:17.771763 :B76D5B56:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted
2025-07-27 06:00:02.076547 :B789567F:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 07-27 06:00:02.074
2025-07-27 06:00:02.076548 :B7895680:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=18048 pso_num=31 pso_serial#=226
2025-07-27 06:00:02.076679 :B7895690:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=18048 osp_idx=29 osp_ver=735 osp_pg=0 (spawn #426938)
2025-07-27 06:00:02.076680 :B7895691:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A
2025-07-27 06:00:02.076680 :B7895692:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=224 time=2276777954
2025-07-27 06:00:02.076680 :B7895693:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs
2025-07-27 06:00:02.076681 :B7895694:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs
2025-07-27 06:00:02.076681 :B7895695:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs
2025-07-27 06:00:02.076682 :B7895696:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs
2025-07-27 06:00:02.076682 :B7895697:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs
2025-07-27 06:00:02.077285 :B789569A: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-07-27 06:00:32.162556 :B789692A:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted
2025-07-27 23:59:10.225383 :B7DF2B43:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 07-27 23:59:10.220
2025-07-27 23:59:10.225385 :B7DF2B44:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=18600 pso_num=31 pso_serial#=227
2025-07-27 23:59:10.225524 :B7DF2B45:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=18600 (legacy spawn)
2025-07-27 23:59:10.240466 :B7DF2B46: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-07-27 23:59:43.390000 :B7DF3709:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted
2025-07-27 23:59:43.937096 :B7DF3718:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 07-27 23:59:43.934
2025-07-27 23:59:43.937098 :B7DF3719:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=19072 pso_num=31 pso_serial#=228
2025-07-27 23:59:43.937245 :B7DF371A:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=19072 (legacy spawn)
2025-07-27 23:59:43.951518 :B7DF371B: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-07-28 00:00:16.978314 :B7DF42CB:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted
2025-07-28 22:00:02.056647 :B846574E:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 07-28 22:00:02.047
2025-07-28 22:00:02.056649 :B846574F:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=19168 pso_num=31 pso_serial#=229
2025-07-28 22:00:02.056788 :B846575A:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=19168 osp_idx=29 osp_ver=738 osp_pg=0 (spawn #432494)
2025-07-28 22:00:02.056789 :B846575B:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A
2025-07-28 22:00:02.056790 :B846575C:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=225 time=2420777954
2025-07-28 22:00:02.056790 :B846575D:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs
2025-07-28 22:00:02.056791 :B846575E:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs
2025-07-28 22:00:02.056791 :B846575F:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs
2025-07-28 22:00:02.056791 :B8465760:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs
2025-07-28 22:00:02.056792 :B8465761:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs
2025-07-28 22:00:02.057366 :B846576D: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-07-28 22:00:32.128154 :B8466B79:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted
2025-07-28 23:59:09.842083 :B84FCA83:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 07-28 23:59:09.837
2025-07-28 23:59:09.842085 :B84FCA84:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=18888 pso_num=31 pso_serial#=230
2025-07-28 23:59:09.842221 :B84FCA85:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=18888 (legacy spawn)
2025-07-28 23:59:09.856601 :B84FCA86: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-07-28 23:59:42.990867 :B84FD695:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted
2025-07-28 23:59:46.854487 :B84FD7CC:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 07-28 23:59:46.842
2025-07-28 23:59:46.854489 :B84FD7CD:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=7616 pso_num=31 pso_serial#=231
2025-07-28 23:59:46.854632 :B84FD7CE:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=7616 (legacy spawn)
2025-07-28 23:59:46.868943 :B84FD7CF: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-07-29 00:00:20.039574 :B84FE3FA:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted
2025-07-29 22:00:02.060028 :B8B6A2D1:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 07-29 22:00:02.051
2025-07-29 22:00:02.060029 :B8B6A2D2:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=18856 pso_num=31 pso_serial#=232
2025-07-29 22:00:02.060188 :B8B6A2D3:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=18856 osp_idx=29 osp_ver=741 osp_pg=0 (spawn #435827)
2025-07-29 22:00:02.060189 :B8B6A2D4:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A
2025-07-29 22:00:02.060190 :B8B6A2D5:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=226 time=2507177954
2025-07-29 22:00:02.060191 :B8B6A2D6:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs
2025-07-29 22:00:02.060191 :B8B6A2D7:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs
2025-07-29 22:00:02.060192 :B8B6A2D8:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs
2025-07-29 22:00:02.060193 :B8B6A2D9:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs
2025-07-29 22:00:02.060193 :B8B6A2DA:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs
2025-07-29 22:00:02.060779 :B8B6A2DB: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-07-29 22:00:32.157504 :B8B6B608:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted
2025-07-29 23:59:09.963012 :B8C00AA4:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 07-29 23:59:09.953
2025-07-29 23:59:09.963014 :B8C00AA5:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=2848 pso_num=31 pso_serial#=233
2025-07-29 23:59:09.963152 :B8C00AA6:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=2848 (legacy spawn)
2025-07-29 23:59:09.976921 :B8C00AA7: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-07-29 23:59:43.259326 :B8C0166F:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted
2025-07-29 23:59:47.831928 :B8C017C5:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 07-29 23:59:47.825
2025-07-29 23:59:47.831930 :B8C017C6:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=10620 pso_num=31 pso_serial#=234
2025-07-29 23:59:47.832065 :B8C017C7:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=10620 (legacy spawn)
2025-07-29 23:59:47.846468 :B8C017C8: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-07-30 00:00:21.389602 :B8C02637:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted
2025-07-30 22:00:00.319689 :B92A6D39:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 07-30 22:00:00.311
2025-07-30 22:00:00.319691 :B92A6D3A:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=11176 pso_num=31 pso_serial#=235
2025-07-30 22:00:00.319826 :B92A6D3B:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=11176 osp_idx=29 osp_ver=744 osp_pg=0 (spawn #439162)
2025-07-30 22:00:00.319827 :B92A6D3C:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A
2025-07-30 22:00:00.319827 :B92A6D3D:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=227 time=2593576204
2025-07-30 22:00:00.319828 :B92A6D3E:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs
2025-07-30 22:00:00.319828 :B92A6D3F:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs
2025-07-30 22:00:00.319829 :B92A6D40:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs
2025-07-30 22:00:00.319829 :B92A6D41:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs
2025-07-30 22:00:00.319830 :B92A6D42:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs
2025-07-30 22:00:00.320449 :B92A6D46: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-07-30 22:00:30.402401 :B92A7EAD:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted
2025-07-30 23:59:07.514085 :B933E397:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 07-30 23:59:07.507
2025-07-30 23:59:07.514088 :B933E398:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=20112 pso_num=31 pso_serial#=236
2025-07-30 23:59:07.514231 :B933E399:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=20112 (legacy spawn)
2025-07-30 23:59:07.520725 :B933E39A: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-07-30 23:59:07.520915 :B933E3A0: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-07-30 23:59:07.521761 :B933E3A4:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted
2025-07-30 23:59:07.530663 :B933E3A7:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 07-30 23:59:07.522
2025-07-30 23:59:07.530665 :B933E3A8:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=5020 pso_num=31 pso_serial#=237
2025-07-30 23:59:07.530806 :B933E3A9:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=5020 (legacy spawn)
2025-07-30 23:59:07.537376 :B933E3AA: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-07-30 23:59:07.537563 :B933E3B2: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-07-30 23:59:07.538405 :B933E3B4:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted
2025-07-30 23:59:09.754098 :B933E47B:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 07-30 23:59:09.741
2025-07-30 23:59:09.754100 :B933E47C:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=20016 pso_num=31 pso_serial#=238
2025-07-30 23:59:09.754242 :B933E47D:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=20016 (legacy spawn)
2025-07-30 23:59:09.768410 :B933E48A: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-07-30 23:59:43.026582 :B933F04B:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted
2025-07-30 23:59:44.087831 :B933F0B1:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 07-30 23:59:44.075
2025-07-30 23:59:44.087833 :B933F0B2:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=19488 pso_num=31 pso_serial#=239
2025-07-30 23:59:44.087980 :B933F0B3:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=19488 (legacy spawn)
2025-07-30 23:59:44.094606 :B933F0B4: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-07-30 23:59:44.094783 :B933F0BD: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-07-30 23:59:44.095575 :B933F0BE:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted
2025-07-30 23:59:44.104314 :B933F0C1:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 07-30 23:59:44.090
2025-07-30 23:59:44.104316 :B933F0C2:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=17500 pso_num=31 pso_serial#=240
2025-07-30 23:59:44.104452 :B933F0C3:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=17500 (legacy spawn)
2025-07-30 23:59:44.111045 :B933F0C4: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-07-30 23:59:44.111207 :B933F0CD: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-07-30 23:59:44.112025 :B933F0CE:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted
2025-07-30 23:59:46.012360 :B933F173:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 07-30 23:59:45.998
2025-07-30 23:59:46.012362 :B933F174:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=680 pso_num=31 pso_serial#=241
2025-07-30 23:59:46.012488 :B933F175:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=680 (legacy spawn)
2025-07-30 23:59:46.019542 :B933F176: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-07-30 23:59:46.019723 :B933F17E: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-07-30 23:59:46.020601 :B933F180:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted
2025-07-30 23:59:46.552803 :B933F1BD:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 07-30 23:59:46.547
2025-07-30 23:59:46.552805 :B933F1BE:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=10372 pso_num=31 pso_serial#=242
2025-07-30 23:59:46.552946 :B933F1BF:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=10372 (legacy spawn)
2025-07-30 23:59:46.567876 :B933F1C0: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-07-31 00:00:19.874207 :B933FE54:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted
2025-07-31 22:00:02.069475 :B99C70B5:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 07-31 22:00:02.061
2025-07-31 22:00:02.069476 :B99C70B6:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=18892 pso_num=31 pso_serial#=243
2025-07-31 22:00:02.069608 :B99C70B7:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=18892 osp_idx=29 osp_ver=752 osp_pg=0 (spawn #442486)
2025-07-31 22:00:02.069609 :B99C70B8:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A
2025-07-31 22:00:02.069609 :B99C70B9:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=228 time=2679977954
2025-07-31 22:00:02.069609 :B99C70BA:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs
2025-07-31 22:00:02.069610 :B99C70BB:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs
2025-07-31 22:00:02.069610 :B99C70BC:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs
2025-07-31 22:00:02.069611 :B99C70BD:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs
2025-07-31 22:00:02.069611 :B99C70BE:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs
2025-07-31 22:00:02.070131 :B99C70BF: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-07-31 22:00:32.103026 :B99C8394:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted
2025-07-31 23:59:09.721664 :B9A5D99A:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 07-31 23:59:09.719
2025-07-31 23:59:09.721667 :B9A5D99B:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=18616 pso_num=31 pso_serial#=244
2025-07-31 23:59:09.721858 :B9A5D99C:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=18616 (legacy spawn)
2025-07-31 23:59:09.736049 :B9A5D99D: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-07-31 23:59:13.008971 :B9A5DA8C: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-07-31 23:59:13.009167 :B9A5DA95: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-07-31 23:59:13.010431 :B9A5DA96:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted
2025-07-31 23:59:13.260618 :B9A5DA99:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 07-31 23:59:13.246
2025-07-31 23:59:13.260620 :B9A5DA9A:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=19760 pso_num=31 pso_serial#=245
2025-07-31 23:59:13.260759 :B9A5DA9B:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=19760 (legacy spawn)
2025-07-31 23:59:13.274893 :B9A5DA9C: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-07-31 23:59:46.442162 :B9A5E6C4:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted
2025-07-31 23:59:46.587513 :B9A5E6D3:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 07-31 23:59:46.581
2025-07-31 23:59:46.587515 :B9A5E6D4:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=19692 pso_num=31 pso_serial#=246
2025-07-31 23:59:46.587647 :B9A5E6D5:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=19692 (legacy spawn)
2025-07-31 23:59:46.602258 :B9A5E6D6: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-07-31 23:59:49.866042 :B9A5E7D8: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-07-31 23:59:49.866220 :B9A5E7DD: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-07-31 23:59:49.867366 :B9A5E7E2:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted
2025-07-31 23:59:50.117781 :B9A5E7F9:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 07-31 23:59:50.103
2025-07-31 23:59:50.117783 :B9A5E7FA:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=20292 pso_num=31 pso_serial#=247
2025-07-31 23:59:50.117921 :B9A5E7FB:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=20292 (legacy spawn)
2025-07-31 23:59:50.132516 :B9A5E7FC: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-08-01 00:00:23.295153 :B9A5F7F7:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted
2025-08-01 22:00:00.341597 :BA0E3A66:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 08-01 22:00:00.331
2025-08-01 22:00:00.341598 :BA0E3A67:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=19460 pso_num=31 pso_serial#=248
2025-08-01 22:00:00.341725 :BA0E3A68:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=19460 osp_idx=29 osp_ver=757 osp_pg=0 (spawn #445805)
2025-08-01 22:00:00.341726 :BA0E3A69:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A
2025-08-01 22:00:00.341727 :BA0E3A6A:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=229 time=2766269642
2025-08-01 22:00:00.341727 :BA0E3A6B:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs
2025-08-01 22:00:00.341728 :BA0E3A6C:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs
2025-08-01 22:00:00.341728 :BA0E3A6D:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs
2025-08-01 22:00:00.341728 :BA0E3A6E:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs
2025-08-01 22:00:00.341729 :BA0E3A6F:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs
2025-08-01 22:00:00.342465 :BA0E3A70: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: 19460, J005)