Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250714220008\orcl_vkrm_17756_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:36318M/63366M, Ph+PgF:42287M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 24 Windows thread id: 17756, image: ORACLE.EXE (VKRM) *** 2025-07-14 22:00:08.471 *** SESSION ID:(193.4089) 2025-07-14 22:00:08.471 *** 2025-07-14 22:00:08.486 Process diagnostic dump for ORACLE.EXE (VKRM), OS id=17756, pid: 24, proc_ser: 200, sid: 193, sess_ser: 4089 ------------------------------------------------------------------------------- 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=8.460432 sec, exc=8.460432 sec, total=8.460432 sec wait times: max=infinite, heur=8.460432 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 4089 --------------------------------------------------- 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 --------------------------------------------------- [9 samples, 22:00:00 - 22:00:08] 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-07-14 22:00:08.486 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 24 (osid: 17756, VKRM) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-07-14 21:57:03.946279 :B20B5139:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-07-14 21:57:03.946633 :B20B513A: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-07-14 21:57:03.946669 :B20B513D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-07-14 21:57:03.947546 :B20B5143: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-07-14 21:57:03.947675 :B20B514B: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-07-14 21:57:34.023233 :B20B5B2A:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-14 21:57:37.103227 :B20B5C2D:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-14 21:57:37.096 2025-07-14 21:57:37.103230 :B20B5C2E:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=16340 pso_num=24 pso_serial#=181 2025-07-14 21:57:37.103369 :B20B5C2F:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=16340 (legacy spawn) 2025-07-14 21:57:37.109920 :B20B5C30: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-07-14 21:57:37.110095 :B20B5C35: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-07-14 21:57:37.110920 :B20B5C3A:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-14 21:57:37.119645 :B20B5C3D:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-14 21:57:37.111 2025-07-14 21:57:37.119647 :B20B5C3E:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=18044 pso_num=24 pso_serial#=182 2025-07-14 21:57:37.119786 :B20B5C3F:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=18044 (legacy spawn) 2025-07-14 21:57:37.126259 :B20B5C40: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-07-14 21:57:37.126440 :B20B5C49: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-07-14 21:57:37.127195 :B20B5C4A:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-14 21:57:42.209309 :B20B5DCF:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-14 21:57:42.204 2025-07-14 21:57:42.209311 :B20B5DD0:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=17424 pso_num=24 pso_serial#=183 2025-07-14 21:57:42.209450 :B20B5DD1:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=17424 osp_idx=22 osp_ver=570118 osp_pg=0 (spawn #385825) 2025-07-14 21:57:42.209451 :B20B5DD2:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-14 21:57:42.209451 :B20B5DD3:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=201 time=1211038111 2025-07-14 21:57:42.209451 :B20B5DD4:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-07-14 21:57:42.209452 :B20B5DD5:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-07-14 21:57:42.209452 :B20B5DD6:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-07-14 21:57:42.209452 :B20B5DD7:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-14 21:57:42.209453 :B20B5DD8:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-14 21:57:42.209951 :B20B5DD9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-14 21:57:42.209999 :B20B5DDF:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-14 21:57:42.214205 :B20B5DEE:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:kelt.c:517 2025-07-14 21:57:42.214247 :B20B5DEF:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:kelt.c:517 2025-07-14 21:57:42.214513 :B20B5DF0:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:kelt.c:517 2025-07-14 21:57:42.214529 :B20B5DF1:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:kelt.c:517 2025-07-14 21:57:42.214745 :B20B5DF2:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:kelt.c:517 2025-07-14 21:57:42.214759 :B20B5DF3:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:kelt.c:517 2025-07-14 21:57:42.214968 :B20B5DF4:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:kelt.c:517 2025-07-14 21:57:42.214987 :B20B5DF5:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:kelt.c:517 2025-07-14 21:57:42.215258 :B20B5DF6:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:kelt.c:517 2025-07-14 21:57:42.215270 :B20B5DF7:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:kelt.c:517 2025-07-14 21:57:42.215477 :B20B5DF8:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:kelt.c:517 2025-07-14 21:57:42.215490 :B20B5DF9:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:kelt.c:517 2025-07-14 21:57:42.217826 :B20B5DFA:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-14 21:57:43.541020 :B20B5E88:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-14 21:57:43.532 2025-07-14 21:57:43.541022 :B20B5E89:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=9728 pso_num=24 pso_serial#=184 2025-07-14 21:57:43.541164 :B20B5E8A:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=9728 (legacy spawn) 2025-07-14 21:57:43.547705 :B20B5E8B: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-07-14 21:57:43.547906 :B20B5E94: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-07-14 21:57:43.548785 :B20B5E95:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-14 21:57:44.388168 :B20B5EA5:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-14 21:57:44.375 2025-07-14 21:57:44.388170 :B20B5EA6:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=11012 pso_num=24 pso_serial#=185 2025-07-14 21:57:44.388307 :B20B5EA7:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=11012 (legacy spawn) 2025-07-14 21:57:44.394772 :B20B5EA8: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-07-14 21:57:44.394944 :B20B5EB1: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-07-14 21:57:44.395771 :B20B5EB2:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-14 21:57:44.404348 :B20B5EB5:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-14 21:57:44.390 2025-07-14 21:57:44.404350 :B20B5EB6:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=17996 pso_num=24 pso_serial#=186 2025-07-14 21:57:44.404489 :B20B5EB7:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=17996 (legacy spawn) 2025-07-14 21:57:44.423340 :B20B5EC4: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-07-14 21:57:44.423506 :B20B5ECD: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-07-14 21:57:44.424401 :B20B5ECE:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-14 21:57:48.476824 :B20B600D:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-14 21:57:48.468 2025-07-14 21:57:48.476826 :B20B600E:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=7000 pso_num=24 pso_serial#=187 2025-07-14 21:57:48.476966 :B20B600F:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=7000 (legacy spawn) 2025-07-14 21:57:48.483461 :B20B6010: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-07-14 21:57:48.483636 :B20B6015: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-07-14 21:57:48.484462 :B20B601A:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-14 21:58:04.032911 :B20B6518:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-14 21:58:04.027 2025-07-14 21:58:04.032913 :B20B6519:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=9724 pso_num=24 pso_serial#=188 2025-07-14 21:58:04.033054 :B20B651A:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=9724 osp_idx=22 osp_ver=570123 osp_pg=0 (spawn #385826) 2025-07-14 21:58:04.033055 :B20B651B:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-14 21:58:04.033055 :B20B651C:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=202 time=1211059923 2025-07-14 21:58:04.033056 :B20B651D:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-07-14 21:58:04.033056 :B20B651E:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-07-14 21:58:04.033056 :B20B651F:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-07-14 21:58:04.033056 :B20B6520:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-14 21:58:04.033057 :B20B6521:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-14 21:58:04.033564 :B20B6522: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-07-14 21:58:04.034217 :B20B6537: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-07-14 21:58:04.045263 :B20B6553:db_trace:kwqid.c@2146:kwqidrdq(): [10960:24:193] kwqidrdq: Error: 1403 occured in OCI execute 2025-07-14 21:58:04.045730 :B20B6554:db_trace:kwqid.c@2146:kwqidrdq(): [10960:24:193] kwqidrdq: Error: 1403 occured in OCI execute 2025-07-14 21:58:04.047986 :B20B6555:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-07-14 21:58:04.048381 :B20B6556: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-07-14 21:58:04.048417 :B20B6559:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-07-14 21:58:04.049316 :B20B655F: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-07-14 21:58:04.049452 :B20B6568: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-07-14 21:58:34.112983 :B20B6F0A:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-14 21:58:46.490219 :B20B72BF:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-14 21:58:46.476 2025-07-14 21:58:46.490222 :B20B72C0:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=14268 pso_num=24 pso_serial#=189 2025-07-14 21:58:46.490362 :B20B72C1:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=14268 (legacy spawn) 2025-07-14 21:58:46.496888 :B20B72C2: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-07-14 21:58:46.497091 :B20B72CB: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-07-14 21:58:46.497853 :B20B72CC:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-14 21:58:46.506039 :B20B72CF:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-14 21:58:46.491 2025-07-14 21:58:46.506041 :B20B72D0:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=15304 pso_num=24 pso_serial#=190 2025-07-14 21:58:46.506173 :B20B72D1:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=15304 (legacy spawn) 2025-07-14 21:58:46.512927 :B20B72D2: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-07-14 21:58:46.513096 :B20B72DB: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-07-14 21:58:46.513891 :B20B72DC:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-14 21:58:49.600097 :B20B73E8:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-14 21:58:49.587 2025-07-14 21:58:49.600099 :B20B73E9:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=17168 pso_num=24 pso_serial#=191 2025-07-14 21:58:49.600257 :B20B73EA:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=17168 (legacy spawn) 2025-07-14 21:58:49.606857 :B20B73F7: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-07-14 21:58:49.607029 :B20B7400: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-07-14 21:58:49.607834 :B20B7401:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-14 21:58:49.616528 :B20B7404:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-14 21:58:49.602 2025-07-14 21:58:49.616530 :B20B7405:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=18400 pso_num=24 pso_serial#=192 2025-07-14 21:58:49.616664 :B20B7406:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=18400 (legacy spawn) 2025-07-14 21:58:49.623114 :B20B7407: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-07-14 21:58:49.623273 :B20B7410: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-07-14 21:58:49.624072 :B20B7411:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-14 21:58:50.641816 :B20B7420:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-14 21:58:50.634 2025-07-14 21:58:50.641818 :B20B7421:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=9112 pso_num=24 pso_serial#=193 2025-07-14 21:58:50.641950 :B20B7422:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=9112 (legacy spawn) 2025-07-14 21:58:50.648380 :B20B7423: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-07-14 21:58:50.648562 :B20B7428: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-07-14 21:58:50.649412 :B20B742D:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-14 21:58:51.736108 :B20B7488:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-14 21:58:51.727 2025-07-14 21:58:51.736111 :B20B7489:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=11764 pso_num=24 pso_serial#=194 2025-07-14 21:58:51.736247 :B20B748A:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=11764 (legacy spawn) 2025-07-14 21:58:51.742665 :B20B748B: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-07-14 21:58:51.742849 :B20B7490: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-07-14 21:58:51.743645 :B20B7495:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-14 21:59:04.149573 :B20B7893:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-14 21:59:04.144 2025-07-14 21:59:04.149575 :B20B7894:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=1812 pso_num=24 pso_serial#=195 2025-07-14 21:59:04.149708 :B20B7895:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=1812 osp_idx=22 osp_ver=570130 osp_pg=0 (spawn #385828) 2025-07-14 21:59:04.149709 :B20B7896:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-14 21:59:04.149709 :B20B7897:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=203 time=1211120048 2025-07-14 21:59:04.149710 :B20B7898:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-07-14 21:59:04.149710 :B20B7899:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-07-14 21:59:04.149710 :B20B789A:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-07-14 21:59:04.149711 :B20B789B:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-14 21:59:04.149711 :B20B789C:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-14 21:59:04.150199 :B20B789D: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-07-14 21:59:04.150898 :B20B78B2: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-07-14 21:59:04.158346 :B20B78CE:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-07-14 21:59:04.158702 :B20B78CF: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-07-14 21:59:04.158738 :B20B78D2:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-07-14 21:59:04.159665 :B20B78D8: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-07-14 21:59:04.159791 :B20B78E1: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-07-14 21:59:34.267057 :B20B830A:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-14 21:59:52.849303 :B20B88C8:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-14 21:59:52.841 2025-07-14 21:59:52.849305 :B20B88C9:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=17976 pso_num=24 pso_serial#=196 2025-07-14 21:59:52.849435 :B20B88CA:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=17976 (legacy spawn) 2025-07-14 21:59:52.855902 :B20B88CB: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-07-14 21:59:52.856076 :B20B88D4: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-07-14 21:59:52.856942 :B20B88D5:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-14 21:59:53.333479 :B20B88D8:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-14 21:59:53.326 2025-07-14 21:59:53.333482 :B20B88D9:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=18108 pso_num=24 pso_serial#=197 2025-07-14 21:59:53.333624 :B20B88DA:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=18108 (legacy spawn) 2025-07-14 21:59:53.340060 :B20B88DB: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-07-14 21:59:53.340223 :B20B88E4: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-07-14 21:59:53.341052 :B20B88E5:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-14 21:59:59.109716 :B20B8AB3:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-14 21:59:59.095 2025-07-14 21:59:59.109718 :B20B8AB4:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=2680 pso_num=24 pso_serial#=198 2025-07-14 21:59:59.109852 :B20B8AB5:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=2680 (legacy spawn) 2025-07-14 21:59:59.116340 :B20B8AB6: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-07-14 21:59:59.116509 :B20B8ABF: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-07-14 21:59:59.117351 :B20B8AC0:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-14 21:59:59.463633 :B20B8AD0:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-14 21:59:59.454 2025-07-14 21:59:59.463635 :B20B8AD1:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=9008 pso_num=24 pso_serial#=199 2025-07-14 21:59:59.463770 :B20B8AD2:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=9008 (legacy spawn) 2025-07-14 21:59:59.470242 :B20B8AD3: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-07-14 21:59:59.470426 :B20B8ADC: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-07-14 21:59:59.471324 :B20B8ADD:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-14 22:00:00.024240 :B20B8B04:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-14 22:00:00.017 2025-07-14 22:00:00.024242 :B20B8B05:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=17756 pso_num=24 pso_serial#=200 2025-07-14 22:00:00.024358 :B20B8B06:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=17756 osp_idx=22 osp_ver=570135 osp_pg=0 (spawn #385830) 2025-07-14 22:00:00.024359 :B20B8B07:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=3656 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-14 22:00:00.024359 :B20B8B08:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=204 time=1211175923 2025-07-14 22:00:00.024359 :B20B8B09:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-07-14 22:00:00.024360 :B20B8B0A:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-07-14 22:00:00.024360 :B20B8B0B:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-07-14 22:00:00.024360 :B20B8B0C:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-14 22:00:00.024361 :B20B8B0D:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-14 22:00:00.024433 :B20B8B0E: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-07-14 22:00:00.024440 :B20B8B0F: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: 17756, VKRM)