Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250702220008\orcl_j005_15440_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250702220008\orcl_j005_15440_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:36835M/63366M, Ph+PgF:42810M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 31 Windows thread id: 15440, image: ORACLE.EXE (J005) *** 2025-07-02 22:00:08.534 *** SESSION ID:(249.1255) 2025-07-02 22:00:08.534 *** 2025-07-02 22:00:08.534 Process diagnostic dump for ORACLE.EXE (J005), OS id=15440, pid: 31, proc_ser: 101, sid: 249, sess_ser: 1255 ------------------------------------------------------------------------------- current sql: <none> client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 15440 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J005) 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.441391 sec, exc=0.441391 sec, total=0.441391 sec wait times: max=0.500000 sec, heur=6.453810 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.000010 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.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.000014 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.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.000008 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.499947 sec, exc=0.499947 sec, total=0.499947 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000062 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.499975 sec, exc=0.499975 sec, total=0.499975 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000014 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.509503 sec, exc=0.509503 sec, total=0.509503 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 5: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=6 seq_num=7 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.000014 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.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 7: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=4 seq_num=5 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.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.499978 sec, exc=0.499978 sec, total=0.499978 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000018 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.500001 sec, exc=0.500001 sec, total=0.500001 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 sec of elapsed time Sampled Session History of session 249 serial 1255 --------------------------------------------------- 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:02 - 22:00:08] 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-07-02 22:00:08.534 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 31 (osid: 15440, J005) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-06-29 14:00:05.555845 :AB3D14CD:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-29 15:00:13.208788 :AB41C87C:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-29 15:00:13.198 2025-06-29 15:00:13.208789 :AB41C87D:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=15492 pso_num=31 pso_serial#=86 2025-06-29 15:00:13.208933 :AB41C87E:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=15492 osp_idx=29 osp_ver=595 osp_pg=0 (spawn #334874) 2025-06-29 15:00:13.208934 :AB41C87F:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-29 15:00:13.208934 :AB41C880:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=181 time=4184956391 2025-06-29 15:00:13.208935 :AB41C881:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-06-29 15:00:13.208935 :AB41C882:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-06-29 15:00:13.208935 :AB41C883:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-06-29 15:00:13.208936 :AB41C884:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-29 15:00:13.208936 :AB41C885:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-29 15:00:13.209459 :AB41C886:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-29 15:00:13.209510 :AB41C88C:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-29 15:00:13.218372 :AB41C8B1:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-29 16:00:20.570215 :AB46746D:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-29 16:00:20.567 2025-06-29 16:00:20.570216 :AB46746E:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=13592 pso_num=31 pso_serial#=87 2025-06-29 16:00:20.570353 :AB46746F:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=13592 osp_idx=29 osp_ver=596 osp_pg=0 (spawn #335011) 2025-06-29 16:00:20.570354 :AB467470:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-29 16:00:20.570354 :AB467471:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=182 time=4188563750 2025-06-29 16:00:20.570355 :AB467472:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-06-29 16:00:20.570355 :AB467473:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-06-29 16:00:20.570355 :AB467474:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-06-29 16:00:20.570356 :AB467475:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-29 16:00:20.570356 :AB467476:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-29 16:00:20.570855 :AB46747B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-29 16:00:20.570899 :AB467481:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-29 16:00:20.576503 :AB46749A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 16:00:20.601354 :AB4674CA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 16:00:20.616302 :AB4674D2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 16:00:20.645424 :AB4674DA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 16:00:20.649224 :AB4674E2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 16:00:20.652924 :AB4674EA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 16:00:20.657235 :AB4674FD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 16:00:20.658399 :AB467505:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 16:00:20.684897 :AB46750D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=16 loc='ktm.h LINE:583 ID:ktmpsm' id1=0 id2=0 name= type=0 2025-06-29 16:00:20.696138 :AB46761B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] 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-06-29 16:00:20.704691 :AB4676DA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 16:00:20.704702 :AB4676DB:db_trace:ktur.c@3079:ktuabt(): [10444:31:249] ABORT TRANSACTION - xid: 0x000a.009.00170690 2025-06-29 16:00:20.705044 :AB4676E3:db_trace:ktu.c@4871:ktuaex1r(): [10442:31:249] Extension usn 10, ext 1, nex 4 2025-06-29 16:00:20.705051 :AB4676E4:db_trace:ktusm.c@2117:ktusmasp(): [10445:31:249] des1:tsn:1 rdba:0x008159ed where: ktspbwh1: ktspfsrch 2025-06-29 16:00:21.780793*:AB467758:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000002DC74678 estart=1751184020 eid=16779586 ctx=0x000000077BA4B1C8 cwh=0x000000002DCA1530 cpu=484375 buffg=0 interb=0 r=0 rb=0 w=0 wb=0 2025-06-29 16:00:21.780793*:AB467759:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000002DC74678 curCtx=0x000000002DCAAFE8 pubTabIdxCnt=0 2025-06-29 16:00:21.780793*:AB46775A:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000002DC74678 2025-06-29 16:00:21.780793*:AB46775B:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000002DC74678 2025-06-29 16:00:21.780793*:AB46775C:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000002DCBDA98 estart=1751184020 eid=16779572 ctx=0x0000000787AD5BF0 cwh=0x000000002DC60AA0 cpu=484375 buffg=0 interb=0 r=0 rb=0 w=0 wb=0 2025-06-29 16:00:21.780793*:AB46775D:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000002DCBDA98 curCtx=0x0000000029960EB8 pubTabIdxCnt=0 2025-06-29 16:00:21.780793*:AB46775E:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000002DCBDA98 2025-06-29 16:00:21.780793*:AB46775F:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000002DCBDA98 2025-06-29 16:00:21.843291*:AB467760:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000002DC74678 curCtx=0x000000002DCAAFE8 xsc->flg4=65792 flags=1 2025-06-29 16:00:21.843291*:AB467761:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000002DC74678 2025-06-29 16:00:21.843291*:AB467762:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000002DCBDA98 curCtx=0x0000000029960EB8 xsc->flg4=65792 flags=2 2025-06-29 16:00:21.843291*:AB467763:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000002DCBDA98 2025-06-29 16:00:21.920601 :AB467764:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 16:00:21.956518 :AB467778:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 16:00:21.956840 :AB467780:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 16:00:21.957119 :AB467788:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 16:00:21.957136 :AB46778B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=18 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 16:00:21.957195 :AB467799:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-29 16:00:21.959855 :AB4677A5:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-29 19:00:43.438726 :AB547EAF:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-29 19:00:43.427 2025-06-29 19:00:43.438728 :AB547EB0:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=6984 pso_num=31 pso_serial#=88 2025-06-29 19:00:43.438882 :AB547EB1:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=6984 osp_idx=29 osp_ver=597 osp_pg=0 (spawn #335424) 2025-06-29 19:00:43.438883 :AB547EB2:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-29 19:00:43.438883 :AB547EB3:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=183 time=4199386625 2025-06-29 19:00:43.438884 :AB547EB4:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-06-29 19:00:43.438885 :AB547EB5:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-06-29 19:00:43.438885 :AB547EB6:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-06-29 19:00:43.438886 :AB547EB7:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-29 19:00:43.438886 :AB547EB8:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-29 19:00:43.439380 :AB547EBC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-29 19:00:43.439424 :AB547EC2:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-29 19:00:43.448524 :AB547ED4:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-29 20:00:50.457736 :AB592BB6:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-29 20:00:50.448 2025-06-29 20:00:50.457739 :AB592BB7:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=18080 pso_num=31 pso_serial#=89 2025-06-29 20:00:50.457879 :AB592BB8:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=18080 osp_idx=29 osp_ver=598 osp_pg=0 (spawn #335562) 2025-06-29 20:00:50.457880 :AB592BB9:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-29 20:00:50.457881 :AB592BBA:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=184 time=4202993641 2025-06-29 20:00:50.457881 :AB592BBB:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-06-29 20:00:50.457882 :AB592BBC:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-06-29 20:00:50.457882 :AB592BBD:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-06-29 20:00:50.457882 :AB592BBE:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-29 20:00:50.457883 :AB592BBF:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-29 20:00:50.458406 :AB592BC0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-29 20:00:50.458444 :AB592BC6:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-29 20:00:50.467353 :AB592BDB:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-29 21:00:57.902278 :AB5DD6C8:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-29 21:00:57.892 2025-06-29 21:00:57.902280 :AB5DD6C9:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=14108 pso_num=31 pso_serial#=90 2025-06-29 21:00:57.902424 :AB5DD6CA:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=14108 osp_idx=29 osp_ver=599 osp_pg=0 (spawn #335700) 2025-06-29 21:00:57.902425 :AB5DD6CB:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-29 21:00:57.902426 :AB5DD6CC:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=185 time=4206601094 2025-06-29 21:00:57.902426 :AB5DD6CD:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-06-29 21:00:57.902426 :AB5DD6CE:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-06-29 21:00:57.902427 :AB5DD6CF:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-06-29 21:00:57.902427 :AB5DD6D0:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-29 21:00:57.902427 :AB5DD6D1:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-29 21:00:57.903016 :AB5DD6D5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-29 21:00:57.903058 :AB5DD6DB:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-29 21:00:57.912306 :AB5DD6F8:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-29 23:59:10.077800 :AB6BD7E2:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-29 23:59:10.068 2025-06-29 23:59:10.077802 :AB6BD7E3:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=16012 pso_num=31 pso_serial#=91 2025-06-29 23:59:10.077947 :AB6BD7E4:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=16012 (legacy spawn) 2025-06-29 23:59:10.092533 :AB6BD7E5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 23:59:13.185062 :AB6BD91C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 23:59:13.185243 :AB6BD921:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-29 23:59:13.186436 :AB6BD926:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-29 23:59:13.351015 :AB6BD929:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-29 23:59:13.349 2025-06-29 23:59:13.351016 :AB6BD92A:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=6652 pso_num=31 pso_serial#=92 2025-06-29 23:59:13.351160 :AB6BD92B:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=6652 (legacy spawn) 2025-06-29 23:59:13.365489 :AB6BD92C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 23:59:46.545072 :AB6BE50A:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-29 23:59:55.028845 :AB6BE864:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-29 23:59:55.018 2025-06-29 23:59:55.028847 :AB6BE865:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=1168 pso_num=31 pso_serial#=93 2025-06-29 23:59:55.028987 :AB6BE866:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=1168 (legacy spawn) 2025-06-29 23:59:55.042650 :AB6BE867:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 23:59:58.179731 :AB6BE956:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-29 23:59:58.179920 :AB6BE95B:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-29 23:59:58.181092 :AB6BE960:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-29 23:59:58.400486 :AB6BE964:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-29 23:59:58.393 2025-06-29 23:59:58.400488 :AB6BE965:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=7880 pso_num=31 pso_serial#=94 2025-06-29 23:59:58.400628 :AB6BE966:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=7880 (legacy spawn) 2025-06-29 23:59:58.415004 :AB6BE967:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-30 00:06:18.380043 :AB6C746A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-30 00:06:18.380215 :AB6C746F:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-30 00:06:18.381314 :AB6C7474:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-30 22:00:01.601197 :ABD35203:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-30 22:00:01.598 2025-06-30 22:00:01.601197 :ABD35204:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=8032 pso_num=31 pso_serial#=95 2025-06-30 22:00:01.601326 :ABD35205:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=8032 osp_idx=29 osp_ver=604 osp_pg=0 (spawn #339177) 2025-06-30 22:00:01.601327 :ABD35206:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-30 22:00:01.601328 :ABD35207:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=186 time=1577486 2025-06-30 22:00:01.601328 :ABD35208:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-06-30 22:00:01.601328 :ABD35209:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-06-30 22:00:01.601329 :ABD3520A:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-06-30 22:00:01.601329 :ABD3520B:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-30 22:00:01.601330 :ABD3520C:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-30 22:00:01.601857 :ABD3521E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-30 22:00:31.719185 :ABD36540:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-30 23:59:17.220097 :ABDD54DE:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-30 23:59:17.209 2025-06-30 23:59:17.220099 :ABDD54DF:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=18200 pso_num=31 pso_serial#=96 2025-06-30 23:59:17.220225 :ABDD54E0:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=18200 osp_idx=29 osp_ver=605 osp_pg=0 (spawn #339457) 2025-06-30 23:59:17.220225 :ABDD54E1:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-30 23:59:17.220226 :ABDD54E2:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=187 time=8733111 2025-06-30 23:59:17.220226 :ABDD54E3:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-06-30 23:59:17.220227 :ABDD54E4:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-06-30 23:59:17.220227 :ABDD54E5:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-06-30 23:59:17.220227 :ABDD54E6:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-30 23:59:17.220227 :ABDD54E7:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-30 23:59:17.220761 :ABDD54E8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-30 23:59:47.276202 :ABDD5F6A:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-30 23:59:52.087007 :ABDD6155:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-30 23:59:52.085 2025-06-30 23:59:52.087010 :ABDD6156:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=15516 pso_num=31 pso_serial#=97 2025-06-30 23:59:52.087146 :ABDD6157:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=15516 (legacy spawn) 2025-06-30 23:59:52.101254 :ABDD6158:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-01 00:00:25.153059 :ABDD6FD8:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-07-01 22:00:00.510726 :AC4243E4:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 07-01 22:00:00.507 2025-07-01 22:00:00.510727 :AC4243E5:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=9584 pso_num=31 pso_serial#=98 2025-07-01 22:00:00.510851 :AC4243E6:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=9584 osp_idx=29 osp_ver=607 osp_pg=0 (spawn #342504) 2025-07-01 22:00:00.510852 :AC4243E8:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-01 22:00:00.510852 :AC4243E9:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=188 time=87976392 2025-07-01 22:00:00.510853 :AC4243EA:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-07-01 22:00:00.510853 :AC4243EB:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-07-01 22:00:00.510853 :AC4243EC:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-07-01 22:00:00.510854 :AC4243ED:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-01 22:00:00.510854 :AC4243EE:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-01 22:00:00.511447 :AC4243FF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-01 22:00:30.559286 :AC4255B4:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-07-01 23:59:18.205497 :AC4BFEB3:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 07-01 23:59:18.205 2025-07-01 23:59:18.205499 :AC4BFEB4:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=2648 pso_num=31 pso_serial#=99 2025-07-01 23:59:18.205641 :AC4BFEB5:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=2648 (legacy spawn) 2025-07-01 23:59:18.220327 :AC4BFEB6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-01 23:59:51.406055 :AC4C0B1F:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-07-01 23:59:55.023387 :AC4C0C32:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 07-01 23:59:55.021 2025-07-01 23:59:55.023389 :AC4C0C33:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=4292 pso_num=31 pso_serial#=100 2025-07-01 23:59:55.023526 :AC4C0C34:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=4292 (legacy spawn) 2025-07-01 23:59:55.038290 :AC4C0C35:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-02 00:00:28.132001 :AC4C1AAA:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-07-02 22:00:02.083464 :ACB29315:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 07-02 22:00:02.077 2025-07-02 22:00:02.083467 :ACB29316:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=15440 pso_num=31 pso_serial#=101 2025-07-02 22:00:02.083657 :ACB29317:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=15440 osp_idx=29 osp_ver=610 osp_pg=0 (spawn #345834) 2025-07-02 22:00:02.083658 :ACB29318:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-02 22:00:02.083659 :ACB29319:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=189 time=174377954 2025-07-02 22:00:02.083660 :ACB2931A:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-07-02 22:00:02.083660 :ACB2931B:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-07-02 22:00:02.083660 :ACB2931C:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-07-02 22:00:02.083661 :ACB2931D:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-02 22:00:02.083661 :ACB2931E:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-02 22:00:02.084415 :ACB2931F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 31 (osid: 15440, J005)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de