Originally Posted by
Doug S
Users should be aware and watch for anything odd.
I am very happy about this change and think it is years overdue.
I do wonder about this difference between lowlatency and the new combined:
That makes two of us on both statements:
Code:
root@me-on-zfs:/sys/kernel/tracing# tail -10 trace
<idle>-0 [007] d.h1. 2313.235147: #167376 context irq timer_latency 6795 ns
<...>-47436 [007] ....1 2313.235152: #167376 context thread timer_latency 10985 ns
<idle>-0 [008] d.h1. 2313.235178: #167376 context irq timer_latency 6589 ns
<...>-47437 [008] ....1 2313.235182: #167376 context thread timer_latency 10919 ns
<idle>-0 [009] d.h1. 2313.235216: #167376 context irq timer_latency 6315 ns
<...>-47438 [009] ....1 2313.235220: #167376 context thread timer_latency 10576 ns
<idle>-0 [010] d.h1. 2313.235260: #167376 context irq timer_latency 6880 ns
<...>-47439 [010] ....1 2313.235264: #167376 context thread timer_latency 11140 ns
<idle>-0 [011] d.h1. 2313.235291: #167376 context irq timer_latency 6465 ns
<...>-47440 [011] ....1 2313.235295: #167376 context thread timer_latency 10725 ns
And:
Code:
root@me-on-zfs:/sys/kernel/tracing# echo 500 > osnoise/stop_tracing_total_us
root@me-on-zfs:/sys/kernel/tracing# tail -21 per_cpu/cpu7/trace
<...>-47436 [007] ....1 2549.953151: #404094 context thread timer_latency 10963 ns
<idle>-0 [007] d.h1. 2549.954147: #404095 context irq timer_latency 6944 ns
<...>-47436 [007] ....1 2549.954151: #404095 context thread timer_latency 10715 ns
<idle>-0 [007] d.h1. 2549.955147: #404096 context irq timer_latency 6626 ns
<...>-47436 [007] ....1 2549.955152: #404096 context thread timer_latency 10956 ns
<idle>-0 [007] d.h1. 2549.956147: #404097 context irq timer_latency 6727 ns
<...>-47436 [007] ....1 2549.956151: #404097 context thread timer_latency 10988 ns
<idle>-0 [007] d.h1. 2549.957147: #404098 context irq timer_latency 6409 ns
<...>-47436 [007] ....1 2549.957151: #404098 context thread timer_latency 10600 ns
<idle>-0 [007] d.h1. 2549.958148: #404099 context irq timer_latency 7069 ns
<...>-47436 [007] ....1 2549.958152: #404099 context thread timer_latency 11330 ns
<idle>-0 [007] d.h1. 2549.959147: #404100 context irq timer_latency 6821 ns
<...>-47436 [007] ....1 2549.959152: #404100 context thread timer_latency 11152 ns
<idle>-0 [007] d.h1. 2549.960148: #404101 context irq timer_latency 7132 ns
<...>-47436 [007] ....1 2549.960152: #404101 context thread timer_latency 10974 ns
<idle>-0 [007] d.h1. 2549.961147: #404102 context irq timer_latency 6884 ns
<...>-47436 [007] ....1 2549.961152: #404102 context thread timer_latency 10586 ns
<idle>-0 [007] d.h1. 2549.962147: #404103 context irq timer_latency 6985 ns
<...>-47436 [007] ....1 2549.962151: #404103 context thread timer_latency 11316 ns
<idle>-0 [007] d.h1. 2549.963147: #404104 context irq timer_latency 6737 ns
<...>-47436 [007] ....1 2549.963152: #404104 context thread timer_latency 11068 ns
I see very little difference between the two