lists.openwall.net   lists  /  announce  owl-users  owl-dev  john-users  john-dev  passwdqc-users  yescrypt  popa3d-users  /  oss-security  kernel-hardening  musl  sabotage  tlsify  passwords  /  crypt-dev  xvendor  /  Bugtraq  Full-Disclosure  linux-kernel  linux-netdev  linux-ext4  linux-hardening  linux-cve-announce  PHC 
Open Source and information security mailing list archives
 
Hash Suite: Windows password security audit tool. GUI, reports in PDF.
[<prev] [next>] [day] [month] [year] [list]
Message-ID: <YxWsnc1JlNemcXfA@Red>
Date:   Mon, 5 Sep 2022 10:00:29 +0200
From:   Corentin Labbe <clabbe.montjoie@...il.com>
To:     anton@...era.com, linux-ntfs-dev@...ts.sourceforge.net,
        akpm@...ux-foundation.org
Cc:     linux-kernel@...r.kernel.org, viro@...iv.linux.org.uk,
        linux-fsdevel@...r.kernel.org
Subject: WARNING: inconsistent lock state when doing fdisk -l

Hello

On a jetson-tk1 I got today:
[   39.582103] ================================
[   39.586361] WARNING: inconsistent lock state
[   39.590618] 6.0.0-rc3-next-20220901-00130-gb6b3fb681f34-dirty #8 Not tainted
[   39.597649] --------------------------------
[   39.601907] inconsistent {SOFTIRQ-ON-W} -> {IN-SOFTIRQ-R} usage.
[   39.607897] rngd/218 [HC0[0]:SC1[1]:HE0:SE0] takes:
[   39.612763] c284dba4 (&inode->i_size_seqcount){+.+-}-{0:0}, at: end_bio_bh_io_sync+0x30/0x4c
[   39.621198] {SOFTIRQ-ON-W} state was registered at:
[   39.626061]   simple_write_end+0x1e8/0x2a4
[   39.630154]   page_symlink+0xb0/0x158
[   39.633808]   ramfs_symlink+0x50/0xcc
[   39.637466]   vfs_symlink+0x80/0xf0
[   39.640944]   init_symlink+0x54/0x88
[   39.644512]   do_symlink+0x54/0x88
[   39.647905]   write_buffer+0x28/0x3c
[   39.651470]   flush_buffer+0x40/0x98
[   39.655035]   __gunzip+0x2c4/0x35c
[   39.658427]   gunzip+0x2c/0x34
[   39.661470]   unpack_to_rootfs+0x18c/0x2b4
[   39.665556]   do_populate_rootfs+0x78/0x1cc
[   39.669728]   async_run_entry_fn+0x24/0xb0
[   39.673817]   process_one_work+0x288/0x774
[   39.677904]   worker_thread+0x54/0x51c
[   39.681643]   kthread+0xf8/0x12c
[   39.684862]   ret_from_fork+0x14/0x2c
[   39.688513]   0x0
[   39.690430] irq event stamp: 19119
[   39.693820] hardirqs last  enabled at (19118): [<c010145c>] __do_softirq+0xdc/0x598
[   39.701460] hardirqs last disabled at (19119): [<c0d0afb0>] _raw_read_lock_irqsave+0x84/0x88
[   39.709883] softirqs last  enabled at (19108): [<c01016b4>] __do_softirq+0x334/0x598
[   39.717609] softirqs last disabled at (19117): [<c012bdb0>] __irq_exit_rcu+0x124/0x1a8
[   39.725511] 
[   39.725511] other info that might help us debug this:
[   39.732021]  Possible unsafe locking scenario:
[   39.732021] 
[   39.737924]        CPU0
[   39.740360]        ----
[   39.742796]   lock(&inode->i_size_seqcount);
[   39.747056]   <Interrupt>
[   39.749665]     lock(&inode->i_size_seqcount);
[   39.754098] 
[   39.754098]  *** DEADLOCK ***
[   39.754098] 
[   39.760001] 1 lock held by rngd/218:
[   39.763566]  #0: c284d950 (&ni->size_lock){...-}-{2:2}, at: ntfs_end_buffer_async_read+0x68/0x458
[   39.772432] 
[   39.772432] stack backtrace:
[   39.776777] CPU: 0 PID: 218 Comm: rngd Not tainted 6.0.0-rc3-next-20220901-00130-gb6b3fb681f34-dirty #8
[   39.786149] Hardware name: NVIDIA Tegra SoC (Flattened Device Tree)
[   39.792401]  unwind_backtrace from show_stack+0x10/0x14
[   39.797618]  show_stack from dump_stack_lvl+0x58/0x70
[   39.802660]  dump_stack_lvl from mark_lock.part.0+0xb80/0x1298
[   39.808482]  mark_lock.part.0 from __lock_acquire+0xa70/0x29fc
[   39.814304]  __lock_acquire from lock_acquire+0x11c/0x3c8
[   39.819691]  lock_acquire from ntfs_end_buffer_async_read+0xac/0x458
[   39.826033]  ntfs_end_buffer_async_read from end_bio_bh_io_sync+0x30/0x4c
[   39.832809]  end_bio_bh_io_sync from blk_update_request+0x158/0x57c
[   39.839064]  blk_update_request from scsi_end_request+0x1c/0x3d4
[   39.845059]  scsi_end_request from scsi_io_completion+0x38/0x688
[   39.851053]  scsi_io_completion from blk_complete_reqs+0x54/0x60
[   39.857047]  blk_complete_reqs from __do_softirq+0x134/0x598
[   39.862694]  __do_softirq from __irq_exit_rcu+0x124/0x1a8
[   39.868083]  __irq_exit_rcu from irq_exit+0x8/0x28
[   39.872866]  irq_exit from call_with_stack+0x18/0x20
[   39.877824]  call_with_stack from __irq_usr+0x7c/0xa0
[   39.882868] Exception stack(0xf0c69fb0 to 0xf0c69ff8)
[   39.887906] 9fa0:                                     553c47b7 41bd9715 553c47b7 b6b5e9d8
[   39.896065] 9fc0: b6b5ea40 00000000 00000000 b62046a0 0000000a b635f000 beefcbf4 b6b5e924
[   39.904223] 9fe0: 0000001d b6b5e910 b6f448ec b6f44900 80000010 ffffffff

The command leading to this is a simple fdisk -l
It is not clear to me if the problem came from NTFS or ramfs.

The full output is:
fdisk -l
Disk /dev/ram0: 4 MiB, 4194304 bytes, 8192 sectors
Units: sectors of 1 * 512 = 512 bytes
Sector size (logical/physical): 512 bytes / 4096 bytes
I/O size (minimum/optimal): 4096 bytes / 4096 bytes
Disk /dev/ram1: 4 MiB, 4194304 bytes, 8192 sectors
Units: sectors of 1 * 512 = 512 bytes
Sector size (logical/physical): 512 bytes / 4096 bytes
I/O size (minimum/optimal): 4096 bytes / 4096 bytes
Disk /dev/ram2: 4 MiB, 4194304 bytes, 8192 sectors
Units: sectors of 1 * 512 = 512 bytes
Sector size (logical/physical): 512 bytes / 4096 bytes
I/O size (minimum/optimal): 4096 bytes / 4096 bytes
Disk /dev/ram3: 4 MiB, 4194304 bytes, 8192 sectors
Units: sectors of 1 * 512 = 512 bytes
Sector size (logical/physical): 512 bytes / 4096 bytes
I/O size (minimum/optimal): 4096 bytes / 4096 bytes
Disk /dev/ram4: 4 MiB, 4194304 bytes, 8192 sectors
Units: sectors of 1 * 512 = 512 bytes
Sector size (logical/physical): 512 bytes / 4096 bytes
I/O size (minimum/optimal): 4096 bytes / 4096 bytes
Disk /dev/ram5: 4 MiB, 4194304 bytes, 8192 sectors
Units: sectors of 1 * 512 = 512 bytes
Sector size (logical/physical): 512 bytes / 4096 bytes
I/O size (minimum/optimal): 4096 bytes / 4096 bytes
Disk /dev/ram6: 4 MiB, 4194304 bytes, 8192 sectors
Units: sectors of 1 * 512 = 512 bytes
Sector size (logical/physical): 512 bytes / 4096 bytes
I/O size (minimum/optimal): 4096 bytes / 4096 bytes
Disk /dev/ram7: 4 MiB, 4194304 bytes, 8192 sectors
Units: sectors of 1 * 512 = 512 bytes
Sector size (logical/physical): 512 bytes / 4096 bytes
I/O size (minimum/optimal): 4096 bytes / 4096 bytes
Disk /dev/ram8: 4 MiB, 4194304 bytes, 8192 sectors
Units: sectors of 1 * 512 = 512 bytes
Sector size (logical/physical): 512 bytes / 4096 bytes
I/O size (minimum/optimal): 4096 bytes / 4096 bytes
Disk /dev/ram9: 4 MiB, 4194304 bytes, 8192 sectors
Units: sectors of 1 * 512 = 512 bytes
Sector size (logical/physical): 512 bytes / 4096 bytes
I/O size (minimum/optimal): 4096 bytes / 4096 bytes
Disk /dev/ram10: 4 MiB, 4194304 bytes, 8192 sectors
Units: sectors of 1 * 512 = 512 bytes
Sector size (logical/physical): 512 bytes / 4096 bytes
I/O size (minimum/optimal): 4096 bytes / 4096 bytes
Disk /dev/ram11: 4 MiB, 4194304 bytes, 8192 sectors
Units: sectors of 1 * 512 = 512 bytes
Sector size (logical/physical): 512 bytes / 4096 bytes
I/O size (minimum/optimal): 4096 bytes / 4096 bytes
Disk /dev/ram12: 4 MiB, 4194304 bytes, 8192 sectors
Units: sectors of 1 * 512[   39.577565] 
[   39.582103] ================================
[   39.586361] WARNING: inconsistent lock state
[   39.590618] 6.0.0-rc3-next-20220901-00130-gb6b3fb681f34-dirty #8 Not tainted
[   39.597649] --------------------------------
[   39.601907] inconsistent {SOFTIRQ-ON-W} -> {IN-SOFTIRQ-R} usage.
[   39.607897] rngd/218 [HC0[0]:SC1[1]:HE0:SE0] takes:
[   39.612763] c284dba4 (&inode->i_size_seqcount){+.+-}-{0:0}, at: end_bio_bh_io_sync+0x30/0x4c
[   39.621198] {SOFTIRQ-ON-W} state was registered at:
[   39.626061]   simple_write_end+0x1e8/0x2a4
[   39.630154]   page_symlink+0xb0/0x158
[   39.633808]   ramfs_symlink+0x50/0xcc
[   39.637466]   vfs_symlink+0x80/0xf0
[   39.640944]   init_symlink+0x54/0x88
[   39.644512]   do_symlink+0x54/0x88
[   39.647905]   write_buffer+0x28/0x3c
[   39.651470]   flush_buffer+0x40/0x98
[   39.655035]   __gunzip+0x2c4/0x35c
[   39.658427]   gunzip+0x2c/0x34
[   39.661470]   unpack_to_rootfs+0x18c/0x2b4
[   39.665556]   do_populate_rootfs+0x78/0x1cc
[   39.669728]   async_run_entry_fn+0x24/0xb0
[   39.673817]   process_one_work+0x288/0x774
[   39.677904]   worker_thread+0x54/0x51c
[   39.681643]   kthread+0xf8/0x12c
[   39.684862]   ret_from_fork+0x14/0x2c
[   39.688513]   0x0
[   39.690430] irq event stamp: 19119
[   39.693820] hardirqs last  enabled at (19118): [<c010145c>] __do_softirq+0xdc/0x598
[   39.701460] hardirqs last disabled at (19119): [<c0d0afb0>] _raw_read_lock_irqsave+0x84/0x88
[   39.709883] softirqs last  enabled at (19108): [<c01016b4>] __do_softirq+0x334/0x598
[   39.717609] softirqs last disabled at (19117): [<c012bdb0>] __irq_exit_rcu+0x124/0x1a8
[   39.725511] 
[   39.725511] other info that might help us debug this:
[   39.732021]  Possible unsafe locking scenario:
[   39.732021] 
[   39.737924]        CPU0
[   39.740360]        ----
[   39.742796]   lock(&inode->i_size_seqcount);
[   39.747056]   <Interrupt>
[   39.749665]     lock(&inode->i_size_seqcount);
[   39.754098] 
[   39.754098]  *** DEADLOCK ***
[   39.754098] 
[   39.760001] 1 lock held by rngd/218:
[   39.763566]  #0: c284d950 (&ni->size_lock){...-}-{2:2}, at: ntfs_end_buffer_async_read+0x68/0x458
[   39.772432] 
[   39.772432] stack backtrace:
[   39.776777] CPU: 0 PID: 218 Comm: rngd Not tainted 6.0.0-rc3-next-20220901-00130-gb6b3fb681f34-dirty #8
[   39.786149] Hardware name: NVIDIA Tegra SoC (Flattened Device Tree)
[   39.792401]  unwind_backtrace from show_stack+0x10/0x14
[   39.797618]  show_stack from dump_stack_lvl+0x58/0x70
[   39.802660]  dump_stack_lvl from mark_lock.part.0+0xb80/0x1298
[   39.808482]  mark_lock.part.0 from __lock_acquire+0xa70/0x29fc
[   39.814304]  __lock_acquire from lock_acquire+0x11c/0x3c8
[   39.819691]  lock_acquire from ntfs_end_buffer_async_read+0xac/0x458
[   39.826033]  ntfs_end_buffer_async_read from end_bio_bh_io_sync+0x30/0x4c
[   39.832809]  end_bio_bh_io_sync from blk_update_request+0x158/0x57c
[   39.839064]  blk_update_request from scsi_end_request+0x1c/0x3d4
[   39.845059]  scsi_end_request from scsi_io_completion+0x38/0x688
[   39.851053]  scsi_io_completion from blk_complete_reqs+0x54/0x60
[   39.857047]  blk_complete_reqs from __do_softirq+0x134/0x598
[   39.862694]  __do_softirq from __irq_exit_rcu+0x124/0x1a8
[   39.868083]  __irq_exit_rcu from irq_exit+0x8/0x28
[   39.872866]  irq_exit from call_with_stack+0x18/0x20
[   39.877824]  call_with_stack from __irq_usr+0x7c/0xa0
[   39.882868] Exception stack(0xf0c69fb0 to 0xf0c69ff8)
[   39.887906] 9fa0:                                     553c47b7 41bd9715 553c47b7 b6b5e9d8
[   39.896065] 9fc0: b6b5ea40 00000000 00000000 b62046a0 0000000a b635f000 beefcbf4 b6b5e924
[   39.904223] 9fe0: 0000001d b6b5e910 b6f448ec b6f44900 80000010 ffffffff
 = 512 bytes
Sector size (logical/physical): 512 bytes / 4096 bytes
I/O size (minimum/optimal): 4096 bytes / 4096 bytes
Disk /dev/ram13: 4 MiB, 4194304 bytes, 8192 sectors
Units: sectors of 1 * 512 = 512 bytes
Sector size (logical/physical): 512 bytes / 4096 bytes
I/O size (minimum/optimal): 4096 bytes / 4096 bytes
Disk /dev/ram14: 4 MiB, 4194304 bytes, 8192 sectors
Units: sectors of 1 * 512 = 512 bytes
Sector size (logical/physical): 512 bytes / 4096 bytes
I/O size (minimum/optima[   39.951621] ntfs: volume version 3.1.
l): 4096 bytes / 4096 bytes
Disk /dev/ram15: 4 MiB, 4194304 bytes, 8192 sectors
Units: sectors of 1 * 512 = 512 bytes
Sector size (logical/physical): 512 bytes / 4096 bytes
I/O size (minimum/optimal): 4096 bytes / 4096 bytes
Disk /dev/mmcblk1: 14.68 GiB, 15758000128 bytes, 30777344 sectors
Units: sectors of 1 * 512 = 512 bytes
Sector size (logical/physical): 512 bytes / 512 bytes
I/O size (minimum/optimal): 512 bytes / 512 bytes
Disklabel type: gpt
Disk identifier: 00F7EF05-A1E9-E53A-CA0B-CBD0484764BD
Device            Start      End  Sectors  Size Type
/dev/mmcblk1p1    49152 29908991 29859840 14.2G Linux filesystem
/dev/mmcblk1p2 29908992 29917183     8192    4M Microsoft basic data
/dev/mmcblk1p3 29917184 30048255   131072   64M Microsoft basic data
/dev/mmcblk1p4 30048256 30056447     8192    4M Microsoft basic data
/dev/mmcblk1p5 30056448 30064639     8192    4M Microsoft basic data
/dev/mmcblk1p6 30064640 30072831     8192    4M Microsoft basic data
/dev/mmcblk1p7 30072832 30081023     8192    4M Microsoft basic data
/dev/mmcblk1p8 30081024 30773247   692224  338M Microsoft basic data
Disk /dev/mmcblk1boot0: 4 MiB, 4194304 bytes, 8192 sectors
Units: sectors of 1 * 512 = 512 bytes
Sector size (logical/physical): 512 bytes / 512 bytes
I/O size (minimum/optimal): 512 bytes / 512 bytes
Disk /dev/mmcblk1boot1: 4 MiB, 4194304 bytes, 8192 sectors
Units: sectors of 1 * 512 = 512 bytes
Sector size (logical/physical): 512 bytes / 512 bytes
I/O size (minimum/optimal): 512 bytes / 512 bytes
Disk /dev/sda: 149.05 GiB, 160041885696 bytes, 312581808 sectors
Disk model: WDC WD1600BEVS-6
Units: sectors of 1 * 512 = 512 bytes
Sector size (logical/physical): 512 bytes / 512 bytes
I/O size (minimum/optimal): 512 bytes / 512 bytes
Disklabel type: dos
Disk identifier: 0x40aa40aa
Device     Boot     Start       End   Sectors   Size Id Type
/dev/sda1  *           63 296929394 296929332 141.6G  7 HPFS/NTFS/exFAT
/dev/sda2       296929395 312576704  15647310   7.5G  7 HPFS/NTFS/exFAT

Regards

Powered by blists - more mailing lists

Powered by Openwall GNU/*/Linux Powered by OpenVZ