Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250803082753\orcl_j000_16392_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250803082753\orcl_j000_16392_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:35781M/63366M, Ph+PgF:41368M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 25 Windows thread id: 16392, image: ORACLE.EXE (J000) *** 2025-08-03 08:27:53.906 *** SESSION ID:(201.40131) 2025-08-03 08:27:53.906 *** 2025-08-03 08:27:53.906 Process diagnostic dump for ORACLE.EXE (J000), OS id=16392, pid: 25, proc_ser: 177, sid: 201, sess_ser: 40131 ------------------------------------------------------------------------------- current sql: <none> client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 16392 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.334413 sec, exc=0.334413 sec, total=0.334413 sec wait times: max=0.500000 sec, heur=6.363138 sec wait counts: calls=1 os=1 in_wait=1 iflags=0x5a8 Wait State: fixed_waits=0 flags=0x22 boundary=0x0000000000000000/-1 Session Wait History: elapsed time of 0.000008 sec since current wait 0: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=11 seq_num=12 snap_id=1 wait times: snap=0.499996 sec, exc=0.499996 sec, total=0.499996 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 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.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.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.499987 sec, exc=0.499987 sec, total=0.499987 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000011 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.510105 sec, exc=0.510105 sec, total=0.510105 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 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.499991 sec, exc=0.499991 sec, total=0.499991 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000010 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.510111 sec, exc=0.510111 sec, total=0.510111 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000007 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.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 7: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=4 seq_num=5 snap_id=1 wait times: snap=0.499996 sec, exc=0.499996 sec, total=0.499996 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 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.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.000007 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.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.000007 sec of elapsed time Sampled Session History of session 201 serial 40131 --------------------------------------------------- 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, 08:27:47 - 08:27:53] idle wait at each sample [session created at: 08:27:47] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-08-03 08:27:53.906 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 25 (osid: 16392, J000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-08-03 08:14:46.390793 :BAB0BDB5:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-03 08:14:46.390793 :BAB0BDB6:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-03 08:14:46.391120 :BAB0BDB7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-03 08:15:01.419720 :BAB0C2F4:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-03 08:15:01.419752*:BAB0C2F5:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x00000000271DBB58 estart=1754180100 eid=16988024 ctx=0x000000077BD98A08 cwh=0x00000000271901B0 cpu=0 buffg=1 interb=0 r=0 rb=0 w=0 wb=0 2025-08-03 08:15:01.419752*:BAB0C2F6:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x00000000271DBB58 curCtx=0x000000002719F708 pubTabIdxCnt=0 2025-08-03 08:15:01.419752*:BAB0C2F7:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x00000000271DBB58 2025-08-03 08:15:01.419752*:BAB0C2F8:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x00000000271DBB58 2025-08-03 08:15:01.419752*:BAB0C2F9:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x00000000271DBB58 curCtx=0x000000002719F708 xsc->flg4=65792 flags=2 2025-08-03 08:15:01.419752*:BAB0C2FA:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x00000000271DBB58 2025-08-03 08:15:01.420378 :BAB0C2FB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-03 08:15:01.425735 :BAB0C303:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-03 08:15:01.426720 :BAB0C30B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-03 08:15:01.426853 :BAB0C314:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-03 08:15:31.496022 :BAB0CCAF:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-03 08:15:46.509522 :BAB0D1EB:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-03 08:15:46.498 2025-08-03 08:15:46.509524 :BAB0D1EC:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=9372 pso_num=25 pso_serial#=163 2025-08-03 08:15:46.509650 :BAB0D1ED:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=9372 osp_idx=23 osp_ver=225950 osp_pg=0 (spawn #450577) 2025-08-03 08:15:46.509651 :BAB0D1EE:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-03 08:15:46.509651 :BAB0D1EF:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=42 time=2889615814 2025-08-03 08:15:46.509652 :BAB0D1F0:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-03 08:15:46.509652 :BAB0D1F1:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-03 08:15:46.509652 :BAB0D1F2:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-03 08:15:46.509653 :BAB0D1F3:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-03 08:15:46.509653 :BAB0D1F4:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-03 08:15:46.510143 :BAB0D1F5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-03 08:16:16.599152 :BAB0DBE6:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-03 08:16:46.600172 :BAB0E5BE:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-03 08:16:46.589 2025-08-03 08:16:46.600174 :BAB0E5BF:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=18448 pso_num=25 pso_serial#=164 2025-08-03 08:16:46.600313 :BAB0E5C0:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=18448 osp_idx=23 osp_ver=225951 osp_pg=0 (spawn #450579) 2025-08-03 08:16:46.600314 :BAB0E5C1:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-03 08:16:46.600315 :BAB0E5C2:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=43 time=2889675908 2025-08-03 08:16:46.600315 :BAB0E5C3:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-03 08:16:46.600316 :BAB0E5C4:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-03 08:16:46.600316 :BAB0E5C5:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-03 08:16:46.600317 :BAB0E5C6:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-03 08:16:46.600317 :BAB0E5C7:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-03 08:16:46.600806 :BAB0E5C8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-03 08:17:16.688957 :BAB0F072:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-03 08:17:46.645539 :BAB0FABD:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-03 08:17:46.634 2025-08-03 08:17:46.645541 :BAB0FABE:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=8628 pso_num=25 pso_serial#=165 2025-08-03 08:17:46.645681 :BAB0FABF:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=8628 osp_idx=23 osp_ver=225952 osp_pg=0 (spawn #450582) 2025-08-03 08:17:46.645682 :BAB0FAC0:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-03 08:17:46.645683 :BAB0FAC1:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=44 time=2889735939 2025-08-03 08:17:46.645683 :BAB0FAC2:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-03 08:17:46.645684 :BAB0FAC3:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-03 08:17:46.645684 :BAB0FAC4:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-03 08:17:46.645685 :BAB0FAC5:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-03 08:17:46.645685 :BAB0FAC6:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-03 08:17:46.646188 :BAB0FAC7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-03 08:18:16.720782 :BAB10501:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-03 08:18:46.750725 :BAB10F06:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-03 08:18:46.739 2025-08-03 08:18:46.750728 :BAB10F07:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=20188 pso_num=25 pso_serial#=166 2025-08-03 08:18:46.750933 :BAB10F08:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=20188 osp_idx=23 osp_ver=225953 osp_pg=0 (spawn #450585) 2025-08-03 08:18:46.750934 :BAB10F09:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-03 08:18:46.750934 :BAB10F0A:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=45 time=2889796048 2025-08-03 08:18:46.750935 :BAB10F0B:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-03 08:18:46.750935 :BAB10F0C:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-03 08:18:46.750935 :BAB10F0D:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-03 08:18:46.750935 :BAB10F0E:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-03 08:18:46.750936 :BAB10F0F:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-03 08:18:46.751418 :BAB10F10:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-03 08:19:16.827169 :BAB118DC:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-03 08:19:46.854894 :BAB122C6:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-03 08:19:46.843 2025-08-03 08:19:46.854897 :BAB122C7:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=20324 pso_num=25 pso_serial#=167 2025-08-03 08:19:46.855015 :BAB122C8:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=20324 osp_idx=23 osp_ver=225954 osp_pg=0 (spawn #450587) 2025-08-03 08:19:46.855016 :BAB122C9:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-03 08:19:46.855017 :BAB122CA:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=46 time=2889856158 2025-08-03 08:19:46.855017 :BAB122CB:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-03 08:19:46.855017 :BAB122CC:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-03 08:19:46.855018 :BAB122CD:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-03 08:19:46.855018 :BAB122CE:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-03 08:19:46.855019 :BAB122CF:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-03 08:19:46.855542 :BAB122D0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-03 08:20:16.911894 :BAB12D24:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-03 08:20:46.931650 :BAB1372E:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-03 08:20:46.920 2025-08-03 08:20:46.931652 :BAB1372F:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=18712 pso_num=25 pso_serial#=168 2025-08-03 08:20:46.931776 :BAB13730:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=18712 osp_idx=23 osp_ver=225955 osp_pg=0 (spawn #450589) 2025-08-03 08:20:46.931777 :BAB13731:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-03 08:20:46.931777 :BAB13732:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=47 time=2889916236 2025-08-03 08:20:46.931778 :BAB13733:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-03 08:20:46.931778 :BAB13734:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-03 08:20:46.931778 :BAB13735:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-03 08:20:46.931779 :BAB13736:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-03 08:20:46.931779 :BAB13737:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-03 08:20:46.932268 :BAB13738:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-03 08:21:17.024321 :BAB14133:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-03 08:21:47.008419 :BAB14B5E:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-03 08:21:46.996 2025-08-03 08:21:47.008421 :BAB14B5F:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=19696 pso_num=25 pso_serial#=169 2025-08-03 08:21:47.008576 :BAB14B60:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=19696 osp_idx=23 osp_ver=225956 osp_pg=0 (spawn #450591) 2025-08-03 08:21:47.008577 :BAB14B61:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-03 08:21:47.008577 :BAB14B62:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=48 time=2889976314 2025-08-03 08:21:47.008578 :BAB14B63:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-03 08:21:47.008578 :BAB14B64:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-03 08:21:47.008579 :BAB14B65:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-03 08:21:47.008579 :BAB14B66:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-03 08:21:47.008580 :BAB14B67:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-03 08:21:47.009094 :BAB14B68:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-03 08:22:17.057173 :BAB155AE:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-03 08:22:47.111817 :BAB15F8F:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-03 08:22:47.101 2025-08-03 08:22:47.111819 :BAB15F90:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=18260 pso_num=25 pso_serial#=170 2025-08-03 08:22:47.111964 :BAB15F91:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=18260 osp_idx=23 osp_ver=225957 osp_pg=0 (spawn #450593) 2025-08-03 08:22:47.111964 :BAB15F92:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-03 08:22:47.111965 :BAB15F93:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=49 time=2890036408 2025-08-03 08:22:47.111965 :BAB15F94:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-03 08:22:47.111966 :BAB15F95:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-03 08:22:47.111966 :BAB15F96:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-03 08:22:47.111966 :BAB15F97:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-03 08:22:47.111967 :BAB15F98:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-03 08:22:47.112437 :BAB15F99:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-03 08:23:17.187793 :BAB169C9:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-03 08:23:47.200809 :BAB173D1:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-03 08:23:47.190 2025-08-03 08:23:47.200811 :BAB173D2:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=17856 pso_num=25 pso_serial#=171 2025-08-03 08:23:47.200943 :BAB173D3:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=17856 osp_idx=23 osp_ver=225958 osp_pg=0 (spawn #450596) 2025-08-03 08:23:47.200944 :BAB173D4:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-03 08:23:47.200944 :BAB173D5:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=50 time=2890096501 2025-08-03 08:23:47.200945 :BAB173D6:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-03 08:23:47.200945 :BAB173D7:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-03 08:23:47.200945 :BAB173D8:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-03 08:23:47.200946 :BAB173D9:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-03 08:23:47.200946 :BAB173DA:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-03 08:23:47.201431 :BAB173DB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-03 08:24:17.292536 :BAB17DCF:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-03 08:24:47.285944 :BAB18806:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-03 08:24:47.275 2025-08-03 08:24:47.285946 :BAB18807:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=20304 pso_num=25 pso_serial#=172 2025-08-03 08:24:47.286074 :BAB18808:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=20304 osp_idx=23 osp_ver=225959 osp_pg=0 (spawn #450598) 2025-08-03 08:24:47.286075 :BAB18809:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-03 08:24:47.286075 :BAB1880A:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=51 time=2890156579 2025-08-03 08:24:47.286076 :BAB1880B:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-03 08:24:47.286076 :BAB1880C:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-03 08:24:47.286076 :BAB1880D:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-03 08:24:47.286077 :BAB1880E:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-03 08:24:47.286077 :BAB1880F:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-03 08:24:47.286559 :BAB18810:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-03 08:25:02.288792 :BAB18D03:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-03 08:25:32.358861 :BAB196F0:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-03 08:25:47.378429 :BAB19BEE:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-03 08:25:47.367 2025-08-03 08:25:47.378431 :BAB19BEF:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=1020 pso_num=25 pso_serial#=173 2025-08-03 08:25:47.378563 :BAB19BF0:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=1020 osp_idx=23 osp_ver=225960 osp_pg=0 (spawn #450600) 2025-08-03 08:25:47.378564 :BAB19BF1:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-03 08:25:47.378565 :BAB19BF2:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=52 time=2890216673 2025-08-03 08:25:47.378565 :BAB19BF3:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-03 08:25:47.378566 :BAB19BF4:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-03 08:25:47.378566 :BAB19BF5:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-03 08:25:47.378567 :BAB19BF6:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-03 08:25:47.378567 :BAB19BF7:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-03 08:25:47.379055 :BAB19BF8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-03 08:26:17.434777 :BAB1A607:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-03 08:26:47.436427 :BAB1B000:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-03 08:26:47.425 2025-08-03 08:26:47.436429 :BAB1B001:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=12540 pso_num=25 pso_serial#=174 2025-08-03 08:26:47.436565 :BAB1B002:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=12540 osp_idx=23 osp_ver=225961 osp_pg=0 (spawn #450602) 2025-08-03 08:26:47.436565 :BAB1B003:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-03 08:26:47.436566 :BAB1B004:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=53 time=2890276736 2025-08-03 08:26:47.436566 :BAB1B005:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-03 08:26:47.436567 :BAB1B006:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-03 08:26:47.436567 :BAB1B007:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-03 08:26:47.436567 :BAB1B008:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-03 08:26:47.436568 :BAB1B009:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-03 08:26:47.437067 :BAB1B00A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-03 08:27:17.508928 :BAB1BAD3:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-03 08:27:47.482927 :BAB1FA9F:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-03 08:27:47.469 2025-08-03 08:27:47.482928 :BAB1FAA0:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=20448 pso_num=25 pso_serial#=175 2025-08-03 08:27:47.483089 :BAB1FAA1:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=20448 (legacy spawn) 2025-08-03 08:27:47.489506 :BAB1FAA2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-03 08:27:47.489682 :BAB1FAAB:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-03 08:27:47.490499 :BAB1FAAC:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-03 08:27:47.508769 :BAB1FAAF:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-03 08:27:47.501 2025-08-03 08:27:47.508772 :BAB1FAB0:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=15432 pso_num=25 pso_serial#=176 2025-08-03 08:27:47.508910 :BAB1FAB1:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=15432 (legacy spawn) 2025-08-03 08:27:47.515491 :BAB1FAB2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-03 08:27:47.515743 :BAB1FABD:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-03 08:27:47.516630 :BAB1FABE:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-03 08:27:47.537629 :BAB1FAD9:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-03 08:27:47.532 2025-08-03 08:27:47.537631 :BAB1FADA:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=16392 pso_num=25 pso_serial#=177 2025-08-03 08:27:47.537772 :BAB1FADB:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=16392 osp_idx=23 osp_ver=225964 osp_pg=0 (spawn #450604) 2025-08-03 08:27:47.537773 :BAB1FADC:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-03 08:27:47.537773 :BAB1FADD:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=54 time=2890336845 2025-08-03 08:27:47.537773 :BAB1FADE:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-03 08:27:47.537774 :BAB1FADF:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-03 08:27:47.537774 :BAB1FAE0:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-03 08:27:47.537774 :BAB1FAE1:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-03 08:27:47.537775 :BAB1FAE2:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-03 08:27:47.538287 :BAB1FAE3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-03 08:27:47.538931 :BAB1FAF8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-03 08:27:47.546610 :BAB1FB14:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:psdpgi.c:2235 2025-08-03 08:27:47.547006 :BAB1FB15:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-03 08:27:47.547044 :BAB1FB18:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:psdpgi.c:2235 2025-08-03 08:27:47.547925 :BAB1FB1E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-03 08:27:47.548049 :BAB1FB27:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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 25 (osid: 16392, J000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de