Re: zfs with operations like rm -rf takes a very long time recently
- In reply to: Mark Millard : "Re: zfs with operations like rm -rf takes a very long time recently"
- Go to: [ bottom of page ] [ top of archives ] [ this month ]
Date: Sun, 16 Oct 2022 22:20:41 UTC
A few hrs ago I rebooted and ran zpool scrub just-in-case, and it completed without issue:
# zpool status -v
pool: zroot
state: ONLINE
scan: scrub repaired 0B in 01:41:20 with 0 errors on Sun Oct 16 19:47:00 2022
config:
NAME STATE READ WRITE CKSUM
zroot ONLINE 0 0 0
da0p3 ONLINE 0 0 0
errors: No known data errors
On Sun, 16 Oct 2022, at 18:24, Mark Millard wrote:
> One thing we do not have is a set of before-the-problem data
> to compare against. It is hard to tell specifically what time
> frames have changed.
>
> I'd guess that each/any of the following could produce interesting
> background information during the problem:
>
> # zpool iostat -w
> # zpool iostat -l
> # zpool iostat -r
> # zpool iostat -q
Ok here's output when it was trying to du -sh /usr/ports. This also has the following sysctl set : vfs.zfs.per_txg_dirty_frees_percent=5
(it took this long to complete:
# date && du -sh /usr/ports && date
Sun Oct 16 23:06:24 BST 2022
8.7G /usr/ports
Sun Oct 16 23:14:25 BST 2022)
# zpool iostat -w
zroot total_wait disk_wait syncq_wait asyncq_wait
latency read write read write read write read write scrub trim rebuild
---------- ----- ----- ----- ----- ----- ----- ----- ----- ----- ----- -----
1ns 0 0 0 0 0 0 0 0 0 0 0
3ns 0 0 0 0 0 0 0 0 0 0 0
7ns 0 0 0 0 0 0 0 0 0 0 0
15ns 0 0 0 0 0 0 0 0 0 0 0
31ns 0 0 0 0 0 0 0 0 0 0 0
63ns 0 0 0 0 0 0 0 0 0 0 0
127ns 0 0 0 0 0 0 0 0 0 0 0
255ns 0 0 0 0 0 0 0 0 0 0 0
511ns 0 0 0 0 3 2.53K 0 7 0 0 0
1us 0 0 0 0 19.0K 6.38K 760 702 72 0 0
2us 0 0 0 0 12.5K 1.95K 1014 4.24K 520 0 0
4us 0 0 0 0 6.17K 7.76K 394 8.10K 224 0 0
8us 0 0 0 0 4.37K 8.12K 141 11.2K 167 0 0
16us 0 0 0 0 1.28K 302 57 2.17K 12 0 0
32us 0 0 0 0 68 34 3 380 1 0 0
65us 0 0 0 0 3 2 5 584 0 0 0
131us 0 0 0 0 7 1 10 1.41K 5 0 0
262us 0 0 0 0 4 1 96 4.26K 8 0 0
524us 12.5K 18.5K 13.0K 18.7K 5 0 145 14.1K 648 0 0
1ms 1.46K 23.6K 2.36K 161K 2 0 116 18.3K 259 0 0
2ms 881 42.5K 9.83K 60.9K 5 0 30 29.8K 256 0 0
4ms 1.05K 50.4K 59.6K 9.75K 22 0 55 44.3K 235 0 0
8ms 3.67K 61.0K 154K 4.47K 79 0 149 47.5K 16.2K 0 0
16ms 11.4K 21.5K 290K 6.40K 234 0 303 14.2K 77.8K 0 0
33ms 19.6K 17.9K 328K 7.10K 455 0 221 13.7K 40.7K 0 0
67ms 147K 13.6K 72.7K 2.23K 899 0 218 11.4K 42.2K 0 0
134ms 65.3K 12.8K 7.88K 1.98K 1.72K 0 368 10.7K 44.7K 0 0
268ms 70.9K 10.3K 4.42K 1.36K 2.60K 0 304 8.41K 64.2K 0 0
536ms 105K 1.73K 171 105 1.86K 0 170 1.42K 101K 0 0
1s 163K 221 11 0 211 0 117 182 161K 0 0
2s 160K 0 1 0 0 0 47 0 158K 0 0
4s 109K 0 0 0 0 0 0 0 108K 0 0
8s 60.6K 0 0 0 0 0 0 0 60.1K 0 0
17s 8.35K 0 0 0 0 0 0 0 8.29K 0 0
34s 1.56K 0 0 0 0 0 0 0 1.56K 0 0
68s 0 0 0 0 0 0 0 0 0 0 0
137s 0 0 0 0 0 0 0 0 0 0 0
---------------------------------------------------------------------------------------
# zpool iostat -l
capacity operations bandwidth total_wait disk_wait syncq_wait asyncq_wait scrub trim rebuild
pool alloc free read write read write read write read write read write read write wait wait wait
---------- ----- ----- ----- ----- ----- ----- ----- ----- ----- ----- ----- ----- ----- ----- ----- ----- -----
zroot 154G 758G 51 15 9.07M 448K 1s 22ms 19ms 4ms 32ms 3us 75ms 20ms 1s - -
# zpool iostat -r
zroot sync_read sync_write async_read async_write scrub trim rebuild
req_size ind agg ind agg ind agg ind agg ind agg ind agg ind agg
---------- ----- ----- ----- ----- ----- ----- ----- ----- ----- ----- ----- ----- ----- -----
512 20.4K 0 0 0 0 0 283 0 7.64K 0 0 0 0 0
1K 3.62K 0 0 0 0 0 1.23K 0 14.2K 0 0 0 0 0
2K 1.47K 0 0 0 0 0 5.10K 0 22.3K 0 0 0 0 0
4K 22.6K 0 11.9K 0 1.22K 0 79.1K 0 353K 0 0 0 0 0
8K 3.22K 14 13.3K 0 2.44K 107 37.3K 29.6K 19.1K 73.2K 0 0 0 0
16K 100 68 734 0 45 389 2.58K 28.3K 5.77K 87.1K 0 0 0 0
32K 274 48 623 0 29 248 18.9K 14.1K 4.25K 68.3K 0 0 0 0
64K 105 18 482 0 0 90 1.37K 15.6K 2.32K 37.7K 0 0 0 0
128K 0 5 60 0 0 37 0 9.20K 3.18K 23.1K 0 0 0 0
256K 0 1 0 0 0 18 0 3.47K 0 17.5K 0 0 0 0
512K 0 1 0 0 0 6 0 953 0 23.1K 0 0 0 0
1M 0 0 0 0 0 0 0 10 0 125K 0 0 0 0
2M 0 0 0 0 0 0 0 0 0 0 0 0 0 0
4M 0 0 0 0 0 0 0 0 0 0 0 0 0 0
8M 0 0 0 0 0 0 0 0 0 0 0 0 0 0
16M 0 0 0 0 0 0 0 0 0 0 0 0 0 0
------------------------------------------------------------------------------------------------------------
# zpool iostat -q
capacity operations bandwidth syncq_read syncq_write asyncq_read asyncq_write scrubq_read trimq_write rebuildq_write
pool alloc free read write read write pend activ pend activ pend activ pend activ pend activ pend activ pend activ
---------- ----- ----- ----- ----- ----- ----- ----- ----- ----- ----- ----- ----- ----- ----- ----- ----- ----- ----- ----- -----
zroot 154G 758G 51 15 9.06M 448K 0 1 0 0 0 0 0 0 0 0 0 0 0 0