Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250502220005\orcl_vkrm_11920_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:37578M/63366M, Ph+PgF:45122M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 26 Windows thread id: 11920, image: ORACLE.EXE (VKRM) *** 2025-05-02 22:00:05.484 *** SESSION ID:(209.20435) 2025-05-02 22:00:05.484 *** 2025-05-02 22:00:05.484 Process diagnostic dump for ORACLE.EXE (VKRM), OS id=11920, pid: 26, proc_ser: 76, sid: 209, sess_ser: 20435 ------------------------------------------------------------------------------- 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=5.469856 sec, exc=5.469856 sec, total=5.469856 sec wait times: max=infinite, heur=5.469856 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 209 serial 20435 --------------------------------------------------- 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 --------------------------------------------------- [6 samples, 22:00:00 - 22:00:05] 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-02 22:00:05.484 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 26 (osid: 11920, VKRM) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-02 21:55:11.239107 :91D7D47F:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=10368 (legacy spawn) 2025-05-02 21:55:11.245713 :91D7D480:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 21:55:11.245880 :91D7D485:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-02 21:55:11.246691 :91D7D48A:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-02 21:55:16.412499 :91D7D61A:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-02 21:55:16.398 2025-05-02 21:55:16.412501 :91D7D61B:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=11332 pso_num=26 pso_serial#=50 2025-05-02 21:55:16.412635 :91D7D61C:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=11332 (legacy spawn) 2025-05-02 21:55:16.419122 :91D7D61D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 21:55:16.419310 :91D7D622:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-02 21:55:16.420168 :91D7D627:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-02 21:55:16.428871 :91D7D62A:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-02 21:55:16.413 2025-05-02 21:55:16.428873 :91D7D62B:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=11952 pso_num=26 pso_serial#=51 2025-05-02 21:55:16.429007 :91D7D62C:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=11952 (legacy spawn) 2025-05-02 21:55:16.435494 :91D7D62D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 21:55:16.435654 :91D7D636:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-02 21:55:16.436465 :91D7D637:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-02 21:55:19.614575 :91D7D739:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-02 21:55:19.601 2025-05-02 21:55:19.614577 :91D7D73A:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=10608 pso_num=26 pso_serial#=52 2025-05-02 21:55:19.614717 :91D7D73B:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=10608 (legacy spawn) 2025-05-02 21:55:19.621210 :91D7D73C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 21:55:19.621380 :91D7D745:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-02 21:55:19.622178 :91D7D746:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-02 21:55:19.641188 :91D7D749:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-02 21:55:19.632 2025-05-02 21:55:19.641190 :91D7D74A:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=9756 pso_num=26 pso_serial#=53 2025-05-02 21:55:19.641328 :91D7D74B:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=9756 (legacy spawn) 2025-05-02 21:55:19.647764 :91D7D74C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 21:55:19.647946 :91D7D755:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-02 21:55:19.648804 :91D7D756:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-02 21:55:56.307051 :91D7E3F4:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-02 21:55:56.294 2025-05-02 21:55:56.307053 :91D7E3F5:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=11376 pso_num=26 pso_serial#=54 2025-05-02 21:55:56.307191 :91D7E3F6:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=11376 (legacy spawn) 2025-05-02 21:55:56.313631 :91D7E3F7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 21:55:56.313808 :91D7E3FC:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-02 21:55:56.314613 :91D7E401:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-02 21:55:56.333969 :91D7E404:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-02 21:55:56.325 2025-05-02 21:55:56.333971 :91D7E405:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12064 pso_num=26 pso_serial#=55 2025-05-02 21:55:56.334105 :91D7E406:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=12064 (legacy spawn) 2025-05-02 21:55:56.340503 :91D7E407:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 21:55:56.340675 :91D7E40F:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-02 21:55:56.341384 :91D7E411:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-02 21:55:59.457144 :91D7E5A8:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-02 21:55:59.452 2025-05-02 21:55:59.457146 :91D7E5A9:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12200 pso_num=26 pso_serial#=56 2025-05-02 21:55:59.457275 :91D7E5AA:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=12200 osp_idx=24 osp_ver=205840 osp_pg=0 (spawn #141914) 2025-05-02 21:55:59.457275 :91D7E5AB:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-02 21:55:59.457276 :91D7E5AC:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=56 time=3493748937 2025-05-02 21:55:59.457276 :91D7E5AD:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-02 21:55:59.457277 :91D7E5AE:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-02 21:55:59.457277 :91D7E5AF:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-02 21:55:59.457277 :91D7E5B0:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-02 21:55:59.457278 :91D7E5B1:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-02 21:55:59.457767 :91D7E5B2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-02 21:55:59.457810 :91D7E5B8:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-05-02 21:55:59.477680 :91D7E625:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-02 21:56:19.372074 :91D7EC1A:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-02 21:56:19.363 2025-05-02 21:56:19.372076 :91D7EC1B:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=9868 pso_num=26 pso_serial#=57 2025-05-02 21:56:19.372210 :91D7EC1C:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=9868 (legacy spawn) 2025-05-02 21:56:19.378664 :91D7EC1D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 21:56:19.378832 :91D7EC22:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-02 21:56:19.379627 :91D7EC27:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-02 21:56:59.204531 :91D7F93A:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-02 21:56:59.191 2025-05-02 21:56:59.204534 :91D7F93B:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=10528 pso_num=26 pso_serial#=58 2025-05-02 21:56:59.204677 :91D7F93C:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=10528 (legacy spawn) 2025-05-02 21:56:59.211185 :91D7F93D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 21:56:59.211358 :91D7F946:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-02 21:56:59.212149 :91D7F947:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-02 21:56:59.220974 :91D7F94A:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-02 21:56:59.207 2025-05-02 21:56:59.220976 :91D7F94B:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=7484 pso_num=26 pso_serial#=59 2025-05-02 21:56:59.221115 :91D7F94C:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=7484 (legacy spawn) 2025-05-02 21:56:59.227684 :91D7F94D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 21:56:59.227848 :91D7F956:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-02 21:56:59.228686 :91D7F957:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-02 21:57:00.903411 :91D7F9D2:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-02 21:57:00.895 2025-05-02 21:57:00.903414 :91D7F9D3:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=10700 pso_num=26 pso_serial#=60 2025-05-02 21:57:00.903548 :91D7F9D4:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=10700 (legacy spawn) 2025-05-02 21:57:00.910257 :91D7F9D5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 21:57:00.910429 :91D7F9DA:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-02 21:57:00.911306 :91D7F9DF:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-02 21:57:03.576158 :91D7FAC7:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-02 21:57:03.568 2025-05-02 21:57:03.576161 :91D7FAC8:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12136 pso_num=26 pso_serial#=61 2025-05-02 21:57:03.576295 :91D7FAC9:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=12136 (legacy spawn) 2025-05-02 21:57:03.582720 :91D7FACA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 21:57:03.582903 :91D7FACF:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-02 21:57:03.583715 :91D7FAD4:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-02 21:57:05.722707 :91D7FB87:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-02 21:57:05.710 2025-05-02 21:57:05.722709 :91D7FB88:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12176 pso_num=26 pso_serial#=62 2025-05-02 21:57:05.722840 :91D7FB89:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=12176 (legacy spawn) 2025-05-02 21:57:05.729404 :91D7FB8A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 21:57:05.729570 :91D7FB8F:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-02 21:57:05.730345 :91D7FB94:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-02 21:57:05.739055 :91D7FB97:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-02 21:57:05.726 2025-05-02 21:57:05.739058 :91D7FB98:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=11876 pso_num=26 pso_serial#=63 2025-05-02 21:57:05.739198 :91D7FB99:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=11876 (legacy spawn) 2025-05-02 21:57:05.745679 :91D7FB9A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 21:57:05.745846 :91D7FBA3:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-02 21:57:05.746645 :91D7FBA4:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-02 21:57:08.822359 :91D7FC96:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-02 21:57:08.809 2025-05-02 21:57:08.822361 :91D7FC97:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=11416 pso_num=26 pso_serial#=64 2025-05-02 21:57:08.822495 :91D7FC98:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=11416 (legacy spawn) 2025-05-02 21:57:08.828952 :91D7FC99:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 21:57:08.829137 :91D7FCA2:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-02 21:57:08.829957 :91D7FCA3:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-02 21:57:08.838578 :91D7FCA6:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-02 21:57:08.825 2025-05-02 21:57:08.838580 :91D7FCA7:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12088 pso_num=26 pso_serial#=65 2025-05-02 21:57:08.838719 :91D7FCA8:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=12088 (legacy spawn) 2025-05-02 21:57:08.845446 :91D7FCA9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 21:57:08.845621 :91D7FCB2:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-02 21:57:08.846479 :91D7FCB3:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-02 21:58:01.738024 :91D80DA5:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-02 21:58:01.729 2025-05-02 21:58:01.738026 :91D80DA6:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=10636 pso_num=26 pso_serial#=66 2025-05-02 21:58:01.738167 :91D80DA7:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=10636 (legacy spawn) 2025-05-02 21:58:01.744756 :91D80DA8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 21:58:01.744946 :91D80DAD:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-02 21:58:01.745813 :91D80DB2:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-02 21:58:05.747168 :91D80EE2:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-02 21:58:05.738 2025-05-02 21:58:05.747170 :91D80EE3:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=11652 pso_num=26 pso_serial#=67 2025-05-02 21:58:05.747308 :91D80EE4:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=11652 (legacy spawn) 2025-05-02 21:58:05.753779 :91D80EE5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 21:58:05.753949 :91D80EED:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-02 21:58:05.754388 :91D80F02:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-02 21:58:18.121139 :91D812D3:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-02 21:58:18.107 2025-05-02 21:58:18.121141 :91D812D4:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=8644 pso_num=26 pso_serial#=68 2025-05-02 21:58:18.121328 :91D812D5:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=8644 (legacy spawn) 2025-05-02 21:58:18.127717 :91D812D6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 21:58:18.127886 :91D812DF:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-02 21:58:18.128717 :91D812E0:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-02 21:58:18.137351 :91D812E3:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-02 21:58:18.122 2025-05-02 21:58:18.137353 :91D812E4:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=11844 pso_num=26 pso_serial#=69 2025-05-02 21:58:18.137488 :91D812E5:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=11844 (legacy spawn) 2025-05-02 21:58:18.143882 :91D812E6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 21:58:18.144047 :91D812EE:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-02 21:58:18.144839 :91D812F0:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-02 21:58:21.208070 :91D813E4:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-02 21:58:21.195 2025-05-02 21:58:21.208071 :91D813E5:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12156 pso_num=26 pso_serial#=70 2025-05-02 21:58:21.208211 :91D813E6:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=12156 (legacy spawn) 2025-05-02 21:58:21.214614 :91D813E7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 21:58:21.214794 :91D813EF:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-02 21:58:21.215593 :91D813F1:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-02 21:58:21.224172 :91D813F4:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-02 21:58:21.211 2025-05-02 21:58:21.224174 :91D813F5:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=10068 pso_num=26 pso_serial#=71 2025-05-02 21:58:21.224310 :91D813F6:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=10068 (legacy spawn) 2025-05-02 21:58:21.230790 :91D81420:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 21:58:21.230962 :91D81429:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-02 21:58:21.231756 :91D8142A:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-02 21:58:57.527085 :91D81FF9:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-02 21:58:57.514 2025-05-02 21:58:57.527087 :91D81FFA:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=2956 pso_num=26 pso_serial#=72 2025-05-02 21:58:57.527220 :91D81FFB:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=2956 (legacy spawn) 2025-05-02 21:58:57.533656 :91D81FFC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 21:58:57.533822 :91D82001:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-02 21:58:57.534614 :91D82006:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-02 21:58:57.543184 :91D82009:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-02 21:58:57.530 2025-05-02 21:58:57.543186 :91D8200A:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=2828 pso_num=26 pso_serial#=73 2025-05-02 21:58:57.543320 :91D8200B:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=2828 (legacy spawn) 2025-05-02 21:58:57.549787 :91D8200C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 21:58:57.549960 :91D82015:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-02 21:58:57.550774 :91D82016:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-02 21:59:07.916569 :91D8233A:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-02 21:59:07.908 2025-05-02 21:59:07.916571 :91D8233B:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=9832 pso_num=26 pso_serial#=74 2025-05-02 21:59:07.916704 :91D8233C:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=9832 (legacy spawn) 2025-05-02 21:59:07.923135 :91D8233D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 21:59:07.923311 :91D82342:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-02 21:59:07.924098 :91D82347:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-02 21:59:09.755140 :91D823F6:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-02 21:59:09.746 2025-05-02 21:59:09.755142 :91D823F7:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=9940 pso_num=26 pso_serial#=75 2025-05-02 21:59:09.755291 :91D823F8:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=9940 (legacy spawn) 2025-05-02 21:59:09.761803 :91D823F9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-02 21:59:09.761972 :91D82401:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-02 21:59:09.762764 :91D82403:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-02 22:00:00.023746 :91D8347D:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-02 22:00:00.016 2025-05-02 22:00:00.023748 :91D8347E:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=11920 pso_num=26 pso_serial#=76 2025-05-02 22:00:00.023858 :91D8347F:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=11920 osp_idx=24 osp_ver=205860 osp_pg=0 (spawn #141925) 2025-05-02 22:00:00.023859 :91D83480:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=3656 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-02 22:00:00.023859 :91D83481:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=57 time=3493989500 2025-05-02 22:00:00.023860 :91D83482:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-02 22:00:00.023861 :91D83483:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-02 22:00:00.023862 :91D83484:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-02 22:00:00.023862 :91D83485:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-02 22:00:00.023862 :91D83486:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-02 22:00:00.023937 :91D83487:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:0] KSL POST SENT postee=6 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-02 22:00:00.023943 :91D83488:db_trace:kso.c@5554:kso_spawn_diag_end(): [10420:26:0] kso: spawn diagnostics: init time=0 secs ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 26 (osid: 11920, VKRM)