Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250815220006\orcl_vkrm_15292_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:35466M/63366M, Ph+PgF:40798M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 22 Windows thread id: 15292, image: ORACLE.EXE (VKRM) *** 2025-08-15 22:00:06.551 *** SESSION ID:(177.53943) 2025-08-15 22:00:06.551 *** 2025-08-15 22:00:06.551 Process diagnostic dump for ORACLE.EXE (VKRM), OS id=15292, pid: 22, proc_ser: 220, sid: 177, sess_ser: 53943 ------------------------------------------------------------------------------- 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=6.539104 sec, exc=6.539104 sec, total=6.539104 sec wait times: max=infinite, heur=6.539104 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 177 serial 53943 --------------------------------------------------- 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 --------------------------------------------------- [7 samples, 22:00:00 - 22:00:06] idle wait at each sample [session created at: 22:00:00] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-08-15 22:00:06.551 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 22 (osid: 15292, VKRM) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-08-15 21:58:04.375715 :C038558B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:ktcc.c:879 2025-08-15 21:58:04.375747 :C038558C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:ktcc.c:879 2025-08-15 21:58:04.379316 :C0385592:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 21:58:04.379368 :C0385595:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:ktcc.c:879 2025-08-15 21:58:04.379400 :C0385596:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:ktcc.c:879 2025-08-15 21:58:04.383089 :C038559C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 21:58:04.383145 :C038559F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:ktcc.c:879 2025-08-15 21:58:04.383182 :C03855A0:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:ktcc.c:879 2025-08-15 21:58:04.386949 :C03855A6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 21:58:04.387008 :C03855A9:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:ktcc.c:879 2025-08-15 21:58:04.387040 :C03855AA:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:ktcc.c:879 2025-08-15 21:58:04.392525 :C03855B0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 21:58:04.392577 :C03855B3:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:ktcc.c:879 2025-08-15 21:58:04.392609 :C03855B4:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:ktcc.c:879 2025-08-15 21:58:04.401770 :C03855BA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 21:58:04.401820 :C03855BD:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:ktcc.c:879 2025-08-15 21:58:04.401856 :C03855BE:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:ktcc.c:879 2025-08-15 21:58:04.405580 :C03855C4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 21:58:04.405639 :C03855C7:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:ktcc.c:879 2025-08-15 21:58:04.405676 :C03855C8:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:ktcc.c:879 2025-08-15 21:58:04.412681 :C03855CE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 21:58:04.412747 :C03855D1:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:ktcc.c:879 2025-08-15 21:58:04.412779 :C03855D2:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:ktcc.c:879 2025-08-15 21:58:04.419674 :C03855D8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 21:58:04.419729 :C03855DB:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:ktcc.c:879 2025-08-15 21:58:04.419764 :C03855DC:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:ktcc.c:879 2025-08-15 21:58:04.423449 :C03855E2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 21:58:04.423503 :C03855E5:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:ktcc.c:879 2025-08-15 21:58:04.423534 :C03855E6:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:ktcc.c:879 2025-08-15 21:58:04.435909 :C03855EC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 21:58:04.435974 :C03855EF:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:ktcc.c:879 2025-08-15 21:58:04.436011 :C03855F0:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:ktcc.c:879 2025-08-15 21:58:04.438399 :C03855F6:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-08-15 21:58:04.438489 :C03855F7:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-08-15 21:58:04.438629 :C03855F8:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-08-15 21:58:04.438963 :C03855F9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 21:58:04.439003 :C03855FC:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-08-15 21:58:04.442420 :C0385602:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 21:58:04.442485 :C0385605:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:ktcc.c:879 2025-08-15 21:58:04.442517 :C0385606:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:ktcc.c:879 2025-08-15 21:58:04.444270 :C038560C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-08-15 21:58:04.444316 :C038560D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-08-15 21:58:04.444527 :C038560E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-08-15 21:58:04.444756 :C038560F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 21:58:04.444788 :C0385612:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-08-15 21:58:04.449450 :C0385618:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 21:58:04.449510 :C038561B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:ktcc.c:879 2025-08-15 21:58:04.449543 :C038561C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:ktcc.c:879 2025-08-15 21:58:04.451651 :C0385622:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-08-15 21:58:04.451698 :C0385623:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-08-15 21:58:04.455406 :C0385624:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 21:58:04.455458 :C0385627:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:ktcc.c:879 2025-08-15 21:58:04.455489 :C0385628:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:ktcc.c:879 2025-08-15 21:58:04.457382 :C038562E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-08-15 21:58:04.457425 :C038562F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-08-15 21:58:04.476235 :C0385630:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-08-15 21:58:04.476297 :C0385631:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-08-15 21:58:04.476578 :C0385632:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-08-15 21:58:04.476614 :C0385633:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-08-15 21:58:04.476664 :C0385634:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-08-15 21:58:04.476959 :C0385635:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 21:58:04.476992 :C0385638:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-08-15 21:58:04.485534 :C038563E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 21:58:04.485606 :C0385641:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:ktcc.c:879 2025-08-15 21:58:04.485639 :C0385642:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:ktcc.c:879 2025-08-15 21:58:04.487474 :C0385648:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-08-15 21:58:04.487521 :C0385649:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-08-15 21:58:04.488034 :C038564A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-08-15 21:58:04.488300 :C038564B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 21:58:04.488336 :C038564E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-08-15 21:58:04.493499 :C0385654:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 21:58:04.493562 :C0385657:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:ktcc.c:879 2025-08-15 21:58:04.493599 :C0385658:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:ktcc.c:879 2025-08-15 21:58:04.493908 :C038565E:db_trace:kwqid.c@2146:kwqidrdq(): [10960:22:177] kwqidrdq: Error: 1403 occured in OCI execute 2025-08-15 21:58:04.494239 :C038565F:db_trace:kwqid.c@2146:kwqidrdq(): [10960:22:177] kwqidrdq: Error: 1403 occured in OCI execute 2025-08-15 21:58:04.494427 :C0385660:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-08-15 21:58:04.494658 :C0385661:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 21:58:04.494687 :C0385664:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-08-15 21:58:04.496377 :C038566A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-08-15 21:58:04.496609 :C038566B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 21:58:04.496638 :C038566E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-08-15 21:58:04.497521 :C0385674:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 21:58:04.497631 :C038567D:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-15 21:58:34.559652 :C0386046:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-15 21:58:57.706024 :C038675D:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-15 21:58:57.697 2025-08-15 21:58:57.706026 :C038675E:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=20644 pso_num=22 pso_serial#=210 2025-08-15 21:58:57.706169 :C038675F:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=20644 (legacy spawn) 2025-08-15 21:58:57.712458 :C0386760:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 21:58:57.712624 :C0386765:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-15 21:58:57.713524 :C038676A:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-15 21:59:01.492428 :C038689C:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-15 21:59:01.478 2025-08-15 21:59:01.492430 :C038689D:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16996 pso_num=22 pso_serial#=211 2025-08-15 21:59:01.492567 :C038689E:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=16996 (legacy spawn) 2025-08-15 21:59:01.498973 :C038689F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 21:59:01.499152 :C03868A4:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-15 21:59:01.499991 :C03868A9:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-15 21:59:01.516115 :C03868AC:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-15 21:59:01.509 2025-08-15 21:59:01.516117 :C03868AD:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=19680 pso_num=22 pso_serial#=212 2025-08-15 21:59:01.516247 :C03868AE:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=19680 (legacy spawn) 2025-08-15 21:59:01.522725 :C03868AF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 21:59:01.522891 :C03868B8:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-15 21:59:01.523739 :C03868B9:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-15 21:59:01.861530 :C03868DA:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-15 21:59:01.853 2025-08-15 21:59:01.861532 :C03868DB:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=19388 pso_num=22 pso_serial#=213 2025-08-15 21:59:01.861687 :C03868DC:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=19388 (legacy spawn) 2025-08-15 21:59:01.868340 :C03868DD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 21:59:01.868507 :C03868E6:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-15 21:59:01.869341 :C03868E7:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-15 21:59:04.402708 :C03869C7:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-15 21:59:04.397 2025-08-15 21:59:04.402710 :C03869C8:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=19516 pso_num=22 pso_serial#=214 2025-08-15 21:59:04.402845 :C03869C9:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=19516 osp_idx=0 osp_ver=519466 osp_pg=0 (spawn #492466) 2025-08-15 21:59:04.402846 :C03869CA:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-15 21:59:04.402847 :C03869CB:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=250 time=3975813704 2025-08-15 21:59:04.402848 :C03869CC:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-15 21:59:04.402848 :C03869CD:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-15 21:59:04.402848 :C03869CE:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-15 21:59:04.402849 :C03869CF:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-15 21:59:04.402849 :C03869D0:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-15 21:59:04.403342 :C03869D1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-15 21:59:04.403960 :C03869E6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 21:59:04.411565 :C0386A02:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-08-15 21:59:04.411909 :C0386A03:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 21:59:04.411943 :C0386A06:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-08-15 21:59:04.412828 :C0386A0C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 21:59:04.412943 :C0386A15:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-15 21:59:34.490346 :C0387394:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-15 21:59:36.136347 :C0387403:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-15 21:59:36.128 2025-08-15 21:59:36.136349 :C0387404:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=21356 pso_num=22 pso_serial#=215 2025-08-15 21:59:36.136482 :C0387405:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=21356 (legacy spawn) 2025-08-15 21:59:36.142932 :C0387406:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 21:59:36.143109 :C038740F:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-15 21:59:36.143925 :C0387410:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-15 21:59:38.095581 :C03874C6:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-15 21:59:38.081 2025-08-15 21:59:38.095583 :C03874C7:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=14784 pso_num=22 pso_serial#=216 2025-08-15 21:59:38.095719 :C03874C8:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=14784 (legacy spawn) 2025-08-15 21:59:38.102220 :C03874C9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 21:59:38.102394 :C03874D2:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-15 21:59:38.103192 :C03874D3:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-15 21:59:38.111956 :C03874D6:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-15 21:59:38.096 2025-08-15 21:59:38.111965 :C03874D7:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=21476 pso_num=22 pso_serial#=217 2025-08-15 21:59:38.112123 :C03874D8:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=21476 (legacy spawn) 2025-08-15 21:59:38.118582 :C03874D9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 21:59:38.118746 :C03874E2:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-15 21:59:38.119596 :C03874E3:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-15 21:59:41.276842 :C03875D3:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-15 21:59:41.264 2025-08-15 21:59:41.276844 :C03875D4:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=19596 pso_num=22 pso_serial#=218 2025-08-15 21:59:41.276977 :C03875D5:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=19596 (legacy spawn) 2025-08-15 21:59:41.283405 :C03875D6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 21:59:41.283580 :C03875DF:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-15 21:59:41.284372 :C03875E0:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-15 21:59:41.293079 :C03875E3:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-15 21:59:41.279 2025-08-15 21:59:41.293081 :C03875E4:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16572 pso_num=22 pso_serial#=219 2025-08-15 21:59:41.293225 :C03875E5:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=16572 (legacy spawn) 2025-08-15 21:59:41.299718 :C03875E6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 21:59:41.299749 :C03875E9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-15 21:59:41.299900 :C03875F1:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-15 21:59:41.300735 :C03875FD:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-15 22:00:00.017173 :C0387BDD:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-15 22:00:00.010 2025-08-15 22:00:00.017175 :C0387BDE:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=15292 pso_num=22 pso_serial#=220 2025-08-15 22:00:00.017284 :C0387BDF:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=15292 osp_idx=0 osp_ver=519472 osp_pg=0 (spawn #492468) 2025-08-15 22:00:00.017285 :C0387BE0:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=3656 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-15 22:00:00.017285 :C0387BE1:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=251 time=3975869314 2025-08-15 22:00:00.017286 :C0387BE2:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-15 22:00:00.017286 :C0387BE3:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-15 22:00:00.017287 :C0387BE4:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-15 22:00:00.017287 :C0387BE5:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-15 22:00:00.017287 :C0387BE6:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-15 22:00:00.017361 :C0387BE7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:0] KSL POST SENT postee=6 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-15 22:00:00.017369 :C0387BE8:db_trace:kso.c@5554:kso_spawn_diag_end(): [10420:22:0] kso: spawn diagnostics: init time=0 secs ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 22 (osid: 15292, VKRM)