Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250618220008\orcl_w000_16752_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250618220008\orcl_w000_16752_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:36500M/63366M, Ph+PgF:42880M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 22 Windows thread id: 16752, image: ORACLE.EXE (W000) *** 2025-06-18 22:00:09.026 *** SESSION ID:(177.37635) 2025-06-18 22:00:09.026 *** 2025-06-18 22:00:09.026 Process diagnostic dump for ORACLE.EXE (W000), OS id=16752, pid: 22, proc_ser: 9, sid: 177, sess_ser: 37635 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=57 seq_num=58 snap_id=1 wait times: snap=1.000721 sec, exc=1.000721 sec, total=1.000721 sec wait times: max=5.000000 sec, heur=4 min 41 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.000021 sec since current wait 0: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=56 seq_num=57 snap_id=1 wait times: snap=5.004615 sec, exc=5.004615 sec, total=5.004615 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000021 sec of elapsed time 1: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=55 seq_num=56 snap_id=1 wait times: snap=5.000026 sec, exc=5.000026 sec, total=5.000026 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000024 sec of elapsed time 2: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=54 seq_num=55 snap_id=1 wait times: snap=5.010136 sec, exc=5.010136 sec, total=5.010136 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000023 sec of elapsed time 3: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=53 seq_num=54 snap_id=1 wait times: snap=5.013061 sec, exc=5.013061 sec, total=5.013061 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000026 sec of elapsed time 4: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=52 seq_num=53 snap_id=1 wait times: snap=5.004002 sec, exc=5.004002 sec, total=5.004002 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000022 sec of elapsed time 5: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=51 seq_num=52 snap_id=1 wait times: snap=5.004617 sec, exc=5.004617 sec, total=5.004617 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000023 sec of elapsed time 6: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=50 seq_num=51 snap_id=1 wait times: snap=5.004622 sec, exc=5.004622 sec, total=5.004622 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000023 sec of elapsed time 7: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=49 seq_num=50 snap_id=1 wait times: snap=5.013507 sec, exc=5.013507 sec, total=5.013507 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000025 sec of elapsed time 8: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=48 seq_num=49 snap_id=1 wait times: snap=5.002139 sec, exc=5.002139 sec, total=5.002139 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000024 sec of elapsed time 9: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=47 seq_num=48 snap_id=1 wait times: snap=5.001444 sec, exc=5.001444 sec, total=5.001444 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000025 sec of elapsed time Sampled Session History of session 177 serial 37635 --------------------------------------------------- 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 --------------------------------------------------- [121 samples, 21:58:09 - 22:00:09] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-06-18 22:00:09.026 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 22 (osid: 16752, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-06-18 19:35:11.193826 :A6762BEC:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=17 time=3251054391 2025-06-18 19:35:11.193826 :A6762BED:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-18 19:35:11.193826 :A6762BEE:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-18 19:35:11.193827 :A6762BEF:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-18 19:35:11.193827 :A6762BF0:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-18 19:35:11.193828 :A6762BF1:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-18 19:35:11.194337 :A6762BF2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-18 19:35:11.194391 :A6762BFA:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-18 19:45:12.035543 :A676EE3F:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-18 19:45:12.415347 :A676EE83:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-18 19:45:12.411 2025-06-18 19:45:12.415349 :A676EE84:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=14204 pso_num=22 pso_serial#=251 2025-06-18 19:45:12.415490 :A676EE85:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=14204 osp_idx=0 osp_ver=318308 osp_pg=0 (spawn #298837) 2025-06-18 19:45:12.415491 :A676EE86:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-18 19:45:12.415491 :A676EE87:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=18 time=3251655610 2025-06-18 19:45:12.415492 :A676EE88:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-18 19:45:12.415492 :A676EE89:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-18 19:45:12.415493 :A676EE8A:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-18 19:45:12.415493 :A676EE8B:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-18 19:45:12.415493 :A676EE8C:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-18 19:45:12.415981 :A676EE8D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-18 19:45:12.416028 :A676EE95:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-18 19:55:13.383989 :A677B1A9:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-18 19:55:13.711297 :A677B1E2:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-18 19:55:13.711 2025-06-18 19:55:13.711299 :A677B1E3:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=17112 pso_num=22 pso_serial#=252 2025-06-18 19:55:13.711484 :A677B1E4:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=17112 osp_idx=0 osp_ver=318309 osp_pg=0 (spawn #298859) 2025-06-18 19:55:13.711485 :A677B1E5:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-18 19:55:13.711486 :A677B1E6:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=19 time=3252256907 2025-06-18 19:55:13.711486 :A677B1E7:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-18 19:55:13.711486 :A677B1E8:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-18 19:55:13.711487 :A677B1E9:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-18 19:55:13.711488 :A677B1EA:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-18 19:55:13.711488 :A677B1EB:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-18 19:55:13.711997 :A677B1EC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-18 19:55:13.712038 :A677B1F4:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-18 19:55:28.726733 :A677B74C:db_trace:ksl2.c@2477:kslwtbctx(): [10005:22:177] KSL WAIT BEG [latch free] 136537728/0x8236680 259/0x103 0/0x0 wait_id=4 seq_num=5 snap_id=1 2025-06-18 19:55:28.726752 :A677B751:db_trace:ksl2.c@2611:kslwtectx(): [10005:22:177] KSL WAIT END [latch free] 136537728/0x8236680 259/0x103 0/0x0 wait_id=4 seq_num=5 snap_id=1 2025-06-18 19:55:28.726754 :A677B752:db_trace:ksl2.c@2619:kslwtectx(): [10005:22:177] KSL WAIT END wait times (usecs) - snap=17, exc=17, tot=17 2025-06-18 20:05:14.597195 :A6787733:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-18 20:05:14.929821 :A678776D:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-18 20:05:14.925 2025-06-18 20:05:14.929823 :A678776E:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16988 pso_num=22 pso_serial#=253 2025-06-18 20:05:14.930017 :A678776F:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=16988 osp_idx=0 osp_ver=318310 osp_pg=0 (spawn #298887) 2025-06-18 20:05:14.930018 :A6787770:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-18 20:05:14.930019 :A6787771:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=20 time=3252858125 2025-06-18 20:05:14.930019 :A6787772:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-18 20:05:14.930019 :A6787773:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-18 20:05:14.930020 :A6787774:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-18 20:05:14.930020 :A6787775:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-18 20:05:14.930021 :A6787776:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-18 20:05:14.930530 :A6787777:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-18 20:05:14.930577 :A678777F:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-18 20:15:15.694273 :A679458D:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-18 20:15:15.952465 :A6794590:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-18 20:15:15.944 2025-06-18 20:15:15.952467 :A6794591:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=17320 pso_num=22 pso_serial#=254 2025-06-18 20:15:15.952607 :A6794592:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=17320 (legacy spawn) 2025-06-18 20:15:15.959091 :A6794593:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-18 20:15:15.959270 :A679459C:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-18 20:15:15.960082 :A679459D:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-18 20:15:16.026999 :A67945E2:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-18 20:15:16.023 2025-06-18 20:15:16.027001 :A67945E3:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=17220 pso_num=22 pso_serial#=255 2025-06-18 20:15:16.027139 :A67945E4:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=17220 osp_idx=0 osp_ver=318312 osp_pg=0 (spawn #298908) 2025-06-18 20:15:16.027139 :A67945E5:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-18 20:15:16.027140 :A67945E6:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=21 time=3253459219 2025-06-18 20:15:16.027140 :A67945E7:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-18 20:15:16.027141 :A67945E8:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-18 20:15:16.027141 :A67945E9:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-18 20:15:16.027141 :A67945EA:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-18 20:15:16.027142 :A67945EB:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-18 20:15:16.027660 :A67945EC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-18 20:15:16.027714 :A67945F6:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-18 20:25:16.872575 :A67A0C18:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-18 20:25:17.252575 :A67A0C55:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-18 20:25:17.247 2025-06-18 20:25:17.252577 :A67A0C56:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=14052 pso_num=22 pso_serial#=1 2025-06-18 20:25:17.252713 :A67A0C57:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=14052 osp_idx=0 osp_ver=318313 osp_pg=0 (spawn #298930) 2025-06-18 20:25:17.252714 :A67A0C58:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-18 20:25:17.252714 :A67A0C59:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=22 time=3254060438 2025-06-18 20:25:17.252715 :A67A0C5A:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-18 20:25:17.252715 :A67A0C5B:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-18 20:25:17.252715 :A67A0C5C:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-18 20:25:17.252716 :A67A0C5D:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-18 20:25:17.252716 :A67A0C5E:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-18 20:25:17.253211 :A67A0C5F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-18 20:25:17.253259 :A67A0C66:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-18 20:35:18.125447 :A67AD3D0:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-18 20:35:18.364399 :A67AD416:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-18 20:35:18.360 2025-06-18 20:35:18.364400 :A67AD417:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=15472 pso_num=22 pso_serial#=2 2025-06-18 20:35:18.364538 :A67AD418:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=15472 osp_idx=0 osp_ver=318314 osp_pg=0 (spawn #298953) 2025-06-18 20:35:18.364538 :A67AD419:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-18 20:35:18.364539 :A67AD41A:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=23 time=3254661547 2025-06-18 20:35:18.364539 :A67AD41B:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-18 20:35:18.364540 :A67AD41C:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-18 20:35:18.364540 :A67AD41D:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-18 20:35:18.364540 :A67AD41E:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-18 20:35:18.364541 :A67AD41F:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-18 20:35:18.365036 :A67AD420:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-18 20:35:18.365079 :A67AD427:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-18 20:45:19.318193 :A67B9AC5:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-18 20:45:19.573138 :A67B9B02:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-18 20:45:19.568 2025-06-18 20:45:19.573140 :A67B9B03:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16644 pso_num=22 pso_serial#=3 2025-06-18 20:45:19.573282 :A67B9B04:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=16644 osp_idx=0 osp_ver=318315 osp_pg=0 (spawn #298976) 2025-06-18 20:45:19.573283 :A67B9B05:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-18 20:45:19.573285 :A67B9B06:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=24 time=3255262766 2025-06-18 20:45:19.573285 :A67B9B07:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-18 20:45:19.573286 :A67B9B08:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-18 20:45:19.573286 :A67B9B09:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-18 20:45:19.573286 :A67B9B0A:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-18 20:45:19.573287 :A67B9B0B:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-18 20:45:19.573834 :A67B9B0C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-18 20:45:19.573880 :A67B9B13:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-18 20:55:20.344339 :A67C6217:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-18 20:55:20.724935 :A67C625A:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-18 20:55:20.719 2025-06-18 20:55:20.724937 :A67C625B:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=15972 pso_num=22 pso_serial#=4 2025-06-18 20:55:20.725078 :A67C625C:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=15972 osp_idx=0 osp_ver=318316 osp_pg=0 (spawn #298998) 2025-06-18 20:55:20.725079 :A67C625D:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-18 20:55:20.725079 :A67C625E:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=25 time=3255863907 2025-06-18 20:55:20.725079 :A67C625F:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-18 20:55:20.725080 :A67C6260:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-18 20:55:20.725080 :A67C6261:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-18 20:55:20.725081 :A67C6262:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-18 20:55:20.725081 :A67C6263:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-18 20:55:20.725645 :A67C6264:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-18 20:55:20.727371 :A67C626E:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-18 21:05:21.572559 :A67D2B28:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-18 21:05:21.858543 :A67D2B88:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-18 21:05:21.854 2025-06-18 21:05:21.858545 :A67D2B89:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16076 pso_num=22 pso_serial#=5 2025-06-18 21:05:21.858683 :A67D2B8A:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=16076 osp_idx=0 osp_ver=318317 osp_pg=0 (spawn #299024) 2025-06-18 21:05:21.858684 :A67D2B8B:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-18 21:05:21.858684 :A67D2B8C:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=26 time=3256465047 2025-06-18 21:05:21.858684 :A67D2B8D:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-18 21:05:21.858685 :A67D2B8E:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-18 21:05:21.858686 :A67D2B8F:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-18 21:05:21.858686 :A67D2B90:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-18 21:05:21.858686 :A67D2B91:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-18 21:05:21.859215 :A67D2B92:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-18 21:05:21.859268 :A67D2B9A:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-18 21:15:22.698288 :A67DF916:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-18 21:15:22.978713 :A67DF976:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-18 21:15:22.974 2025-06-18 21:15:22.978715 :A67DF977:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=17396 pso_num=22 pso_serial#=6 2025-06-18 21:15:22.978860 :A67DF978:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=17396 osp_idx=0 osp_ver=318318 osp_pg=0 (spawn #299047) 2025-06-18 21:15:22.978861 :A67DF979:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-18 21:15:22.978861 :A67DF97A:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=27 time=3257066172 2025-06-18 21:15:22.978862 :A67DF97B:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-18 21:15:22.978862 :A67DF97C:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-18 21:15:22.978863 :A67DF97D:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-18 21:15:22.978863 :A67DF97E:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-18 21:15:22.978863 :A67DF97F:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-18 21:15:22.979358 :A67DF980:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-18 21:15:22.979408 :A67DF98A:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-18 21:20:30.276677 :A67E5DB0:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=16 loc='ksl2.h LINE:2165 ID:kslpsr' id1=255 id2=0 name=EV type=0 fac#=0 facpost=1 2025-06-18 21:25:24.140756 :A67EBB5E:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksl2.h LINE:2165 ID:kslpsr' id1=255 id2=0 name=EV type=0 fac#=0 facpost=1 2025-06-18 21:35:25.013120 :A67F7E91:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-18 21:35:25.377025 :A67F7ED9:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-18 21:35:25.372 2025-06-18 21:35:25.377026 :A67F7EDA:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=17136 pso_num=22 pso_serial#=7 2025-06-18 21:35:25.377166 :A67F7EDB:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=17136 osp_idx=0 osp_ver=318319 osp_pg=0 (spawn #299091) 2025-06-18 21:35:25.377167 :A67F7EDC:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-18 21:35:25.377167 :A67F7EDD:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=28 time=3258268563 2025-06-18 21:35:25.377168 :A67F7EDE:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-18 21:35:25.377168 :A67F7EDF:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-18 21:35:25.377169 :A67F7EE0:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-18 21:35:25.377169 :A67F7EE1:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-18 21:35:25.377170 :A67F7EE2:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-18 21:35:25.377657 :A67F7EE3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-18 21:35:25.377700 :A67F7EE9:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-18 21:45:26.157050 :A6804148:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-18 21:45:26.489872 :A680418B:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-18 21:45:26.485 2025-06-18 21:45:26.489874 :A680418C:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=10376 pso_num=22 pso_serial#=8 2025-06-18 21:45:26.490013 :A680418D:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=10376 osp_idx=0 osp_ver=318320 osp_pg=0 (spawn #299114) 2025-06-18 21:45:26.490013 :A680418E:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-18 21:45:26.490014 :A680418F:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=29 time=3258869672 2025-06-18 21:45:26.490014 :A6804190:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-18 21:45:26.490015 :A6804191:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-18 21:45:26.490015 :A6804192:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-18 21:45:26.490015 :A6804193:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-18 21:45:26.490016 :A6804194:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-18 21:45:26.490517 :A6804195:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-18 21:45:26.490566 :A680419C:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-18 21:55:27.234203 :A6810432:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-18 21:55:27.676515 :A6810483:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-18 21:55:27.671 2025-06-18 21:55:27.676518 :A6810484:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16752 pso_num=22 pso_serial#=9 2025-06-18 21:55:27.676658 :A6810485:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=16752 osp_idx=0 osp_ver=318321 osp_pg=0 (spawn #299136) 2025-06-18 21:55:27.676658 :A6810486:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-18 21:55:27.676659 :A6810487:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=30 time=3259470860 2025-06-18 21:55:27.676659 :A6810488:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-18 21:55:27.676660 :A6810489:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-18 21:55:27.676660 :A681048A:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-18 21:55:27.676661 :A681048B:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-18 21:55:27.676661 :A681048C:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-18 21:55:27.677153 :A681048D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-18 21:55:27.677199 :A6810495:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 22 (osid: 16752, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de