Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250706060006\orcl_j003_11036_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:37140M/63366M, Ph+PgF:43153M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 29 Windows thread id: 11036, image: ORACLE.EXE (J003) *** 2025-07-06 06:00:06.125 *** SESSION ID:(233.28189) 2025-07-06 06:00:06.125 *** 2025-07-06 06:00:06.125 Process diagnostic dump for ORACLE.EXE (J003), OS id=11036, pid: 29, proc_ser: 22, sid: 233, sess_ser: 28189 ------------------------------------------------------------------------------- current sql: client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 11036 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J003) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=4 seq_num=5 snap_id=1 wait times: snap=0.429257 sec, exc=0.429257 sec, total=0.429257 sec wait times: max=0.500000 sec, heur=2.427599 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=3 seq_num=4 snap_id=1 wait times: snap=0.500123 sec, exc=0.500123 sec, total=0.500123 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=2 seq_num=3 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.000014 sec of elapsed time 2: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=1 seq_num=2 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.000008 sec of elapsed time 3: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=0 seq_num=1 snap_id=1 wait times: snap=0.498186 sec, exc=0.498186 sec, total=0.498186 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 233 serial 28189 --------------------------------------------------- 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, 06:00:03 - 06:00:06] idle wait at each sample [session created at: 06:00:03] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-07-06 06:00:06.125 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 29 (osid: 11036, J003) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-07-06 00:04:33.042288 :AE11FA7A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 00:04:33.042458 :AE11FA83:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-06 00:04:33.043380 :AE11FA90:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-07-06 00:04:35.608188 :AE11FB7A:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 07-06 00:04:35.596 2025-07-06 00:04:35.608190 :AE11FB7B:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=1740 pso_num=29 pso_serial#=6 2025-07-06 00:04:35.608326 :AE11FB7C:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=1740 (legacy spawn) 2025-07-06 00:04:35.615009 :AE11FB7D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 00:04:35.615182 :AE11FB83:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-06 00:04:35.616073 :AE11FB87:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-07-06 00:04:36.187954 :AE11FB96:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 07-06 00:04:36.174 2025-07-06 00:04:36.187955 :AE11FB97:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=17204 pso_num=29 pso_serial#=7 2025-07-06 00:04:36.188091 :AE11FB98:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=17204 (legacy spawn) 2025-07-06 00:04:36.194577 :AE11FB99:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 00:04:36.194770 :AE11FBA1:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-06 00:04:36.195567 :AE11FBA3:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-07-06 00:04:36.204096 :AE11FBA6:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 07-06 00:04:36.190 2025-07-06 00:04:36.204098 :AE11FBA7:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=10656 pso_num=29 pso_serial#=8 2025-07-06 00:04:36.204232 :AE11FBA8:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=10656 (legacy spawn) 2025-07-06 00:04:36.210674 :AE11FBA9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 00:04:36.210848 :AE11FBB2:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-06 00:04:36.211641 :AE11FBB3:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-07-06 00:04:37.383567 :AE11FC2C:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 07-06 00:04:37.378 2025-07-06 00:04:37.383569 :AE11FC2D:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=9724 pso_num=29 pso_serial#=9 2025-07-06 00:04:37.383707 :AE11FC2E:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=9724 osp_idx=27 osp_ver=14033 osp_pg=0 (spawn #356124) 2025-07-06 00:04:37.383708 :AE11FC2F:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-06 00:04:37.383708 :AE11FC30:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=93 time=441053283 2025-07-06 00:04:37.383709 :AE11FC31:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-07-06 00:04:37.383709 :AE11FC32:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-07-06 00:04:37.383709 :AE11FC33:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-07-06 00:04:37.383709 :AE11FC34:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-06 00:04:37.383710 :AE11FC35:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-06 00:04:37.384201 :AE11FC36:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-06 00:04:37.384247 :AE11FC3C:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-06 00:04:37.392418 :AE11FC4B:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-07-06 00:05:12.414154 :AE12080C:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 07-06 00:05:12.401 2025-07-06 00:05:12.414156 :AE12080D:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=18160 pso_num=29 pso_serial#=10 2025-07-06 00:05:12.414294 :AE12080E:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=18160 (legacy spawn) 2025-07-06 00:05:12.420795 :AE12080F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 00:05:12.420972 :AE120814:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-06 00:05:12.421781 :AE120819:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-07-06 00:05:12.430461 :AE12081C:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 07-06 00:05:12.416 2025-07-06 00:05:12.430464 :AE12081D:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=12040 pso_num=29 pso_serial#=11 2025-07-06 00:05:12.430630 :AE12081E:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=12040 (legacy spawn) 2025-07-06 00:05:12.437154 :AE12081F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 00:05:12.437327 :AE120828:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-06 00:05:12.438140 :AE120829:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-07-06 00:05:35.196524 :AE1210F5:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 07-06 00:05:35.189 2025-07-06 00:05:35.196527 :AE1210F6:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=17772 pso_num=29 pso_serial#=12 2025-07-06 00:05:35.196662 :AE1210F7:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=17772 (legacy spawn) 2025-07-06 00:05:35.203136 :AE1210F8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 00:05:35.203313 :AE121101:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-06 00:05:35.204219 :AE12110E:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-07-06 00:06:17.759320 :AE12276E:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 07-06 00:06:17.750 2025-07-06 00:06:17.759323 :AE12276F:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=17608 pso_num=29 pso_serial#=13 2025-07-06 00:06:17.759469 :AE122770:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=17608 (legacy spawn) 2025-07-06 00:06:17.766021 :AE122771:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 00:06:17.766190 :AE122776:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-06 00:06:17.766988 :AE12277B:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-07-06 01:00:02.127223 :AE16723D:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 07-06 01:00:02.122 2025-07-06 01:00:02.127225 :AE16723E:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=16968 pso_num=29 pso_serial#=14 2025-07-06 01:00:02.127359 :AE16723F:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=16968 osp_idx=27 osp_ver=14038 osp_pg=0 (spawn #356253) 2025-07-06 01:00:02.127360 :AE167240:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-06 01:00:02.127360 :AE167241:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=94 time=444378017 2025-07-06 01:00:02.127361 :AE167242:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-07-06 01:00:02.127361 :AE167243:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-07-06 01:00:02.127362 :AE167244:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-07-06 01:00:02.127362 :AE167245:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-06 01:00:02.127362 :AE167246:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-06 01:00:02.127879 :AE167247:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-06 01:00:02.127925 :AE16724D:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-06 01:00:02.132373 :AE167260:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 01:00:02.157383 :AE167268:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 01:00:02.172026 :AE167270:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 01:00:02.201187 :AE167278:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 01:00:02.205141 :AE167280:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 01:00:02.205464 :AE167288:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 01:00:02.209188 :AE167290:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 01:00:02.211884 :AE167298:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 01:00:02.213581 :AE1672A0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 01:00:02.214760 :AE1672A8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 01:00:02.218262 :AE1672B0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 01:00:03.508575 :AE16732A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 01:00:03.544998 :AE167332:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 01:00:03.545368 :AE16733A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 01:00:03.545664 :AE167342:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 01:00:03.545681 :AE167345:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 01:00:03.545743 :AE167351:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-06 01:00:03.548926 :AE16735F:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-07-06 01:00:14.200706 :AE16772E:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 07-06 01:00:14.198 2025-07-06 01:00:14.200709 :AE16772F:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=18208 pso_num=29 pso_serial#=15 2025-07-06 01:00:14.200849 :AE167730:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=18208 (legacy spawn) 2025-07-06 01:00:14.207345 :AE167731:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 01:00:14.207515 :AE167736:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-06 01:00:14.208291 :AE16773B:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-07-06 01:00:14.223450 :AE16773E:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 07-06 01:00:14.214 2025-07-06 01:00:14.223452 :AE16773F:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=11340 pso_num=29 pso_serial#=16 2025-07-06 01:00:14.223588 :AE167740:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=11340 (legacy spawn) 2025-07-06 01:00:14.230154 :AE167741:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 01:00:14.230318 :AE16774A:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-06 01:00:14.231122 :AE16774B:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-07-06 01:00:18.650098 :AE1679A6:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 07-06 01:00:18.640 2025-07-06 01:00:18.650100 :AE1679A7:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=4376 pso_num=29 pso_serial#=17 2025-07-06 01:00:18.650242 :AE1679A8:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=4376 (legacy spawn) 2025-07-06 01:00:18.656786 :AE1679A9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 01:00:18.656956 :AE1679AE:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-06 01:00:18.657750 :AE1679B3:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-07-06 01:00:20.072551 :AE167A0C:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 07-06 01:00:20.058 2025-07-06 01:00:20.072553 :AE167A0D:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=15492 pso_num=29 pso_serial#=18 2025-07-06 01:00:20.072720 :AE167A0E:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=15492 (legacy spawn) 2025-07-06 01:00:20.079164 :AE167A0F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 01:00:20.079333 :AE167A17:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-06 01:00:20.080191 :AE167A19:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-07-06 01:00:20.088871 :AE167A1C:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 07-06 01:00:20.073 2025-07-06 01:00:20.088874 :AE167A1D:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=13400 pso_num=29 pso_serial#=19 2025-07-06 01:00:20.089011 :AE167A1E:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=13400 (legacy spawn) 2025-07-06 01:00:20.095549 :AE167A1F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 01:00:20.095713 :AE167A28:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-06 01:00:20.096516 :AE167A29:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-07-06 01:00:23.319024 :AE167B4D:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 07-06 01:00:23.308 2025-07-06 01:00:23.319026 :AE167B4E:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=13572 pso_num=29 pso_serial#=20 2025-07-06 01:00:23.319169 :AE167B4F:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=13572 (legacy spawn) 2025-07-06 01:00:23.325629 :AE167B50:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 01:00:23.325824 :AE167B55:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-06 01:00:23.326640 :AE167B5A:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-07-06 01:00:23.335243 :AE167B5D:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 07-06 01:00:23.324 2025-07-06 01:00:23.335244 :AE167B5E:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=18352 pso_num=29 pso_serial#=21 2025-07-06 01:00:23.335376 :AE167B5F:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=18352 (legacy spawn) 2025-07-06 01:00:23.341967 :AE167B73:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 01:00:23.342136 :AE167B7C:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-06 01:00:23.342974 :AE167B7D:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-07-06 06:00:02.042978 :AE2E87C2:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 07-06 06:00:02.031 2025-07-06 06:00:02.042980 :AE2E87C3:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=11036 pso_num=29 pso_serial#=22 2025-07-06 06:00:02.043113 :AE2E87C8:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=11036 osp_idx=27 osp_ver=14046 osp_pg=0 (spawn #356945) 2025-07-06 06:00:02.043114 :AE2E87C9:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-06 06:00:02.043115 :AE2E87CA:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=95 time=462377923 2025-07-06 06:00:02.043115 :AE2E87CB:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-07-06 06:00:02.043116 :AE2E87CC:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-07-06 06:00:02.043116 :AE2E87CD:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-07-06 06:00:02.043116 :AE2E87CE:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-06 06:00:02.043116 :AE2E87CF:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-06 06:00:02.043730 :AE2E87D5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-06 06:00:02.048855 :AE2E87EA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 06:00:02.048913 :AE2E87EF:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:jslv.c:9203 2025-07-06 06:00:02.053101 :AE2E881A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 06:00:02.213501 :AE2E8B01:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 06:00:02.355324 :AE2E8B09:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 06:00:02.482449 :AE2E8B26:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 06:00:03.601786 :AE2E8D19:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 06:00:03.602804 :AE2E8D21:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 06:00:03.608534 :AE2E8D29:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 06:00:03.625256 :AE2E8D31:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 06:00:03.625899 :AE2E8D39:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 06:00:03.626459 :AE2E8D41:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 06:00:03.626959 :AE2E8D49:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 06:00:03.629499 :AE2E8D51:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 06:00:03.630530 :AE2E8D59:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:psdpgi.c:2235 2025-07-06 06:00:03.631303 :AE2E8D5A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:psdpgi.c:2235 2025-07-06 06:00:03.632083 :AE2E8D5B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:psdpgi.c:2235 2025-07-06 06:00:03.632486 :AE2E8D5C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:psdpgi.c:2235 2025-07-06 06:00:03.632493 :AE2E8D5D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:psdpgi.c:2235 2025-07-06 06:00:03.633019 :AE2E8D5E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:psdpgi.c:2235 2025-07-06 06:00:03.633497 :AE2E8D5F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:psdpgi.c:2235 2025-07-06 06:00:03.633754 :AE2E8D60:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:psdpgi.c:2235 2025-07-06 06:00:03.634789 :AE2E8D61:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:psdpgi.c:2235 2025-07-06 06:00:03.673869 :AE2E8D75:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 06:00:03.673914 :AE2E8D78:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:psdpgi.c:2235 2025-07-06 06:00:03.674773 :AE2E8D7E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 06:00:03.675647 :AE2E8D86:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:psdpgi.c:2235 2025-07-06 06:00:03.676116 :AE2E8D87:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 06:00:03.696003 :AE2E8D8F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 06:00:03.696055 :AE2E8D92:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:psdpgi.c:2235 2025-07-06 06:00:03.697050 :AE2E8D98:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 06:00:03.697593 :AE2E8DA0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 06:00:03.697972 :AE2E8DA8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 06:00:03.698164 :AE2E8DB0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 06:00:03.698305 :AE2E8DB8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 06:00:03.698445 :AE2E8DC0:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:jslv.c:9203 2025-07-06 06:00:03.698982 :AE2E8DC1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 06:00:03.702563 :AE2E8DC9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-06 06:00:03.702637 :AE2E8DCC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 2025-07-06 06:00:03.702739 :AE2E8DD9:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 29 (osid: 11036, J003)