Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250520220006\orcl_j000_12524_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250520220006\orcl_j000_12524_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:37355M/63366M, Ph+PgF:44492M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 24 Windows thread id: 12524, image: ORACLE.EXE (J000) *** 2025-05-20 22:00:06.084 *** SESSION ID:(193.31299) 2025-05-20 22:00:06.084 *** 2025-05-20 22:00:06.084 Process diagnostic dump for ORACLE.EXE (J000), OS id=12524, pid: 24, proc_ser: 161, sid: 193, sess_ser: 31299 ------------------------------------------------------------------------------- current sql: <none> client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 12524 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J000) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=4 seq_num=5 snap_id=1 wait times: snap=0.077201 sec, exc=0.077201 sec, total=0.077201 sec wait times: max=0.500000 sec, heur=2.074201 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=3 seq_num=4 snap_id=1 wait times: snap=0.499993 sec, exc=0.499993 sec, total=0.499993 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000014 sec of elapsed time 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=2 seq_num=3 snap_id=1 wait times: snap=0.500003 sec, exc=0.500003 sec, total=0.500003 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000013 sec of elapsed time 2: 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.000006 sec of elapsed time 3: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=0 seq_num=1 snap_id=1 wait times: snap=0.496956 sec, exc=0.496956 sec, total=0.496956 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 193 serial 31299 --------------------------------------------------- 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 --------------------------------------------------- [3 samples, 22:00:04 - 22:00:06] idle wait at each sample [session created at: 22:00:04] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-05-20 22:00:06.084 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 24 (osid: 12524, J000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-20 21:57:34.715190 :99CC5213:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-20 21:57:34.715191 :99CC5214:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=31 time=754064579 2025-05-20 21:57:34.715191 :99CC5215:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-05-20 21:57:34.715191 :99CC5216:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-05-20 21:57:34.715192 :99CC5217:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-05-20 21:57:34.715192 :99CC5218:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-20 21:57:34.715193 :99CC5219:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-20 21:57:34.715698 :99CC521A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-20 21:57:34.716364 :99CC522F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-20 21:57:34.723903 :99CC524B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-20 21:57:34.724279 :99CC524C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-20 21:57:34.724315 :99CC524F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-20 21:57:34.725189 :99CC5255:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-20 21:57:34.725309 :99CC525E:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-20 21:58:04.825134 :99CC5C3A:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-20 21:58:09.485310 :99CC5DA6:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-20 21:58:09.475 2025-05-20 21:58:09.485312 :99CC5DA7:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=13556 pso_num=24 pso_serial#=147 2025-05-20 21:58:09.485454 :99CC5DA8:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=13556 (legacy spawn) 2025-05-20 21:58:09.491933 :99CC5DA9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-20 21:58:09.492105 :99CC5DB2:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-20 21:58:09.492914 :99CC5DB3:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-20 21:58:09.501734 :99CC5DB6:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-20 21:58:09.491 2025-05-20 21:58:09.501735 :99CC5DB7:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=12832 pso_num=24 pso_serial#=148 2025-05-20 21:58:09.501877 :99CC5DB8:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=12832 (legacy spawn) 2025-05-20 21:58:09.508411 :99CC5DB9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-20 21:58:09.508572 :99CC5DC2:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-20 21:58:09.509398 :99CC5DC3:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-20 21:58:12.722741 :99CC5EC0:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-20 21:58:12.714 2025-05-20 21:58:12.722742 :99CC5EC1:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=13420 pso_num=24 pso_serial#=149 2025-05-20 21:58:12.722879 :99CC5EC2:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=13420 (legacy spawn) 2025-05-20 21:58:12.729287 :99CC5EC3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-20 21:58:12.729453 :99CC5EC8:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-20 21:58:12.730319 :99CC5ECD:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-20 21:58:12.738859 :99CC5ED0:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-20 21:58:12.730 2025-05-20 21:58:12.738861 :99CC5ED1:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=13916 pso_num=24 pso_serial#=150 2025-05-20 21:58:12.738996 :99CC5ED2:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=13916 (legacy spawn) 2025-05-20 21:58:12.745409 :99CC5ED3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-20 21:58:12.745590 :99CC5EDB:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-20 21:58:12.746391 :99CC5EDD:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-20 21:58:13.754828 :99CC5F47:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-20 21:58:13.745 2025-05-20 21:58:13.754830 :99CC5F48:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=13800 pso_num=24 pso_serial#=151 2025-05-20 21:58:13.754968 :99CC5F49:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=13800 (legacy spawn) 2025-05-20 21:58:13.761451 :99CC5F4A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-20 21:58:13.761620 :99CC5F4F:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-20 21:58:13.762436 :99CC5F54:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-20 21:58:19.094590 :99CC612C:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-20 21:58:19.086 2025-05-20 21:58:19.094592 :99CC612D:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=12800 pso_num=24 pso_serial#=152 2025-05-20 21:58:19.094736 :99CC612E:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=12800 (legacy spawn) 2025-05-20 21:58:19.101253 :99CC612F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-20 21:58:19.101425 :99CC6134:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-20 21:58:19.102306 :99CC6139:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-20 21:58:20.045115 :99CC617B:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-20 21:58:20.040 2025-05-20 21:58:20.045117 :99CC617C:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=6028 pso_num=24 pso_serial#=153 2025-05-20 21:58:20.045248 :99CC617D:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=6028 osp_idx=22 osp_ver=296717 osp_pg=0 (spawn #202499) 2025-05-20 21:58:20.045248 :99CC617E:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-20 21:58:20.045249 :99CC617F:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=32 time=754109907 2025-05-20 21:58:20.045249 :99CC6180:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-05-20 21:58:20.045249 :99CC6181:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-05-20 21:58:20.045250 :99CC6182:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-05-20 21:58:20.045250 :99CC6183:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-20 21:58:20.045250 :99CC6184:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-20 21:58:20.045788 :99CC6185:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-20 21:58:20.045836 :99CC618B:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-20 21:58:20.065560 :99CC61F7:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-20 21:58:34.813387 :99CC667B:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-20 21:58:34.807 2025-05-20 21:58:34.813388 :99CC667C:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=11548 pso_num=24 pso_serial#=154 2025-05-20 21:58:34.813525 :99CC667D:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=11548 osp_idx=22 osp_ver=296718 osp_pg=0 (spawn #202501) 2025-05-20 21:58:34.813525 :99CC667E:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-20 21:58:34.813526 :99CC667F:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=33 time=754124688 2025-05-20 21:58:34.813526 :99CC6680:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-05-20 21:58:34.813527 :99CC6681:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-05-20 21:58:34.813527 :99CC6682:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-05-20 21:58:34.813528 :99CC6683:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-20 21:58:34.813528 :99CC6684:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-20 21:58:34.814008 :99CC6685:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-20 21:58:34.814718 :99CC669A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-20 21:58:34.825734 :99CC66B7:db_trace:kwqid.c@2146:kwqidrdq(): [10960:24:193] kwqidrdq: Error: 1403 occured in OCI execute 2025-05-20 21:58:34.826234 :99CC66B8:db_trace:kwqid.c@2146:kwqidrdq(): [10960:24:193] kwqidrdq: Error: 1403 occured in OCI execute 2025-05-20 21:58:34.828532 :99CC66B9:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-20 21:58:34.828880 :99CC66BA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-20 21:58:34.828915 :99CC66BD:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-20 21:58:34.829773 :99CC66C3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-20 21:58:34.829911 :99CC66CC:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-20 21:59:04.925252 :99CC7041:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-20 21:59:21.300092 :99CC7550:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-20 21:59:21.292 2025-05-20 21:59:21.300094 :99CC7551:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=13500 pso_num=24 pso_serial#=155 2025-05-20 21:59:21.300235 :99CC7552:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=13500 (legacy spawn) 2025-05-20 21:59:21.306786 :99CC7553:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-20 21:59:21.306953 :99CC755C:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-20 21:59:21.307783 :99CC755D:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-20 21:59:22.144533 :99CC758B:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-20 21:59:22.136 2025-05-20 21:59:22.144536 :99CC758C:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=13712 pso_num=24 pso_serial#=156 2025-05-20 21:59:22.144675 :99CC758D:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=13712 (legacy spawn) 2025-05-20 21:59:22.151202 :99CC758E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-20 21:59:22.151370 :99CC7593:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-20 21:59:22.152181 :99CC7598:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-20 21:59:22.212456 :99CC759B:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-20 21:59:22.198 2025-05-20 21:59:22.212458 :99CC759C:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=11320 pso_num=24 pso_serial#=157 2025-05-20 21:59:22.212599 :99CC759D:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=11320 (legacy spawn) 2025-05-20 21:59:22.219025 :99CC759E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-20 21:59:22.219216 :99CC75A7:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-20 21:59:22.220051 :99CC75A8:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-20 21:59:22.228644 :99CC75AB:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-20 21:59:22.214 2025-05-20 21:59:22.228646 :99CC75AC:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=3352 pso_num=24 pso_serial#=158 2025-05-20 21:59:22.228783 :99CC75AD:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=3352 (legacy spawn) 2025-05-20 21:59:22.235265 :99CC75AE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-20 21:59:22.235422 :99CC75B6:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-20 21:59:22.236204 :99CC75B8:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-20 21:59:25.422617 :99CC76E4:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-20 21:59:25.415 2025-05-20 21:59:25.422619 :99CC76E5:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=12820 pso_num=24 pso_serial#=159 2025-05-20 21:59:25.422751 :99CC76E6:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=12820 (legacy spawn) 2025-05-20 21:59:25.429189 :99CC76E7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-20 21:59:25.429358 :99CC76EE:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-20 21:59:25.430133 :99CC76F1:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-20 21:59:25.438801 :99CC76F4:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-20 21:59:25.431 2025-05-20 21:59:25.438804 :99CC76F5:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=13264 pso_num=24 pso_serial#=160 2025-05-20 21:59:25.438937 :99CC76F6:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=13264 (legacy spawn) 2025-05-20 21:59:25.445408 :99CC76F7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-20 21:59:25.445572 :99CC7700:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-20 21:59:25.446359 :99CC7701:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-20 21:59:34.909181 :99CC79D0:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-20 21:59:34.903 2025-05-20 21:59:34.909184 :99CC79D1:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=12524 pso_num=24 pso_serial#=161 2025-05-20 21:59:34.909317 :99CC79D2:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=12524 osp_idx=22 osp_ver=296725 osp_pg=0 (spawn #202503) 2025-05-20 21:59:34.909317 :99CC79D3:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-20 21:59:34.909318 :99CC79D4:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=34 time=754184782 2025-05-20 21:59:34.909319 :99CC79D5:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-05-20 21:59:34.909319 :99CC79D6:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-05-20 21:59:34.909319 :99CC79D7:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-05-20 21:59:34.909320 :99CC79D8:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-20 21:59:34.909320 :99CC79D9:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-20 21:59:34.909852 :99CC79DA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-20 21:59:34.910500 :99CC79EF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-20 21:59:34.917892 :99CC7A0B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-05-20 21:59:34.918315 :99CC7A0C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-20 21:59:34.918351 :99CC7A0F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-05-20 21:59:34.919217 :99CC7A15:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-20 21:59:34.919354 :99CC7A1E:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-20 22:00:02.195083 :99CC841F:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=59 loc='kkj.h LINE:914 ID:kkjpstnp' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-20 22:00:02.195083*:99CC8432:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000002495C718 estart=1747749601 eid=16780801 ctx=0x000000077FD6A000 cwh=0x0000000024950068 cpu=0 buffg=1 interb=0 r=0 rb=0 w=0 wb=0 2025-05-20 22:00:02.195083*:99CC8433:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000002495C718 curCtx=0x0000000024958938 pubTabIdxCnt=0 2025-05-20 22:00:02.195083*:99CC8434:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000002495C718 2025-05-20 22:00:02.195083*:99CC8435:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000002495C718 2025-05-20 22:00:02.195083*:99CC8438:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000002495C718 curCtx=0x0000000024958938 xsc->flg4=65792 flags=2 2025-05-20 22:00:02.195083*:99CC8439:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000002495C718 2025-05-20 22:00:02.201328 :99CC8447:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='kcrf.h LINE:3299 ID:kcrfw_redo_gen: wake LGWR after redo copy' id1=0 id2=0 name= type=0 2025-05-20 22:00:02.201370 :99CC844A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:jslv.c:9203 2025-05-20 22:00:02.213151 :99CC85F1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-20 22:00:02.218345 :99CC8619:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-20 22:00:02.219110 :99CC8636:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-20 22:00:02.225408 :99CC866A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-05-20 22:00:02.225555 :99CC8679:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-20 22:00:02.226414 :99CC8681:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-20 22:00:02.226631 :99CC8689:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:jslv.c:9203 2025-05-20 22:00:02.228267 :99CC868A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-20 22:00:02.228313 :99CC868D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 2025-05-20 22:00:02.228423 :99CC869A:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-20 22:00:02.320024 :99CC8768:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=59 loc='kkj.h LINE:914 ID:kkjpstnp' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-20 22:00:02.322136 :99CC876B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-20 22:00:02.322175 :99CC876E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:jslv.c:9203 2025-05-20 22:00:02.324706 :99CC8774:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:jslv.c:9203 2025-05-20 22:00:02.328046 :99CC8775:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-20 22:00:02.328132 :99CC8778:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 2025-05-20 22:00:02.328216 :99CC8785:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-20 22:00:04.012341 :99CC8ABC:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=59 loc='kkj.h LINE:914 ID:kkjpstnp' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-20 22:00:04.012341*:99CC8AC5:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000002495C718 estart=1747749603 eid=16780806 ctx=0x000000077FD6A000 cwh=0x0000000024950068 cpu=0 buffg=1 interb=0 r=0 rb=0 w=0 wb=0 2025-05-20 22:00:04.012341*:99CC8AC6:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000002495C718 curCtx=0x0000000024958938 pubTabIdxCnt=0 2025-05-20 22:00:04.012341*:99CC8AC7:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000002495C718 2025-05-20 22:00:04.012341*:99CC8AC8:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000002495C718 2025-05-20 22:00:04.012341*:99CC8AC9:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000002495C718 curCtx=0x0000000024958938 xsc->flg4=65792 flags=2 2025-05-20 22:00:04.012341*:99CC8ACA:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000002495C718 2025-05-20 22:00:04.014471 :99CC8ACB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-20 22:00:04.014505 :99CC8ACE:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:jslv.c:9203 2025-05-20 22:00:04.020907 :99CC8AD4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-20 22:00:04.021580 :99CC8ADC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-20 22:00:04.022262 :99CC8AE4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-20 22:00:04.022473 :99CC8AEC:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:jslv.c:9203 2025-05-20 22:00:04.024092 :99CC8AED:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-20 22:00:04.024141 :99CC8AF0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 2025-05-20 22:00:04.024244 :99CC8AFD:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 24 (osid: 12524, J000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de