Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250716220009\orcl_w000_12720_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250716220009\orcl_w000_12720_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:36286M/63366M, Ph+PgF:42258M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 22 Windows thread id: 12720, image: ORACLE.EXE (W000) *** 2025-07-16 22:00:09.828 *** SESSION ID:(177.65531) 2025-07-16 22:00:09.828 *** 2025-07-16 22:00:09.828 Process diagnostic dump for ORACLE.EXE (W000), OS id=12720, pid: 22, proc_ser: 149, sid: 177, sess_ser: 65531 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=228 seq_num=229 snap_id=1 wait times: snap=3.337205 sec, exc=3.337205 sec, total=3.337205 sec wait times: max=5.000000 sec, heur=15 min 6 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.000032 sec since current wait 0: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=227 seq_num=228 snap_id=1 wait times: snap=5.002053 sec, exc=5.002053 sec, total=5.002053 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000037 sec of elapsed time 1: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=226 seq_num=227 snap_id=1 wait times: snap=5.004612 sec, exc=5.004612 sec, total=5.004612 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000035 sec of elapsed time 2: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=225 seq_num=226 snap_id=1 wait times: snap=5.004608 sec, exc=5.004608 sec, total=5.004608 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000039 sec of elapsed time 3: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=224 seq_num=225 snap_id=1 wait times: snap=5.014693 sec, exc=5.014693 sec, total=5.014693 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000037 sec of elapsed time 4: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=223 seq_num=224 snap_id=1 wait times: snap=5.008308 sec, exc=5.008308 sec, total=5.008308 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000039 sec of elapsed time 5: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=222 seq_num=223 snap_id=1 wait times: snap=5.000140 sec, exc=5.000140 sec, total=5.000140 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000035 sec of elapsed time 6: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=221 seq_num=222 snap_id=1 wait times: snap=5.013059 sec, exc=5.013059 sec, total=5.013059 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000035 sec of elapsed time 7: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=220 seq_num=221 snap_id=1 wait times: snap=5.014023 sec, exc=5.014023 sec, total=5.014023 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000041 sec of elapsed time 8: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=219 seq_num=220 snap_id=1 wait times: snap=5.004616 sec, exc=5.004616 sec, total=5.004616 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000033 sec of elapsed time 9: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=218 seq_num=219 snap_id=1 wait times: snap=5.004608 sec, exc=5.004608 sec, total=5.004608 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000034 sec of elapsed time Sampled Session History of session 177 serial 65531 --------------------------------------------------- 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-07-16 22:00:09.828 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 22 (osid: 12720, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-07-16 19:10:59.250873 :B2E15244: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-07-16 19:21:00.149075 :B2E21BD5:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-16 19:21:00.685176 :B2E21C1C:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-16 19:21:00.680 2025-07-16 19:21:00.685178 :B2E21C1D:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=18084 pso_num=22 pso_serial#=136 2025-07-16 19:21:00.685318 :B2E21C1E:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=18084 osp_idx=0 osp_ver=413308 osp_pg=0 (spawn #392134) 2025-07-16 19:21:00.685319 :B2E21C1F:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-16 19:21:00.685319 :B2E21C20:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=51 time=1374436579 2025-07-16 19:21:00.685320 :B2E21C21:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-16 19:21:00.685320 :B2E21C22:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-16 19:21:00.685321 :B2E21C23:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-16 19:21:00.685321 :B2E21C24:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-16 19:21:00.685321 :B2E21C25:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-16 19:21:00.685817 :B2E21C26: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-07-16 19:21:00.685872 :B2E21C2C: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-07-16 19:31:01.568731 :B2E2E2F6:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-16 19:31:02.151915 :B2E2E341:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-16 19:31:02.147 2025-07-16 19:31:02.151917 :B2E2E342:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=11012 pso_num=22 pso_serial#=137 2025-07-16 19:31:02.152066 :B2E2E343:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=11012 osp_idx=0 osp_ver=413309 osp_pg=0 (spawn #392157) 2025-07-16 19:31:02.152067 :B2E2E344:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-16 19:31:02.152068 :B2E2E345:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=52 time=1375038048 2025-07-16 19:31:02.152069 :B2E2E346:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-16 19:31:02.152069 :B2E2E347:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-16 19:31:02.152069 :B2E2E348:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-16 19:31:02.152070 :B2E2E349:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-16 19:31:02.152070 :B2E2E34A:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-16 19:31:02.152572 :B2E2E34B: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-07-16 19:31:02.152621 :B2E2E352: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-07-16 19:40:02.593923 :B2E39804: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-07-16 19:41:03.529741 :B2E3ABC6: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-07-16 19:51:04.422332 :B2E473DB:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-16 19:51:04.770700 :B2E47416:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-16 19:51:04.766 2025-07-16 19:51:04.770703 :B2E47417:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=10992 pso_num=22 pso_serial#=138 2025-07-16 19:51:04.770847 :B2E47418:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=10992 osp_idx=0 osp_ver=413310 osp_pg=0 (spawn #392203) 2025-07-16 19:51:04.770847 :B2E47419:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-16 19:51:04.770848 :B2E4741A:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=53 time=1376240658 2025-07-16 19:51:04.770848 :B2E4741B:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-16 19:51:04.770849 :B2E4741C:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-16 19:51:04.770849 :B2E4741D:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-16 19:51:04.770849 :B2E4741E:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-16 19:51:04.770850 :B2E4741F:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-16 19:51:04.771356 :B2E47420: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-07-16 19:51:04.771401 :B2E47429: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-07-16 20:01:05.720701 :B2E53DAA:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-16 20:01:06.147355 :B2E53DE4:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-16 20:01:06.143 2025-07-16 20:01:06.147357 :B2E53DE5:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=13400 pso_num=22 pso_serial#=139 2025-07-16 20:01:06.147532 :B2E53DE6:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=13400 osp_idx=0 osp_ver=413311 osp_pg=0 (spawn #392228) 2025-07-16 20:01:06.147533 :B2E53DE7:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-16 20:01:06.147533 :B2E53DE8:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=54 time=1376842048 2025-07-16 20:01:06.147534 :B2E53DE9:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-16 20:01:06.147534 :B2E53DEA:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-16 20:01:06.147534 :B2E53DEB:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-16 20:01:06.147535 :B2E53DEC:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-16 20:01:06.147535 :B2E53DED:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-16 20:01:06.148043 :B2E53DEE: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-07-16 20:01:06.148090 :B2E53DF6: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-07-16 20:11:07.043084 :B2E60C72:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-16 20:11:07.500924 :B2E60CBA:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-16 20:11:07.496 2025-07-16 20:11:07.500925 :B2E60CBB:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=13816 pso_num=22 pso_serial#=140 2025-07-16 20:11:07.501056 :B2E60CBC:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=13816 osp_idx=0 osp_ver=413312 osp_pg=0 (spawn #392252) 2025-07-16 20:11:07.501056 :B2E60CBD:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-16 20:11:07.501056 :B2E60CBE:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=55 time=1377443392 2025-07-16 20:11:07.501057 :B2E60CBF:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-16 20:11:07.501057 :B2E60CC0:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-16 20:11:07.501057 :B2E60CC1:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-16 20:11:07.501058 :B2E60CC2:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-16 20:11:07.501058 :B2E60CC3:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-16 20:11:07.501599 :B2E60CC4: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-07-16 20:11:07.501644 :B2E60CCD: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-07-16 20:21:08.534939 :B2E6D5E6:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-16 20:21:08.853378 :B2E6D620:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-16 20:21:08.848 2025-07-16 20:21:08.853380 :B2E6D621:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=4660 pso_num=22 pso_serial#=141 2025-07-16 20:21:08.853521 :B2E6D622:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=4660 osp_idx=0 osp_ver=413313 osp_pg=0 (spawn #392274) 2025-07-16 20:21:08.853521 :B2E6D623:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-16 20:21:08.853522 :B2E6D624:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=56 time=1378044751 2025-07-16 20:21:08.853522 :B2E6D625:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-16 20:21:08.853523 :B2E6D626:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-16 20:21:08.853523 :B2E6D627:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-16 20:21:08.853523 :B2E6D628:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-16 20:21:08.853524 :B2E6D629:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-16 20:21:08.854018 :B2E6D62A: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-07-16 20:21:08.854065 :B2E6D631: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-07-16 20:31:09.838530 :B2E79CD3:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-16 20:31:10.234079 :B2E79D13:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-16 20:31:10.229 2025-07-16 20:31:10.234082 :B2E79D14:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16624 pso_num=22 pso_serial#=142 2025-07-16 20:31:10.234264 :B2E79D15:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=16624 osp_idx=0 osp_ver=413314 osp_pg=0 (spawn #392297) 2025-07-16 20:31:10.234265 :B2E79D16:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-16 20:31:10.234265 :B2E79D17:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=57 time=1378646126 2025-07-16 20:31:10.234266 :B2E79D18:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-16 20:31:10.234266 :B2E79D19:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-16 20:31:10.234266 :B2E79D1A:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-16 20:31:10.234267 :B2E79D1B:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-16 20:31:10.234267 :B2E79D1C:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-16 20:31:10.234764 :B2E79D1D: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-07-16 20:31:10.234811 :B2E79D24: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-07-16 20:41:11.172727 :B2E86398:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-16 20:41:11.505596 :B2E863D6:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-16 20:41:11.501 2025-07-16 20:41:11.505598 :B2E863D7:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=14888 pso_num=22 pso_serial#=143 2025-07-16 20:41:11.505734 :B2E863D8:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=14888 osp_idx=0 osp_ver=413315 osp_pg=0 (spawn #392320) 2025-07-16 20:41:11.505735 :B2E863D9:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-16 20:41:11.505735 :B2E863DA:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=58 time=1379247408 2025-07-16 20:41:11.505736 :B2E863DB:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-16 20:41:11.505736 :B2E863DC:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-16 20:41:11.505737 :B2E863DD:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-16 20:41:11.505737 :B2E863DE:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-16 20:41:11.505737 :B2E863DF:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-16 20:41:11.506237 :B2E863E0: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-07-16 20:41:11.506282 :B2E863E8: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-07-16 20:51:12.433370 :B2E92A39:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-16 20:51:12.756587 :B2E92A82:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-16 20:51:12.756 2025-07-16 20:51:12.756589 :B2E92A83:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=7692 pso_num=22 pso_serial#=144 2025-07-16 20:51:12.756724 :B2E92A84:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=7692 osp_idx=0 osp_ver=413316 osp_pg=0 (spawn #392342) 2025-07-16 20:51:12.756724 :B2E92A85:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-16 20:51:12.756725 :B2E92A86:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=59 time=1379848658 2025-07-16 20:51:12.756725 :B2E92A87:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-16 20:51:12.756726 :B2E92A88:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-16 20:51:12.756726 :B2E92A89:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-16 20:51:12.756726 :B2E92A8A:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-16 20:51:12.756727 :B2E92A8B:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-16 20:51:12.757222 :B2E92A8C: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-07-16 20:51:12.757268 :B2E92A95: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-07-16 21:01:13.717569 :B2E9F26F:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-16 21:01:14.034851 :B2E9F2A8:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-16 21:01:14.029 2025-07-16 21:01:14.034853 :B2E9F2A9:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=7468 pso_num=22 pso_serial#=145 2025-07-16 21:01:14.034993 :B2E9F2AA:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=7468 osp_idx=0 osp_ver=413317 osp_pg=0 (spawn #392367) 2025-07-16 21:01:14.034993 :B2E9F2AB:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-16 21:01:14.034994 :B2E9F2AC:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=60 time=1380449923 2025-07-16 21:01:14.034994 :B2E9F2AD:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-16 21:01:14.034994 :B2E9F2AE:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-16 21:01:14.034994 :B2E9F2AF:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-16 21:01:14.034994 :B2E9F2B0:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-16 21:01:14.034995 :B2E9F2B1:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-16 21:01:14.035493 :B2E9F2B2: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-07-16 21:01:14.035538 :B2E9F2BB: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-07-16 21:11:14.979051 :B2EAC1F3:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-16 21:11:15.374351 :B2EAC238:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-16 21:11:15.369 2025-07-16 21:11:15.374353 :B2EAC239:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16492 pso_num=22 pso_serial#=146 2025-07-16 21:11:15.374492 :B2EAC23A:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=16492 osp_idx=0 osp_ver=413318 osp_pg=0 (spawn #392391) 2025-07-16 21:11:15.374493 :B2EAC23B:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-16 21:11:15.374493 :B2EAC23C:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=61 time=1381051267 2025-07-16 21:11:15.374493 :B2EAC23D:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-16 21:11:15.374494 :B2EAC23E:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-16 21:11:15.374494 :B2EAC23F:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-16 21:11:15.374494 :B2EAC240:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-16 21:11:15.374495 :B2EAC241:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-16 21:11:15.374993 :B2EAC242: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-07-16 21:11:15.375041 :B2EAC24A: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-07-16 21:21:16.350644 :B2EB889B:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-16 21:21:16.746044 :B2EB88FB:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-16 21:21:16.741 2025-07-16 21:21:16.746046 :B2EB88FC:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=17140 pso_num=22 pso_serial#=147 2025-07-16 21:21:16.746187 :B2EB88FD:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=17140 osp_idx=0 osp_ver=413319 osp_pg=0 (spawn #392413) 2025-07-16 21:21:16.746187 :B2EB88FE:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-16 21:21:16.746188 :B2EB88FF:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=62 time=1381652642 2025-07-16 21:21:16.746188 :B2EB8900:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-16 21:21:16.746189 :B2EB8901:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-16 21:21:16.746189 :B2EB8902:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-16 21:21:16.746189 :B2EB8903:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-16 21:21:16.746190 :B2EB8904:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-16 21:21:16.746696 :B2EB8905: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-07-16 21:21:16.746741 :B2EB890C: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-07-16 21:31:17.637559 :B2EC5297:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-16 21:31:18.001766 :B2EC52F7:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-16 21:31:17.997 2025-07-16 21:31:18.001768 :B2EC52F8:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=15216 pso_num=22 pso_serial#=148 2025-07-16 21:31:18.001960 :B2EC52F9:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=15216 osp_idx=0 osp_ver=413320 osp_pg=0 (spawn #392436) 2025-07-16 21:31:18.001960 :B2EC52FA:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-16 21:31:18.001961 :B2EC52FB:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=63 time=1382253892 2025-07-16 21:31:18.001961 :B2EC52FC:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-16 21:31:18.001962 :B2EC52FD:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-16 21:31:18.001962 :B2EC52FE:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-16 21:31:18.001963 :B2EC52FF:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-16 21:31:18.001963 :B2EC5300:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-16 21:31:18.002502 :B2EC5301: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-07-16 21:31:18.002550 :B2EC5309: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-07-16 21:41:18.879222 :B2ED18EA:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-16 21:41:19.256939 :B2ED194D:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-16 21:41:19.252 2025-07-16 21:41:19.256942 :B2ED194E:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=12720 pso_num=22 pso_serial#=149 2025-07-16 21:41:19.257075 :B2ED194F:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=12720 osp_idx=0 osp_ver=413321 osp_pg=0 (spawn #392459) 2025-07-16 21:41:19.257076 :B2ED1950:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-16 21:41:19.257077 :B2ED1951:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=64 time=1382855158 2025-07-16 21:41:19.257077 :B2ED1952:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-16 21:41:19.257078 :B2ED1953:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-16 21:41:19.257078 :B2ED1954:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-16 21:41:19.257078 :B2ED1955:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-16 21:41:19.257079 :B2ED1956:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-16 21:41:19.257648 :B2ED1957: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-07-16 21:41:19.257697 :B2ED195F: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-07-16 21:45:03.322594 :B2ED6379: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-07-16 21:51:20.572394 :B2EDE082: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 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 22 (osid: 12720, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de