Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250501220008\orcl_j004_7316_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250501220008\orcl_j004_7316_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:37595M/63366M, Ph+PgF:45172M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 30 Windows thread id: 7316, image: ORACLE.EXE (J004) *** 2025-05-01 22:00:08.159 *** SESSION ID:(241.1245) 2025-05-01 22:00:08.159 *** 2025-05-01 22:00:08.159 Process diagnostic dump for ORACLE.EXE (J004), OS id=7316, pid: 30, proc_ser: 103, sid: 241, sess_ser: 1245 ------------------------------------------------------------------------------- current sql: <none> client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 7316 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J004) 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.496360 sec, exc=0.496360 sec, total=0.496360 sec wait times: max=0.500000 sec, heur=6.000935 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.000010 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.499979 sec, exc=0.499979 sec, total=0.499979 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 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.500313 sec, exc=0.500313 sec, total=0.500313 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.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 3: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=7 seq_num=8 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.000009 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.499981 sec, exc=0.499981 sec, total=0.499981 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 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.500004 sec, exc=0.500004 sec, total=0.500004 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000011 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.500007 sec, exc=0.500007 sec, total=0.500007 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 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.500173 sec, exc=0.500173 sec, total=0.500173 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000010 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.510889 sec, exc=0.510889 sec, total=0.510889 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000007 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.500011 sec, exc=0.500011 sec, total=0.500011 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 sec of elapsed time Sampled Session History of session 241 serial 1245 --------------------------------------------------- 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:02 - 22:00:08] idle wait at each sample [session created at: 22:00:02] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-05-01 22:00:08.159 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 30 (osid: 7316, J004) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-01 00:04:05.882565 :9101457A:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=8780 (legacy spawn) 2025-05-01 00:04:05.889060 :9101457B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-01 00:04:05.889230 :91014580:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-01 00:04:05.890054 :91014585:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-05-01 00:04:07.615908 :910145FA:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 05-01 00:04:07.603 2025-05-01 00:04:07.615910 :910145FB:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=10020 pso_num=30 pso_serial#=92 2025-05-01 00:04:07.616042 :910145FC:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=10020 (legacy spawn) 2025-05-01 00:04:07.622476 :910145FD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-01 00:04:07.622664 :91014602:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-01 00:04:07.623504 :91014607:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-05-01 00:04:07.642755 :9101460A:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 05-01 00:04:07.634 2025-05-01 00:04:07.642758 :9101460B:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=12116 pso_num=30 pso_serial#=93 2025-05-01 00:04:07.642893 :9101460C:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=12116 (legacy spawn) 2025-05-01 00:04:07.649271 :9101460D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-01 00:04:07.649481 :91014614:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-01 00:04:07.650327 :91014617:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-05-01 00:04:10.118370 :910146FE:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 05-01 00:04:10.109 2025-05-01 00:04:10.118372 :910146FF:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=11180 pso_num=30 pso_serial#=94 2025-05-01 00:04:10.118514 :91014700:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=11180 (legacy spawn) 2025-05-01 00:04:10.124994 :91014701:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-01 00:04:10.125169 :91014706:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-01 00:04:10.125992 :9101470B:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-05-01 00:04:54.938132 :910155C2:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 05-01 00:04:54.933 2025-05-01 00:04:54.938134 :910155C3:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=10304 pso_num=30 pso_serial#=95 2025-05-01 00:04:54.938271 :910155C4:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=10304 osp_idx=28 osp_ver=604 osp_pg=0 (spawn #135463) 2025-05-01 00:04:54.938272 :910155C5:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-01 00:04:54.938272 :910155C6:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=24 time=3328684421 2025-05-01 00:04:54.938273 :910155C7:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-05-01 00:04:54.938273 :910155C8:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-05-01 00:04:54.938274 :910155C9:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-05-01 00:04:54.938274 :910155CA:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-01 00:04:54.938274 :910155CB:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-01 00:04:54.938780 :910155CC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-01 00:04:54.938828 :910155D2:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] 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 00:04:54.959100 :91015620:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-05-01 00:05:08.091218 :91015A18:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 05-01 00:05:08.082 2025-05-01 00:05:08.091221 :91015A19:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=11992 pso_num=30 pso_serial#=96 2025-05-01 00:05:08.091380 :91015A1A:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=11992 (legacy spawn) 2025-05-01 00:05:08.097753 :91015A1B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-01 00:05:08.097929 :91015A24:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-01 00:05:08.098772 :91015A25:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-05-01 00:05:52.643269 :91016A22:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 05-01 00:05:52.635 2025-05-01 00:05:52.643271 :91016A23:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=11196 pso_num=30 pso_serial#=97 2025-05-01 00:05:52.643408 :91016A24:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=11196 (legacy spawn) 2025-05-01 00:05:52.649872 :91016A25:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-01 00:05:52.650050 :91016A2A:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-01 00:05:52.650820 :91016A2F:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-05-01 00:05:53.195601 :91016A6C:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 05-01 00:05:53.182 2025-05-01 00:05:53.195604 :91016A6D:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=9580 pso_num=30 pso_serial#=98 2025-05-01 00:05:53.195740 :91016A6E:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=9580 (legacy spawn) 2025-05-01 00:05:53.202202 :91016A6F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-01 00:05:53.202378 :91016A74:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-01 00:05:53.203164 :91016A79:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-05-01 00:05:53.211793 :91016A7C:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 05-01 00:05:53.197 2025-05-01 00:05:53.211795 :91016A7D:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=9176 pso_num=30 pso_serial#=99 2025-05-01 00:05:53.211926 :91016A7E:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=9176 (legacy spawn) 2025-05-01 00:05:53.218451 :91016A7F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-01 00:05:53.218622 :91016A88:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-01 00:05:53.219434 :91016A89:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-05-01 00:05:56.401841 :91016B8E:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 05-01 00:05:56.394 2025-05-01 00:05:56.401843 :91016B8F:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=12036 pso_num=30 pso_serial#=100 2025-05-01 00:05:56.401975 :91016B90:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=12036 (legacy spawn) 2025-05-01 00:05:56.408394 :91016B91:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-01 00:05:56.408568 :91016B9A:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-01 00:05:56.409376 :91016B9B:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-05-01 00:05:56.417935 :91016B9E:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 05-01 00:05:56.410 2025-05-01 00:05:56.417937 :91016B9F:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=9780 pso_num=30 pso_serial#=101 2025-05-01 00:05:56.418073 :91016BA0:db_trace:kso.c@4070:ksonfy(): [10420:30:0] kso: new process: pid=9780 (legacy spawn) 2025-05-01 00:05:56.424466 :91016BA1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-01 00:05:56.424632 :91016BAA:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-01 00:05:56.425455 :91016BAB:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-05-01 01:00:02.207287 :91059F14:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 05-01 01:00:02.205 2025-05-01 01:00:02.207287 :91059F15:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=9184 pso_num=30 pso_serial#=102 2025-05-01 01:00:02.207416 :91059F16:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=9184 osp_idx=28 osp_ver=611 osp_pg=0 (spawn #135592) 2025-05-01 01:00:02.207417 :91059F17:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-01 01:00:02.207417 :91059F18:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=25 time=3331991671 2025-05-01 01:00:02.207418 :91059F19:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-05-01 01:00:02.207418 :91059F1A:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-05-01 01:00:02.207419 :91059F1B:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-05-01 01:00:02.207419 :91059F1C:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-01 01:00:02.207419 :91059F1D:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-01 01:00:02.207923 :91059F1E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-01 01:00:02.207981 :91059F24:db_trace:ksl2.c@12699:ksliwat(): [10005:30:241] 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 01:00:02.216362 :91059F36:db_trace:kst.c@698:kstpsodel(): [10280:30:0] kst: process state object about to be deleted 2025-05-01 22:00:00.242373 :916709E5:db_trace:kst.c@673:kstipg(): [10280:30:0] kst: process state object created on 05-01 22:00:00.241 2025-05-01 22:00:00.242374 :916709E6:db_trace:kst.c@679:kstipg(): [10280:30:0] kst: process info: ospid=7316 pso_num=30 pso_serial#=103 2025-05-01 22:00:00.242539 :916709E8:db_trace:kso.c@4093:ksonfy(): [10420:30:0] kso: new process: pid=7316 osp_idx=28 osp_ver=612 osp_pg=0 (spawn #138545) 2025-05-01 22:00:00.242540 :916709E9:db_trace:kso.c@4099:ksonfy(): [10420:30:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-01 22:00:00.242541 :916709EA:db_trace:kso.c@4103:ksonfy(): [10420:30:0] kso: new process: pso_index=30 reservation=26 time=3407589718 2025-05-01 22:00:00.242541 :916709EB:db_trace:kso.c@4109:ksonfy(): [10420:30:0] kso: spawn diagnostics: queue time=0 secs 2025-05-01 22:00:00.242542 :916709EC:db_trace:kso.c@4111:ksonfy(): [10420:30:0] kso: spawn diagnostics: fork time=0 secs 2025-05-01 22:00:00.242543 :916709ED:db_trace:kso.c@4113:ksonfy(): [10420:30:0] kso: spawn diagnostics: exec time=0 secs 2025-05-01 22:00:00.242544 :916709EE:db_trace:kso.c@4115:ksonfy(): [10420:30:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-01 22:00:00.242544 :916709EF:db_trace:kso.c@4117:ksonfy(): [10420:30:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-01 22:00:00.243141 :916709F0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-01 22:00:00.248387 :91670B5A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-01 22:00:00.248431 :91670B5D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:jslv.c:9203 2025-05-01 22:00:00.253719 :91670B87:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-01 22:00:00.461374 :91670CEE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-01 22:00:00.650781 :91670CFE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-01 22:00:00.784599 :91670D1E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-01 22:00:00.904321 :91670D2E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-01 22:00:01.902814 :91670F08:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-01 22:00:01.903786 :91670F10:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-01 22:00:01.905393 :91670F18:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-01 22:00:01.909257 :91670F20:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-01 22:00:01.911692 :91670F28:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-01 22:00:01.913113 :91670F30:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-01 22:00:01.915419 :91670F38:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-01 22:00:01.916873 :91670F40:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-01 22:00:01.936850 :91670F48:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-01 22:00:01.937455 :91670F52:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-01 22:00:01.937971 :91670F5A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-01 22:00:01.938470 :91670F62:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-01 22:00:01.941122 :91670F6A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-01 22:00:01.942042 :91670F74:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-05-01 22:00:01.942851 :91670F75:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-05-01 22:00:01.943709 :91670F76:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-05-01 22:00:01.944184 :91670F77:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-05-01 22:00:01.944192 :91670F78:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-05-01 22:00:01.944833 :91670F7C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-05-01 22:00:01.945361 :91670F82:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-05-01 22:00:01.945702 :91670F83:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-05-01 22:00:01.992510 :91670FBB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-01 22:00:01.993569 :91670FC3:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-05-01 22:00:02.036348 :91670FD0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-01 22:00:02.036396 :91670FD3:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-05-01 22:00:02.037294 :91670FD9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-01 22:00:02.038310 :91670FE1:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-05-01 22:00:02.038781 :91670FE2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-01 22:00:02.059523 :91670FEA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-01 22:00:02.059570 :91670FED:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-05-01 22:00:02.060416 :91670FF3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-01 22:00:02.071709 :91670FFB:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-05-01 22:00:02.072228 :91670FFC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-01 22:00:02.092449 :9167102C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-01 22:00:02.092499 :9167102F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-05-01 22:00:02.093387 :91671035:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-01 22:00:02.094267 :9167103D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-05-01 22:00:02.094694 :9167103E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-01 22:00:02.112475 :9167104E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-01 22:00:02.112519 :91671051:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-05-01 22:00:02.113269 :91671057:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-01 22:00:02.114112 :9167105F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-05-01 22:00:02.114547 :91671060:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-01 22:00:02.135188 :91671068:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-01 22:00:02.135258 :9167106B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-05-01 22:00:02.136140 :91671071:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-01 22:00:02.136992 :91671079:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpus:psdpgi.c:2235 2025-05-01 22:00:02.137432 :9167107A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-01 22:00:02.147111*:91671082:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000003193A240 estart=1746108001 eid=16777621 ctx=0x000000077B42EF30 cwh=0x0000000031921650 cpu=0 buffg=0 interb=0 r=0 rb=0 w=0 wb=0 2025-05-01 22:00:02.147111*:91671083:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000003193A240 curCtx=0x0000000031937BE8 pubTabIdxCnt=0 2025-05-01 22:00:02.147111*:91671084:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000003193A240 2025-05-01 22:00:02.147111*:91671085:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000003193A240 2025-05-01 22:00:02.147111*:91671086:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000003197E7C8 estart=1746108001 eid=16777621 ctx=0x000000077B447BE8 cwh=0x000000002B58C818 cpu=15625 buffg=696 interb=0 r=0 rb=0 w=0 wb=0 2025-05-01 22:00:02.147111*:91671087:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000003197E7C8 curCtx=0x0000000031938EC0 pubTabIdxCnt=0 2025-05-01 22:00:02.147111*:91671088:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000003197E7C8 2025-05-01 22:00:02.147111*:91671089:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000003197E7C8 2025-05-01 22:00:02.147111*:9167108A:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000002B5B3768 estart=1746108001 eid=16777621 ctx=0x000000077B458BE8 cwh=0x00000000319D0068 cpu=15625 buffg=733 interb=16384 r=2 rb=16384 w=0 wb=0 2025-05-01 22:00:02.147111*:9167108B:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000002B5B3768 curCtx=0x0000000031A89EF0 pubTabIdxCnt=0 2025-05-01 22:00:02.147111*:9167108C:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000002B5B3768 2025-05-01 22:00:02.147111*:9167108D:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000002B5B3768 2025-05-01 22:00:02.147111*:9167108E:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000003193A240 curCtx=0x0000000031937BE8 xsc->flg4=65792 flags=1 2025-05-01 22:00:02.147111*:9167108F:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000003193A240 2025-05-01 22:00:02.147111*:91671098:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000003197E7C8 curCtx=0x0000000031938EC0 xsc->flg4=65792 flags=1 2025-05-01 22:00:02.147111*:91671099:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000003197E7C8 2025-05-01 22:00:02.147111*:9167109C:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000002B5B3768 curCtx=0x0000000031A89EF0 xsc->flg4=65792 flags=2 2025-05-01 22:00:02.147111*:9167109D:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000002B5B3768 2025-05-01 22:00:02.159408 :9167109E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-01 22:00:02.159456 :916710A1:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:psdpgi.c:2235 2025-05-01 22:00:02.160376 :916710A7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-01 22:00:02.160855 :916710AF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-01 22:00:02.161229 :916710B7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-01 22:00:02.161399 :916710BF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-01 22:00:02.161532 :916710C7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-01 22:00:02.161687 :916710CF:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:30:241] atxpop:jslv.c:9203 2025-05-01 22:00:02.165535 :916710D0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-01 22:00:02.165627 :916710D3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:30:241] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 30 (osid: 7316, J004)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de