[ 4499.344557] run fstests btrfs/160 at 2021-03-01 22:05:02
[ 4499.508662] BTRFS info (device dm-0): using free space tree
[ 4499.509028] BTRFS info (device dm-0): has skinny extents
[ 4499.744141] dm-9: detected capacity change from 0 to 20971520
[ 4503.982466] BTRFS: device fsid 2d17e17c-e183-4dfd-89eb-47d564cd667b devid 1 transid 5 /dev/dm-9 scanned by systemd-udevd (482234)
[ 4503.995781] BTRFS: device fsid 2d17e17c-e183-4dfd-89eb-47d564cd667b devid 2 transid 5 /dev/dm-6 scanned by systemd-udevd (482234)
[ 4504.016082] ------------[ cut here ]------------
[ 4504.016352] WARNING: CPU: 0 PID: 257100 at drivers/gpu/drm/ttm/ttm_bo.c:512 ttm_bo_release+0x4f9/0x5c0 [ttm]
[ 4504.016928] Modules linked in: dm_dust dm_flakey loop nft_fib_inet nft_fib_ipv4 nft_fib_ipv6 nft_fib nft_reject_inet nf_reject_ipv4 nf_reject_ipv6 nft_reject nft_ct nft_chain_nat nf_nat nf_conntrack nf_defrag_ipv6 nf_defrag_ipv4 ip6_tables nft_compat ip_set rfkill nf_tables nfnetlink xfs intel_rapl_msr iTCO_wdt iTCO_vendor_support snd_hda_codec_generic intel_rapl_common snd_hda_intel joydev i2c_i801 i2c_smbus snd_intel_dspcfg snd_hda_codec snd_hwdep virtio_balloon snd_hda_core snd_pcm lpc_ich snd_timer snd soundcore zram ip_tables crct10dif_pclmul crc32_pclmul crc32c_intel ghash_clmulni_intel qxl drm_ttm_helper serio_raw ttm drm_kms_helper cec drm virtio_blk qemu_fw_cfg
[ 4504.020222] CPU: 0 PID: 257100 Comm: kworker/0:13 Tainted: G        W         5.12.0-rc1+ #153
[ 4504.020720] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[ 4504.021196] Workqueue: events qxl_gc_work [qxl]
[ 4504.021457] RIP: 0010:ttm_bo_release+0x4f9/0x5c0 [ttm]
[ 4504.021771] Code: ff 48 8b bd e8 fe ff ff b9 30 75 00 00 31 d2 be 01 00 00 00 e8 38 75 55 e5 48 8b 45 e0 e9 fb fe ff ff 4c 89 e8 e9 f3 fe ff ff <0f> 0b c7 85 94 00 00 00 00 00 00 00 48 8b 3c 24 48 8d 75 08 31 d2
[ 4504.022819] RSP: 0018:ffff9cbc016bbd80 EFLAGS: 00010202
[ 4504.023121] RAX: 0000000000000001 RBX: 000000000000000c RCX: 0000000000000000
[ 4504.023524] RDX: 0000000000000001 RSI: 0000000000000000 RDI: ffffffffc03ff168
[ 4504.023941] RBP: ffff8fc7c2121648 R08: 0000000000000000 R09: 0000000000000000
[ 4504.024343] R10: 0000000000000000 R11: ffff8fc7c26d8ff8 R12: ffff8fc7c0ad5200
[ 4504.024759] R13: ffff8fc7cc8d4d90 R14: ffff8fc7c21216b0 R15: ffff8fc7c0ad5700
[ 4504.025162] FS:  0000000000000000(0000) GS:ffff8fc83bc00000(0000) knlGS:0000000000000000
[ 4504.025628] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[ 4504.025957] CR2: 00007f06ebe13158 CR3: 000000011165a005 CR4: 0000000000370ef0
[ 4504.026363] Call Trace:
[ 4504.026510]  qxl_bo_unref+0x31/0x50 [qxl]
[ 4504.026764]  qxl_release_free_list+0x52/0xa0 [qxl]
[ 4504.027043]  qxl_release_free+0x76/0xe0 [qxl]
[ 4504.027296]  qxl_garbage_collect+0xbd/0x170 [qxl]
[ 4504.027568]  process_one_work+0x26e/0x570
[ 4504.027821]  worker_thread+0x55/0x3c0
[ 4504.028036]  ? process_one_work+0x570/0x570
[ 4504.028277]  kthread+0x137/0x150
[ 4504.028467]  ? __kthread_bind_mask+0x60/0x60
[ 4504.028730]  ret_from_fork+0x1f/0x30
[ 4504.028942] irq event stamp: 0
[ 4504.029120] hardirqs last  enabled at (0): [<0000000000000000>] 0x0
[ 4504.029478] hardirqs last disabled at (0): [] copy_process+0x8c4/0x1ca0
[ 4504.029955] softirqs last  enabled at (0): [] copy_process+0x8c4/0x1ca0
[ 4504.030420] softirqs last disabled at (0): [<0000000000000000>] 0x0
[ 4504.030794] ---[ end trace 5f7855eb2e852b30 ]---
[ 4504.031128] ------------[ cut here ]------------
[ 4504.031394] WARNING: CPU: 0 PID: 257100 at drivers/gpu/drm/ttm/ttm_bo.c:512 ttm_bo_release+0x4f9/0x5c0 [ttm]
[ 4504.031965] Modules linked in: dm_dust dm_flakey loop nft_fib_inet nft_fib_ipv4 nft_fib_ipv6 nft_fib nft_reject_inet nf_reject_ipv4 nf_reject_ipv6 nft_reject nft_ct nft_chain_nat nf_nat nf_conntrack nf_defrag_ipv6 nf_defrag_ipv4 ip6_tables nft_compat ip_set rfkill nf_tables nfnetlink xfs intel_rapl_msr iTCO_wdt iTCO_vendor_support snd_hda_codec_generic intel_rapl_common snd_hda_intel joydev i2c_i801 i2c_smbus snd_intel_dspcfg snd_hda_codec snd_hwdep virtio_balloon snd_hda_core snd_pcm lpc_ich snd_timer snd soundcore zram ip_tables crct10dif_pclmul crc32_pclmul crc32c_intel ghash_clmulni_intel qxl drm_ttm_helper serio_raw ttm drm_kms_helper cec drm virtio_blk qemu_fw_cfg
[ 4504.035284] CPU: 0 PID: 257100 Comm: kworker/0:13 Tainted: G        W         5.12.0-rc1+ #153
[ 4504.035783] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[ 4504.036263] Workqueue: events qxl_gc_work [qxl]
[ 4504.036525] RIP: 0010:ttm_bo_release+0x4f9/0x5c0 [ttm]
[ 4504.036842] Code: ff 48 8b bd e8 fe ff ff b9 30 75 00 00 31 d2 be 01 00 00 00 e8 38 75 55 e5 48 8b 45 e0 e9 fb fe ff ff 4c 89 e8 e9 f3 fe ff ff <0f> 0b c7 85 94 00 00 00 00 00 00 00 48 8b 3c 24 48 8d 75 08 31 d2
[ 4504.037906] RSP: 0018:ffff9cbc016bbd80 EFLAGS: 00010202
[ 4504.038205] RAX: 0000000000000001 RBX: 000000000000000f RCX: 0000000000000000
[ 4504.038617] RDX: 0000000000000001 RSI: 0000000000000000 RDI: ffffffffc03ff168
[ 4504.039026] RBP: ffff8fc7d1361e48 R08: 0000000000000000 R09: 0000000000000000
[ 4504.039428] R10: 0000000000000000 R11: ffff8fc7c26d8ff8 R12: ffff8fc73acf8b00
[ 4504.039848] R13: ffff8fc7cc8d4d90 R14: ffff8fc7d1361eb0 R15: ffff8fc73acf8000
[ 4504.040250] FS:  0000000000000000(0000) GS:ffff8fc83bc00000(0000) knlGS:0000000000000000
[ 4504.040720] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[ 4504.041047] CR2: 00007f06ebe13158 CR3: 000000011165a005 CR4: 0000000000370ef0
[ 4504.041451] Call Trace:
[ 4504.041609]  qxl_bo_unref+0x31/0x50 [qxl]
[ 4504.041851]  qxl_release_free_list+0x52/0xa0 [qxl]
[ 4504.042129]  qxl_release_free+0x76/0xe0 [qxl]
[ 4504.042381]  qxl_garbage_collect+0xbd/0x170 [qxl]
[ 4504.042666]  process_one_work+0x26e/0x570
[ 4504.042907]  worker_thread+0x55/0x3c0
[ 4504.043119]  ? process_one_work+0x570/0x570
[ 4504.043360]  kthread+0x137/0x150
[ 4504.043549]  ? __kthread_bind_mask+0x60/0x60
[ 4504.043812]  ret_from_fork+0x1f/0x30
[ 4504.044025] irq event stamp: 0
[ 4504.044203] hardirqs last  enabled at (0): [<0000000000000000>] 0x0
[ 4504.044557] hardirqs last disabled at (0): [] copy_process+0x8c4/0x1ca0
[ 4504.045035] softirqs last  enabled at (0): [] copy_process+0x8c4/0x1ca0
[ 4504.045496] softirqs last disabled at (0): [<0000000000000000>] 0x0
[ 4504.045866] ---[ end trace 5f7855eb2e852b31 ]---
[ 4504.106690] BTRFS: device fsid 2d17e17c-e183-4dfd-89eb-47d564cd667b devid 3 transid 5 /dev/dm-5 scanned by systemd-udevd (482234)
[ 4504.118855] BTRFS: device fsid 2d17e17c-e183-4dfd-89eb-47d564cd667b devid 4 transid 5 /dev/dm-4 scanned by systemd-udevd (482234)
[ 4504.230422] BTRFS: device fsid 2d17e17c-e183-4dfd-89eb-47d564cd667b devid 5 transid 5 /dev/dm-3 scanned by systemd-udevd (482234)
[ 4504.250148] BTRFS: device fsid 2d17e17c-e183-4dfd-89eb-47d564cd667b devid 6 transid 5 /dev/dm-2 scanned by systemd-udevd (482234)
[ 4504.255128] BTRFS: device fsid 2d17e17c-e183-4dfd-89eb-47d564cd667b devid 7 transid 5 /dev/mapper/vg0-lv1 scanned by mkfs.btrfs (482224)
[ 4504.265819] BTRFS info (device dm-9): enabling free space tree
[ 4504.265888] BTRFS info: devid 7 device path /dev/mapper/vg0-lv1 changed to /dev/dm-1 scanned by systemd-udevd (482234)
[ 4504.266162] BTRFS info (device dm-9): using free space tree
[ 4504.267248] BTRFS info (device dm-9): has skinny extents
[ 4504.267552] BTRFS info (device dm-9): flagging fs with big metadata feature
[ 4504.268180] BTRFS info: devid 7 device path /dev/dm-1 changed to /dev/mapper/vg0-lv1 scanned by systemd-udevd (482234)
[ 4504.276789] BTRFS info (device dm-9): creating free space tree
[ 4504.277201] BTRFS info (device dm-9): setting compat-ro feature flag for FREE_SPACE_TREE (0x1)
[ 4504.277705] BTRFS info (device dm-9): setting compat-ro feature flag for FREE_SPACE_TREE_VALID (0x2)
[ 4504.471044] BTRFS info (device dm-9): cleaning free space cache v1
[ 4504.471064] BTRFS info (device dm-9): devid 1 device path /dev/mapper/error-test changed to /dev/dm-9 scanned by systemd-udevd (482234)
[ 4504.698990] BTRFS info (device dm-9): checking UUID tree
[ 4504.699359] BTRFS info (device dm-9): devid 6 device path /dev/mapper/vg0-lv2 changed to /dev/dm-2 scanned by systemd-udevd (482248)
[ 4504.703709] BTRFS info (device dm-9): devid 6 device path /dev/dm-2 changed to /dev/mapper/vg0-lv2 scanned by systemd-udevd (482248)
[ 4504.705349] BTRFS info (device dm-9): devid 5 device path /dev/mapper/vg0-lv3 changed to /dev/dm-3 scanned by systemd-udevd (482268)
[ 4504.708012] BTRFS info (device dm-9): devid 5 device path /dev/dm-3 changed to /dev/mapper/vg0-lv3 scanned by systemd-udevd (482268)
[ 4504.712103] BTRFS info (device dm-9): devid 3 device path /dev/mapper/vg0-lv5 changed to /dev/dm-5 scanned by systemd-udevd (482270)
[ 4504.714398] BTRFS info (device dm-9): devid 2 device path /dev/mapper/vg0-lv6 changed to /dev/dm-6 scanned by systemd-udevd (482271)
[ 4504.717021] BTRFS info (device dm-9): devid 2 device path /dev/dm-6 changed to /dev/mapper/vg0-lv6 scanned by systemd-udevd (482271)
[ 4504.718616] BTRFS info (device dm-9): devid 4 device path /dev/mapper/vg0-lv4 changed to /dev/dm-4 scanned by systemd-udevd (482269)
[ 4504.720610] BTRFS info (device dm-9): devid 1 device path /dev/dm-9 changed to /dev/mapper/error-test scanned by systemd-udevd (482234)
[ 4504.721716] BTRFS info (device dm-9): devid 3 device path /dev/dm-5 changed to /dev/mapper/vg0-lv5 scanned by systemd-udevd (482270)
[ 4504.725649] BTRFS info (device dm-9): devid 4 device path /dev/dm-4 changed to /dev/mapper/vg0-lv4 scanned by systemd-udevd (482269)
[ 4505.079434] BTRFS info (device dm-9): devid 4 device path /dev/mapper/vg0-lv4 changed to /dev/dm-4 scanned by systemd-udevd (482248)
[ 4505.082332] BTRFS info (device dm-9): devid 4 device path /dev/dm-4 changed to /dev/mapper/vg0-lv4 scanned by systemd-udevd (482248)
[ 4505.097044] BTRFS info (device dm-9): devid 1 device path /dev/mapper/error-test changed to /dev/dm-9 scanned by systemd-udevd (482271)
[ 4505.099464] BTRFS info (device dm-9): devid 1 device path /dev/dm-9 changed to /dev/mapper/error-test scanned by systemd-udevd (482271)
[ 4505.136049] btrfs_dev_stat_print_on_error: 38 callbacks suppressed
[ 4505.136052] BTRFS error (device dm-9): bdev /dev/mapper/error-test errs: wr 1, rd 0, flush 0, corrupt 0, gen 0
[ 4505.137552] BTRFS error (device dm-9): bdev /dev/mapper/error-test errs: wr 2, rd 0, flush 0, corrupt 0, gen 0
[ 4505.138861] BTRFS error (device dm-9): bdev /dev/mapper/error-test errs: wr 3, rd 0, flush 0, corrupt 0, gen 0
[ 4505.139851] BTRFS error (device dm-9): bdev /dev/mapper/error-test errs: wr 4, rd 0, flush 0, corrupt 0, gen 0
[ 4505.141933] BTRFS error (device dm-9): bdev /dev/mapper/error-test errs: wr 5, rd 0, flush 0, corrupt 0, gen 0
[ 4505.143209] BTRFS error (device dm-9): bdev /dev/mapper/error-test errs: wr 6, rd 0, flush 0, corrupt 0, gen 0
[ 4505.144241] BTRFS error (device dm-9): bdev /dev/mapper/error-test errs: wr 7, rd 0, flush 0, corrupt 0, gen 0
[ 4505.145951] BTRFS error (device dm-9): bdev /dev/mapper/error-test errs: wr 8, rd 0, flush 0, corrupt 0, gen 0
[ 4505.147430] BTRFS error (device dm-9): bdev /dev/mapper/error-test errs: wr 9, rd 0, flush 0, corrupt 0, gen 0
[ 4505.148796] BTRFS error (device dm-9): bdev /dev/mapper/error-test errs: wr 10, rd 0, flush 0, corrupt 0, gen 0
[ 4505.488513] BTRFS warning (device dm-9): lost page write due to IO error on /dev/mapper/error-test (-5)
[ 4505.489075] BTRFS warning (device dm-9): lost page write due to IO error on /dev/mapper/error-test (-5)
[ 4505.489964] BTRFS error (device dm-9): error writing primary super block to device 1
[ 4505.525888] BTRFS info (device dm-9): devid 1 device path /dev/mapper/error-test changed to /dev/dm-9 scanned by systemd-udevd (482248)
[ 4505.527497] BTRFS info (device dm-9): devid 1 device path /dev/dm-9 changed to /dev/mapper/error-test scanned by systemd-udevd (482248)