Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250517220455\orcl_j000_9052_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250517220455\orcl_j000_9052_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:37360M/63366M, Ph+PgF:44533M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 22 Windows thread id: 9052, image: ORACLE.EXE (J000) *** 2025-05-17 22:04:55.812 *** SESSION ID:(177.17843) 2025-05-17 22:04:55.812 *** 2025-05-17 22:04:55.812 Process diagnostic dump for ORACLE.EXE (J000), OS id=9052, pid: 22, proc_ser: 4, sid: 177, sess_ser: 17843 ------------------------------------------------------------------------------- current sql: <none> client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 9052 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J000) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=41 seq_num=42 snap_id=1 wait times: snap=0.305823 sec, exc=0.305823 sec, total=0.305823 sec wait times: max=0.500000 sec, heur=20.857286 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.000013 sec since current wait 0: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=40 seq_num=41 snap_id=1 wait times: snap=0.510094 sec, exc=0.510094 sec, total=0.510094 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=39 seq_num=40 snap_id=1 wait times: snap=0.499994 sec, exc=0.499994 sec, total=0.499994 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 sec of elapsed time 2: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=38 seq_num=39 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.000009 sec of elapsed time 3: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=37 seq_num=38 snap_id=1 wait times: snap=0.499992 sec, exc=0.499992 sec, total=0.499992 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000013 sec of elapsed time 4: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=36 seq_num=37 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 5: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=35 seq_num=36 snap_id=1 wait times: snap=0.499997 sec, exc=0.499997 sec, total=0.499997 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 sec of elapsed time 6: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=34 seq_num=35 snap_id=1 wait times: snap=0.510094 sec, exc=0.510094 sec, total=0.510094 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=33 seq_num=34 snap_id=1 wait times: snap=0.499969 sec, exc=0.499969 sec, total=0.499969 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=32 seq_num=33 snap_id=1 wait times: snap=0.500025 sec, exc=0.500025 sec, total=0.500025 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=31 seq_num=32 snap_id=1 wait times: snap=0.500005 sec, exc=0.500005 sec, total=0.500005 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 177 serial 17843 --------------------------------------------------- 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 --------------------------------------------------- [21 samples, 22:04:34 - 22:04:55] idle wait at each sample [session created at: 22:04:34] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-05-17 22:04:55.812 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 22 (osid: 9052, J000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-17 22:02:18.017438 :9875F9A4:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-17 22:02:18.026240 :9875F9A7:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-17 22:02:18.019 2025-05-17 22:02:18.026242 :9875F9A8:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=11720 pso_num=22 pso_serial#=238 2025-05-17 22:02:18.026435 :9875F9A9:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=11720 (legacy spawn) 2025-05-17 22:02:18.032794 :9875F9AA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 22:02:18.032963 :9875F9B3:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-17 22:02:18.033792 :9875F9B4:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-17 22:02:21.126708 :9875FAB0:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-17 22:02:21.113 2025-05-17 22:02:21.126710 :9875FAB1:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=14092 pso_num=22 pso_serial#=239 2025-05-17 22:02:21.126848 :9875FAB2:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=14092 (legacy spawn) 2025-05-17 22:02:21.133308 :9875FAB3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 22:02:21.133475 :9875FAB8:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-17 22:02:21.134244 :9875FABD:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-17 22:02:21.142725 :9875FAC0:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-17 22:02:21.129 2025-05-17 22:02:21.142727 :9875FAC1:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=13208 pso_num=22 pso_serial#=240 2025-05-17 22:02:21.142861 :9875FAC2:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=13208 (legacy spawn) 2025-05-17 22:02:21.149285 :9875FAC3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 22:02:21.149447 :9875FACC:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-17 22:02:21.150257 :9875FACD:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-17 22:02:27.142938 :9875FCAD:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-17 22:02:27.130 2025-05-17 22:02:27.142940 :9875FCAE:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=14116 pso_num=22 pso_serial#=241 2025-05-17 22:02:27.143079 :9875FCAF:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=14116 (legacy spawn) 2025-05-17 22:02:27.149488 :9875FCB0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 22:02:27.149655 :9875FCB5:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-17 22:02:27.150478 :9875FCBA:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-17 22:02:28.380172 :9875FCFF:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-17 22:02:28.372 2025-05-17 22:02:28.380174 :9875FD00:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=11488 pso_num=22 pso_serial#=242 2025-05-17 22:02:28.380319 :9875FD01:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=11488 (legacy spawn) 2025-05-17 22:02:28.404872 :9875FD2C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 22:02:28.405045 :9875FD31:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-17 22:02:28.405941 :9875FD36:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-17 22:02:28.414839 :9875FD39:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-17 22:02:28.403 2025-05-17 22:02:28.414841 :9875FD3A:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=9532 pso_num=22 pso_serial#=243 2025-05-17 22:02:28.415021 :9875FD3B:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=9532 (legacy spawn) 2025-05-17 22:02:28.421463 :9875FD3C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 22:02:28.421639 :9875FD45:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-17 22:02:28.422469 :9875FD46:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-17 22:02:34.709908 :9875FF45:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-17 22:02:34.704 2025-05-17 22:02:34.709911 :9875FF46:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=13656 pso_num=22 pso_serial#=244 2025-05-17 22:02:34.710043 :9875FF47:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=13656 osp_idx=0 osp_ver=204754 osp_pg=0 (spawn #192505) 2025-05-17 22:02:34.710043 :9875FF48:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-17 22:02:34.710044 :9875FF49:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=207 time=495164579 2025-05-17 22:02:34.710044 :9875FF4A:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-05-17 22:02:34.710045 :9875FF4B:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-05-17 22:02:34.710045 :9875FF4C:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-05-17 22:02:34.710045 :9875FF4D:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-17 22:02:34.710045 :9875FF4E:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-17 22:02:34.710568 :9875FF4F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-17 22:02:34.711250 :9875FF64:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 22:02:34.722234 :9875FF80:db_trace:kwqid.c@2146:kwqidrdq(): [10960:22:177] kwqidrdq: Error: 1403 occured in OCI execute 2025-05-17 22:02:34.722747 :9875FF81:db_trace:kwqid.c@2146:kwqidrdq(): [10960:22:177] kwqidrdq: Error: 1403 occured in OCI execute 2025-05-17 22:02:34.725077 :9875FF82:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-05-17 22:02:34.725401 :9875FF83:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 22:02:34.725435 :9875FF86:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-05-17 22:02:34.726295 :9875FF8C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 22:02:34.726436 :9875FF95:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-17 22:03:04.811073 :9876094B:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-17 22:03:21.767684 :98760E77:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-17 22:03:21.760 2025-05-17 22:03:21.767686 :98760E78:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=2168 pso_num=22 pso_serial#=245 2025-05-17 22:03:21.767827 :98760E79:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=2168 (legacy spawn) 2025-05-17 22:03:21.774303 :98760E7A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 22:03:21.774476 :98760E7F:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-17 22:03:21.775273 :98760E84:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-17 22:03:29.305384 :987610F6:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-17 22:03:29.293 2025-05-17 22:03:29.305386 :987610F7:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=12620 pso_num=22 pso_serial#=246 2025-05-17 22:03:29.305519 :987610F8:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=12620 (legacy spawn) 2025-05-17 22:03:29.311941 :987610F9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 22:03:29.312122 :98761102:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-17 22:03:29.312908 :98761103:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-17 22:03:30.447062 :98761163:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-17 22:03:30.433 2025-05-17 22:03:30.447064 :98761164:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=13608 pso_num=22 pso_serial#=247 2025-05-17 22:03:30.447208 :98761165:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=13608 (legacy spawn) 2025-05-17 22:03:30.453631 :98761166:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 22:03:30.453803 :9876116B:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-17 22:03:30.454586 :98761170:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-17 22:03:30.463219 :98761173:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-17 22:03:30.449 2025-05-17 22:03:30.463221 :98761174:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=13792 pso_num=22 pso_serial#=248 2025-05-17 22:03:30.463363 :98761175:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=13792 (legacy spawn) 2025-05-17 22:03:30.469821 :98761176:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 22:03:30.469987 :9876117F:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-17 22:03:30.470787 :98761180:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-17 22:03:33.541660 :98761260:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-17 22:03:33.528 2025-05-17 22:03:33.541663 :98761261:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=11784 pso_num=22 pso_serial#=249 2025-05-17 22:03:33.541796 :98761262:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=11784 (legacy spawn) 2025-05-17 22:03:33.548262 :98761263:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 22:03:33.548292 :98761266:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 22:03:33.548444 :98761269:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-17 22:03:33.549230 :9876127A:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-17 22:03:33.557751 :9876127D:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-17 22:03:33.544 2025-05-17 22:03:33.557753 :9876127E:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=2404 pso_num=22 pso_serial#=250 2025-05-17 22:03:33.557886 :9876127F:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=2404 (legacy spawn) 2025-05-17 22:03:33.564555 :98761280:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 22:03:33.564729 :98761289:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-17 22:03:33.565552 :9876128A:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-17 22:03:33.877026 :987612C6:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-17 22:03:33.872 2025-05-17 22:03:33.877028 :987612C7:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=13712 pso_num=22 pso_serial#=251 2025-05-17 22:03:33.877160 :987612C8:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=13712 osp_idx=0 osp_ver=204761 osp_pg=0 (spawn #192507) 2025-05-17 22:03:33.877161 :987612C9:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-17 22:03:33.877161 :987612CA:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=208 time=495223750 2025-05-17 22:03:33.877162 :987612CB:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-05-17 22:03:33.877162 :987612CC:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-05-17 22:03:33.877162 :987612CD:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-05-17 22:03:33.877163 :987612CE:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-17 22:03:33.877163 :987612CF:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-17 22:03:33.877649 :987612D0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-17 22:03:33.877698 :987612D6:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-17 22:03:33.898012 :98761324:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-17 22:03:34.786204 :98761373:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-17 22:03:34.780 2025-05-17 22:03:34.786205 :98761374:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=2472 pso_num=22 pso_serial#=252 2025-05-17 22:03:34.786341 :98761375:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=2472 osp_idx=0 osp_ver=204762 osp_pg=0 (spawn #192509) 2025-05-17 22:03:34.786341 :98761376:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-17 22:03:34.786342 :98761377:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=209 time=495224657 2025-05-17 22:03:34.786342 :98761378:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-05-17 22:03:34.786343 :98761379:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-05-17 22:03:34.786343 :9876137A:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-05-17 22:03:34.786343 :9876137B:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-17 22:03:34.786344 :9876137C:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-17 22:03:34.786835 :9876137D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-17 22:03:34.787491 :98761392:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 22:03:34.795056 :987613AE:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-05-17 22:03:34.795431 :987613AF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 22:03:34.795471 :987613B2:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-05-17 22:03:34.796314 :987613B8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 22:03:34.796428 :987613C1:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-17 22:04:04.921312 :98761DBE:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-17 22:04:06.701150 :98761E3D:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-17 22:04:06.686 2025-05-17 22:04:06.701153 :98761E3E:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=13060 pso_num=22 pso_serial#=253 2025-05-17 22:04:06.701299 :98761E3F:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=13060 (legacy spawn) 2025-05-17 22:04:06.707805 :98761E40:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 22:04:06.707981 :98761E45:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-17 22:04:06.708779 :98761E4A:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-17 22:04:06.717431 :98761E4D:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-17 22:04:06.702 2025-05-17 22:04:06.717433 :98761E4E:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=9064 pso_num=22 pso_serial#=254 2025-05-17 22:04:06.717565 :98761E4F:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=9064 (legacy spawn) 2025-05-17 22:04:06.724003 :98761E50:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 22:04:06.724169 :98761E59:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-17 22:04:06.724998 :98761E5A:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-17 22:04:09.800654 :98761F48:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-17 22:04:09.787 2025-05-17 22:04:09.800656 :98761F49:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=13524 pso_num=22 pso_serial#=255 2025-05-17 22:04:09.800791 :98761F4A:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=13524 (legacy spawn) 2025-05-17 22:04:09.807261 :98761F4B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 22:04:09.807439 :98761F50:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-17 22:04:09.808220 :98761F55:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-17 22:04:09.816961 :98761F58:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-17 22:04:09.803 2025-05-17 22:04:09.816963 :98761F59:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=12472 pso_num=22 pso_serial#=1 2025-05-17 22:04:09.817098 :98761F5A:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=12472 (legacy spawn) 2025-05-17 22:04:09.836043 :98761F5B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 22:04:09.836219 :98761F64:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-17 22:04:09.837096 :98761F65:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-17 22:04:29.957061 :987625E5:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-17 22:04:29.942 2025-05-17 22:04:29.957064 :987625E6:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=5020 pso_num=22 pso_serial#=2 2025-05-17 22:04:29.957204 :987625E7:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=5020 (legacy spawn) 2025-05-17 22:04:29.963644 :987625F3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 22:04:29.963820 :987625F8:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-17 22:04:29.964681 :987625FD:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-17 22:04:31.513790 :9876264E:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-17 22:04:31.505 2025-05-17 22:04:31.513792 :9876264F:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=14084 pso_num=22 pso_serial#=3 2025-05-17 22:04:31.513929 :98762650:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=14084 (legacy spawn) 2025-05-17 22:04:31.520328 :98762651:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 22:04:31.520493 :9876265A:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-17 22:04:31.521325 :9876265B:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-17 22:04:34.945064 :98762789:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-17 22:04:34.940 2025-05-17 22:04:34.945066 :9876278A:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=9052 pso_num=22 pso_serial#=4 2025-05-17 22:04:34.945203 :9876278B:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=9052 osp_idx=0 osp_ver=204769 osp_pg=0 (spawn #192511) 2025-05-17 22:04:34.945204 :9876278C:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-17 22:04:34.945204 :9876278D:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=210 time=495284813 2025-05-17 22:04:34.945205 :9876278E:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-05-17 22:04:34.945205 :9876278F:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-05-17 22:04:34.945206 :98762790:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-05-17 22:04:34.945206 :98762791:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-17 22:04:34.945206 :98762792:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-17 22:04:34.945694 :98762793:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-17 22:04:34.946341 :987627A8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 22:04:34.957161 :987627C4:db_trace:kwqid.c@2146:kwqidrdq(): [10960:22:177] kwqidrdq: Error: 1403 occured in OCI execute 2025-05-17 22:04:34.957609 :987627C5:db_trace:kwqid.c@2146:kwqidrdq(): [10960:22:177] kwqidrdq: Error: 1403 occured in OCI execute 2025-05-17 22:04:34.959942 :987627C6:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-05-17 22:04:34.960291 :987627C7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 22:04:34.960327 :987627CA:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-05-17 22:04:34.961243 :987627D0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 22:04:34.961370 :987627D9:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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 22 (osid: 9052, J000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de