Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250805082851\orcl_j001_19616_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:35714M/63366M, Ph+PgF:41261M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 27 Windows thread id: 19616, image: ORACLE.EXE (J001) *** 2025-08-05 08:28:51.906 *** SESSION ID:(219.58157) 2025-08-05 08:28:51.906 *** 2025-08-05 08:28:51.906 Process diagnostic dump for ORACLE.EXE (J001), OS id=19616, pid: 27, proc_ser: 113, sid: 219, sess_ser: 58157 ------------------------------------------------------------------------------- current sql: client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 19616 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J001) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=5 seq_num=6 snap_id=1 wait times: snap=0.478888 sec, exc=0.478888 sec, total=0.478888 sec wait times: max=0.500000 sec, heur=2.976821 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.000009 sec since current wait 0: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=4 seq_num=5 snap_id=1 wait times: snap=0.510094 sec, exc=0.510094 sec, total=0.510094 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=3 seq_num=4 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.000013 sec of elapsed time 2: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=2 seq_num=3 snap_id=1 wait times: snap=0.499987 sec, exc=0.499987 sec, total=0.499987 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000012 sec of elapsed time 3: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=1 seq_num=2 snap_id=1 wait times: snap=0.500005 sec, exc=0.500005 sec, total=0.500005 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 sec of elapsed time 4: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=0 seq_num=1 snap_id=1 wait times: snap=0.487803 sec, exc=0.487803 sec, total=0.487803 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 58157 --------------------------------------------------- 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 --------------------------------------------------- [3 samples, 08:28:48 - 08:28:51] idle wait at each sample [session created at: 08:28:48] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-08-05 08:28:51.922 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 27 (osid: 19616, J001) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-08-05 08:24:03.997539 :BB96D125:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=16948 (legacy spawn) 2025-08-05 08:24:04.004072 :BB96D126: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-08-05 08:24:04.004243 :BB96D12F: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-08-05 08:24:04.005083 :BB96D130:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-05 08:24:17.120609 :BB96D503:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-05 08:24:17.112 2025-08-05 08:24:17.120611 :BB96D504:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=16984 pso_num=27 pso_serial#=86 2025-08-05 08:24:17.120768 :BB96D505:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=16984 (legacy spawn) 2025-08-05 08:24:17.127193 :BB96D506: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-08-05 08:24:17.127363 :BB96D50B: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-08-05 08:24:17.128393 :BB96D510:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-05 08:25:01.237134 :BB96E4BE:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-05 08:25:01.228 2025-08-05 08:25:01.237136 :BB96E4BF:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=15644 pso_num=27 pso_serial#=87 2025-08-05 08:25:01.237269 :BB96E4C0:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=15644 (legacy spawn) 2025-08-05 08:25:01.243681 :BB96E4C1: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-08-05 08:25:01.243859 :BB96E4C6: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-08-05 08:25:01.244652 :BB96E4CB:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-05 08:25:13.690865 :BB96E899:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-05 08:25:13.677 2025-08-05 08:25:13.690867 :BB96E89A:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=1852 pso_num=27 pso_serial#=88 2025-08-05 08:25:13.691010 :BB96E89B:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=1852 (legacy spawn) 2025-08-05 08:25:13.697466 :BB96E89C: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-08-05 08:25:13.697641 :BB96E8A1: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-08-05 08:25:13.698458 :BB96E8A6:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-05 08:25:13.707093 :BB96E8A9:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-05 08:25:13.692 2025-08-05 08:25:13.707095 :BB96E8AA:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=4148 pso_num=27 pso_serial#=89 2025-08-05 08:25:13.707235 :BB96E8AB:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=4148 (legacy spawn) 2025-08-05 08:25:13.713693 :BB96E8AC: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-08-05 08:25:13.713862 :BB96E8B5: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-08-05 08:25:13.714713 :BB96E8B6:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-05 08:25:16.730597 :BB96E9AC:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-05 08:25:16.718 2025-08-05 08:25:16.730599 :BB96E9AD:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=17692 pso_num=27 pso_serial#=90 2025-08-05 08:25:16.730738 :BB96E9AE:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=17692 (legacy spawn) 2025-08-05 08:25:16.737165 :BB96E9AF: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-08-05 08:25:16.737346 :BB96E9B4: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-08-05 08:25:16.738128 :BB96E9B9:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-05 08:25:16.746725 :BB96E9BC:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-05 08:25:16.734 2025-08-05 08:25:16.746727 :BB96E9BD:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=19636 pso_num=27 pso_serial#=91 2025-08-05 08:25:16.746862 :BB96E9BE:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=19636 (legacy spawn) 2025-08-05 08:25:16.753337 :BB96E9BF: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-08-05 08:25:16.753500 :BB96E9C8: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-08-05 08:25:16.754304 :BB96E9C9:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-05 08:25:49.984435 :BB96F484:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-05 08:25:49.970 2025-08-05 08:25:49.984437 :BB96F485:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=11764 pso_num=27 pso_serial#=92 2025-08-05 08:25:49.984581 :BB96F486:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=11764 (legacy spawn) 2025-08-05 08:25:49.991076 :BB96F487: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-08-05 08:25:49.991248 :BB96F48C: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-08-05 08:25:49.992048 :BB96F491:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-05 08:25:50.000762 :BB96F494:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-05 08:25:49.985 2025-08-05 08:25:50.000763 :BB96F495:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=13480 pso_num=27 pso_serial#=93 2025-08-05 08:25:50.000903 :BB96F496:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=13480 (legacy spawn) 2025-08-05 08:25:50.007409 :BB96F497: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-08-05 08:25:50.007572 :BB96F4A0: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-08-05 08:25:50.008383 :BB96F4A1:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-05 08:25:50.634584 :BB96F4CE:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-05 08:25:50.626 2025-08-05 08:25:50.634586 :BB96F4CF:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=18636 pso_num=27 pso_serial#=94 2025-08-05 08:25:50.634724 :BB96F4D0:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=18636 (legacy spawn) 2025-08-05 08:25:50.641259 :BB96F4D1: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-08-05 08:25:50.641442 :BB96F4D9: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-08-05 08:25:50.642289 :BB96F4DB:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-05 08:25:53.175243 :BB96F5AF:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-05 08:25:53.162 2025-08-05 08:25:53.175245 :BB96F5B0:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=14012 pso_num=27 pso_serial#=95 2025-08-05 08:25:53.175390 :BB96F5B1:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=14012 (legacy spawn) 2025-08-05 08:25:53.181950 :BB96F5B2: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-08-05 08:25:53.182133 :BB96F5B7: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-08-05 08:25:53.182973 :BB96F5BC:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-05 08:25:53.201758 :BB96F5BF:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-05 08:25:53.193 2025-08-05 08:25:53.201760 :BB96F5C0:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=17124 pso_num=27 pso_serial#=96 2025-08-05 08:25:53.201899 :BB96F5C1:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=17124 (legacy spawn) 2025-08-05 08:25:53.208393 :BB96F5C2: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-08-05 08:25:53.208558 :BB96F5CB: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-08-05 08:25:53.209378 :BB96F5CC:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-05 08:26:00.147938 :BB96F84C:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-05 08:26:00.140 2025-08-05 08:26:00.147940 :BB96F84D:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=20004 pso_num=27 pso_serial#=97 2025-08-05 08:26:00.148074 :BB96F84E:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=20004 (legacy spawn) 2025-08-05 08:26:00.154488 :BB96F84F: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-08-05 08:26:00.154666 :BB96F858: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-08-05 08:26:00.155465 :BB96F859:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-05 08:26:09.512578 :BB96FB3D:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-05 08:26:09.503 2025-08-05 08:26:09.512581 :BB96FB3E:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=19020 pso_num=27 pso_serial#=98 2025-08-05 08:26:09.512718 :BB96FB3F:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=19020 (legacy spawn) 2025-08-05 08:26:09.519174 :BB96FB40: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-08-05 08:26:09.519354 :BB96FB46: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-08-05 08:26:09.520155 :BB96FB4A:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-05 08:26:52.829244 :BB97095C:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-05 08:26:52.820 2025-08-05 08:26:52.829246 :BB97095D:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=18148 pso_num=27 pso_serial#=99 2025-08-05 08:26:52.829391 :BB97095E:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=18148 (legacy spawn) 2025-08-05 08:26:52.835864 :BB97095F: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-08-05 08:26:52.836045 :BB970964: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-08-05 08:26:52.836850 :BB970969:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-05 08:27:02.772643 :BB970C5A:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-05 08:27:02.772 2025-08-05 08:27:02.772645 :BB970C5B:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=19688 pso_num=27 pso_serial#=100 2025-08-05 08:27:02.772795 :BB970C5C:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=19688 (legacy spawn) 2025-08-05 08:27:02.779371 :BB970C5D: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-08-05 08:27:02.779555 :BB970C66: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-08-05 08:27:02.780407 :BB970C67:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-05 08:27:02.789647 :BB970C6A:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-05 08:27:02.788 2025-08-05 08:27:02.789649 :BB970C6B:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=16368 pso_num=27 pso_serial#=101 2025-08-05 08:27:02.789794 :BB970C6C:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=16368 (legacy spawn) 2025-08-05 08:27:02.796423 :BB970C6D: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-08-05 08:27:02.796588 :BB970C75: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-08-05 08:27:02.797436 :BB970C77:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-05 08:27:06.134613 :BB970DC6:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-05 08:27:06.121 2025-08-05 08:27:06.134615 :BB970DC7:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=19204 pso_num=27 pso_serial#=102 2025-08-05 08:27:06.134754 :BB970DC8:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=19204 (legacy spawn) 2025-08-05 08:27:06.141791 :BB970DC9: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-08-05 08:27:06.141980 :BB970DD2: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-08-05 08:27:06.142913 :BB970DD3:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-05 08:27:06.152280 :BB970DD6:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-05 08:27:06.152 2025-08-05 08:27:06.152282 :BB970DD7:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=20300 pso_num=27 pso_serial#=103 2025-08-05 08:27:06.152439 :BB970DD8:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=20300 (legacy spawn) 2025-08-05 08:27:06.159303 :BB970DD9: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-08-05 08:27:06.159476 :BB970DE2: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-08-05 08:27:06.160296 :BB970DE3:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-05 08:27:12.398557 :BB970FDC:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-05 08:27:12.386 2025-08-05 08:27:12.398559 :BB970FDD:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=20136 pso_num=27 pso_serial#=104 2025-08-05 08:27:12.398704 :BB970FDE:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=20136 (legacy spawn) 2025-08-05 08:27:12.405238 :BB970FDF: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-08-05 08:27:12.405417 :BB970FE8: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-08-05 08:27:12.406239 :BB970FE9:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-05 08:27:12.414877 :BB970FEC:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-05 08:27:12.401 2025-08-05 08:27:12.414879 :BB970FED:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=20220 pso_num=27 pso_serial#=105 2025-08-05 08:27:12.415015 :BB970FEE:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=20220 (legacy spawn) 2025-08-05 08:27:12.434907 :BB970FEF: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-08-05 08:27:12.435073 :BB970FF4: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-08-05 08:27:12.435887 :BB970FF8:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-05 08:27:17.716801 :BB97114C:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-05 08:27:17.717 2025-08-05 08:27:17.716803 :BB97114D:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=18872 pso_num=27 pso_serial#=106 2025-08-05 08:27:17.716938 :BB97114E:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=18872 (legacy spawn) 2025-08-05 08:27:17.723458 :BB97114F: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-08-05 08:27:17.723634 :BB971154: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-08-05 08:27:17.724416 :BB971159:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-05 08:27:51.780946 :BB971D6A:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-05 08:27:51.772 2025-08-05 08:27:51.780948 :BB971D6B:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=20064 pso_num=27 pso_serial#=107 2025-08-05 08:27:51.781091 :BB971D6C:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=20064 (legacy spawn) 2025-08-05 08:27:51.787582 :BB971D6D: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-08-05 08:27:51.787778 :BB971D72: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-08-05 08:27:51.788602 :BB971D77:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-05 08:27:55.048938 :BB971E95:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-05 08:27:55.040 2025-08-05 08:27:55.048940 :BB971E96:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=19784 pso_num=27 pso_serial#=108 2025-08-05 08:27:55.049086 :BB971E97:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=19784 (legacy spawn) 2025-08-05 08:27:55.055630 :BB971E98: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-08-05 08:27:55.055820 :BB971EA1: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-08-05 08:27:55.056662 :BB971EA2:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-05 08:28:15.589642 :BB972523:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-05 08:28:15.574 2025-08-05 08:28:15.589644 :BB972524:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=16472 pso_num=27 pso_serial#=109 2025-08-05 08:28:15.589783 :BB972525:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=16472 (legacy spawn) 2025-08-05 08:28:15.596385 :BB972526: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-08-05 08:28:15.596417 :BB972529: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-08-05 08:28:15.596578 :BB972530: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-08-05 08:28:15.597386 :BB97253D:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-05 08:28:15.606269 :BB972540:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-05 08:28:15.606 2025-08-05 08:28:15.606271 :BB972541:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=13600 pso_num=27 pso_serial#=110 2025-08-05 08:28:15.606418 :BB972542:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=13600 (legacy spawn) 2025-08-05 08:28:15.612922 :BB972543: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-08-05 08:28:15.613086 :BB97254C: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-08-05 08:28:15.613895 :BB97254D:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-05 08:28:18.689602 :BB972640:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-05 08:28:18.678 2025-08-05 08:28:18.689604 :BB972641:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=12464 pso_num=27 pso_serial#=111 2025-08-05 08:28:18.689740 :BB972642:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=12464 (legacy spawn) 2025-08-05 08:28:18.696237 :BB972643: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-08-05 08:28:18.696412 :BB972649: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-08-05 08:28:18.697198 :BB97264D:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-05 08:28:18.705993 :BB972650:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-05 08:28:18.694 2025-08-05 08:28:18.705995 :BB972651:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=19788 pso_num=27 pso_serial#=112 2025-08-05 08:28:18.706129 :BB972652:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=19788 (legacy spawn) 2025-08-05 08:28:18.712648 :BB972653: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-08-05 08:28:18.712811 :BB97265B: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-08-05 08:28:18.713618 :BB97265D:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-08-05 08:28:48.944137 :BB97696B:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 08-05 08:28:48.933 2025-08-05 08:28:48.944140 :BB97696C:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=19616 pso_num=27 pso_serial#=113 2025-08-05 08:28:48.944272 :BB97696D:db_trace:kso.c@4093:ksonfy(): [10420:27:0] kso: new process: pid=19616 osp_idx=25 osp_ver=225541 osp_pg=0 (spawn #457282) 2025-08-05 08:28:48.944272 :BB97696E:db_trace:kso.c@4099:ksonfy(): [10420:27:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-05 08:28:48.944273 :BB97696F:db_trace:kso.c@4103:ksonfy(): [10420:27:0] kso: new process: pso_index=27 reservation=183 time=3063198251 2025-08-05 08:28:48.944273 :BB976970:db_trace:kso.c@4109:ksonfy(): [10420:27:0] kso: spawn diagnostics: queue time=0 secs 2025-08-05 08:28:48.944274 :BB976971:db_trace:kso.c@4111:ksonfy(): [10420:27:0] kso: spawn diagnostics: fork time=0 secs 2025-08-05 08:28:48.944274 :BB976972:db_trace:kso.c@4113:ksonfy(): [10420:27:0] kso: spawn diagnostics: exec time=0 secs 2025-08-05 08:28:48.944275 :BB976973:db_trace:kso.c@4115:ksonfy(): [10420:27:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-05 08:28:48.944275 :BB976974:db_trace:kso.c@4117:ksonfy(): [10420:27:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-05 08:28:48.944751 :BB976975: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: 19616, J001)