Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250503060008\orcl_j002_10564_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250503060008\orcl_j002_10564_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:37580M/63366M, Ph+PgF:45086M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 27 Windows thread id: 10564, image: ORACLE.EXE (J002) *** 2025-05-03 06:00:08.941 *** SESSION ID:(219.18235) 2025-05-03 06:00:08.941 *** 2025-05-03 06:00:08.941 Process diagnostic dump for ORACLE.EXE (J002), OS id=10564, pid: 27, proc_ser: 27, sid: 219, sess_ser: 18235 ------------------------------------------------------------------------------- current sql: <none> client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 10564 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J002) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=13 seq_num=14 snap_id=1 wait times: snap=0.264938 sec, exc=0.264938 sec, total=0.264938 sec wait times: max=0.500000 sec, heur=6.785296 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=12 seq_num=13 snap_id=1 wait times: snap=0.500004 sec, exc=0.500004 sec, total=0.500004 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 1: 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.000007 sec of elapsed time 2: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=10 seq_num=11 snap_id=1 wait times: snap=0.499998 sec, exc=0.499998 sec, total=0.499998 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 3: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=9 seq_num=10 snap_id=1 wait times: snap=0.510153 sec, exc=0.510153 sec, total=0.510153 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000007 sec of elapsed time 4: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=8 seq_num=9 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.000007 sec of elapsed time 5: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=7 seq_num=8 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 6: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=6 seq_num=7 snap_id=1 wait times: snap=0.499986 sec, exc=0.499986 sec, total=0.499986 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000006 sec of elapsed time 7: 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.000015 sec of elapsed time 8: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=4 seq_num=5 snap_id=1 wait times: snap=0.500004 sec, exc=0.500004 sec, total=0.500004 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000011 sec of elapsed time 9: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=3 seq_num=4 snap_id=1 wait times: snap=0.510110 sec, exc=0.510110 sec, total=0.510110 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000010 sec of elapsed time Sampled Session History of session 219 serial 18235 --------------------------------------------------- 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, 06:00:02 - 06:00:08] idle wait at each sample [session created at: 06:00:02] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.016000 sec (max dump time=30.000000 sec) *** 2025-05-03 06:00:08.957 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 27 (osid: 10564, J002) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-03 05:00:55.228576 :91FA2325:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=11872 pso_num=27 pso_serial#=21 2025-05-03 05:00:55.228715 :91FA2326:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=11872 (legacy spawn) 2025-05-03 05:00:55.235134 :91FA2327:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-03 05:00:55.235428 :91FA2330:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-05-03 05:00:55.236216 :91FA2331:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-05-03 05:00:55.244826 :91FA2334:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 05-03 05:00:55.240 2025-05-03 05:00:55.244828 :91FA2335:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=10484 pso_num=27 pso_serial#=22 2025-05-03 05:00:55.244959 :91FA2336:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=10484 (legacy spawn) 2025-05-03 05:00:55.251263 :91FA2337:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-03 05:00:55.251418 :91FA2340:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-05-03 05:00:55.600666 :91FA2341:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-05-03 05:00:56.427711 :91FA23F1:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 05-03 05:00:56.412 2025-05-03 05:00:56.427713 :91FA23F2:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=10684 pso_num=27 pso_serial#=23 2025-05-03 05:00:56.427844 :91FA23F3:db_trace:kso.c@4093:ksonfy(): [10420:27:0] kso: new process: pid=10684 osp_idx=25 osp_ver=41842 osp_pg=0 (spawn #142926) 2025-05-03 05:00:56.427845 :91FA23F4:db_trace:kso.c@4099:ksonfy(): [10420:27:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-03 05:00:56.427845 :91FA23F5:db_trace:kso.c@4103:ksonfy(): [10420:27:0] kso: new process: pso_index=27 reservation=39 time=3519245906 2025-05-03 05:00:56.427846 :91FA23F6:db_trace:kso.c@4109:ksonfy(): [10420:27:0] kso: spawn diagnostics: queue time=0 secs 2025-05-03 05:00:56.427846 :91FA23F7:db_trace:kso.c@4111:ksonfy(): [10420:27:0] kso: spawn diagnostics: fork time=0 secs 2025-05-03 05:00:56.427846 :91FA23F8:db_trace:kso.c@4113:ksonfy(): [10420:27:0] kso: spawn diagnostics: exec time=0 secs 2025-05-03 05:00:56.427847 :91FA23F9:db_trace:kso.c@4115:ksonfy(): [10420:27:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-03 05:00:56.427848 :91FA23FA:db_trace:kso.c@4117:ksonfy(): [10420:27:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-03 05:00:56.428365 :91FA23FB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-03 05:00:56.428407 :91FA2401:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-03 05:00:56.435496 :91FA240F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-03 05:00:56.436544 :91FA2417:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-03 05:00:56.437080 :91FA241F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-03 05:00:56.437537 :91FA2427:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-03 05:00:56.437969 :91FA242F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-03 05:00:56.440473 :91FA2437:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-03 05:00:56.441552 :91FA243F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-03 05:00:56.499013 :91FA2447:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-03 05:00:56.499895 :91FA244F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-03 05:00:56.500138 :91FA2457:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-03 05:00:56.500347 :91FA245F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-03 05:00:56.502016 :91FA2467:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-05-03 05:26:58.764506 :91FC39CA:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 05-03 05:26:58.752 2025-05-03 05:26:58.764508 :91FC39CB:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=2312 pso_num=27 pso_serial#=24 2025-05-03 05:26:58.764635 :91FC39CC:db_trace:kso.c@4093:ksonfy(): [10420:27:0] kso: new process: pid=2312 osp_idx=25 osp_ver=41843 osp_pg=0 (spawn #142988) 2025-05-03 05:26:58.764636 :91FC39CD:db_trace:kso.c@4099:ksonfy(): [10420:27:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-03 05:26:58.764637 :91FC39CE:db_trace:kso.c@4103:ksonfy(): [10420:27:0] kso: new process: pso_index=27 reservation=40 time=3520808234 2025-05-03 05:26:58.764637 :91FC39CF:db_trace:kso.c@4109:ksonfy(): [10420:27:0] kso: spawn diagnostics: queue time=0 secs 2025-05-03 05:26:58.764637 :91FC39D0:db_trace:kso.c@4111:ksonfy(): [10420:27:0] kso: spawn diagnostics: fork time=0 secs 2025-05-03 05:26:58.764638 :91FC39D1:db_trace:kso.c@4113:ksonfy(): [10420:27:0] kso: spawn diagnostics: exec time=0 secs 2025-05-03 05:26:58.764638 :91FC39D2:db_trace:kso.c@4115:ksonfy(): [10420:27:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-03 05:26:58.764639 :91FC39D3:db_trace:kso.c@4117:ksonfy(): [10420:27:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-03 05:26:58.765189 :91FC39D4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-03 05:26:58.765228 :91FC39DA:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-03 05:26:58.769253 :91FC3A03:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:kelt.c:517 2025-05-03 05:26:58.769321 :91FC3A04:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:kelt.c:517 2025-05-03 05:26:58.769589 :91FC3A05:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:kelt.c:517 2025-05-03 05:26:58.769604 :91FC3A06:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:kelt.c:517 2025-05-03 05:26:58.769818 :91FC3A07:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:kelt.c:517 2025-05-03 05:26:58.769831 :91FC3A08:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:kelt.c:517 2025-05-03 05:26:58.770037 :91FC3A09:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:kelt.c:517 2025-05-03 05:26:58.770050 :91FC3A0A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:kelt.c:517 2025-05-03 05:26:58.770256 :91FC3A0B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:kelt.c:517 2025-05-03 05:26:58.770269 :91FC3A0C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:kelt.c:517 2025-05-03 05:26:58.770471 :91FC3A0D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:kelt.c:517 2025-05-03 05:26:58.770484 :91FC3A0E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:kelt.c:517 2025-05-03 05:26:58.772834 :91FC3A0F:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-05-03 05:57:02.862466 :91FE9A47:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 05-03 05:57:02.850 2025-05-03 05:57:02.862468 :91FE9A48:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=10604 pso_num=27 pso_serial#=25 2025-05-03 05:57:02.862607 :91FE9A49:db_trace:kso.c@4093:ksonfy(): [10420:27:0] kso: new process: pid=10604 osp_idx=25 osp_ver=41844 osp_pg=0 (spawn #143057) 2025-05-03 05:57:02.862608 :91FE9A4A:db_trace:kso.c@4099:ksonfy(): [10420:27:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-03 05:57:02.862609 :91FE9A4B:db_trace:kso.c@4103:ksonfy(): [10420:27:0] kso: new process: pso_index=27 reservation=41 time=3522612343 2025-05-03 05:57:02.862609 :91FE9A4C:db_trace:kso.c@4109:ksonfy(): [10420:27:0] kso: spawn diagnostics: queue time=0 secs 2025-05-03 05:57:02.862609 :91FE9A4D:db_trace:kso.c@4111:ksonfy(): [10420:27:0] kso: spawn diagnostics: fork time=0 secs 2025-05-03 05:57:02.862610 :91FE9A4E:db_trace:kso.c@4113:ksonfy(): [10420:27:0] kso: spawn diagnostics: exec time=0 secs 2025-05-03 05:57:02.862610 :91FE9A4F:db_trace:kso.c@4115:ksonfy(): [10420:27:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-03 05:57:02.862610 :91FE9A50:db_trace:kso.c@4117:ksonfy(): [10420:27:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-03 05:57:02.863121 :91FE9A51:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-03 05:57:02.863163 :91FE9A57:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-03 05:57:02.867208 :91FE9A70:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:kelt.c:517 2025-05-03 05:57:02.867259 :91FE9A71:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:kelt.c:517 2025-05-03 05:57:02.867508 :91FE9A72:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:kelt.c:517 2025-05-03 05:57:02.867524 :91FE9A73:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:kelt.c:517 2025-05-03 05:57:02.867730 :91FE9A74:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:kelt.c:517 2025-05-03 05:57:02.867743 :91FE9A75:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:kelt.c:517 2025-05-03 05:57:02.867946 :91FE9A76:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:kelt.c:517 2025-05-03 05:57:02.867959 :91FE9A77:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:kelt.c:517 2025-05-03 05:57:02.868155 :91FE9A78:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:kelt.c:517 2025-05-03 05:57:02.868168 :91FE9A79:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:kelt.c:517 2025-05-03 05:57:02.868374 :91FE9A7A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:kelt.c:517 2025-05-03 05:57:02.868387 :91FE9A7B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:kelt.c:517 2025-05-03 05:57:02.870783 :91FE9A7C:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-05-03 06:00:00.034597 :91FED60B:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 05-03 06:00:00.026 2025-05-03 06:00:00.034599 :91FED60C:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=4072 pso_num=27 pso_serial#=26 2025-05-03 06:00:00.034733 :91FED60D:db_trace:kso.c@4093:ksonfy(): [10420:27:0] kso: new process: pid=4072 osp_idx=25 osp_ver=41845 osp_pg=0 (spawn #143065) 2025-05-03 06:00:00.034734 :91FED60E:db_trace:kso.c@4099:ksonfy(): [10420:27:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-03 06:00:00.034734 :91FED60F:db_trace:kso.c@4103:ksonfy(): [10420:27:0] kso: new process: pso_index=27 reservation=42 time=3522789515 2025-05-03 06:00:00.034734 :91FED610:db_trace:kso.c@4109:ksonfy(): [10420:27:0] kso: spawn diagnostics: queue time=0 secs 2025-05-03 06:00:00.034735 :91FED611:db_trace:kso.c@4111:ksonfy(): [10420:27:0] kso: spawn diagnostics: fork time=0 secs 2025-05-03 06:00:00.034735 :91FED612:db_trace:kso.c@4113:ksonfy(): [10420:27:0] kso: spawn diagnostics: exec time=0 secs 2025-05-03 06:00:00.034735 :91FED613:db_trace:kso.c@4115:ksonfy(): [10420:27:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-03 06:00:00.034736 :91FED614:db_trace:kso.c@4117:ksonfy(): [10420:27:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-03 06:00:00.035245 :91FED615:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-03 06:00:00.035291 :91FED61C:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-03 06:00:00.035367 :91FED62F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-05-03 06:00:00.039252 :91FED63E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-03 06:00:00.040466 :91FED646:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-03 06:00:00.040489 :91FED649:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-05-03 06:00:00.040533 :91FED654:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] KSL POST RCVD poster=18 loc='ksr2.h LINE:607 ID:ksrmdone' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-03 06:00:00.042377 :91FED65F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-03 06:00:00.042402 :91FED662:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-05-03 06:00:00.042439 :91FED66D:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] KSL POST RCVD poster=18 loc='ksr2.h LINE:607 ID:ksrmdone' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-03 06:00:00.042899 :91FED678:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-03 06:00:00.045447 :91FED680:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-03 06:00:00.050835 :91FED688:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-03 06:00:00.056206 :91FED690:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-03 06:00:00.057686 :91FED698:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-03 06:00:00.060785 :91FED6A0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-03 06:00:00.062157 :91FED6A8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-03 06:00:00.065155 :91FED6B0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-03 06:00:00.069133 :91FED6B8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-05-03 06:00:00.069535 :91FED6C7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-03 06:00:00.069613 :91FED6CA:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:ktcc.c:879 2025-05-03 06:00:00.069637 :91FED6CB:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:ktcc.c:879 2025-05-03 06:00:00.072407 :91FED6D1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-05-03 06:00:00.072703 :91FED6E0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-03 06:00:00.072751 :91FED6E3:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:ktcc.c:879 2025-05-03 06:00:00.072764 :91FED6E4:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:ktcc.c:879 2025-05-03 06:00:00.075579 :91FED6EA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-05-03 06:00:00.075853 :91FED6F9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-03 06:00:00.075901 :91FED6FC:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:ktcc.c:879 2025-05-03 06:00:00.075915 :91FED6FD:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:ktcc.c:879 2025-05-03 06:00:00.076081 :91FED703:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-03 06:00:00.076093 :91FED706:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-05-03 06:00:00.076116 :91FED712:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] KSL POST RCVD poster=18 loc='ksr2.h LINE:607 ID:ksrmdone' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-03 06:00:00.077566 :91FED71C:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-05-03 06:00:02.041945 :91FED7FC:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 05-03 06:00:02.036 2025-05-03 06:00:02.041946 :91FED7FD:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=10564 pso_num=27 pso_serial#=27 2025-05-03 06:00:02.042102 :91FED7FE:db_trace:kso.c@4093:ksonfy(): [10420:27:0] kso: new process: pid=10564 osp_idx=25 osp_ver=41846 osp_pg=0 (spawn #143066) 2025-05-03 06:00:02.042102 :91FED7FF:db_trace:kso.c@4099:ksonfy(): [10420:27:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-03 06:00:02.042103 :91FED800:db_trace:kso.c@4103:ksonfy(): [10420:27:0] kso: new process: pso_index=27 reservation=43 time=3522791515 2025-05-03 06:00:02.042103 :91FED801:db_trace:kso.c@4109:ksonfy(): [10420:27:0] kso: spawn diagnostics: queue time=0 secs 2025-05-03 06:00:02.042104 :91FED802:db_trace:kso.c@4111:ksonfy(): [10420:27:0] kso: spawn diagnostics: fork time=0 secs 2025-05-03 06:00:02.042104 :91FED803:db_trace:kso.c@4113:ksonfy(): [10420:27:0] kso: spawn diagnostics: exec time=0 secs 2025-05-03 06:00:02.042104 :91FED804:db_trace:kso.c@4115:ksonfy(): [10420:27:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-03 06:00:02.042105 :91FED805:db_trace:kso.c@4117:ksonfy(): [10420:27:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-03 06:00:02.042588 :91FED806:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-03 06:00:02.048054 :91FED840:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-03 06:00:02.048098 :91FED841:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:jslv.c:9203 2025-05-03 06:00:02.052990 :91FED868:KFNU:kfn.c@2200:kfnPrepareASM(): kfnPrepareASM force=0 state_kfnsg=0x7 2025-05-03 06:00:02.053590 :91FED872:db_trace:kcc.c@13684:kccwbp(): [10021:27:219:1] 0115000000000000 0115000000000000 c5b2110000000000 2025-05-03 06:00:02.055483 :91FED89A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=15 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-05-03 06:00:02.055531 :91FED8A7:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-03 06:00:02.055540 :91FED8AE:db_trace:ksb.c@6610:ksbcic_int(): [10254:27:219] KSBCIC: (USER) starting cic on opcode KSBCIRCO [1] with args (1 8397264 1) 2025-05-03 06:00:02.055545 :91FED8AF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=15 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-03 06:00:02.055571 :91FED8BB:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-03 06:00:02.056315 :91FED8C7:db_trace:ksb.c@6610:ksbcic_int(): [10254:27:219] KSBCIC: (USER) starting cic on opcode KSBCICKP [2] with args (4 0 224153880) 2025-05-03 06:00:02.056319 :91FED8C8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=15 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-03 06:00:02.056343 :91FED8D5:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-03 06:00:02.056352 :91FED8E0:db_trace:ksb.c@6610:ksbcic_int(): [10254:27:219] KSBCIC: (USER) starting cic on opcode KSBCICKP [2] with args (6 65563 1) 2025-05-03 06:00:02.056355 :91FED8E1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=15 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-03 06:00:02.056382 :91FED8EE:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-03 06:00:02.056385 :91FED8F8:db_trace:ksb.c@6610:ksbcic_int(): [10254:27:219] KSBCIC: (USER) starting cic on opcode KSBCICKP [2] with args (1 2 65563) 2025-05-03 06:00:02.056387 :91FED8FA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=15 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-03 06:00:02.056433 :91FED91A:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-03 06:00:02.056916 :91FED9A9:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-03 06:00:02.056937 :91FED9B5:KFNU:kfn.c@2200:kfnPrepareASM(): kfnPrepareASM force=0 state_kfnsg=0x7 2025-05-03 06:00:02.057773 :91FED9BC:db_trace:kcc.c@13684:kccwbp(): [10021:27:219:1] 0115000000000000 0115000000000000 c6b2110000000000 2025-05-03 06:00:02.058168 :91FED9BD:db_trace:ksb.c@6610:ksbcic_int(): [10254:27:219] KSBCIC: (USER) starting cic on opcode KSBCIBBS [20] with args (2 0 224153880) 2025-05-03 06:00:02.058175 :91FED9BE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=15 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-03 06:00:02.058211 :91FED9C9:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-03 06:00:02.066766 :91FEDA2C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:jslv.c:9203 2025-05-03 06:00:02.067404 :91FEDA2E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=24 loc='kcb2.h LINE:3844 ID:kcbzww' id1=0 id2=0 name= type=0 2025-05-03 06:00:02.068446 :91FEDA30:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-03 06:00:02.068502 :91FEDA33:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 2025-05-03 06:00:02.068604 :91FEDA40:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-05-03 06:00:02.161974 :91FEDB3D:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-03 06:00:02.164149 :91FEDB3F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-03 06:00:02.164189 :91FEDB42:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:jslv.c:9203 2025-05-03 06:00:02.166881 :91FEDB48:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:jslv.c:9203 2025-05-03 06:00:02.170351 :91FEDB49:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-03 06:00:02.170438 :91FEDB4C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 2025-05-03 06:00:02.170525 :91FEDB59:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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 27 (osid: 10564, J002)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de