Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250501221818\orcl_m001_1820_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:37605M/63366M, Ph+PgF:45176M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 24 Windows thread id: 1820, image: ORACLE.EXE (M001) *** 2025-05-01 22:18:18.756 *** 2025-05-01 22:18:18.756 Process diagnostic dump for ORACLE.EXE (M001), OS id=1820, pid: 24, proc_ser: 122, 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-01 22:18:18.756 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 24 (osid: 1820, M001) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-01 22:04:45.746910 :916773F5:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=8588 osp_idx=22 osp_ver=205891 osp_pg=0 (spawn #138564) 2025-05-01 22:04:45.746911 :916773F6:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-01 22:04:45.746911 :916773F7:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=175 time=3407875218 2025-05-01 22:04:45.746912 :916773F8:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-05-01 22:04:45.746912 :916773F9:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-05-01 22:04:45.746912 :916773FA:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-05-01 22:04:45.746913 :916773FB:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-01 22:04:45.746913 :916773FC:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-01 22:04:45.747431 :916773FD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-01 22:05:15.822477 :9167818A:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-01 22:05:45.845490 :91678B4D:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-01 22:05:45.834 2025-05-01 22:05:45.845492 :91678B4E:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=11532 pso_num=24 pso_serial#=108 2025-05-01 22:05:45.845624 :91678B4F:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=11532 osp_idx=22 osp_ver=205892 osp_pg=0 (spawn #138566) 2025-05-01 22:05:45.845624 :91678B50:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-01 22:05:45.845625 :91678B51:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=176 time=3407935328 2025-05-01 22:05:45.845625 :91678B52:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-05-01 22:05:45.845626 :91678B53:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-05-01 22:05:45.845626 :91678B54:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-05-01 22:05:45.845626 :91678B55:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-01 22:05:45.845627 :91678B56:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-01 22:05:45.846124 :91678B57:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-01 22:06:15.940321 :91679BAA:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-01 22:06:45.924178 :9167A5B3:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-01 22:06:45.912 2025-05-01 22:06:45.924180 :9167A5B4:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=11272 pso_num=24 pso_serial#=109 2025-05-01 22:06:45.924312 :9167A5B5:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=11272 osp_idx=22 osp_ver=205893 osp_pg=0 (spawn #138568) 2025-05-01 22:06:45.924313 :9167A5B6:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-01 22:06:45.924313 :9167A5B7:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=177 time=3407995406 2025-05-01 22:06:45.924314 :9167A5B8:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-05-01 22:06:45.924314 :9167A5B9:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-05-01 22:06:45.924314 :9167A5BA:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-05-01 22:06:45.924314 :9167A5BB:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-01 22:06:45.924315 :9167A5BC:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-01 22:06:45.924787 :9167A5BD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-01 22:07:16.002974 :9167B0F2:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-01 22:07:46.021371 :9167BAD8:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-01 22:07:46.010 2025-05-01 22:07:46.021373 :9167BAD9:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=9148 pso_num=24 pso_serial#=110 2025-05-01 22:07:46.021508 :9167BADA:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=9148 osp_idx=22 osp_ver=205894 osp_pg=0 (spawn #138571) 2025-05-01 22:07:46.021509 :9167BADB:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-01 22:07:46.021509 :9167BADC:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=178 time=3408055500 2025-05-01 22:07:46.021510 :9167BADD:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-05-01 22:07:46.021510 :9167BADE:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-05-01 22:07:46.021510 :9167BADF:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-05-01 22:07:46.021511 :9167BAE0:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-01 22:07:46.021511 :9167BAE1:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-01 22:07:46.021982 :9167BAE2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-01 22:08:16.112315 :9167C4DF:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-01 22:08:46.135895 :9167CEB9:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-01 22:08:46.125 2025-05-01 22:08:46.135897 :9167CEBA:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=11836 pso_num=24 pso_serial#=111 2025-05-01 22:08:46.136030 :9167CEBB:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=11836 osp_idx=22 osp_ver=205895 osp_pg=0 (spawn #138574) 2025-05-01 22:08:46.136031 :9167CEBC:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-01 22:08:46.136032 :9167CEBD:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=179 time=3408115609 2025-05-01 22:08:46.136032 :9167CEBE:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-05-01 22:08:46.136033 :9167CEBF:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-05-01 22:08:46.136033 :9167CEC0:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-05-01 22:08:46.136034 :9167CEC1:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-01 22:08:46.136034 :9167CEC2:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-01 22:08:46.136531 :9167CEC3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-01 22:09:16.236905 :9167D835:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-01 22:09:46.235557 :9167E1F5:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-01 22:09:46.224 2025-05-01 22:09:46.235559 :9167E1F6:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=11400 pso_num=24 pso_serial#=112 2025-05-01 22:09:46.235697 :9167E1F7:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=11400 osp_idx=22 osp_ver=205896 osp_pg=0 (spawn #138576) 2025-05-01 22:09:46.235697 :9167E1F8:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-01 22:09:46.235698 :9167E1F9:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=180 time=3408175703 2025-05-01 22:09:46.235699 :9167E1FA:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-05-01 22:09:46.235699 :9167E1FB:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-05-01 22:09:46.235699 :9167E1FC:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-05-01 22:09:46.235699 :9167E1FD:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-01 22:09:46.235700 :9167E1FE:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-01 22:09:46.236200 :9167E1FF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-01 22:10:16.341277 :9167EC12:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-01 22:10:41.330430 :9167F443:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-01 22:10:41.319 2025-05-01 22:10:41.330431 :9167F444:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=11000 pso_num=24 pso_serial#=113 2025-05-01 22:10:41.330577 :9167F445:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=11000 osp_idx=22 osp_ver=205897 osp_pg=0 (spawn #138578) 2025-05-01 22:10:41.330578 :9167F446:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-01 22:10:41.330578 :9167F447:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=181 time=3408230812 2025-05-01 22:10:41.330578 :9167F448:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-05-01 22:10:41.330579 :9167F449:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-05-01 22:10:41.330579 :9167F44A:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-05-01 22:10:41.330580 :9167F44B:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-01 22:10:41.330580 :9167F44C:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-01 22:10:41.331127 :9167F44D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-01 22:10:46.327349 :9167F614:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=59 loc='kkj.h LINE:914 ID:kkjpstnp' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-01 22:11:16.408780 :9167FFFE:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-01 22:11:46.435476 :91680D84:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-01 22:11:46.424 2025-05-01 22:11:46.435478 :91680D85:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=9536 pso_num=24 pso_serial#=114 2025-05-01 22:11:46.435618 :91680D86:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=9536 osp_idx=22 osp_ver=205898 osp_pg=0 (spawn #138580) 2025-05-01 22:11:46.435618 :91680D87:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-01 22:11:46.435619 :91680D88:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=182 time=3408295906 2025-05-01 22:11:46.435619 :91680D89:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-05-01 22:11:46.435620 :91680D8A:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-05-01 22:11:46.435620 :91680D8B:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-05-01 22:11:46.435620 :91680D8C:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-01 22:11:46.435621 :91680D8D:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-01 22:11:46.436102 :91680D8E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-01 22:12:16.521595 :916817CE:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-01 22:12:46.499945 :91682187:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-01 22:12:46.489 2025-05-01 22:12:46.499947 :91682188:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=12048 pso_num=24 pso_serial#=115 2025-05-01 22:12:46.500079 :91682189:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=12048 osp_idx=22 osp_ver=205899 osp_pg=0 (spawn #138582) 2025-05-01 22:12:46.500080 :9168218A:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-01 22:12:46.500080 :9168218B:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=183 time=3408355968 2025-05-01 22:12:46.500080 :9168218C:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-05-01 22:12:46.500081 :9168218D:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-05-01 22:12:46.500081 :9168218E:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-05-01 22:12:46.500081 :9168218F:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-01 22:12:46.500082 :91682190:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-01 22:12:46.500592 :91682191:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-01 22:13:16.566622 :91682B9B:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-01 22:13:46.578621 :91683565:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-01 22:13:46.567 2025-05-01 22:13:46.578623 :91683566:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=5464 pso_num=24 pso_serial#=116 2025-05-01 22:13:46.578750 :91683567:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=5464 osp_idx=22 osp_ver=205900 osp_pg=0 (spawn #138585) 2025-05-01 22:13:46.578751 :91683568:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-01 22:13:46.578751 :91683569:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=184 time=3408416046 2025-05-01 22:13:46.578752 :9168356A:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-05-01 22:13:46.578752 :9168356B:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-05-01 22:13:46.578752 :9168356C:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-05-01 22:13:46.578752 :9168356D:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-01 22:13:46.578753 :9168356E:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-01 22:13:46.579217 :9168356F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-01 22:14:16.663132 :91683F11:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-01 22:14:46.681825 :916848BB:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-01 22:14:46.670 2025-05-01 22:14:46.681827 :916848BC:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=7348 pso_num=24 pso_serial#=117 2025-05-01 22:14:46.681955 :916848BD:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=7348 osp_idx=22 osp_ver=205901 osp_pg=0 (spawn #138587) 2025-05-01 22:14:46.681956 :916848BE:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-01 22:14:46.681956 :916848BF:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=185 time=3408476156 2025-05-01 22:14:46.681957 :916848C0:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-05-01 22:14:46.681957 :916848C1:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-05-01 22:14:46.681957 :916848C2:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-05-01 22:14:46.681958 :916848C3:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-01 22:14:46.681958 :916848C4:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-01 22:14:46.682442 :916848C5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-01 22:15:16.770273 :916852BF:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-01 22:15:46.745823 :91685CA4:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-01 22:15:46.735 2025-05-01 22:15:46.745826 :91685CA5:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=8880 pso_num=24 pso_serial#=118 2025-05-01 22:15:46.745960 :91685CA6:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=8880 osp_idx=22 osp_ver=205902 osp_pg=0 (spawn #138589) 2025-05-01 22:15:46.745961 :91685CA7:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-01 22:15:46.745962 :91685CA8:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=186 time=3408536218 2025-05-01 22:15:46.745962 :91685CA9:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-05-01 22:15:46.745963 :91685CAA:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-05-01 22:15:46.745963 :91685CAB:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-05-01 22:15:46.745963 :91685CAC:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-01 22:15:46.745964 :91685CAD:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-01 22:15:46.746466 :91685CAE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-01 22:16:16.857669 :9168666B:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-01 22:16:46.836003 :916870AC:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-01 22:16:46.824 2025-05-01 22:16:46.836005 :916870AD:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=11044 pso_num=24 pso_serial#=119 2025-05-01 22:16:46.836140 :916870AE:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=11044 osp_idx=22 osp_ver=205903 osp_pg=0 (spawn #138591) 2025-05-01 22:16:46.836140 :916870AF:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-01 22:16:46.836141 :916870B0:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=187 time=3408596312 2025-05-01 22:16:46.836141 :916870B1:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-05-01 22:16:46.836142 :916870B2:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-05-01 22:16:46.836142 :916870B3:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-05-01 22:16:46.836143 :916870B4:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-01 22:16:46.836145 :916870B5:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-01 22:16:46.836630 :916870B6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-01 22:17:16.940807 :91687B92:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-01 22:17:46.933804 :9168850B:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-01 22:17:46.922 2025-05-01 22:17:46.933806 :9168850C:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=10024 pso_num=24 pso_serial#=120 2025-05-01 22:17:46.933941 :9168850D:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=10024 osp_idx=22 osp_ver=205904 osp_pg=0 (spawn #138594) 2025-05-01 22:17:46.933942 :9168850E:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-01 22:17:46.933942 :9168850F:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=188 time=3408656406 2025-05-01 22:17:46.933943 :91688510:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-05-01 22:17:46.933943 :91688511:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-05-01 22:17:46.933944 :91688512:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-05-01 22:17:46.933944 :91688513:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-01 22:17:46.933944 :91688514:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-01 22:17:46.934427 :91688515:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-01 22:18:17.013849 :9168C8C7:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-01 22:18:17.272784 :9168C964:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-01 22:18:17.264 2025-05-01 22:18:17.272787 :9168C965:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=7940 pso_num=24 pso_serial#=121 2025-05-01 22:18:17.274981 :9168C966:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=7940 osp_idx=22 osp_ver=205905 osp_pg=0 (spawn #138597) 2025-05-01 22:18:17.274982 :9168C967:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-01 22:18:17.274983 :9168C968:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=189 time=3408686734 2025-05-01 22:18:17.274984 :9168C969:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-05-01 22:18:17.274984 :9168C96A:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-05-01 22:18:17.274984 :9168C96B:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-05-01 22:18:17.274985 :9168C96C:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-01 22:18:17.274985 :9168C96D:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-01 22:18:17.277761 :9168C96E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-01 22:18:17.277814 :9168C974:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-01 22:18:17.278272 :9168C975:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-01 22:18:18.544805 :9168CA12:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-01 22:18:18.532 2025-05-01 22:18:18.544807 :9168CA13:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=1820 pso_num=24 pso_serial#=122 2025-05-01 22:18:18.544940 :9168CA14:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=1820 osp_idx=22 osp_ver=205906 osp_pg=0 (spawn #138599) 2025-05-01 22:18:18.544941 :9168CA15:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-01 22:18:18.544941 :9168CA16:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=190 time=3408688015 2025-05-01 22:18:18.544942 :9168CA17:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-05-01 22:18:18.544942 :9168CA18:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-05-01 22:18:18.544943 :9168CA19:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-05-01 22:18:18.544943 :9168CA1A:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-01 22:18:18.544943 :9168CA1B:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-01 22:18:18.545440 :9168CA1C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-01 22:18:18.545479 :9168CA22:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-01 22:18:18.545858 :9168CA23:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 24 (osid: 1820, M001)