Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250613220004\orcl_j005_15648_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250613220004\orcl_j005_15648_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:36709M/63366M, Ph+PgF:43188M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 31 Windows thread id: 15648, image: ORACLE.EXE (J005) *** 2025-06-13 22:00:04.822 *** SESSION ID:(249.1035) 2025-06-13 22:00:04.822 *** 2025-06-13 22:00:04.822 Process diagnostic dump for ORACLE.EXE (J005), OS id=15648, pid: 31, proc_ser: 249, sid: 249, sess_ser: 1035 ------------------------------------------------------------------------------- current sql: <none> client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 15648 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J005) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=8 seq_num=9 snap_id=1 wait times: snap=0.377889 sec, exc=0.377889 sec, total=0.377889 sec wait times: max=0.500000 sec, heur=4.383700 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=7 seq_num=8 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.000009 sec of elapsed time 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=6 seq_num=7 snap_id=1 wait times: snap=0.500002 sec, exc=0.500002 sec, total=0.500002 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=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.000009 sec of elapsed time 3: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=4 seq_num=5 snap_id=1 wait times: snap=0.499988 sec, exc=0.499988 sec, total=0.499988 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000013 sec of elapsed time 4: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=3 seq_num=4 snap_id=1 wait times: snap=0.500002 sec, exc=0.500002 sec, total=0.500002 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 sec of elapsed time 5: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=2 seq_num=3 snap_id=1 wait times: snap=0.510106 sec, exc=0.510106 sec, total=0.510106 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000007 sec of elapsed time 6: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=1 seq_num=2 snap_id=1 wait times: snap=0.500002 sec, exc=0.500002 sec, total=0.500002 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 sec of elapsed time 7: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=0 seq_num=1 snap_id=1 wait times: snap=0.495646 sec, exc=0.495646 sec, total=0.495646 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000000 sec of elapsed time Sampled Session History of session 249 serial 1035 --------------------------------------------------- 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 --------------------------------------------------- [5 samples, 22:00:00 - 22:00:04] 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-06-13 22:00:04.822 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 31 (osid: 15648, J005) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-06-11 22:00:00.559391 :A36D3669:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:00:00.559556 :A36D3671:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:00:00.559721 :A36D3679:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:00:00.559881 :A36D3681:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:00:00.560039 :A36D3689:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:00:00.560207 :A36D3691:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:00:00.560369 :A36D3699:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:00:00.560523 :A36D36A1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:00:00.560685 :A36D36A9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:00:00.560845 :A36D36B1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:00:00.561000 :A36D36B9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:00:00.561161 :A36D36C1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:00:00.561314 :A36D36C9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:00:00.561461 :A36D36D1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:00:00.561625 :A36D36DB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:00:00.561788 :A36D36E3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:00:00.561961 :A36D3705:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:00:00.562119 :A36D370D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:00:00.562276 :A36D3715:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:00:00.562432 :A36D371D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:00:00.562588 :A36D3725:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:00:00.562739 :A36D3730:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:00:00.567134 :A36D374D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='kcrf.h LINE:3299 ID:kcrfw_redo_gen: wake LGWR after redo copy' id1=0 id2=0 name= type=0 2025-06-11 22:00:00.567546 :A36D3757:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='kcrf.h LINE:3299 ID:kcrfw_redo_gen: wake LGWR after redo copy' id1=0 id2=0 name= type=0 2025-06-11 22:00:00.572637 :A36D3780:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='kcrf.h LINE:3299 ID:kcrfw_redo_gen: wake LGWR after redo copy' id1=0 id2=0 name= type=0 2025-06-11 22:00:00.572876 :A36D3796:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='kcrf.h LINE:3299 ID:kcrfw_redo_gen: wake LGWR after redo copy' id1=0 id2=0 name= type=0 2025-06-11 22:00:00.572964 :A36D37A0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='kcrf.h LINE:3299 ID:kcrfw_redo_gen: wake LGWR after redo copy' id1=0 id2=0 name= type=0 2025-06-11 22:00:00.573578 :A36D37AD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='kcrf.h LINE:3299 ID:kcrfw_redo_gen: wake LGWR after redo copy' id1=0 id2=0 name= type=0 2025-06-11 22:00:00.577276 :A36D37B7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='kcrf.h LINE:3299 ID:kcrfw_redo_gen: wake LGWR after redo copy' id1=0 id2=0 name= type=0 2025-06-11 22:00:00.577626 :A36D37C3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='kcrf.h LINE:3299 ID:kcrfw_redo_gen: wake LGWR after redo copy' id1=0 id2=0 name= type=0 2025-06-11 22:00:00.591376 :A36D37D4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:00:01.671213*:A36D39B6:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000034363AD0 estart=1749650401 eid=19307133 ctx=0x0000000777968158 cwh=0x0000000044CE0158 cpu=0 buffg=2 interb=0 r=0 rb=0 w=0 wb=0 2025-06-11 22:00:01.671213*:A36D39B7:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000034363AD0 curCtx=0x0000000044BE1BF8 pubTabIdxCnt=0 2025-06-11 22:00:01.671213*:A36D39B8:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000034363AD0 2025-06-11 22:00:01.671213*:A36D39B9:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000034363AD0 2025-06-11 22:00:01.671213*:A36D39BA:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x00000000343EB6F0 estart=1749650400 eid=16777383 ctx=0x000000077B54EAC8 cwh=0x00000000343E0068 cpu=890625 buffg=51047 interb=196608 r=24 rb=196608 w=0 wb=0 2025-06-11 22:00:01.671213*:A36D39BB:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x00000000343EB6F0 curCtx=0x0000000044BD7FD8 pubTabIdxCnt=0 2025-06-11 22:00:01.671213*:A36D39BC:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x00000000343EB6F0 2025-06-11 22:00:01.671213*:A36D39BD:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x00000000343EB6F0 2025-06-11 22:00:01.671213*:A36D39BE:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000034363AD0 curCtx=0x0000000044BE1BF8 xsc->flg4=65792 flags=1 2025-06-11 22:00:01.671213*:A36D39BF:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000034363AD0 2025-06-11 22:00:02.237395 :A36D3ACB:db_trace:ktu.c@4871:ktuaex1r(): [10442:31:249] Extension usn 7, ext 1, nex 2 2025-06-11 22:00:02.237402 :A36D3ACC:db_trace:ktusm.c@2117:ktusmasp(): [10445:31:249] des1:tsn:1 rdba:0x00815e01 where: kdiwh22: kdifind 2025-06-11 22:00:02.244674*:A36D3AEB:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x00000000343EB6F0 curCtx=0x0000000044BD7FD8 xsc->flg4=65792 flags=2 2025-06-11 22:00:02.244674*:A36D3AEC:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x00000000343EB6F0 2025-06-11 22:00:02.244934 :A36D3AED:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:00:02.265291 :A36D3AF8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:00:02.267198 :A36D3B00:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:31:249] atxpus:psdpgi.c:2235 2025-06-11 22:00:02.267395 :A36D3B01:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:31:249] atxpop:psdpgi.c:2235 2025-06-11 22:00:02.268319 :A36D3B02:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:00:02.268433 :A36D3B05:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:00:02.269339 :A36D3B17:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:00:02.270805 :A36D3B1F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:00:02.271116 :A36D3B27:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:00:02.338425*:SQL_Analyze:qksan.c@3402:qksanAnalyzeSql(begin): qksanAnalyzeSql(enter): goal=15 options=16778048 pgadep=0 binds#=0 byPos=0 timeLim=0 timeFired=0 2025-06-11 22:00:02.338425*:SQL_Analyze:qksan.c@936:qksanBindSql(begin): binding for SQL analyze 2025-06-11 22:00:02.338425*:SQL_Analyze:qksan.c@1344:qksanBindSql(end): Done binding: status=0 ret=0 bind#=0 byPos=1 wasBoundP=0x0000000000000000 bindIndP=0x0000000000000000 2025-06-11 22:00:02.369683*:SQL_Analyze:qksan.c@6338:qksanAvgExecStats(): The number of total executions: 1 and execution count: 0 2025-06-11 22:00:02.369683*:SQL_Analyze:qksan.c@4776:qksanPostAnalyzeDump(begin): qksanPostAnalyzeDump(): Dumping analyze context after compilation qksanStatus=SUCCESS ecode=0 2025-06-11 22:00:02.369683*:SQL_Analyze:qksan.c@4800:qksanPostAnalyzeDump(end): 2025-06-11 22:00:02.369683*:SQL_Analyze:qksan.c@3690:qksanAnalyzeSql(end): exit: ecode=0 status=0 2025-06-11 22:00:02.433392 :A36D3C08:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:00:04.338259 :A36D3D1C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:00:04.338272 :A36D3D1D:db_trace:ktur.c@3079:ktuabt(): [10444:31:249] ABORT TRANSACTION - xid: 0x0009.006.0001cc75 2025-06-11 22:00:06.767642 :A36D3EF6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:00:06.769057 :A36D3EFE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:00:06.779194 :A36D3F06:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:00:06.803601 :A36D3F0E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:00:07.972550 :A36D4034:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:31:249] atxpop:jslv.c:9203 2025-06-11 22:00:07.985735 :A36D4035:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:0] KSL POST SENT postee=59 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-11 22:00:07.986463 :A36D403D:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-11 23:59:10.652062 :A3770131:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-11 23:59:10.641 2025-06-11 23:59:10.652064 :A3770132:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=14532 pso_num=31 pso_serial#=235 2025-06-11 23:59:10.652188 :A3770133:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=14532 osp_idx=29 osp_ver=489 osp_pg=0 (spawn #276096) 2025-06-11 23:59:10.652189 :A3770134:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-11 23:59:10.652189 :A3770135:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=156 time=2662093829 2025-06-11 23:59:10.652190 :A3770136:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-06-11 23:59:10.652190 :A3770137:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-06-11 23:59:10.652190 :A3770138:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-06-11 23:59:10.652191 :A3770139:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-11 23:59:10.652191 :A377013A:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-11 23:59:10.653515 :A377013B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-11 23:59:40.696844 :A3770C08:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-11 23:59:51.446095 :A3770FBD:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-11 23:59:51.445 2025-06-11 23:59:51.446097 :A3770FBE:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=15036 pso_num=31 pso_serial#=236 2025-06-11 23:59:51.446234 :A3770FBF:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=15036 (legacy spawn) 2025-06-11 23:59:51.460789 :A3770FC0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-12 00:00:24.967116 :A3771D75:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-12 22:00:02.063933 :A3DCCE73:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-12 22:00:02.060 2025-06-12 22:00:02.063935 :A3DCCE74:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=16540 pso_num=31 pso_serial#=237 2025-06-12 22:00:02.064060 :A3DCCE75:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=16540 osp_idx=29 osp_ver=491 osp_pg=0 (spawn #279139) 2025-06-12 22:00:02.064061 :A3DCCE76:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-12 22:00:02.064061 :A3DCCE77:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=157 time=2741345235 2025-06-12 22:00:02.064062 :A3DCCE78:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-06-12 22:00:02.064062 :A3DCCE79:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-06-12 22:00:02.064063 :A3DCCE7A:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-06-12 22:00:02.064063 :A3DCCE7B:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-12 22:00:02.064063 :A3DCCE7C:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-12 22:00:02.064623 :A3DCCE88:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-12 22:00:32.155681 :A3DCE07A:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-12 23:59:13.626235 :A3E67287:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-12 23:59:13.625 2025-06-12 23:59:13.626237 :A3E67288:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=15620 pso_num=31 pso_serial#=238 2025-06-12 23:59:13.626373 :A3E67289:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=15620 (legacy spawn) 2025-06-12 23:59:13.640222 :A3E6728A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-12 23:59:16.871779 :A3E6739E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-12 23:59:16.871961 :A3E673A3:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-12 23:59:16.873118 :A3E673A8:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-12 23:59:17.672626 :A3E67460:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-12 23:59:17.672 2025-06-12 23:59:17.672627 :A3E67461:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=15876 pso_num=31 pso_serial#=239 2025-06-12 23:59:17.672772 :A3E67462:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=15876 (legacy spawn) 2025-06-12 23:59:17.686832 :A3E67463:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-12 23:59:20.952685 :A3E67577:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-12 23:59:20.952854 :A3E6757C:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-12 23:59:20.954120 :A3E67581:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-12 23:59:21.791477 :A3E675BC:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-12 23:59:21.790 2025-06-12 23:59:21.791479 :A3E675BD:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=16220 pso_num=31 pso_serial#=240 2025-06-12 23:59:21.791612 :A3E675BE:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=16220 (legacy spawn) 2025-06-12 23:59:21.805295 :A3E675BF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-12 23:59:25.046174 :A3E676FE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-12 23:59:25.046350 :A3E67706:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-12 23:59:25.047582 :A3E67708:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-12 23:59:25.905714 :A3E6773A:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-12 23:59:25.905 2025-06-12 23:59:25.905716 :A3E6773B:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=3448 pso_num=31 pso_serial#=241 2025-06-12 23:59:25.905915 :A3E6773C:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=3448 (legacy spawn) 2025-06-12 23:59:25.923929 :A3E6773D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-12 23:59:29.146731 :A3E67891:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-12 23:59:29.146937 :A3E67896:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-12 23:59:29.148217 :A3E6789B:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-12 23:59:29.570662 :A3E678CB:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-12 23:59:29.562 2025-06-12 23:59:29.570665 :A3E678CC:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=16600 pso_num=31 pso_serial#=242 2025-06-12 23:59:29.570805 :A3E678CD:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=16600 (legacy spawn) 2025-06-12 23:59:29.577349 :A3E678CE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-12 23:59:29.577555 :A3E678D3:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-12 23:59:29.578399 :A3E678D8:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-12 23:59:29.970627 :A3E678E7:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-12 23:59:29.958 2025-06-12 23:59:29.970629 :A3E678E8:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=12488 pso_num=31 pso_serial#=243 2025-06-12 23:59:29.970754 :A3E678E9:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=12488 (legacy spawn) 2025-06-12 23:59:29.984422 :A3E678EA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-12 23:59:33.229349 :A3E679E7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-12 23:59:33.229520 :A3E679EC:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-12 23:59:33.230713 :A3E679F1:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-12 23:59:34.091115 :A3E67A46:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-12 23:59:34.088 2025-06-12 23:59:34.091117 :A3E67A47:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=14460 pso_num=31 pso_serial#=244 2025-06-12 23:59:34.091244 :A3E67A48:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=14460 (legacy spawn) 2025-06-12 23:59:34.107031 :A3E67A49:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-12 23:59:37.329367 :A3E67B5C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-12 23:59:37.329561 :A3E67B65:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-12 23:59:37.330772 :A3E67B66:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-12 23:59:38.159359 :A3E67BCC:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-12 23:59:38.157 2025-06-12 23:59:38.159361 :A3E67BCD:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=16340 pso_num=31 pso_serial#=245 2025-06-12 23:59:38.159487 :A3E67BCE:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=16340 (legacy spawn) 2025-06-12 23:59:38.173133 :A3E67BCF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-12 23:59:41.396415 :A3E67CC5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-12 23:59:41.396576 :A3E67CCA:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-12 23:59:41.397841 :A3E67CCF:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-12 23:59:42.277189 :A3E67D0E:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-12 23:59:42.272 2025-06-12 23:59:42.277191 :A3E67D0F:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=13500 pso_num=31 pso_serial#=246 2025-06-12 23:59:42.277329 :A3E67D10:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=13500 (legacy spawn) 2025-06-12 23:59:42.291955 :A3E67D11:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-12 23:59:45.497593 :A3E67E43:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-12 23:59:45.497775 :A3E67E48:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-12 23:59:45.498950 :A3E67E4D:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-12 23:59:48.856484 :A3E67F59:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-12 23:59:48.843 2025-06-12 23:59:48.856485 :A3E67F5A:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=15972 pso_num=31 pso_serial#=247 2025-06-12 23:59:48.856636 :A3E67F5B:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=15972 (legacy spawn) 2025-06-12 23:59:48.863370 :A3E67F5C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-12 23:59:48.863404 :A3E67F5F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-12 23:59:48.863564 :A3E67F62:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-06-12 23:59:48.864384 :A3E67F73:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-12 23:59:51.198528 :A3E68058:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-12 23:59:51.185 2025-06-12 23:59:51.198530 :A3E68059:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=17248 pso_num=31 pso_serial#=248 2025-06-12 23:59:51.198663 :A3E6805A:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=17248 (legacy spawn) 2025-06-12 23:59:51.212431 :A3E6805B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-13 00:00:24.294807 :A3E68D96:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-06-13 22:00:00.439257 :A44BE069:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 06-13 22:00:00.435 2025-06-13 22:00:00.439259 :A44BE06A:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=15648 pso_num=31 pso_serial#=249 2025-06-13 22:00:00.439385 :A44BE06C:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=15648 osp_idx=29 osp_ver=503 osp_pg=0 (spawn #282476) 2025-06-13 22:00:00.439386 :A44BE06D:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-13 22:00:00.439387 :A44BE06E:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=158 time=2827743610 2025-06-13 22:00:00.439387 :A44BE06F:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-06-13 22:00:00.439387 :A44BE070:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-06-13 22:00:00.439387 :A44BE071:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-06-13 22:00:00.439388 :A44BE072:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-13 22:00:00.439388 :A44BE073:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-13 22:00:00.439895 :A44BE074:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 31 (osid: 15648, J005)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de