Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250517220838\orcl_j003_13124_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250517220838\orcl_j003_13124_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:37396M/63366M, Ph+PgF:44633M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 29 Windows thread id: 13124, image: ORACLE.EXE (J003) *** 2025-05-17 22:08:38.704 *** SESSION ID:(233.22345) 2025-05-17 22:08:38.704 *** 2025-05-17 22:08:38.704 Process diagnostic dump for ORACLE.EXE (J003), OS id=13124, pid: 29, proc_ser: 181, sid: 233, sess_ser: 22345 ------------------------------------------------------------------------------- current sql: <none> client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 13124 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J003) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=6 seq_num=7 snap_id=1 wait times: snap=0.368916 sec, exc=0.368916 sec, total=0.368916 sec wait times: max=0.500000 sec, heur=3.362341 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.000008 sec since current wait 0: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=5 seq_num=6 snap_id=1 wait times: snap=0.499997 sec, exc=0.499997 sec, total=0.499997 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000013 sec of elapsed time 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=4 seq_num=5 snap_id=1 wait times: snap=0.499997 sec, exc=0.499997 sec, total=0.499997 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 2: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=3 seq_num=4 snap_id=1 wait times: snap=0.500119 sec, exc=0.500119 sec, total=0.500119 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 3: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=2 seq_num=3 snap_id=1 wait times: snap=0.500007 sec, exc=0.500007 sec, total=0.500007 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000007 sec of elapsed time 4: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=1 seq_num=2 snap_id=1 wait times: snap=0.499998 sec, exc=0.499998 sec, total=0.499998 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000007 sec of elapsed time 5: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=0 seq_num=1 snap_id=1 wait times: snap=0.493256 sec, exc=0.493256 sec, total=0.493256 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 233 serial 22345 --------------------------------------------------- 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 --------------------------------------------------- [4 samples, 22:08:35 - 22:08:38] idle wait at each sample [session created at: 22:08:35] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-05-17 22:08:38.704 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 29 (osid: 13124, J003) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-17 11:32:52.226833 :9843F71F:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-17 11:32:52.213 2025-05-17 11:32:52.226835 :9843F720:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=12636 pso_num=29 pso_serial#=161 2025-05-17 11:32:52.226970 :9843F721:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=12636 (legacy spawn) 2025-05-17 11:32:52.233354 :9843F722:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 11:32:52.233538 :9843F72B:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-17 11:32:52.234342 :9843F72C:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-17 11:32:52.243003 :9843F72F:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-17 11:32:52.229 2025-05-17 11:32:52.243005 :9843F730:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=13976 pso_num=29 pso_serial#=162 2025-05-17 11:32:52.243142 :9843F731:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=13976 (legacy spawn) 2025-05-17 11:32:52.249575 :9843F732:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 11:32:52.249742 :9843F73B:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-17 11:32:52.250547 :9843F73C:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-17 11:32:55.430333 :9843F830:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-17 11:32:55.417 2025-05-17 11:32:55.430336 :9843F831:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=13936 pso_num=29 pso_serial#=163 2025-05-17 11:32:55.430477 :9843F832:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=13936 (legacy spawn) 2025-05-17 11:32:55.436973 :9843F833:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 11:32:55.437003 :9843F836:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 11:32:55.437152 :9843F83D:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-17 11:32:55.437952 :9843F84A:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-17 11:32:55.446433 :9843F84D:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-17 11:32:55.433 2025-05-17 11:32:55.446436 :9843F84E:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=14056 pso_num=29 pso_serial#=164 2025-05-17 11:32:55.446571 :9843F84F:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=14056 (legacy spawn) 2025-05-17 11:32:55.453040 :9843F850:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 11:32:55.453208 :9843F859:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-17 11:32:55.454009 :9843F85A:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-17 13:00:21.262182 :984AC96F:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-17 13:00:21.248 2025-05-17 13:00:21.262183 :984AC970:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=12572 pso_num=29 pso_serial#=165 2025-05-17 13:00:21.262309 :984AC971:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=12572 osp_idx=27 osp_ver=11129 osp_pg=0 (spawn #191250) 2025-05-17 13:00:21.262310 :984AC972:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-17 13:00:21.262310 :984AC973:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=147 time=462631125 2025-05-17 13:00:21.262310 :984AC974:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-17 13:00:21.262311 :984AC975:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-17 13:00:21.262311 :984AC976:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-17 13:00:21.262312 :984AC977:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-17 13:00:21.262312 :984AC978:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-17 13:00:21.262833 :984AC979:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-17 13:00:21.262875 :984AC97F:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=18 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-17 13:00:21.270568 :984AC98D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 13:00:21.271728 :984AC995:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 13:00:21.272313 :984AC99D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 13:00:21.272787 :984AC9A5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 13:00:21.273229 :984AC9AD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 13:00:21.275785 :984AC9B5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 13:00:21.276900 :984AC9BD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 13:00:21.326991 :984AC9C5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 13:00:21.328436 :984AC9CD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 13:00:21.329405 :984AC9D5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 13:00:21.329650 :984AC9DD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 13:00:21.329893 :984AC9E5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 13:00:21.331692 :984AC9ED:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-17 16:00:00.554613 :98590026:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-17 16:00:00.547 2025-05-17 16:00:00.554615 :98590027:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=13716 pso_num=29 pso_serial#=166 2025-05-17 16:00:00.554751 :98590028:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=13716 (legacy spawn) 2025-05-17 16:00:00.561265 :98590029:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 16:00:00.561424 :98590032:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-17 16:00:00.562236 :98590033:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-17 16:00:06.724005 :98590285:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-17 16:00:06.716 2025-05-17 16:00:06.724006 :98590286:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=2472 pso_num=29 pso_serial#=167 2025-05-17 16:00:06.724139 :98590287:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=2472 (legacy spawn) 2025-05-17 16:00:06.730635 :98590288:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 16:00:06.730822 :9859028D:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-17 16:00:06.731648 :98590292:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-17 16:00:09.620871 :9859038D:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-17 16:00:09.606 2025-05-17 16:00:09.620873 :9859038E:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=12612 pso_num=29 pso_serial#=168 2025-05-17 16:00:09.621012 :9859038F:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=12612 (legacy spawn) 2025-05-17 16:00:09.627422 :98590390:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 16:00:09.627597 :98590395:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-17 16:00:09.628379 :9859039A:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-17 16:00:09.636999 :9859039D:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-17 16:00:09.622 2025-05-17 16:00:09.637001 :9859039E:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=12876 pso_num=29 pso_serial#=169 2025-05-17 16:00:09.637139 :9859039F:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=12876 (legacy spawn) 2025-05-17 16:00:09.643585 :985903A0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 16:00:09.643756 :985903A9:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-17 16:00:09.644552 :985903AA:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-17 16:00:12.732011 :98590495:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-17 16:00:12.719 2025-05-17 16:00:12.732013 :98590496:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=10296 pso_num=29 pso_serial#=170 2025-05-17 16:00:12.732150 :98590497:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=10296 (legacy spawn) 2025-05-17 16:00:12.738675 :98590498:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 16:00:12.738851 :9859049D:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-17 16:00:12.739646 :985904A2:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-17 16:00:12.748229 :985904A5:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-17 16:00:12.735 2025-05-17 16:00:12.748231 :985904A6:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=4872 pso_num=29 pso_serial#=171 2025-05-17 16:00:12.748365 :985904A7:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=4872 (legacy spawn) 2025-05-17 16:00:12.754868 :985904A8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 16:00:12.754898 :985904AB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 16:00:12.755051 :985904B2:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-17 16:00:12.755864 :985904BF:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-17 18:08:03.120637 :986352D0:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-17 18:08:03.107 2025-05-17 18:08:03.120639 :986352D1:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=5464 pso_num=29 pso_serial#=172 2025-05-17 18:08:03.120777 :986352D2:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=5464 (legacy spawn) 2025-05-17 18:08:03.127131 :986352D3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 18:08:03.127316 :986352DC:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-17 18:08:03.128085 :986352DD:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-17 18:08:03.136550 :986352E0:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-17 18:08:03.122 2025-05-17 18:08:03.136551 :986352E1:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=11620 pso_num=29 pso_serial#=173 2025-05-17 18:08:03.136673 :986352E2:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=11620 (legacy spawn) 2025-05-17 18:08:03.142973 :986352E3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 18:08:03.143146 :986352EC:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-17 18:08:03.143930 :986352ED:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-17 18:08:06.299619 :98635575:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-17 18:08:06.286 2025-05-17 18:08:06.299621 :98635576:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=14164 pso_num=29 pso_serial#=174 2025-05-17 18:08:06.299760 :98635577:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=14164 (legacy spawn) 2025-05-17 18:08:06.306278 :98635578:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 18:08:06.306436 :98635581:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-17 18:08:06.307226 :98635582:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-17 18:08:06.315826 :98635585:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-17 18:08:06.301 2025-05-17 18:08:06.315828 :98635586:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=12892 pso_num=29 pso_serial#=175 2025-05-17 18:08:06.315965 :98635587:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=12892 (legacy spawn) 2025-05-17 18:08:06.322374 :98635588:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 18:08:06.322532 :98635591:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-17 18:08:06.323319 :98635592:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-17 18:08:09.267618 :986357F5:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-17 18:08:09.259 2025-05-17 18:08:09.267620 :986357F6:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=10576 pso_num=29 pso_serial#=176 2025-05-17 18:08:09.267752 :986357F7:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=10576 (legacy spawn) 2025-05-17 18:08:09.274260 :986357F8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 18:08:09.274421 :986357FD:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-17 18:08:09.275254 :98635802:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-17 22:00:34.908905 :9875D72B:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-17 22:00:34.899 2025-05-17 22:00:34.908908 :9875D72C:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=12436 pso_num=29 pso_serial#=177 2025-05-17 22:00:34.909051 :9875D72D:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=12436 osp_idx=27 osp_ver=11141 osp_pg=0 (spawn #192502) 2025-05-17 22:00:34.909052 :9875D72E:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-17 22:00:34.909052 :9875D72F:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=148 time=495044782 2025-05-17 22:00:34.909053 :9875D730:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-17 22:00:34.909053 :9875D731:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-17 22:00:34.909053 :9875D732:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-17 22:00:34.909054 :9875D733:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-17 22:00:34.909054 :9875D734:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-17 22:00:34.909569 :9875D735:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-17 22:00:34.909612 :9875D73B:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=18 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-17 22:00:34.917305 :9875D749:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 22:00:34.918363 :9875D751:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 22:00:34.918904 :9875D759:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 22:00:34.919352 :9875D761:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 22:00:34.919792 :9875D769:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 22:00:34.922283 :9875D771:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 22:00:34.923356 :9875D779:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 22:00:34.973068 :9875D781:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 22:00:34.974016 :9875D789:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 22:00:34.974260 :9875D791:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 22:00:34.974479 :9875D799:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 22:00:34.976223 :9875D7A1:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-17 22:04:52.863897 :987668F4:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-17 22:04:52.864 2025-05-17 22:04:52.863898 :987668F5:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=14020 pso_num=29 pso_serial#=178 2025-05-17 22:04:52.864057 :987668FC:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=14020 osp_idx=27 osp_ver=11142 osp_pg=0 (spawn #192514) 2025-05-17 22:04:52.864058 :987668FD:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-17 22:04:52.864059 :987668FE:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=149 time=495302719 2025-05-17 22:04:52.864059 :987668FF:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-17 22:04:52.864059 :98766900:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-17 22:04:52.864060 :98766901:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-17 22:04:52.864060 :98766902:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-17 22:04:52.864060 :98766903:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-17 22:04:52.865456 :98766941:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-17 22:04:52.865492 :98766947:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=18 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-17 22:04:52.976098 :98766BD9:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-17 22:04:55.169347 :98766CBC:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-17 22:04:55.155 2025-05-17 22:04:55.169350 :98766CBD:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=13944 pso_num=29 pso_serial#=179 2025-05-17 22:04:55.169510 :98766CBE:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=13944 osp_idx=27 osp_ver=11143 osp_pg=0 (spawn #192516) 2025-05-17 22:04:55.169511 :98766CBF:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-17 22:04:55.169512 :98766CC0:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=150 time=495305032 2025-05-17 22:04:55.169512 :98766CC1:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-17 22:04:55.169512 :98766CC2:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-17 22:04:55.169513 :98766CC3:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-17 22:04:55.169513 :98766CC4:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-17 22:04:55.169513 :98766CC5:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-17 22:04:55.170039 :98766CC6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-17 22:04:55.170091 :98766CCC:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=18 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-17 22:04:56.629867 :98767288:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-17 22:05:02.600524 :987682C6:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-17 22:05:02.592 2025-05-17 22:05:02.600527 :987682C7:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=1880 pso_num=29 pso_serial#=180 2025-05-17 22:05:02.600670 :987682C8:db_trace:kso.c@4070:ksonfy(): [10420:29:0] kso: new process: pid=1880 (legacy spawn) 2025-05-17 22:05:02.607368 :987682C9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-17 22:05:02.607538 :987682CE:db_trace:ksl2.c@12699:ksliwat(): [10005:29:233] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-17 22:05:02.608399 :987682E3:db_trace:kst.c@698:kstpsodel(): [10280:29:0] kst: process state object about to be deleted 2025-05-17 22:08:35.349895 :9876CEFC:db_trace:kst.c@673:kstipg(): [10280:29:0] kst: process state object created on 05-17 22:08:35.344 2025-05-17 22:08:35.349898 :9876CEFD:db_trace:kst.c@679:kstipg(): [10280:29:0] kst: process info: ospid=13124 pso_num=29 pso_serial#=181 2025-05-17 22:08:35.350011 :9876CEFE:db_trace:kso.c@4093:ksonfy(): [10420:29:0] kso: new process: pid=13124 osp_idx=27 osp_ver=11145 osp_pg=0 (spawn #192530) 2025-05-17 22:08:35.350012 :9876CEFF:db_trace:kso.c@4099:ksonfy(): [10420:29:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-17 22:08:35.350012 :9876CF00:db_trace:kso.c@4103:ksonfy(): [10420:29:0] kso: new process: pso_index=29 reservation=151 time=495525219 2025-05-17 22:08:35.350012 :9876CF01:db_trace:kso.c@4109:ksonfy(): [10420:29:0] kso: spawn diagnostics: queue time=0 secs 2025-05-17 22:08:35.350013 :9876CF02:db_trace:kso.c@4111:ksonfy(): [10420:29:0] kso: spawn diagnostics: fork time=0 secs 2025-05-17 22:08:35.350013 :9876CF03:db_trace:kso.c@4113:ksonfy(): [10420:29:0] kso: spawn diagnostics: exec time=0 secs 2025-05-17 22:08:35.350013 :9876CF04:db_trace:kso.c@4115:ksonfy(): [10420:29:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-17 22:08:35.350014 :9876CF05:db_trace:kso.c@4117:ksonfy(): [10420:29:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-17 22:08:35.350539 :9876CF06:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:29:233] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 29 (osid: 13124, J003)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de