Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250805220010\orcl_j001_10744_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250805220010\orcl_j001_10744_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:35714M/63366M, Ph+PgF:41283M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 24 Windows thread id: 10744, image: ORACLE.EXE (J001) *** 2025-08-05 22:00:10.689 *** SESSION ID:(193.63095) 2025-08-05 22:00:10.689 *** 2025-08-05 22:00:10.689 Process diagnostic dump for ORACLE.EXE (J001), OS id=10744, pid: 24, proc_ser: 98, sid: 193, sess_ser: 63095 ------------------------------------------------------------------------------- current sql: <none> client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 10744 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J001) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=18 seq_num=19 snap_id=1 wait times: snap=0.158453 sec, exc=0.158453 sec, total=0.158453 sec wait times: max=0.500000 sec, heur=8.624506 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=17 seq_num=18 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.000010 sec of elapsed time 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=16 seq_num=17 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.000010 sec of elapsed time 2: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=15 seq_num=16 snap_id=1 wait times: snap=0.500131 sec, exc=0.500131 sec, total=0.500131 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000010 sec of elapsed time 3: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=14 seq_num=15 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.000010 sec of elapsed time 4: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=13 seq_num=14 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.000015 sec of elapsed time 5: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=12 seq_num=13 snap_id=1 wait times: snap=0.510269 sec, exc=0.510269 sec, total=0.510269 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 6: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=11 seq_num=12 snap_id=1 wait times: snap=0.500000 sec, exc=0.500000 sec, total=0.500000 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000010 sec of elapsed time 7: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=10 seq_num=11 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.000010 sec of elapsed time 8: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=9 seq_num=10 snap_id=1 wait times: snap=0.510103 sec, exc=0.510103 sec, total=0.510103 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000006 sec of elapsed time 9: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=8 seq_num=9 snap_id=1 wait times: snap=0.510103 sec, exc=0.510103 sec, total=0.510103 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 193 serial 63095 --------------------------------------------------- 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 --------------------------------------------------- [9 samples, 22:00:02 - 22:00:10] idle wait at each sample [session created at: 22:00:02] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-08-05 22:00:10.689 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 24 (osid: 10744, J001) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-08-05 21:48:56.531646 :BBD6ED4E:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-08-05 21:48:56.531646 :BBD6ED4F:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-08-05 21:48:56.531647 :BBD6ED50:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-08-05 21:48:56.531647 :BBD6ED51:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-05 21:48:56.531647 :BBD6ED52:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-05 21:48:56.532167 :BBD6ED53:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-05 21:49:26.624279 :BBD6F71A:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-08-05 21:49:56.637690 :BBD70128:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 08-05 21:49:56.626 2025-08-05 21:49:56.637693 :BBD70129:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=17240 pso_num=24 pso_serial#=88 2025-08-05 21:49:56.637858 :BBD7012A:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=17240 osp_idx=22 osp_ver=679418 osp_pg=0 (spawn #459126) 2025-08-05 21:49:56.637859 :BBD7012B:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-05 21:49:56.637859 :BBD7012C:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=62 time=3111265939 2025-08-05 21:49:56.637859 :BBD7012D:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-08-05 21:49:56.637860 :BBD7012E:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-08-05 21:49:56.637860 :BBD7012F:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-08-05 21:49:56.637861 :BBD70130:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-05 21:49:56.637861 :BBD70131:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-05 21:49:56.638395 :BBD70132:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-05 21:50:11.637753 :BBD706A0:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-05 21:50:11.637781*:BBD706A3:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000024D4BB58 estart=1754401810 eid=16992095 ctx=0x000000077BD98A08 cwh=0x00000000232801B0 cpu=0 buffg=1 interb=0 r=0 rb=0 w=0 wb=0 2025-08-05 21:50:11.637781*:BBD706A4:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000024D4BB58 curCtx=0x000000002328F708 pubTabIdxCnt=0 2025-08-05 21:50:11.637781*:BBD706A5:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000024D4BB58 2025-08-05 21:50:11.637781*:BBD706A6:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000024D4BB58 2025-08-05 21:50:11.637781*:BBD706A7:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000024D4BB58 curCtx=0x000000002328F708 xsc->flg4=65792 flags=2 2025-08-05 21:50:11.637781*:BBD706A8:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000024D4BB58 2025-08-05 21:50:11.638368 :BBD706A9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-05 21:50:11.643763 :BBD706B1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-05 21:50:11.644729 :BBD706B9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-05 21:50:11.644860 :BBD706C2:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-08-05 21:50:41.730525 :BBD710B5:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-08-05 21:50:56.697068 :BBD715C9:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 08-05 21:50:56.685 2025-08-05 21:50:56.697070 :BBD715CA:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=19108 pso_num=24 pso_serial#=89 2025-08-05 21:50:56.697192 :BBD715CB:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=19108 osp_idx=22 osp_ver=679419 osp_pg=0 (spawn #459129) 2025-08-05 21:50:56.697193 :BBD715CC:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-05 21:50:56.697193 :BBD715CD:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=63 time=3111326001 2025-08-05 21:50:56.697194 :BBD715CE:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-08-05 21:50:56.697194 :BBD715CF:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-08-05 21:50:56.697195 :BBD715D0:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-08-05 21:50:56.697195 :BBD715D1:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-05 21:50:56.697195 :BBD715D2:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-05 21:50:56.697712 :BBD715D3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-05 21:51:26.751926 :BBD71FAF:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-08-05 21:51:56.791350 :BBD7294A:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 08-05 21:51:56.780 2025-08-05 21:51:56.791353 :BBD7294B:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=19368 pso_num=24 pso_serial#=90 2025-08-05 21:51:56.791469 :BBD7294C:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=19368 osp_idx=22 osp_ver=679420 osp_pg=0 (spawn #459131) 2025-08-05 21:51:56.791469 :BBD7294D:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-05 21:51:56.791469 :BBD7294E:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=64 time=3111386095 2025-08-05 21:51:56.791469 :BBD7294F:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-08-05 21:51:56.791470 :BBD72950:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-08-05 21:51:56.791470 :BBD72951:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-08-05 21:51:56.791470 :BBD72952:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-05 21:51:56.791471 :BBD72953:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-05 21:51:56.792024 :BBD72954:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-05 21:52:26.886901 :BBD733DF:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-08-05 21:52:56.883249 :BBD73DA8:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 08-05 21:52:56.872 2025-08-05 21:52:56.883251 :BBD73DA9:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=19072 pso_num=24 pso_serial#=91 2025-08-05 21:52:56.883368 :BBD73DAA:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=19072 osp_idx=22 osp_ver=679421 osp_pg=0 (spawn #459133) 2025-08-05 21:52:56.883368 :BBD73DAB:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-05 21:52:56.883369 :BBD73DAC:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=65 time=3111446189 2025-08-05 21:52:56.883369 :BBD73DAD:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-08-05 21:52:56.883369 :BBD73DAE:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-08-05 21:52:56.883370 :BBD73DAF:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-08-05 21:52:56.883370 :BBD73DB0:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-05 21:52:56.883370 :BBD73DB1:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-05 21:52:56.883890 :BBD73DB2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-05 21:53:26.978365 :BBD747C1:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-08-05 21:53:56.984569 :BBD751AD:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 08-05 21:53:56.973 2025-08-05 21:53:56.984571 :BBD751AE:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=19612 pso_num=24 pso_serial#=92 2025-08-05 21:53:56.984709 :BBD751AF:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=19612 osp_idx=22 osp_ver=679422 osp_pg=0 (spawn #459135) 2025-08-05 21:53:56.984710 :BBD751B0:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-05 21:53:56.984710 :BBD751B1:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=66 time=3111506283 2025-08-05 21:53:56.984711 :BBD751B2:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-08-05 21:53:56.984711 :BBD751B3:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-08-05 21:53:56.984712 :BBD751B4:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-08-05 21:53:56.984712 :BBD751B5:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-05 21:53:56.984713 :BBD751B6:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-05 21:53:56.985215 :BBD751B7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-05 21:54:27.058675 :BBD75B6D:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-08-05 21:54:57.070045 :BBD76521:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 08-05 21:54:57.059 2025-08-05 21:54:57.070046 :BBD76522:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=17204 pso_num=24 pso_serial#=93 2025-08-05 21:54:57.070169 :BBD76523:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=17204 osp_idx=22 osp_ver=679423 osp_pg=0 (spawn #459137) 2025-08-05 21:54:57.070170 :BBD76524:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-05 21:54:57.070170 :BBD76525:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=67 time=3111566376 2025-08-05 21:54:57.070171 :BBD76526:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-08-05 21:54:57.070171 :BBD76527:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-08-05 21:54:57.070172 :BBD76528:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-08-05 21:54:57.070172 :BBD76529:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-05 21:54:57.070173 :BBD7652A:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-05 21:54:57.070742 :BBD7652B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-05 21:55:27.128147 :BBD76FA3:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-08-05 21:55:57.168503 :BBD779AC:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 08-05 21:55:57.157 2025-08-05 21:55:57.168505 :BBD779AD:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=19204 pso_num=24 pso_serial#=94 2025-08-05 21:55:57.168618 :BBD779AE:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=19204 osp_idx=22 osp_ver=679424 osp_pg=0 (spawn #459141) 2025-08-05 21:55:57.168618 :BBD779AF:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-05 21:55:57.168619 :BBD779B0:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=68 time=3111626470 2025-08-05 21:55:57.168619 :BBD779B1:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-08-05 21:55:57.168620 :BBD779B2:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-08-05 21:55:57.168620 :BBD779B3:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-08-05 21:55:57.168620 :BBD779B4:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-05 21:55:57.168621 :BBD779B5:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-05 21:55:57.169127 :BBD779B6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-05 21:56:27.221211 :BBD78390:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-08-05 21:56:57.245504 :BBD78D6D:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 08-05 21:56:57.234 2025-08-05 21:56:57.245506 :BBD78D6E:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=18896 pso_num=24 pso_serial#=95 2025-08-05 21:56:57.245662 :BBD78D6F:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=18896 osp_idx=22 osp_ver=679425 osp_pg=0 (spawn #459143) 2025-08-05 21:56:57.245663 :BBD78D70:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-05 21:56:57.245664 :BBD78D71:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=69 time=3111686548 2025-08-05 21:56:57.245665 :BBD78D72:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-08-05 21:56:57.245665 :BBD78D73:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-08-05 21:56:57.245666 :BBD78D74:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-08-05 21:56:57.245666 :BBD78D75:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-05 21:56:57.245667 :BBD78D76:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-05 21:56:57.246213 :BBD78D77:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-05 21:57:27.318994 :BBD79843:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-08-05 21:57:57.324627 :BBD7A204:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 08-05 21:57:57.313 2025-08-05 21:57:57.324629 :BBD7A205:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=17436 pso_num=24 pso_serial#=96 2025-08-05 21:57:57.324753 :BBD7A206:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=17436 osp_idx=22 osp_ver=679426 osp_pg=0 (spawn #459145) 2025-08-05 21:57:57.324753 :BBD7A207:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-05 21:57:57.324754 :BBD7A208:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=70 time=3111746626 2025-08-05 21:57:57.324754 :BBD7A209:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-08-05 21:57:57.324755 :BBD7A20A:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-08-05 21:57:57.324755 :BBD7A20B:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-08-05 21:57:57.324755 :BBD7A20C:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-05 21:57:57.324756 :BBD7A20D:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-05 21:57:57.325240 :BBD7A20E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-05 21:58:27.410489 :BBD7ABCB:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-08-05 21:58:57.398905 :BBD7B5C9:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 08-05 21:58:57.387 2025-08-05 21:58:57.398907 :BBD7B5CA:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=18552 pso_num=24 pso_serial#=97 2025-08-05 21:58:57.399058 :BBD7B5CB:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=18552 osp_idx=22 osp_ver=679427 osp_pg=0 (spawn #459147) 2025-08-05 21:58:57.399059 :BBD7B5CC:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-05 21:58:57.399060 :BBD7B5CD:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=71 time=3111806704 2025-08-05 21:58:57.399060 :BBD7B5CE:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-08-05 21:58:57.399060 :BBD7B5CF:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-08-05 21:58:57.399060 :BBD7B5D0:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-08-05 21:58:57.399061 :BBD7B5D1:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-05 21:58:57.399061 :BBD7B5D2:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-05 21:58:57.399537 :BBD7B5D3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-05 21:59:27.472903 :BBD7C012:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-08-05 21:59:57.513859 :BBD7CA06:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 08-05 21:59:57.503 2025-08-05 21:59:57.513861 :BBD7CA07:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=10744 pso_num=24 pso_serial#=98 2025-08-05 21:59:57.513985 :BBD7CA08:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=10744 osp_idx=22 osp_ver=679428 osp_pg=0 (spawn #459149) 2025-08-05 21:59:57.513986 :BBD7CA09:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-05 21:59:57.513986 :BBD7CA0A:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=72 time=3111866814 2025-08-05 21:59:57.513987 :BBD7CA0B:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-08-05 21:59:57.513987 :BBD7CA0C:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-08-05 21:59:57.513987 :BBD7CA0D:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-08-05 21:59:57.513988 :BBD7CA0E:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-05 21:59:57.513988 :BBD7CA0F:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-05 21:59:57.514468 :BBD7CA10:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-05 22:00:02.039161 :BBD7CD80:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-05 22:00:02.039161*:BBD7CD8E:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000024D5B898 estart=1754402401 eid=16785536 ctx=0x000000077FD6A000 cwh=0x0000000024D50068 cpu=0 buffg=1 interb=0 r=0 rb=0 w=0 wb=0 2025-08-05 22:00:02.039161*:BBD7CD8F:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000024D5B898 curCtx=0x0000000024D57AB8 pubTabIdxCnt=0 2025-08-05 22:00:02.039161*:BBD7CD90:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000024D5B898 2025-08-05 22:00:02.039161*:BBD7CD91:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000024D5B898 2025-08-05 22:00:02.039161*:BBD7CD92:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000024D5B898 curCtx=0x0000000024D57AB8 xsc->flg4=65792 flags=2 2025-08-05 22:00:02.039161*:BBD7CD93:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000024D5B898 2025-08-05 22:00:02.044786 :BBD7CDA2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-05 22:00:02.044836 :BBD7CDA6:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:jslv.c:9203 2025-08-05 22:00:02.049665 :BBD7CDCC:KFNU:kfn.c@2200:kfnPrepareASM(): kfnPrepareASM force=0 state_kfnsg=0x7 2025-08-05 22:00:02.050265 :BBD7CDE0:db_trace:kcc.c@13684:kccwbp(): [10021:24:193:1] 0115000000000000 0115000000000000 726f120000000000 2025-08-05 22:00:02.051932 :BBD7CDF6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=15 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-08-05 22:00:02.052015 :BBD7CE03:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=15 loc='ksr2.h LINE:607 ID:ksrmdone' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-05 22:00:02.052024 :BBD7CE0A:db_trace:ksb.c@6610:ksbcic_int(): [10254:24:193] KSBCIC: (USER) starting cic on opcode KSBCIRCO [1] with args (1 8397264 1) 2025-08-05 22:00:02.052029 :BBD7CE0B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=15 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-05 22:00:02.052058 :BBD7CE18:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=15 loc='ksa2.h LINE:286 ID:ksasnr' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-05 22:00:02.052769 :BBD7CE23:db_trace:ksb.c@6610:ksbcic_int(): [10254:24:193] KSBCIC: (USER) starting cic on opcode KSBCICKP [2] with args (4 0 233555989) 2025-08-05 22:00:02.052772 :BBD7CE24:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=15 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-05 22:00:02.052796 :BBD7CE2F:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=15 loc='ksa2.h LINE:286 ID:ksasnr' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-05 22:00:02.052804 :BBD7CE3B:db_trace:ksb.c@6610:ksbcic_int(): [10254:24:193] KSBCIC: (USER) starting cic on opcode KSBCICKP [2] with args (6 65560 1) 2025-08-05 22:00:02.052807 :BBD7CE3C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=15 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-05 22:00:02.052833 :BBD7CE49:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=15 loc='ksa2.h LINE:286 ID:ksasnr' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-05 22:00:02.052837 :BBD7CE54:db_trace:ksb.c@6610:ksbcic_int(): [10254:24:193] KSBCIC: (USER) starting cic on opcode KSBCICKP [2] with args (1 2 65560) 2025-08-05 22:00:02.052839 :BBD7CE55:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=15 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-05 22:00:02.052897 :BBD7CE75:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=15 loc='ksa2.h LINE:286 ID:ksasnr' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-05 22:00:02.053602 :BBD7CF17:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=15 loc='ksq.h LINE:1877 ID:ksqrcl' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-05 22:00:02.053625 :BBD7CF2E:KFNU:kfn.c@2200:kfnPrepareASM(): kfnPrepareASM force=0 state_kfnsg=0x7 2025-08-05 22:00:02.054532 :BBD7CF2F:db_trace:kcc.c@13684:kccwbp(): [10021:24:193:1] 0115000000000000 0115000000000000 736f120000000000 2025-08-05 22:00:02.054939 :BBD7CF30:db_trace:ksb.c@6610:ksbcic_int(): [10254:24:193] KSBCIC: (USER) starting cic on opcode KSBCIBBS [20] with args (2 0 233555989) 2025-08-05 22:00:02.054946 :BBD7CF31:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=15 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-05 22:00:02.054978 :BBD7CF3C:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=15 loc='ksa2.h LINE:286 ID:ksasnr' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-05 22:00:02.063558 :BBD7CFAE:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:jslv.c:9203 2025-08-05 22:00:02.065277 :BBD7CFAF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-05 22:00:02.065384 :BBD7CFB2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 2025-08-05 22:00:02.065502 :BBD7CFC0:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-08-05 22:00:02.164113 :BBD7D102:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-05 22:00:04.002254 :BBD7D518:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=59 loc='kkj.h LINE:914 ID:kkjpstnp' id1=0 id2=0 name= type=0 fac#=0 facpost=1 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 24 (osid: 10744, J001)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de