Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250823060006\orcl_j002_21908_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250823060006\orcl_j002_21908_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:35287M/63366M, Ph+PgF:40446M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 28 Windows thread id: 21908, image: ORACLE.EXE (J002) *** 2025-08-23 06:00:06.708 *** SESSION ID:(225.43183) 2025-08-23 06:00:06.708 *** 2025-08-23 06:00:06.708 Process diagnostic dump for ORACLE.EXE (J002), OS id=21908, pid: 28, proc_ser: 60, sid: 225, sess_ser: 43183 ------------------------------------------------------------------------------- current sql: <none> client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 21908 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J002) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=10 seq_num=11 snap_id=1 wait times: snap=0.019641 sec, exc=0.019641 sec, total=0.019641 sec wait times: max=0.500000 sec, heur=4.635179 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.000007 sec since current wait 0: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=9 seq_num=10 snap_id=1 wait times: snap=0.499998 sec, exc=0.499998 sec, total=0.499998 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 sec of elapsed time 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=8 seq_num=9 snap_id=1 wait times: snap=0.500110 sec, exc=0.500110 sec, total=0.500110 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 sec of elapsed time 2: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=7 seq_num=8 snap_id=1 wait times: snap=0.500001 sec, exc=0.500001 sec, total=0.500001 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000007 sec of elapsed time 3: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=6 seq_num=7 snap_id=1 wait times: snap=0.499997 sec, exc=0.499997 sec, total=0.499997 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000010 sec of elapsed time 4: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=5 seq_num=6 snap_id=1 wait times: snap=0.499993 sec, exc=0.499993 sec, total=0.499993 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000010 sec of elapsed time 5: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=4 seq_num=5 snap_id=1 wait times: snap=0.499993 sec, exc=0.499993 sec, total=0.499993 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000005 sec of elapsed time 6: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=3 seq_num=4 snap_id=1 wait times: snap=0.513686 sec, exc=0.513686 sec, total=0.513686 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=2 seq_num=3 snap_id=1 wait times: snap=0.505090 sec, exc=0.505090 sec, total=0.505090 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 sec of elapsed time 8: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=1 seq_num=2 snap_id=1 wait times: snap=0.499242 sec, exc=0.499242 sec, total=0.499242 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000005 sec of elapsed time 9: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=0 seq_num=1 snap_id=1 wait times: snap=0.097348 sec, exc=0.097348 sec, total=0.097348 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 225 serial 43183 --------------------------------------------------- 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, 06:00:02 - 06:00:06] idle wait at each sample [session created at: 06:00:02] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-08-23 06:00:06.708 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 28 (osid: 21908, J002) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-08-23 01:58:12.487067 :C35FA888:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=20628 (legacy spawn) 2025-08-23 01:58:12.493596 :C35FA889:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-23 01:58:12.493767 :C35FA88E:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-08-23 01:58:12.494584 :C35FA893:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-23 01:58:12.846001 :C35FA8B0:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-23 01:58:12.833 2025-08-23 01:58:12.846003 :C35FA8B1:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=18072 pso_num=28 pso_serial#=46 2025-08-23 01:58:12.846145 :C35FA8B2:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=18072 (legacy spawn) 2025-08-23 01:58:12.852585 :C35FA8B3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-23 01:58:12.852775 :C35FA8B9:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-08-23 01:58:12.853567 :C35FA8BD:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-23 01:58:14.856375 :C35FA95D:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-23 01:58:14.848 2025-08-23 01:58:14.856377 :C35FA95E:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=20172 pso_num=28 pso_serial#=47 2025-08-23 01:58:14.856512 :C35FA95F:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=20172 (legacy spawn) 2025-08-23 01:58:14.862926 :C35FA960:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-23 01:58:14.863104 :C35FA965:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-08-23 01:58:14.863963 :C35FA96A:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-23 01:58:17.794304 :C35FAA41:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-23 01:58:17.780 2025-08-23 01:58:17.794306 :C35FAA42:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=8552 pso_num=28 pso_serial#=48 2025-08-23 01:58:17.794453 :C35FAA43:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=8552 (legacy spawn) 2025-08-23 01:58:17.800959 :C35FAA44:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-23 01:58:17.801138 :C35FAA49:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-08-23 01:58:17.801946 :C35FAA4E:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-23 01:58:17.810893 :C35FAA51:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-23 01:58:17.796 2025-08-23 01:58:17.810896 :C35FAA52:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=11644 pso_num=28 pso_serial#=49 2025-08-23 01:58:17.811033 :C35FAA53:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=11644 (legacy spawn) 2025-08-23 01:58:17.817493 :C35FAA54:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-23 01:58:17.817658 :C35FAA5D:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-08-23 01:58:17.818466 :C35FAA5E:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-23 01:58:21.939193 :C35FABD8:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-23 01:58:21.930 2025-08-23 01:58:21.939195 :C35FABD9:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=22224 pso_num=28 pso_serial#=50 2025-08-23 01:58:21.939331 :C35FABDA:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=22224 (legacy spawn) 2025-08-23 01:58:21.945888 :C35FABDB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-23 01:58:21.946101 :C35FABE3:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-08-23 01:58:21.949870 :C35FABE5:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-23 01:58:56.331377 :C35FB72B:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-23 01:58:56.318 2025-08-23 01:58:56.331379 :C35FB72C:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=21736 pso_num=28 pso_serial#=51 2025-08-23 01:58:56.331537 :C35FB72D:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=21736 (legacy spawn) 2025-08-23 01:58:56.338364 :C35FB72E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-23 01:58:56.338561 :C35FB737:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-08-23 01:58:56.339457 :C35FB738:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-23 01:59:17.031769 :C35FBDCF:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-23 01:59:17.019 2025-08-23 01:59:17.031771 :C35FBDD0:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=21476 pso_num=28 pso_serial#=52 2025-08-23 01:59:17.031908 :C35FBDD1:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=21476 (legacy spawn) 2025-08-23 01:59:17.038566 :C35FBDD2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-23 01:59:17.038750 :C35FBDD7:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-08-23 01:59:17.039608 :C35FBDDC:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-23 01:59:22.286275 :C35FBF86:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-23 01:59:22.273 2025-08-23 01:59:22.286277 :C35FBF87:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=20664 pso_num=28 pso_serial#=53 2025-08-23 01:59:22.286415 :C35FBF88:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=20664 (legacy spawn) 2025-08-23 01:59:22.292946 :C35FBF89:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-23 01:59:22.293128 :C35FBF91:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-08-23 01:59:22.293932 :C35FBF93:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-23 01:59:22.302768 :C35FBF96:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-23 01:59:22.288 2025-08-23 01:59:22.302770 :C35FBF97:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=22228 pso_num=28 pso_serial#=54 2025-08-23 01:59:22.302911 :C35FBF98:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=22228 (legacy spawn) 2025-08-23 01:59:22.309486 :C35FBF99:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-23 01:59:22.309654 :C35FBFA2:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-08-23 01:59:22.310467 :C35FBFA3:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-23 01:59:22.637586 :C35FBFD4:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-23 01:59:22.632 2025-08-23 01:59:22.637588 :C35FBFD5:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=20048 pso_num=28 pso_serial#=55 2025-08-23 01:59:22.637722 :C35FBFD6:db_trace:kso.c@4093:ksonfy(): [10420:28:0] kso: new process: pid=20048 osp_idx=26 osp_ver=250768 osp_pg=0 (spawn #516364) 2025-08-23 01:59:22.637722 :C35FBFD7:db_trace:kso.c@4099:ksonfy(): [10420:28:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-23 01:59:22.637723 :C35FBFD8:db_trace:kso.c@4103:ksonfy(): [10420:28:0] kso: new process: pso_index=28 reservation=177 time=300064643 2025-08-23 01:59:22.637724 :C35FBFD9:db_trace:kso.c@4109:ksonfy(): [10420:28:0] kso: spawn diagnostics: queue time=0 secs 2025-08-23 01:59:22.637725 :C35FBFDA:db_trace:kso.c@4111:ksonfy(): [10420:28:0] kso: spawn diagnostics: fork time=0 secs 2025-08-23 01:59:22.637725 :C35FBFDB:db_trace:kso.c@4113:ksonfy(): [10420:28:0] kso: spawn diagnostics: exec time=0 secs 2025-08-23 01:59:22.637726 :C35FBFDC:db_trace:kso.c@4115:ksonfy(): [10420:28:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-23 01:59:22.637726 :C35FBFDD:db_trace:kso.c@4117:ksonfy(): [10420:28:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-23 01:59:22.638214 :C35FBFDE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-23 01:59:22.638258 :C35FBFE4:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-08-23 01:59:22.642509 :C35FBFFD:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:kelt.c:517 2025-08-23 01:59:22.642550 :C35FBFFE:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:kelt.c:517 2025-08-23 01:59:22.642849 :C35FBFFF:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:kelt.c:517 2025-08-23 01:59:22.642874 :C35FC000:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:kelt.c:517 2025-08-23 01:59:22.643117 :C35FC001:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:kelt.c:517 2025-08-23 01:59:22.643131 :C35FC002:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:kelt.c:517 2025-08-23 01:59:22.643342 :C35FC003:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:kelt.c:517 2025-08-23 01:59:22.643356 :C35FC004:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:kelt.c:517 2025-08-23 01:59:22.643575 :C35FC005:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:kelt.c:517 2025-08-23 01:59:22.643589 :C35FC006:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:kelt.c:517 2025-08-23 01:59:22.643797 :C35FC007:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:kelt.c:517 2025-08-23 01:59:22.643811 :C35FC008:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:kelt.c:517 2025-08-23 01:59:22.646102 :C35FC009:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-23 01:59:58.712568 :C35FCBA8:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-23 01:59:58.709 2025-08-23 01:59:58.712571 :C35FCBA9:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=17248 pso_num=28 pso_serial#=56 2025-08-23 01:59:58.712715 :C35FCBAA:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=17248 (legacy spawn) 2025-08-23 01:59:58.719362 :C35FCBAB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-23 01:59:58.719549 :C35FCBB3:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-08-23 01:59:58.720386 :C35FCBB4:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-23 01:59:58.729840 :C35FCBDA:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-23 01:59:58.725 2025-08-23 01:59:58.729842 :C35FCBDB:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=13880 pso_num=28 pso_serial#=57 2025-08-23 01:59:58.729988 :C35FCBDC:db_trace:kso.c@4070:ksonfy(): [10420:28:0] kso: new process: pid=13880 (legacy spawn) 2025-08-23 01:59:58.736854 :C35FCBDD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-23 01:59:58.737035 :C35FCBE6:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-08-23 01:59:58.737942 :C35FCBE7:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-23 02:00:00.031864 :C35FCC81:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-23 02:00:00.021 2025-08-23 02:00:00.031866 :C35FCC82:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=19096 pso_num=28 pso_serial#=58 2025-08-23 02:00:00.032012 :C35FCC83:db_trace:kso.c@4093:ksonfy(): [10420:28:0] kso: new process: pid=19096 osp_idx=26 osp_ver=250771 osp_pg=0 (spawn #516367) 2025-08-23 02:00:00.032013 :C35FCC84:db_trace:kso.c@4099:ksonfy(): [10420:28:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-23 02:00:00.032014 :C35FCC85:db_trace:kso.c@4103:ksonfy(): [10420:28:0] kso: new process: pso_index=28 reservation=178 time=300102033 2025-08-23 02:00:00.032014 :C35FCC86:db_trace:kso.c@4109:ksonfy(): [10420:28:0] kso: spawn diagnostics: queue time=0 secs 2025-08-23 02:00:00.032014 :C35FCC87:db_trace:kso.c@4111:ksonfy(): [10420:28:0] kso: spawn diagnostics: fork time=0 secs 2025-08-23 02:00:00.032015 :C35FCC88:db_trace:kso.c@4113:ksonfy(): [10420:28:0] kso: spawn diagnostics: exec time=0 secs 2025-08-23 02:00:00.032015 :C35FCC89:db_trace:kso.c@4115:ksonfy(): [10420:28:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-23 02:00:00.032015 :C35FCC8A:db_trace:kso.c@4117:ksonfy(): [10420:28:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-23 02:00:00.032511 :C35FCC8B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-23 02:00:00.032556 :C35FCC92:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-08-23 02:00:00.032637 :C35FCCA6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-08-23 02:00:00.036518 :C35FCCB5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-23 02:00:00.090314 :C35FCCC0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-23 02:00:00.092407 :C35FCCC8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-23 02:00:00.094239 :C35FCCD0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-23 02:00:00.095026 :C35FCCD8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-23 02:00:00.095049 :C35FCCDB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-08-23 02:00:00.095094 :C35FCCE5:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] KSL POST RCVD poster=18 loc='ksr2.h LINE:607 ID:ksrmdone' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-23 02:00:00.095749 :C35FCCF1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-23 02:00:00.095765 :C35FCCF4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-08-23 02:00:00.095789 :C35FCD00:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] KSL POST RCVD poster=18 loc='ksr2.h LINE:607 ID:ksrmdone' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-23 02:00:00.096663 :C35FCD0A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-23 02:00:00.096677 :C35FCD0D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-08-23 02:00:00.096701 :C35FCD19:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] KSL POST RCVD poster=18 loc='ksr2.h LINE:607 ID:ksrmdone' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-23 02:00:00.096755 :C35FCD24:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-08-23 02:00:00.098017 :C35FCD25:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-23 02:04:23.280627 :C3602725:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-23 02:04:23.268 2025-08-23 02:04:23.280629 :C3602726:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=13660 pso_num=28 pso_serial#=59 2025-08-23 02:04:23.280764 :C3602727:db_trace:kso.c@4093:ksonfy(): [10420:28:0] kso: new process: pid=13660 osp_idx=26 osp_ver=250772 osp_pg=0 (spawn #516380) 2025-08-23 02:04:23.280765 :C3602728:db_trace:kso.c@4099:ksonfy(): [10420:28:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-23 02:04:23.280765 :C3602729:db_trace:kso.c@4103:ksonfy(): [10420:28:0] kso: new process: pso_index=28 reservation=179 time=300365283 2025-08-23 02:04:23.280766 :C360272A:db_trace:kso.c@4109:ksonfy(): [10420:28:0] kso: spawn diagnostics: queue time=0 secs 2025-08-23 02:04:23.280766 :C360272B:db_trace:kso.c@4111:ksonfy(): [10420:28:0] kso: spawn diagnostics: fork time=0 secs 2025-08-23 02:04:23.280766 :C360272C:db_trace:kso.c@4113:ksonfy(): [10420:28:0] kso: spawn diagnostics: exec time=0 secs 2025-08-23 02:04:23.280767 :C360272D:db_trace:kso.c@4115:ksonfy(): [10420:28:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-23 02:04:23.280767 :C360272E:db_trace:kso.c@4117:ksonfy(): [10420:28:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-23 02:04:23.281325 :C360272F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-23 02:04:23.281370 :C3602735:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-08-23 02:04:23.289259 :C360274F:db_trace:kst.c@698:kstpsodel(): [10280:28:0] kst: process state object about to be deleted 2025-08-23 06:00:02.046781 :C372B545:db_trace:kst.c@673:kstipg(): [10280:28:0] kst: process state object created on 08-23 06:00:02.046 2025-08-23 06:00:02.046783 :C372B546:db_trace:kst.c@679:kstipg(): [10280:28:0] kst: process info: ospid=21908 pso_num=28 pso_serial#=60 2025-08-23 06:00:02.046919 :C372B547:db_trace:kso.c@4093:ksonfy(): [10420:28:0] kso: new process: pid=21908 osp_idx=26 osp_ver=250773 osp_pg=0 (spawn #516924) 2025-08-23 06:00:02.046920 :C372B548:db_trace:kso.c@4099:ksonfy(): [10420:28:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-23 06:00:02.046920 :C372B549:db_trace:kso.c@4103:ksonfy(): [10420:28:0] kso: new process: pso_index=28 reservation=180 time=314504049 2025-08-23 06:00:02.046921 :C372B54A:db_trace:kso.c@4109:ksonfy(): [10420:28:0] kso: spawn diagnostics: queue time=0 secs 2025-08-23 06:00:02.046922 :C372B54B:db_trace:kso.c@4111:ksonfy(): [10420:28:0] kso: spawn diagnostics: fork time=0 secs 2025-08-23 06:00:02.046922 :C372B54C:db_trace:kso.c@4113:ksonfy(): [10420:28:0] kso: spawn diagnostics: exec time=0 secs 2025-08-23 06:00:02.046922 :C372B54D:db_trace:kso.c@4115:ksonfy(): [10420:28:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-23 06:00:02.046923 :C372B54E:db_trace:kso.c@4117:ksonfy(): [10420:28:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-23 06:00:02.047417 :C372B558:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-23 06:00:02.054511 :C372B59C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-23 06:00:02.054568 :C372B59F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpus:jslv.c:9203 2025-08-23 06:00:02.059964 :C372B5DD:KFNU:kfn.c@2200:kfnPrepareASM(): kfnPrepareASM force=0 state_kfnsg=0x7 2025-08-23 06:00:02.060592 :C372B5DE:db_trace:kcc.c@13684:kccwbp(): [10021:28:225:1] 0115000000000000 0115000000000000 f391120000000000 2025-08-23 06:00:02.062426 :C372B5DF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=15 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-08-23 06:00:02.062582 :C372B5EC:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] KSL POST RCVD poster=15 loc='ksr2.h LINE:607 ID:ksrmdone' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-23 06:00:02.062593 :C372B5F3:db_trace:ksb.c@6610:ksbcic_int(): [10254:28:225] KSBCIC: (USER) starting cic on opcode KSBCIRCO [1] with args (1 8397264 1) 2025-08-23 06:00:02.062600 :C372B5F4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=15 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-23 06:00:02.062641 :C372B600:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] KSL POST RCVD poster=15 loc='ksa2.h LINE:286 ID:ksasnr' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-23 06:00:02.063371 :C372B60C:db_trace:ksb.c@6610:ksbcic_int(): [10254:28:225] KSBCIC: (USER) starting cic on opcode KSBCICKP [2] with args (4 0 235270147) 2025-08-23 06:00:02.063375 :C372B60D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=15 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-23 06:00:02.063404 :C372B616:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] KSL POST RCVD poster=15 loc='ksa2.h LINE:286 ID:ksasnr' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-23 06:00:02.063413 :C372B622:db_trace:ksb.c@6610:ksbcic_int(): [10254:28:225] KSBCIC: (USER) starting cic on opcode KSBCICKP [2] with args (6 65564 1) 2025-08-23 06:00:02.063417 :C372B626:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=15 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-23 06:00:02.063448 :C372B631:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] KSL POST RCVD poster=15 loc='ksa2.h LINE:286 ID:ksasnr' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-23 06:00:02.063452 :C372B638:db_trace:ksb.c@6610:ksbcic_int(): [10254:28:225] KSBCIC: (USER) starting cic on opcode KSBCICKP [2] with args (1 2 65564) 2025-08-23 06:00:02.063455 :C372B63E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=15 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-23 06:00:02.063511 :C372B65C:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] KSL POST RCVD poster=15 loc='ksa2.h LINE:286 ID:ksasnr' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-23 06:00:02.064103 :C372B6E1:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] KSL POST RCVD poster=15 loc='ksq.h LINE:1877 ID:ksqrcl' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-23 06:00:02.064120 :C372B6E8:KFNU:kfn.c@2200:kfnPrepareASM(): kfnPrepareASM force=0 state_kfnsg=0x7 2025-08-23 06:00:02.064950 :C372B6FA:db_trace:kcc.c@13684:kccwbp(): [10021:28:225:1] 0115000000000000 0115000000000000 f491120000000000 2025-08-23 06:00:02.065376 :C372B710:db_trace:ksb.c@6610:ksbcic_int(): [10254:28:225] KSBCIC: (USER) starting cic on opcode KSBCIBBS [20] with args (2 0 235270147) 2025-08-23 06:00:02.065387 :C372B711:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=15 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-23 06:00:02.065413 :C372B71D:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] KSL POST RCVD poster=15 loc='ksa2.h LINE:286 ID:ksasnr' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-23 06:00:02.074315 :C372B75F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:28:225] atxpop:jslv.c:9203 2025-08-23 06:00:02.076213 :C372B760:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-23 06:00:02.076269 :C372B764:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:28:225] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 2025-08-23 06:00:02.076392 :C372B772:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] 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-08-23 06:00:02.174490 :C372B85B:db_trace:ksl2.c@12699:ksliwat(): [10005:28:225] KSL POST RCVD poster=59 loc='kkj.h LINE:914 ID:kkjpstnp' id1=0 id2=0 name= type=0 fac#=0 facpost=1 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 28 (osid: 21908, J002)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de