Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250907060004\orcl_j004_24404_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:34970M/63366M, Ph+PgF:39783M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 30 Windows thread id: 24404, image: ORACLE.EXE (J004) *** 2025-09-07 06:00:05.102 *** SESSION ID:(241.4553) 2025-09-07 06:00:05.102 *** 2025-09-07 06:00:05.102 Process diagnostic dump for ORACLE.EXE (J004), OS id=24404, pid: 30, proc_ser: 79, sid: 241, sess_ser: 4553 ------------------------------------------------------------------------------- current sql: client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 24404 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J004) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=5 seq_num=6 snap_id=1 wait times: snap=0.061463 sec, exc=0.061463 sec, total=0.061463 sec wait times: max=0.500000 sec, heur=2.557047 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=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.000012 sec of elapsed time 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=3 seq_num=4 snap_id=1 wait times: snap=0.499992 sec, exc=0.499992 sec, total=0.499992 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000011 sec of elapsed time 2: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=2 seq_num=3 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.000008 sec of elapsed time 3: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=1 seq_num=2 snap_id=1 wait times: snap=0.499974 sec, exc=0.499974 sec, total=0.499974 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000018 sec of elapsed time 4: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=0 seq_num=1 snap_id=1 wait times: snap=0.495563 sec, exc=0.495563 sec, total=0.495563 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 241 serial 4553 --------------------------------------------------- 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 --------------------------------------------------- [3 samples, 06:00:02 - 06:00:05] idle wait at each sample [session created at: 06:00:02] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-09-07 06:00:05.102 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 30 (osid: 24404, J004) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-09-06 22:04:39.195060 :C9EF0936:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-09-06 22:04:39.195213 :C9EF0945:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=59 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-06 22:04:39.195507 :C9EF0950:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-06 22:04:39.195558 :C9EF0953:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:ktcc.c:879 2025-09-06 22:04:39.195577 :C9EF0954:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:ktcc.c:879 2025-09-06 22:04:39.198365 :C9EF0972:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-09-06 22:04:39.198463 :C9EF0981:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=59 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-06 22:04:39.198673 :C9EF0989:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-06 22:04:39.198714 :C9EF098C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:ktcc.c:879 2025-09-06 22:04:39.198728 :C9EF098D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:ktcc.c:879 2025-09-06 22:04:39.198947 :C9EF0993:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-06 22:04:39.198958 :C9EF0996:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-09-06 22:04:39.198985 :C9EF09A2:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] KSL POST RCVD poster=18 loc='ksr2.h LINE:607 ID:ksrmdone' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-09-06 22:04:39.200968 :C9EF09AC:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-09-06 22:20:47.969654 :C9F08EAF:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 09-06 22:20:47.961 2025-09-06 22:20:47.969656 :C9F08EB0:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=7692 pso_num=30 pso_serial#=70 2025-09-06 22:20:47.971278 :C9F08EB1:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=7692 osp_idx=28 osp_ver=2109 osp_pg=0 (spawn #565884) 2025-09-06 22:20:47.971279 :C9F08EB2:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-06 22:20:47.971279 :C9F08EB3:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=69 time=1582899252 2025-09-06 22:20:47.971279 :C9F08EB4:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-09-06 22:20:47.971280 :C9F08EB5:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-09-06 22:20:47.971280 :C9F08EB6:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-09-06 22:20:47.971280 :C9F08EB7:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-06 22:20:47.971280 :C9F08EB8:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-06 22:20:47.972924 :C9F08EB9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-06 22:20:47.972970 :C9F08EBF:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] 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-09-06 22:20:47.973401 :C9F08EC0:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-09-06 22:20:49.262504 :C9F08F77:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 09-06 22:20:49.260 2025-09-06 22:20:49.262505 :C9F08F78:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=22036 pso_num=30 pso_serial#=71 2025-09-06 22:20:49.262647 :C9F08F79:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=22036 osp_idx=28 osp_ver=2110 osp_pg=0 (spawn #565886) 2025-09-06 22:20:49.262648 :C9F08F7A:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-06 22:20:49.262648 :C9F08F7B:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=70 time=1582900549 2025-09-06 22:20:49.262649 :C9F08F7C:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-09-06 22:20:49.262649 :C9F08F7D:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-09-06 22:20:49.262649 :C9F08F7E:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-09-06 22:20:49.262650 :C9F08F7F:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-06 22:20:49.262650 :C9F08F80:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-06 22:20:49.263161 :C9F08F81:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-06 22:20:49.263200 :C9F08F87:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] 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-09-06 22:20:49.263583 :C9F08F88:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-09-06 22:20:50.158789 :C9F091E1:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 09-06 22:20:50.151 2025-09-06 22:20:50.158791 :C9F091E2:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=19980 pso_num=30 pso_serial#=72 2025-09-06 22:20:50.158925 :C9F091E3:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=19980 (legacy spawn) 2025-09-06 22:20:50.165503 :C9F091E4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-06 22:20:50.165924 :C9F091ED:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] 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-09-06 22:20:50.166782 :C9F091EE:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-09-06 23:04:46.281547 :C9F43728:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 09-06 23:04:46.278 2025-09-06 23:04:46.281548 :C9F43729:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=24276 pso_num=30 pso_serial#=73 2025-09-06 23:04:46.281680 :C9F4372A:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=24276 osp_idx=28 osp_ver=2112 osp_pg=0 (spawn #565989) 2025-09-06 23:04:46.281681 :C9F4372B:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-06 23:04:46.281682 :C9F4372C:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=71 time=1585537565 2025-09-06 23:04:46.281682 :C9F4372D:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-09-06 23:04:46.281682 :C9F4372E:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-09-06 23:04:46.281683 :C9F4372F:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-09-06 23:04:46.281683 :C9F43730:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-06 23:04:46.281683 :C9F43731:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-06 23:04:46.282210 :C9F43732:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-06 23:04:46.282257 :C9F43738:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] 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-09-06 23:04:46.291168 :C9F43750:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-09-06 23:59:05.613896 :C9F8751C:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 09-06 23:59:05.608 2025-09-06 23:59:05.613898 :C9F8751D:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=18472 pso_num=30 pso_serial#=74 2025-09-06 23:59:05.614044 :C9F8751E:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=18472 (legacy spawn) 2025-09-06 23:59:05.629182 :C9F8751F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-06 23:59:38.996506 :C9F880CA:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-09-06 23:59:40.019194 :C9F88141:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 09-06 23:59:40.009 2025-09-06 23:59:40.019196 :C9F88142:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=8240 pso_num=30 pso_serial#=75 2025-09-06 23:59:40.019339 :C9F88143:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=8240 (legacy spawn) 2025-09-06 23:59:40.026303 :C9F88144:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-06 23:59:40.026488 :C9F88149:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] 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-09-06 23:59:40.027301 :C9F8814E:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-09-06 23:59:40.723027 :C9F881AB:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 09-06 23:59:40.712 2025-09-06 23:59:40.723028 :C9F881AC:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=21416 pso_num=30 pso_serial#=76 2025-09-06 23:59:40.723179 :C9F881AD:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=21416 (legacy spawn) 2025-09-06 23:59:40.738221 :C9F881AE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 00:00:13.771689 :C9F88DF3:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-09-07 00:00:54.207865 :C9F89E34:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 09-07 00:00:54.193 2025-09-07 00:00:54.207867 :C9F89E35:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=22692 pso_num=30 pso_serial#=77 2025-09-07 00:00:54.208048 :C9F89E36:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=22692 osp_idx=28 osp_ver=2116 osp_pg=0 (spawn #566116) 2025-09-07 00:00:54.208049 :C9F89E37:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-07 00:00:54.208049 :C9F89E38:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=72 time=1588905502 2025-09-07 00:00:54.208050 :C9F89E39:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-09-07 00:00:54.208050 :C9F89E3A:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-09-07 00:00:54.208051 :C9F89E3B:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-09-07 00:00:54.208051 :C9F89E3C:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-07 00:00:54.208051 :C9F89E3D:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-07 00:00:54.208596 :C9F89E3E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-07 00:00:54.208636 :C9F89E44:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] 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-09-07 00:00:54.216671 :C9F89E52:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 00:00:54.217761 :C9F89E5A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 00:00:54.218319 :C9F89E62:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 00:00:54.218790 :C9F89E6A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 00:00:54.219224 :C9F89E72:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 00:00:54.221775 :C9F89E7A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 00:00:54.222862 :C9F89E82:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 00:00:54.274771 :C9F89EDD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 00:00:54.275648 :C9F89EE5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 00:00:54.275883 :C9F89EED:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 00:00:54.276101 :C9F89EF5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 00:00:54.277915 :C9F89EFD:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-09-07 00:04:53.297797 :C9F8EDD4:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 09-07 00:04:53.284 2025-09-07 00:04:53.297799 :C9F8EDD5:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=24248 pso_num=30 pso_serial#=78 2025-09-07 00:04:53.297962 :C9F8EDD6:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=24248 osp_idx=28 osp_ver=2117 osp_pg=0 (spawn #566126) 2025-09-07 00:04:53.297964 :C9F8EDD7:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-07 00:04:53.297965 :C9F8EDD8:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=73 time=1589144596 2025-09-07 00:04:53.297967 :C9F8EDD9:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-09-07 00:04:53.297968 :C9F8EDDA:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-09-07 00:04:53.297969 :C9F8EDDB:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-09-07 00:04:53.297970 :C9F8EDDC:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-07 00:04:53.297971 :C9F8EDDD:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-07 00:04:53.298571 :C9F8EDDE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-07 00:04:53.298617 :C9F8EDE4:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] 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-09-07 00:04:53.302916 :C9F8EDFC:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:kelt.c:517 2025-09-07 00:04:53.302987 :C9F8EDFD:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:kelt.c:517 2025-09-07 00:04:53.303252 :C9F8EDFE:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:kelt.c:517 2025-09-07 00:04:53.303271 :C9F8EDFF:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:kelt.c:517 2025-09-07 00:04:53.303495 :C9F8EE00:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:kelt.c:517 2025-09-07 00:04:53.303508 :C9F8EE01:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:kelt.c:517 2025-09-07 00:04:53.303716 :C9F8EE02:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:kelt.c:517 2025-09-07 00:04:53.303729 :C9F8EE03:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:kelt.c:517 2025-09-07 00:04:53.303942 :C9F8EE04:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:kelt.c:517 2025-09-07 00:04:53.303954 :C9F8EE05:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:kelt.c:517 2025-09-07 00:04:53.304162 :C9F8EE06:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:kelt.c:517 2025-09-07 00:04:53.304175 :C9F8EE07:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:kelt.c:517 2025-09-07 00:04:53.306716 :C9F8EE2A:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-09-07 06:00:00.872440 :CA14AC30:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 09-07 06:00:00.860 2025-09-07 06:00:00.872442 :CA14AC31:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=24404 pso_num=30 pso_serial#=79 2025-09-07 06:00:00.872567 :CA14AC36:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=24404 osp_idx=28 osp_ver=2118 osp_pg=0 (spawn #566949) 2025-09-07 06:00:00.872568 :CA14AC37:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-07 06:00:00.872568 :CA14AC38:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=74 time=1610452174 2025-09-07 06:00:00.872568 :CA14AC39:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-09-07 06:00:00.872569 :CA14AC3A:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-09-07 06:00:00.872570 :CA14AC3B:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-09-07 06:00:00.872570 :CA14AC3C:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-07 06:00:00.872571 :CA14AC3D:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-07 06:00:00.873113 :CA14AC43:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-07 06:00:00.877992 :CA14AC68:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 06:00:00.878034 :CA14AC6B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:jslv.c:9203 2025-09-07 06:00:00.883490 :CA14ACF4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 06:00:01.038319 :CA14AF9C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 06:00:01.175506 :CA14AFA4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 06:00:01.306725 :CA14AFC4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 06:00:02.437756 :CA14B1C0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 06:00:02.438765 :CA14B1C8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 06:00:02.444557 :CA14B1D0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 06:00:02.446056 :CA14B1D8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 06:00:02.460867 :CA14B1E0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 06:00:02.461495 :CA14B1E8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 06:00:02.462372 :CA14B1F0:db_trace:ktu.c@4871:ktuaex1r(): [10442:30:241] Extension usn 3, ext 0, nex 2 2025-09-07 06:00:02.462378 :CA14B1F1:db_trace:ktusm.c@2117:ktusmasp(): [10445:30:241] des1:tsn:1 rdba:0x00800a64 where: kduwh01: kdusru 2025-09-07 06:00:02.462527 :CA14B1F2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 06:00:02.463092 :CA14B1FA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 06:00:02.465664 :CA14B202:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 06:00:02.466566 :CA14B20A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-09-07 06:00:02.467314 :CA14B20B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-09-07 06:00:02.468049 :CA14B20C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-09-07 06:00:02.468437 :CA14B20D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-09-07 06:00:02.468443 :CA14B20E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-09-07 06:00:02.468947 :CA14B20F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-09-07 06:00:02.469428 :CA14B210:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-09-07 06:00:02.469766 :CA14B211:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-09-07 06:00:02.470801 :CA14B212:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-09-07 06:00:02.505454 :CA14B213:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 06:00:02.505513 :CA14B216:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-09-07 06:00:02.506399 :CA14B21C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 06:00:02.507269 :CA14B224:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-09-07 06:00:02.507766 :CA14B225:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 06:00:02.526161 :CA14B22D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 06:00:02.526209 :CA14B230:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-09-07 06:00:02.527009 :CA14B236:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 06:00:02.527841 :CA14B23E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-09-07 06:00:02.528250 :CA14B23F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 06:00:02.549204 :CA14B247:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 06:00:02.549267 :CA14B24A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-09-07 06:00:02.550182 :CA14B250:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 06:00:02.550759 :CA14B258:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 06:00:02.551227 :CA14B260:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 06:00:02.551449 :CA14B268:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 06:00:02.551605 :CA14B270:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 06:00:02.551772 :CA14B278:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:jslv.c:9203 2025-09-07 06:00:02.556058 :CA14B279:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-07 06:00:02.556166 :CA14B27C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 30 (osid: 24404, J004)