Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250531140404\orcl_m001_13256_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:37242M/63366M, Ph+PgF:44151M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 29 Windows thread id: 13256, image: ORACLE.EXE (M001) *** 2025-05-31 14:04:04.943 *** 2025-05-31 14:04:04.943 Process diagnostic dump for ORACLE.EXE (M001), OS id=13256, pid: 29, proc_ser: 152, sid: ------------------------------------------------------------------------------- Skipping session state dump because target process has no session. ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-05-31 14:04:04.943 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 29 (osid: 13256, M001) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-31 06:00:15.950338 :9E512C4A:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-31 06:00:19.138796 :9E512D67:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-31 06:00:19.125 2025-05-31 06:00:19.138799 :9E512D68:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=14592 pso_num=29 pso_serial#=139 2025-05-31 06:00:19.138932 :9E512D69:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=14592 (legacy spawn) 2025-05-31 06:00:19.145408 :9E512D6A: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-05-31 06:00:19.145624 :9E512D6F: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-05-31 06:00:19.146463 :9E512D74:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-31 06:00:19.154927 :9E512D77:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-31 06:00:19.141 2025-05-31 06:00:19.154929 :9E512D78:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=7880 pso_num=29 pso_serial#=140 2025-05-31 06:00:19.155066 :9E512D79:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=7880 (legacy spawn) 2025-05-31 06:00:19.161483 :9E512D7A: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-05-31 06:00:19.161646 :9E512D83: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-05-31 06:00:19.162413 :9E512D84:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-31 06:00:32.117351 :9E5131A6:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-31 06:00:32.108 2025-05-31 06:00:32.117353 :9E5131A7:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=12908 pso_num=29 pso_serial#=141 2025-05-31 06:00:32.117491 :9E5131A8:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=12908 (legacy spawn) 2025-05-31 06:00:32.124018 :9E5131A9: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-05-31 06:00:32.124180 :9E5131B2: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-05-31 06:00:32.124994 :9E5131B3:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-31 08:17:21.234220 :9E5C0261:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-31 08:17:21.221 2025-05-31 08:17:21.234223 :9E5C0262:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=15120 pso_num=29 pso_serial#=142 2025-05-31 08:17:21.234339 :9E5C0263:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=15120 osp_idx=27 osp_ver=11871 osp_pg=0 (spawn #237249) 2025-05-31 08:17:21.234340 :9E5C0264:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-31 08:17:21.234340 :9E5C0265:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=139 time=1655199875 2025-05-31 08:17:21.234340 :9E5C0266:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-31 08:17:21.234341 :9E5C0267:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-31 08:17:21.234341 :9E5C0268:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-31 08:17:21.234341 :9E5C0269:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-31 08:17:21.234342 :9E5C026A:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-31 08:17:21.234824 :9E5C026B: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-05-31 08:17:51.308141 :9E5C1B03:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-31 10:03:25.073376 :9E645B3A:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-31 10:03:25.063 2025-05-31 10:03:25.073377 :9E645B3B:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=13452 pso_num=29 pso_serial#=143 2025-05-31 10:03:25.073518 :9E645B3C:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=13452 osp_idx=27 osp_ver=11872 osp_pg=0 (spawn #237496) 2025-05-31 10:03:25.073519 :9E645B3D:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-31 10:03:25.073520 :9E645B3E:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=140 time=1661563719 2025-05-31 10:03:25.073521 :9E645B3F:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-31 10:03:25.073521 :9E645B40:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-31 10:03:25.073521 :9E645B41:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-31 10:03:25.073522 :9E645B42:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-31 10:03:25.073522 :9E645B43:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-31 10:03:25.074103 :9E645B47: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-05-31 10:03:25.074144 :9E645B4D: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-05-31 10:03:25.083355 :9E645B5F:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-31 10:42:42.381938 :9E67669F:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-31 10:42:42.377 2025-05-31 10:42:42.381940 :9E6766A0:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=15104 pso_num=29 pso_serial#=144 2025-05-31 10:42:42.382081 :9E6766A1:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=15104 (legacy spawn) 2025-05-31 10:42:42.388595 :9E6766A2: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-05-31 10:42:42.388756 :9E6766AB: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-05-31 10:42:42.389578 :9E6766AC:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-31 12:48:41.370144 :9E710F97:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-31 12:48:41.361 2025-05-31 12:48:41.370147 :9E710F98:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=12296 pso_num=29 pso_serial#=145 2025-05-31 12:48:41.370284 :9E710F99:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=12296 (legacy spawn) 2025-05-31 12:48:41.376743 :9E710F9A: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-05-31 12:48:41.376907 :9E710FA3: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-05-31 12:48:41.377691 :9E710FA4:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-31 12:48:46.716437 :9E71114A:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-31 12:48:46.711 2025-05-31 12:48:46.716439 :9E71114B:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=14512 pso_num=29 pso_serial#=146 2025-05-31 12:48:46.716572 :9E71114C:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=14512 osp_idx=27 osp_ver=11875 osp_pg=0 (spawn #237877) 2025-05-31 12:48:46.716573 :9E71114D:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-31 12:48:46.716574 :9E71114E:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=141 time=1671485360 2025-05-31 12:48:46.716574 :9E71114F:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-31 12:48:46.716575 :9E711150:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-31 12:48:46.716575 :9E711151:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-31 12:48:46.716575 :9E711152:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-31 12:48:46.716576 :9E711153:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-31 12:48:46.717064 :9E711154: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-05-31 12:48:46.717107 :9E71115A: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-05-31 12:48:46.737668 :9E711184:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-31 13:00:49.336400 :9E71FDA8:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-31 13:00:49.324 2025-05-31 13:00:49.336402 :9E71FDA9:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=10720 pso_num=29 pso_serial#=147 2025-05-31 13:00:49.336537 :9E71FDAA:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=10720 (legacy spawn) 2025-05-31 13:00:49.343162 :9E71FDAB: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-05-31 13:00:49.343365 :9E71FDB4: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-05-31 13:00:49.344259 :9E71FDB5:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-31 13:00:49.352721 :9E71FDB8:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-31 13:00:49.339 2025-05-31 13:00:49.352723 :9E71FDB9:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=8812 pso_num=29 pso_serial#=148 2025-05-31 13:00:49.352867 :9E71FDBA:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=8812 (legacy spawn) 2025-05-31 13:00:49.359253 :9E71FDBB: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-05-31 13:00:49.359415 :9E71FDC4: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-05-31 13:00:49.360202 :9E71FDC5:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-31 13:00:49.703481 :9E71FE00:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-31 13:00:49.699 2025-05-31 13:00:49.703483 :9E71FE01:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=12488 pso_num=29 pso_serial#=149 2025-05-31 13:00:49.703627 :9E71FE02:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=12488 osp_idx=27 osp_ver=11878 osp_pg=0 (spawn #237905) 2025-05-31 13:00:49.703629 :9E71FE03:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-31 13:00:49.703629 :9E71FE04:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=142 time=1672208329 2025-05-31 13:00:49.703630 :9E71FE05:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-31 13:00:49.703630 :9E71FE06:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-31 13:00:49.703630 :9E71FE07:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-31 13:00:49.703631 :9E71FE08:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-31 13:00:49.703631 :9E71FE09:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-31 13:00:49.704118 :9E71FE0A: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-05-31 13:00:49.704162 :9E71FE10: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-05-31 13:00:49.712062 :9E71FE1E: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-05-31 13:00:49.713131 :9E71FE26: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-05-31 13:00:49.713814 :9E71FE5B: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-05-31 13:00:49.714326 :9E71FE67: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-05-31 13:00:49.714779 :9E71FE6F: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-05-31 13:00:49.717251 :9E71FE77: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-05-31 13:00:49.718415 :9E71FE7F: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-05-31 13:00:49.767158 :9E71FE87: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-05-31 13:00:49.768675 :9E71FE8F: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-05-31 13:00:49.769530 :9E71FE97: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-05-31 13:00:49.769760 :9E71FE9F: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-05-31 13:00:49.769996 :9E71FEA7: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-05-31 13:00:49.771801 :9E71FEAF:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-31 13:33:52.839537 :9E748E70:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-31 13:33:52.827 2025-05-31 13:33:52.839540 :9E748E71:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=5912 pso_num=29 pso_serial#=150 2025-05-31 13:33:52.839719 :9E748E72:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=5912 osp_idx=27 osp_ver=11879 osp_pg=0 (spawn #237982) 2025-05-31 13:33:52.839722 :9E748E73:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-31 13:33:52.839722 :9E748E74:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=143 time=1674191485 2025-05-31 13:33:52.839723 :9E748E75:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-31 13:33:52.839723 :9E748E76:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-31 13:33:52.839724 :9E748E77:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-31 13:33:52.839724 :9E748E78:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-31 13:33:52.839724 :9E748E79:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-31 13:33:52.840239 :9E748E7A: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-05-31 13:33:52.840282 :9E748E80: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-05-31 13:33:52.844341 :9E748E99:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-31 13:33:52.844384 :9E748E9A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-31 13:33:52.844649 :9E748E9B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-31 13:33:52.844666 :9E748E9C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-31 13:33:52.844886 :9E748E9D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-31 13:33:52.844900 :9E748E9E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-31 13:33:52.845110 :9E748E9F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-31 13:33:52.845123 :9E748EA0:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-31 13:33:52.845344 :9E748EA1:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-31 13:33:52.845357 :9E748EA2:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-31 13:33:52.845561 :9E748EA3:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-31 13:33:52.845575 :9E748EA4:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-31 13:33:52.847836 :9E748EA5:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-31 14:00:58.032195 :9E76A220:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-31 14:00:58.031 2025-05-31 14:00:58.032197 :9E76A221:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=15256 pso_num=29 pso_serial#=151 2025-05-31 14:00:58.032332 :9E76A222:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=15256 osp_idx=27 osp_ver=11880 osp_pg=0 (spawn #238043) 2025-05-31 14:00:58.032333 :9E76A223:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-31 14:00:58.032333 :9E76A224:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=144 time=1675816672 2025-05-31 14:00:58.032333 :9E76A225:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-31 14:00:58.032334 :9E76A226:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-31 14:00:58.032334 :9E76A227:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-31 14:00:58.032334 :9E76A228:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-31 14:00:58.032335 :9E76A229:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-31 14:00:58.032845 :9E76A22A: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-05-31 14:00:58.032890 :9E76A230: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-05-31 14:00:58.040202 :9E76A23E: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-05-31 14:00:58.041260 :9E76A246: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-05-31 14:00:58.041805 :9E76A24E: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-05-31 14:00:58.042306 :9E76A256: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-05-31 14:00:58.042779 :9E76A25E: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-05-31 14:00:58.045188 :9E76A266: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-05-31 14:00:58.046345 :9E76A26E: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-05-31 14:00:58.096304 :9E76A276: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-05-31 14:00:58.097218 :9E76A27E: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-05-31 14:00:58.097472 :9E76A286: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-05-31 14:00:58.097685 :9E76A28E: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-05-31 14:00:58.099485 :9E76A296:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-31 14:03:57.040585 :9E76DDD1:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-31 14:03:57.028 2025-05-31 14:03:57.040587 :9E76DDD2:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=13256 pso_num=29 pso_serial#=152 2025-05-31 14:03:57.040723 :9E76DDD3:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=13256 osp_idx=27 osp_ver=11881 osp_pg=0 (spawn #238052) 2025-05-31 14:03:57.040724 :9E76DDD4:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-31 14:03:57.040724 :9E76DDD5:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=145 time=1675995688 2025-05-31 14:03:57.040725 :9E76DDD6:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-31 14:03:57.040725 :9E76DDD7:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-31 14:03:57.040725 :9E76DDD8:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-31 14:03:57.040726 :9E76DDD9:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-31 14:03:57.040726 :9E76DDDA:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-31 14:03:57.041225 :9E76DDDB: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-05-31 14:03:57.041285 :9E76DDE1: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-05-31 14:03:57.045412 :9E76DDF8:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-31 14:03:57.045460 :9E76DDF9:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-31 14:03:57.045714 :9E76DDFA:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-31 14:03:57.045730 :9E76DDFB:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-31 14:03:57.045948 :9E76DDFC:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-31 14:03:57.045961 :9E76DDFD:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-31 14:03:57.046170 :9E76DDFE:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-31 14:03:57.046182 :9E76DDFF:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-31 14:03:57.046388 :9E76DE00:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-31 14:03:57.046400 :9E76DE01:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-31 14:03:57.046646 :9E76DE02:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-31 14:03:57.046666 :9E76DE03:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-31 14:03:57.048960 :9E76DE28:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 29 (osid: 13256, M001)