Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250515220007\orcl_j003_9532_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250515220007\orcl_j003_9532_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:37370M/63366M, Ph+PgF:44593M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 29 Windows thread id: 9532, image: ORACLE.EXE (J003) *** 2025-05-15 22:00:07.731 *** SESSION ID:(233.22017) 2025-05-15 22:00:07.731 *** 2025-05-15 22:00:07.731 Process diagnostic dump for ORACLE.EXE (J003), OS id=9532, pid: 29, proc_ser: 18, sid: 233, sess_ser: 22017 ------------------------------------------------------------------------------- current sql: <none> client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 9532 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J003) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=14 seq_num=15 snap_id=1 wait times: snap=0.364697 sec, exc=0.364697 sec, total=0.364697 sec wait times: max=0.500000 sec, heur=6.973795 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=13 seq_num=14 snap_id=1 wait times: snap=0.504586 sec, exc=0.504586 sec, total=0.504586 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=12 seq_num=13 snap_id=1 wait times: snap=0.499994 sec, exc=0.499994 sec, total=0.499994 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 2: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=11 seq_num=12 snap_id=1 wait times: snap=0.500006 sec, exc=0.500006 sec, total=0.500006 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000007 sec of elapsed time 3: 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.000008 sec of elapsed time 4: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=9 seq_num=10 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.000006 sec of elapsed time 5: 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.000008 sec of elapsed time 6: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=7 seq_num=8 snap_id=1 wait times: snap=0.504572 sec, exc=0.504572 sec, total=0.504572 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 7: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=6 seq_num=7 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.000012 sec of elapsed time 8: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=5 seq_num=6 snap_id=1 wait times: snap=0.499999 sec, exc=0.499999 sec, total=0.499999 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 9: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=4 seq_num=5 snap_id=1 wait times: snap=0.500006 sec, exc=0.500006 sec, total=0.500006 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time Sampled Session History of session 233 serial 22017 --------------------------------------------------- The sampled session history is constructed by sampling the target session every 1 second. The sampling process captures at each sample if the session is in a non-idle wait, an idle wait, or not in a wait. If the session is in a non-idle wait then one interval is shown for all the samples the session was in the same non-idle wait. If the session is in an idle wait or not in a wait for consecutive samples then one interval is shown for all the consecutive samples. Though we display these consecutive samples in a single interval the session may NOT be continuously idle or not in a wait (the sampling process does not know). The history is displayed in reverse chronological order. sample interval: 1 sec, max history 120 sec --------------------------------------------------- [7 samples, 22:00:00 - 22:00:07] idle wait at each sample [session created at: 22:00:00] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-05-15 22:00:07.731 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 29 (osid: 9532, J003) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-15 01:00:02.164798 :972E2662:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:psdpgi.c:2235 2025-05-15 01:00:02.165316 :972E2668:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:psdpgi.c:2235 2025-05-15 01:00:02.165440 :972E2669:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-15 01:00:02.165459 :972E266C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:psdpgi.c:2235 2025-05-15 01:00:02.169150 :972E2672:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-15 01:00:02.169225 :972E2675:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:psdpgi.c:2235 2025-05-15 01:00:02.169455 :972E267B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-15 01:00:02.169477 :972E267E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:psdpgi.c:2235 2025-05-15 01:00:02.171618 :972E2684:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-15 01:00:02.171763 :972E268D:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-15 01:00:32.278254 :972E31E3:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-15 01:09:13.007472 :972EE391:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-15 01:09:12.995 2025-05-15 01:09:13.007475 :972EE392:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=9804 pso_num=29 pso_serial#=11 2025-05-15 01:09:13.007610 :972EE393:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=9804 osp_idx=27 osp_ver=10975 osp_pg=0 (spawn #182935) 2025-05-15 01:09:13.007610 :972EE394:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-15 01:09:13.007610 :972EE395:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=89 time=247162875 2025-05-15 01:09:13.007611 :972EE396:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-15 01:09:13.007611 :972EE397:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-15 01:09:13.007611 :972EE398:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-15 01:09:13.007612 :972EE399:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-15 01:09:13.007612 :972EE39A:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-15 01:09:13.008121 :972EE39B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-15 01:09:13.008168 :972EE3A1:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-15 01:09:13.012273 :972EE3BA:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-15 01:09:13.012315 :972EE3BB:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-15 01:09:13.012566 :972EE3BC:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-15 01:09:13.012582 :972EE3BD:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-15 01:09:13.012794 :972EE3BE:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-15 01:09:13.012807 :972EE3BF:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-15 01:09:13.013022 :972EE3C0:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-15 01:09:13.013034 :972EE3C1:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-15 01:09:13.013233 :972EE3C2:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-15 01:09:13.013245 :972EE3C3:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-15 01:09:13.013441 :972EE3C4:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-15 01:09:13.013454 :972EE3C5:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-15 01:09:13.015882 :972EE3C6:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-15 01:39:17.177437 :973138D2:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-15 01:39:17.165 2025-05-15 01:39:17.177440 :973138D3:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=10456 pso_num=29 pso_serial#=12 2025-05-15 01:39:17.177606 :973138D4:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=10456 osp_idx=27 osp_ver=10976 osp_pg=0 (spawn #183003) 2025-05-15 01:39:17.177606 :973138D5:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-15 01:39:17.177606 :973138D6:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=90 time=248967047 2025-05-15 01:39:17.177607 :973138D7:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-15 01:39:17.177607 :973138D8:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-15 01:39:17.177607 :973138D9:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-15 01:39:17.177607 :973138DA:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-15 01:39:17.177608 :973138DB:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-15 01:39:17.178136 :973138DC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-15 01:39:17.178189 :973138E2:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-15 01:39:17.182274 :973138FB:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-15 01:39:17.182317 :973138FC:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-15 01:39:17.182570 :973138FD:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-15 01:39:17.182585 :973138FE:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-15 01:39:17.182795 :973138FF:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-15 01:39:17.182808 :97313900:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-15 01:39:17.183014 :97313901:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-15 01:39:17.183027 :97313902:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-15 01:39:17.183231 :97313903:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-15 01:39:17.183244 :97313904:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-15 01:39:17.183446 :97313905:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-15 01:39:17.183459 :97313906:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-15 01:39:17.185807 :97313907:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-15 07:00:01.195321 :974AC79F:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-15 07:00:01.193 2025-05-15 07:00:01.195322 :974AC7A0:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=9944 pso_num=29 pso_serial#=13 2025-05-15 07:00:01.195460 :974AC7A1:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=9944 osp_idx=27 osp_ver=10977 osp_pg=0 (spawn #183744) 2025-05-15 07:00:01.195461 :974AC7A2:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-15 07:00:01.195461 :974AC7A3:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=91 time=268211047 2025-05-15 07:00:01.195462 :974AC7A4:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-15 07:00:01.195462 :974AC7A5:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-15 07:00:01.195463 :974AC7A6:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-15 07:00:01.195463 :974AC7A7:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-15 07:00:01.195463 :974AC7A8:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-15 07:00:01.195969 :974AC7A9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-15 07:00:01.196016 :974AC7AF:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-15 07:00:01.204156 :974AC7C1:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-15 08:00:09.057360 :974F8512:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-15 08:00:09.055 2025-05-15 08:00:09.057361 :974F8513:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=10376 pso_num=29 pso_serial#=14 2025-05-15 08:00:09.057493 :974F8514:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=10376 osp_idx=27 osp_ver=10978 osp_pg=0 (spawn #183883) 2025-05-15 08:00:09.057493 :974F8515:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-15 08:00:09.057494 :974F8516:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=92 time=271818907 2025-05-15 08:00:09.057494 :974F8517:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-15 08:00:09.057495 :974F8518:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-15 08:00:09.057495 :974F8519:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-15 08:00:09.057495 :974F851A:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-15 08:00:09.057496 :974F851B:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-15 08:00:09.058083 :974F851C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-15 08:00:09.058128 :974F8522:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-15 08:00:09.066342 :974F8534:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-15 08:02:42.291946 :974FF70C:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-15 08:02:42.279 2025-05-15 08:02:42.291947 :974FF70D:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=6028 pso_num=29 pso_serial#=15 2025-05-15 08:02:42.292075 :974FF70E:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=6028 osp_idx=27 osp_ver=10979 osp_pg=0 (spawn #183895) 2025-05-15 08:02:42.292076 :974FF70F:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-15 08:02:42.292076 :974FF710:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=93 time=271972157 2025-05-15 08:02:42.292077 :974FF711:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-15 08:02:42.292077 :974FF712:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-15 08:02:42.292078 :974FF713:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-15 08:02:42.292078 :974FF714:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-15 08:02:42.292078 :974FF715:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-15 08:02:42.292582 :974FF716:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-15 08:02:42.292618 :974FF71C:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-15 08:02:42.293053 :974FF71D:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-15 09:00:17.060613 :9754A835:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-15 09:00:17.058 2025-05-15 09:00:17.060614 :9754A836:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=12904 pso_num=29 pso_serial#=16 2025-05-15 09:00:17.060740 :9754A837:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=12904 osp_idx=27 osp_ver=10980 osp_pg=0 (spawn #184026) 2025-05-15 09:00:17.060740 :9754A838:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-15 09:00:17.060741 :9754A839:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=94 time=275426922 2025-05-15 09:00:17.060741 :9754A83A:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-15 09:00:17.060742 :9754A83B:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-15 09:00:17.060742 :9754A83C:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-15 09:00:17.060742 :9754A83D:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-15 09:00:17.060743 :9754A83E:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-15 09:00:17.061224 :9754A83F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-15 09:00:17.061275 :9754A845:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-15 09:00:17.069168 :9754A867:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-15 16:00:15.807410 :9775CBC2:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-15 16:00:15.799 2025-05-15 16:00:15.807412 :9775CBC3:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=13264 pso_num=29 pso_serial#=17 2025-05-15 16:00:15.807541 :9775CBC4:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=13264 osp_idx=27 osp_ver=10981 osp_pg=0 (spawn #184993) 2025-05-15 16:00:15.807541 :9775CBC5:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-15 16:00:15.807542 :9775CBC6:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=95 time=300625672 2025-05-15 16:00:15.807542 :9775CBC7:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-15 16:00:15.807543 :9775CBC8:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-15 16:00:15.807544 :9775CBC9:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-15 16:00:15.807544 :9775CBCA:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-15 16:00:15.807544 :9775CBCB:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-15 16:00:15.808105 :9775CBCC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-15 16:00:15.808147 :9775CBD2:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-15 16:00:15.815731 :9775CBE0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-15 16:00:15.816841 :9775CBE8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-15 16:00:15.817400 :9775CBF0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-15 16:00:15.817853 :9775CBF8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-15 16:00:15.818287 :9775CC00:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-15 16:00:15.820795 :9775CC08:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-15 16:00:15.821886 :9775CC10:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-15 16:00:15.870645 :9775CC18:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-15 16:00:15.871502 :9775CC20:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-15 16:00:15.871734 :9775CC28:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-15 16:00:15.871954 :9775CC30:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-15 16:00:15.873735 :9775CC38:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-15 22:00:00.734243 :979229D0:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-15 22:00:00.727 2025-05-15 22:00:00.734245 :979229D1:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=9532 pso_num=29 pso_serial#=18 2025-05-15 22:00:00.734372 :979229D3:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=9532 osp_idx=27 osp_ver=10982 osp_pg=0 (spawn #185825) 2025-05-15 22:00:00.734373 :979229D4:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-15 22:00:00.734374 :979229D5:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=96 time=322210610 2025-05-15 22:00:00.734374 :979229D6:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-15 22:00:00.734374 :979229D7:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-15 22:00:00.734375 :979229D8:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-15 22:00:00.734375 :979229D9:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-15 22:00:00.734376 :979229DA:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-15 22:00:00.734893 :979229E3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-15 22:00:00.740213 :979229F8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-15 22:00:00.740257 :979229FB:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:jslv.c:9203 2025-05-15 22:00:00.745447 :97922A34:KFNU:kfn.c@2200:kfnPrepareASM(): kfnPrepareASM force=0 state_kfnsg=0x7 2025-05-15 22:00:00.746056 :97922A3F:db_trace:kcc.c@13684:kccwbp(): [10021:29:233:1] 0115000000000000 0115000000000000 02cc110000000000 2025-05-15 22:00:00.748039 :97922A6C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=15 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-05-15 22:00:00.748205 :97922A7C:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-15 22:00:00.748215 :97922A83:db_trace:ksb.c@6610:ksbcic_int(): [10254:29:233] KSBCIC: (USER) starting cic on opcode KSBCIRCO [1] with args (1 8397264 1) 2025-05-15 22:00:00.748221 :97922A85:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=15 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-15 22:00:00.748261 :97922A90:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-15 22:00:00.749100 :97922AAD:db_trace:ksb.c@6610:ksbcic_int(): [10254:29:233] KSBCIC: (USER) starting cic on opcode KSBCICKP [2] with args (4 0 225409411) 2025-05-15 22:00:00.749107 :97922AAE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=15 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-15 22:00:00.749152 :97922AB7:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-15 22:00:00.749161 :97922ABA:db_trace:ksb.c@6610:ksbcic_int(): [10254:29:233] KSBCIC: (USER) starting cic on opcode KSBCICKP [2] with args (6 65565 1) 2025-05-15 22:00:00.749164 :97922ABC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=15 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-15 22:00:00.749211 :97922AD1:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-15 22:00:00.749214 :97922ADA:db_trace:ksb.c@6610:ksbcic_int(): [10254:29:233] KSBCIC: (USER) starting cic on opcode KSBCICKP [2] with args (1 2 65565) 2025-05-15 22:00:00.749217 :97922ADE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=15 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-15 22:00:00.749264 :97922AFA:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-15 22:00:00.750455 :97922BCC:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-15 22:00:00.750487 :97922BD4:KFNU:kfn.c@2200:kfnPrepareASM(): kfnPrepareASM force=0 state_kfnsg=0x7 2025-05-15 22:00:00.751420 :97922BD8:db_trace:kcc.c@13684:kccwbp(): [10021:29:233:1] 0115000000000000 0115000000000000 03cc110000000000 2025-05-15 22:00:00.751808 :97922BD9:db_trace:ksb.c@6610:ksbcic_int(): [10254:29:233] KSBCIC: (USER) starting cic on opcode KSBCIBBS [20] with args (2 0 225409411) 2025-05-15 22:00:00.751815 :97922BDA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=15 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-15 22:00:00.751845 :97922BE5:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-15 22:00:00.760157 :97922C42:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:jslv.c:9203 2025-05-15 22:00:00.761733 :97922C5B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-15 22:00:00.761770 :97922C5E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 2025-05-15 22:00:00.761823 :97922C6B:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] 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-15 22:00:00.853119 :97922E93:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=59 loc='kkj.h LINE:914 ID:kkjpstnp' id1=0 id2=0 name= type=0 fac#=0 facpost=1 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 29 (osid: 9532, J003)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de