DF-5382 / run.log
=== DF-5382 decisive run (module: umcsbusfreeze) === === kldload/kldunload rc=0 === HX5382: DF-5382 umcs intr-callback bus-freeze harness, hz=100, 4 ports, 500 ms/request, errpause=62 ms HX5382[A]: --- baseline (production umcs.c:756/766) --- HX5382: evil intr packet done (4 x 562.5 ms on the bus callback thread) HX5382: victim callback (other device's xfer) ran HX5382[A]: victim delay after 1 packet = 2226 ms (expect ~2250 baseline / ~0 fixed) HX5382: evil intr packet done (4 x 562.5 ms on the bus callback thread) HX5382: victim callback (other device's xfer) ran HX5382[A]: stream round 1: victim delay = 2169 ms HX5382: evil intr packet done (4 x 562.5 ms on the bus callback thread) HX5382: victim callback (other device's xfer) ran HX5382[A]: stream round 2: victim delay = 2158 ms HX5382: evil intr packet done (4 x 562.5 ms on the bus callback thread) HX5382: victim callback (other device's xfer) ran HX5382[A]: stream round 3: victim delay = 2159 ms HX5382[B]: --- fix mechanism (deferred status task) --- HX5382: (fixed) intr packet: deferred, bus thread free HX5382: victim callback (other device's xfer) ran HX5382[B]: victim delay after 1 packet = 0 ms (expect ~2250 baseline / ~0 fixed) HX5382: (fixed) intr packet: deferred, bus thread free HX5382: victim callback (other device's xfer) ran HX5382[B]: stream round 1: victim delay = 0 ms HX5382: (fixed) intr packet: deferred, bus thread free HX5382: victim callback (other device's xfer) ran HX5382[B]: stream round 2: victim delay = 0 ms HX5382: (fixed) intr packet: deferred, bus thread free HX5382: victim callback (other device's xfer) ran HX5382[B]: stream round 3: victim delay = 0 ms HX5382: (fixed) deferred status task done (4 x 562.5 ms on the ucom taskqueue, NOT on the bus thread) HX5382: harness complete HX5382: DF-5382 umcs intr-callback bus-freeze harness, hz=100, 4 ports, 500 ms/request, errpause=62 ms HX5382[A]: --- baseline (production umcs.c:756/766) --- HX5382: evil intr packet done (4 x 562.5 ms on the bus callback thread) HX5382: victim callback (other device's xfer) ran HX5382: evil intr packet done (4 x 562.5 ms on the bus callback thread) HX5382: victim callback (other device's xfer) ran HX5382[A]: stream round 1: victim delay = 2167 ms HX5382: evil intr packet done (4 x 562.5 ms on the bus callback thread) HX5382: victim callback (other device's xfer) ran HX5382[A]: stream round 2: victim delay = 2165 ms HX5382: evil intr packet done (4 x 562.5 ms on the bus callback thread) HX5382: victim callback (other device's xfer) ran HX5382[A]: stream round 3: victim delay = 2160 ms HX5382[B]: --- fix mechanism (deferred status task) --- HX5382: (fixed) intr packet: deferred, bus thread free HX5382: victim callback (other device's xfer) ran HX5382[B]: victim delay after 1 packet = 0 ms (expect ~2250 baseline / ~0 fixed) HX5382: (fixed) intr packet: deferred, bus thread free HX5382: victim callback (other device's xfer) ran HX5382[B]: stream round 1: victim delay = 0 ms HX5382: (fixed) intr packet: deferred, bus thread free HX5382: victim callback (other device's xfer) ran HX5382[B]: stream round 2: victim delay = 0 ms HX5382: (fixed) intr packet: deferred, bus thread free HX5382: victim callback (other device's xfer) ran HX5382[B]: stream round 3: victim delay = 0 ms HX5382: (fixed) deferred status task done (4 x 562.5 ms on the ucom taskqueue, NOT on the bus thread) HX5382: harness complete HX5382: DF-5382 umcs intr-callback bus-freeze harness, hz=100, 4 ports, 500 ms/request, errpause=62 ms HX5382[A]: --- baseline (production umcs.c:756/766) --- HX5382: evil intr packet done (4 x 562.5 ms on the bus callback thread) HX5382: victim callback (other device's xfer) ran HX5382[A]: victim delay after 1 packet = 2240 ms (expect ~2250 baseline / ~0 fixed) HX5382: evil intr packet done (4 x 562.5 ms on the bus callback thread) HX5382: victim callback (other device's xfer) ran HX5382[A]: stream round 1: victim delay = 2152 ms HX5382: evil intr packet done (4 x 562.5 ms on the bus callback thread) HX5382: victim callback (other device's xfer) ran HX5382[A]: stream round 2: victim delay = 2161 ms HX5382: evil intr packet done (4 x 562.5 ms on the bus callback thread) HX5382: victim callback (other device's xfer) ran HX5382[A]: stream round 3: victim delay = 2161 ms HX5382[B]: --- fix mechanism (deferred status task) --- HX5382: (fixed) intr packet: deferred, bus thread free HX5382: victim callback (other device's xfer) ran HX5382[B]: victim delay after 1 packet = 0 ms (expect ~2250 baseline / ~0 fixed) HX5382: (fixed) intr packet: deferred, bus thread free HX5382: victim callback (other device's xfer) ran HX5382[B]: stream round 1: victim delay = 0 ms HX5382: (fixed) intr packet: deferred, bus thread free HX5382: victim callback (other device's xfer) ran HX5382[B]: stream round 2: victim delay = 0 ms HX5382: (fixed) intr packet: deferred, bus thread free HX5382: victim callback (other device's xfer) ran HX5382[B]: stream round 3: victim delay = 0 ms HX5382: (fixed) deferred status task done (4 x 562.5 ms on the ucom taskqueue, NOT on the bus thread) HX5382: harness complete HX5382: DF-5382 umcs intr-callback bus-freeze harness, hz=100, 4 ports, 500 ms/request, errpause=62 ms HX5382[A]: --- baseline (production umcs.c:756/766) --- HX5382: evil intr packet done (4 x 562.5 ms on the bus callback thread) HX5382: victim callback (other device's xfer) ran HX5382: evil intr packet done (4 x 562.5 ms on the bus callback thread) HX5382: victim callback (other device's xfer) ran HX5382[A]: stream round 1: victim delay = 2157 ms HX5382: evil intr packet done (4 x 562.5 ms on the bus callback thread) HX5382: victim callback (other device's xfer) ran HX5382[A]: stream round 2: victim delay = 2168 ms HX5382: evil intr packet done (4 x 562.5 ms on the bus callback thread) HX5382: victim callback (other device's xfer) ran HX5382[A]: stream round 3: victim delay = 2163 ms HX5382[B]: --- fix mechanism (deferred status task) --- HX5382: (fixed) intr packet: deferred, bus thread free HX5382: victim callback (other device's xfer) ran HX5382[B]: victim delay after 1 packet = 0 ms (expect ~2250 baseline / ~0 fixed) HX5382: (fixed) intr packet: deferred, bus thread free HX5382: victim callback (other device's xfer) ran HX5382[B]: stream round 1: victim delay = 0 ms HX5382: (fixed) intr packet: deferred, bus thread free HX5382: victim callback (other device's xfer) ran HX5382[B]: stream round 2: victim delay = 0 ms HX5382: (fixed) intr packet: deferred, bus thread free HX5382: victim callback (other device's xfer) ran HX5382[B]: stream round 3: victim delay = 0 ms HX5382: (fixed) deferred status task done (4 x 562.5 ms on the ucom taskqueue, NOT on the bus thread) HX5382: harness complete