Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250707220007\orcl_j004_11420_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:36639M/63366M, Ph+PgF:42679M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 30 Windows thread id: 11420, image: ORACLE.EXE (J004) *** 2025-07-07 22:00:07.275 *** SESSION ID:(241.2969) 2025-07-07 22:00:07.275 *** 2025-07-07 22:00:07.275 Process diagnostic dump for ORACLE.EXE (J004), OS id=11420, pid: 30, proc_ser: 125, sid: 241, sess_ser: 2969 ------------------------------------------------------------------------------- current sql: client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 11420 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J004) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=9 seq_num=10 snap_id=1 wait times: snap=0.174772 sec, exc=0.174772 sec, total=0.174772 sec wait times: max=0.500000 sec, heur=4.663840 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=8 seq_num=9 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.000009 sec of elapsed time 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=7 seq_num=8 snap_id=1 wait times: snap=0.499994 sec, exc=0.499994 sec, total=0.499994 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=6 seq_num=7 snap_id=1 wait times: snap=0.502096 sec, exc=0.502096 sec, total=0.502096 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=5 seq_num=6 snap_id=1 wait times: snap=0.500002 sec, exc=0.500002 sec, total=0.500002 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000007 sec of elapsed time 4: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=4 seq_num=5 snap_id=1 wait times: snap=0.499991 sec, exc=0.499991 sec, total=0.499991 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000011 sec of elapsed time 5: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=3 seq_num=4 snap_id=1 wait times: snap=0.499989 sec, exc=0.499989 sec, total=0.499989 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000017 sec of elapsed time 6: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=2 seq_num=3 snap_id=1 wait times: snap=0.499994 sec, exc=0.499994 sec, total=0.499994 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000011 sec of elapsed time 7: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=1 seq_num=2 snap_id=1 wait times: snap=0.499955 sec, exc=0.499955 sec, total=0.499955 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000017 sec of elapsed time 8: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=0 seq_num=1 snap_id=1 wait times: snap=0.486951 sec, exc=0.486951 sec, total=0.486951 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 2969 --------------------------------------------------- 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:02 - 22:00:07] 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-07-07 22:00:07.275 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 30 (osid: 11420, J004) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-07-06 06:00:04.802620 :AE2E8ECD:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-07-06 06:00:04.802620 :AE2E8ECE:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-07-06 06:00:04.802621 :AE2E8ECF:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-06 06:00:04.802621 :AE2E8ED0:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-06 06:00:04.803166 :AE2E8ED1: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-07-06 06:00:04.803217 :AE2E8ED7: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-07-06 06:00:04.807417 :AE2E8EEE:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:kelt.c:517 2025-07-06 06:00:04.807469 :AE2E8EEF:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:kelt.c:517 2025-07-06 06:00:04.807736 :AE2E8EF0:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:kelt.c:517 2025-07-06 06:00:04.807753 :AE2E8EF1:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:kelt.c:517 2025-07-06 06:00:04.807966 :AE2E8EF2:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:kelt.c:517 2025-07-06 06:00:04.807979 :AE2E8EF3:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:kelt.c:517 2025-07-06 06:00:04.808189 :AE2E8EF4:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:kelt.c:517 2025-07-06 06:00:04.808201 :AE2E8EF5:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:kelt.c:517 2025-07-06 06:00:04.808404 :AE2E8EF6:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:kelt.c:517 2025-07-06 06:00:04.808416 :AE2E8EF7:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:kelt.c:517 2025-07-06 06:00:04.808619 :AE2E8EF8:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:kelt.c:517 2025-07-06 06:00:04.808634 :AE2E8EF9:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:kelt.c:517 2025-07-06 06:00:04.811395 :AE2E8EFA:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-07-06 06:00:06.321885 :AE2E8FFF:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 07-06 06:00:06.313 2025-07-06 06:00:06.321887 :AE2E9000:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=18260 pso_num=30 pso_serial#=114 2025-07-06 06:00:06.322022 :AE2E9001:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=18260 (legacy spawn) 2025-07-06 06:00:06.328763 :AE2E9002: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-07-06 06:00:06.328921 :AE2E9007: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-07-06 06:00:06.329757 :AE2E900C:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-07-06 22:02:14.395058 :AE7BA0D7:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 07-06 22:02:14.395 2025-07-06 22:02:14.395060 :AE7BA0D8:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=12004 pso_num=30 pso_serial#=115 2025-07-06 22:02:14.395200 :AE7BA0D9:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=12004 (legacy spawn) 2025-07-06 22:02:14.402019 :AE7BA0DA: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-07-06 22:02:14.402181 :AE7BA0E2: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-07-06 22:02:14.402966 :AE7BA0E4:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-07-06 22:02:14.412062 :AE7BA0E7:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 07-06 22:02:14.410 2025-07-06 22:02:14.412064 :AE7BA0E8:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=11336 pso_num=30 pso_serial#=116 2025-07-06 22:02:14.412201 :AE7BA0E9:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=11336 (legacy spawn) 2025-07-06 22:02:14.418888 :AE7BA0EA: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-07-06 22:02:14.419053 :AE7BA0F3: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-07-06 22:02:14.419853 :AE7BA0F4:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-07-06 23:59:14.702369 :AE858A82:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 07-06 23:59:14.688 2025-07-06 23:59:14.702371 :AE858A83:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=16176 pso_num=30 pso_serial#=117 2025-07-06 23:59:14.702515 :AE858A84:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=16176 (legacy spawn) 2025-07-06 23:59:14.709227 :AE858A85: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-07-06 23:59:14.709396 :AE858A8E: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-07-06 23:59:14.710180 :AE858A8F:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-07-06 23:59:15.109242 :AE858B02:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 07-06 23:59:15.095 2025-07-06 23:59:15.109244 :AE858B03:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=2964 pso_num=30 pso_serial#=118 2025-07-06 23:59:15.109385 :AE858B04:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=2964 (legacy spawn) 2025-07-06 23:59:15.115922 :AE858B05: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-07-06 23:59:15.116099 :AE858B0E: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-07-06 23:59:15.116880 :AE858B0F:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-07-06 23:59:15.125984 :AE858B12:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 07-06 23:59:15.126 2025-07-06 23:59:15.125988 :AE858B13:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=10028 pso_num=30 pso_serial#=119 2025-07-06 23:59:15.126152 :AE858B14:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=10028 (legacy spawn) 2025-07-06 23:59:15.133067 :AE858B15: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-07-06 23:59:15.133231 :AE858B1E: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-07-06 23:59:15.134045 :AE858B1F:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-07-06 23:59:15.658033 :AE858B38:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 07-06 23:59:15.655 2025-07-06 23:59:15.658034 :AE858B39:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=11292 pso_num=30 pso_serial#=120 2025-07-06 23:59:15.658172 :AE858B3A:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=11292 (legacy spawn) 2025-07-06 23:59:15.673437 :AE858B3B: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-07-06 23:59:18.919970 :AE858C58: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-07-06 23:59:18.920157 :AE858C61: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-07-06 23:59:18.921418 :AE858C62:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-07-06 23:59:19.178632 :AE858C65:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 07-06 23:59:19.171 2025-07-06 23:59:19.178634 :AE858C66:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=17004 pso_num=30 pso_serial#=121 2025-07-06 23:59:19.178788 :AE858C67:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=17004 (legacy spawn) 2025-07-06 23:59:19.193595 :AE858C68: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-07-06 23:59:52.344203 :AE859902:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-07-06 23:59:52.401560 :AE859905:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 07-06 23:59:52.387 2025-07-06 23:59:52.401563 :AE859906:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=4488 pso_num=30 pso_serial#=122 2025-07-06 23:59:52.401709 :AE859907:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=4488 (legacy spawn) 2025-07-06 23:59:52.416617 :AE859908: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-07-06 23:59:55.716262 :AE859A23: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-07-06 23:59:55.716435 :AE859A28: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-07-06 23:59:55.717721 :AE859A2D:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-07-06 23:59:55.978143 :AE859A3C:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 07-06 23:59:55.968 2025-07-06 23:59:55.978145 :AE859A3D:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=18412 pso_num=30 pso_serial#=123 2025-07-06 23:59:55.978284 :AE859A3E:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=18412 (legacy spawn) 2025-07-06 23:59:55.993046 :AE859A3F: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-07-07 00:00:29.124998 :AE85A7C8:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-07-07 01:00:08.835764 :AE8A7474:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 07-07 01:00:08.824 2025-07-07 01:00:08.835767 :AE8A7475:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=18136 pso_num=30 pso_serial#=124 2025-07-07 01:00:08.835908 :AE8A7476:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=18136 osp_idx=28 osp_ver=1398 osp_pg=0 (spawn #359599) 2025-07-07 01:00:08.835908 :AE8A7477:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-07 01:00:08.835909 :AE8A7478:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=112 time=530784720 2025-07-07 01:00:08.835909 :AE8A7479:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-07-07 01:00:08.835910 :AE8A747A:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-07-07 01:00:08.835910 :AE8A747B:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-07-07 01:00:08.835910 :AE8A747C:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-07 01:00:08.835911 :AE8A747D:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-07 01:00:08.836423 :AE8A747E: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-07-07 01:00:08.836472 :AE8A7484: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-07-07 01:00:08.844319 :AE8A7492: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-07-07 01:00:08.845582 :AE8A749A: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-07-07 01:00:08.846218 :AE8A74A2: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-07-07 01:00:08.846704 :AE8A74AA: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-07-07 01:00:08.847144 :AE8A74B2: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-07-07 01:00:08.849867 :AE8A74BA: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-07-07 01:00:08.851055 :AE8A74C2: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-07-07 01:00:08.905113 :AE8A74CA: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-07-07 01:00:08.906865 :AE8A74D2: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-07-07 01:00:08.907938 :AE8A74DA: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-07-07 01:00:08.908225 :AE8A74E2: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-07-07 01:00:08.908462 :AE8A74EA: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-07-07 01:00:08.910565 :AE8A74F2:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-07-07 22:00:00.754546 :AEEF6085:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 07-07 22:00:00.740 2025-07-07 22:00:00.754547 :AEEF6086:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=11420 pso_num=30 pso_serial#=125 2025-07-07 22:00:00.754665 :AEEF6087:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=11420 osp_idx=28 osp_ver=1399 osp_pg=0 (spawn #362513) 2025-07-07 22:00:00.754666 :AEEF6088:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-07 22:00:00.754666 :AEEF6089:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=113 time=606376642 2025-07-07 22:00:00.754667 :AEEF608A:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-07-07 22:00:00.754668 :AEEF608B:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-07-07 22:00:00.754668 :AEEF608C:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-07-07 22:00:00.754668 :AEEF608D:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-07 22:00:00.754669 :AEEF608E:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-07 22:00:00.755392 :AEEF6097: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-07-07 22:00:00.760549 :AEEF60AC: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-07-07 22:00:00.760586 :AEEF60AF:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:jslv.c:9203 2025-07-07 22:00:00.766496 :AEEF60FA: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-07-07 22:00:00.961871 :AEEF6380: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-07-07 22:00:01.137519 :AEEF63B8: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-07-07 22:00:01.268842 :AEEF63D8: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-07-07 22:00:02.387028 :AEEF65FF: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-07-07 22:00:02.388046 :AEEF6607: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-07-07 22:00:02.392201 :AEEF660F: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-07-07 22:00:02.394772 :AEEF6617: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-07-07 22:00:02.397060 :AEEF661F: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-07-07 22:00:02.398621 :AEEF6627: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-07-07 22:00:02.402388 :AEEF662F: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-07-07 22:00:02.418750 :AEEF6637: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-07-07 22:00:02.419356 :AEEF663F: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-07-07 22:00:02.419854 :AEEF6647: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-07-07 22:00:02.420345 :AEEF664F: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-07-07 22:00:02.423061 :AEEF6657: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-07-07 22:00:02.423993 :AEEF665F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-07-07 22:00:02.424766 :AEEF6660:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-07-07 22:00:02.425554 :AEEF6661:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-07-07 22:00:02.425973 :AEEF6662:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-07-07 22:00:02.425980 :AEEF6663:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-07-07 22:00:02.426643 :AEEF6664:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-07-07 22:00:02.427165 :AEEF6665:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-07-07 22:00:02.427469 :AEEF6666:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-07-07 22:00:02.428624 :AEEF6667:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-07-07 22:00:02.475807 :AEEF6668: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-07-07 22:00:02.475865 :AEEF666B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-07-07 22:00:02.476806 :AEEF6671: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-07-07 22:00:02.477784 :AEEF6679:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-07-07 22:00:02.478227 :AEEF667A: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-07-07 22:00:02.500716 :AEEF6682: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-07-07 22:00:02.500776 :AEEF6685:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-07-07 22:00:02.501647 :AEEF668B: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-07-07 22:00:02.502598 :AEEF6693:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-07-07 22:00:02.503093 :AEEF6694: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-07-07 22:00:02.525031 :AEEF669E: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-07-07 22:00:02.525088 :AEEF66A1:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-07-07 22:00:02.526028 :AEEF66B1: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-07-07 22:00:02.527098 :AEEF66B9:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-07-07 22:00:02.527600 :AEEF66BA: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-07-07 22:00:02.550282 :AEEF66CA: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-07-07 22:00:02.550335 :AEEF66CD:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-07-07 22:00:02.551252 :AEEF66D5: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-07-07 22:00:02.552172 :AEEF66DD:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-07-07 22:00:02.552659 :AEEF66EE: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-07-07 22:00:02.573917 :AEEF670E: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-07-07 22:00:02.573968 :AEEF6711:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-07-07 22:00:02.574901 :AEEF6717: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-07-07 22:00:02.586414 :AEEF671F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-07-07 22:00:02.586965 :AEEF6720: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-07-07 22:00:02.604742 :AEEF6728: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-07-07 22:00:02.604792 :AEEF672B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-07-07 22:00:02.605679 :AEEF6731: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-07-07 22:00:02.606126 :AEEF6739: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-07-07 22:00:02.606470 :AEEF6741: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-07-07 22:00:02.606649 :AEEF6749: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-07-07 22:00:02.606782 :AEEF6751: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-07-07 22:00:02.606922 :AEEF6759:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:jslv.c:9203 2025-07-07 22:00:02.607445 :AEEF675A: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-07-07 22:00:02.610875 :AEEF6762: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-07-07 22:00:02.610960 :AEEF6765: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 2025-07-07 22:00:02.611035 :AEEF6772: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 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 30 (osid: 11420, J004)