Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250513220006\orcl_j005_12760_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250513220006\orcl_j005_12760_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:37408M/63366M, Ph+PgF:44705M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 31 Windows thread id: 12760, image: ORACLE.EXE (J005) *** 2025-05-13 22:00:06.737 *** SESSION ID:(249.661) 2025-05-13 22:00:06.737 *** 2025-05-13 22:00:06.737 Process diagnostic dump for ORACLE.EXE (J005), OS id=12760, pid: 31, proc_ser: 67, sid: 249, sess_ser: 661 ------------------------------------------------------------------------------- current sql: <none> client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 12760 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J005) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=9 seq_num=10 snap_id=1 wait times: snap=0.067760 sec, exc=0.067760 sec, total=0.067760 sec wait times: max=0.500000 sec, heur=4.576282 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.000009 sec since current wait 0: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=8 seq_num=9 snap_id=1 wait times: snap=0.499999 sec, exc=0.499999 sec, total=0.499999 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=7 seq_num=8 snap_id=1 wait times: snap=0.500173 sec, exc=0.500173 sec, total=0.500173 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000011 sec of elapsed time 2: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=6 seq_num=7 snap_id=1 wait times: snap=0.499985 sec, exc=0.499985 sec, total=0.499985 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000015 sec of elapsed time 3: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=5 seq_num=6 snap_id=1 wait times: snap=0.511695 sec, exc=0.511695 sec, total=0.511695 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000014 sec of elapsed time 4: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=4 seq_num=5 snap_id=1 wait times: snap=0.500008 sec, exc=0.500008 sec, total=0.500008 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000007 sec of elapsed time 5: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=3 seq_num=4 snap_id=1 wait times: snap=0.500295 sec, exc=0.500295 sec, total=0.500295 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000010 sec of elapsed time 6: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=2 seq_num=3 snap_id=1 wait times: snap=0.499992 sec, exc=0.499992 sec, total=0.499992 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 7: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=1 seq_num=2 snap_id=1 wait times: snap=0.500006 sec, exc=0.500006 sec, total=0.500006 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 8: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=0 seq_num=1 snap_id=1 wait times: snap=0.496279 sec, exc=0.496279 sec, total=0.496279 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000000 sec of elapsed time Sampled Session History of session 249 serial 661 --------------------------------------------------- The sampled session history is constructed by sampling the target session every 1 second. The sampling process captures at each sample if the session is in a non-idle wait, an idle wait, or not in a wait. If the session is in a non-idle wait then one interval is shown for all the samples the session was in the same non-idle wait. If the session is in an idle wait or not in a wait for consecutive samples then one interval is shown for all the consecutive samples. Though we display these consecutive samples in a single interval the session may NOT be continuously idle or not in a wait (the sampling process does not know). The history is displayed in reverse chronological order. sample interval: 1 sec, max history 120 sec --------------------------------------------------- [5 samples, 22:00:02 - 22:00:06] idle wait at each sample [session created at: 22:00:02] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-05-13 22:00:06.737 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 31 (osid: 12760, J005) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-09 22:00:02.080579 :94F3420E:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-09 22:00:02.080579 :94F3420F:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-09 22:00:02.081101 :94F34221:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-09 22:00:32.153793 :94F3547F:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-05-09 23:59:07.216576 :94FC819A:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 05-09 23:59:07.203 2025-05-09 23:59:07.216578 :94FC819B:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=12616 pso_num=31 pso_serial#=45 2025-05-09 23:59:07.216711 :94FC819C:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=12616 (legacy spawn) 2025-05-09 23:59:07.223161 :94FC819D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-09 23:59:07.223340 :94FC81A2:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-09 23:59:07.224130 :94FC81A7:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-05-09 23:59:07.232739 :94FC81AA:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 05-09 23:59:07.219 2025-05-09 23:59:07.232741 :94FC81AB:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=8228 pso_num=31 pso_serial#=46 2025-05-09 23:59:07.232916 :94FC81AC:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=8228 (legacy spawn) 2025-05-09 23:59:07.239658 :94FC81AD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-09 23:59:07.239831 :94FC81B6:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-09 23:59:07.240685 :94FC81B7:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-05-09 23:59:10.213317 :94FC82BC:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 05-09 23:59:10.199 2025-05-09 23:59:10.213319 :94FC82BD:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=12732 pso_num=31 pso_serial#=47 2025-05-09 23:59:10.213453 :94FC82BE:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=12732 (legacy spawn) 2025-05-09 23:59:10.227432 :94FC82BF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-09 23:59:43.354816 :94FC8ED9:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-05-09 23:59:43.619291 :94FC8EDC:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 05-09 23:59:43.617 2025-05-09 23:59:43.619293 :94FC8EDD:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=10684 pso_num=31 pso_serial#=48 2025-05-09 23:59:43.619429 :94FC8EDE:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=10684 (legacy spawn) 2025-05-09 23:59:43.625843 :94FC8EDF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-09 23:59:43.626013 :94FC8EE8:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-09 23:59:43.626813 :94FC8EE9:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-05-09 23:59:43.635445 :94FC8EEC:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 05-09 23:59:43.633 2025-05-09 23:59:43.635448 :94FC8EED:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=13208 pso_num=31 pso_serial#=49 2025-05-09 23:59:43.635580 :94FC8EEE:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=13208 (legacy spawn) 2025-05-09 23:59:43.653243 :94FC8EEF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-09 23:59:43.653407 :94FC8EF8:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-09 23:59:43.654212 :94FC8EF9:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-05-09 23:59:47.058715 :94FC9020:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 05-09 23:59:47.053 2025-05-09 23:59:47.058717 :94FC9021:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=12440 pso_num=31 pso_serial#=50 2025-05-09 23:59:47.058854 :94FC9022:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=12440 (legacy spawn) 2025-05-09 23:59:47.072755 :94FC9023:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-10 00:00:20.198326 :94FC9B6E:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-05-10 06:00:02.070317 :95189B02:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 05-10 06:00:02.068 2025-05-10 06:00:02.070317 :95189B03:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=11796 pso_num=31 pso_serial#=51 2025-05-10 06:00:02.070455 :95189B0C:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=11796 osp_idx=29 osp_ver=305 osp_pg=0 (spawn #166801) 2025-05-10 06:00:02.070456 :95189B0D:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-10 06:00:02.070456 :95189B0E:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=106 time=4127579218 2025-05-10 06:00:02.070457 :95189B0F:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-05-10 06:00:02.070457 :95189B10:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-05-10 06:00:02.070458 :95189B11:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-05-10 06:00:02.070458 :95189B12:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-10 06:00:02.070459 :95189B13:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-10 06:00:02.071081 :95189B14:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-10 06:00:32.165627 :9518ADC5:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-05-10 23:59:06.906040 :956CB244:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 05-10 23:59:06.898 2025-05-10 23:59:06.906042 :956CB245:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=9288 pso_num=31 pso_serial#=52 2025-05-10 23:59:06.906174 :956CB246:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=9288 (legacy spawn) 2025-05-10 23:59:06.912563 :956CB247:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-10 23:59:06.912737 :956CB24C:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-10 23:59:06.913543 :956CB251:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-05-10 23:59:08.422502 :956CB28B:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 05-10 23:59:08.414 2025-05-10 23:59:08.422505 :956CB28C:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=9452 pso_num=31 pso_serial#=53 2025-05-10 23:59:08.422642 :956CB28D:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=9452 (legacy spawn) 2025-05-10 23:59:08.429289 :956CB28E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-10 23:59:08.429465 :956CB293:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-10 23:59:08.430336 :956CB298:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-05-10 23:59:08.439258 :956CB29B:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 05-10 23:59:08.429 2025-05-10 23:59:08.439260 :956CB29C:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=11376 pso_num=31 pso_serial#=54 2025-05-10 23:59:08.439395 :956CB29D:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=11376 (legacy spawn) 2025-05-10 23:59:08.446078 :956CB29E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-10 23:59:08.446237 :956CB2A7:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-10 23:59:08.447059 :956CB2A8:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-05-10 23:59:10.086960 :956CB377:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 05-10 23:59:10.086 2025-05-10 23:59:10.086962 :956CB378:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=11412 pso_num=31 pso_serial#=55 2025-05-10 23:59:10.087096 :956CB379:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=11412 (legacy spawn) 2025-05-10 23:59:10.101056 :956CB37A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-10 23:59:13.250236 :956CB495:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-10 23:59:13.250267 :956CB498:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-10 23:59:13.250411 :956CB49B:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-10 23:59:13.251760 :956CB4AC:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-05-10 23:59:13.509491 :956CB4BB:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 05-10 23:59:13.510 2025-05-10 23:59:13.509493 :956CB4BC:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=13020 pso_num=31 pso_serial#=56 2025-05-10 23:59:13.509623 :956CB4BD:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=13020 (legacy spawn) 2025-05-10 23:59:13.523580 :956CB4BE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-10 23:59:46.537101 :956CC04A:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-05-10 23:59:46.732890 :956CC04E:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 05-10 23:59:46.722 2025-05-10 23:59:46.732892 :956CC04F:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=3752 pso_num=31 pso_serial#=57 2025-05-10 23:59:46.733038 :956CC050:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=3752 (legacy spawn) 2025-05-10 23:59:46.746917 :956CC051:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-11 00:00:19.784942 :956CCD0F:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-05-11 01:00:12.888939 :957160C1:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 05-11 01:00:12.877 2025-05-11 01:00:12.888941 :957160C2:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=9992 pso_num=31 pso_serial#=58 2025-05-11 01:00:12.889072 :957160C3:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=9992 osp_idx=29 osp_ver=312 osp_pg=0 (spawn #169493) 2025-05-11 01:00:12.889073 :957160C4:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-11 01:00:12.889073 :957160C5:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=107 time=4195990046 2025-05-11 01:00:12.889074 :957160C6:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-05-11 01:00:12.889074 :957160C7:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-05-11 01:00:12.889075 :957160C8:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-05-11 01:00:12.889075 :957160C9:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-11 01:00:12.889075 :957160CA:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-11 01:00:12.889560 :957160CB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-11 01:00:12.889602 :957160D1:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-05-11 01:00:12.896919 :957160DF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-11 01:00:12.897968 :957160E7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-11 01:00:12.898608 :957160EF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-11 01:00:12.899082 :957160F7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-11 01:00:12.899528 :957160FF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-11 01:00:12.901993 :95716107:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-11 01:00:12.903177 :9571610F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-11 01:00:12.952782 :9571612A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-11 01:00:12.953672 :95716132:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-11 01:00:12.953919 :9571613A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-11 01:00:12.954133 :95716142:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-11 01:00:12.955813 :9571614A:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-05-11 06:00:02.076622 :95884789:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 05-11 06:00:02.069 2025-05-11 06:00:02.076623 :9588478A:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=12740 pso_num=31 pso_serial#=59 2025-05-11 06:00:02.076749 :9588478B:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=12740 osp_idx=29 osp_ver=313 osp_pg=0 (spawn #170203) 2025-05-11 06:00:02.076750 :9588478C:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-11 06:00:02.076750 :9588478D:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=108 time=4213979234 2025-05-11 06:00:02.076751 :9588478E:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-05-11 06:00:02.076751 :9588478F:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-05-11 06:00:02.076752 :95884790:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-05-11 06:00:02.076752 :95884791:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-11 06:00:02.076753 :95884792:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-11 06:00:02.077247 :95884793:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-11 06:00:32.179385 :95885B57:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-05-11 08:26:02.278523 :9593E956:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 05-11 08:26:02.269 2025-05-11 08:26:02.278524 :9593E957:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=10416 pso_num=31 pso_serial#=60 2025-05-11 08:26:02.278656 :9593E958:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=10416 osp_idx=29 osp_ver=314 osp_pg=0 (spawn #170555) 2025-05-11 08:26:02.278657 :9593E959:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-11 08:26:02.278658 :9593E95A:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=109 time=4222739437 2025-05-11 08:26:02.278658 :9593E95B:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-05-11 08:26:02.278658 :9593E95C:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-05-11 08:26:02.278659 :9593E95D:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-05-11 08:26:02.278659 :9593E95E:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-11 08:26:02.278659 :9593E95F:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-11 08:26:02.279155 :9593E960:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-11 08:26:02.279192 :9593E967:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] 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-05-11 08:26:02.285463 :9593E974:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-05-11 23:59:09.977591 :95DC5EFC:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 05-11 23:59:09.974 2025-05-11 23:59:09.977593 :95DC5EFD:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=13296 pso_num=31 pso_serial#=61 2025-05-11 23:59:09.977726 :95DC5EFE:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=13296 (legacy spawn) 2025-05-11 23:59:09.992253 :95DC5EFF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-11 23:59:43.265089 :95DC6AC2:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-05-11 23:59:53.223728 :95DC6E2B:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 05-11 23:59:53.214 2025-05-11 23:59:53.223730 :95DC6E2C:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=10888 pso_num=31 pso_serial#=62 2025-05-11 23:59:53.223868 :95DC6E2D:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=10888 (legacy spawn) 2025-05-11 23:59:53.248808 :95DC6E2E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-11 23:59:53.249003 :95DC6E33:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-11 23:59:53.249838 :95DC6E38:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-05-11 23:59:55.478343 :95DC6EE2:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 05-11 23:59:55.464 2025-05-11 23:59:55.478345 :95DC6EE3:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=8180 pso_num=31 pso_serial#=63 2025-05-11 23:59:55.478495 :95DC6EE4:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=8180 (legacy spawn) 2025-05-11 23:59:55.492259 :95DC6EE5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-12 00:00:28.527687 :95DC7D8E:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-05-12 22:00:02.065904 :96425017:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 05-12 22:00:02.064 2025-05-12 22:00:02.065905 :96425018:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=12144 pso_num=31 pso_serial#=64 2025-05-12 22:00:02.066030 :96425019:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=12144 osp_idx=29 osp_ver=318 osp_pg=0 (spawn #175825) 2025-05-12 22:00:02.066031 :9642501A:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-12 22:00:02.066031 :9642501B:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=110 time=63011922 2025-05-12 22:00:02.066032 :9642501C:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-05-12 22:00:02.066032 :9642501D:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-05-12 22:00:02.066033 :9642501E:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-05-12 22:00:02.066033 :9642501F:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-12 22:00:02.066033 :96425020:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-12 22:00:02.066550 :96425032:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-12 22:00:32.163888 :9642653A:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-05-12 23:59:18.450310 :964B7C1E:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 05-12 23:59:18.437 2025-05-12 23:59:18.450312 :964B7C1F:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=12592 pso_num=31 pso_serial#=65 2025-05-12 23:59:18.450448 :964B7C20:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=12592 (legacy spawn) 2025-05-12 23:59:18.464396 :964B7C21:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-12 23:59:51.878088 :964B88C8:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-05-12 23:59:59.750445 :964B8B81:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 05-12 23:59:59.747 2025-05-12 23:59:59.750447 :964B8B82:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=11708 pso_num=31 pso_serial#=66 2025-05-12 23:59:59.750592 :964B8B83:db_trace:kso.c@4070:ksonfy(): [10420:31:0] kso: new process: pid=11708 (legacy spawn) 2025-05-12 23:59:59.764843 :964B8B84:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-13 00:06:19.723840 :964C1299:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-13 00:06:19.724002 :964C12A2:db_trace:ksl2.c@12699:ksliwat(): [10005:31:249] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-13 00:06:19.725288 :964C12A3:db_trace:kst.c@698:kstpsodel(): [10280:31:0] kst: process state object about to be deleted 2025-05-13 22:00:02.165751 :96B13842:db_trace:kst.c@673:kstipg(): [10280:31:0] kst: process state object created on 05-13 22:00:02.162 2025-05-13 22:00:02.165753 :96B13843:db_trace:kst.c@679:kstipg(): [10280:31:0] kst: process info: ospid=12760 pso_num=31 pso_serial#=67 2025-05-13 22:00:02.165873 :96B13844:db_trace:kso.c@4093:ksonfy(): [10420:31:0] kso: new process: pid=12760 osp_idx=29 osp_ver=321 osp_pg=0 (spawn #179159) 2025-05-13 22:00:02.165874 :96B13845:db_trace:kso.c@4099:ksonfy(): [10420:31:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-13 22:00:02.165875 :96B13846:db_trace:kso.c@4103:ksonfy(): [10420:31:0] kso: new process: pso_index=31 reservation=111 time=149412016 2025-05-13 22:00:02.165875 :96B13847:db_trace:kso.c@4109:ksonfy(): [10420:31:0] kso: spawn diagnostics: queue time=0 secs 2025-05-13 22:00:02.165876 :96B13848:db_trace:kso.c@4111:ksonfy(): [10420:31:0] kso: spawn diagnostics: fork time=0 secs 2025-05-13 22:00:02.165876 :96B13849:db_trace:kso.c@4113:ksonfy(): [10420:31:0] kso: spawn diagnostics: exec time=0 secs 2025-05-13 22:00:02.165876 :96B1384A:db_trace:kso.c@4115:ksonfy(): [10420:31:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-13 22:00:02.165877 :96B1384B:db_trace:kso.c@4117:ksonfy(): [10420:31:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-13 22:00:02.166392 :96B1385D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:31:249] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 31 (osid: 12760, J005)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de