Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250701220433\orcl_j000_14088_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250701220433\orcl_j000_14088_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:36793M/63366M, Ph+PgF:42826M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 24 Windows thread id: 14088, image: ORACLE.EXE (J000) *** 2025-07-01 22:04:33.244 *** SESSION ID:(193.33843) 2025-07-01 22:04:33.244 *** 2025-07-01 22:04:33.244 Process diagnostic dump for ORACLE.EXE (J000), OS id=14088, pid: 24, proc_ser: 174, sid: 193, sess_ser: 33843 ------------------------------------------------------------------------------- current sql: <none> client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 14088 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J000) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=34 seq_num=35 snap_id=1 wait times: snap=0.171606 sec, exc=0.171606 sec, total=0.171606 sec wait times: max=0.500000 sec, heur=17.240282 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.000038 sec since current wait 0: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=33 seq_num=34 snap_id=1 wait times: snap=0.500161 sec, exc=0.500161 sec, total=0.500161 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000010 sec of elapsed time 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=32 seq_num=33 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.000012 sec of elapsed time 2: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=31 seq_num=32 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.000008 sec of elapsed time 3: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=30 seq_num=31 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.000012 sec of elapsed time 4: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=29 seq_num=30 snap_id=1 wait times: snap=0.509288 sec, exc=0.509288 sec, total=0.509288 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 5: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=28 seq_num=29 snap_id=1 wait times: snap=0.499998 sec, exc=0.499998 sec, total=0.499998 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000014 sec of elapsed time 6: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=27 seq_num=28 snap_id=1 wait times: snap=0.504575 sec, exc=0.504575 sec, total=0.504575 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000012 sec of elapsed time 7: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=26 seq_num=27 snap_id=1 wait times: snap=0.500003 sec, exc=0.500003 sec, total=0.500003 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 8: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=25 seq_num=26 snap_id=1 wait times: snap=0.510084 sec, exc=0.510084 sec, total=0.510084 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000010 sec of elapsed time 9: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=24 seq_num=25 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.000007 sec of elapsed time Sampled Session History of session 193 serial 33843 --------------------------------------------------- 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 --------------------------------------------------- [18 samples, 22:04:16 - 22:04:33] idle wait at each sample [session created at: 22:04:16] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.016000 sec (max dump time=30.000000 sec) *** 2025-07-01 22:04:33.259 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 24 (osid: 14088, J000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-07-01 22:01:54.502005 :AC4271AF: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-01 22:01:54.502005 :AC4271B0:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=176 time=88090392 2025-07-01 22:01:54.502006 :AC4271B1:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-07-01 22:01:54.502006 :AC4271B2:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-07-01 22:01:54.502007 :AC4271B3:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-07-01 22:01:54.502007 :AC4271B4:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-01 22:01:54.502007 :AC4271B5:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-01 22:01:54.502521 :AC4271B6: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-01 22:01:54.502574 :AC4271BC: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-01 22:01:54.510918 :AC4271CE:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-01 22:01:57.818257 :AC4272BE:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-01 22:01:57.809 2025-07-01 22:01:57.818259 :AC4272BF:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=17772 pso_num=24 pso_serial#=155 2025-07-01 22:01:57.818401 :AC4272C0:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=17772 (legacy spawn) 2025-07-01 22:01:57.824841 :AC4272C1: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-01 22:01:57.825020 :AC4272C6: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-01 22:01:57.825869 :AC4272CB:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-01 22:01:57.834541 :AC4272CE:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-01 22:01:57.825 2025-07-01 22:01:57.834543 :AC4272CF:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=16108 pso_num=24 pso_serial#=156 2025-07-01 22:01:57.834680 :AC4272D0:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=16108 (legacy spawn) 2025-07-01 22:01:57.841130 :AC4272D1: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-01 22:01:57.841292 :AC4272DA: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-01 22:01:57.842083 :AC4272DB:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-01 22:02:01.002181 :AC4273CD:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-01 22:02:00.988 2025-07-01 22:02:01.002183 :AC4273CE:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=12004 pso_num=24 pso_serial#=157 2025-07-01 22:02:01.002325 :AC4273CF:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=12004 (legacy spawn) 2025-07-01 22:02:01.009250 :AC4273D0: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-01 22:02:01.009450 :AC4273D5: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-01 22:02:01.010394 :AC4273DA:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-01 22:02:01.019389 :AC4273DD:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-01 22:02:01.004 2025-07-01 22:02:01.019391 :AC4273DE:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=16304 pso_num=24 pso_serial#=158 2025-07-01 22:02:01.019541 :AC4273DF:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=16304 (legacy spawn) 2025-07-01 22:02:01.026462 :AC4273E0: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-01 22:02:01.026646 :AC4273E7: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-01 22:02:01.027519 :AC4273EA:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-01 22:02:11.616007 :AC42774B:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-01 22:02:11.607 2025-07-01 22:02:11.616009 :AC42774C:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=16604 pso_num=24 pso_serial#=159 2025-07-01 22:02:11.616150 :AC42774D:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=16604 (legacy spawn) 2025-07-01 22:02:11.622584 :AC42774E: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-01 22:02:11.622882 :AC427754: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-01 22:02:11.623751 :AC427758:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-01 22:02:15.805019 :AC42787F:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-01 22:02:15.799 2025-07-01 22:02:15.805022 :AC427880:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=16852 pso_num=24 pso_serial#=160 2025-07-01 22:02:15.805161 :AC427881:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=16852 osp_idx=22 osp_ver=498950 osp_pg=0 (spawn #342510) 2025-07-01 22:02:15.805161 :AC427882: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-01 22:02:15.805162 :AC427883:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=177 time=88111704 2025-07-01 22:02:15.805162 :AC427884:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-07-01 22:02:15.805163 :AC427885:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-07-01 22:02:15.805163 :AC427886:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-07-01 22:02:15.805163 :AC427887:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-01 22:02:15.805164 :AC427888:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-01 22:02:15.805679 :AC427889: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-01 22:02:15.806356 :AC42789E: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-01 22:02:15.817423 :AC4278BA:db_trace:kwqid.c@2146:kwqidrdq(): [10960:24:193] kwqidrdq: Error: 1403 occured in OCI execute 2025-07-01 22:02:15.817947 :AC4278BB:db_trace:kwqid.c@2146:kwqidrdq(): [10960:24:193] kwqidrdq: Error: 1403 occured in OCI execute 2025-07-01 22:02:15.820314 :AC4278BC:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-07-01 22:02:15.820689 :AC4278BD: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-01 22:02:15.820725 :AC4278C0:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-07-01 22:02:15.821617 :AC4278C6: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-01 22:02:15.821753 :AC4278CF: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-01 22:02:45.901716 :AC428217:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-01 22:02:50.534125 :AC4283BD:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-01 22:02:50.525 2025-07-01 22:02:50.534127 :AC4283BE:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=14916 pso_num=24 pso_serial#=161 2025-07-01 22:02:50.534260 :AC4283BF:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=14916 (legacy spawn) 2025-07-01 22:02:50.540728 :AC4283C0: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-01 22:02:50.540922 :AC4283C9: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-01 22:02:50.541794 :AC4283CA:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-01 22:03:10.510206 :AC428993:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-01 22:03:10.496 2025-07-01 22:03:10.510208 :AC428994:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=15912 pso_num=24 pso_serial#=162 2025-07-01 22:03:10.510348 :AC428995:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=15912 (legacy spawn) 2025-07-01 22:03:10.516776 :AC428996: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-01 22:03:10.516944 :AC42899B: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-01 22:03:10.517723 :AC4289A0:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-01 22:03:10.526398 :AC4289A3:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-01 22:03:10.512 2025-07-01 22:03:10.526400 :AC4289A4:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=11988 pso_num=24 pso_serial#=163 2025-07-01 22:03:10.526539 :AC4289A5:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=11988 (legacy spawn) 2025-07-01 22:03:10.547099 :AC4289B2: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-01 22:03:10.547274 :AC4289BB: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-01 22:03:10.548079 :AC4289BC:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-01 22:03:13.628900 :AC428AA1:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-01 22:03:13.615 2025-07-01 22:03:13.628902 :AC428AA2:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=15096 pso_num=24 pso_serial#=164 2025-07-01 22:03:13.629040 :AC428AA3:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=15096 (legacy spawn) 2025-07-01 22:03:13.635445 :AC428AA4: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-01 22:03:13.635610 :AC428AA9: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-01 22:03:13.636394 :AC428AAE:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-01 22:03:13.645217 :AC428AB1:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-01 22:03:13.631 2025-07-01 22:03:13.645219 :AC428AB2:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=9284 pso_num=24 pso_serial#=165 2025-07-01 22:03:13.645361 :AC428AB3:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=9284 (legacy spawn) 2025-07-01 22:03:13.651884 :AC428AB4: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-01 22:03:13.652056 :AC428ABD: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-01 22:03:13.652853 :AC428ABE:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-01 22:03:13.811946 :AC428ACC:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-01 22:03:13.803 2025-07-01 22:03:13.811948 :AC428ACD:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=18244 pso_num=24 pso_serial#=166 2025-07-01 22:03:13.812086 :AC428ACE:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=18244 (legacy spawn) 2025-07-01 22:03:13.818762 :AC428ACF: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-01 22:03:13.818939 :AC428AD5: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-01 22:03:13.819818 :AC428AD9:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-01 22:03:15.881476 :AC428B94:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-01 22:03:15.876 2025-07-01 22:03:15.881478 :AC428B95:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=18304 pso_num=24 pso_serial#=167 2025-07-01 22:03:15.881614 :AC428B96:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=18304 osp_idx=22 osp_ver=498957 osp_pg=0 (spawn #342512) 2025-07-01 22:03:15.881615 :AC428B97: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-01 22:03:15.881616 :AC428B98:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=178 time=88171783 2025-07-01 22:03:15.881616 :AC428B99:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-07-01 22:03:15.881616 :AC428B9A:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-07-01 22:03:15.881617 :AC428B9B:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-07-01 22:03:15.881617 :AC428B9C:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-01 22:03:15.881617 :AC428B9D:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-01 22:03:15.882106 :AC428B9E: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-01 22:03:15.882746 :AC428BB3: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-01 22:03:15.890332 :AC428BCF:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-07-01 22:03:15.890702 :AC428BD0: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-01 22:03:15.890737 :AC428BD3:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-07-01 22:03:15.891557 :AC428BD9: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-01 22:03:15.891677 :AC428BDE: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-01 22:03:45.976930 :AC4294EB:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-01 22:03:46.694129 :AC429523:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-01 22:03:46.680 2025-07-01 22:03:46.694131 :AC429524:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=14548 pso_num=24 pso_serial#=168 2025-07-01 22:03:46.694273 :AC429525:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=14548 (legacy spawn) 2025-07-01 22:03:46.700620 :AC429526: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-01 22:03:46.700818 :AC42952B: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-01 22:03:46.701643 :AC429530:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-01 22:03:46.710298 :AC429533:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-01 22:03:46.696 2025-07-01 22:03:46.710300 :AC429534:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=18396 pso_num=24 pso_serial#=169 2025-07-01 22:03:46.710435 :AC429535:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=18396 (legacy spawn) 2025-07-01 22:03:46.716904 :AC429536: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-01 22:03:46.717072 :AC42953F: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-01 22:03:46.717862 :AC429540:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-01 22:03:50.206580 :AC42962A:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-01 22:03:50.195 2025-07-01 22:03:50.206582 :AC42962B:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=16076 pso_num=24 pso_serial#=170 2025-07-01 22:03:50.206763 :AC42962C:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=16076 (legacy spawn) 2025-07-01 22:03:50.213105 :AC42962D: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-01 22:03:50.213287 :AC429632: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-01 22:03:50.214102 :AC429637:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-01 22:03:50.222809 :AC42963A:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-01 22:03:50.210 2025-07-01 22:03:50.222811 :AC42963B:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=13156 pso_num=24 pso_serial#=171 2025-07-01 22:03:50.222955 :AC42963C:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=13156 (legacy spawn) 2025-07-01 22:03:50.229375 :AC42963D: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-01 22:03:50.229552 :AC429646: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-01 22:03:50.230343 :AC429647:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-01 22:03:54.661076 :AC4297A4:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-01 22:03:54.652 2025-07-01 22:03:54.661079 :AC4297A5:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=9636 pso_num=24 pso_serial#=172 2025-07-01 22:03:54.661215 :AC4297A6:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=9636 (legacy spawn) 2025-07-01 22:03:54.667632 :AC4297A7: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-01 22:03:54.667813 :AC4297AF: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-01 22:03:54.668634 :AC4297B1:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-01 22:03:58.772810 :AC429922:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-01 22:03:58.765 2025-07-01 22:03:58.772812 :AC429923:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=16832 pso_num=24 pso_serial#=173 2025-07-01 22:03:58.772956 :AC429924:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=16832 (legacy spawn) 2025-07-01 22:03:58.779381 :AC429925: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-01 22:03:58.779552 :AC42992A: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-01 22:03:58.780346 :AC42992F:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-01 22:04:15.986811 :AC429E7E:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-01 22:04:15.981 2025-07-01 22:04:15.986814 :AC429E7F:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=14088 pso_num=24 pso_serial#=174 2025-07-01 22:04:15.986952 :AC429E80:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=14088 osp_idx=22 osp_ver=498964 osp_pg=0 (spawn #342514) 2025-07-01 22:04:15.986953 :AC429E81: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-01 22:04:15.986953 :AC429E82:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=179 time=88231876 2025-07-01 22:04:15.986954 :AC429E83:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-07-01 22:04:15.986954 :AC429E84:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-07-01 22:04:15.986955 :AC429E85:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-07-01 22:04:15.986955 :AC429E86:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-01 22:04:15.986955 :AC429E87:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-01 22:04:15.987436 :AC429E88: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-01 22:04:15.988176 :AC429E9D: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-01 22:04:16.002408 :AC429EBA:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-07-01 22:04:16.002492 :AC429EBB:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-07-01 22:04:16.003277 :AC429EBC:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-07-01 22:04:16.003601 :AC429EBD: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-01 22:04:16.003641 :AC429EC0:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-07-01 22:04:16.011690 :AC429EC6: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-01 22:04:16.011783 :AC429EC9:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:ktcc.c:879 2025-07-01 22:04:16.011834 :AC429ECA:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:ktcc.c:879 2025-07-01 22:04:16.012223 :AC429ED0:db_trace:kwqid.c@2146:kwqidrdq(): [10960:24:193] kwqidrdq: Error: 1403 occured in OCI execute 2025-07-01 22:04:16.012617 :AC429ED1:db_trace:kwqid.c@2146:kwqidrdq(): [10960:24:193] kwqidrdq: Error: 1403 occured in OCI execute 2025-07-01 22:04:16.012817 :AC429ED2:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-07-01 22:04:16.013106 :AC429ED3: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-01 22:04:16.013134 :AC429ED6:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-07-01 22:04:16.014730 :AC429EDC:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-07-01 22:04:16.014952 :AC429EDD: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-01 22:04:16.014980 :AC429EE0:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-07-01 22:04:16.015926 :AC429EE6: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 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 24 (osid: 14088, J000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de