Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250528081438\orcl_j000_12636_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250528081438\orcl_j000_12636_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:37291M/63366M, Ph+PgF:44223M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 22 Windows thread id: 12636, image: ORACLE.EXE (J000) *** 2025-05-28 08:14:38.689 *** SESSION ID:(177.49303) 2025-05-28 08:14:38.689 *** 2025-05-28 08:14:38.689 Process diagnostic dump for ORACLE.EXE (J000), OS id=12636, pid: 22, proc_ser: 119, sid: 177, sess_ser: 49303 ------------------------------------------------------------------------------- current sql: <none> client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 12636 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J000) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=37 seq_num=38 snap_id=1 wait times: snap=0.132322 sec, exc=0.132322 sec, total=0.132322 sec wait times: max=0.500000 sec, heur=18.716606 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.000008 sec since current wait 0: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=36 seq_num=37 snap_id=1 wait times: snap=0.500984 sec, exc=0.500984 sec, total=0.500984 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000020 sec of elapsed time 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=35 seq_num=36 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.000008 sec of elapsed time 2: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=34 seq_num=35 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 3: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=33 seq_num=34 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.000011 sec of elapsed time 4: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=32 seq_num=33 snap_id=1 wait times: snap=0.510087 sec, exc=0.510087 sec, total=0.510087 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000014 sec of elapsed time 5: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=31 seq_num=32 snap_id=1 wait times: snap=0.510101 sec, exc=0.510101 sec, total=0.510101 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000013 sec of elapsed time 6: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=30 seq_num=31 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.000011 sec of elapsed time 7: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=29 seq_num=30 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=28 seq_num=29 snap_id=1 wait times: snap=0.499991 sec, exc=0.499991 sec, total=0.499991 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 sec of elapsed time 9: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=27 seq_num=28 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.000009 sec of elapsed time Sampled Session History of session 177 serial 49303 --------------------------------------------------- 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 --------------------------------------------------- [19 samples, 08:14:19 - 08:14:38] idle wait at each sample [session created at: 08:14:19] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-05-28 08:14:38.689 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 22 (osid: 12636, J000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-28 08:12:06.371826 :9D093B8A:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=15204 pso_num=22 pso_serial#=100 2025-05-28 08:12:06.371962 :9D093B8B:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=15204 (legacy spawn) 2025-05-28 08:12:06.378415 :9D093B8C: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-28 08:12:06.378577 :9D093B95: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-28 08:12:06.379358 :9D093B96:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-28 08:12:06.387939 :9D093B99:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-28 08:12:06.374 2025-05-28 08:12:06.387941 :9D093B9A:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=8392 pso_num=22 pso_serial#=101 2025-05-28 08:12:06.388121 :9D093B9B:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=8392 (legacy spawn) 2025-05-28 08:12:06.394541 :9D093B9C: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-28 08:12:06.394712 :9D093BA4: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-28 08:12:06.395531 :9D093BA6:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-28 08:12:15.100780 :9D093E11:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-28 08:12:15.092 2025-05-28 08:12:15.100783 :9D093E12:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=6400 pso_num=22 pso_serial#=102 2025-05-28 08:12:15.100928 :9D093E13:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=6400 (legacy spawn) 2025-05-28 08:12:15.126462 :9D093E14: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-28 08:12:15.126645 :9D093E1D: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-28 08:12:15.127485 :9D093E1E:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-28 08:12:19.758212 :9D093FBE:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-28 08:12:19.753 2025-05-28 08:12:19.758214 :9D093FBF:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=11336 pso_num=22 pso_serial#=103 2025-05-28 08:12:19.758348 :9D093FC0:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=11336 osp_idx=22 osp_ver=330603 osp_pg=0 (spawn #227224) 2025-05-28 08:12:19.758349 :9D093FC1: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-28 08:12:19.758349 :9D093FC2:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=0 time=1395712016 2025-05-28 08:12:19.758350 :9D093FC3:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-05-28 08:12:19.758350 :9D093FC4:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-05-28 08:12:19.758350 :9D093FC5:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-05-28 08:12:19.758351 :9D093FC6:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-28 08:12:19.758351 :9D093FC7:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-28 08:12:19.758838 :9D093FC8: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-28 08:12:19.759478 :9D093FDD: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-28 08:12:19.770509 :9D093FF9:db_trace:kwqid.c@2146:kwqidrdq(): [10960:22:177] kwqidrdq: Error: 1403 occured in OCI execute 2025-05-28 08:12:19.770969 :9D093FFA:db_trace:kwqid.c@2146:kwqidrdq(): [10960:22:177] kwqidrdq: Error: 1403 occured in OCI execute 2025-05-28 08:12:19.773315 :9D093FFB:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-05-28 08:12:19.773668 :9D093FFC: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-28 08:12:19.773704 :9D093FFF:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-05-28 08:12:19.774571 :9D094005: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-28 08:12:19.774691 :9D09400E: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-28 08:12:49.839398 :9D09499C:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-28 08:12:57.074655 :9D094BD7:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-28 08:12:57.067 2025-05-28 08:12:57.074657 :9D094BD8:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=13172 pso_num=22 pso_serial#=104 2025-05-28 08:12:57.074798 :9D094BD9:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=13172 (legacy spawn) 2025-05-28 08:12:57.081218 :9D094BDA: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-28 08:12:57.081397 :9D094BDF: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-28 08:12:57.082219 :9D094BE4:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-28 08:13:16.028366 :9D0951C1:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-28 08:13:16.021 2025-05-28 08:13:16.028368 :9D0951C2:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=10976 pso_num=22 pso_serial#=105 2025-05-28 08:13:16.028507 :9D0951C3:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=10976 (legacy spawn) 2025-05-28 08:13:16.034937 :9D0951C4: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-28 08:13:16.035110 :9D0951C9: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-28 08:13:16.035882 :9D0951CE:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-28 08:13:16.044572 :9D0951D1:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-28 08:13:16.037 2025-05-28 08:13:16.044574 :9D0951D2:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=10332 pso_num=22 pso_serial#=106 2025-05-28 08:13:16.044704 :9D0951D3:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=10332 (legacy spawn) 2025-05-28 08:13:16.051106 :9D0951D4: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-28 08:13:16.051263 :9D0951DD: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-28 08:13:16.052061 :9D0951DE:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-28 08:13:17.130624 :9D095255:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-28 08:13:17.125 2025-05-28 08:13:17.130626 :9D095256:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=11720 pso_num=22 pso_serial#=107 2025-05-28 08:13:17.130759 :9D095257:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=11720 osp_idx=22 osp_ver=330607 osp_pg=0 (spawn #227226) 2025-05-28 08:13:17.130759 :9D095258: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-28 08:13:17.130760 :9D095259:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=1 time=1395769391 2025-05-28 08:13:17.130760 :9D09525A:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-05-28 08:13:17.130760 :9D09525B:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-05-28 08:13:17.130761 :9D09525C:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-05-28 08:13:17.130761 :9D09525D:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-28 08:13:17.130761 :9D09525E:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-28 08:13:17.131307 :9D09525F: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-28 08:13:17.131354 :9D095265: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-28 08:13:17.135396 :9D09527E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:kelt.c:517 2025-05-28 08:13:17.135438 :9D09527F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:kelt.c:517 2025-05-28 08:13:17.135705 :9D095280:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:kelt.c:517 2025-05-28 08:13:17.135721 :9D095281:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:kelt.c:517 2025-05-28 08:13:17.135934 :9D095282:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:kelt.c:517 2025-05-28 08:13:17.135948 :9D095283:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:kelt.c:517 2025-05-28 08:13:17.136160 :9D095284:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:kelt.c:517 2025-05-28 08:13:17.136173 :9D095285:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:kelt.c:517 2025-05-28 08:13:17.136384 :9D095286:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:kelt.c:517 2025-05-28 08:13:17.136397 :9D095287:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:kelt.c:517 2025-05-28 08:13:17.136606 :9D095288:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:kelt.c:517 2025-05-28 08:13:17.136619 :9D095289:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:kelt.c:517 2025-05-28 08:13:17.138953 :9D09528A:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-28 08:13:17.289593 :9D09528D:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-28 08:13:17.281 2025-05-28 08:13:17.289595 :9D09528E:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=14480 pso_num=22 pso_serial#=108 2025-05-28 08:13:17.289735 :9D09528F:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=14480 (legacy spawn) 2025-05-28 08:13:17.296251 :9D095290: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-28 08:13:17.296419 :9D095299: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-28 08:13:17.297243 :9D09529A:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-28 08:13:19.236536 :9D095313:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-28 08:13:19.229 2025-05-28 08:13:19.236538 :9D095314:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=15172 pso_num=22 pso_serial#=109 2025-05-28 08:13:19.236678 :9D095315:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=15172 (legacy spawn) 2025-05-28 08:13:19.243082 :9D095316: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-28 08:13:19.243250 :9D09531B: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-28 08:13:19.244048 :9D095320:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-28 08:13:19.252755 :9D095323:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-28 08:13:19.244 2025-05-28 08:13:19.252757 :9D095324:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=13936 pso_num=22 pso_serial#=110 2025-05-28 08:13:19.252891 :9D095325:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=13936 (legacy spawn) 2025-05-28 08:13:19.259247 :9D095326: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-28 08:13:19.259405 :9D09532F: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-28 08:13:19.260259 :9D095330:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-28 08:13:19.859643 :9D09536C:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-28 08:13:19.854 2025-05-28 08:13:19.859646 :9D09536D:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=15352 pso_num=22 pso_serial#=111 2025-05-28 08:13:19.859784 :9D09536E:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=15352 osp_idx=22 osp_ver=330611 osp_pg=0 (spawn #227227) 2025-05-28 08:13:19.859785 :9D09536F: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-28 08:13:19.859785 :9D095370:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=2 time=1395772110 2025-05-28 08:13:19.859786 :9D095371:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-05-28 08:13:19.859786 :9D095372:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-05-28 08:13:19.859786 :9D095373:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-05-28 08:13:19.859787 :9D095374:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-28 08:13:19.859787 :9D095375:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-28 08:13:19.860297 :9D095376: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-28 08:13:19.860938 :9D09538B: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-28 08:13:19.868412 :9D0953A8:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-05-28 08:13:19.868781 :9D0953A9: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-28 08:13:19.868816 :9D0953AC:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-05-28 08:13:19.869654 :9D0953B2: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-28 08:13:19.869768 :9D0953BB: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-28 08:13:49.954153 :9D095D9A:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-28 08:13:52.446967 :9D095E5A:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-28 08:13:52.432 2025-05-28 08:13:52.446969 :9D095E5B:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=15240 pso_num=22 pso_serial#=112 2025-05-28 08:13:52.447111 :9D095E5C:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=15240 (legacy spawn) 2025-05-28 08:13:52.453541 :9D095E5D: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-28 08:13:52.453710 :9D095E62: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-28 08:13:52.454517 :9D095E67:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-28 08:13:52.463129 :9D095E6A:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-28 08:13:52.448 2025-05-28 08:13:52.463131 :9D095E6B:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=12524 pso_num=22 pso_serial#=113 2025-05-28 08:13:52.463269 :9D095E6C:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=12524 (legacy spawn) 2025-05-28 08:13:52.469720 :9D095E6D: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-28 08:13:52.469881 :9D095E76: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-28 08:13:52.470653 :9D095E77:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-28 08:13:55.549723 :9D095F6B:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-28 08:13:55.536 2025-05-28 08:13:55.549725 :9D095F6C:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=14860 pso_num=22 pso_serial#=114 2025-05-28 08:13:55.549863 :9D095F6D:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=14860 (legacy spawn) 2025-05-28 08:13:55.556338 :9D095F6E: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-28 08:13:55.556511 :9D095F73: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-28 08:13:55.557287 :9D095F78:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-28 08:13:55.565875 :9D095F7B:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-28 08:13:55.552 2025-05-28 08:13:55.565877 :9D095F7C:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=12448 pso_num=22 pso_serial#=115 2025-05-28 08:13:55.566014 :9D095F7D:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=12448 (legacy spawn) 2025-05-28 08:13:55.572479 :9D095F7E: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-28 08:13:55.572643 :9D095F87: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-28 08:13:55.573424 :9D095F88:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-28 08:14:05.086167 :9D09626D:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-28 08:14:05.079 2025-05-28 08:14:05.086170 :9D09626E:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=14848 pso_num=22 pso_serial#=116 2025-05-28 08:14:05.086312 :9D09626F:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=14848 (legacy spawn) 2025-05-28 08:14:05.092794 :9D096270: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-28 08:14:05.092971 :9D096275: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-28 08:14:05.093761 :9D09627A:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-28 08:14:17.563805 :9D096668:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-28 08:14:17.556 2025-05-28 08:14:17.563807 :9D096669:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=9492 pso_num=22 pso_serial#=117 2025-05-28 08:14:17.563942 :9D09666A:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=9492 (legacy spawn) 2025-05-28 08:14:17.570331 :9D09666B: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-28 08:14:17.570501 :9D096674: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-28 08:14:17.571301 :9D096675:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-28 08:14:19.495790 :9D0966ED:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-28 08:14:19.488 2025-05-28 08:14:19.495792 :9D0966EE:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=15348 pso_num=22 pso_serial#=118 2025-05-28 08:14:19.495954 :9D0966EF:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=15348 (legacy spawn) 2025-05-28 08:14:19.502839 :9D0966F0: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-28 08:14:19.503076 :9D0966F5: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-28 08:14:19.503986 :9D0966FA:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-05-28 08:14:19.961815 :9D096735:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 05-28 08:14:19.956 2025-05-28 08:14:19.961817 :9D096736:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=12636 pso_num=22 pso_serial#=119 2025-05-28 08:14:19.961955 :9D096737:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=12636 osp_idx=22 osp_ver=330619 osp_pg=0 (spawn #227229) 2025-05-28 08:14:19.961955 :9D096738: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-28 08:14:19.961956 :9D096739:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=3 time=1395832219 2025-05-28 08:14:19.961956 :9D09673A:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-05-28 08:14:19.961956 :9D09673B:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-05-28 08:14:19.961957 :9D09673C:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-05-28 08:14:19.961958 :9D09673D:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-28 08:14:19.961958 :9D09673E:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-28 08:14:19.962464 :9D09673F: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-28 08:14:19.963148 :9D096754: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-28 08:14:19.974157 :9D096770:db_trace:kwqid.c@2146:kwqidrdq(): [10960:22:177] kwqidrdq: Error: 1403 occured in OCI execute 2025-05-28 08:14:19.974684 :9D096771:db_trace:kwqid.c@2146:kwqidrdq(): [10960:22:177] kwqidrdq: Error: 1403 occured in OCI execute 2025-05-28 08:14:19.976987 :9D096772:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-05-28 08:14:19.977340 :9D096773: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-28 08:14:19.977377 :9D096776:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-05-28 08:14:19.978222 :9D09677C: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-28 08:14:19.978364 :9D096785: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: 12636, J000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de