Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250720180632\orcl_j002_19432_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:36167M/63366M, Ph+PgF:42090M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 27 Windows thread id: 19432, image: ORACLE.EXE (J002) *** 2025-07-20 18:06:32.400 *** SESSION ID:(219.36995) 2025-07-20 18:06:32.400 *** 2025-07-20 18:06:32.400 Process diagnostic dump for ORACLE.EXE (J002), OS id=19432, pid: 27, proc_ser: 143, sid: 219, sess_ser: 36995 ------------------------------------------------------------------------------- current sql: client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 19432 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J002) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=15 seq_num=16 snap_id=1 wait times: snap=0.373356 sec, exc=0.373356 sec, total=0.373356 sec wait times: max=0.500000 sec, heur=7.902958 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=14 seq_num=15 snap_id=1 wait times: snap=0.500004 sec, exc=0.500004 sec, total=0.500004 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=13 seq_num=14 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.000014 sec of elapsed time 2: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=12 seq_num=13 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.000009 sec of elapsed time 3: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=11 seq_num=12 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 4: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=10 seq_num=11 snap_id=1 wait times: snap=0.510081 sec, exc=0.510081 sec, total=0.510081 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000014 sec of elapsed time 5: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=9 seq_num=10 snap_id=1 wait times: snap=0.500014 sec, exc=0.500014 sec, total=0.500014 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=8 seq_num=9 snap_id=1 wait times: snap=0.515486 sec, exc=0.515486 sec, total=0.515486 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000013 sec of elapsed time 7: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=7 seq_num=8 snap_id=1 wait times: snap=0.499988 sec, exc=0.499988 sec, total=0.499988 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000013 sec of elapsed time 8: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=6 seq_num=7 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 9: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=5 seq_num=6 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.000014 sec of elapsed time Sampled Session History of session 219 serial 36995 --------------------------------------------------- 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 --------------------------------------------------- [8 samples, 18:06:24 - 18:06:32] idle wait at each sample [session created at: 18:06:24] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-07-20 18:06:32.400 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 27 (osid: 19432, J002) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-07-20 18:01:41.609762 :B4A831D5:db_trace:kso.c@4103:ksonfy(): [10420:27:0] kso: new process: pso_index=27 reservation=4 time=1715277501 2025-07-20 18:01:41.609762 :B4A831D6:db_trace:kso.c@4109:ksonfy(): [10420:27:0] kso: spawn diagnostics: queue time=0 secs 2025-07-20 18:01:41.609763 :B4A831D7:db_trace:kso.c@4111:ksonfy(): [10420:27:0] kso: spawn diagnostics: fork time=0 secs 2025-07-20 18:01:41.609763 :B4A831D8:db_trace:kso.c@4113:ksonfy(): [10420:27:0] kso: spawn diagnostics: exec time=0 secs 2025-07-20 18:01:41.609764 :B4A831D9:db_trace:kso.c@4115:ksonfy(): [10420:27:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-20 18:01:41.609764 :B4A831DA:db_trace:kso.c@4117:ksonfy(): [10420:27:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-20 18:01:41.610262 :B4A831DB: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-07-20 18:01:41.610308 :B4A831E1: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-07-20 18:01:41.618318 :B4A831F0:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-20 18:02:34.018859 :B4A8432A:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-20 18:02:34.015 2025-07-20 18:02:34.018861 :B4A8432B:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=16524 pso_num=27 pso_serial#=120 2025-07-20 18:02:34.018994 :B4A8432C:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=16524 (legacy spawn) 2025-07-20 18:02:34.025516 :B4A8432D: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-07-20 18:02:34.025693 :B4A84332: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-07-20 18:02:34.026515 :B4A84337:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-20 18:02:34.035244 :B4A8433A:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-20 18:02:34.031 2025-07-20 18:02:34.035246 :B4A8433B:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=14600 pso_num=27 pso_serial#=121 2025-07-20 18:02:34.035386 :B4A8433C:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=14600 (legacy spawn) 2025-07-20 18:02:34.041897 :B4A8433D: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-07-20 18:02:34.042061 :B4A84346: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-07-20 18:02:34.042860 :B4A84347:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-20 18:02:37.178651 :B4A84441:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-20 18:02:37.165 2025-07-20 18:02:37.178653 :B4A84442:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=14072 pso_num=27 pso_serial#=122 2025-07-20 18:02:37.178796 :B4A84443:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=14072 (legacy spawn) 2025-07-20 18:02:37.185367 :B4A84444: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-07-20 18:02:37.185545 :B4A8444D: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-07-20 18:02:37.186345 :B4A8444E:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-20 18:02:37.205115 :B4A84451:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-20 18:02:37.197 2025-07-20 18:02:37.205117 :B4A84452:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=6652 pso_num=27 pso_serial#=123 2025-07-20 18:02:37.205255 :B4A84453:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=6652 (legacy spawn) 2025-07-20 18:02:37.211833 :B4A84454: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-07-20 18:02:37.211997 :B4A8445D: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-07-20 18:02:37.212879 :B4A8445E:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-20 18:02:39.034024 :B4A844EC:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-20 18:02:39.025 2025-07-20 18:02:39.034027 :B4A844ED:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=19112 pso_num=27 pso_serial#=124 2025-07-20 18:02:39.034191 :B4A844EE:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=19112 (legacy spawn) 2025-07-20 18:02:39.040687 :B4A844EF: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-07-20 18:02:39.040857 :B4A844F4: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-07-20 18:02:39.041713 :B4A844F9:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-20 18:02:40.158032 :B4A84567:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-20 18:02:40.150 2025-07-20 18:02:40.158034 :B4A84568:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=18288 pso_num=27 pso_serial#=125 2025-07-20 18:02:40.158174 :B4A84569:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=18288 (legacy spawn) 2025-07-20 18:02:40.164585 :B4A8456A: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-07-20 18:02:40.164755 :B4A84573: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-07-20 18:02:40.165647 :B4A84574:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-20 18:03:41.298389 :B4A85979:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-20 18:03:41.295 2025-07-20 18:03:41.298391 :B4A8597A:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=18488 pso_num=27 pso_serial#=126 2025-07-20 18:03:41.298538 :B4A8597B:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=18488 (legacy spawn) 2025-07-20 18:03:41.315837 :B4A8597C: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-07-20 18:03:41.316017 :B4A85984: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-07-20 18:03:41.316938 :B4A85986:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-20 18:03:41.326430 :B4A85989:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-20 18:03:41.326 2025-07-20 18:03:41.326432 :B4A8598A:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=15076 pso_num=27 pso_serial#=127 2025-07-20 18:03:41.326568 :B4A8598B:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=15076 (legacy spawn) 2025-07-20 18:03:41.333360 :B4A8598C: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-07-20 18:03:41.333542 :B4A85995: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-07-20 18:03:41.334408 :B4A85996:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-20 18:03:42.344888 :B4A859DE:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-20 18:03:42.336 2025-07-20 18:03:42.344890 :B4A859DF:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=7184 pso_num=27 pso_serial#=128 2025-07-20 18:03:42.345030 :B4A859E0:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=7184 (legacy spawn) 2025-07-20 18:03:42.351823 :B4A859E1: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-07-20 18:03:42.352086 :B4A859E6: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-07-20 18:03:42.352937 :B4A859EB:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-20 18:03:46.579246 :B4A85B71:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-20 18:03:46.565 2025-07-20 18:03:46.579248 :B4A85B72:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=18848 pso_num=27 pso_serial#=129 2025-07-20 18:03:46.579381 :B4A85B73:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=18848 (legacy spawn) 2025-07-20 18:03:46.585805 :B4A85B74: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-07-20 18:03:46.585977 :B4A85B7D: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-07-20 18:03:46.586776 :B4A85B7E:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-20 18:03:46.943409 :B4A85B8D:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-20 18:03:46.940 2025-07-20 18:03:46.943411 :B4A85B8E:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=19040 pso_num=27 pso_serial#=130 2025-07-20 18:03:46.943552 :B4A85B8F:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=19040 (legacy spawn) 2025-07-20 18:03:46.950016 :B4A85B90: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-07-20 18:03:46.950187 :B4A85B95: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-07-20 18:03:46.950988 :B4A85B9A:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-20 18:03:47.229648 :B4A85B9D:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-20 18:03:47.221 2025-07-20 18:03:47.229651 :B4A85B9E:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=7572 pso_num=27 pso_serial#=131 2025-07-20 18:03:47.229786 :B4A85B9F:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=7572 (legacy spawn) 2025-07-20 18:03:47.236290 :B4A85BA0: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-07-20 18:03:47.236475 :B4A85BA8: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-07-20 18:03:47.237302 :B4A85BAA:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-20 18:03:50.108986 :B4A85C9F:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-20 18:03:50.095 2025-07-20 18:03:50.108989 :B4A85CA0:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=18404 pso_num=27 pso_serial#=132 2025-07-20 18:03:50.109134 :B4A85CA1:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=18404 (legacy spawn) 2025-07-20 18:03:50.115797 :B4A85CA2: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-07-20 18:03:50.115971 :B4A85CA8: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-07-20 18:03:50.116809 :B4A85CAC:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-20 18:03:50.125740 :B4A85CAF:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-20 18:03:50.110 2025-07-20 18:03:50.125743 :B4A85CB0:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=16212 pso_num=27 pso_serial#=133 2025-07-20 18:03:50.125885 :B4A85CB1:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=16212 (legacy spawn) 2025-07-20 18:03:50.132593 :B4A85CB2: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-07-20 18:03:50.132766 :B4A85CBA: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-07-20 18:03:50.133633 :B4A85CBC:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-20 18:04:26.383620 :B4A868A7:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-20 18:04:26.370 2025-07-20 18:04:26.383622 :B4A868A8:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=17752 pso_num=27 pso_serial#=134 2025-07-20 18:04:26.383783 :B4A868A9:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=17752 (legacy spawn) 2025-07-20 18:04:26.390235 :B4A868AA: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-07-20 18:04:26.390413 :B4A868AF: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-07-20 18:04:26.391258 :B4A868B4:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-20 18:04:26.399962 :B4A868B7:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-20 18:04:26.385 2025-07-20 18:04:26.399964 :B4A868B8:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=19176 pso_num=27 pso_serial#=135 2025-07-20 18:04:26.400096 :B4A868B9:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=19176 (legacy spawn) 2025-07-20 18:04:26.406584 :B4A868BA: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-07-20 18:04:26.406752 :B4A868C3: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-07-20 18:04:26.407589 :B4A868C4:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-20 18:04:44.507547 :B4A86E64:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-20 18:04:44.498 2025-07-20 18:04:44.507549 :B4A86E65:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=1216 pso_num=27 pso_serial#=136 2025-07-20 18:04:44.507695 :B4A86E66:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=1216 (legacy spawn) 2025-07-20 18:04:44.514664 :B4A86E67: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-07-20 18:04:44.514845 :B4A86E6C: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-07-20 18:04:44.515745 :B4A86E71:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-20 18:05:29.426987 :B4A881A4:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-20 18:05:29.413 2025-07-20 18:05:29.426989 :B4A881A5:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=18980 pso_num=27 pso_serial#=137 2025-07-20 18:05:29.427132 :B4A881A6:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=18980 (legacy spawn) 2025-07-20 18:05:29.433573 :B4A881A7: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-07-20 18:05:29.433757 :B4A881AC: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-07-20 18:05:29.434559 :B4A881B0:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-20 18:05:35.987906 :B4A883A3:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-20 18:05:35.973 2025-07-20 18:05:35.987908 :B4A883A4:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=18740 pso_num=27 pso_serial#=138 2025-07-20 18:05:35.988040 :B4A883A5:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=18740 (legacy spawn) 2025-07-20 18:05:35.994474 :B4A883A6: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-07-20 18:05:35.994650 :B4A883AF: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-07-20 18:05:35.995441 :B4A883B0:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-20 18:05:36.013095 :B4A883B3:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-20 18:05:36.005 2025-07-20 18:05:36.013097 :B4A883B4:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=14888 pso_num=27 pso_serial#=139 2025-07-20 18:05:36.013238 :B4A883B5:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=14888 (legacy spawn) 2025-07-20 18:05:36.019631 :B4A883B6: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-07-20 18:05:36.019789 :B4A883BF: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-07-20 18:05:36.020712 :B4A883C0:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-20 18:05:39.097317 :B4A884B7:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-20 18:05:39.084 2025-07-20 18:05:39.097318 :B4A884B8:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=8140 pso_num=27 pso_serial#=140 2025-07-20 18:05:39.097454 :B4A884B9:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=8140 (legacy spawn) 2025-07-20 18:05:39.103863 :B4A884BA: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-07-20 18:05:39.104034 :B4A884C0: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-07-20 18:05:39.104835 :B4A884C4:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-20 18:05:39.113490 :B4A884C7:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-20 18:05:39.100 2025-07-20 18:05:39.113492 :B4A884C8:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=10656 pso_num=27 pso_serial#=141 2025-07-20 18:05:39.113631 :B4A884C9:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=10656 (legacy spawn) 2025-07-20 18:05:39.120050 :B4A884CA: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-07-20 18:05:39.120213 :B4A884D3: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-07-20 18:05:39.121013 :B4A884D4:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-20 18:06:24.307530 :B4A8992B:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-20 18:06:24.302 2025-07-20 18:06:24.307532 :B4A8992C:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=14056 pso_num=27 pso_serial#=142 2025-07-20 18:06:24.307671 :B4A8992D:db_trace:kso.c@4093:ksonfy(): [10420:27:0] kso: new process: pid=14056 osp_idx=25 osp_ver=182220 osp_pg=0 (spawn #405296) 2025-07-20 18:06:24.307671 :B4A8992E:db_trace:kso.c@4099:ksonfy(): [10420:27:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-20 18:06:24.307672 :B4A8992F:db_trace:kso.c@4103:ksonfy(): [10420:27:0] kso: new process: pso_index=27 reservation=5 time=1715560204 2025-07-20 18:06:24.307672 :B4A89930:db_trace:kso.c@4109:ksonfy(): [10420:27:0] kso: spawn diagnostics: queue time=0 secs 2025-07-20 18:06:24.307672 :B4A89931:db_trace:kso.c@4111:ksonfy(): [10420:27:0] kso: spawn diagnostics: fork time=0 secs 2025-07-20 18:06:24.307673 :B4A89932:db_trace:kso.c@4113:ksonfy(): [10420:27:0] kso: spawn diagnostics: exec time=0 secs 2025-07-20 18:06:24.307673 :B4A89933:db_trace:kso.c@4115:ksonfy(): [10420:27:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-20 18:06:24.307674 :B4A89934:db_trace:kso.c@4117:ksonfy(): [10420:27:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-20 18:06:24.308177 :B4A89935: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-07-20 18:06:24.308225 :B4A8993B: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-07-20 18:06:24.312434 :B4A8994D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:kelt.c:517 2025-07-20 18:06:24.312482 :B4A8994E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:kelt.c:517 2025-07-20 18:06:24.312755 :B4A8994F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:kelt.c:517 2025-07-20 18:06:24.312773 :B4A89950:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:kelt.c:517 2025-07-20 18:06:24.312997 :B4A89951:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:kelt.c:517 2025-07-20 18:06:24.313012 :B4A89952:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:kelt.c:517 2025-07-20 18:06:24.313221 :B4A89953:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:kelt.c:517 2025-07-20 18:06:24.313234 :B4A89954:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:kelt.c:517 2025-07-20 18:06:24.313445 :B4A89955:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:kelt.c:517 2025-07-20 18:06:24.313457 :B4A89956:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:kelt.c:517 2025-07-20 18:06:24.313660 :B4A89957:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:kelt.c:517 2025-07-20 18:06:24.313672 :B4A89958:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:kelt.c:517 2025-07-20 18:06:24.316168 :B4A89986:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-07-20 18:06:24.510648 :B4A89AED:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 07-20 18:06:24.505 2025-07-20 18:06:24.510650 :B4A89AEE:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=19432 pso_num=27 pso_serial#=143 2025-07-20 18:06:24.510780 :B4A89AEF:db_trace:kso.c@4093:ksonfy(): [10420:27:0] kso: new process: pid=19432 osp_idx=25 osp_ver=182221 osp_pg=0 (spawn #405298) 2025-07-20 18:06:24.510781 :B4A89AF0:db_trace:kso.c@4099:ksonfy(): [10420:27:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-20 18:06:24.510781 :B4A89AF1:db_trace:kso.c@4103:ksonfy(): [10420:27:0] kso: new process: pso_index=27 reservation=6 time=1715560408 2025-07-20 18:06:24.510782 :B4A89AF2:db_trace:kso.c@4109:ksonfy(): [10420:27:0] kso: spawn diagnostics: queue time=0 secs 2025-07-20 18:06:24.510782 :B4A89AF3:db_trace:kso.c@4111:ksonfy(): [10420:27:0] kso: spawn diagnostics: fork time=0 secs 2025-07-20 18:06:24.510782 :B4A89AF4:db_trace:kso.c@4113:ksonfy(): [10420:27:0] kso: spawn diagnostics: exec time=0 secs 2025-07-20 18:06:24.510783 :B4A89AF5:db_trace:kso.c@4115:ksonfy(): [10420:27:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-20 18:06:24.510783 :B4A89AF6:db_trace:kso.c@4117:ksonfy(): [10420:27:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-20 18:06:24.511258 :B4A89B00: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: 19432, J002)