Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250504082024\orcl_m002_9360_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250504082024\orcl_m002_9360_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:37568M/63366M, Ph+PgF:45050M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 29 Windows thread id: 9360, image: ORACLE.EXE (M002) *** 2025-05-04 08:20:24.975 *** SESSION ID:(233.20633) 2025-05-04 08:20:24.975 *** 2025-05-04 08:20:24.975 Process diagnostic dump for ORACLE.EXE (M002), OS id=9360, pid: 29, proc_ser: 95, sid: 233, sess_ser: 20633 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'db file sequential read' file#=0x2, block#=0x5322, blocks=0x1 wait_id=1708 seq_num=1709 snap_id=1 wait times: snap=0.000174 sec, exc=0.000174 sec, total=0.000174 sec wait times: max=infinite, heur=0.000174 sec wait counts: calls=0 os=0 in_wait=1 iflags=0x5a0 Wait State: fixed_waits=0 flags=0x22 boundary=0x0000000000000000/-1 Session Wait History: elapsed time of 0.000178 sec since current wait 0: waited for 'db file sequential read' file#=0x2, block#=0x5302, blocks=0x1 wait_id=1707 seq_num=1708 snap_id=1 wait times: snap=0.000141 sec, exc=0.000141 sec, total=0.000141 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000378 sec of elapsed time 1: waited for 'db file sequential read' file#=0x2, block#=0x7442, blocks=0x1 wait_id=1706 seq_num=1707 snap_id=1 wait times: snap=0.005619 sec, exc=0.005619 sec, total=0.005619 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000479 sec of elapsed time 2: waited for 'db file sequential read' file#=0x2, block#=0x52aa, blocks=0x1 wait_id=1705 seq_num=1706 snap_id=1 wait times: snap=0.005968 sec, exc=0.005968 sec, total=0.005968 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000345 sec of elapsed time 3: waited for 'db file sequential read' file#=0x2, block#=0x528a, blocks=0x1 wait_id=1704 seq_num=1705 snap_id=1 wait times: snap=0.003526 sec, exc=0.003526 sec, total=0.003526 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000351 sec of elapsed time 4: waited for 'db file sequential read' file#=0x2, block#=0x4e6a, blocks=0x1 wait_id=1703 seq_num=1704 snap_id=1 wait times: snap=0.002500 sec, exc=0.002500 sec, total=0.002500 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000373 sec of elapsed time 5: waited for 'db file sequential read' file#=0x2, block#=0x7462, blocks=0x1 wait_id=1702 seq_num=1703 snap_id=1 wait times: snap=0.004517 sec, exc=0.004517 sec, total=0.004517 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000335 sec of elapsed time 6: waited for 'db file sequential read' file#=0x2, block#=0x7472, blocks=0x1 wait_id=1701 seq_num=1702 snap_id=1 wait times: snap=0.003141 sec, exc=0.003141 sec, total=0.003141 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000141 sec of elapsed time 7: waited for 'db file sequential read' file#=0x2, block#=0x4e4a, blocks=0x1 wait_id=1700 seq_num=1701 snap_id=1 wait times: snap=0.000093 sec, exc=0.000093 sec, total=0.000093 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000146 sec of elapsed time 8: waited for 'db file sequential read' file#=0x2, block#=0x4e3a, blocks=0x1 wait_id=1699 seq_num=1700 snap_id=1 wait times: snap=0.000094 sec, exc=0.000094 sec, total=0.000094 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000176 sec of elapsed time 9: waited for 'db file sequential read' file#=0x2, block#=0x4ada, blocks=0x1 wait_id=1698 seq_num=1699 snap_id=1 wait times: snap=0.000087 sec, exc=0.000087 sec, total=0.000087 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000178 sec of elapsed time Sampled Session History of session 233 serial 20633 --------------------------------------------------- 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 --------------------------------------------------- [1 sample, 08:20:24] waited for 'db file sequential read', seq_num: 1446 p1: 'file#'=0x2 p2: 'block#'=0x1dd2 p3: 'blocks'=0x1 time_waited: >= 0 sec (still in wait) [1 sample, 08:20:23] idle wait at each sample [session created at: 08:20:23] --------------------------------------------------- Sampled Session History Summary: longest_non_idle_wait: 'db file sequential read' [1 sample, 08:20:24 ] time_waited: >= 0 sec (still in wait) --------------------------------------------------- ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-05-04 08:20:24.975 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 29 (osid: 9360, M002) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-04 06:00:25.337144 :9272905F:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=12068 pso_num=29 pso_serial#=84 2025-05-04 06:00:25.337277 :92729060:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=12068 osp_idx=27 osp_ver=10283 osp_pg=0 (spawn #146472) 2025-05-04 06:00:25.337278 :92729061: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-04 06:00:25.337278 :92729062:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=41 time=3609202500 2025-05-04 06:00:25.337279 :92729063:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-04 06:00:25.337279 :92729064:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-04 06:00:25.337279 :92729065:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-04 06:00:25.337280 :92729066:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-04 06:00:25.337280 :92729067:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-04 06:00:25.337770 :92729068: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-04 06:00:25.337815 :9272906E: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-04 06:00:25.358932 :9272911D:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-04 06:00:26.730205 :92729244:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-04 06:00:26.723 2025-05-04 06:00:26.730207 :92729245:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=12008 pso_num=29 pso_serial#=85 2025-05-04 06:00:26.730339 :92729246:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=12008 osp_idx=27 osp_ver=10284 osp_pg=0 (spawn #146476) 2025-05-04 06:00:26.730340 :92729247: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-04 06:00:26.730340 :92729248:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=42 time=3609203890 2025-05-04 06:00:26.730341 :92729249:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-04 06:00:26.730341 :9272924A:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-04 06:00:26.730341 :9272924B:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-04 06:00:26.730342 :9272924C:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-04 06:00:26.730342 :9272924D:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-04 06:00:26.730828 :9272924E: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-04 06:00:26.730877 :92729257: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-04 06:00:26.737970 :92729262: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-04 06:00:26.739155 :9272926A: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-04 06:00:26.739739 :92729272: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-04 06:00:26.740207 :9272927A: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-04 06:00:26.740638 :92729282: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-04 06:00:26.743327 :9272928A: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-04 06:00:26.744437 :92729292: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-04 06:00:26.793785 :9272929A: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-04 06:00:26.794667 :927292A2: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-04 06:00:26.794907 :927292AA: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-04 06:00:26.795123 :927292B2: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-04 06:00:26.796921 :927292BA:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-04 06:01:07.534753 :9272A10A:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-04 06:01:07.536 2025-05-04 06:01:07.534754 :9272A10B:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=11368 pso_num=29 pso_serial#=86 2025-05-04 06:01:07.534887 :9272A10C:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=11368 osp_idx=27 osp_ver=10285 osp_pg=0 (spawn #146480) 2025-05-04 06:01:07.534887 :9272A10D: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-04 06:01:07.534888 :9272A10E:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=43 time=3609244687 2025-05-04 06:01:07.534888 :9272A10F:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-04 06:01:07.534889 :9272A110:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-04 06:01:07.534889 :9272A111:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-04 06:01:07.534889 :9272A112:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-04 06:01:07.534890 :9272A113:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-04 06:01:07.535372 :9272A114: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-04 06:01:07.535414 :9272A11B: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-04 06:01:07.542042 :9272A128:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-04 06:30:29.222487 :9274F4E9:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-04 06:30:29.210 2025-05-04 06:30:29.222489 :9274F4EA:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=11452 pso_num=29 pso_serial#=87 2025-05-04 06:30:29.222623 :9274F4EB:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=11452 osp_idx=27 osp_ver=10286 osp_pg=0 (spawn #146546) 2025-05-04 06:30:29.222624 :9274F4EC: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-04 06:30:29.222624 :9274F4ED:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=44 time=3611006375 2025-05-04 06:30:29.222625 :9274F4EE:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-04 06:30:29.222625 :9274F4EF:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-04 06:30:29.222626 :9274F4F0:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-04 06:30:29.222626 :9274F4F1:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-04 06:30:29.222626 :9274F4F2:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-04 06:30:29.223133 :9274F4F3: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-04 06:30:29.223176 :9274F4F9: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-04 06:30:29.227317 :9274F512:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-04 06:30:29.227374 :9274F513:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-04 06:30:29.227629 :9274F514:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-04 06:30:29.227646 :9274F515:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-04 06:30:29.227855 :9274F516:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-04 06:30:29.227868 :9274F517:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-04 06:30:29.228070 :9274F518:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-04 06:30:29.228082 :9274F519:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-04 06:30:29.228286 :9274F51A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-04 06:30:29.228298 :9274F51B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-04 06:30:29.228500 :9274F51C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-04 06:30:29.228513 :9274F51D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-04 06:30:29.230856 :9274F51E:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-04 07:00:33.396951 :92774667:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-04 07:00:33.387 2025-05-04 07:00:33.396953 :92774668:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=10932 pso_num=29 pso_serial#=88 2025-05-04 07:00:33.397090 :92774669:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=10932 osp_idx=27 osp_ver=10287 osp_pg=0 (spawn #146615) 2025-05-04 07:00:33.397091 :9277466A: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-04 07:00:33.397091 :9277466B:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=45 time=3612810562 2025-05-04 07:00:33.397092 :9277466C:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-04 07:00:33.397092 :9277466D:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-04 07:00:33.397093 :9277466E:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-04 07:00:33.397093 :9277466F:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-04 07:00:33.397093 :92774670:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-04 07:00:33.397617 :92774671: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-04 07:00:33.397660 :92774677: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-04 07:00:33.406267 :9277468C:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-04 07:01:09.487811 :92775375:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-04 07:01:09.482 2025-05-04 07:01:09.487814 :92775376:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=8400 pso_num=29 pso_serial#=89 2025-05-04 07:01:09.487943 :92775377:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=8400 osp_idx=27 osp_ver=10288 osp_pg=0 (spawn #146620) 2025-05-04 07:01:09.487944 :92775378: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-04 07:01:09.487944 :92775379:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=46 time=3612846656 2025-05-04 07:01:09.487944 :9277537A:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-04 07:01:09.487945 :9277537B:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-04 07:01:09.487945 :9277537C:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-04 07:01:09.487945 :9277537D:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-04 07:01:09.487946 :9277537E:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-04 07:01:09.488489 :9277537F: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-04 07:01:09.488538 :92775388: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-04 07:01:09.494940 :92775393:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-04 07:30:37.842193 :9279A231:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-04 07:30:37.827 2025-05-04 07:30:37.842195 :9279A232:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=8768 pso_num=29 pso_serial#=90 2025-05-04 07:30:37.842330 :9279A233:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=8768 osp_idx=27 osp_ver=10289 osp_pg=0 (spawn #146686) 2025-05-04 07:30:37.842331 :9279A234: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-04 07:30:37.842331 :9279A235:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=47 time=3614615000 2025-05-04 07:30:37.842332 :9279A236:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-04 07:30:37.842332 :9279A237:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-04 07:30:37.842333 :9279A238:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-04 07:30:37.842333 :9279A239:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-04 07:30:37.842333 :9279A23A:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-04 07:30:37.842878 :9279A23B: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-04 07:30:37.842919 :9279A241: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-04 07:30:37.847069 :9279A25A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-04 07:30:37.847116 :9279A25B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-04 07:30:37.847368 :9279A25C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-04 07:30:37.847384 :9279A25D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-04 07:30:37.847598 :9279A25E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-04 07:30:37.847612 :9279A25F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-04 07:30:37.847818 :9279A260:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-04 07:30:37.847831 :9279A261:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-04 07:30:37.848041 :9279A262:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-04 07:30:37.848054 :9279A263:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-04 07:30:37.848256 :9279A264:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:kelt.c:517 2025-05-04 07:30:37.848269 :9279A265:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:kelt.c:517 2025-05-04 07:30:37.855858 :9279A269:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-04 08:00:41.999213 :927BF582:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-04 08:00:41.990 2025-05-04 08:00:41.999214 :927BF583:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=10296 pso_num=29 pso_serial#=91 2025-05-04 08:00:41.999355 :927BF584:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=10296 osp_idx=27 osp_ver=10290 osp_pg=0 (spawn #146755) 2025-05-04 08:00:41.999356 :927BF585: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-04 08:00:41.999357 :927BF586:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=48 time=3616419156 2025-05-04 08:00:41.999357 :927BF587:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-04 08:00:41.999358 :927BF588:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-04 08:00:41.999358 :927BF589:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-04 08:00:41.999359 :927BF58A:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-04 08:00:41.999359 :927BF58B:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-04 08:00:41.999882 :927BF58C: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-04 08:00:41.999924 :927BF593: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-04 08:00:42.008765 :927BF5A7:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-04 08:01:12.067799 :927C011D:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-04 08:01:12.062 2025-05-04 08:01:12.067801 :927C011E:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=9960 pso_num=29 pso_serial#=92 2025-05-04 08:01:12.067939 :927C011F:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=9960 osp_idx=27 osp_ver=10291 osp_pg=0 (spawn #146760) 2025-05-04 08:01:12.067939 :927C0120: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-04 08:01:12.067940 :927C0121:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=49 time=3616449234 2025-05-04 08:01:12.067940 :927C0122:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-04 08:01:12.067941 :927C0123:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-04 08:01:12.067941 :927C0124:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-04 08:01:12.067941 :927C0125:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-04 08:01:12.067942 :927C0126:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-04 08:01:12.068431 :927C0127: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-04 08:01:12.068480 :927C012F: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-04 08:01:12.074932 :927C013B:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-04 08:20:18.092924 :927DC071:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-04 08:20:18.085 2025-05-04 08:20:18.092926 :927DC072:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=11596 pso_num=29 pso_serial#=93 2025-05-04 08:20:18.093053 :927DC073:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=11596 (legacy spawn) 2025-05-04 08:20:18.099545 :927DC07C: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-04 08:20:18.099703 :927DC086: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-04 08:20:18.100552 :927DC11C:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-04 08:20:21.723298 :927DF19A:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-04 08:20:21.720 2025-05-04 08:20:21.723300 :927DF19B:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=3740 pso_num=29 pso_serial#=94 2025-05-04 08:20:21.723468 :927DF19C:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=3740 osp_idx=27 osp_ver=10293 osp_pg=0 (spawn #146804) 2025-05-04 08:20:21.723469 :927DF19D: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-04 08:20:21.723469 :927DF19E:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=50 time=3617598875 2025-05-04 08:20:21.723469 :927DF19F:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-04 08:20:21.723470 :927DF1A0:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-04 08:20:21.723470 :927DF1A1:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-04 08:20:21.723470 :927DF1A2:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-04 08:20:21.723471 :927DF1A3:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-04 08:20:21.724900 :927DF1A4: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-04 08:20:21.724943 :927DF1AA: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-04 08:20:21.846197 :927DF1DC:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-04 08:20:23.961075 :927DF2A3:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-04 08:20:23.959 2025-05-04 08:20:23.961077 :927DF2A4:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=9360 pso_num=29 pso_serial#=95 2025-05-04 08:20:23.961205 :927DF2A5:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=9360 osp_idx=27 osp_ver=10294 osp_pg=0 (spawn #146806) 2025-05-04 08:20:23.961206 :927DF2A6: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-04 08:20:23.961207 :927DF2A7:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=51 time=3617601109 2025-05-04 08:20:23.961207 :927DF2A8:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-04 08:20:23.961208 :927DF2A9:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-04 08:20:23.961208 :927DF2AA:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-04 08:20:23.961208 :927DF2AB:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-04 08:20:23.961208 :927DF2AC:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-04 08:20:23.961721 :927DF2AD: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-04 08:20:23.961765 :927DF2B3: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 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 29 (osid: 9360, M002)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de