Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250615100758\orcl_j002_14524_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:36625M/63366M, Ph+PgF:43076M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 27 Windows thread id: 14524, image: ORACLE.EXE (J002) *** 2025-06-15 10:07:58.919 *** SESSION ID:(219.11919) 2025-06-15 10:07:58.919 *** 2025-06-15 10:07:58.919 Process diagnostic dump for ORACLE.EXE (J002), OS id=14524, pid: 27, proc_ser: 45, sid: 219, sess_ser: 11919 ------------------------------------------------------------------------------- current sql: client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 14524 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J002) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=13 seq_num=14 snap_id=1 wait times: snap=0.271781 sec, exc=0.271781 sec, total=0.271781 sec wait times: max=0.500000 sec, heur=6.768834 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.000010 sec since current wait 0: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=12 seq_num=13 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.000010 sec of elapsed time 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=11 seq_num=12 snap_id=1 wait times: snap=0.499995 sec, exc=0.499995 sec, total=0.499995 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 sec of elapsed time 2: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=10 seq_num=11 snap_id=1 wait times: snap=0.499996 sec, exc=0.499996 sec, total=0.499996 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000012 sec of elapsed time 3: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=9 seq_num=10 snap_id=1 wait times: snap=0.499999 sec, exc=0.499999 sec, total=0.499999 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000010 sec of elapsed time 4: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=8 seq_num=9 snap_id=1 wait times: snap=0.499995 sec, exc=0.499995 sec, total=0.499995 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 sec of elapsed time 5: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=7 seq_num=8 snap_id=1 wait times: snap=0.503188 sec, exc=0.503188 sec, total=0.503188 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000013 sec of elapsed time 6: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=6 seq_num=7 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 7: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=5 seq_num=6 snap_id=1 wait times: snap=0.499995 sec, exc=0.499995 sec, total=0.499995 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 sec of elapsed time 8: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=4 seq_num=5 snap_id=1 wait times: snap=0.499991 sec, exc=0.499991 sec, total=0.499991 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000013 sec of elapsed time 9: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=3 seq_num=4 snap_id=1 wait times: snap=0.499986 sec, exc=0.499986 sec, total=0.499986 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000012 sec of elapsed time Sampled Session History of session 219 serial 11919 --------------------------------------------------- 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 --------------------------------------------------- [7 samples, 10:07:52 - 10:07:58] idle wait at each sample [session created at: 10:07:52] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-06-15 10:07:58.919 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 27 (osid: 14524, J002) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-06-15 10:03:37.410297 :A4F705DB:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=16884 (legacy spawn) 2025-06-15 10:03:37.416694 :A4F705DC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 10:03:37.416886 :A4F705E4:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 10:03:37.417704 :A4F705E6:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 10:03:37.426289 :A4F705E9:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 10:03:37.411 2025-06-15 10:03:37.426291 :A4F705EA:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=15536 pso_num=27 pso_serial#=18 2025-06-15 10:03:37.426429 :A4F705EB:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=15536 (legacy spawn) 2025-06-15 10:03:37.432847 :A4F705EC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 10:03:37.433011 :A4F705F5:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 10:03:37.433827 :A4F705F6:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 10:03:40.513130 :A4F706EE:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 10:03:40.499 2025-06-15 10:03:40.513132 :A4F706EF:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=15480 pso_num=27 pso_serial#=19 2025-06-15 10:03:40.513271 :A4F706F0:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=15480 (legacy spawn) 2025-06-15 10:03:40.519865 :A4F706F1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 10:03:40.520035 :A4F706F9:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 10:03:40.520858 :A4F706FB:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 10:03:40.529708 :A4F706FE:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 10:03:40.515 2025-06-15 10:03:40.529711 :A4F706FF:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=16120 pso_num=27 pso_serial#=20 2025-06-15 10:03:40.529857 :A4F70700:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=16120 (legacy spawn) 2025-06-15 10:03:40.536540 :A4F70701:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 10:03:40.536715 :A4F7070A:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 10:03:40.537561 :A4F7070B:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 10:03:42.533562 :A4F707D8:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 10:03:42.525 2025-06-15 10:03:42.533564 :A4F707D9:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=17348 pso_num=27 pso_serial#=21 2025-06-15 10:03:42.533702 :A4F707DA:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=17348 (legacy spawn) 2025-06-15 10:03:42.540182 :A4F707DB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 10:03:42.540212 :A4F707DE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 10:03:42.540362 :A4F707E1:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 10:03:42.541207 :A4F707F2:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 10:04:16.833675 :A4F71325:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 10:04:16.820 2025-06-15 10:04:16.833677 :A4F71326:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=17252 pso_num=27 pso_serial#=22 2025-06-15 10:04:16.833810 :A4F71327:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=17252 (legacy spawn) 2025-06-15 10:04:16.840309 :A4F71328:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 10:04:16.840491 :A4F71331:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 10:04:16.841284 :A4F71332:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 10:04:16.849886 :A4F71335:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 10:04:16.835 2025-06-15 10:04:16.849888 :A4F71336:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=15704 pso_num=27 pso_serial#=23 2025-06-15 10:04:16.850021 :A4F71337:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=15704 (legacy spawn) 2025-06-15 10:04:16.856489 :A4F71338:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 10:04:16.856659 :A4F7133E:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 10:04:16.857444 :A4F71342:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 10:04:21.796367 :A4F71500:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 10:04:21.783 2025-06-15 10:04:21.796369 :A4F71501:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=13176 pso_num=27 pso_serial#=24 2025-06-15 10:04:21.796505 :A4F71502:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=13176 (legacy spawn) 2025-06-15 10:04:21.803003 :A4F71503:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 10:04:21.803181 :A4F71508:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 10:04:21.803977 :A4F7150D:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 10:04:22.152625 :A4F7151C:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 10:04:22.142 2025-06-15 10:04:22.152627 :A4F7151D:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=16676 pso_num=27 pso_serial#=25 2025-06-15 10:04:22.152762 :A4F7151E:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=16676 (legacy spawn) 2025-06-15 10:04:22.159347 :A4F7151F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 10:04:22.159505 :A4F71528:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 10:04:22.160370 :A4F71529:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 10:04:22.162554 :A4F7152C:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 10:04:22.158 2025-06-15 10:04:22.162555 :A4F7152D:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=13792 pso_num=27 pso_serial#=26 2025-06-15 10:04:22.162682 :A4F7152E:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=13792 (legacy spawn) 2025-06-15 10:04:22.169168 :A4F7152F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 10:04:22.169331 :A4F71538:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 10:04:22.170105 :A4F71539:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 10:04:26.360500 :A4F716AD:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 10:04:26.352 2025-06-15 10:04:26.360502 :A4F716AE:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=15476 pso_num=27 pso_serial#=27 2025-06-15 10:04:26.360648 :A4F716AF:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=15476 (legacy spawn) 2025-06-15 10:04:26.367084 :A4F716B0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 10:04:26.367249 :A4F716B9:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 10:04:26.368072 :A4F716BA:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 10:05:15.765916 :A4F72734:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 10:05:15.757 2025-06-15 10:05:15.765918 :A4F72735:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=17112 pso_num=27 pso_serial#=28 2025-06-15 10:05:15.766066 :A4F72736:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=17112 (legacy spawn) 2025-06-15 10:05:15.772910 :A4F72737:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 10:05:15.773095 :A4F7273C:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 10:05:15.773984 :A4F72741:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 10:05:26.519799 :A4F72BC4:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 10:05:26.505 2025-06-15 10:05:26.519800 :A4F72BC5:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=2472 pso_num=27 pso_serial#=29 2025-06-15 10:05:26.519937 :A4F72BC6:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=2472 (legacy spawn) 2025-06-15 10:05:26.538232 :A4F72BC7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 10:05:26.538407 :A4F72BD0:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 10:05:26.539248 :A4F72BD1:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 10:05:26.547898 :A4F72BD4:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 10:05:26.537 2025-06-15 10:05:26.547900 :A4F72BD5:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=16724 pso_num=27 pso_serial#=30 2025-06-15 10:05:26.548030 :A4F72BD6:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=16724 (legacy spawn) 2025-06-15 10:05:26.554491 :A4F72BD7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 10:05:26.554649 :A4F72BE0:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 10:05:26.555423 :A4F72BE1:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 10:05:29.591675 :A4F72CDD:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 10:05:29.578 2025-06-15 10:05:29.591677 :A4F72CDE:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=17188 pso_num=27 pso_serial#=31 2025-06-15 10:05:29.591813 :A4F72CDF:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=17188 (legacy spawn) 2025-06-15 10:05:29.598348 :A4F72CE0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 10:05:29.598524 :A4F72CE6:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 10:05:29.599329 :A4F72CEA:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 10:05:29.607975 :A4F72CED:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 10:05:29.594 2025-06-15 10:05:29.607977 :A4F72CEE:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=9964 pso_num=27 pso_serial#=32 2025-06-15 10:05:29.608114 :A4F72CEF:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=9964 (legacy spawn) 2025-06-15 10:05:29.614791 :A4F72CF0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 10:05:29.614952 :A4F72CF9:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 10:05:29.615764 :A4F72CFA:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 10:05:30.525018 :A4F72D38:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 10:05:30.515 2025-06-15 10:05:30.525019 :A4F72D39:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=1112 pso_num=27 pso_serial#=33 2025-06-15 10:05:30.525161 :A4F72D3A:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=1112 (legacy spawn) 2025-06-15 10:05:30.549892 :A4F72D3B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 10:05:30.550072 :A4F72D40:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 10:05:30.550872 :A4F72D45:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 10:06:17.934119 :A4F742C3:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 10:06:17.925 2025-06-15 10:06:17.934121 :A4F742C4:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=15092 pso_num=27 pso_serial#=34 2025-06-15 10:06:17.934259 :A4F742C5:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=15092 (legacy spawn) 2025-06-15 10:06:17.940732 :A4F742C6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 10:06:17.940909 :A4F742CD:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 10:06:17.941754 :A4F742D0:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 10:06:38.480521 :A4F74907:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 10:06:38.472 2025-06-15 10:06:38.480523 :A4F74908:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=16896 pso_num=27 pso_serial#=35 2025-06-15 10:06:38.480662 :A4F74909:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=16896 (legacy spawn) 2025-06-15 10:06:38.487097 :A4F7490A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 10:06:38.487452 :A4F74917:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 10:06:38.488370 :A4F74920:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 10:06:39.283019 :A4F74995:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 10:06:39.268 2025-06-15 10:06:39.283021 :A4F74996:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=16932 pso_num=27 pso_serial#=36 2025-06-15 10:06:39.283156 :A4F74997:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=16932 (legacy spawn) 2025-06-15 10:06:39.289671 :A4F749B3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 10:06:39.289854 :A4F749BC:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 10:06:39.290699 :A4F749BD:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 10:06:39.299267 :A4F749C0:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 10:06:39.284 2025-06-15 10:06:39.299268 :A4F749C1:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=15468 pso_num=27 pso_serial#=37 2025-06-15 10:06:39.299408 :A4F749C2:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=15468 (legacy spawn) 2025-06-15 10:06:39.305848 :A4F749C3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 10:06:39.306009 :A4F749C8:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 10:06:39.306784 :A4F749CD:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 10:06:42.438913 :A4F74AC5:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 10:06:42.426 2025-06-15 10:06:42.438915 :A4F74AC6:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=13948 pso_num=27 pso_serial#=38 2025-06-15 10:06:42.439052 :A4F74AC7:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=13948 (legacy spawn) 2025-06-15 10:06:42.445658 :A4F74AC8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 10:06:42.445834 :A4F74ACD:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 10:06:42.446673 :A4F74AD2:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 10:06:42.455340 :A4F74AD5:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 10:06:42.441 2025-06-15 10:06:42.455342 :A4F74AD6:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=16132 pso_num=27 pso_serial#=39 2025-06-15 10:06:42.455479 :A4F74AD7:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=16132 (legacy spawn) 2025-06-15 10:06:42.461960 :A4F74AD8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 10:06:42.462129 :A4F74AE1:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 10:06:42.462964 :A4F74AE2:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 10:07:15.511565 :A4F755BC:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 10:07:15.497 2025-06-15 10:07:15.511567 :A4F755BD:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=16804 pso_num=27 pso_serial#=40 2025-06-15 10:07:15.511709 :A4F755BE:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=16804 (legacy spawn) 2025-06-15 10:07:15.518145 :A4F755BF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 10:07:15.518324 :A4F755C4:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 10:07:15.519100 :A4F755C9:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 10:07:15.527775 :A4F755CC:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 10:07:15.513 2025-06-15 10:07:15.527777 :A4F755CD:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=12316 pso_num=27 pso_serial#=41 2025-06-15 10:07:15.527919 :A4F755CE:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=12316 (legacy spawn) 2025-06-15 10:07:15.548656 :A4F755CF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 10:07:15.548816 :A4F755D8:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 10:07:15.549606 :A4F755D9:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 10:07:18.698791 :A4F756D7:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 10:07:18.686 2025-06-15 10:07:18.698793 :A4F756D8:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=13328 pso_num=27 pso_serial#=42 2025-06-15 10:07:18.698935 :A4F756D9:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=13328 (legacy spawn) 2025-06-15 10:07:18.705439 :A4F756DA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 10:07:18.705628 :A4F756DF:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 10:07:18.706422 :A4F756E4:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 10:07:18.715149 :A4F756E7:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 10:07:18.701 2025-06-15 10:07:18.715152 :A4F756E8:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=13888 pso_num=27 pso_serial#=43 2025-06-15 10:07:18.715290 :A4F756E9:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=13888 (legacy spawn) 2025-06-15 10:07:18.721743 :A4F756EA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 10:07:18.721913 :A4F756F3:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 10:07:18.722735 :A4F756F4:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 10:07:20.118418 :A4F75746:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 10:07:20.110 2025-06-15 10:07:20.118420 :A4F75747:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=17068 pso_num=27 pso_serial#=44 2025-06-15 10:07:20.118555 :A4F75748:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=17068 (legacy spawn) 2025-06-15 10:07:20.125017 :A4F75749:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-15 10:07:20.125193 :A4F75752:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-15 10:07:20.125998 :A4F75753:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-15 10:07:52.150267 :A4F76693:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-15 10:07:52.145 2025-06-15 10:07:52.150270 :A4F76694:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=14524 pso_num=27 pso_serial#=45 2025-06-15 10:07:52.150399 :A4F76695:db_trace:kso.c@4093:ksonfy(): [10420:27:0] kso: new process: pid=14524 osp_idx=25 osp_ver=71444 osp_pg=0 (spawn #287520) 2025-06-15 10:07:52.150400 :A4F76696:db_trace:kso.c@4099:ksonfy(): [10420:27:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-15 10:07:52.150401 :A4F76697:db_trace:kso.c@4103:ksonfy(): [10420:27:0] kso: new process: pso_index=27 reservation=195 time=2957815344 2025-06-15 10:07:52.150401 :A4F76698:db_trace:kso.c@4109:ksonfy(): [10420:27:0] kso: spawn diagnostics: queue time=0 secs 2025-06-15 10:07:52.150402 :A4F76699:db_trace:kso.c@4111:ksonfy(): [10420:27:0] kso: spawn diagnostics: fork time=0 secs 2025-06-15 10:07:52.150402 :A4F7669A:db_trace:kso.c@4113:ksonfy(): [10420:27:0] kso: spawn diagnostics: exec time=0 secs 2025-06-15 10:07:52.150403 :A4F7669B:db_trace:kso.c@4115:ksonfy(): [10420:27:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-15 10:07:52.150403 :A4F7669C:db_trace:kso.c@4117:ksonfy(): [10420:27:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-15 10:07:52.150976 :A4F766A1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] 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 27 (osid: 14524, J002)