Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250611222406\orcl_j001_15496_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:36758M/63366M, Ph+PgF:43290M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 27 Windows thread id: 15496, image: ORACLE.EXE (J001) *** 2025-06-11 22:24:06.725 *** SESSION ID:(219.51813) 2025-06-11 22:24:06.725 *** 2025-06-11 22:24:06.725 Process diagnostic dump for ORACLE.EXE (J001), OS id=15496, pid: 27, proc_ser: 234, sid: 219, sess_ser: 51813 ------------------------------------------------------------------------------- current sql: client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 15496 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J001) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=8 seq_num=9 snap_id=1 wait times: snap=0.189748 sec, exc=0.189748 sec, total=0.189748 sec wait times: max=0.500000 sec, heur=4.178035 sec wait counts: calls=1 os=1 in_wait=1 iflags=0x5a8 Wait State: fixed_waits=0 flags=0x22 boundary=0x0000000000000000/-1 Session Wait History: elapsed time of 0.000012 sec since current wait 0: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=7 seq_num=8 snap_id=1 wait times: snap=0.500002 sec, exc=0.500002 sec, total=0.500002 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 sec of elapsed time 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=6 seq_num=7 snap_id=1 wait times: snap=0.499996 sec, exc=0.499996 sec, total=0.499996 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 2: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=5 seq_num=6 snap_id=1 wait times: snap=0.499993 sec, exc=0.499993 sec, total=0.499993 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000014 sec of elapsed time 3: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=4 seq_num=5 snap_id=1 wait times: snap=0.500124 sec, exc=0.500124 sec, total=0.500124 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000011 sec of elapsed time 4: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=3 seq_num=4 snap_id=1 wait times: snap=0.500001 sec, exc=0.500001 sec, total=0.500001 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 5: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=2 seq_num=3 snap_id=1 wait times: snap=0.499998 sec, exc=0.499998 sec, total=0.499998 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 sec of elapsed time 6: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=1 seq_num=2 snap_id=1 wait times: snap=0.499992 sec, exc=0.499992 sec, total=0.499992 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 7: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=0 seq_num=1 snap_id=1 wait times: snap=0.488102 sec, exc=0.488102 sec, total=0.488102 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000000 sec of elapsed time Sampled Session History of session 219 serial 51813 --------------------------------------------------- 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:24:02 - 22:24:06] idle wait at each sample [session created at: 22:24:02] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-06-11 22:24:06.725 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 27 (osid: 15496, J001) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-06-11 22:19:22.749104 :A36ECC53:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-11 22:19:22.749888 :A36ECC54:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-11 22:19:22.758469 :A36ECC57:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-11 22:19:22.744 2025-06-11 22:19:22.758471 :A36ECC58:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=12944 pso_num=27 pso_serial#=208 2025-06-11 22:19:22.758607 :A36ECC59:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=12944 (legacy spawn) 2025-06-11 22:19:22.765091 :A36ECC5A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:19:22.765266 :A36ECC63:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-11 22:19:22.766080 :A36ECC64:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-11 22:19:23.769181 :A36ECC89:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-11 22:19:23.760 2025-06-11 22:19:23.769183 :A36ECC8A:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=16292 pso_num=27 pso_serial#=209 2025-06-11 22:19:23.769324 :A36ECC8B:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=16292 (legacy spawn) 2025-06-11 22:19:23.775986 :A36ECC8C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:19:23.776150 :A36ECC91:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-11 22:19:23.776950 :A36ECC96:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-11 22:19:25.821704 :A36ECD5D:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-11 22:19:25.808 2025-06-11 22:19:25.821706 :A36ECD5E:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=2472 pso_num=27 pso_serial#=210 2025-06-11 22:19:25.821842 :A36ECD5F:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=2472 (legacy spawn) 2025-06-11 22:19:25.828280 :A36ECD60:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:19:25.828447 :A36ECD69:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-11 22:19:25.829238 :A36ECD6A:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-11 22:19:25.837833 :A36ECD6D:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-11 22:19:25.824 2025-06-11 22:19:25.837835 :A36ECD6E:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=10388 pso_num=27 pso_serial#=211 2025-06-11 22:19:25.837968 :A36ECD6F:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=10388 (legacy spawn) 2025-06-11 22:19:25.844401 :A36ECD70:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:19:25.844565 :A36ECD79:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-11 22:19:25.845334 :A36ECD7A:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-11 22:19:32.007267 :A36ECF60:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-11 22:19:31.998 2025-06-11 22:19:32.007270 :A36ECF61:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=11720 pso_num=27 pso_serial#=212 2025-06-11 22:19:32.007410 :A36ECF62:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=11720 (legacy spawn) 2025-06-11 22:19:32.013850 :A36ECF63:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:19:32.013880 :A36ECF66:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:19:32.014045 :A36ECF6C:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-11 22:19:32.014903 :A36ECF79:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-11 22:20:03.118647 :A36ED9F5:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-11 22:20:03.111 2025-06-11 22:20:03.118648 :A36ED9F6:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=14644 pso_num=27 pso_serial#=213 2025-06-11 22:20:03.118781 :A36ED9F7:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=14644 (legacy spawn) 2025-06-11 22:20:03.125285 :A36ED9F8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:20:03.125450 :A36ED9FD:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-11 22:20:03.126287 :A36EDA02:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-11 22:20:32.031304 :A36EE2D2:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-11 22:20:32.018 2025-06-11 22:20:32.031306 :A36EE2D3:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=15904 pso_num=27 pso_serial#=214 2025-06-11 22:20:32.031444 :A36EE2D4:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=15904 (legacy spawn) 2025-06-11 22:20:32.037883 :A36EE2D5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:20:32.038059 :A36EE2DD:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-11 22:20:32.038858 :A36EE2DF:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-11 22:21:05.310241 :A36EEDCF:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-11 22:21:05.302 2025-06-11 22:21:05.310243 :A36EEDD0:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=14912 pso_num=27 pso_serial#=215 2025-06-11 22:21:05.310426 :A36EEDD1:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=14912 (legacy spawn) 2025-06-11 22:21:05.316854 :A36EEDD2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:21:05.317028 :A36EEDD9:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-11 22:21:05.317888 :A36EEDDC:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-11 22:21:06.123154 :A36EEE15:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-11 22:21:06.114 2025-06-11 22:21:06.123156 :A36EEE16:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=16412 pso_num=27 pso_serial#=216 2025-06-11 22:21:06.123345 :A36EEE17:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=16412 (legacy spawn) 2025-06-11 22:21:06.129758 :A36EEE18:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:21:06.129953 :A36EEE21:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-11 22:21:06.130765 :A36EEE22:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-11 22:21:11.509107 :A36EEFC6:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-11 22:21:11.495 2025-06-11 22:21:11.509108 :A36EEFC7:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=9964 pso_num=27 pso_serial#=217 2025-06-11 22:21:11.509246 :A36EEFC8:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=9964 (legacy spawn) 2025-06-11 22:21:11.515718 :A36EEFC9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:21:11.515885 :A36EEFCE:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-11 22:21:11.516691 :A36EEFD3:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-11 22:21:11.525441 :A36EEFD6:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-11 22:21:11.510 2025-06-11 22:21:11.525443 :A36EEFD7:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=13784 pso_num=27 pso_serial#=218 2025-06-11 22:21:11.525580 :A36EEFD8:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=13784 (legacy spawn) 2025-06-11 22:21:11.532071 :A36EEFD9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:21:11.532241 :A36EEFE1:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-11 22:21:11.533076 :A36EEFE3:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-11 22:21:14.680608 :A36EF0D7:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-11 22:21:14.667 2025-06-11 22:21:14.680610 :A36EF0D8:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=16664 pso_num=27 pso_serial#=219 2025-06-11 22:21:14.680747 :A36EF0D9:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=16664 (legacy spawn) 2025-06-11 22:21:14.687180 :A36EF0DA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:21:14.687356 :A36EF0E3:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-11 22:21:14.688135 :A36EF0E4:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-11 22:21:14.696725 :A36EF0E7:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-11 22:21:14.683 2025-06-11 22:21:14.696729 :A36EF0E8:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=17200 pso_num=27 pso_serial#=220 2025-06-11 22:21:14.696863 :A36EF0E9:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=17200 (legacy spawn) 2025-06-11 22:21:14.703310 :A36EF0F6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:21:14.703470 :A36EF0FF:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-11 22:21:14.704261 :A36EF100:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-11 22:22:07.446038 :A36F0392:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-11 22:22:07.437 2025-06-11 22:22:07.446040 :A36F0393:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=17276 pso_num=27 pso_serial#=221 2025-06-11 22:22:07.446182 :A36F0394:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=17276 (legacy spawn) 2025-06-11 22:22:07.452915 :A36F0395:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:22:07.453086 :A36F039E:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-11 22:22:07.454006 :A36F039F:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-11 22:22:14.224543 :A36F05B4:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-11 22:22:14.216 2025-06-11 22:22:14.224545 :A36F05B5:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=15840 pso_num=27 pso_serial#=222 2025-06-11 22:22:14.224693 :A36F05B6:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=15840 (legacy spawn) 2025-06-11 22:22:14.231202 :A36F05B7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:22:14.231379 :A36F05C0:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-11 22:22:14.232198 :A36F05C1:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-11 22:22:24.315819 :A36F08D0:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-11 22:22:24.313 2025-06-11 22:22:24.315821 :A36F08D1:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=16604 pso_num=27 pso_serial#=223 2025-06-11 22:22:24.315961 :A36F08D2:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=16604 (legacy spawn) 2025-06-11 22:22:24.322330 :A36F08D3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:22:24.322510 :A36F08D8:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-11 22:22:24.323294 :A36F08DD:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-11 22:22:24.332030 :A36F08E0:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-11 22:22:24.328 2025-06-11 22:22:24.332032 :A36F08E1:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=15512 pso_num=27 pso_serial#=224 2025-06-11 22:22:24.332166 :A36F08E2:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=15512 (legacy spawn) 2025-06-11 22:22:24.338604 :A36F08E3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:22:24.338766 :A36F08EC:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-11 22:22:24.339542 :A36F08ED:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-11 22:22:27.614151 :A36F09FE:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-11 22:22:27.601 2025-06-11 22:22:27.614153 :A36F09FF:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=9092 pso_num=27 pso_serial#=225 2025-06-11 22:22:27.614287 :A36F0A00:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=9092 (legacy spawn) 2025-06-11 22:22:27.620816 :A36F0A01:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:22:27.620991 :A36F0A09:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-11 22:22:27.621794 :A36F0A0B:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-11 22:22:27.630837 :A36F0A0E:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-11 22:22:27.617 2025-06-11 22:22:27.630839 :A36F0A0F:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=14844 pso_num=27 pso_serial#=226 2025-06-11 22:22:27.630990 :A36F0A10:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=14844 (legacy spawn) 2025-06-11 22:22:27.637695 :A36F0A11:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:22:27.637876 :A36F0A1A:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-11 22:22:27.638764 :A36F0A1B:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-11 22:22:38.529369 :A36F0D7E:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-11 22:22:38.521 2025-06-11 22:22:38.529371 :A36F0D7F:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=15620 pso_num=27 pso_serial#=227 2025-06-11 22:22:38.529501 :A36F0D80:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=15620 (legacy spawn) 2025-06-11 22:22:38.535986 :A36F0D81:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:22:38.536156 :A36F0D8A:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-11 22:22:38.536992 :A36F0D8B:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-11 22:22:46.390276 :A36F0FFE:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-11 22:22:46.385 2025-06-11 22:22:46.390278 :A36F0FFF:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=15776 pso_num=27 pso_serial#=228 2025-06-11 22:22:46.390412 :A36F1000:db_trace:kso.c@4093:ksonfy(): [10420:27:0] kso: new process: pid=15776 osp_idx=25 osp_ver=58622 osp_pg=0 (spawn #275868) 2025-06-11 22:22:46.390413 :A36F1001:db_trace:kso.c@4099:ksonfy(): [10420:27:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-11 22:22:46.390413 :A36F1002:db_trace:kso.c@4103:ksonfy(): [10420:27:0] kso: new process: pso_index=27 reservation=149 time=2656309579 2025-06-11 22:22:46.390414 :A36F1003:db_trace:kso.c@4109:ksonfy(): [10420:27:0] kso: spawn diagnostics: queue time=0 secs 2025-06-11 22:22:46.390414 :A36F1004:db_trace:kso.c@4111:ksonfy(): [10420:27:0] kso: spawn diagnostics: fork time=0 secs 2025-06-11 22:22:46.390415 :A36F1005:db_trace:kso.c@4113:ksonfy(): [10420:27:0] kso: spawn diagnostics: exec time=0 secs 2025-06-11 22:22:46.390415 :A36F1006:db_trace:kso.c@4115:ksonfy(): [10420:27:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-11 22:22:46.390415 :A36F1007:db_trace:kso.c@4117:ksonfy(): [10420:27:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-11 22:22:46.390907 :A36F1008:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-11 22:22:46.390952 :A36F100E:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-11 22:22:46.410898 :A36F1038:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-11 22:22:48.523204 :A36F10D3:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-11 22:22:48.515 2025-06-11 22:22:48.523207 :A36F10D4:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=16492 pso_num=27 pso_serial#=229 2025-06-11 22:22:48.523342 :A36F10D5:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=16492 (legacy spawn) 2025-06-11 22:22:48.529729 :A36F10D6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:22:48.529944 :A36F10DB:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-11 22:22:48.530736 :A36F10E0:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-11 22:23:04.005656 :A36F163A:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-11 22:23:03.992 2025-06-11 22:23:04.005658 :A36F163B:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=16196 pso_num=27 pso_serial#=230 2025-06-11 22:23:04.005791 :A36F163C:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=16196 (legacy spawn) 2025-06-11 22:23:04.012273 :A36F163D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:23:04.012447 :A36F1642:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-11 22:23:04.013241 :A36F1647:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-11 22:23:04.021920 :A36F164A:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-11 22:23:04.008 2025-06-11 22:23:04.021922 :A36F164B:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=16420 pso_num=27 pso_serial#=231 2025-06-11 22:23:04.022062 :A36F164C:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=16420 (legacy spawn) 2025-06-11 22:23:04.028522 :A36F164D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:23:04.028553 :A36F1650:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:23:04.028690 :A36F1657:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-11 22:23:04.029487 :A36F1664:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-11 22:23:09.608924 :A36F1820:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-11 22:23:09.601 2025-06-11 22:23:09.608926 :A36F1821:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=10512 pso_num=27 pso_serial#=232 2025-06-11 22:23:09.609072 :A36F1822:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=10512 (legacy spawn) 2025-06-11 22:23:09.633468 :A36F1823:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:23:09.633638 :A36F1828:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-11 22:23:09.634532 :A36F182D:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-11 22:23:22.544153 :A36F1C35:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-11 22:23:22.531 2025-06-11 22:23:22.544155 :A36F1C36:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=15688 pso_num=27 pso_serial#=233 2025-06-11 22:23:22.544296 :A36F1C37:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=15688 (legacy spawn) 2025-06-11 22:23:22.550770 :A36F1C38:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:23:22.550948 :A36F1C3D:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-11 22:23:22.551747 :A36F1C42:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-11 22:24:02.547953 :A36F5E95:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-11 22:24:02.537 2025-06-11 22:24:02.547955 :A36F5E96:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=15496 pso_num=27 pso_serial#=234 2025-06-11 22:24:02.548076 :A36F5E97:db_trace:kso.c@4093:ksonfy(): [10420:27:0] kso: new process: pid=15496 osp_idx=25 osp_ver=58628 osp_pg=0 (spawn #275873) 2025-06-11 22:24:02.548076 :A36F5E98:db_trace:kso.c@4099:ksonfy(): [10420:27:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-11 22:24:02.548077 :A36F5E99:db_trace:kso.c@4103:ksonfy(): [10420:27:0] kso: new process: pso_index=27 reservation=150 time=2656385735 2025-06-11 22:24:02.548077 :A36F5E9A:db_trace:kso.c@4109:ksonfy(): [10420:27:0] kso: spawn diagnostics: queue time=0 secs 2025-06-11 22:24:02.548078 :A36F5E9B:db_trace:kso.c@4111:ksonfy(): [10420:27:0] kso: spawn diagnostics: fork time=0 secs 2025-06-11 22:24:02.548079 :A36F5E9C:db_trace:kso.c@4113:ksonfy(): [10420:27:0] kso: spawn diagnostics: exec time=0 secs 2025-06-11 22:24:02.548079 :A36F5E9D:db_trace:kso.c@4115:ksonfy(): [10420:27:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-11 22:24:02.548079 :A36F5E9E:db_trace:kso.c@4117:ksonfy(): [10420:27:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-11 22:24:02.548561 :A36F5E9F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 27 (osid: 15496, J001)