Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250818220010\orcl_j000_19660_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250818220010\orcl_j000_19660_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:35390M/63366M, Ph+PgF:40652M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 22 Windows thread id: 19660, image: ORACLE.EXE (J000) *** 2025-08-18 22:00:10.168 *** SESSION ID:(177.19095) 2025-08-18 22:00:10.168 *** 2025-08-18 22:00:10.168 Process diagnostic dump for ORACLE.EXE (J000), OS id=19660, pid: 22, proc_ser: 218, sid: 177, sess_ser: 19095 ------------------------------------------------------------------------------- current sql: <none> client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 19660 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J000) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=12 seq_num=13 snap_id=1 wait times: snap=0.162632 sec, exc=0.162632 sec, total=0.162632 sec wait times: max=0.500000 sec, heur=6.149320 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.000018 sec since current wait 0: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=11 seq_num=12 snap_id=1 wait times: snap=0.499989 sec, exc=0.499989 sec, total=0.499989 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000017 sec of elapsed time 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=10 seq_num=11 snap_id=1 wait times: snap=0.500113 sec, exc=0.500113 sec, total=0.500113 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=9 seq_num=10 snap_id=1 wait times: snap=0.499999 sec, exc=0.499999 sec, total=0.499999 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000014 sec of elapsed time 3: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=8 seq_num=9 snap_id=1 wait times: snap=0.499988 sec, exc=0.499988 sec, total=0.499988 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=7 seq_num=8 snap_id=1 wait times: snap=0.500009 sec, exc=0.500009 sec, total=0.500009 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 sec of elapsed time 5: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=6 seq_num=7 snap_id=1 wait times: snap=0.499982 sec, exc=0.499982 sec, total=0.499982 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=5 seq_num=6 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.000007 sec of elapsed time 7: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=4 seq_num=5 snap_id=1 wait times: snap=0.500127 sec, exc=0.500127 sec, total=0.500127 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=3 seq_num=4 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.000012 sec of elapsed time 9: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=2 seq_num=3 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.000008 sec of elapsed time Sampled Session History of session 177 serial 19095 --------------------------------------------------- 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 --------------------------------------------------- [7 samples, 22:00:04 - 22:00:10] idle wait at each sample [session created at: 22:00:04] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-08-18 22:00:10.168 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 22 (osid: 19660, J000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-08-18 21:56:38.073423 :C18C4F15: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-08-18 21:56:38.073547 :C18C4F1E: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-08-18 21:57:08.191167 :C18C58DA:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-18 21:57:09.543949 :C18C58E9:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-18 21:57:09.535 2025-08-18 21:57:09.543951 :C18C58EA:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=20928 pso_num=22 pso_serial#=206 2025-08-18 21:57:09.544092 :C18C58EB:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=20928 (legacy spawn) 2025-08-18 21:57:09.550624 :C18C58EC: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-08-18 21:57:09.550793 :C18C58F1: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-08-18 21:57:09.551599 :C18C58F6:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-18 21:57:18.939074 :C18C5BBC:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-18 21:57:18.931 2025-08-18 21:57:18.939076 :C18C5BBD:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=18656 pso_num=22 pso_serial#=207 2025-08-18 21:57:18.939221 :C18C5BBE:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=18656 (legacy spawn) 2025-08-18 21:57:18.945684 :C18C5BBF: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-08-18 21:57:18.945859 :C18C5BC4: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-08-18 21:57:18.946674 :C18C5BC9:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-18 21:57:35.586329 :C18C614E:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-18 21:57:35.583 2025-08-18 21:57:35.586332 :C18C614F:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=22024 pso_num=22 pso_serial#=208 2025-08-18 21:57:35.586467 :C18C6150:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=22024 (legacy spawn) 2025-08-18 21:57:35.592975 :C18C6151: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-08-18 21:57:35.593147 :C18C615A: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-08-18 21:57:35.593959 :C18C615B:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-18 21:57:35.602817 :C18C615E:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-18 21:57:35.598 2025-08-18 21:57:35.602819 :C18C615F:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=19376 pso_num=22 pso_serial#=209 2025-08-18 21:57:35.602965 :C18C6160:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=19376 (legacy spawn) 2025-08-18 21:57:35.609585 :C18C6161: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-08-18 21:57:35.609752 :C18C616A: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-08-18 21:57:35.610664 :C18C616B:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-18 21:57:38.140121 :C18C6257:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-18 21:57:38.134 2025-08-18 21:57:38.140122 :C18C6258:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=19544 pso_num=22 pso_serial#=210 2025-08-18 21:57:38.140266 :C18C6259:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=19544 osp_idx=0 osp_ver=532467 osp_pg=0 (spawn #502482) 2025-08-18 21:57:38.140267 :C18C625A:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-18 21:57:38.140267 :C18C625B:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=96 time=4234927439 2025-08-18 21:57:38.140268 :C18C625C:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-18 21:57:38.140268 :C18C625D:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-18 21:57:38.140268 :C18C625E:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-18 21:57:38.140269 :C18C625F:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-18 21:57:38.140269 :C18C6260:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-18 21:57:38.140769 :C18C6261: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-08-18 21:57:38.141400 :C18C6276: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-08-18 21:57:38.148962 :C18C6292:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-08-18 21:57:38.149366 :C18C6293: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-08-18 21:57:38.149399 :C18C6296:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-08-18 21:57:38.150294 :C18C629C: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-08-18 21:57:38.150417 :C18C62A5: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-08-18 21:57:53.149021 :C18C67FB:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=59 loc='kkj.h LINE:914 ID:kkjpstnp' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-18 21:57:53.149047*:C18C6802:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000000FCCBB58 estart=1755525472 eid=17012730 ctx=0x000000077BD98A08 cwh=0x000000000FC802A0 cpu=0 buffg=1 interb=0 r=0 rb=0 w=0 wb=0 2025-08-18 21:57:53.149047*:C18C6803:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000000FCCBB58 curCtx=0x000000000FC8F300 pubTabIdxCnt=0 2025-08-18 21:57:53.149047*:C18C6804:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000000FCCBB58 2025-08-18 21:57:53.149047*:C18C6805:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000000FCCBB58 2025-08-18 21:57:53.149047*:C18C6806:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000000FCCBB58 curCtx=0x000000000FC8F300 xsc->flg4=65792 flags=2 2025-08-18 21:57:53.149047*:C18C6807:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000000FCCBB58 2025-08-18 21:57:53.149583 :C18C6808: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-08-18 21:57:53.154875 :C18C6810: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-08-18 21:57:53.155660 :C18C6818: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-08-18 21:57:53.155778 :C18C6821: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-08-18 21:58:23.261565 :C18C71B4:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-18 21:58:38.207242 :C18C765C:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-18 21:58:38.201 2025-08-18 21:58:38.207244 :C18C765D:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=14012 pso_num=22 pso_serial#=211 2025-08-18 21:58:38.207381 :C18C765E:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=14012 osp_idx=0 osp_ver=532468 osp_pg=0 (spawn #502484) 2025-08-18 21:58:38.207382 :C18C765F:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-18 21:58:38.207383 :C18C7660:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=97 time=4234987517 2025-08-18 21:58:38.207383 :C18C7661:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-18 21:58:38.207384 :C18C7662:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-18 21:58:38.207384 :C18C7663:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-18 21:58:38.207384 :C18C7664:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-18 21:58:38.207384 :C18C7665:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-18 21:58:38.207907 :C18C7666: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-08-18 21:58:38.208543 :C18C767B: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-08-18 21:58:38.219612 :C18C7697:db_trace:kwqid.c@2146:kwqidrdq(): [10960:22:177] kwqidrdq: Error: 1403 occured in OCI execute 2025-08-18 21:58:38.220142 :C18C7698:db_trace:kwqid.c@2146:kwqidrdq(): [10960:22:177] kwqidrdq: Error: 1403 occured in OCI execute 2025-08-18 21:58:38.222509 :C18C7699:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-08-18 21:58:38.222852 :C18C769A: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-08-18 21:58:38.222892 :C18C769D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-08-18 21:58:38.223824 :C18C76A3: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-08-18 21:58:38.223954 :C18C76AC: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-08-18 21:59:08.308145 :C18C804A:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-18 21:59:23.314321 :C18C84DE:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-18 21:59:23.306 2025-08-18 21:59:23.314323 :C18C84DF:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=18680 pso_num=22 pso_serial#=212 2025-08-18 21:59:23.314460 :C18C84E0:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=18680 (legacy spawn) 2025-08-18 21:59:23.320934 :C18C84E1: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-08-18 21:59:23.321102 :C18C84EA: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-08-18 21:59:23.321956 :C18C84EB:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-18 21:59:24.581580 :C18C8511:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-18 21:59:24.581 2025-08-18 21:59:24.581582 :C18C8512:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=19892 pso_num=22 pso_serial#=213 2025-08-18 21:59:24.581739 :C18C8513:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=19892 (legacy spawn) 2025-08-18 21:59:24.588666 :C18C8514: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-08-18 21:59:24.588871 :C18C8519: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-08-18 21:59:24.589751 :C18C851E:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-18 21:59:24.599168 :C18C8521:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-18 21:59:24.597 2025-08-18 21:59:24.599170 :C18C8522:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=19656 pso_num=22 pso_serial#=214 2025-08-18 21:59:24.599320 :C18C8523:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=19656 (legacy spawn) 2025-08-18 21:59:24.606358 :C18C8524: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-08-18 21:59:24.606564 :C18C8529: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-08-18 21:59:24.607523 :C18C852E:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-18 21:59:26.208835 :C18C85F2:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-18 21:59:26.195 2025-08-18 21:59:26.208837 :C18C85F3:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=18812 pso_num=22 pso_serial#=215 2025-08-18 21:59:26.208973 :C18C85F4:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=18812 (legacy spawn) 2025-08-18 21:59:26.215506 :C18C85F5: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-08-18 21:59:26.215669 :C18C85FE: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-08-18 21:59:26.216504 :C18C85FF:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-18 21:59:27.787663 :C18C862A:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-18 21:59:27.774 2025-08-18 21:59:27.787666 :C18C862B:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=22460 pso_num=22 pso_serial#=216 2025-08-18 21:59:27.787825 :C18C862C:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=22460 (legacy spawn) 2025-08-18 21:59:27.794301 :C18C862D: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-08-18 21:59:27.794479 :C18C8632: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-08-18 21:59:27.795328 :C18C8637:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-18 21:59:28.148311 :C18C863A:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-18 21:59:28.133 2025-08-18 21:59:28.148313 :C18C863B:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=21660 pso_num=22 pso_serial#=217 2025-08-18 21:59:28.148450 :C18C863C:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=21660 (legacy spawn) 2025-08-18 21:59:28.154928 :C18C863D: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-08-18 21:59:28.155091 :C18C8646: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-08-18 21:59:28.155885 :C18C8647:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-18 21:59:38.310532 :C18C89EF:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-18 21:59:38.304 2025-08-18 21:59:38.310534 :C18C89F0:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=19660 pso_num=22 pso_serial#=218 2025-08-18 21:59:38.310679 :C18C89F1:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=19660 osp_idx=0 osp_ver=532475 osp_pg=0 (spawn #502486) 2025-08-18 21:59:38.310680 :C18C89F2:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-18 21:59:38.310681 :C18C89F3:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=98 time=4235047611 2025-08-18 21:59:38.310681 :C18C89F4:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-18 21:59:38.310682 :C18C89F5:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-18 21:59:38.310683 :C18C89F6:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-18 21:59:38.310683 :C18C89F7:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-18 21:59:38.310684 :C18C89F8:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-18 21:59:38.311179 :C18C89F9: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-08-18 21:59:38.311847 :C18C8A0E: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-08-18 21:59:38.319372 :C18C8A2A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-08-18 21:59:38.319727 :C18C8A2B: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-08-18 21:59:38.319765 :C18C8A2E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-08-18 21:59:38.320599 :C18C8A34: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-08-18 21:59:38.320709 :C18C8A3D: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-08-18 22:00:02.042703 :C18C9316:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=59 loc='kkj.h LINE:914 ID:kkjpstnp' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-18 22:00:02.042703*:C18C9326:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000000FCDC718 estart=1755525601 eid=16786337 ctx=0x000000077FD6A000 cwh=0x000000000FCD0068 cpu=0 buffg=1 interb=0 r=0 rb=0 w=0 wb=0 2025-08-18 22:00:02.042703*:C18C9328:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000000FCDC718 curCtx=0x000000000FCD8938 pubTabIdxCnt=0 2025-08-18 22:00:02.042703*:C18C9329:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000000FCDC718 2025-08-18 22:00:02.042703*:C18C932B:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000000FCDC718 2025-08-18 22:00:02.047315 :C18C932E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=24 loc='kcb2.h LINE:3844 ID:kcbzww' id1=0 id2=0 name= type=0 2025-08-18 22:00:02.047330 :C18C9330:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=24 loc='kcb2.h LINE:3844 ID:kcbzww' id1=0 id2=0 name= type=0 2025-08-18 22:00:02.047402 :C18C9332:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=24 loc='kcb2.h LINE:3844 ID:kcbzww' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-18 22:00:02.047428 :C18C9335:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=24 loc='kcb2.h LINE:3844 ID:kcbzww' id1=0 id2=0 name= type=0 2025-08-18 22:00:02.047428*:C18C9337:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000000FCDC718 curCtx=0x000000000FCD8938 xsc->flg4=65792 flags=2 2025-08-18 22:00:02.047428*:C18C9338:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000000FCDC718 2025-08-18 22:00:02.048147 :C18C934E: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-08-18 22:00:02.048177 :C18C9351:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:jslv.c:9203 2025-08-18 22:00:02.058699 :C18C93A0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='kcrf.h LINE:3299 ID:kcrfw_redo_gen: wake LGWR after redo copy' id1=0 id2=0 name= type=0 2025-08-18 22:00:02.059092 :C18C93A7: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-08-18 22:00:02.063922 :C18C93CE: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-08-18 22:00:02.064450 :C18C93D6:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=24 loc='kcb2.h LINE:3844 ID:kcbzww' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-18 22:00:02.064469 :C18C93D8:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=30 loc='kcb2.h LINE:3844 ID:kcbzww' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-18 22:00:02.064970 :C18C93D9: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-08-18 22:00:02.070666 :C18C9461:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-08-18 22:00:02.070842 :C18C9491:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=59 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-18 22:00:02.071658 :C18C954A: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-08-18 22:00:02.071879 :C18C9552:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:jslv.c:9203 2025-08-18 22:00:02.073504 :C18C956D: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-08-18 22:00:02.073582 :C18C9570:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 2025-08-18 22:00:02.167812 :C18C96B0:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=59 loc='kkj.h LINE:914 ID:kkjpstnp' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-18 22:00:02.169951 :C18C96B3: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-08-18 22:00:02.169988 :C18C96B6:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:jslv.c:9203 2025-08-18 22:00:02.172457 :C18C96BC:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:jslv.c:9203 2025-08-18 22:00:02.175639 :C18C96BD: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-08-18 22:00:02.175722 :C18C96C0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 2025-08-18 22:00:02.175819 :C18C96CD: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-08-18 22:00:04.011732 :C18C9AAB:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=59 loc='kkj.h LINE:914 ID:kkjpstnp' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-18 22:00:04.011732*:C18C9AAD:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000000FCDC718 estart=1755525603 eid=16786343 ctx=0x000000077FD6A000 cwh=0x000000000FCD0068 cpu=0 buffg=1 interb=0 r=0 rb=0 w=0 wb=0 2025-08-18 22:00:04.011732*:C18C9AAE:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000000FCDC718 curCtx=0x000000000FCD8938 pubTabIdxCnt=0 2025-08-18 22:00:04.011732*:C18C9AAF:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000000FCDC718 2025-08-18 22:00:04.011732*:C18C9AB0:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000000FCDC718 2025-08-18 22:00:04.011732*:C18C9AB1:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000000FCDC718 curCtx=0x000000000FCD8938 xsc->flg4=65792 flags=2 2025-08-18 22:00:04.011732*:C18C9AB2:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000000FCDC718 2025-08-18 22:00:04.013988 :C18C9AB3: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-08-18 22:00:04.014027 :C18C9AB6:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:jslv.c:9203 2025-08-18 22:00:04.020671 :C18C9ABC: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-08-18 22:00:04.021491 :C18C9AC4: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-08-18 22:00:04.022236 :C18C9ACC: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-08-18 22:00:04.022444 :C18C9AD4:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:jslv.c:9203 2025-08-18 22:00:04.023875 :C18C9AD5: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-08-18 22:00:04.023917 :C18C9AD8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 2025-08-18 22:00:04.023993 :C18C9AE5: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: 19660, J000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de