Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250812220009\orcl_j005_11712_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:35538M/63366M, Ph+PgF:40944M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 31 Windows thread id: 11712, image: ORACLE.EXE (J005) *** 2025-08-12 22:00:09.821 *** SESSION ID:(249.1673) 2025-08-12 22:00:09.821 *** 2025-08-12 22:00:09.821 Process diagnostic dump for ORACLE.EXE (J005), OS id=11712, pid: 31, proc_ser: 50, sid: 249, sess_ser: 1673 ------------------------------------------------------------------------------- current sql: client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 11712 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J005) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=15 seq_num=16 snap_id=1 wait times: snap=0.221023 sec, exc=0.221023 sec, total=0.221023 sec wait times: max=0.500000 sec, heur=7.752346 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=14 seq_num=15 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.000009 sec of elapsed time 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=13 seq_num=14 snap_id=1 wait times: snap=0.510103 sec, exc=0.510103 sec, total=0.510103 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 sec of elapsed time 2: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=12 seq_num=13 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.000011 sec of elapsed time 3: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=11 seq_num=12 snap_id=1 wait times: snap=0.510114 sec, exc=0.510114 sec, total=0.510114 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=10 seq_num=11 snap_id=1 wait times: snap=0.499998 sec, exc=0.499998 sec, total=0.499998 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000010 sec of elapsed time 5: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=9 seq_num=10 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.000008 sec of elapsed time 6: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=8 seq_num=9 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.000012 sec of elapsed time 7: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=7 seq_num=8 snap_id=1 wait times: snap=0.510103 sec, exc=0.510103 sec, total=0.510103 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000011 sec of elapsed time 8: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=6 seq_num=7 snap_id=1 wait times: snap=0.500000 sec, exc=0.500000 sec, total=0.500000 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 9: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=5 seq_num=6 snap_id=1 wait times: snap=0.500000 sec, exc=0.500000 sec, total=0.500000 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time Sampled Session History of session 249 serial 1673 --------------------------------------------------- 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, 22:00:02 - 22:00:09] idle wait at each sample [session created at: 22:00:02] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-08-12 22:00:09.821 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 31 (osid: 11712, J005) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-08-08 00:00:43.171257 :BCC2B629:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-08-08 22:00:02.058748 :BD299AAC:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 08-08 22:00:02.056 2025-08-08 22:00:02.058750 :BD299AAD:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=12612 pso_num=31 pso_serial#=28 2025-08-08 22:00:02.058888 :BD299AAE:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=12612 osp_idx=29 osp_ver=792 osp_pg=0 (spawn #469150) 2025-08-08 22:00:02.058888 :BD299AAF: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-08 22:00:02.058889 :BD299AB0:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=238 time=3371071345 2025-08-08 22:00:02.058890 :BD299AB1:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-08-08 22:00:02.058890 :BD299AB2:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-08-08 22:00:02.058890 :BD299AB3:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-08-08 22:00:02.058891 :BD299AB4:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-08 22:00:02.058891 :BD299AB5:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-08 22:00:02.059414 :BD299AC7: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-08-08 22:00:32.103837 :BD29AF09:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-08-08 23:59:14.743405 :BD32C9AE:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 08-08 23:59:14.736 2025-08-08 23:59:14.743407 :BD32C9AF:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=19936 pso_num=31 pso_serial#=29 2025-08-08 23:59:14.743567 :BD32C9B0:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=19936 osp_idx=29 osp_ver=793 osp_pg=0 (spawn #469423) 2025-08-08 23:59:14.743568 :BD32C9B1: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-08 23:59:14.743569 :BD32C9B2:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=239 time=3378224048 2025-08-08 23:59:14.743569 :BD32C9B3:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-08-08 23:59:14.743570 :BD32C9B4:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-08-08 23:59:14.743570 :BD32C9B5:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-08-08 23:59:14.743570 :BD32C9B6:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-08 23:59:14.743571 :BD32C9B7:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-08 23:59:14.744099 :BD32C9B8: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-08-08 23:59:14.744859 :BD32C9CD: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-08 23:59:14.752729 :BD32C9E9:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:31:249] atxpus:psdpgi.c:2235 2025-08-08 23:59:14.753115 :BD32C9EA: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-08 23:59:14.753149 :BD32C9ED:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:31:249] atxpop:psdpgi.c:2235 2025-08-08 23:59:14.753989 :BD32C9F3: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-08 23:59:14.754080 :BD32C9FC: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-08-08 23:59:44.844567 :BD32D4A1:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-08-08 23:59:49.678548 :BD32D60F:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 08-08 23:59:49.669 2025-08-08 23:59:49.678550 :BD32D610:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=20888 pso_num=31 pso_serial#=30 2025-08-08 23:59:49.678731 :BD32D611:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=20888 (legacy spawn) 2025-08-08 23:59:49.686127 :BD32D612: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-08 23:59:49.686324 :BD32D617: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-08-08 23:59:49.687200 :BD32D61C:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-08-08 23:59:56.048289 :BD32D878:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 08-08 23:59:56.047 2025-08-08 23:59:56.048291 :BD32D879:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=19676 pso_num=31 pso_serial#=31 2025-08-08 23:59:56.048431 :BD32D87A:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=19676 (legacy spawn) 2025-08-08 23:59:56.062468 :BD32D87B: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-09 00:00:29.367094 :BD32E688:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-08-09 06:00:00.734053 :BD4E670C:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 08-09 06:00:00.726 2025-08-09 06:00:00.734054 :BD4E670D:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=21072 pso_num=31 pso_serial#=32 2025-08-09 06:00:00.734216 :BD4E670E:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=21072 osp_idx=29 osp_ver=796 osp_pg=0 (spawn #470262) 2025-08-09 06:00:00.734217 :BD4E670F: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-09 06:00:00.734217 :BD4E6710:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=240 time=3399870033 2025-08-09 06:00:00.734218 :BD4E6711:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-08-09 06:00:00.734218 :BD4E6712:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-08-09 06:00:00.734218 :BD4E6713:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-08-09 06:00:00.734219 :BD4E6714:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-09 06:00:00.734219 :BD4E6715:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-09 06:00:00.734817 :BD4E671E: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-08-09 06:00:30.770887 :BD4E7797:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-08-09 23:59:15.058968 :BDA1EBFE:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 08-09 23:59:15.058 2025-08-09 23:59:15.058970 :BDA1EBFF:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=21468 pso_num=31 pso_serial#=33 2025-08-09 23:59:15.059125 :BDA1EC00:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=21468 (legacy spawn) 2025-08-09 23:59:15.066348 :BDA1EC01: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-09 23:59:15.066547 :BDA1EC0A: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-08-09 23:59:15.067362 :BDA1EC0B:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-08-09 23:59:15.083671 :BDA1EC0E:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 08-09 23:59:15.074 2025-08-09 23:59:15.083673 :BDA1EC0F:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=18760 pso_num=31 pso_serial#=34 2025-08-09 23:59:15.083833 :BDA1EC10:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=18760 (legacy spawn) 2025-08-09 23:59:15.090758 :BDA1EC11: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-09 23:59:15.090916 :BDA1EC1A: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-08-09 23:59:15.091744 :BDA1EC1B:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-08-09 23:59:17.740906 :BDA1ED18:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 08-09 23:59:17.732 2025-08-09 23:59:17.740909 :BDA1ED19:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=6572 pso_num=31 pso_serial#=35 2025-08-09 23:59:17.741060 :BDA1ED1A:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=6572 (legacy spawn) 2025-08-09 23:59:17.748146 :BDA1ED1B: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-09 23:59:17.748388 :BDA1ED21: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-08-09 23:59:17.749803 :BDA1ED25:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-08-09 23:59:17.923907 :BDA1ED28:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 08-09 23:59:17.923 2025-08-09 23:59:17.923909 :BDA1ED29:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=19612 pso_num=31 pso_serial#=36 2025-08-09 23:59:17.924068 :BDA1ED2A:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=19612 (legacy spawn) 2025-08-09 23:59:17.938766 :BDA1ED2B: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-09 23:59:21.168100 :BDA1EEA5: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-09 23:59:21.168274 :BDA1EEAE: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-08-09 23:59:21.169554 :BDA1EEAF:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-08-09 23:59:21.428073 :BDA1EF29:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 08-09 23:59:21.424 2025-08-09 23:59:21.428075 :BDA1EF2A:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=4428 pso_num=31 pso_serial#=37 2025-08-09 23:59:21.428246 :BDA1EF2B:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=4428 (legacy spawn) 2025-08-09 23:59:21.444692 :BDA1EF2C: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-09 23:59:54.580462 :BDA1FB16:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-08-09 23:59:54.731950 :BDA1FB3C:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 08-09 23:59:54.718 2025-08-09 23:59:54.731952 :BDA1FB3D:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=21144 pso_num=31 pso_serial#=38 2025-08-09 23:59:54.732087 :BDA1FB3E:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=21144 (legacy spawn) 2025-08-09 23:59:54.745838 :BDA1FB3F: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-09 23:59:57.985481 :BDA1FC6F: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-09 23:59:57.985650 :BDA1FC74: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-08-09 23:59:57.986894 :BDA1FC79:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-08-09 23:59:58.248175 :BDA1FC88:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 08-09 23:59:58.237 2025-08-09 23:59:58.248177 :BDA1FC89:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=20616 pso_num=31 pso_serial#=39 2025-08-09 23:59:58.248314 :BDA1FC8A:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=20616 (legacy spawn) 2025-08-09 23:59:58.262916 :BDA1FC8B: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-10 00:06:18.203586 :BDA2828D: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-10 00:06:18.203760 :BDA28296: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-08-10 00:06:18.204839 :BDA28297:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-08-10 06:00:02.070279 :BDBDB100:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 08-10 06:00:02.061 2025-08-10 06:00:02.070280 :BDBDB101:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=16948 pso_num=31 pso_serial#=40 2025-08-10 06:00:02.070418 :BDBDB102:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=16948 osp_idx=29 osp_ver=804 osp_pg=0 (spawn #473605) 2025-08-10 06:00:02.070419 :BDBDB103: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-10 06:00:02.070420 :BDBDB104:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=241 time=3486271376 2025-08-10 06:00:02.070420 :BDBDB105:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-08-10 06:00:02.070420 :BDBDB106:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-08-10 06:00:02.070421 :BDBDB107:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-08-10 06:00:02.070421 :BDBDB108:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-10 06:00:02.070422 :BDBDB109:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-10 06:00:02.071004 :BDBDB10A: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-08-10 06:00:32.134868 :BDBDC21C:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-08-10 23:59:17.826650 :BE113D84:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 08-10 23:59:17.817 2025-08-10 23:59:17.826652 :BE113D85:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=18024 pso_num=31 pso_serial#=41 2025-08-10 23:59:17.826792 :BE113D86:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=18024 (legacy spawn) 2025-08-10 23:59:17.834136 :BE113D87: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-10 23:59:17.834311 :BE113D90: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-08-10 23:59:17.835188 :BE113D91:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-08-10 23:59:17.870403 :BE113DA0:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 08-10 23:59:17.864 2025-08-10 23:59:17.870405 :BE113DA1:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=19060 pso_num=31 pso_serial#=42 2025-08-10 23:59:17.870546 :BE113DA2:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=19060 (legacy spawn) 2025-08-10 23:59:17.891726 :BE113DA3: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-10 23:59:21.341139 :BE113E8C: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-10 23:59:21.341328 :BE113E91: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-08-10 23:59:21.342605 :BE113E96:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-08-10 23:59:21.606556 :BE113E99:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 08-10 23:59:21.601 2025-08-10 23:59:21.606558 :BE113E9A:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=20916 pso_num=31 pso_serial#=43 2025-08-10 23:59:21.606721 :BE113E9B:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=20916 (legacy spawn) 2025-08-10 23:59:21.622296 :BE113E9C: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-10 23:59:55.520131 :BE114B1D:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-08-10 23:59:58.043716 :BE114BF7:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 08-10 23:59:58.038 2025-08-10 23:59:58.043719 :BE114BF8:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=4644 pso_num=31 pso_serial#=44 2025-08-10 23:59:58.043853 :BE114BF9:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=4644 (legacy spawn) 2025-08-10 23:59:58.057968 :BE114BFA: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-11 00:06:18.012764 :BE11D188: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-11 00:06:18.012933 :BE11D191: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-08-11 00:06:18.014003 :BE11D192:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-08-11 22:00:01.307307 :BE76F989:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 08-11 22:00:01.303 2025-08-11 22:00:01.307308 :BE76F98A:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=316 pso_num=31 pso_serial#=45 2025-08-11 22:00:01.307425 :BE76F98B:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=316 osp_idx=29 osp_ver=809 osp_pg=0 (spawn #479158) 2025-08-11 22:00:01.307427 :BE76F98C: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-11 22:00:01.307427 :BE76F98D:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=242 time=3630270595 2025-08-11 22:00:01.307428 :BE76F98E:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-08-11 22:00:01.307428 :BE76F98F:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-08-11 22:00:01.307429 :BE76F990:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-08-11 22:00:01.307429 :BE76F991:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-11 22:00:01.307429 :BE76F992:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-11 22:00:01.307973 :BE76F9A5: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-08-11 22:00:31.376039 :BE770C82:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-08-11 23:59:18.283078 :BE80DFA6:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 08-11 23:59:18.282 2025-08-11 23:59:18.283080 :BE80DFA7:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=20276 pso_num=31 pso_serial#=46 2025-08-11 23:59:18.283233 :BE80DFA8:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=20276 (legacy spawn) 2025-08-11 23:59:18.299445 :BE80DFA9: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-11 23:59:21.533146 :BE80E098: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-11 23:59:21.533330 :BE80E09D: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-08-11 23:59:21.534543 :BE80E0A2:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-08-11 23:59:21.794759 :BE80E0E6:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 08-11 23:59:21.786 2025-08-11 23:59:21.794762 :BE80E0E7:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=19980 pso_num=31 pso_serial#=47 2025-08-11 23:59:21.794939 :BE80E0E8:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=19980 (legacy spawn) 2025-08-11 23:59:21.811283 :BE80E10C: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-11 23:59:54.924243 :BE80ED32:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-08-11 23:59:55.053030 :BE80ED35:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 08-11 23:59:55.046 2025-08-11 23:59:55.053032 :BE80ED36:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=20448 pso_num=31 pso_serial#=48 2025-08-11 23:59:55.053211 :BE80ED37:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=20448 (legacy spawn) 2025-08-11 23:59:55.067295 :BE80ED38: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-11 23:59:58.316720 :BE80EE43: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-11 23:59:58.316889 :BE80EE4C: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-08-11 23:59:58.318122 :BE80EE4D:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-08-11 23:59:58.580581 :BE80EE5B:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 08-11 23:59:58.580 2025-08-11 23:59:58.580583 :BE80EE5C:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=20068 pso_num=31 pso_serial#=49 2025-08-11 23:59:58.580732 :BE80EE5D:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=20068 (legacy spawn) 2025-08-11 23:59:58.595588 :BE80EE5E: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-12 00:06:18.520780 :BE8176F7: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-12 00:06:18.520952 :BE817700: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-08-12 00:06:18.522174 :BE817701:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-08-12 22:00:02.069754 :BEE7981D:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 08-12 22:00:02.066 2025-08-12 22:00:02.069755 :BEE7981E:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=11712 pso_num=31 pso_serial#=50 2025-08-12 22:00:02.069889 :BEE7982C:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=11712 osp_idx=29 osp_ver=814 osp_pg=0 (spawn #482488) 2025-08-12 22:00:02.069890 :BEE7982D: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-12 22:00:02.069891 :BEE7982E:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=243 time=3716671361 2025-08-12 22:00:02.069891 :BEE7982F:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-08-12 22:00:02.069891 :BEE79830:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-08-12 22:00:02.069892 :BEE79831:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-08-12 22:00:02.069892 :BEE79832:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-12 22:00:02.069892 :BEE79833:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-12 22:00:02.070421 :BEE79838: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: 11712, J005)