linux-kernel.vger.kernel.org archive mirror
 help / color / mirror / Atom feed
From: David Arendt <admin@prnet.org>
To: Filipe Manana <fdmanana@kernel.org>
Cc: Qu Wenruo <quwenruo.btrfs@gmx.com>,
	dsterba@suse.cz, Thorsten Leemhuis <regressions@leemhuis.info>,
	linux-btrfs <linux-btrfs@vger.kernel.org>,
	Chris Mason <clm@fb.com>, Josef Bacik <josef@toxicpanda.com>,
	David Sterba <dsterba@suse.com>,
	LKML <linux-kernel@vger.kernel.org>,
	"regressions@lists.linux.dev" <regressions@lists.linux.dev>
Subject: Re: [regression] Bug 216851 - btrfs write time corrupting for log tree
Date: Sun, 22 Jan 2023 21:45:39 +0100	[thread overview]
Message-ID: <bbdb2ebe-4af3-fee6-fb8a-de67144dc50a@prnet.org> (raw)
In-Reply-To: <ed7d2424-fb13-eccf-11ea-ac08c618f5aa@prnet.org>

On 1/22/23 16:53, David Arendt wrote:
> On 1/10/23 22:12, David Arendt wrote:
>> On 1/10/23 16:10, Filipe Manana wrote:
>>> On Thu, Jan 5, 2023 at 9:11 PM Filipe Manana <fdmanana@kernel.org> 
>>> wrote:
>>>> On Thu, Jan 5, 2023 at 6:24 PM David Arendt <admin@prnet.org> wrote:
>>>>> On 1/5/23 18:04, Filipe Manana wrote:
>>>>>> On Thu, Jan 5, 2023 at 4:49 PM David Arendt <admin@prnet.org> wrote:
>>>>>>> On 1/5/23 11:22, Filipe Manana wrote:
>>>>>>>> On Wed, Jan 4, 2023 at 7:35 PM David Arendt <admin@prnet.org> 
>>>>>>>> wrote:
>>>>>>>>> On 1/4/23 20:29, Filipe Manana wrote:
>>>>>>>>>> On Wed, Jan 4, 2023 at 7:26 PM David Arendt <admin@prnet.org> 
>>>>>>>>>> wrote:
>>>>>>>>>>> On 1/3/23 00:38, Qu Wenruo wrote:
>>>>>>>>>>>> On 2023/1/2 23:40, David Sterba wrote:
>>>>>>>>>>>>> On Tue, Dec 27, 2022 at 03:01:34PM +0100, Thorsten 
>>>>>>>>>>>>> Leemhuis wrote:
>>>>>>>>>>>>>> Hi, this is your Linux kernel regression tracker speaking.
>>>>>>>>>>>>>>
>>>>>>>>>>>>>> I noticed a regression report in bugzilla.kernel.org. As 
>>>>>>>>>>>>>> many (most?)
>>>>>>>>>>>>>> kernel developer don't keep an eye on it, I decided to 
>>>>>>>>>>>>>> forward it by
>>>>>>>>>>>>>> mail. Quoting from 
>>>>>>>>>>>>>> https://bugzilla.kernel.org/show_bug.cgi?id=216851 :
>>>>>>>>>>>>>>
>>>>>>>>>>>>>>> I am experiencing btrfs file system errors followed by a 
>>>>>>>>>>>>>>> switch to
>>>>>>>>>>>>>>> readony with kernel 6.1 and 6.1.1. It never happened 
>>>>>>>>>>>>>>> with kernel
>>>>>>>>>>>>>>> versions before.
>>>>>>>>>>>>>>>
>>>>>>>>>>>>>>> A btrfs scrub and a btrfs check --readonly returned 0 
>>>>>>>>>>>>>>> errors.
>>>>>>>>>>>>>>>
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - - 
>>>>>>>>>>>>>>> BTRFS
>>>>>>>>>>>>>>> critical (device sda2): corrupt leaf: 
>>>>>>>>>>>>>>> root=18446744073709551610
>>>>>>>>>>>>>>> block=203366612992 slot=73, bad key order, prev (484119 
>>>>>>>>>>>>>>> 96 1312873)
>>>>>>>>>>>>>>> current (484119 96 1312849)
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - - 
>>>>>>>>>>>>>>> BTRFS info
>>>>>>>>>>>>>>> (device sda2): leaf 203366612992 gen 5068802 total ptrs 
>>>>>>>>>>>>>>> 105 free
>>>>>>>>>>>>>>> space 10820 owner 18446744073709551610
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - - 
>>>>>>>>>>>>>>> \x09item 0
>>>>>>>>>>>>>>> key (484119 1 0) itemoff 16123 itemsize 160
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - -
>>>>>>>>>>>>>>> \x09\x09inode generation 45 size 2250 mode 40700
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - - 
>>>>>>>>>>>>>>> \x09item 1
>>>>>>>>>>>>>>> key (484119 12 484118) itemoff 16097 itemsize 26
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - - 
>>>>>>>>>>>>>>> \x09item 2
>>>>>>>>>>>>>>> key (484119 72 15) itemoff 16089 itemsize 8
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - - 
>>>>>>>>>>>>>>> \x09item 3
>>>>>>>>>>>>>>> key (484119 72 20) itemoff 16081 itemsize 8
>>>>>>>>>>>>>>> ...
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - - 
>>>>>>>>>>>>>>> \x09item 82
>>>>>>>>>>>>>>> key (484119 96 1312873) itemoff 14665 itemsize 51
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - - 
>>>>>>>>>>>>>>> \x09item 83
>>>>>>>>>>>>>>> key (484119 96 1312877) itemoff 14609 itemsize 56
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - - 
>>>>>>>>>>>>>>> \x09item 84
>>>>>>>>>>>>>>> key (484128 1 0) itemoff 14449 itemsize 160
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - -
>>>>>>>>>>>>>>> \x09\x09inode generation 45 size 98304 mode 100644
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - - 
>>>>>>>>>>>>>>> \x09item 85
>>>>>>>>>>>>>>> key (484128 108 0) itemoff 14396 itemsize 53
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - -
>>>>>>>>>>>>>>> \x09\x09extent data disk bytenr 10674830381056 nr 65536
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - -
>>>>>>>>>>>>>>> \x09\x09extent data offset 0 nr 65536 ram 65536
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - - 
>>>>>>>>>>>>>>> \x09item 86
>>>>>>>>>>>>>>> key (484129 1 0) itemoff 14236 itemsize 160
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - -
>>>>>>>>>>>>>>> \x09\x09inode generation 45 size 26214400 mode 100644
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - - 
>>>>>>>>>>>>>>> \x09item 87
>>>>>>>>>>>>>>> key (484129 108 589824) itemoff 14183 itemsize 53
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - -
>>>>>>>>>>>>>>> \x09\x09extent data disk bytenr 10665699962880 nr 32768
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - -
>>>>>>>>>>>>>>> \x09\x09extent data offset 0 nr 32768 ram 32768
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - - 
>>>>>>>>>>>>>>> \x09item 88
>>>>>>>>>>>>>>> key (484129 108 2850816) itemoff 14130 itemsize 53
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - -
>>>>>>>>>>>>>>> \x09\x09extent data disk bytenr 10665848733696 nr 32768
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - -
>>>>>>>>>>>>>>> \x09\x09extent data offset 0 nr 32768 ram 32768
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - - 
>>>>>>>>>>>>>>> \x09item 89
>>>>>>>>>>>>>>> key (484129 108 11042816) itemoff 14077 itemsize 53
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - -
>>>>>>>>>>>>>>> \x09\x09extent data disk bytenr 10660869349376 nr 32768
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - -
>>>>>>>>>>>>>>> \x09\x09extent data offset 0 nr 32768 ram 32768
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - - 
>>>>>>>>>>>>>>> \x09item 90
>>>>>>>>>>>>>>> key (484129 108 13402112) itemoff 14024 itemsize 53
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - -
>>>>>>>>>>>>>>> \x09\x09extent data disk bytenr 10660207378432 nr 32768
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - -
>>>>>>>>>>>>>>> \x09\x09extent data offset 0 nr 32768 ram 32768
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - - 
>>>>>>>>>>>>>>> \x09item 91
>>>>>>>>>>>>>>> key (484129 108 19628032) itemoff 13971 itemsize 53
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - -
>>>>>>>>>>>>>>> \x09\x09extent data disk bytenr 10665835618304 nr 32768
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - -
>>>>>>>>>>>>>>> \x09\x09extent data offset 0 nr 32768 ram 32768
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - - 
>>>>>>>>>>>>>>> \x09item 92
>>>>>>>>>>>>>>> key (484129 108 21266432) itemoff 13918 itemsize 53
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - -
>>>>>>>>>>>>>>> \x09\x09extent data disk bytenr 10661222666240 nr 32768
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - -
>>>>>>>>>>>>>>> \x09\x09extent data offset 0 nr 32768 ram 32768
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - - 
>>>>>>>>>>>>>>> \x09item 93
>>>>>>>>>>>>>>> key (484129 108 22740992) itemoff 13865 itemsize 53
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - -
>>>>>>>>>>>>>>> \x09\x09extent data disk bytenr 10665565814784 nr 32768
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - -
>>>>>>>>>>>>>>> \x09\x09extent data offset 0 nr 32768 ram 32768
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - - 
>>>>>>>>>>>>>>> \x09item 94
>>>>>>>>>>>>>>> key (484129 108 23101440) itemoff 13812 itemsize 53
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - -
>>>>>>>>>>>>>>> \x09\x09extent data disk bytenr 10665836371968 nr 32768
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - -
>>>>>>>>>>>>>>> \x09\x09extent data offset 0 nr 32768 ram 32768
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - - 
>>>>>>>>>>>>>>> \x09item 95
>>>>>>>>>>>>>>> key (484129 108 24084480) itemoff 13759 itemsize 53
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - -
>>>>>>>>>>>>>>> \x09\x09extent data disk bytenr 10665836404736 nr 32768
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - -
>>>>>>>>>>>>>>> \x09\x09extent data offset 0 nr 32768 ram 32768
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - - 
>>>>>>>>>>>>>>> \x09item 96
>>>>>>>>>>>>>>> key (484129 108 24150016) itemoff 13706 itemsize 53
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - -
>>>>>>>>>>>>>>> \x09\x09extent data disk bytenr 10665849159680 nr 32768
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - -
>>>>>>>>>>>>>>> \x09\x09extent data offset 0 nr 32768 ram 32768
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - - 
>>>>>>>>>>>>>>> \x09item 97
>>>>>>>>>>>>>>> key (484129 108 24313856) itemoff 13653 itemsize 53
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - -
>>>>>>>>>>>>>>> \x09\x09extent data disk bytenr 10665849192448 nr 32768
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - -
>>>>>>>>>>>>>>> \x09\x09extent data offset 0 nr 32768 ram 32768
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - - 
>>>>>>>>>>>>>>> \x09item 98
>>>>>>>>>>>>>>> key (484147 1 0) itemoff 13493 itemsize 160
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - -
>>>>>>>>>>>>>>> \x09\x09inode generation 45 size 886 mode 40755
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - - 
>>>>>>>>>>>>>>> \x09item 99
>>>>>>>>>>>>>>> key (484147 72 4) itemoff 13485 itemsize 8
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - - 
>>>>>>>>>>>>>>> \x09item 100
>>>>>>>>>>>>>>> key (484147 72 27) itemoff 13477 itemsize 8
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - - 
>>>>>>>>>>>>>>> \x09item 101
>>>>>>>>>>>>>>> key (484147 72 35) itemoff 13469 itemsize 8
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - - 
>>>>>>>>>>>>>>> \x09item 102
>>>>>>>>>>>>>>> key (484147 72 40) itemoff 13461 itemsize 8
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - - 
>>>>>>>>>>>>>>> \x09item 103
>>>>>>>>>>>>>>> key (484147 72 45) itemoff 13453 itemsize 8
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - - 
>>>>>>>>>>>>>>> \x09item 104
>>>>>>>>>>>>>>> key (484147 72 52) itemoff 13445 itemsize 8
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - - 
>>>>>>>>>>>>>>> BTRFS error
>>>>>>>>>>>>>>> (device sda2): block=203366612992 write time tree block 
>>>>>>>>>>>>>>> corruption
>>>>>>>>>>>>>>> detected
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - - 
>>>>>>>>>>>>>>> BTRFS: error
>>>>>>>>>>>>>>> (device sda2: state AL) in free_log_tree:3284: errno=-5 
>>>>>>>>>>>>>>> IO failure
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - - 
>>>>>>>>>>>>>>> BTRFS info
>>>>>>>>>>>>>>> (device sda2: state EAL): forced readonly
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - - 
>>>>>>>>>>>>>>> BTRFS
>>>>>>>>>>>>>>> warning (device sda2: state EAL): Skipping commit of 
>>>>>>>>>>>>>>> aborted
>>>>>>>>>>>>>>> transaction.
>>>>>>>>>>>>>>> 2022-12-26T07:44:45.000000+01:00 server02 kernel - - - 
>>>>>>>>>>>>>>> BTRFS: error
>>>>>>>>>>>>>>> (device sda2: state EAL) in cleanup_transaction:1958: 
>>>>>>>>>>>>>>> errno=-5 IO
>>>>>>>>>>>>>>> failure
>>>>>>>>>>>>>>>
>>>>>>>>>>>>>>>
>>>>>>>>>>>>>>> There are no SSD access errors in the kernel logs. Smart 
>>>>>>>>>>>>>>> data for
>>>>>>>>>>>>>>> the SSD is normal. I also did a 12 hour memtest to rule 
>>>>>>>>>>>>>>> out bad RAM.
>>>>>>>>>>>>>>>
>>>>>>>>>>>>>>> The filesystem consists of a single 480GB SATA SSD 
>>>>>>>>>>>>>>> (Corsair Neutron
>>>>>>>>>>>>>>> XTI). The problems occurs only on one machine.
>>>>>>>>>>>>>>>
>>>>>>>>>>>>>>> The error appears about every few days and seems to be 
>>>>>>>>>>>>>>> triggered by
>>>>>>>>>>>>>>> a cspecially under high cpu utilization combined with 
>>>>>>>>>>>>>>> some disk IO.
>>>>>>>>>>>>>>> CPU temperature never exceeds 60 degrees.
>>>>>>>>>>>>>> See the ticket for more details.
>>>>>>>>>>>>>>
>>>>>>>>>>>>>> For the record, the issue is apparently different from 
>>>>>>>>>>>>>> the 6.2-rc
>>>>>>>>>>>>>> regression currently discussed, as stated here:
>>>>>>>>>>>>>> https://lore.kernel.org/lkml/462e7bd3-d1f2-3718-fde9-77b418e9fd91@gmx.com/ 
>>>>>>>>>>>>>>
>>>>>>>>>>>>>>
>>>>>>>>>>>>>>
>>>>>>>>>>>>>> BTW, let me use this mail to also add the report to the 
>>>>>>>>>>>>>> list of tracked
>>>>>>>>>>>>>> regressions to ensure it's doesn't fall through the cracks:
>>>>>>>>>>>>>>
>>>>>>>>>>>>>> #regzbot introduced: v6.0..v6.1
>>>>>>>>>>>>>> https://bugzilla.kernel.org/show_bug.cgi?id=216851
>>>>>>>>>>>>>> #regzbot title: btrfs: write time corrupting for log tree 
>>>>>>>>>>>>>> in 6.1
>>>>>>>>>>>>>> #regzbot ignore-activity
>>>>>>>>>>>>> #regzbot fix: 'btrfs: fix false alert on bad tree level 
>>>>>>>>>>>>> check'
>>>>>>>>>>>> Oh no, this is a different one, this one is not level 
>>>>>>>>>>>> mismatch.
>>>>>>>>>>>>
>>>>>>>>>>>> Thanks,
>>>>>>>>>>>> Qu
>>>>>>>>>>> Hi,
>>>>>>>>>>>
>>>>>>>>>>> Here the logging from another crash, this time on kernel 
>>>>>>>>>>> 6.1.3, about 1
>>>>>>>>>>> hour after boot. Again during high CPU usage combined with 
>>>>>>>>>>> lots of io.
>>>>>>>>>>>
>>>>>>>>>>> [ 1989.025015] BTRFS critical (device sda2): corrupt leaf:
>>>>>>>>>>> root=18446744073709551610 block=574078976 slot=70, bad key 
>>>>>>>>>>> order, prev
>>>>>>>>>>> (484119 96 1328571) current (484119 96 1328553)
>>>>>>>>>>> [ 1989.025022] BTRFS info (device sda2): leaf 574078976 gen 
>>>>>>>>>>> 5089233
>>>>>>>>>>> total ptrs 108 free space 10370 owner 18446744073709551610
>>>>>>>>>>> [ 1989.025024]  item 0 key (484119 1 0) itemoff 16123 
>>>>>>>>>>> itemsize 160
>>>>>>>>>>> [ 1989.025025]          inode generation 45 size 2198 mode 
>>>>>>>>>>> 40700
>>>>>>>>>>> [ 1989.025026]  item 1 key (484119 12 484118) itemoff 16097 
>>>>>>>>>>> itemsize 26
>>>>>>>>>>> [ 1989.025027]  item 2 key (484119 72 15) itemoff 16089 
>>>>>>>>>>> itemsize 8
>>>>>>>>>>> [ 1989.025027]  item 3 key (484119 72 20) itemoff 16081 
>>>>>>>>>>> itemsize 8
>>>>>>>>>>>
>>>>>>>>>>> ...
>>>>>>>>>> Can you please paste the full message?
>>>>>>>>>> If an error/warning, don't just paste a section of the 
>>>>>>>>>> message, paste
>>>>>>>>>> the full thing.
>>>>>>>>>>
>>>>>>>>>> I've previously commented on that in the other thread:
>>>>>>>>>>
>>>>>>>>>> https://lore.kernel.org/linux-btrfs/CAL3q7H6RbPsa9Ff9or6+0d4R5vzVcR=RPxHA0=3A_KeSmf7hcQ@mail.gmail.com/ 
>>>>>>>>>>
>>>>>>>>>>
>>>>>>>>>> Thanks.
>>>>>>>>>>
>>>>>>>>>>
>>>>>>>>>>> [ 1989.025135]  item 105 key (484147 1 0) itemoff 13086 
>>>>>>>>>>> itemsize 160
>>>>>>>>>>> [ 1989.025137]          inode generation 45 size 886 mode 40755
>>>>>>>>>>> [ 1989.025138]  item 106 key (484147 72 4) itemoff 13078 
>>>>>>>>>>> itemsize 8
>>>>>>>>>>> [ 1989.025139]  item 107 key (484147 72 27) itemoff 13070 
>>>>>>>>>>> itemsize 8
>>>>>>>>>>> [ 1989.025140] BTRFS error (device sda2): block=574078976 
>>>>>>>>>>> write time
>>>>>>>>>>> tree block corruption detected
>>>>>>>>>>> [ 1989.053710] BTRFS: error (device sda2: state AL) in
>>>>>>>>>>> free_log_tree:3284: errno=-5 IO failure
>>>>>>>>>>> [ 1989.053717] BTRFS info (device sda2: state EAL): forced 
>>>>>>>>>>> readonly
>>>>>>>>>>> [ 1989.055442] BTRFS warning (device sda2: state EAL): 
>>>>>>>>>>> Skipping commit
>>>>>>>>>>> of aborted transaction.
>>>>>>>>>>> [ 1989.055444] BTRFS: error (device sda2: state EAL) in
>>>>>>>>>>> cleanup_transaction:1958: errno=-5 IO failure
>>>>>>>>>>>
>>>>>>>>>>> Thanks in advance,
>>>>>>>>>>>
>>>>>>>>>>> David Arendt
>>>>>>>>>>>
>>>>>>>>> Hi,
>>>>>>>>>
>>>>>>>>> here is the full message:
>>>>>>>> Ok, this is intriguing. Same set of keys is added twice to a leaf.
>>>>>>>>
>>>>>>>> Are you able to apply a debug patch which adds extra logging 
>>>>>>>> when the
>>>>>>>> issue happens?
>>>>>>>> That would be the fastest way to figure where and why the issue 
>>>>>>>> is happening.
>>>>>>>>
>>>>>>>> Thanks.
>>>>>>>>
>>>>>>>>
>>>>>>>>> [ 1989.025015] BTRFS critical (device sda2): corrupt leaf:
>>>>>>>>> root=18446744073709551610 block=574078976 slot=70, bad key 
>>>>>>>>> order, prev
>>>>>>>>> (484119 96 1328571) current (484119 96 1328553)
>>>>>>>>> [ 1989.025022] BTRFS info (device sda2): leaf 574078976 gen 
>>>>>>>>> 5089233
>>>>>>>>> total ptrs 108 free space 10370 owner 18446744073709551610
>>>>>>>>> [ 1989.025024]     item 0 key (484119 1 0) itemoff 16123 
>>>>>>>>> itemsize 160
>>>>>>>>> [ 1989.025025]         inode generation 45 size 2198 mode 40700
>>>>>>>>> [ 1989.025026]     item 1 key (484119 12 484118) itemoff 16097 
>>>>>>>>> itemsize 26
>>>>>>>>> [ 1989.025027]     item 2 key (484119 72 15) itemoff 16089 
>>>>>>>>> itemsize 8
>>>>>>>>> [ 1989.025027]     item 3 key (484119 72 20) itemoff 16081 
>>>>>>>>> itemsize 8
>>>>>>>>> [ 1989.025028]     item 4 key (484119 72 25) itemoff 16073 
>>>>>>>>> itemsize 8
>>>>>>>>> [ 1989.025029]     item 5 key (484119 72 30) itemoff 16065 
>>>>>>>>> itemsize 8
>>>>>>>>> [ 1989.025029]     item 6 key (484119 72 32630) itemoff 16057 
>>>>>>>>> itemsize 8
>>>>>>>>> [ 1989.025030]     item 7 key (484119 72 40332) itemoff 16049 
>>>>>>>>> itemsize 8
>>>>>>>>> [ 1989.025031]     item 8 key (484119 72 40335) itemoff 16041 
>>>>>>>>> itemsize 8
>>>>>>>>> [ 1989.025031]     item 9 key (484119 72 93630) itemoff 16033 
>>>>>>>>> itemsize 8
>>>>>>>>> [ 1989.025032]     item 10 key (484119 72 101741) itemoff 
>>>>>>>>> 16025 itemsize 8
>>>>>>>>> [ 1989.025033]     item 11 key (484119 72 131485) itemoff 
>>>>>>>>> 16017 itemsize 8
>>>>>>>>> [ 1989.025034]     item 12 key (484119 72 183799) itemoff 
>>>>>>>>> 16009 itemsize 8
>>>>>>>>> [ 1989.025034]     item 13 key (484119 72 183801) itemoff 
>>>>>>>>> 16001 itemsize 8
>>>>>>>>> [ 1989.025035]     item 14 key (484119 72 203038) itemoff 
>>>>>>>>> 15993 itemsize 8
>>>>>>>>> [ 1989.025036]     item 15 key (484119 72 254997) itemoff 
>>>>>>>>> 15985 itemsize 8
>>>>>>>>> [ 1989.025036]     item 16 key (484119 72 255172) itemoff 
>>>>>>>>> 15977 itemsize 8
>>>>>>>>> [ 1989.025037]     item 17 key (484119 72 255208) itemoff 
>>>>>>>>> 15969 itemsize 8
>>>>>>>>> [ 1989.025037]     item 18 key (484119 72 256848) itemoff 
>>>>>>>>> 15961 itemsize 8
>>>>>>>>> [ 1989.025038]     item 19 key (484119 72 264839) itemoff 
>>>>>>>>> 15953 itemsize 8
>>>>>>>>> [ 1989.025039]     item 20 key (484119 72 266090) itemoff 
>>>>>>>>> 15945 itemsize 8
>>>>>>>>> [ 1989.025039]     item 21 key (484119 72 266976) itemoff 
>>>>>>>>> 15937 itemsize 8
>>>>>>>>> [ 1989.025040]     item 22 key (484119 72 267056) itemoff 
>>>>>>>>> 15929 itemsize 8
>>>>>>>>> [ 1989.025040]     item 23 key (484119 72 302340) itemoff 
>>>>>>>>> 15921 itemsize 8
>>>>>>>>> [ 1989.025041]     item 24 key (484119 72 513980) itemoff 
>>>>>>>>> 15913 itemsize 8
>>>>>>>>> [ 1989.025042]     item 25 key (484119 72 848319) itemoff 
>>>>>>>>> 15905 itemsize 8
>>>>>>>>> [ 1989.025042]     item 26 key (484119 72 848845) itemoff 
>>>>>>>>> 15897 itemsize 8
>>>>>>>>> [ 1989.025043]     item 27 key (484119 72 938962) itemoff 
>>>>>>>>> 15889 itemsize 8
>>>>>>>>> [ 1989.025044]     item 28 key (484119 72 1001565) itemoff 
>>>>>>>>> 15881 itemsize 8
>>>>>>>>> [ 1989.025044]     item 29 key (484119 72 1217319) itemoff 
>>>>>>>>> 15873 itemsize 8
>>>>>>>>> [ 1989.025045]     item 30 key (484119 72 1217321) itemoff 
>>>>>>>>> 15865 itemsize 8
>>>>>>>>> [ 1989.025046]     item 31 key (484119 72 1268172) itemoff 
>>>>>>>>> 15857 itemsize 8
>>>>>>>>> [ 1989.025046]     item 32 key (484119 72 1298657) itemoff 
>>>>>>>>> 15849 itemsize 8
>>>>>>>>> [ 1989.025047]     item 33 key (484119 72 1299762) itemoff 
>>>>>>>>> 15841 itemsize 8
>>>>>>>>> [ 1989.025048]     item 34 key (484119 72 1322969) itemoff 
>>>>>>>>> 15833 itemsize 8
>>>>>>>>> [ 1989.025048]     item 35 key (484119 72 1326818) itemoff 
>>>>>>>>> 15825 itemsize 8
>>>>>>>>> [ 1989.025049]     item 36 key (484119 72 1327157) itemoff 
>>>>>>>>> 15817 itemsize 8
>>>>>>>>> [ 1989.025050]     item 37 key (484119 72 1327930) itemoff 
>>>>>>>>> 15809 itemsize 8
>>>>>>>>> [ 1989.025050]     item 38 key (484119 72 1327934) itemoff 
>>>>>>>>> 15801 itemsize 8
>>>>>>>>> [ 1989.025051]     item 39 key (484119 72 1328324) itemoff 
>>>>>>>>> 15793 itemsize 8
>>>>>>>>> [ 1989.025052]     item 40 key (484119 72 1328423) itemoff 
>>>>>>>>> 15785 itemsize 8
>>>>>>>>> [ 1989.025052]     item 41 key (484119 72 1328486) itemoff 
>>>>>>>>> 15777 itemsize 8
>>>>>>>>> [ 1989.025053]     item 42 key (484119 72 1328506) itemoff 
>>>>>>>>> 15769 itemsize 8
>>>>>>>>> [ 1989.025054]     item 43 key (484119 72 1328507) itemoff 
>>>>>>>>> 15761 itemsize 8
>>>>>>>>> [ 1989.025054]     item 44 key (484119 72 1328509) itemoff 
>>>>>>>>> 15753 itemsize 8
>>>>>>>>> [ 1989.025055]     item 45 key (484119 72 1328510) itemoff 
>>>>>>>>> 15745 itemsize 8
>>>>>>>>> [ 1989.025055]     item 46 key (484119 72 1328511) itemoff 
>>>>>>>>> 15737 itemsize 8
>>>>>>>>> [ 1989.025056]     item 47 key (484119 72 1328514) itemoff 
>>>>>>>>> 15729 itemsize 8
>>>>>>>>> [ 1989.025057]     item 48 key (484119 72 1328515) itemoff 
>>>>>>>>> 15721 itemsize 8
>>>>>>>>> [ 1989.025057]     item 49 key (484119 72 1328518) itemoff 
>>>>>>>>> 15713 itemsize 8
>>>>>>>>> [ 1989.025058]     item 50 key (484119 72 1328519) itemoff 
>>>>>>>>> 15705 itemsize 8
>>>>>>>>> [ 1989.025059]     item 51 key (484119 72 1328520) itemoff 
>>>>>>>>> 15697 itemsize 8
>>>>>>>>> [ 1989.025059]     item 52 key (484119 72 1328521) itemoff 
>>>>>>>>> 15689 itemsize 8
>>>>>>>>> [ 1989.025060]     item 53 key (484119 72 1328523) itemoff 
>>>>>>>>> 15681 itemsize 8
>>>>>>>>> [ 1989.025060]     item 54 key (484119 72 1328525) itemoff 
>>>>>>>>> 15673 itemsize 8
>>>>>>>>> [ 1989.025061]     item 55 key (484119 72 1328528) itemoff 
>>>>>>>>> 15665 itemsize 8
>>>>>>>>> [ 1989.025062]     item 56 key (484119 72 1328529) itemoff 
>>>>>>>>> 15657 itemsize 8
>>>>>>>>> [ 1989.025062]     item 57 key (484119 72 1328532) itemoff 
>>>>>>>>> 15649 itemsize 8
>>>>>>>>> [ 1989.025063]     item 58 key (484119 72 1328561) itemoff 
>>>>>>>>> 15641 itemsize 8
>>>>>>>>> [ 1989.025063]     item 59 key (484119 72 1328564) itemoff 
>>>>>>>>> 15633 itemsize 8
>>>>>>>>> [ 1989.025064]     item 60 key (484119 72 1328566) itemoff 
>>>>>>>>> 15625 itemsize 8
>>>>>>>>> [ 1989.025065]     item 61 key (484119 72 1328570) itemoff 
>>>>>>>>> 15617 itemsize 8
>>>>>>>>> [ 1989.025065]     item 62 key (484119 96 1328553) itemoff 
>>>>>>>>> 15566 itemsize 51
>>>>>>>>> [ 1989.025066]     item 63 key (484119 96 1328555) itemoff 
>>>>>>>>> 15523 itemsize 43
>>>>>>>>> [ 1989.025067]     item 64 key (484119 96 1328559) itemoff 
>>>>>>>>> 15489 itemsize 34
>>>>>>>>> [ 1989.025067]     item 65 key (484119 96 1328563) itemoff 
>>>>>>>>> 15441 itemsize 48
>>>>>>>>> [ 1989.025068]     item 66 key (484119 96 1328565) itemoff 
>>>>>>>>> 15388 itemsize 53
>>>>>>>>> [ 1989.025069]     item 67 key (484119 96 1328568) itemoff 
>>>>>>>>> 15341 itemsize 47
>>>>>>>>> [ 1989.025069]     item 68 key (484119 96 1328569) itemoff 
>>>>>>>>> 15292 itemsize 49
>>>>>>>>> [ 1989.025070]     item 69 key (484119 96 1328571) itemoff 
>>>>>>>>> 15254 itemsize 38
>>>>>>>>> [ 1989.025071]     item 70 key (484119 96 1328553) itemoff 
>>>>>>>>> 15203 itemsize 51
>>>>>>>>> [ 1989.025071]     item 71 key (484119 96 1328555) itemoff 
>>>>>>>>> 15160 itemsize 43
>>>>>>>>> [ 1989.025072]     item 72 key (484119 96 1328559) itemoff 
>>>>>>>>> 15126 itemsize 34
>>>>>>>>> [ 1989.025073]     item 73 key (484119 96 1328563) itemoff 
>>>>>>>>> 15078 itemsize 48
>>>>>>>>> [ 1989.025073]     item 74 key (484119 96 1328565) itemoff 
>>>>>>>>> 15025 itemsize 53
>>>>>>>>> [ 1989.025074]     item 75 key (484119 96 1328568) itemoff 
>>>>>>>>> 14978 itemsize 47
>>>>>>>>> [ 1989.025074]     item 76 key (484119 96 1328569) itemoff 
>>>>>>>>> 14929 itemsize 49
>>>>>>>>> [ 1989.025076]     item 77 key (484119 96 1328571) itemoff 
>>>>>>>>> 14891 itemsize 38
>>>>>>>>> [ 1989.025077]     item 78 key (484128 1 0) itemoff 14731 
>>>>>>>>> itemsize 160
>>>>>>>>> [ 1989.025078]         inode generation 45 size 98304 mode 100644
>>>>>>>>> [ 1989.025079]     item 79 key (484128 108 0) itemoff 14678 
>>>>>>>>> itemsize 53
>>>>>>>>> [ 1989.025080]         extent data disk bytenr 10698843275264 
>>>>>>>>> nr 65536
>>>>>>>>> [ 1989.025081]         extent data offset 0 nr 65536 ram 65536
>>>>>>>>> [ 1989.025081]     item 80 key (484129 1 0) itemoff 14518 
>>>>>>>>> itemsize 160
>>>>>>>>> [ 1989.025082]         inode generation 45 size 26214400 mode 
>>>>>>>>> 100644
>>>>>>>>> [ 1989.025083]     item 81 key (484129 108 589824) itemoff 
>>>>>>>>> 14465 itemsize 53
>>>>>>>>> [ 1989.025084]         extent data disk bytenr 10697670373376 
>>>>>>>>> nr 32768
>>>>>>>>> [ 1989.025085]         extent data offset 0 nr 32768 ram 32768
>>>>>>>>> [ 1989.025086]     item 82 key (484129 108 1310720) itemoff 14412
>>>>>>>>> itemsize 53
>>>>>>>>> [ 1989.025087]         extent data disk bytenr 10697126309888 
>>>>>>>>> nr 32768
>>>>>>>>> [ 1989.025087]         extent data offset 0 nr 32768 ram 32768
>>>>>>>>> [ 1989.025088]     item 83 key (484129 108 3670016) itemoff 14359
>>>>>>>>> itemsize 53
>>>>>>>>> [ 1989.025089]         extent data disk bytenr 10697672445952 
>>>>>>>>> nr 32768
>>>>>>>>> [ 1989.025090]         extent data offset 0 nr 32768 ram 32768
>>>>>>>>> [ 1989.025090]     item 84 key (484129 108 10944512) itemoff 
>>>>>>>>> 14306
>>>>>>>>> itemsize 53
>>>>>>>>> [ 1989.025091]         extent data disk bytenr 10697673764864 
>>>>>>>>> nr 65536
>>>>>>>>> [ 1989.025092]         extent data offset 0 nr 65536 ram 65536
>>>>>>>>> [ 1989.025093]     item 85 key (484129 108 11304960) itemoff 
>>>>>>>>> 14253
>>>>>>>>> itemsize 53
>>>>>>>>> [ 1989.025094]         extent data disk bytenr 10697154973696 
>>>>>>>>> nr 32768
>>>>>>>>> [ 1989.025095]         extent data offset 0 nr 32768 ram 32768
>>>>>>>>> [ 1989.025095]     item 86 key (484129 108 11370496) itemoff 
>>>>>>>>> 14200
>>>>>>>>> itemsize 53
>>>>>>>>> [ 1989.025096]         extent data disk bytenr 10697160564736 
>>>>>>>>> nr 32768
>>>>>>>>> [ 1989.025097]         extent data offset 0 nr 32768 ram 32768
>>>>>>>>> [ 1989.025098]     item 87 key (484129 108 11730944) itemoff 
>>>>>>>>> 14147
>>>>>>>>> itemsize 53
>>>>>>>>> [ 1989.025099]         extent data disk bytenr 10697672478720 
>>>>>>>>> nr 32768
>>>>>>>>> [ 1989.025100]         extent data offset 0 nr 32768 ram 32768
>>>>>>>>> [ 1989.025100]     item 88 key (484129 108 12156928) itemoff 
>>>>>>>>> 14094
>>>>>>>>> itemsize 53
>>>>>>>>> [ 1989.025102]         extent data disk bytenr 10697673052160 
>>>>>>>>> nr 32768
>>>>>>>>> [ 1989.025102]         extent data offset 0 nr 32768 ram 32768
>>>>>>>>> [ 1989.025103]     item 89 key (484129 108 12353536) itemoff 
>>>>>>>>> 14041
>>>>>>>>> itemsize 53
>>>>>>>>> [ 1989.025104]         extent data disk bytenr 10697160597504 
>>>>>>>>> nr 32768
>>>>>>>>> [ 1989.025105]         extent data offset 0 nr 32768 ram 32768
>>>>>>>>> [ 1989.025106]     item 90 key (484129 108 12582912) itemoff 
>>>>>>>>> 13988
>>>>>>>>> itemsize 53
>>>>>>>>> [ 1989.025107]         extent data disk bytenr 10697677389824 
>>>>>>>>> nr 32768
>>>>>>>>> [ 1989.025108]         extent data offset 0 nr 32768 ram 32768
>>>>>>>>> [ 1989.025108]     item 91 key (484129 108 13139968) itemoff 
>>>>>>>>> 13935
>>>>>>>>> itemsize 53
>>>>>>>>> [ 1989.025110]         extent data disk bytenr 10697681383424 
>>>>>>>>> nr 65536
>>>>>>>>> [ 1989.025110]         extent data offset 0 nr 65536 ram 65536
>>>>>>>>> [ 1989.025111]     item 92 key (484129 108 13467648) itemoff 
>>>>>>>>> 13882
>>>>>>>>> itemsize 53
>>>>>>>>> [ 1989.025111]         extent data disk bytenr 10697743683584 
>>>>>>>>> nr 65536
>>>>>>>>> [ 1989.025112]         extent data offset 0 nr 65536 ram 65536
>>>>>>>>> [ 1989.025112]     item 93 key (484129 108 13697024) itemoff 
>>>>>>>>> 13829
>>>>>>>>> itemsize 53
>>>>>>>>> [ 1989.025113]         extent data disk bytenr 10697160630272 
>>>>>>>>> nr 32768
>>>>>>>>> [ 1989.025113]         extent data offset 0 nr 32768 ram 32768
>>>>>>>>> [ 1989.025114]     item 94 key (484129 108 13795328) itemoff 
>>>>>>>>> 13776
>>>>>>>>> itemsize 53
>>>>>>>>> [ 1989.025114]         extent data disk bytenr 10697160663040 
>>>>>>>>> nr 32768
>>>>>>>>> [ 1989.025115]         extent data offset 0 nr 32768 ram 32768
>>>>>>>>> [ 1989.025115]     item 95 key (484129 108 14090240) itemoff 
>>>>>>>>> 13723
>>>>>>>>> itemsize 53
>>>>>>>>> [ 1989.025116]         extent data disk bytenr 10697160695808 
>>>>>>>>> nr 32768
>>>>>>>>> [ 1989.025116]         extent data offset 0 nr 32768 ram 32768
>>>>>>>>> [ 1989.025117]     item 96 key (484129 108 14548992) itemoff 
>>>>>>>>> 13670
>>>>>>>>> itemsize 53
>>>>>>>>> [ 1989.025117]         extent data disk bytenr 10697677422592 
>>>>>>>>> nr 32768
>>>>>>>>> [ 1989.025118]         extent data offset 0 nr 32768 ram 32768
>>>>>>>>> [ 1989.025118]     item 97 key (484129 108 17694720) itemoff 
>>>>>>>>> 13617
>>>>>>>>> itemsize 53
>>>>>>>>> [ 1989.025119]         extent data disk bytenr 10697686274048 
>>>>>>>>> nr 32768
>>>>>>>>> [ 1989.025119]         extent data offset 0 nr 32768 ram 32768
>>>>>>>>> [ 1989.025120]     item 98 key (484129 108 19726336) itemoff 
>>>>>>>>> 13564
>>>>>>>>> itemsize 53
>>>>>>>>> [ 1989.025121]         extent data disk bytenr 10697688305664 
>>>>>>>>> nr 32768
>>>>>>>>> [ 1989.025121]         extent data offset 0 nr 32768 ram 32768
>>>>>>>>> [ 1989.025122]     item 99 key (484129 108 20185088) itemoff 
>>>>>>>>> 13511
>>>>>>>>> itemsize 53
>>>>>>>>> [ 1989.025122]         extent data disk bytenr 10697690374144 
>>>>>>>>> nr 32768
>>>>>>>>> [ 1989.025123]         extent data offset 0 nr 32768 ram 32768
>>>>>>>>> [ 1989.025124]     item 100 key (484129 108 20971520) itemoff 
>>>>>>>>> 13458
>>>>>>>>> itemsize 53
>>>>>>>>> [ 1989.025125]         extent data disk bytenr 10697714982912 
>>>>>>>>> nr 32768
>>>>>>>>> [ 1989.025126]         extent data offset 0 nr 32768 ram 32768
>>>>>>>>> [ 1989.025126]     item 101 key (484129 108 22151168) itemoff 
>>>>>>>>> 13405
>>>>>>>>> itemsize 53
>>>>>>>>> [ 1989.025127]         extent data disk bytenr 10697718345728 
>>>>>>>>> nr 32768
>>>>>>>>> [ 1989.025128]         extent data offset 0 nr 32768 ram 32768
>>>>>>>>> [ 1989.025129]     item 102 key (484129 108 23363584) itemoff 
>>>>>>>>> 13352
>>>>>>>>> itemsize 53
>>>>>>>>> [ 1989.025129]         extent data disk bytenr 10697768124416 
>>>>>>>>> nr 65536
>>>>>>>>> [ 1989.025130]         extent data offset 0 nr 65536 ram 65536
>>>>>>>>> [ 1989.025131]     item 103 key (484129 108 23461888) itemoff 
>>>>>>>>> 13299
>>>>>>>>> itemsize 53
>>>>>>>>> [ 1989.025132]         extent data disk bytenr 10697730711552 
>>>>>>>>> nr 32768
>>>>>>>>> [ 1989.025133]         extent data offset 0 nr 32768 ram 32768
>>>>>>>>> [ 1989.025133]     item 104 key (484129 108 23527424) itemoff 
>>>>>>>>> 13246
>>>>>>>>> itemsize 53
>>>>>>>>> [ 1989.025134]         extent data disk bytenr 10697164943360 
>>>>>>>>> nr 32768
>>>>>>>>> [ 1989.025135]         extent data offset 0 nr 32768 ram 32768
>>>>>>>>> [ 1989.025135]     item 105 key (484147 1 0) itemoff 13086 
>>>>>>>>> itemsize 160
>>>>>>>>> [ 1989.025137]         inode generation 45 size 886 mode 40755
>>>>>>>>> [ 1989.025138]     item 106 key (484147 72 4) itemoff 13078 
>>>>>>>>> itemsize 8
>>>>>>>>> [ 1989.025139]     item 107 key (484147 72 27) itemoff 13070 
>>>>>>>>> itemsize 8
>>>>>>>>> [ 1989.025140] BTRFS error (device sda2): block=574078976 
>>>>>>>>> write time
>>>>>>>>> tree block corruption detected
>>>>>>>>> [ 1989.053710] BTRFS: error (device sda2: state AL) in
>>>>>>>>> free_log_tree:3284: errno=-5 IO failure
>>>>>>>>> [ 1989.053717] BTRFS info (device sda2: state EAL): forced 
>>>>>>>>> readonly
>>>>>>>>> [ 1989.055442] BTRFS warning (device sda2: state EAL): 
>>>>>>>>> Skipping commit
>>>>>>>>> of aborted transaction.
>>>>>>>>> [ 1989.055444] BTRFS: error (device sda2: state EAL) in
>>>>>>>>> cleanup_transaction:1958: errno=-5 IO failure
>>>>>>>>>
>>>>>>>>> Sorry, I didn't notice your message in the other thread.
>>>>>>>>>
>>>>>>>>> Thanks in advance,
>>>>>>>>>
>>>>>>>>> David Arendt
>>>>>>>>>
>>>>>>> Hi,
>>>>>>>
>>>>>>> Yes, if you send me a debug patch, I can apply it. However it 
>>>>>>> might take
>>>>>>> between 1 hour and 2 weeks until the next crash.
>>>>>> That would be very helpful.
>>>>>> So here's a debug patch (against 6.2-rc, but should apply to 6.1 as
>>>>>> well) attached.
>>>>>>
>>>>>> Thanks a lot!
>>>>>>
>>>>>>> Thanks in advance,
>>>>>>>
>>>>>>> David Arendt
>>>>>>>
>>>>> Hi,
>>>>>
>>>>> The patch did not apply to 6.1.3, so I tried using 6.2-rc2. I did my
>>>>> best to do much IO and different load as possible and was having this
>>>>> output:
>>>>>
>>>>> [ 1716.050035] BTRFS error (device sda2): corrupt leaf batch insert
>>>>> (count 6), slot 75, leaf before:
>>>>> [ 1716.050037] BTRFS info (device sda2): leaf 713932800 gen 5091428
>>>>> total ptrs 106 free space 11639 owner 18446744073709551610
>>>>> [ 1716.050040]  item 0 key (484119 1 0) itemoff 16123 itemsize 160
>>>>> [ 1716.050041]          inode generation 45 size 2238 mode 40700
>>>>> [ 1716.050042]  item 1 key (484119 12 484118) itemoff 16097 
>>>>> itemsize 26
>>>>> [ 1716.050044]  item 2 key (484119 72 15) itemoff 16089 itemsize 8
>>>>> [ 1716.050045]  item 3 key (484119 72 20) itemoff 16081 itemsize 8
>>>>> [ 1716.050046]  item 4 key (484119 72 25) itemoff 16073 itemsize 8
>>>>> [ 1716.050048]  item 5 key (484119 72 30) itemoff 16065 itemsize 8
>>>>> [ 1716.050049]  item 6 key (484119 72 32630) itemoff 16057 itemsize 8
>>>>> [ 1716.050050]  item 7 key (484119 72 40332) itemoff 16049 itemsize 8
>>>>> [ 1716.050051]  item 8 key (484119 72 40335) itemoff 16041 itemsize 8
>>>>> [ 1716.050052]  item 9 key (484119 72 93630) itemoff 16033 itemsize 8
>>>>> [ 1716.050053]  item 10 key (484119 72 101741) itemoff 16025 
>>>>> itemsize 8
>>>>> [ 1716.050054]  item 11 key (484119 72 131485) itemoff 16017 
>>>>> itemsize 8
>>>>> [ 1716.050056]  item 12 key (484119 72 183799) itemoff 16009 
>>>>> itemsize 8
>>>>> [ 1716.050057]  item 13 key (484119 72 183801) itemoff 16001 
>>>>> itemsize 8
>>>>> [ 1716.050058]  item 14 key (484119 72 203038) itemoff 15993 
>>>>> itemsize 8
>>>>> [ 1716.050059]  item 15 key (484119 72 254997) itemoff 15985 
>>>>> itemsize 8
>>>>> [ 1716.050060]  item 16 key (484119 72 255172) itemoff 15977 
>>>>> itemsize 8
>>>>> [ 1716.050062]  item 17 key (484119 72 255208) itemoff 15969 
>>>>> itemsize 8
>>>>> [ 1716.050063]  item 18 key (484119 72 256848) itemoff 15961 
>>>>> itemsize 8
>>>>> [ 1716.050064]  item 19 key (484119 72 264839) itemoff 15953 
>>>>> itemsize 8
>>>>> [ 1716.050065]  item 20 key (484119 72 266090) itemoff 15945 
>>>>> itemsize 8
>>>>> [ 1716.050066]  item 21 key (484119 72 266976) itemoff 15937 
>>>>> itemsize 8
>>>>> [ 1716.050067]  item 22 key (484119 72 267056) itemoff 15929 
>>>>> itemsize 8
>>>>> [ 1716.050068]  item 23 key (484119 72 302340) itemoff 15921 
>>>>> itemsize 8
>>>>> [ 1716.050070]  item 24 key (484119 72 513980) itemoff 15913 
>>>>> itemsize 8
>>>>> [ 1716.050071]  item 25 key (484119 72 848319) itemoff 15905 
>>>>> itemsize 8
>>>>> [ 1716.050072]  item 26 key (484119 72 848845) itemoff 15897 
>>>>> itemsize 8
>>>>> [ 1716.050073]  item 27 key (484119 72 938962) itemoff 15889 
>>>>> itemsize 8
>>>>> [ 1716.050074]  item 28 key (484119 72 1001565) itemoff 15881 
>>>>> itemsize 8
>>>>> [ 1716.050076]  item 29 key (484119 72 1217319) itemoff 15873 
>>>>> itemsize 8
>>>>> [ 1716.050077]  item 30 key (484119 72 1217321) itemoff 15865 
>>>>> itemsize 8
>>>>> [ 1716.050078]  item 31 key (484119 72 1268172) itemoff 15857 
>>>>> itemsize 8
>>>>> [ 1716.050079]  item 32 key (484119 72 1298657) itemoff 15849 
>>>>> itemsize 8
>>>>> [ 1716.050080]  item 33 key (484119 72 1299762) itemoff 15841 
>>>>> itemsize 8
>>>>> [ 1716.050081]  item 34 key (484119 72 1328486) itemoff 15833 
>>>>> itemsize 8
>>>>> [ 1716.050082]  item 35 key (484119 72 1329021) itemoff 15825 
>>>>> itemsize 8
>>>>> [ 1716.050083]  item 36 key (484119 72 1329328) itemoff 15817 
>>>>> itemsize 8
>>>>> [ 1716.050085]  item 37 key (484119 72 1329330) itemoff 15809 
>>>>> itemsize 8
>>>>> [ 1716.050086]  item 38 key (484119 72 1329857) itemoff 15801 
>>>>> itemsize 8
>>>>> [ 1716.050087]  item 39 key (484119 72 1330009) itemoff 15793 
>>>>> itemsize 8
>>>>> [ 1716.050089]  item 40 key (484119 72 1330037) itemoff 15785 
>>>>> itemsize 8
>>>>> [ 1716.050091]  item 41 key (484119 72 1330038) itemoff 15777 
>>>>> itemsize 8
>>>>> [ 1716.050092]  item 42 key (484119 72 1330041) itemoff 15769 
>>>>> itemsize 8
>>>>> [ 1716.050093]  item 43 key (484119 72 1330042) itemoff 15761 
>>>>> itemsize 8
>>>>> [ 1716.050094]  item 44 key (484119 72 1330046) itemoff 15753 
>>>>> itemsize 8
>>>>> [ 1716.050096]  item 45 key (484119 72 1330048) itemoff 15745 
>>>>> itemsize 8
>>>>> [ 1716.050097]  item 46 key (484119 72 1330054) itemoff 15737 
>>>>> itemsize 8
>>>>> [ 1716.050098]  item 47 key (484119 72 1330055) itemoff 15729 
>>>>> itemsize 8
>>>>> [ 1716.050099]  item 48 key (484119 72 1330059) itemoff 15721 
>>>>> itemsize 8
>>>>> [ 1716.050101]  item 49 key (484119 72 1330062) itemoff 15713 
>>>>> itemsize 8
>>>>> [ 1716.050102]  item 50 key (484119 72 1330066) itemoff 15705 
>>>>> itemsize 8
>>>>> [ 1716.050103]  item 51 key (484119 72 1330080) itemoff 15697 
>>>>> itemsize 8
>>>>> [ 1716.050104]  item 52 key (484119 72 1330081) itemoff 15689 
>>>>> itemsize 8
>>>>> [ 1716.050105]  item 53 key (484119 72 1330087) itemoff 15681 
>>>>> itemsize 8
>>>>> [ 1716.050107]  item 54 key (484119 72 1330088) itemoff 15673 
>>>>> itemsize 8
>>>>> [ 1716.050108]  item 55 key (484119 72 1330089) itemoff 15665 
>>>>> itemsize 8
>>>>> [ 1716.050109]  item 56 key (484119 72 1330090) itemoff 15657 
>>>>> itemsize 8
>>>>> [ 1716.050111]  item 57 key (484119 72 1330091) itemoff 15649 
>>>>> itemsize 8
>>>>> [ 1716.050112]  item 58 key (484119 72 1330092) itemoff 15641 
>>>>> itemsize 8
>>>>> [ 1716.050114]  item 59 key (484119 72 1330105) itemoff 15633 
>>>>> itemsize 8
>>>>> [ 1716.050115]  item 60 key (484119 72 1330107) itemoff 15625 
>>>>> itemsize 8
>>>>> [ 1716.050116]  item 61 key (484119 72 1330110) itemoff 15617 
>>>>> itemsize 8
>>>>> [ 1716.050117]  item 62 key (484119 72 1330112) itemoff 15609 
>>>>> itemsize 8
>>>>> [ 1716.050118]  item 63 key (484119 72 1330113) itemoff 15601 
>>>>> itemsize 8
>>>>> [ 1716.050119]  item 64 key (484119 72 1330115) itemoff 15593 
>>>>> itemsize 8
>>>>> [ 1716.050120]  item 65 key (484119 72 1330118) itemoff 15585 
>>>>> itemsize 8
>>>>> [ 1716.050122]  item 66 key (484119 72 1330120) itemoff 15577 
>>>>> itemsize 8
>>>>> [ 1716.050123]  item 67 key (484119 72 1330122) itemoff 15569 
>>>>> itemsize 8
>>>>> [ 1716.050124]  item 68 key (484119 72 1330124) itemoff 15561 
>>>>> itemsize 8
>>>>> [ 1716.050125]  item 69 key (484119 72 1330126) itemoff 15553 
>>>>> itemsize 8
>>>>> [ 1716.050126]  item 70 key (484119 72 1330129) itemoff 15545 
>>>>> itemsize 8
>>>>> [ 1716.050127]  item 71 key (484119 72 1330131) itemoff 15537 
>>>>> itemsize 8
>>>>> [ 1716.050128]  item 72 key (484119 72 1330136) itemoff 15529 
>>>>> itemsize 8
>>>>> [ 1716.050130]  item 73 key (484119 72 1330139) itemoff 15521 
>>>>> itemsize 8
>>>>> [ 1716.050131]  item 74 key (484119 72 1330141) itemoff 15513 
>>>>> itemsize 8
>>>>> [ 1716.050132]  item 75 key (484119 96 1330116) itemoff 15463 
>>>>> itemsize 50
>>>>> [ 1716.050133]  item 76 key (484119 96 1330128) itemoff 15405 
>>>>> itemsize 58
>>>>> [ 1716.050134]  item 77 key (484119 96 1330130) itemoff 15362 
>>>>> itemsize 43
>>>>> [ 1716.050136]  item 78 key (484129 1 0) itemoff 15202 itemsize 160
>>>>> [ 1716.050137]          inode generation 45 size 26214400 mode 100644
>>>>> [ 1716.050138]  item 79 key (484129 108 589824) itemoff 15149 
>>>>> itemsize 53
>>>>> [ 1716.050140]          extent data disk bytenr 10701807767552 nr 
>>>>> 32768
>>>>> [ 1716.050141]          extent data offset 0 nr 32768 ram 32768
>>>>> [ 1716.050142]  item 80 key (484129 108 1310720) itemoff 15096 
>>>>> itemsize 53
>>>>> [ 1716.050144]          extent data disk bytenr 10701808283648 nr 
>>>>> 32768
>>>>> [ 1716.050144]          extent data offset 0 nr 32768 ram 32768
>>>>> [ 1716.050145]  item 81 key (484129 108 1769472) itemoff 15043 
>>>>> itemsize 53
>>>>> [ 1716.050146]          extent data disk bytenr 10701828988928 nr 
>>>>> 32768
>>>>> [ 1716.050147]          extent data offset 0 nr 32768 ram 32768
>>>>> [ 1716.050148]  item 82 key (484129 108 11763712) itemoff 14990 
>>>>> itemsize 53
>>>>> [ 1716.050150]          extent data disk bytenr 10701830090752 nr 
>>>>> 32768
>>>>> [ 1716.050150]          extent data offset 0 nr 32768 ram 32768
>>>>> [ 1716.050151]  item 83 key (484129 108 13139968) itemoff 14937 
>>>>> itemsize 53
>>>>> [ 1716.050153]          extent data disk bytenr 10701269446656 nr 
>>>>> 32768
>>>>> [ 1716.050153]          extent data offset 0 nr 32768 ram 32768
>>>>> [ 1716.050154]  item 84 key (484129 108 13467648) itemoff 14884 
>>>>> itemsize 53
>>>>> [ 1716.050156]          extent data disk bytenr 10701904338944 nr 
>>>>> 32768
>>>>> [ 1716.050156]          extent data offset 0 nr 32768 ram 32768
>>>>> [ 1716.050157]  item 85 key (484129 108 13795328) itemoff 14831 
>>>>> itemsize 53
>>>>> [ 1716.050159]          extent data disk bytenr 10701904437248 nr 
>>>>> 32768
>>>>> [ 1716.050159]          extent data offset 0 nr 32768 ram 32768
>>>>> [ 1716.050160]  item 86 key (484129 108 17694720) itemoff 14778 
>>>>> itemsize 53
>>>>> [ 1716.050161]          extent data disk bytenr 10701806407680 nr 
>>>>> 32768
>>>>> [ 1716.050162]          extent data offset 0 nr 32768 ram 32768
>>>>> [ 1716.050163]  item 87 key (484129 108 19726336) itemoff 14725 
>>>>> itemsize 53
>>>>> [ 1716.050164]          extent data disk bytenr 10701806505984 nr 
>>>>> 32768
>>>>> [ 1716.050165]          extent data offset 0 nr 32768 ram 32768
>>>>> [ 1716.050166]  item 88 key (484129 108 20185088) itemoff 14672 
>>>>> itemsize 53
>>>>> [ 1716.050167]          extent data disk bytenr 10701806538752 nr 
>>>>> 32768
>>>>> [ 1716.050168]          extent data offset 0 nr 32768 ram 32768
>>>>> [ 1716.050168]  item 89 key (484129 108 21168128) itemoff 14619 
>>>>> itemsize 53
>>>>> [ 1716.050170]          extent data disk bytenr 10701807833088 nr 
>>>>> 32768
>>>>> [ 1716.050170]          extent data offset 0 nr 32768 ram 32768
>>>>> [ 1716.050171]  item 90 key (484129 108 23396352) itemoff 14566 
>>>>> itemsize 53
>>>>> [ 1716.050172]          extent data disk bytenr 10701807865856 nr 
>>>>> 32768
>>>>> [ 1716.050173]          extent data offset 0 nr 32768 ram 32768
>>>>> [ 1716.050174]  item 91 key (484147 1 0) itemoff 14406 itemsize 160
>>>>> [ 1716.050175]          inode generation 45 size 1096 mode 40755
>>>>> [ 1716.050176]  item 92 key (484147 12 484145) itemoff 14393 
>>>>> itemsize 13
>>>>> [ 1716.050177]  item 93 key (484147 72 4) itemoff 14385 itemsize 8
>>>>> [ 1716.050179]  item 94 key (484147 72 27) itemoff 14377 itemsize 8
>>>>> [ 1716.050180]  item 95 key (484147 72 35) itemoff 14369 itemsize 8
>>>>> [ 1716.050181]  item 96 key (484147 72 40) itemoff 14361 itemsize 8
>>>>> [ 1716.050183]  item 97 key (484147 72 45) itemoff 14353 itemsize 8
>>>>> [ 1716.050184]  item 98 key (484147 72 52) itemoff 14345 itemsize 8
>>>>> [ 1716.050185]  item 99 key (484147 72 61) itemoff 14337 itemsize 8
>>>>> [ 1716.050186]  item 100 key (484147 72 65) itemoff 14329 itemsize 8
>>>>> [ 1716.050187]  item 101 key (484147 72 88) itemoff 14321 itemsize 8
>>>>> [ 1716.050189]  item 102 key (484147 72 92) itemoff 14313 itemsize 8
>>>>> [ 1716.050190]  item 103 key (484147 72 350) itemoff 14305 itemsize 8
>>>>> [ 1716.050192]  item 104 key (484147 72 351) itemoff 14297 itemsize 8
>>>>> [ 1716.050193]  item 105 key (484147 72 352) itemoff 14289 itemsize 8
>>>>> [ 1716.050194] BTRFS error (device sda2): batch items:
>>>>> [ 1716.050195] BTRFS error (device sda2): item 0 index 1330094
>>>>> [ 1716.050197] BTRFS error (device sda2): item 1 index 1330116
>>>>> [ 1716.050198] BTRFS error (device sda2): item 2 index 1330127
>>>>> [ 1716.050199] BTRFS error (device sda2): item 3 index 1330128
>>>>> [ 1716.050200] BTRFS error (device sda2): item 4 index 1330130
>>>>> [ 1716.050201] BTRFS error (device sda2): item 5 index 1330132
>>>> Wow, that was fast!
>>>>
>>>>> However this time the filesystem didn't switch to readonly.
>>>> Yes, the debug patch changed that too. It's actually not a critical
>>>> situation to turn the fs to readonly.
>>>>
>>>> Ok, I see now what's going on. I will work on a fix for that plus a
>>>> few other things I noticed are not right.
>>>> I'll likely submit the changes to the list by monday or tuesday, and
>>>> let you know in case you want/can test them.
>>> Ok, here they are:
>>>
>>> https://lore.kernel.org/linux-btrfs/cover.1673361215.git.fdmanana@suse.com/ 
>>>
>>>
>>>> Thanks a lot for the testing and reporting.
>>>>
>>>>> Thanks in advance,
>>>>>
>>>>> David Arendt
>>>>>
>> Hi,
>>
>> Many thanks.
>>
>> I have applied the patches to 6.2-rc3 and tried to do everything to 
>> reproduce the problem so the problem seems to be fixed by the 
>> patches, but for sure only time will tell.
>>
>> Bye,
>>
>> David Arendt
>>
> Hi,
>
> In 6.2-rc3 + your patches, the problem did not appear within 2 weeks. 
> I skipped rc4 and today I upgraded to 6.2-rc5 which should have to 
> patches included (or not ?). About one hour later, the filesystem 
> turned again read-only with the following kernel log entries:
>
> [ 7611.406077] BTRFS critical (device sda2): corrupt leaf: 
> root=18446744073709551610 block=75971280896 slot=71, bad key order, 
> prev (484119 96 1358553) current (484119 96 1358532)
> [ 7611.406087] BTRFS info (device sda2): leaf 75971280896 gen 5130699 
> total ptrs 105 free space 10909 owner 18446744073709551610
> [ 7611.406090]     item 0 key (484119 1 0) itemoff 16123 itemsize 160
> [ 7611.406091]         inode generation 45 size 2198 mode 40700
> [ 7611.406093]     item 1 key (484119 12 484118) itemoff 16097 
> itemsize 26
> [ 7611.406094]     item 2 key (484119 72 15) itemoff 16089 itemsize 8
> [ 7611.406095]     item 3 key (484119 72 20) itemoff 16081 itemsize 8
> [ 7611.406097]     item 4 key (484119 72 25) itemoff 16073 itemsize 8
> [ 7611.406098]     item 5 key (484119 72 30) itemoff 16065 itemsize 8
> [ 7611.406099]     item 6 key (484119 72 32630) itemoff 16057 itemsize 8
> [ 7611.406100]     item 7 key (484119 72 40332) itemoff 16049 itemsize 8
> [ 7611.406101]     item 8 key (484119 72 40335) itemoff 16041 itemsize 8
> [ 7611.406102]     item 9 key (484119 72 93630) itemoff 16033 itemsize 8
> [ 7611.406104]     item 10 key (484119 72 101741) itemoff 16025 
> itemsize 8
> [ 7611.406105]     item 11 key (484119 72 131485) itemoff 16017 
> itemsize 8
> [ 7611.406106]     item 12 key (484119 72 183799) itemoff 16009 
> itemsize 8
> [ 7611.406108]     item 13 key (484119 72 183801) itemoff 16001 
> itemsize 8
> [ 7611.406109]     item 14 key (484119 72 203038) itemoff 15993 
> itemsize 8
> [ 7611.406110]     item 15 key (484119 72 254997) itemoff 15985 
> itemsize 8
> [ 7611.406111]     item 16 key (484119 72 255172) itemoff 15977 
> itemsize 8
> [ 7611.406112]     item 17 key (484119 72 255208) itemoff 15969 
> itemsize 8
> [ 7611.406113]     item 18 key (484119 72 256848) itemoff 15961 
> itemsize 8
> [ 7611.406115]     item 19 key (484119 72 264839) itemoff 15953 
> itemsize 8
> [ 7611.406116]     item 20 key (484119 72 266090) itemoff 15945 
> itemsize 8
> [ 7611.406117]     item 21 key (484119 72 266976) itemoff 15937 
> itemsize 8
> [ 7611.406118]     item 22 key (484119 72 267056) itemoff 15929 
> itemsize 8
> [ 7611.406120]     item 23 key (484119 72 302340) itemoff 15921 
> itemsize 8
> [ 7611.406121]     item 24 key (484119 72 513980) itemoff 15913 
> itemsize 8
> [ 7611.406122]     item 25 key (484119 72 848319) itemoff 15905 
> itemsize 8
> [ 7611.406123]     item 26 key (484119 72 848845) itemoff 15897 
> itemsize 8
> [ 7611.406124]     item 27 key (484119 72 938962) itemoff 15889 
> itemsize 8
> [ 7611.406125]     item 28 key (484119 72 1001565) itemoff 15881 
> itemsize 8
> [ 7611.406127]     item 29 key (484119 72 1268172) itemoff 15873 
> itemsize 8
> [ 7611.406128]     item 30 key (484119 72 1298657) itemoff 15865 
> itemsize 8
> [ 7611.406129]     item 31 key (484119 72 1299762) itemoff 15857 
> itemsize 8
> [ 7611.406130]     item 32 key (484119 72 1336351) itemoff 15849 
> itemsize 8
> [ 7611.406131]     item 33 key (484119 72 1356235) itemoff 15841 
> itemsize 8
> [ 7611.406133]     item 34 key (484119 72 1356237) itemoff 15833 
> itemsize 8
> [ 7611.406134]     item 35 key (484119 72 1357416) itemoff 15825 
> itemsize 8
> [ 7611.406135]     item 36 key (484119 72 1357797) itemoff 15817 
> itemsize 8
> [ 7611.406137]     item 37 key (484119 72 1358273) itemoff 15809 
> itemsize 8
> [ 7611.406138]     item 38 key (484119 72 1358275) itemoff 15801 
> itemsize 8
> [ 7611.406139]     item 39 key (484119 72 1358278) itemoff 15793 
> itemsize 8
> [ 7611.406141]     item 40 key (484119 72 1358448) itemoff 15785 
> itemsize 8
> [ 7611.406142]     item 41 key (484119 72 1358449) itemoff 15777 
> itemsize 8
> [ 7611.406143]     item 42 key (484119 72 1358452) itemoff 15769 
> itemsize 8
> [ 7611.406144]     item 43 key (484119 72 1358453) itemoff 15761 
> itemsize 8
> [ 7611.406145]     item 44 key (484119 72 1358456) itemoff 15753 
> itemsize 8
> [ 7611.406147]     item 45 key (484119 72 1358457) itemoff 15745 
> itemsize 8
> [ 7611.406148]     item 46 key (484119 72 1358460) itemoff 15737 
> itemsize 8
> [ 7611.406149]     item 47 key (484119 72 1358461) itemoff 15729 
> itemsize 8
> [ 7611.406150]     item 48 key (484119 72 1358463) itemoff 15721 
> itemsize 8
> [ 7611.406151]     item 49 key (484119 72 1358469) itemoff 15713 
> itemsize 8
> [ 7611.406153]     item 50 key (484119 72 1358485) itemoff 15705 
> itemsize 8
> [ 7611.406154]     item 51 key (484119 72 1358486) itemoff 15697 
> itemsize 8
> [ 7611.406155]     item 52 key (484119 72 1358499) itemoff 15689 
> itemsize 8
> [ 7611.406156]     item 53 key (484119 72 1358502) itemoff 15681 
> itemsize 8
> [ 7611.406157]     item 54 key (484119 72 1358513) itemoff 15673 
> itemsize 8
> [ 7611.406159]     item 55 key (484119 72 1358514) itemoff 15665 
> itemsize 8
> [ 7611.406160]     item 56 key (484119 72 1358515) itemoff 15657 
> itemsize 8
> [ 7611.406161]     item 57 key (484119 72 1358516) itemoff 15649 
> itemsize 8
> [ 7611.406162]     item 58 key (484119 72 1358543) itemoff 15641 
> itemsize 8
> [ 7611.406164]     item 59 key (484119 72 1358546) itemoff 15633 
> itemsize 8
> [ 7611.406165]     item 60 key (484119 72 1358548) itemoff 15625 
> itemsize 8
> [ 7611.406166]     item 61 key (484119 72 1358552) itemoff 15617 
> itemsize 8
> [ 7611.406167]     item 62 key (484119 96 1358532) itemoff 15566 
> itemsize 51
> [ 7611.406168]     item 63 key (484119 96 1358534) itemoff 15508 
> itemsize 58
> [ 7611.406170]     item 64 key (484119 96 1358536) itemoff 15465 
> itemsize 43
> [ 7611.406171]     item 65 key (484119 96 1358541) itemoff 15431 
> itemsize 34
> [ 7611.406172]     item 66 key (484119 96 1358545) itemoff 15383 
> itemsize 48
> [ 7611.406173]     item 67 key (484119 96 1358549) itemoff 15330 
> itemsize 53
> [ 7611.406174]     item 68 key (484119 96 1358550) itemoff 15283 
> itemsize 47
> [ 7611.406175]     item 69 key (484119 96 1358551) itemoff 15234 
> itemsize 49
> [ 7611.406177]     item 70 key (484119 96 1358553) itemoff 15196 
> itemsize 38
> [ 7611.406178]     item 71 key (484119 96 1358532) itemoff 15145 
> itemsize 51
> [ 7611.406179]     item 72 key (484119 96 1358534) itemoff 15087 
> itemsize 58
> [ 7611.406180]     item 73 key (484119 96 1358536) itemoff 15044 
> itemsize 43
> [ 7611.406181]     item 74 key (484119 96 1358541) itemoff 15010 
> itemsize 34
> [ 7611.406182]     item 75 key (484119 96 1358545) itemoff 14962 
> itemsize 48
> [ 7611.406184]     item 76 key (484119 96 1358549) itemoff 14909 
> itemsize 53
> [ 7611.406185]     item 77 key (484119 96 1358550) itemoff 14862 
> itemsize 47
> [ 7611.406186]     item 78 key (484119 96 1358551) itemoff 14813 
> itemsize 49
> [ 7611.406187]     item 79 key (484119 96 1358553) itemoff 14775 
> itemsize 38
> [ 7611.406188]     item 80 key (484128 1 0) itemoff 14615 itemsize 160
> [ 7611.406189]         inode generation 45 size 98304 mode 100644
> [ 7611.406190]     item 81 key (484128 108 0) itemoff 14562 itemsize 53
> [ 7611.406192]         extent data disk bytenr 10745529716736 nr 65536
> [ 7611.406193]         extent data offset 0 nr 65536 ram 65536
> [ 7611.406194]     item 82 key (484129 1 0) itemoff 14402 itemsize 160
> [ 7611.406195]         inode generation 45 size 26214400 mode 100644
> [ 7611.406196]     item 83 key (484129 108 98304) itemoff 14349 
> itemsize 53
> [ 7611.406197]         extent data disk bytenr 10744232108032 nr 65536
> [ 7611.406198]         extent data offset 0 nr 65536 ram 65536
> [ 7611.406198]     item 84 key (484129 108 589824) itemoff 14296 
> itemsize 53
> [ 7611.406200]         extent data disk bytenr 10745529593856 nr 32768
> [ 7611.406200]         extent data offset 0 nr 32768 ram 32768
> [ 7611.406201]     item 85 key (484129 108 4685824) itemoff 14243 
> itemsize 53
> [ 7611.406203]         extent data disk bytenr 10744231481344 nr 32768
> [ 7611.406203]         extent data offset 0 nr 32768 ram 32768
> [ 7611.406204]     item 86 key (484129 108 11468800) itemoff 14190 
> itemsize 53
> [ 7611.406205]         extent data disk bytenr 10745067331584 nr 32768
> [ 7611.406206]         extent data offset 0 nr 32768 ram 32768
> [ 7611.406207]     item 87 key (484129 108 13139968) itemoff 14137 
> itemsize 53
> [ 7611.406208]         extent data disk bytenr 10745022545920 nr 32768
> [ 7611.406209]         extent data offset 0 nr 32768 ram 32768
> [ 7611.406210]     item 88 key (484129 108 13795328) itemoff 14084 
> itemsize 53
> [ 7611.406211]         extent data disk bytenr 10744891514880 nr 32768
> [ 7611.406212]         extent data offset 0 nr 32768 ram 32768
> [ 7611.406213]     item 89 key (484129 108 20185088) itemoff 14031 
> itemsize 53
> [ 7611.406214]         extent data disk bytenr 10745022578688 nr 32768
> [ 7611.406215]         extent data offset 0 nr 32768 ram 32768
> [ 7611.406216]     item 90 key (484129 108 22347776) itemoff 13978 
> itemsize 53
> [ 7611.406217]         extent data disk bytenr 10744205844480 nr 32768
> [ 7611.406218]         extent data offset 0 nr 32768 ram 32768
> [ 7611.406218]     item 91 key (484129 108 23429120) itemoff 13925 
> itemsize 53
> [ 7611.406220]         extent data disk bytenr 10745067364352 nr 32768
> [ 7611.406220]         extent data offset 0 nr 32768 ram 32768
> [ 7611.406221]     item 92 key (484129 108 24870912) itemoff 13872 
> itemsize 53
> [ 7611.406222]         extent data disk bytenr 10745022611456 nr 32768
> [ 7611.406223]         extent data offset 0 nr 32768 ram 32768
> [ 7611.406224]     item 93 key (484129 108 25001984) itemoff 13819 
> itemsize 53
> [ 7611.406225]         extent data disk bytenr 10745022709760 nr 32768
> [ 7611.406226]         extent data offset 0 nr 32768 ram 32768
> [ 7611.406227]     item 94 key (484129 108 25165824) itemoff 13766 
> itemsize 53
> [ 7611.406228]         extent data disk bytenr 10745022742528 nr 32768
> [ 7611.406229]         extent data offset 0 nr 32768 ram 32768
> [ 7611.406230]     item 95 key (484147 1 0) itemoff 13606 itemsize 160
> [ 7611.406231]         inode generation 45 size 886 mode 40755
> [ 7611.406232]     item 96 key (484147 72 4) itemoff 13598 itemsize 8
> [ 7611.406233]     item 97 key (484147 72 27) itemoff 13590 itemsize 8
> [ 7611.406234]     item 98 key (484147 72 35) itemoff 13582 itemsize 8
> [ 7611.406235]     item 99 key (484147 72 40) itemoff 13574 itemsize 8
> [ 7611.406236]     item 100 key (484147 72 45) itemoff 13566 itemsize 8
> [ 7611.406238]     item 101 key (484147 72 52) itemoff 13558 itemsize 8
> [ 7611.406239]     item 102 key (484147 72 61) itemoff 13550 itemsize 8
> [ 7611.406240]     item 103 key (484147 72 65) itemoff 13542 itemsize 8
> [ 7611.406241]     item 104 key (484147 72 88) itemoff 13534 itemsize 8
> [ 7611.406242] BTRFS error (device sda2): block=75971280896 write time 
> tree block corruption detected
> [ 7611.406255] ------------[ cut here ]------------
> [ 7611.406256] WARNING: CPU: 5 PID: 32347 at fs/btrfs/disk-io.c:376 
> csum_one_extent_buffer+0x136/0x140
> [ 7611.406261] Modules linked in: zfs(PO) zunicode(PO) zzstd(O) 
> zlua(O) zavl(PO) icp(PO) zcommon(PO) znvpair(PO) spl(O)
> [ 7611.406270] CPU: 5 PID: 32347 Comm: mozStorage #2 Tainted: P        
> W  O       6.2.0-rc5 #1
> [ 7611.406272] Hardware name: ASUS All Series/H87M-PRO, BIOS 2102 
> 10/28/2014
> [ 7611.406273] RIP: 0010:csum_one_extent_buffer+0x136/0x140
> [ 7611.406275] Code: 48 c1 e2 29 48 03 53 70 48 c1 fa 06 81 e1 ff 0f 
> 00 00 48 c1 e2 0c 48 01 ca b9 11 ff ff 01 48 c1 e1 27 48 83 7c 0a 58 
> fa 75 98 <0f> 0b eb 94 66 0f 1f 44 00 00 90 90 90 90 90 90 90 90 90 90 
> 90 90
> [ 7611.406277] RSP: 0018:ffffc9000d803850 EFLAGS: 00010246
> [ 7611.406279] RAX: 00000000ffffff8b RBX: ffff888411886200 RCX: 
> ffff888000000000
> [ 7611.406280] RDX: 0000000479022000 RSI: 0000000000000001 RDI: 
> ffff8887fdd5b280
> [ 7611.406282] RBP: ffff888102fa3000 R08: 00000000ffffdfff R09: 
> 00000000ffffdfff
> [ 7611.406283] R10: ffffffff82854220 R11: ffffffff82854220 R12: 
> ffff888102fa3000
> [ 7611.406284] R13: 0000000000001000 R14: ffffea0011e40880 R15: 
> ffff888102fa3000
> [ 7611.406285] FS:  00007f43d72986c0(0000) GS:ffff8887fdd40000(0000) 
> knlGS:0000000000000000
> [ 7611.406287] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
> [ 7611.406288] CR2: 00007f246eb9e000 CR3: 000000040de5e005 CR4: 
> 00000000001706e0
> [ 7611.406289] Call Trace:
> [ 7611.406291]  <TASK>
> [ 7611.406293]  btree_csum_one_bio+0x220/0x2a0
> [ 7611.406295]  btrfs_submit_metadata_bio+0x84/0xc0
> [ 7611.406297]  submit_one_bio+0xbd/0x110
> [ 7611.406300]  btree_write_cache_pages+0x721/0x790
> [ 7611.406303]  ? __pfx_end_bio_extent_buffer_writepage+0x10/0x10
> [ 7611.406306]  ? btrfs_search_slot+0x8a5/0xc70
> [ 7611.406309]  do_writepages+0x99/0x180
> [ 7611.406313]  ? btrfs_read_extent_buffer+0x8a/0x130
> [ 7611.406314]  ? merge_state.part.0+0x41/0xf0
> [ 7611.406317]  filemap_fdatawrite_wbc+0x5a/0x80
> [ 7611.406321]  __filemap_fdatawrite_range+0x45/0x50
> [ 7611.406323]  btrfs_write_marked_extents+0x52/0x120
> [ 7611.406326]  btrfs_sync_log+0x1ce/0x9a0
> [ 7611.406329]  ? btrfs_unlock_up_safe+0x69/0xc0
> [ 7611.406332]  ? btrfs_search_forward+0x260/0x340
> [ 7611.406334]  ? log_new_dir_dentries.isra.0+0x36c/0x390
> [ 7611.406335]  ? __pfx_autoremove_wake_function+0x10/0x10
> [ 7611.406339]  ? log_new_dir_dentries.isra.0+0x36c/0x390
> [ 7611.406340]  ? btrfs_log_inode_parent+0x3e0/0xdf0
> [ 7611.406342]  ? pagevec_lookup_range_tag+0x1f/0x30
> [ 7611.406345]  ? __filemap_fdatawait_range+0x46/0xe0
> [ 7611.406347]  ? perf_event_exec+0xe0/0x310
> [ 7611.406350]  ? wait_current_trans+0x15/0xe0
> [ 7611.406353]  ? kmem_cache_alloc+0x226/0x380
> [ 7611.406357]  ? join_transaction+0x1b/0x3f0
> [ 7611.406359]  ? dput+0xaf/0x2d0
> [ 7611.406361]  btrfs_sync_file+0x31f/0x4e0
> [ 7611.406364]  __x64_sys_fsync+0x32/0x60
> [ 7611.406367]  do_syscall_64+0x42/0x90
> [ 7611.406371]  entry_SYSCALL_64_after_hwframe+0x72/0xdc
> [ 7611.406375] RIP: 0033:0x7f440320651a
> [ 7611.406377] Code: 48 3d 00 f0 ff ff 77 48 c3 0f 1f 80 00 00 00 00 
> 48 83 ec 18 89 7c 24 0c e8 13 71 f8 ff 8b 7c 24 0c 89 c2 b8 4a 00 00 
> 00 0f 05 <48> 3d 00 f0 ff ff 77 36 89 d7 89 44 24 0c e8 73 71 f8 ff 8b 
> 44 24
> [ 7611.406378] RSP: 002b:00007f43d7297170 EFLAGS: 00000293 ORIG_RAX: 
> 000000000000004a
> [ 7611.406381] RAX: ffffffffffffffda RBX: 00007f43ee222be8 RCX: 
> 00007f440320651a
> [ 7611.406382] RDX: 0000000000000000 RSI: 0000000000000000 RDI: 
> 0000000000000090
> [ 7611.406383] RBP: 0000000000000000 R08: 0000000000000000 R09: 
> 00007f440255e000
> [ 7611.406384] R10: 0000000000000000 R11: 0000000000000293 R12: 
> 00007f43d63ed038
> [ 7611.406385] R13: 0000000000000000 R14: 0000000000000002 R15: 
> 0000000000000000
> [ 7611.406387]  </TASK>
> [ 7611.406387] ---[ end trace 0000000000000000 ]---
> [ 7611.459735] BTRFS error (device sda2: state AL): Transaction 
> aborted (error -5)
> [ 7611.459742] BTRFS: error (device sda2: state AL) in 
> free_log_tree:3248: errno=-5 IO failure
> [ 7611.459744] BTRFS info (device sda2: state EAL): forced readonly
> [ 7611.463492] BTRFS warning (device sda2: state EAL): Skipping commit 
> of aborted transaction.
> [ 7611.463498] BTRFS: error (device sda2: state EAL) in 
> cleanup_transaction:1984: errno=-5 IO failure
>
> Thanks in advance,
>
> David Arendt
>
Hi,

I found a way to reproduce the bug on 6.2-rc5 (at least on my machine) 
in less then 30 minutes.

In a shell I run the following command:

while true; do XZ_DEFAULTS="-T0" tar -cJf - /home/admin/.mozilla > 
/dev/null; done

Afterwards I use firefox to navigate through pages with lots of images 
like for example facebook and to some intermediary clear caches in 
between the visits, which triggers lots of changes on cache files.

Using this, I was able to reproduce the bug 2 more times.

Without the tar running, the bug is not reproducible.

The bug is also reproducible when I run tar on a snapshot of the filesystem.

Thanks in advance,

David Arendt


  reply	other threads:[~2023-01-22 20:47 UTC|newest]

Thread overview: 25+ messages / expand[flat|nested]  mbox.gz  Atom feed  top
2022-12-27 14:01 [regression] Bug 216851 - btrfs write time corrupting for log tree Thorsten Leemhuis
2023-01-02 15:40 ` David Sterba
2023-01-02 23:38   ` Qu Wenruo
2023-01-04 19:15     ` David Arendt
2023-01-04 19:29       ` Filipe Manana
2023-01-04 19:35         ` David Arendt
2023-01-05 10:22           ` Filipe Manana
2023-01-05 16:49             ` David Arendt
2023-01-05 17:04               ` Filipe Manana
2023-01-05 18:24                 ` David Arendt
2023-01-05 18:35                   ` David Arendt
2023-01-05 18:41                     ` David Arendt
2023-01-05 21:11                   ` Filipe Manana
2023-01-10 15:10                     ` Filipe Manana
2023-01-10 21:12                       ` David Arendt
2023-01-22 15:53                         ` David Arendt
2023-01-22 20:45                           ` David Arendt [this message]
2023-01-23 10:28                           ` Filipe Manana
2023-01-23 21:06                             ` David Arendt
2023-01-23 22:14                               ` Filipe Manana
2023-01-25 20:54                                 ` David Arendt
2023-01-30 21:07                                 ` David Arendt
2023-01-31 17:41                                   ` Filipe Manana
2023-02-06  5:16                                     ` David Arendt
2023-02-06 10:10                                       ` Filipe Manana

Reply instructions:

You may reply publicly to this message via plain-text email
using any one of the following methods:

* Save the following mbox file, import it into your mail client,
  and reply-to-all from there: mbox

  Avoid top-posting and favor interleaved quoting:
  https://en.wikipedia.org/wiki/Posting_style#Interleaved_style

* Reply using the --to, --cc, and --in-reply-to
  switches of git-send-email(1):

  git send-email \
    --in-reply-to=bbdb2ebe-4af3-fee6-fb8a-de67144dc50a@prnet.org \
    --to=admin@prnet.org \
    --cc=clm@fb.com \
    --cc=dsterba@suse.com \
    --cc=dsterba@suse.cz \
    --cc=fdmanana@kernel.org \
    --cc=josef@toxicpanda.com \
    --cc=linux-btrfs@vger.kernel.org \
    --cc=linux-kernel@vger.kernel.org \
    --cc=quwenruo.btrfs@gmx.com \
    --cc=regressions@leemhuis.info \
    --cc=regressions@lists.linux.dev \
    /path/to/YOUR_REPLY

  https://kernel.org/pub/software/scm/git/docs/git-send-email.html

* If your mail client supports setting the In-Reply-To header
  via mailto: links, try the mailto: link
Be sure your reply has a Subject: header at the top and a blank line before the message body.
This is a public inbox, see mirroring instructions
for how to clone and mirror all data and code used for this inbox;
as well as URLs for NNTP newsgroup(s).