Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250906180418\orcl_j003_15732_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250906180418\orcl_j003_15732_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:35008M/63366M, Ph+PgF:39850M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 29 Windows thread id: 15732, image: ORACLE.EXE (J003) *** 2025-09-06 18:04:18.546 *** SESSION ID:(233.34289) 2025-09-06 18:04:18.546 *** 2025-09-06 18:04:18.546 Process diagnostic dump for ORACLE.EXE (J003), OS id=15732, pid: 29, proc_ser: 239, sid: 233, sess_ser: 34289 ------------------------------------------------------------------------------- current sql: <none> client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 15732 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J003) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=15 seq_num=16 snap_id=1 wait times: snap=0.271462 sec, exc=0.271462 sec, total=0.271462 sec wait times: max=0.500000 sec, heur=7.788557 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.000023 sec since current wait 0: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=14 seq_num=15 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.000014 sec of elapsed time 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=13 seq_num=14 snap_id=1 wait times: snap=0.510087 sec, exc=0.510087 sec, total=0.510087 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000017 sec of elapsed time 2: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=12 seq_num=13 snap_id=1 wait times: snap=0.499991 sec, exc=0.499991 sec, total=0.499991 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000021 sec of elapsed time 3: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=11 seq_num=12 snap_id=1 wait times: snap=0.499995 sec, exc=0.499995 sec, total=0.499995 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000015 sec of elapsed time 4: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=10 seq_num=11 snap_id=1 wait times: snap=0.499989 sec, exc=0.499989 sec, total=0.499989 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000015 sec of elapsed time 5: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=9 seq_num=10 snap_id=1 wait times: snap=0.499944 sec, exc=0.499944 sec, total=0.499944 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000061 sec of elapsed time 6: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=8 seq_num=9 snap_id=1 wait times: snap=0.499995 sec, exc=0.499995 sec, total=0.499995 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000013 sec of elapsed time 7: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=7 seq_num=8 snap_id=1 wait times: snap=0.510099 sec, exc=0.510099 sec, total=0.510099 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000013 sec of elapsed time 8: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=6 seq_num=7 snap_id=1 wait times: snap=0.499989 sec, exc=0.499989 sec, total=0.499989 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000014 sec of elapsed time 9: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=5 seq_num=6 snap_id=1 wait times: snap=0.500005 sec, exc=0.500005 sec, total=0.500005 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000012 sec of elapsed time Sampled Session History of session 233 serial 34289 --------------------------------------------------- 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 --------------------------------------------------- [8 samples, 18:04:10 - 18:04:18] idle wait at each sample [session created at: 18:04:10] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-09-06 18:04:18.546 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 29 (osid: 15732, J003) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-09-06 06:00:02.295241 :C9A458B3:db_trace:ktu.c@4871:ktuaex1r(): [10442:29:233] Extension usn 6, ext 0, nex 2 2025-09-06 06:00:02.295249 :C9A458B4:db_trace:ktusm.c@2117:ktusmasp(): [10445:29:233] des1:tsn:1 rdba:0x00800356 where: kduwh01: kdusru 2025-09-06 06:00:02.303117 :C9A458C1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] 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-09-06 06:00:02.303117*:C9A458C8:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x00000000312AB6F0 curCtx=0x000000005CD87FD8 xsc->flg4=65792 flags=2 2025-09-06 06:00:02.303117*:C9A458C9:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x00000000312AB6F0 2025-09-06 06:00:02.310617 :C9A458CA: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-09-06 06:00:02.333256 :C9A458DB:db_trace:ktu.c@4871:ktuaex1r(): [10442:29:233] Extension usn 6, ext 1, nex 3 2025-09-06 06:00:02.333265 :C9A458DC:db_trace:ktusm.c@2117:ktusmasp(): [10445:29:233] des1:tsn:1 rdba:0x00800357 where: kduwh01: kdusru 2025-09-06 06:00:02.333466 :C9A458DD: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-09-06 06:00:02.335615 :C9A458EE:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpus:psdpgi.c:2235 2025-09-06 06:00:02.335845 :C9A458EF:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:psdpgi.c:2235 2025-09-06 06:00:02.336784 :C9A458FB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] 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-09-06 06:00:02.336870 :C9A45902: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-09-06 06:00:02.336968 :C9A4590F: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-09-06 06:00:02.338012 :C9A45930: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-09-06 06:00:02.339815 :C9A45940: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-09-06 06:00:02.340136 :C9A45948: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-09-06 06:00:02.405689*:SQL_Analyze:qksan.c@3402:qksanAnalyzeSql(begin): qksanAnalyzeSql(enter): goal=15 options=16778048 pgadep=0 binds#=0 byPos=0 timeLim=0 timeFired=0 2025-09-06 06:00:02.405689*:SQL_Analyze:qksan.c@936:qksanBindSql(begin): binding for SQL analyze 2025-09-06 06:00:02.405689*:SQL_Analyze:qksan.c@1344:qksanBindSql(end): Done binding: status=0 ret=0 bind#=0 byPos=1 wasBoundP=0x0000000000000000 bindIndP=0x0000000000000000 2025-09-06 06:00:02.452534*:SQL_Analyze:qksan.c@6338:qksanAvgExecStats(): The number of total executions: 1 and execution count: 0 2025-09-06 06:00:02.452534*:SQL_Analyze:qksan.c@4776:qksanPostAnalyzeDump(begin): qksanPostAnalyzeDump(): Dumping analyze context after compilation qksanStatus=SUCCESS ecode=0 2025-09-06 06:00:02.452534*:SQL_Analyze:qksan.c@4800:qksanPostAnalyzeDump(end): 2025-09-06 06:00:02.452534*:SQL_Analyze:qksan.c@3690:qksanAnalyzeSql(end): exit: ecode=0 status=0 2025-09-06 06:00:02.507713 :C9A45963: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-09-06 06:00:04.427625 :C9A45A1F: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-09-06 06:00:04.427635 :C9A45A20:db_trace:ktur.c@3079:ktuabt(): [10444:29:233] ABORT TRANSACTION - xid: 0x000a.009.0017b778 2025-09-06 06:00:07.118919 :C9A45BDF: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-09-06 06:00:07.120285 :C9A45BE7: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-09-06 06:00:07.130905 :C9A45BEF: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-09-06 06:00:07.160225 :C9A45BF7: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-09-06 06:00:08.330007 :C9A45D19:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:29:233] atxpop:jslv.c:9203 2025-09-06 06:00:08.341199 :C9A45D1A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:0] KSL POST SENT postee=59 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-06 06:00:08.342582 :C9A45D22:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-09-06 06:00:27.817320 :C9A46450:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 09-06 06:00:27.804 2025-09-06 06:00:27.817322 :C9A46451:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=24416 pso_num=29 pso_serial#=224 2025-09-06 06:00:27.817470 :C9A46452:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=24416 (legacy spawn) 2025-09-06 06:00:27.825023 :C9A46453: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-09-06 06:00:27.825199 :C9A46458: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-09-06 06:00:27.826001 :C9A4645D:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-09-06 08:50:28.210590 :C9B1A1C0:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 09-06 08:50:28.198 2025-09-06 08:50:28.210591 :C9B1A1C1:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=20504 pso_num=29 pso_serial#=225 2025-09-06 08:50:28.210730 :C9B1A1C2:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=20504 osp_idx=27 osp_ver=17054 osp_pg=0 (spawn #564000) 2025-09-06 08:50:28.210732 :C9B1A1C3:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-06 08:50:28.210733 :C9B1A1C4:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=151 time=1534279502 2025-09-06 08:50:28.210733 :C9B1A1C5:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-09-06 08:50:28.210733 :C9B1A1C6:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-09-06 08:50:28.210734 :C9B1A1C7:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-09-06 08:50:28.210734 :C9B1A1C8:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-06 08:50:28.210734 :C9B1A1C9:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-06 08:50:28.211256 :C9B1A1CA: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-09-06 08:50:28.211296 :C9B1A1D0: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-09-06 08:50:28.216101 :C9B1A1DE: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-09-06 08:50:28.216291 :C9B1A1E7: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-09-06 08:50:28.216719 :C9B1A1E8:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-09-06 10:03:13.060518 :C9B735D3:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 09-06 10:03:13.048 2025-09-06 10:03:13.060519 :C9B735D4:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=22932 pso_num=29 pso_serial#=226 2025-09-06 10:03:13.060648 :C9B735D5:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=22932 osp_idx=27 osp_ver=17055 osp_pg=0 (spawn #564170) 2025-09-06 10:03:13.060649 :C9B735D6:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-06 10:03:13.060649 :C9B735D7:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=152 time=1538644362 2025-09-06 10:03:13.060650 :C9B735D8:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-09-06 10:03:13.060650 :C9B735D9:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-09-06 10:03:13.060651 :C9B735DA:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-09-06 10:03:13.060651 :C9B735DB:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-06 10:03:13.060651 :C9B735DC:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-06 10:03:13.061271 :C9B735DD: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-09-06 10:03:13.061312 :C9B735E3: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-09-06 10:03:13.071458 :C9B735F5:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-09-06 14:03:41.879567 :C9C9FE8E:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 09-06 14:03:41.869 2025-09-06 14:03:41.879568 :C9C9FE8F:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=20856 pso_num=29 pso_serial#=227 2025-09-06 14:03:41.879737 :C9C9FE93:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=20856 osp_idx=27 osp_ver=17056 osp_pg=0 (spawn #564726) 2025-09-06 14:03:41.879738 :C9C9FE94:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-06 14:03:41.879739 :C9C9FE95:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=153 time=1553073174 2025-09-06 14:03:41.879739 :C9C9FE96:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-09-06 14:03:41.879740 :C9C9FE97:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-09-06 14:03:41.879740 :C9C9FE98:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-09-06 14:03:41.879741 :C9C9FE99:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-06 14:03:41.879741 :C9C9FE9A:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-06 14:03:41.880277 :C9C9FE9B: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-09-06 14:03:41.880315 :C9C9FEA1: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-09-06 14:03:41.889479 :C9C9FEB3:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-09-06 14:03:42.991327 :C9CA033E:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 09-06 14:03:42.978 2025-09-06 14:03:42.991329 :C9CA033F:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=20536 pso_num=29 pso_serial#=228 2025-09-06 14:03:42.991460 :C9CA0340:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=20536 (legacy spawn) 2025-09-06 14:03:42.997929 :C9CA0341: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-09-06 14:03:42.997959 :C9CA0344: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-09-06 14:03:42.998100 :C9CA034A: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-09-06 14:03:42.998871 :C9CA0358:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-09-06 14:03:43.007507 :C9CA035B:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 09-06 14:03:42.994 2025-09-06 14:03:43.007509 :C9CA035C:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=23892 pso_num=29 pso_serial#=229 2025-09-06 14:03:43.007647 :C9CA035D:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=23892 (legacy spawn) 2025-09-06 14:03:43.029555 :C9CA0388: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-09-06 14:03:43.029730 :C9CA038E: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-09-06 14:03:43.030510 :C9CA0392:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-09-06 16:00:01.092970 :C9D2FE58:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 09-06 16:00:01.079 2025-09-06 16:00:01.092972 :C9D2FE59:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=23024 pso_num=29 pso_serial#=230 2025-09-06 16:00:01.093107 :C9D2FE5A:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=23024 (legacy spawn) 2025-09-06 16:00:01.099585 :C9D2FE5B: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-09-06 16:00:01.099755 :C9D2FE64: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-09-06 16:00:01.100537 :C9D2FE65:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-09-06 16:00:01.109277 :C9D2FE68:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 09-06 16:00:01.094 2025-09-06 16:00:01.109279 :C9D2FE69:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=24316 pso_num=29 pso_serial#=231 2025-09-06 16:00:01.109424 :C9D2FE6A:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=24316 (legacy spawn) 2025-09-06 16:00:01.115909 :C9D2FE6B: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-09-06 16:00:01.116065 :C9D2FE74: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-09-06 16:00:01.116879 :C9D2FE75:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-09-06 16:00:04.187337 :C9D2FF52:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 09-06 16:00:04.174 2025-09-06 16:00:04.187339 :C9D2FF53:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=24412 pso_num=29 pso_serial#=232 2025-09-06 16:00:04.187483 :C9D2FF54:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=24412 (legacy spawn) 2025-09-06 16:00:04.193909 :C9D2FF55: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-09-06 16:00:04.194078 :C9D2FF5E: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-09-06 16:00:04.194866 :C9D2FF5F:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-09-06 16:00:04.214277 :C9D2FF62:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 09-06 16:00:04.205 2025-09-06 16:00:04.214279 :C9D2FF63:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=24232 pso_num=29 pso_serial#=233 2025-09-06 16:00:04.214419 :C9D2FF64:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=24232 (legacy spawn) 2025-09-06 16:00:04.220978 :C9D2FF65: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-09-06 16:00:04.221145 :C9D2FF6D: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-09-06 16:00:04.221959 :C9D2FF6F:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-09-06 16:00:11.755659 :C9D301A6:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 09-06 16:00:11.748 2025-09-06 16:00:11.755661 :C9D301A7:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=23140 pso_num=29 pso_serial#=234 2025-09-06 16:00:11.755815 :C9D301A8:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=23140 (legacy spawn) 2025-09-06 16:00:11.762609 :C9D301A9: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-09-06 16:00:11.762813 :C9D301AE: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-09-06 16:00:11.763728 :C9D301B3:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-09-06 16:00:27.343900 :C9D30666:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 09-06 16:00:27.335 2025-09-06 16:00:27.343902 :C9D30667:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=23748 pso_num=29 pso_serial#=235 2025-09-06 16:00:27.344046 :C9D30668:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=23748 (legacy spawn) 2025-09-06 16:00:27.350573 :C9D30669: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-09-06 16:00:27.350741 :C9D3066E: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-09-06 16:00:27.351529 :C9D30673:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-09-06 16:00:29.890283 :C9D3072D:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 09-06 16:00:29.882 2025-09-06 16:00:29.890285 :C9D3072E:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=24228 pso_num=29 pso_serial#=236 2025-09-06 16:00:29.890418 :C9D3072F:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=24228 (legacy spawn) 2025-09-06 16:00:29.896958 :C9D30730: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-09-06 16:00:29.897141 :C9D30735: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-09-06 16:00:29.897971 :C9D3073A:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-09-06 18:00:11.434775 :C9DC36F4:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 09-06 18:00:11.430 2025-09-06 18:00:11.434778 :C9DC36F5:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=24176 pso_num=29 pso_serial#=237 2025-09-06 18:00:11.434984 :C9DC36F6:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=24176 osp_idx=27 osp_ver=17066 osp_pg=0 (spawn #565273) 2025-09-06 18:00:11.434985 :C9DC36F7:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-06 18:00:11.434986 :C9DC36F8:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=154 time=1567262721 2025-09-06 18:00:11.434986 :C9DC36F9:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-09-06 18:00:11.434987 :C9DC36FA:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-09-06 18:00:11.434988 :C9DC36FB:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-09-06 18:00:11.434989 :C9DC36FC:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-06 18:00:11.434989 :C9DC36FD:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-06 18:00:11.435521 :C9DC36FE: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-09-06 18:00:11.435570 :C9DC3704: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-09-06 18:00:11.443538 :C9DC3712: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-09-06 18:00:11.444605 :C9DC371A: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-09-06 18:00:11.445165 :C9DC3722: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-09-06 18:00:11.445615 :C9DC372A: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-09-06 18:00:11.446045 :C9DC3732: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-09-06 18:00:11.448617 :C9DC373A: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-09-06 18:00:11.449680 :C9DC3742: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-09-06 18:00:11.501109 :C9DC379D: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-09-06 18:00:11.502016 :C9DC37A5: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-09-06 18:00:11.502263 :C9DC37AD: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-09-06 18:00:11.502478 :C9DC37B5: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-09-06 18:00:11.504371 :C9DC37BD:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-09-06 18:04:10.543933 :C9DC86C9:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 09-06 18:04:10.531 2025-09-06 18:04:10.543934 :C9DC86CA:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=22408 pso_num=29 pso_serial#=238 2025-09-06 18:04:10.544085 :C9DC86CB:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=22408 osp_idx=27 osp_ver=17067 osp_pg=0 (spawn #565283) 2025-09-06 18:04:10.544087 :C9DC86CC:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-06 18:04:10.544087 :C9DC86CD:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=155 time=1567501846 2025-09-06 18:04:10.544088 :C9DC86CE:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-09-06 18:04:10.544088 :C9DC86CF:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-09-06 18:04:10.544089 :C9DC86D0:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-09-06 18:04:10.544089 :C9DC86D1:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-06 18:04:10.544089 :C9DC86D2:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-06 18:04:10.544654 :C9DC86D3: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-09-06 18:04:10.544698 :C9DC86D9: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-09-06 18:04:10.553815 :C9DC86EB:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-09-06 18:04:10.762934 :C9DC88BE:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 09-06 18:04:10.750 2025-09-06 18:04:10.762936 :C9DC88BF:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=15732 pso_num=29 pso_serial#=239 2025-09-06 18:04:10.763076 :C9DC88C4:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=15732 osp_idx=27 osp_ver=17068 osp_pg=0 (spawn #565287) 2025-09-06 18:04:10.763077 :C9DC88C5:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-06 18:04:10.763078 :C9DC88C6:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=156 time=1567502065 2025-09-06 18:04:10.763078 :C9DC88C7:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-09-06 18:04:10.763079 :C9DC88C8:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-09-06 18:04:10.763080 :C9DC88C9:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-09-06 18:04:10.763080 :C9DC88CA:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-06 18:04:10.763081 :C9DC88CB:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-06 18:04:10.763632 :C9DC88D1: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 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 29 (osid: 15732, J003)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de