0 2 504 sleepq resume: thread 0xc26db6e0 (pid 41, yarrow) 1 2 968 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:546 2 2 532 LOCK (spin mutex) entropy harvest r = 0 at ../../../dev/random/randomdev_soft.c:248 3 2 848 UNLOCK (spin mutex) entropy harvest r = 0 at ../../../dev/random/randomdev_soft.c:262 4 2 432 LOCK (spin mutex) entropy harvest r = 0 at ../../../dev/random/randomdev_soft.c:248 5 2 812 UNLOCK (spin mutex) entropy harvest r = 0 at ../../../dev/random/randomdev_soft.c:262 6 2 428 LOCK (spin mutex) entropy harvest r = 0 at ../../../dev/random/randomdev_soft.c:248 7 2 764 UNLOCK (spin mutex) entropy harvest r = 0 at ../../../dev/random/randomdev_soft.c:262 8 2 432 LOCK (spin mutex) entropy harvest r = 0 at ../../../dev/random/randomdev_soft.c:248 9 2 824 UNLOCK (spin mutex) entropy harvest r = 0 at ../../../dev/random/randomdev_soft.c:262 10 2 444 LOCK (spin mutex) entropy harvest r = 0 at ../../../dev/random/randomdev_soft.c:248 11 2 796 UNLOCK (spin mutex) entropy harvest r = 0 at ../../../dev/random/randomdev_soft.c:262 12 2 436 LOCK (spin mutex) entropy harvest r = 0 at ../../../dev/random/randomdev_soft.c:248 13 2 952 UNLOCK (spin mutex) entropy harvest r = 0 at ../../../dev/random/randomdev_soft.c:262 14 2 668 LOCK (spin mutex) sleepq chain r = 0 at ../../../kern/subr_sleepqueue.c:223 15 2 444 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_synch.c:169 16 2 572 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_synch.c:190 17 2 736 msleep: thread 0xc26db6e0 (pid 41, yarrow) on - (0xc088cd80) 18 2 456 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:297 19 2 804 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:300 20 2 520 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 21 2 768 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 22 2 452 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_synch.c:229 23 2 776 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_synch.c:231 24 2 428 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:407 25 2 2968 UNLOCK (spin mutex) sleepq chain r = 0 at ../../../kern/subr_sleepqueue.c:408 26 2 904 mi_switch: old thread 0xc26db6e0 (kse 0xc2667400, pid 41, yarrow) 27 2 464 mi_switch: new thread 0xc26616e0 (kse 0xc2667d40, pid 12, idle: cpu2) 28 2 17684240 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:110 29 0 6138732 intr_execute_handlers: executing handler 0xc07787fc(0xdb897c98) 30 0 7048 intr_execute_handlers: executing handler 0xc07784bc(0xdb897c98) 31 0 604 swi_sched pid 38(swi5: clock sio) need=0 32 0 716 ithread_schedule: pid 38: (swi5: clock sio) need = 0 33 0 688 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:407 34 0 1784 ithread_schedule: setrunqueue 38 35 0 2112 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:416 36 0 2604 LOCK (spin mutex) icu r = 0 at ../../../i386/isa/atpic.c:268 37 0 652 UNLOCK (spin mutex) icu r = 0 at ../../../i386/isa/atpic.c:270 38 2 2136 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:108 39 0 2840 _mtx_lock_spin: 0xc0e95940 spinning 40 2 3064 mi_switch: old thread 0xc26616e0 (kse 0xc2667d40, pid 12, idle: cpu2) 41 2 540 mi_switch: new thread 0xc2666160 (kse 0xc26678c0, pid 38, swi5: clock sio) 42 2 564 ithread_loop: pid 38: resumed 43 2 1900 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:613 44 2 348 ithread_loop: pid 38: (swi5: clock sio) need=1 45 0 564 _mtx_lock_spin: 0xc0e95940 spin done 46 2 596 ithread_loop: pid 38 ih=0xc26b51c0: 0xc06051d8(0x0) flg=80000000 47 0 1664 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:108 48 2 1572 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:201 49 2 640 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 50 2 820 callout mpsafe 0xc067e3bc 51 2 548 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 52 2 588 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 53 0 456 mi_switch: old thread 0xc26619a0 (kse 0xc2667dc0, pid 14, idle: cpu0) 54 2 760 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 55 2 328 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 56 0 1172 mi_switch: new thread 0xc26619a0 (kse 0xc2667dc0, pid 14, idle: cpu0) 57 2 452 callout mpsafe 0xc06cea14 58 0 560 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:110 59 2 876 LOCK (sleep mutex) nfsd_mtx r = 0 at ../../../nfsserver/nfs_srvsock.c:811 60 2 748 UNLOCK (sleep mutex) nfsd_mtx r = 0 at ../../../nfsserver/nfs_srvsock.c:822 61 2 752 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 62 2 808 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 63 2 536 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 64 2 1132 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:305 65 2 480 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:606 66 2 5480 ithread_loop: pid 38: done 67 2 1392 mi_switch: old thread 0xc2666160 (kse 0xc26678c0, pid 38, swi5: clock sio) 68 2 460 mi_switch: new thread 0xc26616e0 (kse 0xc2667d40, pid 12, idle: cpu2) 69 2 12502060 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:110 70 0 11374520 intr_execute_handlers: executing handler 0xc07787fc(0xdb897c98) 71 0 6920 intr_execute_handlers: executing handler 0xc07784bc(0xdb897c98) 72 0 724 swi_sched pid 38(swi5: clock sio) need=0 73 0 616 ithread_schedule: pid 38: (swi5: clock sio) need = 0 74 0 1348 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:407 75 0 1316 ithread_schedule: setrunqueue 38 76 0 2008 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:416 77 0 2604 LOCK (spin mutex) icu r = 0 at ../../../i386/isa/atpic.c:268 78 0 1088 UNLOCK (spin mutex) icu r = 0 at ../../../i386/isa/atpic.c:270 79 2 2224 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:108 80 0 3292 _mtx_lock_spin: 0xc0e95940 spinning 81 2 3032 mi_switch: old thread 0xc26616e0 (kse 0xc2667d40, pid 12, idle: cpu2) 82 2 504 mi_switch: new thread 0xc2666160 (kse 0xc26678c0, pid 38, swi5: clock sio) 83 2 668 ithread_loop: pid 38: resumed 84 2 1648 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:613 85 2 452 ithread_loop: pid 38: (swi5: clock sio) need=1 86 0 1664 _mtx_lock_spin: 0xc0e95940 spin done 87 2 360 ithread_loop: pid 38 ih=0xc26b51c0: 0xc06051d8(0x0) flg=80000000 88 0 960 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:108 89 2 1688 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:201 90 2 836 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 91 2 468 LOCK (sleep mutex) Giant r = 0 at ../../../kern/kern_timeout.c:247 92 2 1180 callout 0xc075b154 93 2 1496 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:333 94 0 316 mi_switch: old thread 0xc26619a0 (kse 0xc2667dc0, pid 14, idle: cpu0) 95 2 676 LOCK (spin mutex) callout r = 1 at ../../../kern/kern_timeout.c:398 96 2 1312 UNLOCK (spin mutex) callout r = 1 at ../../../kern/kern_timeout.c:439 97 0 436 mi_switch: new thread 0xc26619a0 (kse 0xc2667dc0, pid 14, idle: cpu0) 98 2 600 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:345 99 0 1312 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:110 100 2 920 UNLOCK (sleep mutex) Giant r = 0 at ../../../kern/kern_timeout.c:279 101 2 672 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 102 2 640 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 103 2 752 callout mpsafe 0xc067e3bc 104 2 468 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 105 2 856 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 106 2 560 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 107 2 592 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 108 2 608 callout mpsafe 0xc06cea14 109 2 548 LOCK (sleep mutex) nfsd_mtx r = 0 at ../../../nfsserver/nfs_srvsock.c:811 110 2 720 UNLOCK (sleep mutex) nfsd_mtx r = 0 at ../../../nfsserver/nfs_srvsock.c:822 111 2 484 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 112 2 788 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 113 2 548 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 114 2 1168 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:305 115 2 484 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:606 116 2 3092 ithread_loop: pid 38: done 117 2 1384 mi_switch: old thread 0xc2666160 (kse 0xc26678c0, pid 38, swi5: clock sio) 118 2 476 mi_switch: new thread 0xc26616e0 (kse 0xc2667d40, pid 12, idle: cpu2) 119 2 7259704 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:110 120 0 16610404 intr_execute_handlers: executing handler 0xc07787fc(0xdb897c98) 121 0 6924 intr_execute_handlers: executing handler 0xc07784bc(0xdb897c98) 122 0 688 swi_sched pid 38(swi5: clock sio) need=0 123 0 628 ithread_schedule: pid 38: (swi5: clock sio) need = 0 124 0 748 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:407 125 0 1696 ithread_schedule: setrunqueue 38 126 0 2028 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:416 127 0 2608 LOCK (spin mutex) icu r = 0 at ../../../i386/isa/atpic.c:268 128 0 1124 UNLOCK (spin mutex) icu r = 0 at ../../../i386/isa/atpic.c:270 129 2 1884 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:108 130 0 2748 _mtx_lock_spin: 0xc0e95940 spinning 131 2 2816 mi_switch: old thread 0xc26616e0 (kse 0xc2667d40, pid 12, idle: cpu2) 132 2 504 mi_switch: new thread 0xc2666160 (kse 0xc26678c0, pid 38, swi5: clock sio) 133 2 692 ithread_loop: pid 38: resumed 134 2 2276 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:613 135 2 96 ithread_loop: pid 38: (swi5: clock sio) need=1 136 0 512 _mtx_lock_spin: 0xc0e95940 spin done 137 0 836 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:108 138 2 2276 ithread_loop: pid 38 ih=0xc26b51c0: 0xc06051d8(0x0) flg=80000000 139 2 1156 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:201 140 2 648 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 141 2 536 callout mpsafe 0xc067e3bc 142 0 728 mi_switch: old thread 0xc26619a0 (kse 0xc2667dc0, pid 14, idle: cpu0) 143 2 2196 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 144 2 312 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 145 0 824 mi_switch: new thread 0xc26619a0 (kse 0xc2667dc0, pid 14, idle: cpu0) 146 2 2276 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 147 0 312 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:110 148 2 740 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 149 2 680 callout mpsafe 0xc06cea14 150 2 872 LOCK (sleep mutex) nfsd_mtx r = 0 at ../../../nfsserver/nfs_srvsock.c:811 151 2 732 UNLOCK (sleep mutex) nfsd_mtx r = 0 at ../../../nfsserver/nfs_srvsock.c:822 152 2 604 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 153 2 812 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 154 2 824 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 155 2 1128 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:305 156 2 456 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:606 157 2 4140 ithread_loop: pid 38: done 158 2 1272 mi_switch: old thread 0xc2666160 (kse 0xc26678c0, pid 38, swi5: clock sio) 159 2 460 mi_switch: new thread 0xc26616e0 (kse 0xc2667d40, pid 12, idle: cpu2) 160 2 2030400 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:110 161 0 18690980 intr_execute_handlers: executing handler 0xc07787fc(0xdb897c98) 162 0 3153444 intr_execute_handlers: executing handler 0xc07787fc(0xdb897c98) 163 0 7180 intr_execute_handlers: executing handler 0xc07784bc(0xdb897c98) 164 0 584 swi_sched pid 38(swi5: clock sio) need=0 165 0 636 ithread_schedule: pid 38: (swi5: clock sio) need = 0 166 0 736 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:407 167 0 1304 ithread_schedule: setrunqueue 38 168 0 2092 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:416 169 0 2584 LOCK (spin mutex) icu r = 0 at ../../../i386/isa/atpic.c:268 170 0 644 UNLOCK (spin mutex) icu r = 0 at ../../../i386/isa/atpic.c:270 171 2 2372 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:108 172 0 2384 _mtx_lock_spin: 0xc0e95940 spinning 173 2 2992 mi_switch: old thread 0xc26616e0 (kse 0xc2667d40, pid 12, idle: cpu2) 174 2 508 mi_switch: new thread 0xc2666160 (kse 0xc26678c0, pid 38, swi5: clock sio) 175 2 668 ithread_loop: pid 38: resumed 176 2 1528 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:613 177 0 380 _mtx_lock_spin: 0xc0e95940 spin done 178 2 756 ithread_loop: pid 38: (swi5: clock sio) need=1 179 0 1776 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:108 180 2 1172 ithread_loop: pid 38 ih=0xc26b51c0: 0xc06051d8(0x0) flg=80000000 181 2 1352 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:201 182 2 636 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 183 2 1204 callout mpsafe 0xc06149ec 184 0 436 mi_switch: old thread 0xc26619a0 (kse 0xc2667dc0, pid 14, idle: cpu0) 185 2 1404 sleepq_timeout: thread 0xc2666580 (pid 2, g_event) 186 0 1232 mi_switch: new thread 0xc26619a0 (kse 0xc2667dc0, pid 14, idle: cpu0) 187 0 728 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:110 188 2 1616 _mtx_lock_spin: 0xc0e95940 spinning 189 2 472 _mtx_lock_spin: 0xc0e95940 spin done 190 2 472 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:724 191 2 852 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:727 192 2 756 LOCK (spin mutex) sleepq chain r = 0 at ../../../kern/subr_sleepqueue.c:223 193 2 472 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:729 194 2 880 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:749 195 2 452 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:603 196 2 648 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:606 197 2 844 UNLOCK (spin mutex) sleepq chain r = 0 at ../../../kern/subr_sleepqueue.c:239 198 2 484 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:623 199 2 1708 sleepq_wakeup: thread 0xc2666580 (pid 2, g_event) 200 2 836 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:633 201 2 624 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 202 2 592 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 203 2 744 callout mpsafe 0xc067e3bc 204 2 540 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 205 2 816 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 206 2 556 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 207 2 592 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 208 2 612 callout mpsafe 0xc06cea14 209 2 692 LOCK (sleep mutex) nfsd_mtx r = 0 at ../../../nfsserver/nfs_srvsock.c:811 210 2 748 UNLOCK (sleep mutex) nfsd_mtx r = 0 at ../../../nfsserver/nfs_srvsock.c:822 211 2 476 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 212 2 788 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 213 2 524 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 214 2 888 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:305 215 2 472 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:606 216 2 3320 ithread_loop: pid 38: done 217 2 936 mi_switch: old thread 0xc2666160 (kse 0xc26678c0, pid 38, swi5: clock sio) 218 2 508 mi_switch: new thread 0xc2666580 (kse 0xc2667980, pid 2, g_event) 219 2 492 sleepq resume: thread 0xc2666580 (pid 2, g_event) 220 2 1072 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:546 221 2 868 XLOCK (sx) GEOM topology r = 0 at ../../../geom/geom_event.c:157 222 2 484 LOCK (sleep mutex) GEOM orphanage r = 0 at ../../../geom/geom_event.c:159 223 2 728 UNLOCK (sleep mutex) GEOM orphanage r = 0 at ../../../geom/geom_event.c:165 224 2 480 LOCK (sleep mutex) GEOM orphanage r = 0 at ../../../geom/geom_event.c:170 225 2 748 UNLOCK (sleep mutex) GEOM orphanage r = 0 at ../../../geom/geom_event.c:173 226 2 800 XUNLOCK (sx) GEOM topology r = 0 at ../../../geom/geom_event.c:174 227 2 716 XLOCK (sx) GEOM topology r = 0 at ../../../geom/geom_event.c:202 228 2 836 XUNLOCK (sx) GEOM topology r = 0 at ../../../geom/geom_event.c:209 229 2 732 LOCK (spin mutex) sleepq chain r = 0 at ../../../kern/subr_sleepqueue.c:223 230 2 476 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_synch.c:169 231 2 600 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_synch.c:190 232 2 796 msleep: thread 0xc2666580 (pid 2, g_event) on - (0xc0891afc) 233 2 464 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:297 234 2 860 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:300 235 2 548 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 236 2 808 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 237 2 560 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_synch.c:229 238 2 828 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_synch.c:231 239 2 456 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:407 240 2 3424 UNLOCK (spin mutex) sleepq chain r = 0 at ../../../kern/subr_sleepqueue.c:408 241 2 1084 mi_switch: old thread 0xc2666580 (kse 0xc2667980, pid 2, g_event) 242 2 488 mi_switch: new thread 0xc26616e0 (kse 0xc2667d40, pid 12, idle: cpu2) 243 2 15459228 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:110 244 0 8386832 intr_execute_handlers: executing handler 0xc07787fc(0xdb897c98) 245 0 8480 intr_execute_handlers: executing handler 0xc07784bc(0xdb897c98) 246 0 616 swi_sched pid 38(swi5: clock sio) need=0 247 0 628 ithread_schedule: pid 38: (swi5: clock sio) need = 0 248 0 892 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:407 249 0 1284 ithread_schedule: setrunqueue 38 250 0 2044 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:416 251 0 2616 LOCK (spin mutex) icu r = 0 at ../../../i386/isa/atpic.c:268 252 0 732 UNLOCK (spin mutex) icu r = 0 at ../../../i386/isa/atpic.c:270 253 2 1992 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:108 254 0 3104 _mtx_lock_spin: 0xc0e95940 spinning 255 2 3184 mi_switch: old thread 0xc26616e0 (kse 0xc2667d40, pid 12, idle: cpu2) 256 2 516 mi_switch: new thread 0xc2666160 (kse 0xc26678c0, pid 38, swi5: clock sio) 257 2 836 ithread_loop: pid 38: resumed 258 2 1740 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:613 259 0 348 _mtx_lock_spin: 0xc0e95940 spin done 260 2 1504 ithread_loop: pid 38: (swi5: clock sio) need=1 261 0 676 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:108 262 2 1760 ithread_loop: pid 38 ih=0xc26b51c0: 0xc06051d8(0x0) flg=80000000 263 2 1332 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:201 264 2 624 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 265 2 1312 callout mpsafe 0xc067e3bc 266 0 332 mi_switch: old thread 0xc26619a0 (kse 0xc2667dc0, pid 14, idle: cpu0) 267 2 760 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 268 2 1152 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 269 0 316 mi_switch: new thread 0xc26619a0 (kse 0xc2667dc0, pid 14, idle: cpu0) 270 2 1840 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 271 2 228 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 272 0 880 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:110 273 2 680 callout mpsafe 0xc06cea14 274 2 1304 LOCK (sleep mutex) nfsd_mtx r = 0 at ../../../nfsserver/nfs_srvsock.c:811 275 2 740 UNLOCK (sleep mutex) nfsd_mtx r = 0 at ../../../nfsserver/nfs_srvsock.c:822 276 2 476 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 277 2 820 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 278 2 536 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 279 2 1108 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:305 280 2 480 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:606 281 2 4484 ithread_loop: pid 38: done 282 2 1224 mi_switch: old thread 0xc2666160 (kse 0xc26678c0, pid 38, swi5: clock sio) 283 2 464 mi_switch: new thread 0xc26616e0 (kse 0xc2667d40, pid 12, idle: cpu2) 284 2 10250972 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:110 285 0 13622600 intr_execute_handlers: executing handler 0xc07787fc(0xdb897c98) 286 0 7304 intr_execute_handlers: executing handler 0xc07784bc(0xdb897c98) 287 0 572 swi_sched pid 38(swi5: clock sio) need=0 288 0 672 ithread_schedule: pid 38: (swi5: clock sio) need = 0 289 0 760 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:407 290 0 1584 ithread_schedule: setrunqueue 38 291 0 2020 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:416 292 0 2632 LOCK (spin mutex) icu r = 0 at ../../../i386/isa/atpic.c:268 293 0 628 UNLOCK (spin mutex) icu r = 0 at ../../../i386/isa/atpic.c:270 294 2 2104 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:108 295 0 2340 _mtx_lock_spin: 0xc0e95940 spinning 296 2 2920 mi_switch: old thread 0xc26616e0 (kse 0xc2667d40, pid 12, idle: cpu2) 297 2 504 mi_switch: new thread 0xc2666160 (kse 0xc26678c0, pid 38, swi5: clock sio) 298 2 668 ithread_loop: pid 38: resumed 299 2 1900 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:613 300 2 320 ithread_loop: pid 38: (swi5: clock sio) need=1 301 0 1188 _mtx_lock_spin: 0xc0e95940 spin done 302 0 368 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:108 303 2 1672 ithread_loop: pid 38 ih=0xc26b51c0: 0xc06051d8(0x0) flg=80000000 304 2 1456 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:201 305 2 1568 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 306 0 316 mi_switch: old thread 0xc26619a0 (kse 0xc2667dc0, pid 14, idle: cpu0) 307 2 752 LOCK (sleep mutex) Giant r = 0 at ../../../kern/kern_timeout.c:247 308 2 856 callout 0xc075b154 309 0 440 mi_switch: new thread 0xc26619a0 (kse 0xc2667dc0, pid 14, idle: cpu0) 310 2 884 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:333 311 0 1124 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:110 312 2 700 LOCK (spin mutex) callout r = 1 at ../../../kern/kern_timeout.c:398 313 2 600 UNLOCK (spin mutex) callout r = 1 at ../../../kern/kern_timeout.c:439 314 2 856 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:345 315 2 724 UNLOCK (sleep mutex) Giant r = 0 at ../../../kern/kern_timeout.c:279 316 2 612 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 317 2 608 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 318 2 736 callout mpsafe 0xc067e3bc 319 2 468 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 320 2 792 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 321 2 508 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 322 2 856 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 323 2 612 callout mpsafe 0xc06cea14 324 2 544 LOCK (sleep mutex) nfsd_mtx r = 0 at ../../../nfsserver/nfs_srvsock.c:811 325 2 952 UNLOCK (sleep mutex) nfsd_mtx r = 0 at ../../../nfsserver/nfs_srvsock.c:822 326 2 480 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 327 2 792 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 328 2 548 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 329 2 1204 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:305 330 2 492 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:606 331 2 3628 ithread_loop: pid 38: done 332 2 1228 mi_switch: old thread 0xc2666160 (kse 0xc26678c0, pid 38, swi5: clock sio) 333 2 484 mi_switch: new thread 0xc26616e0 (kse 0xc2667d40, pid 12, idle: cpu2) 334 2 5013172 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:110 335 0 18692736 intr_execute_handlers: executing handler 0xc07787fc(0xdb897c98) 336 0 165732 intr_execute_handlers: executing handler 0xc07787fc(0xdb897c98) 337 0 7396 intr_execute_handlers: executing handler 0xc07784bc(0xdb897c98) 338 0 616 swi_sched pid 38(swi5: clock sio) need=0 339 0 628 ithread_schedule: pid 38: (swi5: clock sio) need = 0 340 0 736 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:407 341 0 1796 ithread_schedule: setrunqueue 38 342 0 2020 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:416 343 0 2644 LOCK (spin mutex) icu r = 0 at ../../../i386/isa/atpic.c:268 344 0 928 UNLOCK (spin mutex) icu r = 0 at ../../../i386/isa/atpic.c:270 345 2 2092 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:108 346 0 2720 _mtx_lock_spin: 0xc0e95940 spinning 347 2 3252 mi_switch: old thread 0xc26616e0 (kse 0xc2667d40, pid 12, idle: cpu2) 348 2 512 mi_switch: new thread 0xc2666160 (kse 0xc26678c0, pid 38, swi5: clock sio) 349 2 668 ithread_loop: pid 38: resumed 350 2 1912 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:613 351 2 372 ithread_loop: pid 38: (swi5: clock sio) need=1 352 0 1236 _mtx_lock_spin: 0xc0e95940 spin done 353 2 324 ithread_loop: pid 38 ih=0xc26b51c0: 0xc06051d8(0x0) flg=80000000 354 0 1508 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:108 355 2 1916 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:201 356 2 624 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 357 2 744 callout mpsafe 0xc067e3bc 358 2 528 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 359 0 632 mi_switch: old thread 0xc26619a0 (kse 0xc2667dc0, pid 14, idle: cpu0) 360 2 1572 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 361 0 612 mi_switch: new thread 0xc26619a0 (kse 0xc2667dc0, pid 14, idle: cpu0) 362 2 1716 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 363 0 556 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:110 364 2 728 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 365 2 716 callout mpsafe 0xc06cea14 366 2 712 LOCK (sleep mutex) nfsd_mtx r = 0 at ../../../nfsserver/nfs_srvsock.c:811 367 2 732 UNLOCK (sleep mutex) nfsd_mtx r = 0 at ../../../nfsserver/nfs_srvsock.c:822 368 2 472 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 369 2 820 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 370 2 512 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 371 2 1120 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:305 372 2 480 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:606 373 2 5148 ithread_loop: pid 38: done 374 2 1208 mi_switch: old thread 0xc2666160 (kse 0xc26678c0, pid 38, swi5: clock sio) 375 2 460 mi_switch: new thread 0xc26616e0 (kse 0xc2667d40, pid 12, idle: cpu2) 376 2 18473472 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:110 377 0 5400828 intr_execute_handlers: executing handler 0xc07787fc(0xdb897c98) 378 0 7184 intr_execute_handlers: executing handler 0xc07784bc(0xdb897c98) 379 0 592 swi_sched pid 38(swi5: clock sio) need=0 380 0 628 ithread_schedule: pid 38: (swi5: clock sio) need = 0 381 0 904 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:407 382 0 1296 ithread_schedule: setrunqueue 38 383 0 2028 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:416 384 0 3500 LOCK (spin mutex) icu r = 0 at ../../../i386/isa/atpic.c:268 385 0 444 UNLOCK (spin mutex) icu r = 0 at ../../../i386/isa/atpic.c:270 386 2 2468 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:108 387 0 2540 _mtx_lock_spin: 0xc0e95940 spinning 388 2 3148 mi_switch: old thread 0xc26616e0 (kse 0xc2667d40, pid 12, idle: cpu2) 389 2 508 mi_switch: new thread 0xc2666160 (kse 0xc26678c0, pid 38, swi5: clock sio) 390 2 860 ithread_loop: pid 38: resumed 391 2 1472 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:613 392 0 368 _mtx_lock_spin: 0xc0e95940 spin done 393 2 676 ithread_loop: pid 38: (swi5: clock sio) need=1 394 0 1316 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:108 395 2 1888 ithread_loop: pid 38 ih=0xc26b51c0: 0xc06051d8(0x0) flg=80000000 396 2 1340 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:201 397 2 640 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 398 2 1404 callout mpsafe 0xc067e3bc 399 2 296 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 400 0 724 mi_switch: old thread 0xc26619a0 (kse 0xc2667dc0, pid 14, idle: cpu0) 401 2 1460 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 402 0 444 mi_switch: new thread 0xc26619a0 (kse 0xc2667dc0, pid 14, idle: cpu0) 403 2 1460 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 404 0 576 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:110 405 2 784 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 406 2 656 callout mpsafe 0xc06cea14 407 2 880 LOCK (sleep mutex) nfsd_mtx r = 0 at ../../../nfsserver/nfs_srvsock.c:811 408 2 732 UNLOCK (sleep mutex) nfsd_mtx r = 0 at ../../../nfsserver/nfs_srvsock.c:822 409 2 492 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 410 2 1060 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 411 2 528 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 412 2 1108 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:305 413 2 480 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:606 414 2 3516 ithread_loop: pid 38: done 415 2 1204 mi_switch: old thread 0xc2666160 (kse 0xc26678c0, pid 38, swi5: clock sio) 416 2 464 mi_switch: new thread 0xc26616e0 (kse 0xc2667d40, pid 12, idle: cpu2) 417 2 13240516 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:110 418 0 10635032 intr_execute_handlers: executing handler 0xc07787fc(0xdb897c98) 419 0 7320 intr_execute_handlers: executing handler 0xc07784bc(0xdb897c98) 420 0 572 swi_sched pid 38(swi5: clock sio) need=0 421 0 780 ithread_schedule: pid 38: (swi5: clock sio) need = 0 422 0 748 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:407 423 0 1304 ithread_schedule: setrunqueue 38 424 0 2080 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:416 425 0 3500 LOCK (spin mutex) icu r = 0 at ../../../i386/isa/atpic.c:268 426 0 440 UNLOCK (spin mutex) icu r = 0 at ../../../i386/isa/atpic.c:270 427 2 2176 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:108 428 0 2308 _mtx_lock_spin: 0xc0e95940 spinning 429 2 3384 mi_switch: old thread 0xc26616e0 (kse 0xc2667d40, pid 12, idle: cpu2) 430 2 508 mi_switch: new thread 0xc2666160 (kse 0xc26678c0, pid 38, swi5: clock sio) 431 2 668 ithread_loop: pid 38: resumed 432 2 1816 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:613 433 2 452 ithread_loop: pid 38: (swi5: clock sio) need=1 434 0 496 _mtx_lock_spin: 0xc0e95940 spin done 435 2 788 ithread_loop: pid 38 ih=0xc26b51c0: 0xc06051d8(0x0) flg=80000000 436 0 660 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:108 437 2 1712 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:201 438 2 872 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 439 2 492 LOCK (sleep mutex) Giant r = 0 at ../../../kern/kern_timeout.c:247 440 2 1188 callout 0xc0503730 441 0 1432 mi_switch: old thread 0xc26619a0 (kse 0xc2667dc0, pid 14, idle: cpu0) 442 0 480 mi_switch: new thread 0xc26619a0 (kse 0xc2667dc0, pid 14, idle: cpu0) 443 0 2096 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:110 444 2 624 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 445 2 796 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 446 2 820 UNLOCK (sleep mutex) Giant r = 0 at ../../../kern/kern_timeout.c:279 447 2 984 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 448 2 648 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 449 2 980 callout mpsafe 0xc060859c 450 2 1360 LOCK (spin mutex) sched lock r = 0 at ../../../kern/sched_4bsd.c:188 451 2 852 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/sched_4bsd.c:190 452 2 524 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 453 2 868 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 454 2 676 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 455 2 824 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 456 2 488 LOCK (sleep mutex) Giant r = 0 at ../../../kern/kern_timeout.c:247 457 2 4012 callout 0xc074ab90 458 2 824 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:333 459 2 576 LOCK (spin mutex) callout r = 1 at ../../../kern/kern_timeout.c:398 460 2 648 UNLOCK (spin mutex) callout r = 1 at ../../../kern/kern_timeout.c:439 461 2 800 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:345 462 2 816 UNLOCK (sleep mutex) Giant r = 0 at ../../../kern/kern_timeout.c:279 463 2 668 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 464 2 656 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 465 2 564 callout mpsafe 0xc06149ec 466 2 732 sleepq_timeout: thread 0xc26db580 (pid 4, g_down) 467 2 556 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:724 468 2 892 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:727 469 2 788 LOCK (spin mutex) sleepq chain r = 0 at ../../../kern/subr_sleepqueue.c:223 470 2 564 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:729 471 2 876 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:749 472 2 520 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:603 473 2 736 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:606 474 2 972 UNLOCK (spin mutex) sleepq chain r = 0 at ../../../kern/subr_sleepqueue.c:239 475 2 492 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:623 476 2 952 sleepq_wakeup: thread 0xc26db580 (pid 4, g_down) 477 2 1020 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:633 478 2 608 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 479 2 636 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 480 2 800 callout mpsafe 0xc067e3bc 481 2 536 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 482 2 872 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 483 2 696 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 484 2 660 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 485 2 708 callout mpsafe 0xc06cea14 486 2 632 LOCK (sleep mutex) nfsd_mtx r = 0 at ../../../nfsserver/nfs_srvsock.c:811 487 2 772 UNLOCK (sleep mutex) nfsd_mtx r = 0 at ../../../nfsserver/nfs_srvsock.c:822 488 2 524 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 489 2 872 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 490 2 632 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 491 2 932 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:305 492 2 560 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:606 493 2 3708 ithread_loop: pid 38: done 494 2 1064 mi_switch: old thread 0xc2666160 (kse 0xc26678c0, pid 38, swi5: clock sio) 495 2 576 mi_switch: new thread 0xc26db580 (kse 0xc26673c0, pid 4, g_down) 496 2 608 sleepq resume: thread 0xc26db580 (pid 4, g_down) 497 2 1004 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:546 498 2 860 LOCK (sleep mutex) bio queue r = 0 at ../../../geom/geom_io.c:65 499 2 728 LOCK (spin mutex) sleepq chain r = 0 at ../../../kern/subr_sleepqueue.c:223 500 2 544 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_synch.c:169 501 2 680 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_synch.c:190 502 2 568 msleep: thread 0xc26db580 (pid 4, g_down) on - (0xc0891b08) 503 2 812 UNLOCK (sleep mutex) bio queue r = 0 at ../../../kern/kern_synch.c:198 504 2 532 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:297 505 2 872 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:300 506 2 612 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 507 2 804 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 508 2 564 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_synch.c:229 509 2 792 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_synch.c:231 510 2 504 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:407 511 2 3060 UNLOCK (spin mutex) sleepq chain r = 0 at ../../../kern/subr_sleepqueue.c:408 512 2 1040 mi_switch: old thread 0xc26db580 (kse 0xc26673c0, pid 4, g_down) 513 2 552 mi_switch: new thread 0xc26616e0 (kse 0xc2667d40, pid 12, idle: cpu2) 514 2 7958864 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:110 515 0 15870396 intr_execute_handlers: executing handler 0xc07787fc(0xdb897c98) 516 0 7540 intr_execute_handlers: executing handler 0xc07784bc(0xdb897c98) 517 0 728 swi_sched pid 38(swi5: clock sio) need=0 518 0 636 ithread_schedule: pid 38: (swi5: clock sio) need = 0 519 0 736 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:407 520 0 1784 ithread_schedule: setrunqueue 38 521 0 2028 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:416 522 0 3596 LOCK (spin mutex) icu r = 0 at ../../../i386/isa/atpic.c:268 523 0 344 UNLOCK (spin mutex) icu r = 0 at ../../../i386/isa/atpic.c:270 524 2 2376 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:108 525 0 2592 _mtx_lock_spin: 0xc0e95940 spinning 526 2 3012 mi_switch: old thread 0xc26616e0 (kse 0xc2667d40, pid 12, idle: cpu2) 527 2 532 mi_switch: new thread 0xc2666160 (kse 0xc26678c0, pid 38, swi5: clock sio) 528 2 776 ithread_loop: pid 38: resumed 529 2 1792 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:613 530 2 448 ithread_loop: pid 38: (swi5: clock sio) need=1 531 0 488 _mtx_lock_spin: 0xc0e95940 spin done 532 2 508 ithread_loop: pid 38 ih=0xc26b51c0: 0xc06051d8(0x0) flg=80000000 533 0 1248 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:108 534 2 1616 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:201 535 2 820 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 536 2 460 LOCK (sleep mutex) Giant r = 0 at ../../../kern/kern_timeout.c:247 537 2 860 callout 0xc068ff14 538 0 2556 mi_switch: old thread 0xc26619a0 (kse 0xc2667dc0, pid 14, idle: cpu0) 539 2 388 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 540 0 652 mi_switch: new thread 0xc26619a0 (kse 0xc2667dc0, pid 14, idle: cpu0) 541 0 976 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:110 542 2 856 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 543 2 748 UNLOCK (sleep mutex) Giant r = 0 at ../../../kern/kern_timeout.c:279 544 2 644 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 545 2 664 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 546 2 592 callout mpsafe 0xc06149ec 547 2 1016 sleepq_timeout: thread 0xc26db420 (pid 3, g_up) 548 2 472 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:724 549 2 860 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:727 550 2 692 LOCK (spin mutex) sleepq chain r = 0 at ../../../kern/subr_sleepqueue.c:223 551 2 472 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:729 552 2 832 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:749 553 2 480 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:603 554 2 584 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:606 555 2 908 UNLOCK (spin mutex) sleepq chain r = 0 at ../../../kern/subr_sleepqueue.c:239 556 2 440 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:623 557 2 1656 sleepq_wakeup: thread 0xc26db420 (pid 3, g_up) 558 2 880 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:633 559 2 528 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 560 2 632 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 561 2 448 callout mpsafe 0xc06149ec 562 2 592 sleepq_timeout: thread 0xc26db6e0 (pid 41, yarrow) 563 2 428 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:724 564 2 800 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:727 565 2 708 LOCK (spin mutex) sleepq chain r = 0 at ../../../kern/subr_sleepqueue.c:223 566 2 440 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:729 567 2 888 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:749 568 2 448 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:603 569 2 664 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:606 570 2 776 UNLOCK (spin mutex) sleepq chain r = 0 at ../../../kern/subr_sleepqueue.c:239 571 2 408 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:623 572 2 640 sleepq_wakeup: thread 0xc26db6e0 (pid 41, yarrow) 573 2 828 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:633 574 2 552 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 575 2 776 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 576 2 416 LOCK (sleep mutex) Giant r = 0 at ../../../kern/kern_timeout.c:247 577 2 1128 callout 0xc075b154 578 2 804 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:333 579 2 476 LOCK (spin mutex) callout r = 1 at ../../../kern/kern_timeout.c:398 580 2 592 UNLOCK (spin mutex) callout r = 1 at ../../../kern/kern_timeout.c:439 581 2 852 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:345 582 2 752 UNLOCK (sleep mutex) Giant r = 0 at ../../../kern/kern_timeout.c:279 583 2 508 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 584 2 632 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 585 2 868 callout mpsafe 0xc067e3bc 586 2 472 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 587 2 804 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 588 2 544 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 589 2 604 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 590 2 664 callout mpsafe 0xc06cea14 591 2 556 LOCK (sleep mutex) nfsd_mtx r = 0 at ../../../nfsserver/nfs_srvsock.c:811 592 2 720 UNLOCK (sleep mutex) nfsd_mtx r = 0 at ../../../nfsserver/nfs_srvsock.c:822 593 2 484 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 594 2 804 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 595 2 548 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 596 2 876 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:305 597 2 472 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:606 598 2 3424 ithread_loop: pid 38: done 599 2 884 mi_switch: old thread 0xc2666160 (kse 0xc26678c0, pid 38, swi5: clock sio) 600 2 468 mi_switch: new thread 0xc26db420 (kse 0xc2667380, pid 3, g_up) 601 2 492 sleepq resume: thread 0xc26db420 (pid 3, g_up) 602 2 960 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:546 603 2 808 LOCK (sleep mutex) bio queue r = 0 at ../../../geom/geom_io.c:65 604 2 656 LOCK (spin mutex) sleepq chain r = 0 at ../../../kern/subr_sleepqueue.c:223 605 2 480 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_synch.c:169 606 2 612 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_synch.c:190 607 2 472 msleep: thread 0xc26db420 (pid 3, g_up) on - (0xc0891b04) 608 2 808 UNLOCK (sleep mutex) bio queue r = 0 at ../../../kern/kern_synch.c:198 609 2 476 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:297 610 2 848 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:300 611 2 1032 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 612 2 792 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 613 2 476 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_synch.c:229 614 2 828 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_synch.c:231 615 2 444 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:407 616 2 2972 UNLOCK (spin mutex) sleepq chain r = 0 at ../../../kern/subr_sleepqueue.c:408 617 2 864 mi_switch: old thread 0xc26db420 (kse 0xc2667380, pid 3, g_up) 618 2 452 mi_switch: new thread 0xc26db6e0 (kse 0xc2667400, pid 41, yarrow) 619 2 452 sleepq resume: thread 0xc26db6e0 (pid 41, yarrow) 620 2 1160 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:546 621 2 468 LOCK (spin mutex) entropy harvest r = 0 at ../../../dev/random/randomdev_soft.c:248 622 2 884 UNLOCK (spin mutex) entropy harvest r = 0 at ../../../dev/random/randomdev_soft.c:262 623 2 436 LOCK (spin mutex) entropy harvest r = 0 at ../../../dev/random/randomdev_soft.c:248 624 2 772 UNLOCK (spin mutex) entropy harvest r = 0 at ../../../dev/random/randomdev_soft.c:262 625 2 452 LOCK (spin mutex) entropy harvest r = 0 at ../../../dev/random/randomdev_soft.c:248 626 2 776 UNLOCK (spin mutex) entropy harvest r = 0 at ../../../dev/random/randomdev_soft.c:262 627 2 432 LOCK (spin mutex) entropy harvest r = 0 at ../../../dev/random/randomdev_soft.c:248 628 2 788 UNLOCK (spin mutex) entropy harvest r = 0 at ../../../dev/random/randomdev_soft.c:262 629 2 464 LOCK (spin mutex) entropy harvest r = 0 at ../../../dev/random/randomdev_soft.c:248 630 2 808 UNLOCK (spin mutex) entropy harvest r = 0 at ../../../dev/random/randomdev_soft.c:262 631 2 448 LOCK (spin mutex) entropy harvest r = 0 at ../../../dev/random/randomdev_soft.c:248 632 2 928 UNLOCK (spin mutex) entropy harvest r = 0 at ../../../dev/random/randomdev_soft.c:262 633 2 668 LOCK (spin mutex) sleepq chain r = 0 at ../../../kern/subr_sleepqueue.c:223 634 2 428 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_synch.c:169 635 2 568 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_synch.c:190 636 2 740 msleep: thread 0xc26db6e0 (pid 41, yarrow) on - (0xc088cd80) 637 2 452 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:297 638 2 812 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:300 639 2 508 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 640 2 756 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 641 2 444 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_synch.c:229 642 2 748 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_synch.c:231 643 2 440 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:407 644 2 3884 UNLOCK (spin mutex) sleepq chain r = 0 at ../../../kern/subr_sleepqueue.c:408 645 2 908 mi_switch: old thread 0xc26db6e0 (kse 0xc2667400, pid 41, yarrow) 646 2 492 mi_switch: new thread 0xc26616e0 (kse 0xc2667d40, pid 12, idle: cpu2) 647 2 2703168 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:110 648 0 18692804 intr_execute_handlers: executing handler 0xc07787fc(0xdb897c98) 649 0 2413860 intr_execute_handlers: executing handler 0xc07787fc(0xdb897c98) 650 0 7888 intr_execute_handlers: executing handler 0xc07784bc(0xdb897c98) 651 0 604 swi_sched pid 38(swi5: clock sio) need=0 652 0 628 ithread_schedule: pid 38: (swi5: clock sio) need = 0 653 0 940 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:407 654 0 1436 ithread_schedule: setrunqueue 38 655 0 2028 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:416 656 0 2588 LOCK (spin mutex) icu r = 0 at ../../../i386/isa/atpic.c:268 657 0 748 UNLOCK (spin mutex) icu r = 0 at ../../../i386/isa/atpic.c:270 658 2 1968 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:108 659 0 3168 _mtx_lock_spin: 0xc0e95940 spinning 660 2 3324 mi_switch: old thread 0xc26616e0 (kse 0xc2667d40, pid 12, idle: cpu2) 661 2 512 mi_switch: new thread 0xc2666160 (kse 0xc26678c0, pid 38, swi5: clock sio) 662 2 680 ithread_loop: pid 38: resumed 663 2 1624 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:613 664 2 456 ithread_loop: pid 38: (swi5: clock sio) need=1 665 0 672 _mtx_lock_spin: 0xc0e95940 spin done 666 2 392 ithread_loop: pid 38 ih=0xc26b51c0: 0xc06051d8(0x0) flg=80000000 667 0 1972 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:108 668 2 1716 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:201 669 2 780 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 670 2 824 callout mpsafe 0xc067e3bc 671 2 516 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 672 0 396 mi_switch: old thread 0xc26619a0 (kse 0xc2667dc0, pid 14, idle: cpu0) 673 2 988 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 674 2 568 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 675 0 688 mi_switch: new thread 0xc26619a0 (kse 0xc2667dc0, pid 14, idle: cpu0) 676 2 692 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 677 0 484 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:110 678 2 1072 callout mpsafe 0xc06cea14 679 2 840 LOCK (sleep mutex) nfsd_mtx r = 0 at ../../../nfsserver/nfs_srvsock.c:811 680 2 756 UNLOCK (sleep mutex) nfsd_mtx r = 0 at ../../../nfsserver/nfs_srvsock.c:822 681 2 508 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 682 2 812 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 683 2 536 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 684 2 1344 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:305 685 2 496 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:606 686 2 4304 ithread_loop: pid 38: done 687 2 1176 mi_switch: old thread 0xc2666160 (kse 0xc26678c0, pid 38, swi5: clock sio) 688 2 452 mi_switch: new thread 0xc26616e0 (kse 0xc2667d40, pid 12, idle: cpu2) 689 2 16227044 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:110 690 0 7648996 intr_execute_handlers: executing handler 0xc07787fc(0xdb897c98) 691 0 7616 intr_execute_handlers: executing handler 0xc07784bc(0xdb897c98) 692 0 572 swi_sched pid 38(swi5: clock sio) need=0 693 0 768 ithread_schedule: pid 38: (swi5: clock sio) need = 0 694 0 748 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:407 695 0 1280 ithread_schedule: setrunqueue 38 696 0 2104 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:416 697 0 3484 LOCK (spin mutex) icu r = 0 at ../../../i386/isa/atpic.c:268 698 0 440 UNLOCK (spin mutex) icu r = 0 at ../../../i386/isa/atpic.c:270 699 2 2084 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:108 700 0 2912 _mtx_lock_spin: 0xc0e95940 spinning 701 2 3708 mi_switch: old thread 0xc26616e0 (kse 0xc2667d40, pid 12, idle: cpu2) 702 2 512 mi_switch: new thread 0xc2666160 (kse 0xc26678c0, pid 38, swi5: clock sio) 703 2 668 ithread_loop: pid 38: resumed 704 2 1672 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:613 705 2 456 ithread_loop: pid 38: (swi5: clock sio) need=1 706 0 1704 _mtx_lock_spin: 0xc0e95940 spin done 707 2 468 ithread_loop: pid 38 ih=0xc26b51c0: 0xc06051d8(0x0) flg=80000000 708 0 944 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:108 709 2 2048 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:201 710 2 640 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 711 2 784 callout mpsafe 0xc067e3bc 712 2 1308 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 713 0 584 mi_switch: old thread 0xc26619a0 (kse 0xc2667dc0, pid 14, idle: cpu0) 714 2 1528 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 715 0 348 mi_switch: new thread 0xc26619a0 (kse 0xc2667dc0, pid 14, idle: cpu0) 716 2 768 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 717 0 256 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:110 718 2 764 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 719 2 616 callout mpsafe 0xc06cea14 720 2 960 LOCK (sleep mutex) nfsd_mtx r = 0 at ../../../nfsserver/nfs_srvsock.c:811 721 2 740 UNLOCK (sleep mutex) nfsd_mtx r = 0 at ../../../nfsserver/nfs_srvsock.c:822 722 2 484 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 723 2 792 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 724 2 524 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 725 2 1220 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:305 726 2 492 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:606 727 2 4236 ithread_loop: pid 38: done 728 2 1236 mi_switch: old thread 0xc2666160 (kse 0xc26678c0, pid 38, swi5: clock sio) 729 2 460 mi_switch: new thread 0xc26616e0 (kse 0xc2667d40, pid 12, idle: cpu2) 730 2 10991576 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:110 731 0 12883164 intr_execute_handlers: executing handler 0xc07787fc(0xdb897c98) 732 0 7188 intr_execute_handlers: executing handler 0xc07784bc(0xdb897c98) 733 0 716 swi_sched pid 38(swi5: clock sio) need=0 734 0 636 ithread_schedule: pid 38: (swi5: clock sio) need = 0 735 0 736 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:407 736 0 1688 ithread_schedule: setrunqueue 38 737 0 2044 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:416 738 0 2772 LOCK (spin mutex) icu r = 0 at ../../../i386/isa/atpic.c:268 739 0 764 UNLOCK (spin mutex) icu r = 0 at ../../../i386/isa/atpic.c:270 740 2 2424 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:108 741 0 2400 _mtx_lock_spin: 0xc0e95940 spinning 742 2 3124 mi_switch: old thread 0xc26616e0 (kse 0xc2667d40, pid 12, idle: cpu2) 743 2 504 mi_switch: new thread 0xc2666160 (kse 0xc26678c0, pid 38, swi5: clock sio) 744 2 932 ithread_loop: pid 38: resumed 745 2 1460 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:613 746 0 340 _mtx_lock_spin: 0xc0e95940 spin done 747 2 804 ithread_loop: pid 38: (swi5: clock sio) need=1 748 0 732 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:108 749 2 1316 ithread_loop: pid 38 ih=0xc26b51c0: 0xc06051d8(0x0) flg=80000000 750 2 1356 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:201 751 2 624 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 752 2 1284 callout mpsafe 0xc06006cc 753 0 1664 mi_switch: old thread 0xc26619a0 (kse 0xc2667dc0, pid 14, idle: cpu0) 754 0 2036 mi_switch: new thread 0xc26619a0 (kse 0xc2667dc0, pid 14, idle: cpu0) 755 2 360 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 756 0 2088 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:110 757 2 888 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 758 2 628 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 759 2 588 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 760 2 724 callout mpsafe 0xc067e3bc 761 2 496 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 762 2 792 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 763 2 552 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 764 2 580 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 765 2 620 callout mpsafe 0xc06cea14 766 2 676 LOCK (sleep mutex) nfsd_mtx r = 0 at ../../../nfsserver/nfs_srvsock.c:811 767 2 740 UNLOCK (sleep mutex) nfsd_mtx r = 0 at ../../../nfsserver/nfs_srvsock.c:822 768 2 476 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 769 2 820 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 770 2 512 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 771 2 1148 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:305 772 2 496 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:606 773 2 3516 ithread_loop: pid 38: done 774 2 1460 mi_switch: old thread 0xc2666160 (kse 0xc26678c0, pid 38, swi5: clock sio) 775 2 472 mi_switch: new thread 0xc26616e0 (kse 0xc2667d40, pid 12, idle: cpu2) 776 2 5752484 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:110 777 0 18118904 intr_execute_handlers: executing handler 0xc07787fc(0xdb897c98) 778 0 7364 intr_execute_handlers: executing handler 0xc07784bc(0xdb897c98) 779 0 584 swi_sched pid 38(swi5: clock sio) need=0 780 0 612 ithread_schedule: pid 38: (swi5: clock sio) need = 0 781 0 748 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:407 782 0 1276 ithread_schedule: setrunqueue 38 783 0 2032 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:416 784 0 2636 LOCK (spin mutex) icu r = 0 at ../../../i386/isa/atpic.c:268 785 0 696 UNLOCK (spin mutex) icu r = 0 at ../../../i386/isa/atpic.c:270 786 2 2608 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:108 787 0 2048 _mtx_lock_spin: 0xc0e95940 spinning 788 2 3192 mi_switch: old thread 0xc26616e0 (kse 0xc2667d40, pid 12, idle: cpu2) 789 2 504 mi_switch: new thread 0xc2666160 (kse 0xc26678c0, pid 38, swi5: clock sio) 790 2 680 ithread_loop: pid 38: resumed 791 2 1648 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:613 792 2 740 ithread_loop: pid 38: (swi5: clock sio) need=1 793 0 1396 _mtx_lock_spin: 0xc0e95940 spin done 794 0 556 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:108 795 2 1532 ithread_loop: pid 38 ih=0xc26b51c0: 0xc06051d8(0x0) flg=80000000 796 2 1180 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:201 797 2 636 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 798 2 548 callout mpsafe 0xc06149ec 799 2 520 sleepq_timeout: thread 0xc2666580 (pid 2, g_event) 800 0 492 mi_switch: old thread 0xc26619a0 (kse 0xc2667dc0, pid 14, idle: cpu0) 801 2 1480 _mtx_lock_spin: 0xc0e95940 spinning 802 0 1680 mi_switch: new thread 0xc26619a0 (kse 0xc2667dc0, pid 14, idle: cpu0) 803 0 1296 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:110 804 2 480 _mtx_lock_spin: 0xc0e95940 spin done 805 2 560 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:724 806 2 880 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:727 807 2 756 LOCK (spin mutex) sleepq chain r = 0 at ../../../kern/subr_sleepqueue.c:223 808 2 472 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:729 809 2 872 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:749 810 2 480 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:603 811 2 568 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:606 812 2 820 UNLOCK (spin mutex) sleepq chain r = 0 at ../../../kern/subr_sleepqueue.c:239 813 2 448 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:623 814 2 1548 sleepq_wakeup: thread 0xc2666580 (pid 2, g_event) 815 2 876 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:633 816 2 652 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 817 2 872 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 818 2 480 LOCK (sleep mutex) Giant r = 0 at ../../../kern/kern_timeout.c:247 819 2 1196 callout 0xc075b154 820 2 780 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:333 821 2 536 LOCK (spin mutex) callout r = 1 at ../../../kern/kern_timeout.c:398 822 2 588 UNLOCK (spin mutex) callout r = 1 at ../../../kern/kern_timeout.c:439 823 2 724 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:345 824 2 728 UNLOCK (sleep mutex) Giant r = 0 at ../../../kern/kern_timeout.c:279 825 2 576 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 826 2 672 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 827 2 712 callout mpsafe 0xc067e3bc 828 2 484 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 829 2 936 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 830 2 572 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 831 2 588 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 832 2 612 callout mpsafe 0xc06cea14 833 2 548 LOCK (sleep mutex) nfsd_mtx r = 0 at ../../../nfsserver/nfs_srvsock.c:811 834 2 780 UNLOCK (sleep mutex) nfsd_mtx r = 0 at ../../../nfsserver/nfs_srvsock.c:822 835 2 484 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 836 2 796 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 837 2 580 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 838 2 884 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:305 839 2 460 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:606 840 2 3368 ithread_loop: pid 38: done 841 2 880 mi_switch: old thread 0xc2666160 (kse 0xc26678c0, pid 38, swi5: clock sio) 842 2 468 mi_switch: new thread 0xc2666580 (kse 0xc2667980, pid 2, g_event) 843 2 496 sleepq resume: thread 0xc2666580 (pid 2, g_event) 844 2 1112 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:546 845 2 808 XLOCK (sx) GEOM topology r = 0 at ../../../geom/geom_event.c:157 846 2 484 LOCK (sleep mutex) GEOM orphanage r = 0 at ../../../geom/geom_event.c:159 847 2 700 UNLOCK (sleep mutex) GEOM orphanage r = 0 at ../../../geom/geom_event.c:165 848 2 972 LOCK (sleep mutex) GEOM orphanage r = 0 at ../../../geom/geom_event.c:170 849 2 752 UNLOCK (sleep mutex) GEOM orphanage r = 0 at ../../../geom/geom_event.c:173 850 2 796 XUNLOCK (sx) GEOM topology r = 0 at ../../../geom/geom_event.c:174 851 2 716 XLOCK (sx) GEOM topology r = 0 at ../../../geom/geom_event.c:202 852 2 844 XUNLOCK (sx) GEOM topology r = 0 at ../../../geom/geom_event.c:209 853 2 720 LOCK (spin mutex) sleepq chain r = 0 at ../../../kern/subr_sleepqueue.c:223 854 2 476 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_synch.c:169 855 2 600 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_synch.c:190 856 2 796 msleep: thread 0xc2666580 (pid 2, g_event) on - (0xc0891afc) 857 2 464 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:297 858 2 784 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:300 859 2 548 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 860 2 808 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 861 2 472 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_synch.c:229 862 2 736 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_synch.c:231 863 2 444 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:407 864 2 3248 UNLOCK (spin mutex) sleepq chain r = 0 at ../../../kern/subr_sleepqueue.c:408 865 2 972 mi_switch: old thread 0xc2666580 (kse 0xc2667980, pid 2, g_event) 866 2 480 mi_switch: new thread 0xc26616e0 (kse 0xc2667d40, pid 12, idle: cpu2) 867 2 485244 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:110 868 0 18692756 intr_execute_handlers: executing handler 0xc07787fc(0xdb897c98) 869 0 4662064 intr_execute_handlers: executing handler 0xc07787fc(0xdb897c98) 870 0 7252 intr_execute_handlers: executing handler 0xc07784bc(0xdb897c98) 871 0 584 swi_sched pid 38(swi5: clock sio) need=0 872 0 612 ithread_schedule: pid 38: (swi5: clock sio) need = 0 873 0 820 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:407 874 0 1524 ithread_schedule: setrunqueue 38 875 0 2076 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:416 876 0 2584 LOCK (spin mutex) icu r = 0 at ../../../i386/isa/atpic.c:268 877 0 732 UNLOCK (spin mutex) icu r = 0 at ../../../i386/isa/atpic.c:270 878 2 2116 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:108 879 0 2828 _mtx_lock_spin: 0xc0e95940 spinning 880 2 3484 mi_switch: old thread 0xc26616e0 (kse 0xc2667d40, pid 12, idle: cpu2) 881 2 512 mi_switch: new thread 0xc2666160 (kse 0xc26678c0, pid 38, swi5: clock sio) 882 2 668 ithread_loop: pid 38: resumed 883 2 1648 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:613 884 2 416 ithread_loop: pid 38: (swi5: clock sio) need=1 885 0 1264 _mtx_lock_spin: 0xc0e95940 spin done 886 0 720 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:108 887 2 1360 ithread_loop: pid 38 ih=0xc26b51c0: 0xc06051d8(0x0) flg=80000000 888 2 1524 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:201 889 2 1296 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 890 2 312 callout mpsafe 0xc067e3bc 891 0 972 mi_switch: old thread 0xc26619a0 (kse 0xc2667dc0, pid 14, idle: cpu0) 892 2 1524 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 893 2 244 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 894 0 2056 mi_switch: new thread 0xc26619a0 (kse 0xc2667dc0, pid 14, idle: cpu0) 895 0 224 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:110 896 2 648 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 897 2 604 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 898 2 852 callout mpsafe 0xc06cea14 899 2 692 LOCK (sleep mutex) nfsd_mtx r = 0 at ../../../nfsserver/nfs_srvsock.c:811 900 2 728 UNLOCK (sleep mutex) nfsd_mtx r = 0 at ../../../nfsserver/nfs_srvsock.c:822 901 2 476 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 902 2 804 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 903 2 548 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 904 2 1128 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:305 905 2 484 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:606 906 2 3592 ithread_loop: pid 38: done 907 2 1076 mi_switch: old thread 0xc2666160 (kse 0xc26678c0, pid 38, swi5: clock sio) 908 2 452 mi_switch: new thread 0xc26616e0 (kse 0xc2667d40, pid 12, idle: cpu2) 909 2 13979020 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:110 910 0 9897084 intr_execute_handlers: executing handler 0xc07787fc(0xdb897c98) 911 0 7556 intr_execute_handlers: executing handler 0xc07784bc(0xdb897c98) 912 0 640 swi_sched pid 38(swi5: clock sio) need=0 913 0 652 ithread_schedule: pid 38: (swi5: clock sio) need = 0 914 0 1096 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:407 915 0 1280 ithread_schedule: setrunqueue 38 916 0 2028 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:416 917 0 2652 LOCK (spin mutex) icu r = 0 at ../../../i386/isa/atpic.c:268 918 0 836 UNLOCK (spin mutex) icu r = 0 at ../../../i386/isa/atpic.c:270 919 2 2372 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:108 920 0 2676 _mtx_lock_spin: 0xc0e95940 spinning 921 2 2804 mi_switch: old thread 0xc26616e0 (kse 0xc2667d40, pid 12, idle: cpu2) 922 2 508 mi_switch: new thread 0xc2666160 (kse 0xc26678c0, pid 38, swi5: clock sio) 923 2 668 ithread_loop: pid 38: resumed 924 2 1672 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:613 925 2 456 ithread_loop: pid 38: (swi5: clock sio) need=1 926 0 1176 _mtx_lock_spin: 0xc0e95940 spin done 927 2 432 ithread_loop: pid 38 ih=0xc26b51c0: 0xc06051d8(0x0) flg=80000000 928 0 892 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:108 929 2 1680 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:201 930 2 628 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 931 2 804 callout mpsafe 0xc067e3bc 932 2 536 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 933 2 1512 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 934 2 320 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 935 0 548 mi_switch: old thread 0xc26619a0 (kse 0xc2667dc0, pid 14, idle: cpu0) 936 2 1940 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 937 2 1220 callout mpsafe 0xc06cea14 938 0 332 mi_switch: new thread 0xc26619a0 (kse 0xc2667dc0, pid 14, idle: cpu0) 939 2 828 LOCK (sleep mutex) nfsd_mtx r = 0 at ../../../nfsserver/nfs_srvsock.c:811 940 0 1108 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:110 941 2 1012 UNLOCK (sleep mutex) nfsd_mtx r = 0 at ../../../nfsserver/nfs_srvsock.c:822 942 2 528 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 943 2 788 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 944 2 768 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 945 2 1320 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:305 946 2 480 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:606 947 2 3368 ithread_loop: pid 38: done 948 2 1188 mi_switch: old thread 0xc2666160 (kse 0xc26678c0, pid 38, swi5: clock sio) 949 2 456 mi_switch: new thread 0xc26616e0 (kse 0xc2667d40, pid 12, idle: cpu2) 950 2 8744644 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:110 951 0 15131212 intr_execute_handlers: executing handler 0xc07787fc(0xdb897c98) 952 0 7228 intr_execute_handlers: executing handler 0xc07784bc(0xdb897c98) 953 0 616 swi_sched pid 38(swi5: clock sio) need=0 954 0 736 ithread_schedule: pid 38: (swi5: clock sio) need = 0 955 0 704 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:407 956 0 1264 ithread_schedule: setrunqueue 38 957 0 2064 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:416 958 0 3500 LOCK (spin mutex) icu r = 0 at ../../../i386/isa/atpic.c:268 959 0 468 UNLOCK (spin mutex) icu r = 0 at ../../../i386/isa/atpic.c:270 960 2 2176 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:108 961 0 2364 _mtx_lock_spin: 0xc0e95940 spinning 962 2 3468 mi_switch: old thread 0xc26616e0 (kse 0xc2667d40, pid 12, idle: cpu2) 963 2 504 mi_switch: new thread 0xc2666160 (kse 0xc26678c0, pid 38, swi5: clock sio) 964 2 680 ithread_loop: pid 38: resumed 965 2 1624 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:613 966 2 448 ithread_loop: pid 38: (swi5: clock sio) need=1 967 0 756 _mtx_lock_spin: 0xc0e95940 spin done 968 2 388 ithread_loop: pid 38 ih=0xc26b51c0: 0xc06051d8(0x0) flg=80000000 969 0 880 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:108 970 2 1824 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:201 971 2 624 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 972 2 800 callout mpsafe 0xc067e3bc 973 2 612 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 974 0 752 mi_switch: old thread 0xc26619a0 (kse 0xc2667dc0, pid 14, idle: cpu0) 975 2 2300 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 976 2 292 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 977 0 1740 mi_switch: new thread 0xc26619a0 (kse 0xc2667dc0, pid 14, idle: cpu0) 978 2 332 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 979 0 1048 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:110 980 2 680 callout mpsafe 0xc06cea14 981 2 1040 LOCK (sleep mutex) nfsd_mtx r = 0 at ../../../nfsserver/nfs_srvsock.c:811 982 2 740 UNLOCK (sleep mutex) nfsd_mtx r = 0 at ../../../nfsserver/nfs_srvsock.c:822 983 2 484 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 984 2 1052 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 985 2 528 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 986 2 1160 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:305 987 2 468 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:606 988 2 4488 ithread_loop: pid 38: done 989 2 1396 mi_switch: old thread 0xc2666160 (kse 0xc26678c0, pid 38, swi5: clock sio) 990 2 448 mi_switch: new thread 0xc26616e0 (kse 0xc2667d40, pid 12, idle: cpu2) 991 2 3507864 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:110 992 0 18691072 intr_execute_handlers: executing handler 0xc07787fc(0xdb897c98) 993 0 1676004 intr_execute_handlers: executing handler 0xc07787fc(0xdb897c98) 994 0 7428 intr_execute_handlers: executing handler 0xc07784bc(0xdb897c98) 995 0 572 swi_sched pid 38(swi5: clock sio) need=0 996 0 612 ithread_schedule: pid 38: (swi5: clock sio) need = 0 997 0 928 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:407 998 0 1328 ithread_schedule: setrunqueue 38 999 0 2064 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:416 1000 0 3008 LOCK (spin mutex) icu r = 0 at ../../../i386/isa/atpic.c:268 1001 0 296 UNLOCK (spin mutex) icu r = 0 at ../../../i386/isa/atpic.c:270 1002 2 2544 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:108 1003 0 2648 _mtx_lock_spin: 0xc0e95940 spinning 1004 2 3156 mi_switch: old thread 0xc26616e0 (kse 0xc2667d40, pid 12, idle: cpu2) 1005 2 552 mi_switch: new thread 0xc2666160 (kse 0xc26678c0, pid 38, swi5: clock sio) 1006 2 684 ithread_loop: pid 38: resumed 1007 2 1648 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:613 1008 2 464 ithread_loop: pid 38: (swi5: clock sio) need=1 1009 0 772 _mtx_lock_spin: 0xc0e95940 spin done 1010 0 568 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:108 1011 2 2056 ithread_loop: pid 38 ih=0xc26b51c0: 0xc06051d8(0x0) flg=80000000 1012 2 1524 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:201 1013 2 1712 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 1014 2 80 LOCK (sleep mutex) Giant r = 0 at ../../../kern/kern_timeout.c:247 1015 0 796 mi_switch: old thread 0xc26619a0 (kse 0xc2667dc0, pid 14, idle: cpu0) 1016 2 2228 callout 0xc075b154 1017 0 312 mi_switch: new thread 0xc26619a0 (kse 0xc2667dc0, pid 14, idle: cpu0) 1018 2 824 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:333 1019 0 1176 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:110 1020 2 500 LOCK (spin mutex) callout r = 1 at ../../../kern/kern_timeout.c:398 1021 2 804 UNLOCK (spin mutex) callout r = 1 at ../../../kern/kern_timeout.c:439 1022 2 772 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:345 1023 2 724 UNLOCK (sleep mutex) Giant r = 0 at ../../../kern/kern_timeout.c:279 1024 2 884 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 1025 2 664 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 1026 2 744 callout mpsafe 0xc067e3bc 1027 2 496 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 1028 2 832 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 1029 2 512 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 1030 2 596 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 1031 2 608 callout mpsafe 0xc06cea14 1032 2 544 LOCK (sleep mutex) nfsd_mtx r = 0 at ../../../nfsserver/nfs_srvsock.c:811 1033 2 752 UNLOCK (sleep mutex) nfsd_mtx r = 0 at ../../../nfsserver/nfs_srvsock.c:822 1034 2 480 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 1035 2 792 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 1036 2 524 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 1037 2 1172 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:305 1038 2 492 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:606 1039 2 3032 ithread_loop: pid 38: done 1040 2 1224 mi_switch: old thread 0xc2666160 (kse 0xc26678c0, pid 38, swi5: clock sio) 1041 2 488 mi_switch: new thread 0xc26616e0 (kse 0xc2667d40, pid 12, idle: cpu2) 1042 2 16960588 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:110 1043 0 6909412 intr_execute_handlers: executing handler 0xc07787fc(0xdb897c98) 1044 0 7264 intr_execute_handlers: executing handler 0xc07784bc(0xdb897c98) 1045 0 716 swi_sched pid 38(swi5: clock sio) need=0 1046 0 636 ithread_schedule: pid 38: (swi5: clock sio) need = 0 1047 0 736 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:407 1048 0 1760 ithread_schedule: setrunqueue 38 1049 0 2028 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:416 1050 0 3500 LOCK (spin mutex) icu r = 0 at ../../../i386/isa/atpic.c:268 1051 0 444 UNLOCK (spin mutex) icu r = 0 at ../../../i386/isa/atpic.c:270 1052 2 2228 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:108 1053 0 2836 _mtx_lock_spin: 0xc0e95940 spinning 1054 2 3528 mi_switch: old thread 0xc26616e0 (kse 0xc2667d40, pid 12, idle: cpu2) 1055 2 528 mi_switch: new thread 0xc2666160 (kse 0xc26678c0, pid 38, swi5: clock sio) 1056 2 920 ithread_loop: pid 38: resumed 1057 2 2140 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:613 1058 2 356 ithread_loop: pid 38: (swi5: clock sio) need=1 1059 0 604 _mtx_lock_spin: 0xc0e95940 spin done 1060 0 556 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:108 1061 2 1960 ithread_loop: pid 38 ih=0xc26b51c0: 0xc06051d8(0x0) flg=80000000 1062 2 1372 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:201 1063 2 696 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 1064 0 364 mi_switch: old thread 0xc26619a0 (kse 0xc2667dc0, pid 14, idle: cpu0) 1065 2 600 LOCK (sleep mutex) Giant r = 0 at ../../../kern/kern_timeout.c:247 1066 2 896 callout 0xc0652560 1067 0 616 mi_switch: new thread 0xc26619a0 (kse 0xc2667dc0, pid 14, idle: cpu0) 1068 0 1036 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:110 1069 2 5488 LOCK (sleep mutex) ifnet r = 0 at ../../../net/if.c:1034 1070 2 740 UNLOCK (sleep mutex) ifnet r = 0 at ../../../net/if.c:1041 1071 2 768 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:333 1072 2 1072 LOCK (spin mutex) callout r = 1 at ../../../kern/kern_timeout.c:398 1073 2 620 UNLOCK (spin mutex) callout r = 1 at ../../../kern/kern_timeout.c:439 1074 2 740 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:345 1075 2 704 UNLOCK (sleep mutex) Giant r = 0 at ../../../kern/kern_timeout.c:279 1076 2 600 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 1077 2 1052 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 1078 2 436 LOCK (sleep mutex) Giant r = 0 at ../../../kern/kern_timeout.c:247 1079 2 1492 callout 0xc069a9b8 1080 2 556 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 1081 2 10572 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 1082 2 716 UNLOCK (sleep mutex) Giant r = 0 at ../../../kern/kern_timeout.c:279 1083 2 540 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 1084 2 632 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 1085 2 1636 callout mpsafe 0xc060074c 1086 2 1056 sleepq_broadcast(0xc0e971ac, 0) 1087 2 2240 LOCK (spin mutex) sleepq chain r = 0 at ../../../kern/subr_sleepqueue.c:223 1088 2 612 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:603 1089 2 692 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:606 1090 2 972 UNLOCK (spin mutex) sleepq chain r = 0 at ../../../kern/subr_sleepqueue.c:239 1091 2 824 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:623 1092 2 1976 sleepq_wakeup: thread 0xc26bddc0 (pid 57, syncer) 1093 2 976 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:633 1094 2 508 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 1095 2 796 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 1096 2 684 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 1097 2 608 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 1098 2 788 callout mpsafe 0xc0626af4 1099 2 1060 LOCK (sleep mutex) ip6qlock r = 0 at ../../../netinet6/frag6.c:687 1100 2 1124 UNLOCK (sleep mutex) ip6qlock r = 0 at ../../../netinet6/frag6.c:710 1101 2 1720 LOCK (sleep mutex) ipqlock r = 0 at ../../../netinet/ip_input.c:1237 1102 2 888 UNLOCK (sleep mutex) ipqlock r = 0 at ../../../netinet/ip_input.c:1264 1103 2 956 LOCK (sleep mutex) tcp r = 0 at ../../../netinet/tcp_timer.c:138 1104 2 880 UNLOCK (sleep mutex) tcp r = 0 at ../../../netinet/tcp_timer.c:140 1105 2 484 LOCK (sleep mutex) igmp_mtx r = 0 at ../../../netinet/igmp.c:435 1106 2 1076 UNLOCK (sleep mutex) igmp_mtx r = 0 at ../../../netinet/igmp.c:443 1107 2 876 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 1108 2 796 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 1109 2 660 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 1110 2 816 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 1111 2 412 LOCK (sleep mutex) Giant r = 0 at ../../../kern/kern_timeout.c:247 1112 2 808 callout 0xc059e7d8 1113 2 1212 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 1114 2 4432 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 1115 2 732 UNLOCK (sleep mutex) Giant r = 0 at ../../../kern/kern_timeout.c:279 1116 2 524 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 1117 2 788 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 1118 2 428 LOCK (sleep mutex) Giant r = 0 at ../../../kern/kern_timeout.c:247 1119 2 716 callout 0xc059e7d8 1120 2 500 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 1121 2 4296 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 1122 2 740 UNLOCK (sleep mutex) Giant r = 0 at ../../../kern/kern_timeout.c:279 1123 2 576 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 1124 2 592 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 1125 2 1308 callout mpsafe 0xc0626b50 1126 2 476 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 1127 2 792 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 1128 2 528 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 1129 2 776 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 1130 2 440 LOCK (sleep mutex) Giant r = 0 at ../../../kern/kern_timeout.c:247 1131 2 4780 callout 0xc0503730 1132 2 488 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 1133 2 692 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 1134 2 712 UNLOCK (sleep mutex) Giant r = 0 at ../../../kern/kern_timeout.c:279 1135 2 504 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 1136 2 580 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 1137 2 664 callout mpsafe 0xc060859c 1138 2 1772 LOCK (spin mutex) sched lock r = 0 at ../../../kern/sched_4bsd.c:188 1139 2 796 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/sched_4bsd.c:190 1140 2 472 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 1141 2 804 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 1142 2 576 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 1143 2 768 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 1144 2 416 LOCK (sleep mutex) Giant r = 0 at ../../../kern/kern_timeout.c:247 1145 2 3920 callout 0xc074ab90 1146 2 772 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:333 1147 2 476 LOCK (spin mutex) callout r = 1 at ../../../kern/kern_timeout.c:398 1148 2 524 UNLOCK (spin mutex) callout r = 1 at ../../../kern/kern_timeout.c:439 1149 2 808 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:345 1150 2 728 UNLOCK (sleep mutex) Giant r = 0 at ../../../kern/kern_timeout.c:279 1151 2 520 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 1152 2 592 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 1153 2 488 callout mpsafe 0xc06149ec 1154 2 644 sleepq_timeout: thread 0xc26db580 (pid 4, g_down) 1155 2 468 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:724 1156 2 832 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:727 1157 2 716 LOCK (spin mutex) sleepq chain r = 0 at ../../../kern/subr_sleepqueue.c:223 1158 2 472 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:729 1159 2 836 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:749 1160 2 448 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:603 1161 2 664 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:606 1162 2 832 UNLOCK (spin mutex) sleepq chain r = 0 at ../../../kern/subr_sleepqueue.c:239 1163 2 408 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:623 1164 2 776 sleepq_wakeup: thread 0xc26db580 (pid 4, g_down) 1165 2 836 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:633 1166 2 524 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 1167 2 612 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 1168 2 756 callout mpsafe 0xc067e3bc 1169 2 584 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 1170 2 796 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 1171 2 548 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 1172 2 612 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 1173 2 644 callout mpsafe 0xc06cea14 1174 2 572 LOCK (sleep mutex) nfsd_mtx r = 0 at ../../../nfsserver/nfs_srvsock.c:811 1175 2 716 UNLOCK (sleep mutex) nfsd_mtx r = 0 at ../../../nfsserver/nfs_srvsock.c:822 1176 2 512 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 1177 2 820 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 1178 2 620 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 1179 2 872 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:305 1180 2 460 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:606 1181 2 3024 ithread_loop: pid 38: done 1182 2 940 mi_switch: old thread 0xc2666160 (kse 0xc26678c0, pid 38, swi5: clock sio) 1183 2 480 mi_switch: new thread 0xc26db580 (kse 0xc26673c0, pid 4, g_down) 1184 2 488 sleepq resume: thread 0xc26db580 (pid 4, g_down) 1185 2 1008 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:546 1186 2 776 LOCK (sleep mutex) bio queue r = 0 at ../../../geom/geom_io.c:65 1187 2 632 LOCK (spin mutex) sleepq chain r = 0 at ../../../kern/subr_sleepqueue.c:223 1188 2 464 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_synch.c:169 1189 2 648 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_synch.c:190 1190 2 472 msleep: thread 0xc26db580 (pid 4, g_down) on - (0xc0891b08) 1191 2 768 UNLOCK (sleep mutex) bio queue r = 0 at ../../../kern/kern_synch.c:198 1192 2 468 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:297 1193 2 860 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:300 1194 2 560 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 1195 2 752 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 1196 2 472 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_synch.c:229 1197 2 744 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_synch.c:231 1198 2 448 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:407 1199 2 3472 UNLOCK (spin mutex) sleepq chain r = 0 at ../../../kern/subr_sleepqueue.c:408 1200 2 2552 mi_switch: old thread 0xc26db580 (kse 0xc26673c0, pid 4, g_down) 1201 2 440 mi_switch: new thread 0xc26bddc0 (kse 0xc2667280, pid 57, syncer) 1202 2 492 sleepq resume: thread 0xc26bddc0 (pid 57, syncer) 1203 2 1632 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:517 1204 2 2336 LOCK (sleep mutex) Giant r = 0 at ../../../kern/kern_synch.c:249 1205 2 2380 LOCK (sleep mutex) Syncer mtx r = 0 at ../../../kern/vfs_subr.c:1570 1206 2 2336 UNLOCK (sleep mutex) Syncer mtx r = 0 at ../../../kern/vfs_subr.c:1666 1207 2 1008 LOCK (sleep mutex) Syncer mtx r = 0 at ../../../kern/vfs_subr.c:1684 1208 2 840 UNLOCK (sleep mutex) Syncer mtx r = 0 at ../../../kern/vfs_subr.c:1690 1209 2 624 LOCK (spin mutex) sleepq chain r = 0 at ../../../kern/subr_sleepqueue.c:223 1210 2 572 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_synch.c:169 1211 2 548 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_synch.c:190 1212 2 472 msleep: thread 0xc26bddc0 (pid 57, syncer) on syncer (0xc0e971ac) 1213 2 1152 UNLOCK (sleep mutex) Giant r = 0 at ../../../kern/kern_synch.c:194 1214 2 452 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:297 1215 2 740 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:300 1216 2 440 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_synch.c:229 1217 2 752 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_synch.c:231 1218 2 432 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:407 1219 2 3284 UNLOCK (spin mutex) sleepq chain r = 0 at ../../../kern/subr_sleepqueue.c:408 1220 2 1612 mi_switch: old thread 0xc26bddc0 (kse 0xc2667280, pid 57, syncer) 1221 2 468 mi_switch: new thread 0xc26616e0 (kse 0xc2667d40, pid 12, idle: cpu2) 1222 2 11587396 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:110 1223 0 12144920 intr_execute_handlers: executing handler 0xc07787fc(0xdb897c98) 1224 0 6992 intr_execute_handlers: executing handler 0xc07784bc(0xdb897c98) 1225 0 584 swi_sched pid 38(swi5: clock sio) need=0 1226 0 780 ithread_schedule: pid 38: (swi5: clock sio) need = 0 1227 0 676 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:407 1228 0 1312 ithread_schedule: setrunqueue 38 1229 0 2140 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:416 1230 0 3484 LOCK (spin mutex) icu r = 0 at ../../../i386/isa/atpic.c:268 1231 0 444 UNLOCK (spin mutex) icu r = 0 at ../../../i386/isa/atpic.c:270 1232 2 2084 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:108 1233 0 2400 _mtx_lock_spin: 0xc0e95940 spinning 1234 2 3412 mi_switch: old thread 0xc26616e0 (kse 0xc2667d40, pid 12, idle: cpu2) 1235 2 536 mi_switch: new thread 0xc2666160 (kse 0xc26678c0, pid 38, swi5: clock sio) 1236 2 500 ithread_loop: pid 38: resumed 1237 2 1732 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:613 1238 0 376 _mtx_lock_spin: 0xc0e95940 spin done 1239 2 1588 ithread_loop: pid 38: (swi5: clock sio) need=1 1240 0 684 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:108 1241 2 1108 ithread_loop: pid 38 ih=0xc26b51c0: 0xc06051d8(0x0) flg=80000000 1242 2 1880 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:201 1243 2 1408 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 1244 2 428 callout mpsafe 0xc06149ec 1245 0 1188 mi_switch: old thread 0xc26619a0 (kse 0xc2667dc0, pid 14, idle: cpu0) 1246 2 980 sleepq_timeout: thread 0xc26bdc60 (pid 56, bufdaemon) 1247 0 984 mi_switch: new thread 0xc26619a0 (kse 0xc2667dc0, pid 14, idle: cpu0) 1248 2 1148 _mtx_lock_spin: 0xc0e95940 spinning 1249 0 2980 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_idle.c:110 1250 2 792 _mtx_lock_spin: 0xc0e95940 spin done 1251 2 1116 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:724 1252 2 1396 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:727 1253 2 776 LOCK (spin mutex) sleepq chain r = 0 at ../../../kern/subr_sleepqueue.c:223 1254 2 472 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:729 1255 2 844 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:749 1256 2 480 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:603 1257 2 616 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:606 1258 2 836 UNLOCK (spin mutex) sleepq chain r = 0 at ../../../kern/subr_sleepqueue.c:239 1259 2 440 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:623 1260 2 2152 sleepq_wakeup: thread 0xc26bdc60 (pid 56, bufdaemon) 1261 2 1012 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:633 1262 2 596 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 1263 2 588 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 1264 2 1208 callout mpsafe 0xc06149ec 1265 2 596 sleepq_timeout: thread 0xc26db000 (pid 58, vnlru) 1266 2 460 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:724 1267 2 1068 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:727 1268 2 1212 LOCK (spin mutex) sleepq chain r = 0 at ../../../kern/subr_sleepqueue.c:223 1269 2 448 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:729 1270 2 800 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:749 1271 2 444 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:603 1272 2 608 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:606 1273 2 788 UNLOCK (spin mutex) sleepq chain r = 0 at ../../../kern/subr_sleepqueue.c:239 1274 2 408 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:623 1275 2 1024 sleepq_wakeup: thread 0xc26db000 (pid 58, vnlru) 1276 2 780 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:633 1277 2 548 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 1278 2 604 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 1279 2 1188 callout mpsafe 0xc06149ec 1280 2 564 sleepq_timeout: thread 0xc2af1840 (pid 63, schedcpu) 1281 2 808 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:724 1282 2 816 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:727 1283 2 756 LOCK (spin mutex) sleepq chain r = 0 at ../../../kern/subr_sleepqueue.c:223 1284 2 444 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:729 1285 2 832 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:749 1286 2 444 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:603 1287 2 608 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:606 1288 2 756 UNLOCK (spin mutex) sleepq chain r = 0 at ../../../kern/subr_sleepqueue.c:239 1289 2 428 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:623 1290 2 1276 sleepq_wakeup: thread 0xc2af1840 (pid 63, schedcpu) 1291 2 808 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:633 1292 2 576 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 1293 2 612 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 1294 2 784 callout mpsafe 0xc06149ec 1295 2 584 sleepq_timeout: thread 0xc26db420 (pid 3, g_up) 1296 2 428 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:724 1297 2 824 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:727 1298 2 672 LOCK (spin mutex) sleepq chain r = 0 at ../../../kern/subr_sleepqueue.c:223 1299 2 440 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:729 1300 2 744 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:749 1301 2 564 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:603 1302 2 628 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:606 1303 2 740 UNLOCK (spin mutex) sleepq chain r = 0 at ../../../kern/subr_sleepqueue.c:239 1304 2 412 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:623 1305 2 652 sleepq_wakeup: thread 0xc26db420 (pid 3, g_up) 1306 2 796 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:633 1307 2 528 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 1308 2 576 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 1309 2 440 callout mpsafe 0xc06149ec 1310 2 580 sleepq_timeout: thread 0xc26db6e0 (pid 41, yarrow) 1311 2 428 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:724 1312 2 788 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:727 1313 2 648 LOCK (spin mutex) sleepq chain r = 0 at ../../../kern/subr_sleepqueue.c:223 1314 2 444 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:729 1315 2 800 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:749 1316 2 444 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:603 1317 2 664 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:606 1318 2 776 UNLOCK (spin mutex) sleepq chain r = 0 at ../../../kern/subr_sleepqueue.c:239 1319 2 408 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:623 1320 2 648 sleepq_wakeup: thread 0xc26db6e0 (pid 41, yarrow) 1321 2 800 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:633 1322 2 536 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 1323 2 576 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 1324 2 756 callout mpsafe 0xc067e3bc 1325 2 536 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 1326 2 804 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 1327 2 560 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 1328 2 592 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:245 1329 2 656 callout mpsafe 0xc06cea14 1330 2 676 LOCK (sleep mutex) nfsd_mtx r = 0 at ../../../nfsserver/nfs_srvsock.c:811 1331 2 748 UNLOCK (sleep mutex) nfsd_mtx r = 0 at ../../../nfsserver/nfs_srvsock.c:822 1332 2 472 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 1333 2 812 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 1334 2 544 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:280 1335 2 872 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:305 1336 2 484 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_intr.c:606 1337 2 3388 ithread_loop: pid 38: done 1338 2 1940 mi_switch: old thread 0xc2666160 (kse 0xc26678c0, pid 38, swi5: clock sio) 1339 2 1232 mi_switch: new thread 0xc26bdc60 (kse 0xc2667240, pid 56, bufdaemon) 1340 2 564 sleepq resume: thread 0xc26bdc60 (pid 56, bufdaemon) 1341 2 1292 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:546 1342 2 1448 LOCK (sleep mutex) Giant r = 0 at ../../../kern/kern_synch.c:249 1343 2 1404 LOCK (sleep mutex) buffer daemon lock r = 0 at ../../../kern/kern_synch.c:251 1344 2 2284 UNLOCK (sleep mutex) buffer daemon lock r = 0 at ../../../kern/vfs_bio.c:2079 1345 2 528 LOCK (sleep mutex) process lock r = 0 at ../../../kern/kern_kthread.c:182 1346 2 808 UNLOCK (sleep mutex) process lock r = 0 at ../../../kern/kern_kthread.c:187 1347 2 700 LOCK (sleep mutex) buffer daemon lock r = 0 at ../../../kern/vfs_bio.c:2113 1348 2 728 LOCK (spin mutex) sleepq chain r = 0 at ../../../kern/subr_sleepqueue.c:223 1349 2 568 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_synch.c:169 1350 2 612 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_synch.c:190 1351 2 500 msleep: thread 0xc26bdc60 (pid 56, bufdaemon) on psleep (0xc0e9d12c) 1352 2 624 UNLOCK (sleep mutex) Giant r = 0 at ../../../kern/kern_synch.c:194 1353 2 864 UNLOCK (sleep mutex) buffer daemon lock r = 0 at ../../../kern/kern_synch.c:198 1354 2 476 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:297 1355 2 836 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:300 1356 2 644 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 1357 2 844 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 1358 2 480 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_synch.c:229 1359 2 732 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_synch.c:231 1360 2 448 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:407 1361 2 3704 UNLOCK (spin mutex) sleepq chain r = 0 at ../../../kern/subr_sleepqueue.c:408 1362 2 928 mi_switch: old thread 0xc26bdc60 (kse 0xc2667240, pid 56, bufdaemon) 1363 2 428 mi_switch: new thread 0xc26db420 (kse 0xc2667380, pid 3, g_up) 1364 2 488 sleepq resume: thread 0xc26db420 (pid 3, g_up) 1365 2 996 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:546 1366 2 884 LOCK (sleep mutex) bio queue r = 0 at ../../../geom/geom_io.c:65 1367 2 596 LOCK (spin mutex) sleepq chain r = 0 at ../../../kern/subr_sleepqueue.c:223 1368 2 468 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_synch.c:169 1369 2 572 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_synch.c:190 1370 2 500 msleep: thread 0xc26db420 (pid 3, g_up) on - (0xc0891b04) 1371 2 780 UNLOCK (sleep mutex) bio queue r = 0 at ../../../kern/kern_synch.c:198 1372 2 460 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:297 1373 2 784 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:300 1374 2 488 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 1375 2 704 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 1376 2 440 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_synch.c:229 1377 2 740 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_synch.c:231 1378 2 432 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:407 1379 2 3564 UNLOCK (spin mutex) sleepq chain r = 0 at ../../../kern/subr_sleepqueue.c:408 1380 2 2496 mi_switch: old thread 0xc26db420 (kse 0xc2667380, pid 3, g_up) 1381 2 516 mi_switch: new thread 0xc26db000 (kse 0xc26672c0, pid 58, vnlru) 1382 2 1396 sleepq resume: thread 0xc26db000 (pid 58, vnlru) 1383 2 976 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:546 1384 2 1820 LOCK (sleep mutex) Giant r = 0 at ../../../kern/kern_synch.c:249 1385 2 464 LOCK (sleep mutex) process lock r = 0 at ../../../kern/kern_kthread.c:182 1386 2 1420 UNLOCK (sleep mutex) process lock r = 0 at ../../../kern/kern_kthread.c:187 1387 2 524 LOCK (sleep mutex) vnode_free_list r = 0 at ../../../kern/vfs_subr.c:580 1388 2 596 UNLOCK (sleep mutex) vnode_free_list r = 0 at ../../../kern/vfs_subr.c:582 1389 2 680 sleepq_broadcast(0xc0e9d5e4, 0) 1390 2 544 LOCK (spin mutex) sleepq chain r = 0 at ../../../kern/subr_sleepqueue.c:223 1391 2 924 UNLOCK (spin mutex) sleepq chain r = 0 at ../../../kern/subr_sleepqueue.c:239 1392 2 608 LOCK (spin mutex) sleepq chain r = 0 at ../../../kern/subr_sleepqueue.c:223 1393 2 436 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_synch.c:169 1394 2 608 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_synch.c:190 1395 2 456 msleep: thread 0xc26db000 (pid 58, vnlru) on vlruwt (0xc26dd534) 1396 2 864 UNLOCK (sleep mutex) Giant r = 0 at ../../../kern/kern_synch.c:194 1397 2 480 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:297 1398 2 744 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:300 1399 2 480 LOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:398 1400 2 696 UNLOCK (spin mutex) callout r = 0 at ../../../kern/kern_timeout.c:439 1401 2 444 LOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_synch.c:229 1402 2 720 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/kern_synch.c:231 1403 2 416 LOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:407 1404 2 3264 UNLOCK (spin mutex) sleepq chain r = 0 at ../../../kern/subr_sleepqueue.c:408 1405 2 3028 mi_switch: old thread 0xc26db000 (kse 0xc26672c0, pid 58, vnlru) 1406 2 1164 mi_switch: new thread 0xc2af1840 (kse 0xc2668c40, pid 63, schedcpu) 1407 2 448 sleepq resume: thread 0xc2af1840 (pid 63, schedcpu) 1408 2 4716 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/subr_sleepqueue.c:546 1409 2 1120 SLOCK (sx) allproc r = 0 at ../../../kern/sched_4bsd.c:298 1410 2 2104 LOCK (spin mutex) sched lock r = 0 at ../../../kern/sched_4bsd.c:303 1411 2 820 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/sched_4bsd.c:389 1412 2 2276 LOCK (spin mutex) sched lock r = 0 at ../../../kern/sched_4bsd.c:303 1413 2 936 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/sched_4bsd.c:389 1414 2 2364 LOCK (spin mutex) sched lock r = 0 at ../../../kern/sched_4bsd.c:303 1415 2 740 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/sched_4bsd.c:389 1416 2 2460 LOCK (spin mutex) sched lock r = 0 at ../../../kern/sched_4bsd.c:303 1417 2 768 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/sched_4bsd.c:389 1418 2 1180 LOCK (spin mutex) sched lock r = 0 at ../../../kern/sched_4bsd.c:303 1419 2 736 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/sched_4bsd.c:389 1420 2 1000 LOCK (spin mutex) sched lock r = 0 at ../../../kern/sched_4bsd.c:303 1421 2 768 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/sched_4bsd.c:389 1422 2 1480 LOCK (spin mutex) sched lock r = 0 at ../../../kern/sched_4bsd.c:303 1423 2 1148 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/sched_4bsd.c:389 1424 2 2032 LOCK (spin mutex) sched lock r = 0 at ../../../kern/sched_4bsd.c:303 1425 2 780 UNLOCK (spin mutex) sched lock r = 0 at ../../../kern/sched_4bsd.c:389 1426 2 1928 LOCK (spin mu