Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250711220009\orcl_j000_16980_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250711220009\orcl_j000_16980_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:36430M/63366M, Ph+PgF:42512M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 24 Windows thread id: 16980, image: ORACLE.EXE (J000) *** 2025-07-11 22:00:09.630 *** SESSION ID:(193.43749) 2025-07-11 22:00:09.630 *** 2025-07-11 22:00:09.630 Process diagnostic dump for ORACLE.EXE (J000), OS id=16980, pid: 24, proc_ser: 222, sid: 193, sess_ser: 43749 ------------------------------------------------------------------------------- current sql: <none> client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 16980 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J000) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=11 seq_num=12 snap_id=1 wait times: snap=0.094299 sec, exc=0.094299 sec, total=0.094299 sec wait times: max=0.500000 sec, heur=5.603237 sec wait counts: calls=1 os=1 in_wait=1 iflags=0x5a8 Wait State: fixed_waits=0 flags=0x22 boundary=0x0000000000000000/-1 Session Wait History: elapsed time of 0.000009 sec since current wait 0: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=10 seq_num=11 snap_id=1 wait times: snap=0.499999 sec, exc=0.499999 sec, total=0.499999 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000012 sec of elapsed time 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=9 seq_num=10 snap_id=1 wait times: snap=0.507867 sec, exc=0.507867 sec, total=0.507867 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000010 sec of elapsed time 2: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=8 seq_num=9 snap_id=1 wait times: snap=0.500452 sec, exc=0.500452 sec, total=0.500452 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000011 sec of elapsed time 3: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=7 seq_num=8 snap_id=1 wait times: snap=0.500001 sec, exc=0.500001 sec, total=0.500001 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 4: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=6 seq_num=7 snap_id=1 wait times: snap=0.500000 sec, exc=0.500000 sec, total=0.500000 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000006 sec of elapsed time 5: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=5 seq_num=6 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.000007 sec of elapsed time 6: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=4 seq_num=5 snap_id=1 wait times: snap=0.500002 sec, exc=0.500002 sec, total=0.500002 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000007 sec of elapsed time 7: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=3 seq_num=4 snap_id=1 wait times: snap=0.510111 sec, exc=0.510111 sec, total=0.510111 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000006 sec of elapsed time 8: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=2 seq_num=3 snap_id=1 wait times: snap=0.499976 sec, exc=0.499976 sec, total=0.499976 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000013 sec of elapsed time 9: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=1 seq_num=2 snap_id=1 wait times: snap=0.500018 sec, exc=0.500018 sec, total=0.500018 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time Sampled Session History of session 193 serial 43749 --------------------------------------------------- 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 --------------------------------------------------- [6 samples, 22:00:04 - 22:00:09] idle wait at each sample [session created at: 22:00:04] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-07-11 22:00:09.630 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 24 (osid: 16980, J000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-07-11 21:51:46.452622 :B0B70C13:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-11 21:52:16.459730 :B0B715E5:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-11 21:52:16.448 2025-07-11 21:52:16.459733 :B0B715E6:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=5092 pso_num=24 pso_serial#=213 2025-07-11 21:52:16.459877 :B0B715E7:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=5092 osp_idx=22 osp_ver=558928 osp_pg=0 (spawn #375801) 2025-07-11 21:52:16.459878 :B0B715E8:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-11 21:52:16.459878 :B0B715E9:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=233 time=951512345 2025-07-11 21:52:16.459879 :B0B715EA:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-07-11 21:52:16.459879 :B0B715EB:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-07-11 21:52:16.459880 :B0B715EC:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-07-11 21:52:16.459880 :B0B715ED:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-11 21:52:16.459880 :B0B715EE:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-11 21:52:16.460363 :B0B715EF: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-07-11 21:52:46.575712 :B0B71F78:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-11 21:53:16.530657 :B0B7297A:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-11 21:53:16.519 2025-07-11 21:53:16.530660 :B0B7297B:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=4508 pso_num=24 pso_serial#=214 2025-07-11 21:53:16.530793 :B0B7297C:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=4508 osp_idx=22 osp_ver=558929 osp_pg=0 (spawn #375804) 2025-07-11 21:53:16.530794 :B0B7297D:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-11 21:53:16.530794 :B0B7297E:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=234 time=951572423 2025-07-11 21:53:16.530795 :B0B7297F:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-07-11 21:53:16.530795 :B0B72980:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-07-11 21:53:16.530795 :B0B72981:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-07-11 21:53:16.530796 :B0B72982:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-11 21:53:16.530796 :B0B72983:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-11 21:53:16.531300 :B0B72984: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-07-11 21:53:46.606708 :B0B733AB:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-11 21:54:16.606675 :B0B73D84:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-11 21:54:16.595 2025-07-11 21:54:16.606678 :B0B73D85:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=8036 pso_num=24 pso_serial#=215 2025-07-11 21:54:16.606817 :B0B73D86:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=8036 osp_idx=22 osp_ver=558930 osp_pg=0 (spawn #375806) 2025-07-11 21:54:16.606817 :B0B73D87:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-11 21:54:16.606818 :B0B73D88:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=235 time=951632501 2025-07-11 21:54:16.606818 :B0B73D89:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-07-11 21:54:16.606818 :B0B73D8A:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-07-11 21:54:16.606819 :B0B73D8B:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-07-11 21:54:16.606819 :B0B73D8C:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-11 21:54:16.606820 :B0B73D8D:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-11 21:54:16.607296 :B0B73D8E: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-07-11 21:54:46.643135 :B0B74717:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-11 21:55:16.667483 :B0B750C6:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-11 21:55:16.656 2025-07-11 21:55:16.667485 :B0B750C7:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=13632 pso_num=24 pso_serial#=216 2025-07-11 21:55:16.667625 :B0B750C8:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=13632 osp_idx=22 osp_ver=558931 osp_pg=0 (spawn #375808) 2025-07-11 21:55:16.667626 :B0B750C9:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-11 21:55:16.667626 :B0B750CA:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=236 time=951692548 2025-07-11 21:55:16.667627 :B0B750CB:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-07-11 21:55:16.667627 :B0B750CC:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-07-11 21:55:16.667627 :B0B750CD:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-07-11 21:55:16.667627 :B0B750CE:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-11 21:55:16.667628 :B0B750CF:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-11 21:55:16.668112 :B0B750D0: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-07-11 21:55:46.745255 :B0B75AEE:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-11 21:56:16.751369 :B0B76481:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-11 21:56:16.740 2025-07-11 21:56:16.751371 :B0B76482:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=15316 pso_num=24 pso_serial#=217 2025-07-11 21:56:16.751500 :B0B76483:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=15316 osp_idx=22 osp_ver=558932 osp_pg=0 (spawn #375811) 2025-07-11 21:56:16.751500 :B0B76484:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-11 21:56:16.751501 :B0B76485:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=237 time=951752642 2025-07-11 21:56:16.751501 :B0B76486:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-07-11 21:56:16.751501 :B0B76487:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-07-11 21:56:16.751502 :B0B76488:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-07-11 21:56:16.751502 :B0B76489:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-11 21:56:16.751502 :B0B7648A:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-11 21:56:16.751998 :B0B7648B: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-07-11 21:56:41.770142 :B0B76CD4: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-07-11 21:57:11.855170 :B0B7767D:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-11 21:57:16.848580 :B0B7783E:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-11 21:57:16.837 2025-07-11 21:57:16.848582 :B0B7783F:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=12684 pso_num=24 pso_serial#=218 2025-07-11 21:57:16.848716 :B0B77840:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=12684 osp_idx=22 osp_ver=558933 osp_pg=0 (spawn #375813) 2025-07-11 21:57:16.848716 :B0B77841:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-11 21:57:16.848716 :B0B77842:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=238 time=951812736 2025-07-11 21:57:16.848717 :B0B77843:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-07-11 21:57:16.848717 :B0B77844:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-07-11 21:57:16.848718 :B0B77845:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-07-11 21:57:16.848718 :B0B77846:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-11 21:57:16.848718 :B0B77847:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-11 21:57:16.849243 :B0B77848: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-07-11 21:57:46.915463 :B0B7820C:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-11 21:58:16.988751 :B0B78C2C:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-11 21:58:16.989 2025-07-11 21:58:16.988753 :B0B78C2D:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=4728 pso_num=24 pso_serial#=219 2025-07-11 21:58:16.988901 :B0B78C2E:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=4728 osp_idx=22 osp_ver=558934 osp_pg=0 (spawn #375816) 2025-07-11 21:58:16.988902 :B0B78C2F:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-11 21:58:16.988903 :B0B78C30:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=239 time=951872876 2025-07-11 21:58:16.988904 :B0B78C31:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-07-11 21:58:16.988904 :B0B78C32:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-07-11 21:58:16.988904 :B0B78C33:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-07-11 21:58:16.988905 :B0B78C34:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-11 21:58:16.988905 :B0B78C35:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-11 21:58:16.989379 :B0B78C36: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-07-11 21:58:47.101946 :B0B7960A:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-11 21:59:17.056459 :B0B79FC0:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-11 21:59:17.045 2025-07-11 21:59:17.056461 :B0B79FC1:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=7532 pso_num=24 pso_serial#=220 2025-07-11 21:59:17.056607 :B0B79FC2:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=7532 osp_idx=22 osp_ver=558935 osp_pg=0 (spawn #375818) 2025-07-11 21:59:17.056608 :B0B79FC3:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-11 21:59:17.056608 :B0B79FC4:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=240 time=951932939 2025-07-11 21:59:17.056609 :B0B79FC5:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-07-11 21:59:17.056609 :B0B79FC6:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-07-11 21:59:17.056609 :B0B79FC7:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-07-11 21:59:17.056610 :B0B79FC8:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-11 21:59:17.056610 :B0B79FC9:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-11 21:59:17.057094 :B0B79FCA: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-07-11 21:59:47.137052 :B0B7A98C:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-11 22:00:00.048197 :B0B7ADF4:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-11 22:00:00.039 2025-07-11 22:00:00.048199 :B0B7ADF5:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=8400 pso_num=24 pso_serial#=221 2025-07-11 22:00:00.048333 :B0B7ADF6:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=8400 osp_idx=22 osp_ver=558936 osp_pg=0 (spawn #375820) 2025-07-11 22:00:00.048333 :B0B7ADF7:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-11 22:00:00.048334 :B0B7ADF8:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=241 time=951975939 2025-07-11 22:00:00.048334 :B0B7ADF9:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-07-11 22:00:00.048335 :B0B7ADFA:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-07-11 22:00:00.048335 :B0B7ADFB:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-07-11 22:00:00.048335 :B0B7ADFC:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-11 22:00:00.048336 :B0B7ADFD:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-11 22:00:00.048831 :B0B7ADFE: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-07-11 22:00:00.048877 :B0B7AE05: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-07-11 22:00:00.048953 :B0B7AE19:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-07-11 22:00:00.052909 :B0B7AE28:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-11 22:00:00.054134 :B0B7AE30:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-11 22:00:00.054159 :B0B7AE33:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-07-11 22:00:00.054199 :B0B7AE3E:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=18 loc='ksr2.h LINE:607 ID:ksrmdone' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-07-11 22:00:00.056087 :B0B7AE55:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-11 22:00:00.056114 :B0B7AE58:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-07-11 22:00:00.056161 :B0B7AE63:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=18 loc='ksr2.h LINE:607 ID:ksrmdone' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-07-11 22:00:00.056625 :B0B7AE6E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-11 22:00:00.059121 :B0B7AE76:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-11 22:00:00.064372 :B0B7AE7E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-11 22:00:00.070102 :B0B7AE86:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-11 22:00:00.071533 :B0B7AE8E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-11 22:00:00.074612 :B0B7AE96:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-11 22:00:00.075922 :B0B7AE9E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-11 22:00:00.078891 :B0B7AEA6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-11 22:00:00.082201 :B0B7AEAE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-07-11 22:00:00.082666 :B0B7AEBD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-11 22:00:00.082714 :B0B7AEC0:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:ktcc.c:879 2025-07-11 22:00:00.082728 :B0B7AEC1:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:ktcc.c:879 2025-07-11 22:00:00.084715 :B0B7AEC7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-11 22:00:00.084758 :B0B7AECA:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:ktcc.c:879 2025-07-11 22:00:00.084769 :B0B7AECB:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:ktcc.c:879 2025-07-11 22:00:00.087023 :B0B7AEF4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-11 22:00:00.087062 :B0B7AEF7:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:ktcc.c:879 2025-07-11 22:00:00.087075 :B0B7AEF8:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:ktcc.c:879 2025-07-11 22:00:00.087299 :B0B7AEFE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-11 22:00:00.087319 :B0B7AF01:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-07-11 22:00:00.087346 :B0B7AF0D:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=18 loc='ksr2.h LINE:607 ID:ksrmdone' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-07-11 22:00:00.089027 :B0B7AF17:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-11 22:00:02.045221 :B0B7AFA2:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-11 22:00:02.039 2025-07-11 22:00:02.045223 :B0B7AFA3:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=16980 pso_num=24 pso_serial#=222 2025-07-11 22:00:02.045367 :B0B7AFA4:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=16980 osp_idx=22 osp_ver=558937 osp_pg=0 (spawn #375821) 2025-07-11 22:00:02.045367 :B0B7AFA5:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-11 22:00:02.045368 :B0B7AFA6:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=242 time=951977939 2025-07-11 22:00:02.045368 :B0B7AFA7:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-07-11 22:00:02.045369 :B0B7AFA8:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-07-11 22:00:02.045369 :B0B7AFA9:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-07-11 22:00:02.045369 :B0B7AFAA:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-11 22:00:02.045370 :B0B7AFAB:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-11 22:00:02.045855 :B0B7AFAC: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-07-11 22:00:02.051144 :B0B7AFCB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-11 22:00:02.051184 :B0B7AFCF:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:jslv.c:9203 2025-07-11 22:00:02.060860 :B0B7B025:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-11 22:00:02.063125 :B0B7B055:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-11 22:00:02.068230 :B0B7B074:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-11 22:00:02.069015 :B0B7B0BC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-11 22:00:02.074476 :B0B7B1CE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-07-11 22:00:02.074640 :B0B7B1DE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-11 22:00:02.075425 :B0B7B1F4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-11 22:00:02.075717 :B0B7B1FC:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:jslv.c:9203 2025-07-11 22:00:02.077198 :B0B7B1FD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-11 22:00:02.077238 :B0B7B200:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 2025-07-11 22:00:02.077317 :B0B7B20D:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-11 22:00:02.180651 :B0B7B305: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-07-11 22:00:02.182711 :B0B7B309:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-11 22:00:02.182750 :B0B7B30C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:jslv.c:9203 2025-07-11 22:00:02.185171 :B0B7B312:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:jslv.c:9203 2025-07-11 22:00:02.188373 :B0B7B313:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-11 22:00:02.188447 :B0B7B316:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 2025-07-11 22:00:02.188555 :B0B7B322:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-11 22:00:04.012741 :B0B7B72F: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-07-11 22:00:04.012741*:B0B7B732:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000024D5C718 estart=1752242403 eid=16783997 ctx=0x000000077FD6A000 cwh=0x0000000024D50068 cpu=0 buffg=1 interb=0 r=0 rb=0 w=0 wb=0 2025-07-11 22:00:04.012741*:B0B7B733:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000024D5C718 curCtx=0x0000000024D58938 pubTabIdxCnt=0 2025-07-11 22:00:04.012741*:B0B7B734:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000024D5C718 2025-07-11 22:00:04.012741*:B0B7B735:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000024D5C718 2025-07-11 22:00:04.012741*:B0B7B736:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000024D5C718 curCtx=0x0000000024D58938 xsc->flg4=65792 flags=2 2025-07-11 22:00:04.012741*:B0B7B737:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000024D5C718 2025-07-11 22:00:04.015135 :B0B7B738:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-11 22:00:04.015176 :B0B7B73B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:jslv.c:9203 2025-07-11 22:00:04.022816 :B0B7B741:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-11 22:00:04.023491 :B0B7B749:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-11 22:00:04.024145 :B0B7B751:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-11 22:00:04.024346 :B0B7B759:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:jslv.c:9203 2025-07-11 22:00:04.026031 :B0B7B75A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-11 22:00:04.026081 :B0B7B75D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 2025-07-11 22:00:04.026158 :B0B7B76A:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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 24 (osid: 16980, J000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de