Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250715220008\orcl_j004_18036_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:36323M/63366M, Ph+PgF:42305M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 30 Windows thread id: 18036, image: ORACLE.EXE (J004) *** 2025-07-15 22:00:08.957 *** SESSION ID:(241.3125) 2025-07-15 22:00:08.957 *** 2025-07-15 22:00:08.957 Process diagnostic dump for ORACLE.EXE (J004), OS id=18036, pid: 30, proc_ser: 194, sid: 241, sess_ser: 3125 ------------------------------------------------------------------------------- current sql: client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 18036 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J004) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=12 seq_num=13 snap_id=1 wait times: snap=0.366304 sec, exc=0.366304 sec, total=0.366304 sec wait times: max=0.500000 sec, heur=6.381769 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.000008 sec since current wait 0: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=11 seq_num=12 snap_id=1 wait times: snap=0.499997 sec, exc=0.499997 sec, total=0.499997 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000013 sec of elapsed time 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=10 seq_num=11 snap_id=1 wait times: snap=0.499997 sec, exc=0.499997 sec, total=0.499997 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 sec of elapsed time 2: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=9 seq_num=10 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.000007 sec of elapsed time 3: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=8 seq_num=9 snap_id=1 wait times: snap=0.499994 sec, exc=0.499994 sec, total=0.499994 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000013 sec of elapsed time 4: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=7 seq_num=8 snap_id=1 wait times: snap=0.499994 sec, exc=0.499994 sec, total=0.499994 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000011 sec of elapsed time 5: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=6 seq_num=7 snap_id=1 wait times: snap=0.510129 sec, exc=0.510129 sec, total=0.510129 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000011 sec of elapsed time 6: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=5 seq_num=6 snap_id=1 wait times: snap=0.499995 sec, exc=0.499995 sec, total=0.499995 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 sec of elapsed time 7: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=4 seq_num=5 snap_id=1 wait times: snap=0.500000 sec, exc=0.500000 sec, total=0.500000 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000010 sec of elapsed time 8: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=3 seq_num=4 snap_id=1 wait times: snap=0.499991 sec, exc=0.499991 sec, total=0.499991 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000011 sec of elapsed time 9: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=2 seq_num=3 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.000008 sec of elapsed time Sampled Session History of session 241 serial 3125 --------------------------------------------------- The sampled session history is constructed by sampling the target session every 1 second. The sampling process captures at each sample if the session is in a non-idle wait, an idle wait, or not in a wait. If the session is in a non-idle wait then one interval is shown for all the samples the session was in the same non-idle wait. If the session is in an idle wait or not in a wait for consecutive samples then one interval is shown for all the consecutive samples. Though we display these consecutive samples in a single interval the session may NOT be continuously idle or not in a wait (the sampling process does not know). The history is displayed in reverse chronological order. sample interval: 1 sec, max history 120 sec --------------------------------------------------- [7 samples, 22:00:02 - 22:00:08] idle wait at each sample [session created at: 22:00:02] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-07-15 22:00:08.957 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 30 (osid: 18036, J004) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-07-14 22:00:02.066416 :B20B8E39:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-14 22:00:02.066459 :B20B8E3C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:jslv.c:9203 2025-07-14 22:00:02.072155 :B20B8FC8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-14 22:00:02.288978 :B20B90F1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-14 22:00:02.491208 :B20B9109:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-14 22:00:02.626139 :B20B9141:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-14 22:00:03.773468 :B20B9344:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-14 22:00:03.774576 :B20B934C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-14 22:00:03.778751 :B20B9354:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-14 22:00:03.781797 :B20B935C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-14 22:00:03.783475 :B20B9371:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-14 22:00:03.784832 :B20B937B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-14 22:00:03.786153 :B20B9398:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-14 22:00:03.807939 :B20B93B8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-14 22:00:03.808619 :B20B93C0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-14 22:00:03.809141 :B20B93C8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-14 22:00:03.809637 :B20B93D0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-14 22:00:03.812360 :B20B93D8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-14 22:00:03.813299 :B20B93E0:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-07-14 22:00:03.814075 :B20B93E1:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-07-14 22:00:03.814888 :B20B93E2:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-07-14 22:00:03.815302 :B20B93E3:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-07-14 22:00:03.815309 :B20B93E4:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-07-14 22:00:03.815927 :B20B93E5:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-07-14 22:00:03.816438 :B20B93E6:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-07-14 22:00:03.816737 :B20B93E7:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-07-14 22:00:03.817838 :B20B93E8:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-07-14 22:00:03.854283 :B20B93F5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-14 22:00:03.854338 :B20B93F8:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-07-14 22:00:03.855269 :B20B93FE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-14 22:00:03.856253 :B20B9406:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-07-14 22:00:03.856677 :B20B9407:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-14 22:00:03.877449 :B20B940F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-14 22:00:03.877497 :B20B9412:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-07-14 22:00:03.878444 :B20B9418:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-14 22:00:03.879362 :B20B9420:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-07-14 22:00:03.879855 :B20B9421:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-14 22:00:03.897425 :B20B9429:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-14 22:00:03.897490 :B20B942C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-07-14 22:00:03.898420 :B20B9432:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-14 22:00:03.899314 :B20B943A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-07-14 22:00:03.899788 :B20B943B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-14 22:00:03.920958 :B20B9443:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-14 22:00:03.921009 :B20B9446:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-07-14 22:00:03.921842 :B20B944C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-14 22:00:03.922689 :B20B9454:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-07-14 22:00:03.923097 :B20B9455:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-14 22:00:03.942977 :B20B9467:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-14 22:00:03.943026 :B20B946A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-07-14 22:00:03.943908 :B20B9470:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-14 22:00:03.956772 :B20B9478:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-07-14 22:00:03.957350 :B20B9479:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-14 22:00:03.974992 :B20B948C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-14 22:00:03.975041 :B20B948F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-07-14 22:00:03.975920 :B20B9495:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-14 22:00:03.976362 :B20B949D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-14 22:00:03.976718 :B20B94A5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-14 22:00:03.976896 :B20B94AD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-14 22:00:03.977025 :B20B94B5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-14 22:00:03.977193 :B20B94BD:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:jslv.c:9203 2025-07-14 22:00:03.980991 :B20B94BE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-14 22:00:03.981076 :B20B94C1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 2025-07-14 22:00:03.981148 :B20B94CE:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] 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 22:00:34.080306 :B20BA2D1:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-07-14 23:59:13.873738 :B21507A5:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 07-14 23:59:13.860 2025-07-14 23:59:13.873741 :B21507A6:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=13960 pso_num=30 pso_serial#=191 2025-07-14 23:59:13.873874 :B21507A7:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=13960 (legacy spawn) 2025-07-14 23:59:13.888259 :B21507A8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-14 23:59:47.032216 :B21514AE:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-07-14 23:59:47.577089 :B21514E3:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 07-14 23:59:47.567 2025-07-14 23:59:47.577091 :B21514E4:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=15876 pso_num=30 pso_serial#=192 2025-07-14 23:59:47.577238 :B21514E5:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=15876 (legacy spawn) 2025-07-14 23:59:47.591586 :B21514E6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-15 00:00:20.652905 :B21522B6:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-07-15 00:00:36.034072 :B2152897:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 07-15 00:00:36.022 2025-07-15 00:00:36.034074 :B2152898:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=4124 pso_num=30 pso_serial#=193 2025-07-15 00:00:36.034216 :B2152899:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=4124 osp_idx=28 osp_ver=1467 osp_pg=0 (spawn #386116) 2025-07-15 00:00:36.034216 :B215289A:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-15 00:00:36.034217 :B215289B:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=135 time=1218411923 2025-07-15 00:00:36.034217 :B215289C:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-07-15 00:00:36.034217 :B215289D:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-07-15 00:00:36.034218 :B215289E:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-07-15 00:00:36.034218 :B215289F:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-15 00:00:36.034219 :B21528A0:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-15 00:00:36.034711 :B21528A1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-15 00:00:36.034752 :B21528A7:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] 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-15 00:00:36.042140 :B21528B5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-15 00:00:36.043240 :B21528BD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-15 00:00:36.043786 :B21528C5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-15 00:00:36.044345 :B21528CD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-15 00:00:36.044803 :B21528D5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-15 00:00:36.047407 :B21528DD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-15 00:00:36.048642 :B21528E5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-15 00:00:36.098642 :B21528ED:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-15 00:00:36.100244 :B21528F5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-15 00:00:36.101148 :B21528FD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-15 00:00:36.101387 :B2152905:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-15 00:00:36.101632 :B215290D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-15 00:00:36.103651 :B2152915:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-07-15 22:00:00.647585 :B27DC72D:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 07-15 22:00:00.635 2025-07-15 22:00:00.647586 :B27DC72E:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=18036 pso_num=30 pso_serial#=194 2025-07-15 22:00:00.647710 :B27DC72F:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=18036 osp_idx=28 osp_ver=1468 osp_pg=0 (spawn #389171) 2025-07-15 22:00:00.647711 :B27DC730:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-15 22:00:00.647712 :B27DC731:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=136 time=1297576533 2025-07-15 22:00:00.647712 :B27DC732:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-07-15 22:00:00.647713 :B27DC733:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-07-15 22:00:00.647713 :B27DC734:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-07-15 22:00:00.647713 :B27DC735:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-15 22:00:00.647714 :B27DC736:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-15 22:00:00.648264 :B27DC748:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-15 22:00:00.653524 :B27DC89D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-15 22:00:00.653560 :B27DC8A0:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:jslv.c:9203 2025-07-15 22:00:00.659107 :B27DC8EB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-15 22:00:00.877667 :B27DCA0D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-15 22:00:01.076974 :B27DCA25:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-15 22:00:01.220176 :B27DCA3D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-15 22:00:02.370274 :B27DCBEC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-15 22:00:02.371639 :B27DCBF4:db_trace:ktu.c@4871:ktuaex1r(): [10442:30:241] Extension usn 9, ext 1, nex 3 2025-07-15 22:00:02.371646 :B27DCBF5:db_trace:ktusm.c@2117:ktusmasp(): [10445:30:241] des1:tsn:1 rdba:0x00813b2a where: ktspbwh1: ktspfsrch 2025-07-15 22:00:02.371955 :B27DCBF6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-15 22:00:02.376348 :B27DCC08:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-15 22:00:02.379331*:B27DCC36:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000002DD60320 estart=1752588002 eid=16793492 ctx=0x000000077B7B64F0 cwh=0x000000002DD30F70 cpu=0 buffg=2 interb=0 r=0 rb=0 w=0 wb=0 2025-07-15 22:00:02.379331*:B27DCC37:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000002DD60320 curCtx=0x000000002DD78E40 pubTabIdxCnt=0 2025-07-15 22:00:02.379331*:B27DCC38:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000002DD60320 2025-07-15 22:00:02.379331*:B27DCC39:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000002DD60320 2025-07-15 22:00:02.379331*:B27DCC3A:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000002DD60320 curCtx=0x000000002DD78E40 xsc->flg4=65792 flags=2 2025-07-15 22:00:02.379331*:B27DCC3B:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000002DD60320 2025-07-15 22:00:02.379769 :B27DCC3C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-15 22:00:02.381273 :B27DCC54:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-15 22:00:02.382833 :B27DCC5C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-15 22:00:02.385194 :B27DCC64:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-15 22:00:02.405825 :B27DCC6C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-15 22:00:02.406418 :B27DCC74:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-15 22:00:02.406924 :B27DCC7C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-15 22:00:02.407438 :B27DCC84:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-15 22:00:02.410447 :B27DCC8C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-15 22:00:02.411436 :B27DCC94:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-07-15 22:00:02.412322 :B27DCC95:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-07-15 22:00:02.413103 :B27DCC96:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-07-15 22:00:02.413534 :B27DCC97:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-07-15 22:00:02.413541 :B27DCC98:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-07-15 22:00:02.414106 :B27DCC99:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-07-15 22:00:02.414588 :B27DCC9A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-07-15 22:00:02.414862 :B27DCC9B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-07-15 22:00:02.416025 :B27DCC9C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-07-15 22:00:02.454738 :B27DCC9D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-15 22:00:02.454797 :B27DCCA0:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-07-15 22:00:02.455840 :B27DCCA6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-15 22:00:02.456950 :B27DCCAE:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-07-15 22:00:02.457454 :B27DCCAF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-15 22:00:02.478144 :B27DCCB7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-15 22:00:02.478200 :B27DCCBA:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-07-15 22:00:02.479156 :B27DCCC0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-15 22:00:02.480019 :B27DCCC8:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-07-15 22:00:02.480460 :B27DCCC9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-15 22:00:02.500515 :B27DCCD3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-15 22:00:02.500565 :B27DCCD6:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-07-15 22:00:02.501484 :B27DCCDC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-15 22:00:02.502376 :B27DCCE4:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-07-15 22:00:02.502876 :B27DCCE5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-15 22:00:02.520946 :B27DCCED:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-15 22:00:02.521007 :B27DCCF0:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-07-15 22:00:02.521925 :B27DCCFE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-15 22:00:02.522884 :B27DCD06:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-07-15 22:00:02.523389 :B27DCD07:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-15 22:00:02.544847 :B27DCD0F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-15 22:00:02.544906 :B27DCD12:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-07-15 22:00:02.545837 :B27DCD18:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-15 22:00:02.558852 :B27DCD20:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-07-15 22:00:02.559427 :B27DCD21:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-15 22:00:02.577245 :B27DCD29:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-15 22:00:02.577285 :B27DCD2C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-07-15 22:00:02.578184 :B27DCD32:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-15 22:00:02.578601 :B27DCD3A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-15 22:00:02.578946 :B27DCD42:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-15 22:00:02.579125 :B27DCD4A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-15 22:00:02.579256 :B27DCD52:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-15 22:00:02.579399 :B27DCD5A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:jslv.c:9203 2025-07-15 22:00:02.583407 :B27DCD5B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-15 22:00:02.583484 :B27DCD5E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 30 (osid: 18036, J004)