Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250531100329\orcl_j001_15216_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250531100329\orcl_j001_15216_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:37240M/63366M, Ph+PgF:44147M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 26 Windows thread id: 15216, image: ORACLE.EXE (J001) *** 2025-05-31 10:03:29.367 *** SESSION ID:(209.10279) 2025-05-31 10:03:29.367 *** 2025-05-31 10:03:29.367 Process diagnostic dump for ORACLE.EXE (J001), OS id=15216, pid: 26, proc_ser: 147, sid: 209, sess_ser: 10279 ------------------------------------------------------------------------------- current sql: <none> client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 15216 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J001) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=5 seq_num=6 snap_id=1 wait times: snap=0.007223 sec, exc=0.007223 sec, total=0.007223 sec wait times: max=0.500000 sec, heur=2.502025 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.000007 sec since current wait 0: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=4 seq_num=5 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.000009 sec of elapsed time 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=3 seq_num=4 snap_id=1 wait times: snap=0.499991 sec, exc=0.499991 sec, total=0.499991 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000011 sec of elapsed time 2: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=2 seq_num=3 snap_id=1 wait times: snap=0.505094 sec, exc=0.505094 sec, total=0.505094 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000013 sec of elapsed time 3: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=1 seq_num=2 snap_id=1 wait times: snap=0.499990 sec, exc=0.499990 sec, total=0.499990 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=0 seq_num=1 snap_id=1 wait times: snap=0.489677 sec, exc=0.489677 sec, total=0.489677 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 209 serial 10279 --------------------------------------------------- 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, 10:03:26 - 10:03:29] idle wait at each sample [session created at: 10:03:26] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-05-31 10:03:29.367 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 26 (osid: 15216, J001) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-31 09:55:30.895670 :9E63BD0F:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-31 09:55:30.895671 :9E63BD10:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-31 09:55:30.895671 :9E63BD11:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-31 09:55:30.895671 :9E63BD12:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-31 09:55:30.896166 :9E63BD13:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-31 09:56:01.004074 :9E63C6CD:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-31 09:56:30.974800 :9E63D066:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-31 09:56:30.963 2025-05-31 09:56:30.974803 :9E63D067:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12636 pso_num=26 pso_serial#=138 2025-05-31 09:56:30.974935 :9E63D068:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=12636 osp_idx=24 osp_ver=364278 osp_pg=0 (spawn #237477) 2025-05-31 09:56:30.974936 :9E63D069:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-31 09:56:30.974937 :9E63D06A:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=163 time=1661149610 2025-05-31 09:56:30.974937 :9E63D06B:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-31 09:56:30.974937 :9E63D06C:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-31 09:56:30.974938 :9E63D06D:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-31 09:56:30.974938 :9E63D06E:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-31 09:56:30.974939 :9E63D06F:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-31 09:56:30.975408 :9E63D070:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-31 09:57:01.050787 :9E63D9CF:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-31 09:57:31.092501 :9E63E3BD:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-31 09:57:31.081 2025-05-31 09:57:31.092503 :9E63E3BE:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12820 pso_num=26 pso_serial#=139 2025-05-31 09:57:31.092641 :9E63E3BF:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=12820 osp_idx=24 osp_ver=364279 osp_pg=0 (spawn #237479) 2025-05-31 09:57:31.092641 :9E63E3C0:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-31 09:57:31.092642 :9E63E3C1:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=164 time=1661209735 2025-05-31 09:57:31.092642 :9E63E3C2:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-31 09:57:31.092642 :9E63E3C3:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-31 09:57:31.092643 :9E63E3C4:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-31 09:57:31.092643 :9E63E3C5:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-31 09:57:31.092643 :9E63E3C6:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-31 09:57:31.093108 :9E63E3C7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-31 09:58:01.188934 :9E63ED99:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-31 09:58:06.167801 :9E63EF4E:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-31 09:58:06.156 2025-05-31 09:58:06.167803 :9E63EF4F:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12132 pso_num=26 pso_serial#=140 2025-05-31 09:58:06.167938 :9E63EF50:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=12132 osp_idx=24 osp_ver=364280 osp_pg=0 (spawn #237481) 2025-05-31 09:58:06.167939 :9E63EF51:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-31 09:58:06.167939 :9E63EF52:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=165 time=1661244813 2025-05-31 09:58:06.167939 :9E63EF53:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-31 09:58:06.167940 :9E63EF54:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-31 09:58:06.167940 :9E63EF55:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-31 09:58:06.167940 :9E63EF56:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-31 09:58:06.167941 :9E63EF57:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-31 09:58:06.168413 :9E63EF58:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-31 09:58:31.195343 :9E63F779:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-31 09:59:01.321920 :9E6400CD:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-31 09:59:31.288846 :9E640A8D:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-31 09:59:31.278 2025-05-31 09:59:31.288847 :9E640A8E:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=10020 pso_num=26 pso_serial#=141 2025-05-31 09:59:31.288984 :9E640A8F:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=10020 osp_idx=24 osp_ver=364281 osp_pg=0 (spawn #237483) 2025-05-31 09:59:31.288985 :9E640A90:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-31 09:59:31.288985 :9E640A91:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=166 time=1661329922 2025-05-31 09:59:31.288986 :9E640A92:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-31 09:59:31.288986 :9E640A93:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-31 09:59:31.288986 :9E640A94:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-31 09:59:31.288987 :9E640A95:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-31 09:59:31.288987 :9E640A96:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-31 09:59:31.289442 :9E640A97:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-31 10:00:01.390172 :9E6413FC:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-31 10:00:25.992253 :9E641C38:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-31 10:00:25.990 2025-05-31 10:00:25.992255 :9E641C39:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=14700 pso_num=26 pso_serial#=142 2025-05-31 10:00:25.992383 :9E641C3A:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=14700 osp_idx=24 osp_ver=364282 osp_pg=0 (spawn #237485) 2025-05-31 10:00:25.992384 :9E641C3B:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-31 10:00:25.992384 :9E641C3C:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=167 time=1661384625 2025-05-31 10:00:25.992385 :9E641C3D:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-31 10:00:25.992385 :9E641C3E:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-31 10:00:25.992385 :9E641C3F:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-31 10:00:25.992386 :9E641C40:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-31 10:00:25.992386 :9E641C41:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-31 10:00:25.992899 :9E641C42:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-31 10:00:25.992943 :9E641C48:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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:00:26.000837 :9E641C56:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 10:00:26.001937 :9E641C5E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 10:00:26.002484 :9E641C66:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 10:00:26.002942 :9E641C6E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 10:00:26.003375 :9E641C76:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 10:00:26.005949 :9E641C7E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 10:00:26.007051 :9E641C86:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 10:00:26.058576 :9E641CC2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 10:00:26.059419 :9E641CCA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 10:00:26.059688 :9E641CD2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 10:00:26.059948 :9E641CDA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 10:00:26.061700 :9E641CE2:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-31 10:00:31.405632 :9E641EB5:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-31 10:00:31.394 2025-05-31 10:00:31.405634 :9E641EB6:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=8812 pso_num=26 pso_serial#=143 2025-05-31 10:00:31.405767 :9E641EB7:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=8812 osp_idx=24 osp_ver=364283 osp_pg=0 (spawn #237487) 2025-05-31 10:00:31.405768 :9E641EB8:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-31 10:00:31.405768 :9E641EB9:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=168 time=1661390047 2025-05-31 10:00:31.405768 :9E641EBA:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-31 10:00:31.405769 :9E641EBB:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-31 10:00:31.405769 :9E641EBC:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-31 10:00:31.405770 :9E641EBD:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-31 10:00:31.405770 :9E641EBE:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-31 10:00:31.406246 :9E641EBF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-31 10:01:01.459150 :9E642930:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-31 10:01:31.486614 :9E64332D:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-31 10:01:31.475 2025-05-31 10:01:31.486616 :9E64332E:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12772 pso_num=26 pso_serial#=144 2025-05-31 10:01:31.486754 :9E64332F:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=12772 osp_idx=24 osp_ver=364284 osp_pg=0 (spawn #237490) 2025-05-31 10:01:31.486755 :9E643330:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-31 10:01:31.486755 :9E643331:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=169 time=1661450125 2025-05-31 10:01:31.486755 :9E643332:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-31 10:01:31.486756 :9E643333:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-31 10:01:31.486756 :9E643334:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-31 10:01:31.486756 :9E643335:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-31 10:01:31.486757 :9E643336:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-31 10:01:31.487235 :9E643337:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-31 10:02:01.573772 :9E643F54:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-31 10:02:31.557004 :9E6448E2:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-31 10:02:31.546 2025-05-31 10:02:31.557007 :9E6448E3:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=14972 pso_num=26 pso_serial#=145 2025-05-31 10:02:31.557128 :9E6448E4:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=14972 osp_idx=24 osp_ver=364285 osp_pg=0 (spawn #237492) 2025-05-31 10:02:31.557129 :9E6448E5:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-31 10:02:31.557129 :9E6448E6:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=170 time=1661510204 2025-05-31 10:02:31.557129 :9E6448E7:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-31 10:02:31.557130 :9E6448E8:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-31 10:02:31.557130 :9E6448E9:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-31 10:02:31.557131 :9E6448EA:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-31 10:02:31.557131 :9E6448EB:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-31 10:02:31.557628 :9E6448EC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-31 10:03:01.654323 :9E645340:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-31 10:03:25.059438 :9E645AD8:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-31 10:03:25.047 2025-05-31 10:03:25.059440 :9E645AD9:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=3236 pso_num=26 pso_serial#=146 2025-05-31 10:03:25.059584 :9E645ADA:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=3236 osp_idx=24 osp_ver=364286 osp_pg=0 (spawn #237494) 2025-05-31 10:03:25.059585 :9E645ADB:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-31 10:03:25.059585 :9E645ADC:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=171 time=1661563704 2025-05-31 10:03:25.059586 :9E645ADD:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-31 10:03:25.059586 :9E645ADE:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-31 10:03:25.059586 :9E645ADF:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-31 10:03:25.059587 :9E645AE0:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-31 10:03:25.059587 :9E645AE1:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-31 10:03:25.060113 :9E645AE2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] 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.060155 :9E645AE8:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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.064238 :9E645AFF:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-05-31 10:03:25.064292 :9E645B00:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-05-31 10:03:25.064555 :9E645B01:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-05-31 10:03:25.064573 :9E645B02:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-05-31 10:03:25.064797 :9E645B03:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-05-31 10:03:25.064811 :9E645B04:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-05-31 10:03:25.065027 :9E645B05:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-05-31 10:03:25.065040 :9E645B06:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-05-31 10:03:25.065259 :9E645B07:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-05-31 10:03:25.065271 :9E645B08:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-05-31 10:03:25.065480 :9E645B09:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-05-31 10:03:25.065493 :9E645B0A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-05-31 10:03:25.067923 :9E645B2F:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-31 10:03:25.165985 :9E645C73:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-31 10:03:25.156 2025-05-31 10:03:25.165986 :9E645C74:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=15216 pso_num=26 pso_serial#=147 2025-05-31 10:03:25.166116 :9E645C75:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=15216 osp_idx=24 osp_ver=364287 osp_pg=0 (spawn #237498) 2025-05-31 10:03:25.166117 :9E645C76:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-31 10:03:25.166118 :9E645C77:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=172 time=1661563813 2025-05-31 10:03:25.166120 :9E645C78:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-31 10:03:25.166120 :9E645C79:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-31 10:03:25.166121 :9E645C7A:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-31 10:03:25.166121 :9E645C7B:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-31 10:03:25.166121 :9E645C7C:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-31 10:03:25.166609 :9E645C86:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-31 10:03:25.268532 :9E645D4D:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-31 10:03:25.273725 :9E645D66:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 10:03:25.273769 :9E645D69:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:jslv.c:9203 2025-05-31 10:03:25.278616 :9E645D79:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 10:03:25.404992 :9E645D81:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 10:03:25.540217 :9E645D89:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 10:03:25.671177 :9E645DBC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 10:03:26.791508 :9E645E18:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 10:03:26.792511 :9E645E20:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 10:03:26.810854 :9E645E28:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 10:03:26.811600 :9E645E30:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 10:03:26.812176 :9E645E38:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 10:03:26.812703 :9E645E40:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 10:03:26.815413 :9E645E48:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 10:03:26.816418 :9E645E50:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:psdpgi.c:2235 2025-05-31 10:03:26.817263 :9E645E51:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:psdpgi.c:2235 2025-05-31 10:03:26.818029 :9E645E52:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:psdpgi.c:2235 2025-05-31 10:03:26.818437 :9E645E53:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:psdpgi.c:2235 2025-05-31 10:03:26.818443 :9E645E54:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:psdpgi.c:2235 2025-05-31 10:03:26.819021 :9E645E55:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:psdpgi.c:2235 2025-05-31 10:03:26.819505 :9E645E56:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:psdpgi.c:2235 2025-05-31 10:03:26.819881 :9E645E57:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:psdpgi.c:2235 2025-05-31 10:03:26.820860 :9E645E58:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:psdpgi.c:2235 2025-05-31 10:03:26.863057 :9E645E59:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 10:03:26.863101 :9E645E5C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:psdpgi.c:2235 2025-05-31 10:03:26.863945 :9E645E62:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 10:03:26.864454 :9E645E6A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 10:03:26.864770 :9E645E72:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 10:03:26.864969 :9E645E7A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 10:03:26.865112 :9E645E82:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 10:03:26.865248 :9E645E8A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:jslv.c:9203 2025-05-31 10:03:26.869230 :9E645E8B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-31 10:03:26.869312 :9E645E8E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 2025-05-31 10:03:26.869389 :9E645E9B:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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 26 (osid: 15216, J001)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de