Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250508220004\orcl_vkrm_12968_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:37530M/63366M, Ph+PgF:44934M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 24 Windows thread id: 12968, image: ORACLE.EXE (VKRM) *** 2025-05-08 22:00:04.879 *** SESSION ID:(193.51247) 2025-05-08 22:00:04.879 *** 2025-05-08 22:00:04.879 Process diagnostic dump for ORACLE.EXE (VKRM), OS id=12968, pid: 24, proc_ser: 185, sid: 193, sess_ser: 51247 ------------------------------------------------------------------------------- current sql: Current Wait Stack: 0: waiting for 'VKRM Idle' =0x0, =0x0, =0x0 wait_id=0 seq_num=1 snap_id=1 wait times: snap=4.854526 sec, exc=4.854526 sec, total=4.854526 sec wait times: max=infinite, heur=4.854526 sec wait counts: calls=0 os=0 in_wait=1 iflags=0x5a0 Wait State: fixed_waits=0 flags=0x22 boundary=0x0000000000000000/-1 Session Wait History: elapsed time of 0.000000 sec since current wait Sampled Session History of session 193 serial 51247 --------------------------------------------------- The sampled session history is constructed by sampling the target session every 1 second. The sampling process captures at each sample if the session is in a non-idle wait, an idle wait, or not in a wait. If the session is in a non-idle wait then one interval is shown for all the samples the session was in the same non-idle wait. If the session is in an idle wait or not in a wait for consecutive samples then one interval is shown for all the consecutive samples. Though we display these consecutive samples in a single interval the session may NOT be continuously idle or not in a wait (the sampling process does not know). The history is displayed in reverse chronological order. sample interval: 1 sec, max history 120 sec --------------------------------------------------- [5 samples, 22:00:00 - 22:00:04] idle wait at each sample [session created at: 22:00:00] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-05-08 22:00:04.879 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 24 (osid: 12968, VKRM) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-08 21:58:15.837470 :9482C040:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-08 21:58:15.837532 :9482C043:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:ktcc.c:879 2025-05-08 21:58:15.837566 :9482C044:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:ktcc.c:879 2025-05-08 21:58:15.839430 :9482C04A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-08 21:58:15.839475 :9482C04B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-08 21:58:15.839950 :9482C04C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-08 21:58:15.839991 :9482C04D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-08 21:58:15.840240 :9482C04E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-08 21:58:15.840291 :9482C04F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-08 21:58:15.840400 :9482C050:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-08 21:58:15.840647 :9482C051:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-08 21:58:15.840682 :9482C054:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-08 21:58:15.848861 :9482C05A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-08 21:58:15.848924 :9482C05D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:ktcc.c:879 2025-05-08 21:58:15.848956 :9482C05E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:ktcc.c:879 2025-05-08 21:58:15.850717 :9482C064:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-08 21:58:15.850759 :9482C065:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-08 21:58:15.850937 :9482C066:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-08 21:58:15.851161 :9482C067:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-08 21:58:15.851195 :9482C06A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-08 21:58:15.855686 :9482C070:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-08 21:58:15.855744 :9482C073:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:ktcc.c:879 2025-05-08 21:58:15.855773 :9482C074:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:ktcc.c:879 2025-05-08 21:58:15.857545 :9482C07A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-08 21:58:15.857590 :9482C07B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-08 21:58:15.860819 :9482C07C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-08 21:58:15.861086 :9482C07D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-08 21:58:15.861123 :9482C080:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-08 21:58:15.865843 :9482C086:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-08 21:58:15.865900 :9482C089:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:ktcc.c:879 2025-05-08 21:58:15.865930 :9482C08A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:ktcc.c:879 2025-05-08 21:58:15.867725 :9482C090:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-08 21:58:15.867772 :9482C091:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-08 21:58:15.868110 :9482C092:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-08 21:58:15.868142 :9482C093:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-08 21:58:15.868382 :9482C094:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-08 21:58:15.868411 :9482C095:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-08 21:58:15.868417 :9482C096:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-08 21:58:15.868441 :9482C097:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-08 21:58:15.868540 :9482C098:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-08 21:58:15.868566 :9482C099:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-08 21:58:15.868571 :9482C09A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-08 21:58:15.868595 :9482C09B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-08 21:58:15.868689 :9482C09C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-08 21:58:15.868715 :9482C09D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-08 21:58:15.868720 :9482C09E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-08 21:58:15.868745 :9482C09F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-08 21:58:15.868874 :9482C0A0:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-08 21:58:15.868914 :9482C0A1:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-08 21:58:15.868922 :9482C0A2:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-08 21:58:15.868962 :9482C0A3:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-08 21:58:15.869062 :9482C0A4:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-08 21:58:15.869089 :9482C0A5:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-08 21:58:15.869094 :9482C0A6:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-08 21:58:15.869119 :9482C0A7:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-08 21:58:15.869215 :9482C0A8:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-08 21:58:15.869241 :9482C0A9:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-08 21:58:15.869274 :9482C0AA:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-08 21:58:15.869512 :9482C0AB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-08 21:58:15.869549 :9482C0AE:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-08 21:58:15.881408 :9482C0B4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-08 21:58:15.881476 :9482C0B7:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:ktcc.c:879 2025-05-08 21:58:15.881507 :9482C0B8:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:ktcc.c:879 2025-05-08 21:58:15.883385 :9482C0BE:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-08 21:58:15.883429 :9482C0BF:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-08 21:58:15.884035 :9482C0C0:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-08 21:58:15.884289 :9482C0C1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-08 21:58:15.884324 :9482C0C4:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-08 21:58:15.891631 :9482C0CA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-08 21:58:15.891692 :9482C0CD:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:ktcc.c:879 2025-05-08 21:58:15.891724 :9482C0CE:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:ktcc.c:879 2025-05-08 21:58:15.892057 :9482C0D4:db_trace:kwqid.c@2146:kwqidrdq(): [10960:24:193] kwqidrdq: Error: 1403 occured in OCI execute 2025-05-08 21:58:15.892393 :9482C0D5:db_trace:kwqid.c@2146:kwqidrdq(): [10960:24:193] kwqidrdq: Error: 1403 occured in OCI execute 2025-05-08 21:58:15.892511 :9482C0D6:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-08 21:58:15.892731 :9482C0D7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-08 21:58:15.892756 :9482C0DA:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-08 21:58:15.894415 :9482C0E0:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-08 21:58:15.894706 :9482C0E1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-08 21:58:15.894736 :9482C0E4:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-08 21:58:15.895626 :9482C0EA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-08 21:58:15.895730 :9482C0F3:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-05-08 21:58:45.980268 :9482CABD:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-08 21:58:47.831965 :9482CB47:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-08 21:58:47.824 2025-05-08 21:58:47.831967 :9482CB48:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=12188 pso_num=24 pso_serial#=175 2025-05-08 21:58:47.832104 :9482CB49:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=12188 (legacy spawn) 2025-05-08 21:58:47.838514 :9482CB4A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-08 21:58:47.838683 :9482CB53:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-05-08 21:58:47.839506 :9482CB54:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-08 21:59:14.334644 :9482D37D:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-08 21:59:14.320 2025-05-08 21:59:14.334646 :9482D37E:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=5912 pso_num=24 pso_serial#=176 2025-05-08 21:59:14.334789 :9482D37F:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=5912 (legacy spawn) 2025-05-08 21:59:14.341139 :9482D380:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-08 21:59:14.341313 :9482D389:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-05-08 21:59:14.342151 :9482D38A:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-08 21:59:14.350769 :9482D38D:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-08 21:59:14.336 2025-05-08 21:59:14.350771 :9482D38E:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=12956 pso_num=24 pso_serial#=177 2025-05-08 21:59:14.350905 :9482D38F:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=12956 (legacy spawn) 2025-05-08 21:59:14.357302 :9482D390:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-08 21:59:14.357464 :9482D399:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-05-08 21:59:14.358259 :9482D39A:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-08 21:59:15.872656 :9482D472:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-08 21:59:15.867 2025-05-08 21:59:15.872658 :9482D473:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=12976 pso_num=24 pso_serial#=178 2025-05-08 21:59:15.872790 :9482D474:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=12976 osp_idx=22 osp_ver=248802 osp_pg=0 (spawn #162273) 2025-05-08 21:59:15.872791 :9482D475:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-08 21:59:15.872792 :9482D476:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=119 time=4012333031 2025-05-08 21:59:15.872792 :9482D477:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-05-08 21:59:15.872792 :9482D478:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-05-08 21:59:15.872793 :9482D479:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-05-08 21:59:15.872793 :9482D47A:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-08 21:59:15.872793 :9482D47B:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-08 21:59:15.873301 :9482D47C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-08 21:59:15.873924 :9482D491:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-08 21:59:15.881486 :9482D4AD:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-08 21:59:15.881855 :9482D4AE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-08 21:59:15.881892 :9482D4B1:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-08 21:59:15.882766 :9482D4B7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-08 21:59:15.882899 :9482D4C0:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-05-08 21:59:45.979245 :9482DE63:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-08 21:59:49.990218 :9482DF54:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-08 21:59:49.990 2025-05-08 21:59:49.990220 :9482DF55:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=9744 pso_num=24 pso_serial#=179 2025-05-08 21:59:49.990367 :9482DF56:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=9744 (legacy spawn) 2025-05-08 21:59:49.996968 :9482DF57:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-08 21:59:49.997149 :9482DF5C:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-05-08 21:59:49.997993 :9482DF61:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-08 21:59:50.712508 :9482DF77:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-08 21:59:50.698 2025-05-08 21:59:50.712510 :9482DF78:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=11752 pso_num=24 pso_serial#=180 2025-05-08 21:59:50.712648 :9482DF79:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=11752 (legacy spawn) 2025-05-08 21:59:50.719131 :9482DF7A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-08 21:59:50.719294 :9482DF83:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-05-08 21:59:50.720087 :9482DF84:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-08 21:59:50.728675 :9482DF87:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-08 21:59:50.714 2025-05-08 21:59:50.728677 :9482DF88:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=11196 pso_num=24 pso_serial#=181 2025-05-08 21:59:50.728858 :9482DF89:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=11196 (legacy spawn) 2025-05-08 21:59:50.735289 :9482DF8A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-08 21:59:50.735453 :9482DF91:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-05-08 21:59:50.736284 :9482DF94:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-08 21:59:51.179680 :9482E030:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-08 21:59:51.167 2025-05-08 21:59:51.179682 :9482E031:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=12544 pso_num=24 pso_serial#=182 2025-05-08 21:59:51.179819 :9482E032:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=12544 (legacy spawn) 2025-05-08 21:59:51.186388 :9482E033:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-08 21:59:51.186559 :9482E03C:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-05-08 21:59:51.187363 :9482E03D:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-08 21:59:53.867672 :9482E0CA:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-08 21:59:53.855 2025-05-08 21:59:53.867674 :9482E0CB:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=11716 pso_num=24 pso_serial#=183 2025-05-08 21:59:53.867814 :9482E0CC:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=11716 (legacy spawn) 2025-05-08 21:59:53.874220 :9482E0F5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-08 21:59:53.874392 :9482E0FD:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-05-08 21:59:53.875174 :9482E0FF:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-08 21:59:53.894377 :9482E102:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-08 21:59:53.886 2025-05-08 21:59:53.894379 :9482E103:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=12316 pso_num=24 pso_serial#=184 2025-05-08 21:59:53.894518 :9482E104:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=12316 (legacy spawn) 2025-05-08 21:59:53.900997 :9482E105:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-08 21:59:53.901185 :9482E10E:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-05-08 21:59:53.902208 :9482E10F:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-08 22:00:00.025685 :9482E314:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-08 22:00:00.019 2025-05-08 22:00:00.025687 :9482E315:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=12968 pso_num=24 pso_serial#=185 2025-05-08 22:00:00.025793 :9482E316:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=12968 osp_idx=22 osp_ver=248809 osp_pg=0 (spawn #162275) 2025-05-08 22:00:00.025794 :9482E317:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=3656 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-08 22:00:00.025794 :9482E318:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=120 time=4012377187 2025-05-08 22:00:00.025795 :9482E319:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-05-08 22:00:00.025795 :9482E31A:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-05-08 22:00:00.025796 :9482E31B:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-05-08 22:00:00.025796 :9482E31C:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-08 22:00:00.025796 :9482E31D:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-08 22:00:00.025865 :9482E31E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:0] KSL POST SENT postee=6 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-08 22:00:00.025871 :9482E31F:db_trace:kso.c@5554:kso_spawn_diag_end(): [10420:24:0] kso: spawn diagnostics: init time=0 secs ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 24 (osid: 12968, VKRM)