Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250522220955\orcl_j001_13256_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250522220955\orcl_j001_13256_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:37351M/63366M, Ph+PgF:44419M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 24 Windows thread id: 13256, image: ORACLE.EXE (J001) *** 2025-05-22 22:09:55.592 *** SESSION ID:(193.50257) 2025-05-22 22:09:55.592 *** 2025-05-22 22:09:55.592 Process diagnostic dump for ORACLE.EXE (J001), OS id=13256, pid: 24, proc_ser: 28, sid: 193, sess_ser: 50257 ------------------------------------------------------------------------------- current sql: <none> client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 13256 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J001) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=32 seq_num=33 snap_id=1 wait times: snap=0.393281 sec, exc=0.393281 sec, total=0.393281 sec wait times: max=0.500000 sec, heur=16.457369 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.000020 sec since current wait 0: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=31 seq_num=32 snap_id=1 wait times: snap=0.499992 sec, exc=0.499992 sec, total=0.499992 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000013 sec of elapsed time 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=30 seq_num=31 snap_id=1 wait times: snap=0.499985 sec, exc=0.499985 sec, total=0.499985 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000017 sec of elapsed time 2: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=29 seq_num=30 snap_id=1 wait times: snap=0.515405 sec, exc=0.515405 sec, total=0.515405 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000019 sec of elapsed time 3: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=28 seq_num=29 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.000017 sec of elapsed time 4: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=27 seq_num=28 snap_id=1 wait times: snap=0.499990 sec, exc=0.499990 sec, total=0.499990 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000013 sec of elapsed time 5: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=26 seq_num=27 snap_id=1 wait times: snap=0.510100 sec, exc=0.510100 sec, total=0.510100 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000017 sec of elapsed time 6: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=25 seq_num=26 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.000015 sec of elapsed time 7: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=24 seq_num=25 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.000012 sec of elapsed time 8: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=23 seq_num=24 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.000015 sec of elapsed time 9: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=22 seq_num=23 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.000013 sec of elapsed time Sampled Session History of session 193 serial 50257 --------------------------------------------------- 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 --------------------------------------------------- [17 samples, 22:09:39 - 22:09:55] idle wait at each sample [session created at: 22:09:39] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-05-22 22:09:55.592 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 24 (osid: 13256, J001) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-22 21:59:38.130521 :9AAA34F3: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-05-22 22:00:02.038214 :9AAA3E16: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-05-22 22:00:02.038214*:9AAA3E24:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000002495B898 estart=1747922401 eid=16780918 ctx=0x000000077FD6A000 cwh=0x0000000024950068 cpu=0 buffg=1 interb=0 r=0 rb=0 w=0 wb=0 2025-05-22 22:00:02.038214*:9AAA3E25:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000002495B898 curCtx=0x0000000024957AB8 pubTabIdxCnt=0 2025-05-22 22:00:02.038214*:9AAA3E26:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000002495B898 2025-05-22 22:00:02.038214*:9AAA3E27:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000002495B898 2025-05-22 22:00:02.038214*:9AAA3E28:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000002495B898 curCtx=0x0000000024957AB8 xsc->flg4=65792 flags=2 2025-05-22 22:00:02.038214*:9AAA3E29:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000002495B898 2025-05-22 22:00:02.043752 :9AAA3E34: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-05-22 22:00:02.043800 :9AAA3E37:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:jslv.c:9203 2025-05-22 22:00:02.048666 :9AAA3E61:KFNU:kfn.c@2200:kfnPrepareASM(): kfnPrepareASM force=0 state_kfnsg=0x7 2025-05-22 22:00:02.049245 :9AAA3E74:db_trace:kcc.c@13684:kccwbp(): [10021:24:193:1] 0115000000000000 0115000000000000 e5d9110000000000 2025-05-22 22:00:02.050921 :9AAA3E8A: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-05-22 22:00:02.050981 :9AAA3E97: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-05-22 22:00:02.050990 :9AAA3E9D:db_trace:ksb.c@6610:ksbcic_int(): [10254:24:193] KSBCIC: (USER) starting cic on opcode KSBCIRCO [1] with args (1 8397264 1) 2025-05-22 22:00:02.050995 :9AAA3E9E: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-05-22 22:00:02.051019 :9AAA3EAA: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-05-22 22:00:02.051766 :9AAA3EB6:db_trace:ksb.c@6610:ksbcic_int(): [10254:24:193] KSBCIC: (USER) starting cic on opcode KSBCICKP [2] with args (4 0 226099024) 2025-05-22 22:00:02.051771 :9AAA3EB7: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-05-22 22:00:02.051796 :9AAA3EC5: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-05-22 22:00:02.051805 :9AAA3ECF:db_trace:ksb.c@6610:ksbcic_int(): [10254:24:193] KSBCIC: (USER) starting cic on opcode KSBCICKP [2] with args (6 65560 1) 2025-05-22 22:00:02.051808 :9AAA3ED0: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-05-22 22:00:02.051836 :9AAA3EDC: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-05-22 22:00:02.051840 :9AAA3EE2:db_trace:ksb.c@6610:ksbcic_int(): [10254:24:193] KSBCIC: (USER) starting cic on opcode KSBCICKP [2] with args (1 2 65560) 2025-05-22 22:00:02.051843 :9AAA3EE5: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-05-22 22:00:02.051896 :9AAA3F1A: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-05-22 22:00:02.052473 :9AAA3FAB: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-05-22 22:00:02.052501 :9AAA3FAC:KFNU:kfn.c@2200:kfnPrepareASM(): kfnPrepareASM force=0 state_kfnsg=0x7 2025-05-22 22:00:02.053409 :9AAA3FB7:db_trace:kcc.c@13684:kccwbp(): [10021:24:193:1] 0115000000000000 0115000000000000 e6d9110000000000 2025-05-22 22:00:02.053789 :9AAA3FB8:db_trace:ksb.c@6610:ksbcic_int(): [10254:24:193] KSBCIC: (USER) starting cic on opcode KSBCIBBS [20] with args (2 0 226099024) 2025-05-22 22:00:02.053795 :9AAA3FB9: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-05-22 22:00:02.053820 :9AAA3FC4: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-05-22 22:00:02.062019 :9AAA4028:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:jslv.c:9203 2025-05-22 22:00:02.063667 :9AAA4037: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-05-22 22:00:02.063743 :9AAA403A: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-05-22 22:00:02.173198 :9AAA416E: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-05-22 22:00:04.012053 :9AAA45C8: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-05-22 22:00:34.100046 :9AAA52AE:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-22 22:00:38.261292 :9AAA54A8:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-22 22:00:38.250 2025-05-22 22:00:38.261294 :9AAA54A9:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=13376 pso_num=24 pso_serial#=18 2025-05-22 22:00:38.261419 :9AAA54AA:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=13376 osp_idx=22 osp_ver=304997 osp_pg=0 (spawn #209181) 2025-05-22 22:00:38.261420 :9AAA54AB:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-22 22:00:38.261421 :9AAA54AC:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=228 time=927013157 2025-05-22 22:00:38.261421 :9AAA54AD:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-05-22 22:00:38.261421 :9AAA54AE:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-05-22 22:00:38.261422 :9AAA54AF:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-05-22 22:00:38.261422 :9AAA54B0:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-22 22:00:38.261422 :9AAA54B1:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-22 22:00:38.261976 :9AAA54BA: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-05-22 22:01:08.297301 :9AAA5ED6:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-22 22:01:38.340200 :9AAA6873:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-22 22:01:38.328 2025-05-22 22:01:38.340203 :9AAA6874:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=8928 pso_num=24 pso_serial#=19 2025-05-22 22:01:38.340336 :9AAA6875:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=8928 osp_idx=22 osp_ver=304998 osp_pg=0 (spawn #209183) 2025-05-22 22:01:38.340336 :9AAA6876:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-22 22:01:38.340337 :9AAA6877:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=229 time=927073235 2025-05-22 22:01:38.340337 :9AAA6878:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-05-22 22:01:38.340337 :9AAA6879:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-05-22 22:01:38.340338 :9AAA687A:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-05-22 22:01:38.340338 :9AAA687B:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-22 22:01:38.340338 :9AAA687C:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-22 22:01:38.340840 :9AAA687D: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-05-22 22:02:08.416737 :9AAA71F3:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-22 22:02:38.421942 :9AAA7B68:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-22 22:02:38.410 2025-05-22 22:02:38.421944 :9AAA7B69:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=13500 pso_num=24 pso_serial#=20 2025-05-22 22:02:38.422073 :9AAA7B6A:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=13500 osp_idx=22 osp_ver=304999 osp_pg=0 (spawn #209185) 2025-05-22 22:02:38.422074 :9AAA7B6B:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-22 22:02:38.422075 :9AAA7B6C:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=230 time=927133313 2025-05-22 22:02:38.422075 :9AAA7B6D:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-05-22 22:02:38.422076 :9AAA7B6E:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-05-22 22:02:38.422076 :9AAA7B6F:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-05-22 22:02:38.422076 :9AAA7B70:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-22 22:02:38.422077 :9AAA7B71:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-22 22:02:38.422545 :9AAA7B72: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-05-22 22:03:08.514783 :9AAA85C0:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-22 22:03:38.531320 :9AAA8F39:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-22 22:03:38.519 2025-05-22 22:03:38.531322 :9AAA8F3A:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=13400 pso_num=24 pso_serial#=21 2025-05-22 22:03:38.531445 :9AAA8F3B:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=13400 osp_idx=22 osp_ver=305000 osp_pg=0 (spawn #209187) 2025-05-22 22:03:38.531446 :9AAA8F3C:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-22 22:03:38.531447 :9AAA8F3D:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=231 time=927193422 2025-05-22 22:03:38.531447 :9AAA8F3E:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-05-22 22:03:38.531447 :9AAA8F3F:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-05-22 22:03:38.531448 :9AAA8F40:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-05-22 22:03:38.531448 :9AAA8F41:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-22 22:03:38.531448 :9AAA8F42:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-22 22:03:38.531962 :9AAA8F43: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-05-22 22:04:08.593668 :9AAA98EC:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-22 22:04:38.636394 :9AAAA287:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-22 22:04:38.625 2025-05-22 22:04:38.636396 :9AAAA288:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=10456 pso_num=24 pso_serial#=22 2025-05-22 22:04:38.636546 :9AAAA289:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=10456 osp_idx=22 osp_ver=305001 osp_pg=0 (spawn #209190) 2025-05-22 22:04:38.636547 :9AAAA28A:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-22 22:04:38.636547 :9AAAA28B:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=232 time=927253532 2025-05-22 22:04:38.636548 :9AAAA28C:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-05-22 22:04:38.636548 :9AAAA28D:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-05-22 22:04:38.636549 :9AAAA28E:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-05-22 22:04:38.636549 :9AAAA28F:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-22 22:04:38.636549 :9AAAA290:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-22 22:04:38.637035 :9AAAA291: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-05-22 22:05:08.733098 :9AAAAD4F:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-22 22:05:34.139433 :9AAAB7EC:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-22 22:05:34.127 2025-05-22 22:05:34.139435 :9AAAB7ED:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=14320 pso_num=24 pso_serial#=23 2025-05-22 22:05:34.139568 :9AAAB7EE:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=14320 osp_idx=22 osp_ver=305002 osp_pg=0 (spawn #209192) 2025-05-22 22:05:34.139568 :9AAAB7EF:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-22 22:05:34.139569 :9AAAB7F0:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=233 time=927309032 2025-05-22 22:05:34.139569 :9AAAB7F1:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-05-22 22:05:34.139570 :9AAAB7F2:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-05-22 22:05:34.139570 :9AAAB7F3:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-05-22 22:05:34.139570 :9AAAB7F4:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-22 22:05:34.139571 :9AAAB7F5:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-22 22:05:34.140086 :9AAAB7F6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-22 22:05:34.140135 :9AAAB7FC:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=18 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-22 22:05:34.144258 :9AAAB81D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:kelt.c:517 2025-05-22 22:05:34.144307 :9AAAB81E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:kelt.c:517 2025-05-22 22:05:34.144564 :9AAAB81F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:kelt.c:517 2025-05-22 22:05:34.144578 :9AAAB820:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:kelt.c:517 2025-05-22 22:05:34.144782 :9AAAB821:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:kelt.c:517 2025-05-22 22:05:34.144795 :9AAAB822:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:kelt.c:517 2025-05-22 22:05:34.145000 :9AAAB823:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:kelt.c:517 2025-05-22 22:05:34.145013 :9AAAB824:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:kelt.c:517 2025-05-22 22:05:34.145215 :9AAAB825:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:kelt.c:517 2025-05-22 22:05:34.145227 :9AAAB826:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:kelt.c:517 2025-05-22 22:05:34.145427 :9AAAB827:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:kelt.c:517 2025-05-22 22:05:34.145439 :9AAAB828:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:kelt.c:517 2025-05-22 22:05:34.147831 :9AAAB829:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-22 22:05:38.742120 :9AAAB974:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-22 22:05:38.731 2025-05-22 22:05:38.742122 :9AAAB975:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=9492 pso_num=24 pso_serial#=24 2025-05-22 22:05:38.742267 :9AAAB976:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=9492 osp_idx=22 osp_ver=305003 osp_pg=0 (spawn #209194) 2025-05-22 22:05:38.742268 :9AAAB977:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-22 22:05:38.742269 :9AAAB978:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=234 time=927313641 2025-05-22 22:05:38.742269 :9AAAB979:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-05-22 22:05:38.742269 :9AAAB97A:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-05-22 22:05:38.742270 :9AAAB97B:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-05-22 22:05:38.742270 :9AAAB97C:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-22 22:05:38.742270 :9AAAB97D:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-22 22:05:38.742749 :9AAAB97E: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-05-22 22:06:08.837307 :9AAACA08:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-22 22:06:38.826763 :9AAAD35C:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-22 22:06:38.816 2025-05-22 22:06:38.826765 :9AAAD35D:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=13600 pso_num=24 pso_serial#=25 2025-05-22 22:06:38.826896 :9AAAD35E:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=13600 osp_idx=22 osp_ver=305004 osp_pg=0 (spawn #209196) 2025-05-22 22:06:38.826896 :9AAAD35F:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-22 22:06:38.826897 :9AAAD360:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=235 time=927373719 2025-05-22 22:06:38.826897 :9AAAD361:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-05-22 22:06:38.826898 :9AAAD362:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-05-22 22:06:38.826898 :9AAAD363:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-05-22 22:06:38.826899 :9AAAD364:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-22 22:06:38.826899 :9AAAD365:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-22 22:06:38.827380 :9AAAD366: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-05-22 22:07:08.958054 :9AAADC9C:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-22 22:07:38.917831 :9AAAE62F:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-22 22:07:38.906 2025-05-22 22:07:38.917833 :9AAAE630:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=8880 pso_num=24 pso_serial#=26 2025-05-22 22:07:38.917957 :9AAAE631:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=8880 osp_idx=22 osp_ver=305005 osp_pg=0 (spawn #209198) 2025-05-22 22:07:38.917958 :9AAAE632:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-22 22:07:38.917959 :9AAAE633:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=236 time=927433813 2025-05-22 22:07:38.917959 :9AAAE634:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-05-22 22:07:38.917960 :9AAAE635:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-05-22 22:07:38.917960 :9AAAE636:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-05-22 22:07:38.917960 :9AAAE637:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-22 22:07:38.917961 :9AAAE638:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-22 22:07:38.918434 :9AAAE639: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-05-22 22:08:09.040319 :9AAAEFCD:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-22 22:08:13.993935 :9AAAF1AF:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-22 22:08:13.983 2025-05-22 22:08:13.993937 :9AAAF1B0:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=12532 pso_num=24 pso_serial#=27 2025-05-22 22:08:13.994089 :9AAAF1B1:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=12532 osp_idx=22 osp_ver=305006 osp_pg=0 (spawn #209200) 2025-05-22 22:08:13.994090 :9AAAF1B2:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-22 22:08:13.994090 :9AAAF1B3:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=237 time=927468891 2025-05-22 22:08:13.994090 :9AAAF1B4:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-05-22 22:08:13.994091 :9AAAF1B5:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-05-22 22:08:13.994091 :9AAAF1B6:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-05-22 22:08:13.994091 :9AAAF1B7:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-22 22:08:13.994092 :9AAAF1B8:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-22 22:08:13.994606 :9AAAF1B9: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-05-22 22:08:39.024936 :9AAAF9A1: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-05-22 22:09:09.131663 :9AAB0321:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-22 22:09:39.136843 :9AAB0CC6:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-22 22:09:39.125 2025-05-22 22:09:39.136845 :9AAB0CC7:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=13256 pso_num=24 pso_serial#=28 2025-05-22 22:09:39.136985 :9AAB0CC8:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=13256 osp_idx=22 osp_ver=305007 osp_pg=0 (spawn #209202) 2025-05-22 22:09:39.136986 :9AAB0CC9:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-22 22:09:39.136986 :9AAB0CCA:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=238 time=927554032 2025-05-22 22:09:39.136986 :9AAB0CCB:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-05-22 22:09:39.136987 :9AAB0CCC:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-05-22 22:09:39.136987 :9AAB0CCD:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-05-22 22:09:39.136987 :9AAB0CCE:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-22 22:09:39.136988 :9AAB0CCF:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-22 22:09:39.137479 :9AAB0CD0: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 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 24 (osid: 13256, J001)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de