Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250515080242\orcl_j001_10332_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:37388M/63366M, Ph+PgF:44630M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 26 Windows thread id: 10332, image: ORACLE.EXE (J001) *** 2025-05-15 08:02:42.842 *** SESSION ID:(209.18509) 2025-05-15 08:02:42.842 *** 2025-05-15 08:02:42.842 Process diagnostic dump for ORACLE.EXE (J001), OS id=10332, pid: 26, proc_ser: 12, sid: 209, sess_ser: 18509 ------------------------------------------------------------------------------- current sql: client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 10332 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J001) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=1 seq_num=2 snap_id=1 wait times: snap=0.335555 sec, exc=0.335555 sec, total=0.335555 sec wait times: max=0.500000 sec, heur=0.823369 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=0 seq_num=1 snap_id=1 wait times: snap=0.487806 sec, exc=0.487806 sec, total=0.487806 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 209 serial 18509 --------------------------------------------------- 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 --------------------------------------------------- [1 sample, 08:02:42] idle wait at each sample [session created at: 08:02:42] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-05-15 08:02:42.842 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 26 (osid: 10332, J001) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-15 07:59:57.715567 :974F80BA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-15 07:59:57.715743 :974F80BF:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-15 07:59:57.716554 :974F80C4:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-15 07:59:57.725177 :974F80C7:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-15 07:59:57.710 2025-05-15 07:59:57.725179 :974F80C8:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=8880 pso_num=26 pso_serial#=246 2025-05-15 07:59:57.725319 :974F80C9:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=8880 (legacy spawn) 2025-05-15 07:59:57.731792 :974F80CA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-15 07:59:57.731955 :974F80D2:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-15 07:59:57.732739 :974F80D4:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-15 07:59:58.283102 :974F8121:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-15 07:59:58.275 2025-05-15 07:59:58.283104 :974F8122:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=10120 pso_num=26 pso_serial#=247 2025-05-15 07:59:58.283239 :974F8123:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=10120 (legacy spawn) 2025-05-15 07:59:58.307882 :974F8130:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-15 07:59:58.308050 :974F8135:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-15 07:59:58.308921 :974F8139:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-15 08:00:00.808617 :974F81CA:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-15 08:00:00.796 2025-05-15 08:00:00.808618 :974F81CB:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=10436 pso_num=26 pso_serial#=248 2025-05-15 08:00:00.808816 :974F81CC:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=10436 (legacy spawn) 2025-05-15 08:00:00.815270 :974F81E0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-15 08:00:00.815453 :974F81E9:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-15 08:00:00.816244 :974F81EA:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-15 08:00:00.824949 :974F81ED:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-15 08:00:00.811 2025-05-15 08:00:00.824951 :974F81EE:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=11940 pso_num=26 pso_serial#=249 2025-05-15 08:00:00.825091 :974F81EF:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=11940 (legacy spawn) 2025-05-15 08:00:00.831605 :974F81F0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-15 08:00:00.831769 :974F81F7:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-15 08:00:00.832547 :974F81FA:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-15 08:00:09.044745 :974F84B2:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-15 08:00:09.039 2025-05-15 08:00:09.044747 :974F84B3:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=11576 pso_num=26 pso_serial#=250 2025-05-15 08:00:09.044879 :974F84B4:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=11576 osp_idx=24 osp_ver=270294 osp_pg=0 (spawn #183881) 2025-05-15 08:00:09.044880 :974F84B5:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-15 08:00:09.044880 :974F84B6:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=44 time=271818907 2025-05-15 08:00:09.044881 :974F84B7:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-15 08:00:09.044881 :974F84B8:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-15 08:00:09.044881 :974F84B9:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-15 08:00:09.044882 :974F84BA:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-15 08:00:09.044882 :974F84BB:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-15 08:00:09.045440 :974F84BC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-15 08:00:09.045499 :974F84C2:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-15 08:00:09.049654 :974F84D5:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-05-15 08:00:09.049697 :974F84D6:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-05-15 08:00:09.049966 :974F84D7:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-05-15 08:00:09.049982 :974F84D8:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-05-15 08:00:09.050199 :974F84D9:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-05-15 08:00:09.050213 :974F84DA:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-05-15 08:00:09.050429 :974F84E5:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-05-15 08:00:09.050442 :974F84E6:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-05-15 08:00:09.050649 :974F84E7:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-05-15 08:00:09.050662 :974F84E8:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-05-15 08:00:09.050867 :974F84E9:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-05-15 08:00:09.050881 :974F84EB:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-05-15 08:00:09.053236 :974F8507:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-15 08:00:10.441586 :974F85F7:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-15 08:00:10.435 2025-05-15 08:00:10.441588 :974F85F8:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=1880 pso_num=26 pso_serial#=251 2025-05-15 08:00:10.441726 :974F85F9:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=1880 osp_idx=24 osp_ver=270295 osp_pg=0 (spawn #183884) 2025-05-15 08:00:10.441727 :974F85FA:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-15 08:00:10.441728 :974F85FB:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=45 time=271820313 2025-05-15 08:00:10.441728 :974F85FC:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-15 08:00:10.441728 :974F85FD:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-15 08:00:10.441729 :974F85FE:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-15 08:00:10.441729 :974F85FF:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-15 08:00:10.441729 :974F8600:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-15 08:00:10.442222 :974F8601:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-15 08:00:10.442264 :974F8607:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-15 08:00:10.506544 :974F862B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-15 08:00:10.507463 :974F8633:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-15 08:00:10.507703 :974F863B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-15 08:00:10.507918 :974F8643:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-15 08:00:10.509615 :974F864B:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-15 08:00:37.001999 :974F8F47:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-15 08:00:36.989 2025-05-15 08:00:37.002001 :974F8F48:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12820 pso_num=26 pso_serial#=252 2025-05-15 08:00:37.002132 :974F8F49:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=12820 (legacy spawn) 2025-05-15 08:00:37.008508 :974F8F4A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-15 08:00:37.008681 :974F8F53:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-15 08:00:37.009462 :974F8F54:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-15 08:00:37.018093 :974F8F57:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-15 08:00:37.005 2025-05-15 08:00:37.018096 :974F8F58:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=8784 pso_num=26 pso_serial#=253 2025-05-15 08:00:37.018231 :974F8F59:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=8784 (legacy spawn) 2025-05-15 08:00:37.024653 :974F8F5A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-15 08:00:37.024813 :974F8F63:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-15 08:00:37.025602 :974F8F64:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-15 08:00:52.879171 :974F9528:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-15 08:00:52.871 2025-05-15 08:00:52.879173 :974F9529:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12128 pso_num=26 pso_serial#=254 2025-05-15 08:00:52.879310 :974F952A:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=12128 (legacy spawn) 2025-05-15 08:00:52.885759 :974F952B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-15 08:00:52.885933 :974F9534:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-15 08:00:52.886788 :974F9535:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-15 08:00:57.778453 :974F96C0:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-15 08:00:57.770 2025-05-15 08:00:57.778455 :974F96C1:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12640 pso_num=26 pso_serial#=255 2025-05-15 08:00:57.778595 :974F96C2:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=12640 (legacy spawn) 2025-05-15 08:00:57.785145 :974F96C3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-15 08:00:57.785319 :974F96C8:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-15 08:00:57.786114 :974F96CD:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-15 08:01:00.497307 :974F97AB:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-15 08:01:00.489 2025-05-15 08:01:00.497309 :974F97AC:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=11928 pso_num=26 pso_serial#=1 2025-05-15 08:01:00.497449 :974F97AD:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=11928 (legacy spawn) 2025-05-15 08:01:00.503991 :974F97AE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-15 08:01:00.504162 :974F97B3:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-15 08:01:00.505013 :974F97B8:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-15 08:01:10.219554 :974F9ADE:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-15 08:01:10.216 2025-05-15 08:01:10.219556 :974F9ADF:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12756 pso_num=26 pso_serial#=2 2025-05-15 08:01:10.219695 :974F9AE0:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=12756 (legacy spawn) 2025-05-15 08:01:10.226106 :974F9AE1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-15 08:01:10.226273 :974F9AE6:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-15 08:01:10.227067 :974F9AEB:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-15 08:01:10.255153 :974F9AEE:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-15 08:01:10.248 2025-05-15 08:01:10.255155 :974F9AEF:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=11632 pso_num=26 pso_serial#=3 2025-05-15 08:01:10.255291 :974F9AF0:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=11632 (legacy spawn) 2025-05-15 08:01:10.261694 :974F9AF1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-15 08:01:10.261864 :974F9AFA:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-15 08:01:10.262672 :974F9AFB:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-15 08:01:46.420160 :974FA6C8:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-15 08:01:46.406 2025-05-15 08:01:46.420162 :974FA6C9:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12004 pso_num=26 pso_serial#=4 2025-05-15 08:01:46.420292 :974FA6CA:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=12004 (legacy spawn) 2025-05-15 08:01:46.426770 :974FA6CB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-15 08:01:46.426941 :974FA6D0:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-15 08:01:46.427756 :974FA6D5:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-15 08:01:46.436419 :974FA6D8:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-15 08:01:46.421 2025-05-15 08:01:46.436420 :974FA6D9:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12916 pso_num=26 pso_serial#=5 2025-05-15 08:01:46.436555 :974FA6DA:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=12916 (legacy spawn) 2025-05-15 08:01:46.443025 :974FA6DB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-15 08:01:46.443202 :974FA6E3:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-15 08:01:46.443987 :974FA6E5:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-15 08:01:49.642353 :974FA856:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-15 08:01:49.629 2025-05-15 08:01:49.642355 :974FA857:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=6844 pso_num=26 pso_serial#=6 2025-05-15 08:01:49.642499 :974FA858:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=6844 (legacy spawn) 2025-05-15 08:01:49.648973 :974FA859:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-15 08:01:49.649156 :974FA85F:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-15 08:01:49.649948 :974FA863:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-15 08:01:49.658572 :974FA866:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-15 08:01:49.645 2025-05-15 08:01:49.658575 :974FA867:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12876 pso_num=26 pso_serial#=7 2025-05-15 08:01:49.658769 :974FA868:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=12876 (legacy spawn) 2025-05-15 08:01:49.665147 :974FA875:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-15 08:01:49.665322 :974FA87E:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-15 08:01:49.666112 :974FA87F:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-15 08:02:02.688744 :974FAC81:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-15 08:02:02.680 2025-05-15 08:02:02.688746 :974FAC82:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12352 pso_num=26 pso_serial#=8 2025-05-15 08:02:02.688885 :974FAC83:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=12352 (legacy spawn) 2025-05-15 08:02:02.695381 :974FAC84:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-15 08:02:02.695576 :974FAC89:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-15 08:02:02.696441 :974FAC8E:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-15 08:02:06.052403 :974FAD83:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-15 08:02:06.042 2025-05-15 08:02:06.052406 :974FAD84:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12512 pso_num=26 pso_serial#=9 2025-05-15 08:02:06.052539 :974FAD85:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=12512 (legacy spawn) 2025-05-15 08:02:06.075366 :974FAD86:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-15 08:02:06.075552 :974FAD8B:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-15 08:02:06.076412 :974FAD90:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-15 08:02:40.107562 :974FF576:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-15 08:02:40.095 2025-05-15 08:02:40.107565 :974FF577:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=11624 pso_num=26 pso_serial#=10 2025-05-15 08:02:40.108450 :974FF578:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=11624 osp_idx=24 osp_ver=270309 osp_pg=0 (spawn #183891) 2025-05-15 08:02:40.108452 :974FF579:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-15 08:02:40.108452 :974FF57A:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=46 time=271969954 2025-05-15 08:02:40.108453 :974FF57B:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-15 08:02:40.108454 :974FF57C:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-15 08:02:40.108454 :974FF57D:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-15 08:02:40.108455 :974FF57E:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-15 08:02:40.108455 :974FF57F:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-15 08:02:40.111432 :974FF580:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-15 08:02:40.111474 :974FF586:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-15 08:02:40.111879 :974FF587:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-15 08:02:40.152340 :974FF5BA:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-15 08:02:40.142 2025-05-15 08:02:40.152343 :974FF5BB:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12908 pso_num=26 pso_serial#=11 2025-05-15 08:02:40.152480 :974FF5BC:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=12908 (legacy spawn) 2025-05-15 08:02:40.168433 :974FF5BD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-15 08:02:40.168564 :974FF5C6:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-15 08:02:40.169426 :974FF5C7:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-15 08:02:42.025243 :974FF697:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-15 08:02:42.014 2025-05-15 08:02:42.025244 :974FF698:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=10332 pso_num=26 pso_serial#=12 2025-05-15 08:02:42.025391 :974FF699:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=10332 osp_idx=24 osp_ver=270311 osp_pg=0 (spawn #183893) 2025-05-15 08:02:42.025392 :974FF69A:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-15 08:02:42.025393 :974FF69B:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=47 time=271971891 2025-05-15 08:02:42.025393 :974FF69C:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-15 08:02:42.025394 :974FF69D:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-15 08:02:42.025394 :974FF69E:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-15 08:02:42.025394 :974FF69F:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-15 08:02:42.025395 :974FF6A0:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-15 08:02:42.025933 :974FF6A1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] 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 26 (osid: 10332, J001)