Date:   Wed, 07 Mar 2018 16:30:05 +0000
From:   bugzilla-daemon@...zilla.kernel.org
To:     linux-ext4@...nel.org
Subject: [Bug 198923] Linux 4.15.4+: Write on Ext4 causes system block

https://bugzilla.kernel.org/show_bug.cgi?id=198923

Dāvis (davispuh@...il.com) changed:

           What    |Removed                     |Added
----------------------------------------------------------------------------
                 CC|                            |davispuh@...il.com

--- Comment #7 from Dāvis (davispuh@...il.com) ---
I think I'm getting similar or this same problem on ArchLinux with 4.15.7
kernel.

Trying to read one file on BTRFS partition on a HDD which has unreadable sector
causes kernel to lockup and I have to restart PC.

dmesg

[ 2253.091452] WARNING: CPU: 5 PID: 47 at kernel/rcu/tree.c:2792
rcu_do_batch.isra.28+0x231/0x250
[ 2253.091455] Modules linked in: nls_iso8859_4 nls_cp775 cfg80211 rfkill
devlink nf_conntrack_netbios_ns nf_conntrack_broadcast xt_tcpudp xt_CT
ip6t_rpfilter ip6t_REJECT nf_reject_ipv6 ipt_REJECT nf_reject_ipv4 xt_conntrack
ip_set nfnetlink ebtable_nat ebtable_broute ip6table_nat nf_conntrack_ipv6
nf_defrag_ipv6 nf_nat_ipv6 ip6table_mangle ip6table_raw ip6table_security
iptable_nat nf_conntrack_ipv4 nf_defrag_ipv4 nf_nat_ipv4 nf_nat nf_conntrack
iptable_mangle iptable_raw iptable_security ebtable_filter ebtables
ip6table_filter ip6_tables bridge stp llc iptable_filter it87 hwmon_vid
saa7134_alsa saa7134 edac_mce_amd kvm_amd tveeprom v4l2_common videobuf2_dma_sg
kvm videobuf2_memops snd_hda_codec_hdmi irqbypass crct10dif_pclmul crc32_pclmul
snd_hda_codec_realtek snd_hda_codec_generic ghash_clmulni_intel
[ 2253.091504]  videobuf2_v4l2 snd_hda_intel pcbc raid456 async_raid6_recov
async_memcpy libcrc32c async_pq async_xor async_tx aesni_intel snd_hda_codec
videobuf2_core r8169 snd_hda_core md_mod snd_hwdep mxm_wmi aes_x86_64 snd_pcm
wmi_bmof crypto_simd glue_helper snd_timer cryptd fam15h_power k10temp snd
videodev pcspkr mii media rc_core sp5100_tco evdev i2c_piix4 soundcore wmi
mac_hid shpchp rtc_cmos acpi_cpufreq nfsd auth_rpcgss nfs_acl lockd grace
sunrpc sg crypto_user nvidia_uvm(PO) btrfs xor zstd_decompress zstd_compress
xxhash raid6_pq sd_mod nvidia_drm(PO) nvidia_modeset(PO) ohci_pci ata_generic
pata_acpi nvidia(PO) drm_kms_helper syscopyarea sysfillrect sysimgblt
fb_sys_fops firewire_ohci firewire_core xhci_pci crc_itu_t drm pata_atiixp
ehci_pci xhci_hcd ahci ehci_hcd ohci_hcd libahci agpgart
[ 2253.091572]  ipmi_devintf usbcore ipmi_msghandler usb_common mvsas libsas
scsi_transport_sas libata scsi_mod crc32c_generic crc32c_intel vfat fat
ip_tables x_tables
[ 2253.091587] CPU: 5 PID: 47 Comm: rcuc/5 Tainted: P           O    
4.15.7-1-ARCH #1
[ 2253.091589] Hardware name: Gigabyte Technology Co., Ltd.
GA-990FXA-UD3/GA-990FXA-UD3, BIOS FFe 11/08/2013
[ 2253.091593] RIP: 0010:rcu_do_batch.isra.28+0x231/0x250
[ 2253.091595] RSP: 0018:ffffa8fe432efe50 EFLAGS: 00010002
[ 2253.091597] RAX: ffffffffffffd800 RBX: ffff9e1f2ed62380 RCX:
000000000b955e01
[ 2253.091599] RDX: 0000000000000005 RSI: ffffa8fe432efe50 RDI:
ffff9e1f2ed623b8
[ 2253.091600] RBP: ffff9e1f2ed623b8 R08: 00002adf10e20800 R09:
ffffffffb70ee1f9
[ 2253.091602] R10: ffffedcb8ed99000 R11: 00000000ffffff80 R12:
0000000000000246
[ 2253.091603] R13: ffffffffb8054250 R14: fffffffffffffeac R15:
ffff9e1f128a3c80
[ 2253.091606] FS:  0000000000000000(0000) GS:ffff9e1f2ed40000(0000)
knlGS:0000000000000000
[ 2253.091607] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[ 2253.091609] CR2: 00007f24768d8010 CR3: 000000053a1f8000 CR4:
00000000000406e0
[ 2253.091611] Call Trace:
[ 2253.091619]  ? rcu_cpu_kthread+0x49/0x2d0
[ 2253.091623]  ? sort_range+0x20/0x20
[ 2253.091626]  rcu_cpu_kthread+0x10d/0x2d0
[ 2253.091629]  ? sort_range+0x20/0x20
[ 2253.091632]  smpboot_thread_fn+0x19e/0x240
[ 2253.091635]  kthread+0x113/0x130
[ 2253.091638]  ? kthread_create_on_node+0x70/0x70
[ 2253.091642]  ret_from_fork+0x22/0x40
[ 2253.091645] Code: 48 83 6c 24 18 01 e9 e8 fe ff ff 48 3b 15 d0 5f f6 00 0f
8f 6b ff ff ff 48 8b 05 d3 5f f6 00 48 89 83 b0 00 00 00 e9 58 ff ff ff <0f> 0b
eb 8d 0f 0b e9 65 fe ff ff e8 8f cc f8 ff 0f 1f 44 00 00
[ 2253.091692] ---[ end trace 43c301635fb3a898 ]---
[ 2458.658915] INFO: task btrfs-transacti:353 blocked for more than 120
seconds.
[ 2458.658990]       Tainted: P        W  O     4.15.7-1-ARCH #1
[ 2458.659046] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this
message.
[ 2458.659115] btrfs-transacti D    0   353      2 0x80000000
[ 2458.659121] Call Trace:
[ 2458.659136]  ? __schedule+0x24b/0x8c0
[ 2458.659142]  ? percpu_counter_add_batch+0x7e/0xb0
[ 2458.659148]  schedule+0x32/0x90
[ 2458.659154]  io_schedule+0x12/0x40
[ 2458.659160]  wait_on_page_bit+0xea/0x130
[ 2458.659166]  ? add_to_page_cache_lru+0xe0/0xe0
[ 2458.659172]  __filemap_fdatawait_range+0xbf/0x110
[ 2458.659180]  filemap_fdatawait_range+0xe/0x20
[ 2458.659231]  btrfs_wait_ordered_range+0x68/0x100 [btrfs]
[ 2458.659275]  __btrfs_wait_cache_io+0x42/0x1b0 [btrfs]
[ 2458.659311]  btrfs_start_dirty_block_groups+0x1a2/0x470 [btrfs]
[ 2458.659351]  btrfs_commit_transaction+0x117/0x930 [btrfs]
[ 2458.659389]  ? start_transaction+0x9e/0x420 [btrfs]
[ 2458.659426]  transaction_kthread+0x17b/0x1a0 [btrfs]
[ 2458.659463]  ? btrfs_cleanup_transaction+0x570/0x570 [btrfs]
[ 2458.659467]  kthread+0x113/0x130
[ 2458.659471]  ? kthread_create_on_node+0x70/0x70
[ 2458.659475]  ? do_syscall_64+0x74/0x190
[ 2458.659481]  ? SyS_exit_group+0x10/0x10
[ 2458.659484]  ret_from_fork+0x22/0x40
[ 2458.659495] INFO: task systemd-journal:410 blocked for more than 120
seconds.
[ 2458.659559]       Tainted: P        W  O     4.15.7-1-ARCH #1
[ 2458.659611] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this
message.
[ 2458.659679] systemd-journal D    0   410      1 0x00000104
[ 2458.659683] Call Trace:
[ 2458.659689]  ? __schedule+0x24b/0x8c0
[ 2458.659695]  ? bit_wait+0x50/0x50
[ 2458.659699]  schedule+0x32/0x90
[ 2458.659703]  io_schedule+0x12/0x40
[ 2458.659707]  bit_wait_io+0xd/0x50
[ 2458.659712]  __wait_on_bit+0x44/0x80
[ 2458.659718]  ? submit_bio+0x6c/0x140
[ 2458.659722]  out_of_line_wait_on_bit+0x91/0xb0
[ 2458.659727]  ? bit_waitqueue+0x30/0x30
[ 2458.659763]  write_all_supers+0x3b6/0xa80 [btrfs]
[ 2458.659792]  ? _raw_spin_lock_irq+0x1a/0x40
[ 2458.659835]  ? btrfs_sync_log+0x7b7/0xaf0 [btrfs]
[ 2458.659876]  btrfs_sync_log+0x7b7/0xaf0 [btrfs]
[ 2458.659919]  ? btrfs_sync_file+0x32e/0x440 [btrfs]
[ 2458.659958]  btrfs_sync_file+0x32e/0x440 [btrfs]
[ 2458.659965]  do_fsync+0x38/0x60
[ 2458.659969]  SyS_fsync+0xc/0x10
[ 2458.659973]  do_syscall_64+0x74/0x190
[ 2458.659978]  entry_SYSCALL_64_after_hwframe+0x3d/0xa2
[ 2458.659982] RIP: 0033:0x7f24764c90ec
[ 2458.659984] RSP: 002b:00007ffc11e7e3e0 EFLAGS: 00000293 ORIG_RAX:
000000000000004a
[ 2458.659988] RAX: ffffffffffffffda RBX: 000055a735604850 RCX:
00007f24764c90ec
[ 2458.659991] RDX: 0000000000000000 RSI: 000055a735603960 RDI:
0000000000000026
[ 2458.659993] RBP: 0000000000000001 R08: 00000000000000ca R09:
00007f2470a3f9d0
[ 2458.659995] R10: 0000000000000000 R11: 0000000000000293 R12:
00007ffc11e7e540
[ 2458.659997] R13: 00007ffc11e7e538 R14: 000055a735604850 R15:
00007ffc11e7e6a8
[ 2458.660015] INFO: task WTJourn.Flusher:1149 blocked for more than 120
seconds.
[ 2458.660081]       Tainted: P        W  O     4.15.7-1-ARCH #1
[ 2458.660132] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this
message.
[ 2458.660200] WTJourn.Flusher D    0  1149      1 0x00000000
[ 2458.660204] Call Trace:
[ 2458.660210]  ? __schedule+0x24b/0x8c0
[ 2458.660215]  ? preempt_count_add+0x68/0xa0
[ 2458.660220]  schedule+0x32/0x90
[ 2458.660261]  wait_ordered_extents.isra.3.constprop.7+0x337/0x3b0 [btrfs]
[ 2458.660267]  ? wait_woken+0x80/0x80
[ 2458.660309]  btrfs_log_changed_extents+0x256/0x610 [btrfs]
[ 2458.660351]  ? fill_inode_item.isra.2+0x22f/0x290 [btrfs]
[ 2458.660392]  btrfs_log_inode+0x9ba/0xf60 [btrfs]
[ 2458.660432]  ? btrfs_submit_bio_hook+0x8e/0x180 [btrfs]
[ 2458.660475]  btrfs_log_inode_parent+0x27f/0xa40 [btrfs]
[ 2458.660482]  ? preempt_count_add+0x68/0xa0
[ 2458.660485]  ? _raw_spin_lock+0x13/0x40
[ 2458.660488]  ? preempt_count_add+0x68/0xa0
[ 2458.660491]  ? _raw_spin_lock+0x13/0x40
[ 2458.660531]  btrfs_log_dentry_safe+0x58/0x80 [btrfs]
[ 2458.660572]  btrfs_sync_file+0x2eb/0x440 [btrfs]
[ 2458.660578]  do_fsync+0x38/0x60
[ 2458.660582]  SyS_fdatasync+0xf/0x20
[ 2458.660586]  do_syscall_64+0x74/0x190
[ 2458.660590]  entry_SYSCALL_64_after_hwframe+0x3d/0xa2
[ 2458.660593] RIP: 0033:0x7fa5ba08da7c
[ 2458.660596] RSP: 002b:00007fa5b32dc710 EFLAGS: 00000293 ORIG_RAX:
000000000000004b
[ 2458.660599] RAX: ffffffffffffffda RBX: 0000000000000010 RCX:
00007fa5ba08da7c
[ 2458.660602] RDX: 0000000000000000 RSI: 0000000000000010 RDI:
0000000000000010
[ 2458.660604] RBP: 000000000000000a R08: 0000000000000020 R09:
0000000000000010
[ 2458.660606] R10: 6769546465726957 R11: 0000000000000293 R12:
0000000000000001
[ 2458.660608] R13: 000055e6352ab2f0 R14: 000055e635208480 R15:
00007fa5bcc5b6a7
[ 2458.660631] INFO: task netdata:1301 blocked for more than 120 seconds.
[ 2458.660690]       Tainted: P        W  O     4.15.7-1-ARCH #1
[ 2458.660741] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this
message.
[ 2458.660819] netdata         D    0  1301      1 0x00000000
[ 2458.660823] Call Trace:
[ 2458.660830]  ? __schedule+0x24b/0x8c0
[ 2458.660835]  schedule+0x32/0x90
[ 2458.660839]  schedule_preempt_disabled+0x14/0x20
[ 2458.660844]  __mutex_lock.isra.0+0x274/0x520
[ 2458.660877]  ? btrfs_show_devname+0x28/0xf0 [btrfs]
[ 2458.660907]  btrfs_show_devname+0x28/0xf0 [btrfs]
[ 2458.660913]  show_mountinfo+0x1a2/0x290
[ 2458.660918]  seq_read+0x371/0x480
[ 2458.660925]  __vfs_read+0x36/0x170
[ 2458.660932]  vfs_read+0x91/0x130
[ 2458.660937]  SyS_read+0x52/0xc0
[ 2458.660942]  do_syscall_64+0x74/0x190
[ 2458.660947]  entry_SYSCALL_64_after_hwframe+0x3d/0xa2
[ 2458.660949] RIP: 0033:0x7fac0c978988
[ 2458.660952] RSP: 002b:00007fac0a564c90 EFLAGS: 00000246 ORIG_RAX:
0000000000000000
[ 2458.660956] RAX: ffffffffffffffda RBX: 000055dff2ac3ec0 RCX:
00007fac0c978988
[ 2458.660958] RDX: 0000000000000200 RSI: 000055dff2ac3ec0 RDI:
0000000000000027
[ 2458.660960] RBP: 0000000000000200 R08: 0000000000000000 R09:
00000000000040b0
[ 2458.660962] R10: 000055dff2062840 R11: 0000000000000246 R12:
000000005a9ffc5b
[ 2458.660964] R13: 00007fac0a565dd0 R14: 000055dff2aa6980 R15:
0000000000000001
[ 2485.422034] systemd[1]: systemd-journald.service: State 'stop-sigabrt' timed
out. Terminating.
[ 2575.674793] systemd[1]: systemd-journald.service: State 'stop-sigterm' timed
out. Killing.
[ 2575.674845] systemd[1]: systemd-journald.service: Killing process 410
(systemd-journal) with signal SIGKILL.
[ 2581.542546] INFO: task btrfs-transacti:353 blocked for more than 120
seconds.
[ 2581.542622]       Tainted: P        W  O     4.15.7-1-ARCH #1
[ 2581.542675] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this
message.
[ 2581.542750] btrfs-transacti D    0   353      2 0x80000000
[ 2581.542755] Call Trace:
[ 2581.542765]  ? __schedule+0x24b/0x8c0
[ 2581.542770]  ? percpu_counter_add_batch+0x7e/0xb0
[ 2581.542773]  schedule+0x32/0x90
[ 2581.542778]  io_schedule+0x12/0x40
[ 2581.542783]  wait_on_page_bit+0xea/0x130
[ 2581.542787]  ? add_to_page_cache_lru+0xe0/0xe0
[ 2581.542791]  __filemap_fdatawait_range+0xbf/0x110
[ 2581.542796]  filemap_fdatawait_range+0xe/0x20
[ 2581.542833]  btrfs_wait_ordered_range+0x68/0x100 [btrfs]
[ 2581.542864]  __btrfs_wait_cache_io+0x42/0x1b0 [btrfs]
[ 2581.542889]  btrfs_start_dirty_block_groups+0x1a2/0x470 [btrfs]
[ 2581.542917]  btrfs_commit_transaction+0x117/0x930 [btrfs]
[ 2581.542943]  ? start_transaction+0x9e/0x420 [btrfs]
[ 2581.542970]  transaction_kthread+0x17b/0x1a0 [btrfs]
[ 2581.542996]  ? btrfs_cleanup_transaction+0x570/0x570 [btrfs]
[ 2581.542999]  kthread+0x113/0x130
[ 2581.543002]  ? kthread_create_on_node+0x70/0x70
[ 2581.543005]  ? do_syscall_64+0x74/0x190
[ 2581.543009]  ? SyS_exit_group+0x10/0x10
[ 2581.543012]  ret_from_fork+0x22/0x40
[ 2581.543019] INFO: task systemd-journal:410 blocked for more than 120
seconds.
[ 2581.543065]       Tainted: P        W  O     4.15.7-1-ARCH #1
[ 2581.543101] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this
message.
[ 2581.543148] systemd-journal D    0   410      1 0x00000104
[ 2581.543151] Call Trace:
[ 2581.543156]  ? __schedule+0x24b/0x8c0
[ 2581.543159]  ? bit_wait+0x50/0x50
[ 2581.543162]  schedule+0x32/0x90
[ 2581.543165]  io_schedule+0x12/0x40
[ 2581.543168]  bit_wait_io+0xd/0x50
[ 2581.543171]  __wait_on_bit+0x44/0x80
[ 2581.543175]  ? submit_bio+0x6c/0x140
[ 2581.543178]  out_of_line_wait_on_bit+0x91/0xb0
[ 2581.543181]  ? bit_waitqueue+0x30/0x30
[ 2581.543207]  write_all_supers+0x3b6/0xa80 [btrfs]
[ 2581.543210]  ? _raw_spin_lock_irq+0x1a/0x40
[ 2581.543239]  ? btrfs_sync_log+0x7b7/0xaf0 [btrfs]
[ 2581.543268]  btrfs_sync_log+0x7b7/0xaf0 [btrfs]
[ 2581.543298]  ? btrfs_sync_file+0x32e/0x440 [btrfs]
[ 2581.543325]  btrfs_sync_file+0x32e/0x440 [btrfs]
[ 2581.543330]  do_fsync+0x38/0x60
[ 2581.543333]  SyS_fsync+0xc/0x10
[ 2581.543336]  do_syscall_64+0x74/0x190
[ 2581.543339]  entry_SYSCALL_64_after_hwframe+0x3d/0xa2
[ 2581.543342] RIP: 0033:0x7f24764c90ec
[ 2581.543344] RSP: 002b:00007ffc11e7e3e0 EFLAGS: 00000293 ORIG_RAX:
000000000000004a
[ 2581.543346] RAX: ffffffffffffffda RBX: 000055a735604850 RCX:
00007f24764c90ec
[ 2581.543348] RDX: 0000000000000000 RSI: 000055a735603960 RDI:
0000000000000026
[ 2581.543350] RBP: 0000000000000001 R08: 00000000000000ca R09:
00007f2470a3f9d0
[ 2581.543351] R10: 0000000000000000 R11: 0000000000000293 R12:
00007ffc11e7e540
[ 2581.543353] R13: 00007ffc11e7e538 R14: 000055a735604850 R15:
00007ffc11e7e6a8
[ 2581.543366] INFO: task mongod:1137 blocked for more than 120 seconds.
[ 2581.543407]       Tainted: P        W  O     4.15.7-1-ARCH #1
[ 2581.543452] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this
message.
[ 2581.543501] mongod          D    0  1137      1 0x00000000
[ 2581.543504] Call Trace:
[ 2581.543509]  ? __schedule+0x24b/0x8c0
[ 2581.543513]  schedule+0x32/0x90
[ 2581.543516]  rwsem_down_write_failed+0x164/0x240
[ 2581.543520]  ? futex_wait+0x1c7/0x240
[ 2581.543525]  ? call_rwsem_down_write_failed+0x13/0x20
[ 2581.543527]  call_rwsem_down_write_failed+0x13/0x20
[ 2581.543531]  down_write+0x20/0x30
[ 2581.543558]  btrfs_file_write_iter+0xb6/0x650 [btrfs]
[ 2581.543565]  __vfs_write+0xf8/0x180
[ 2581.543570]  vfs_write+0xb1/0x1a0
[ 2581.543573]  SyS_pwrite64+0x90/0xb0
[ 2581.543577]  do_syscall_64+0x74/0x190
[ 2581.543579]  entry_SYSCALL_64_after_hwframe+0x3d/0xa2
[ 2581.543582] RIP: 0033:0x7fa5ba3694f3
[ 2581.543583] RSP: 002b:00007fa5b62e2880 EFLAGS: 00000293 ORIG_RAX:
0000000000000012
[ 2581.543586] RAX: ffffffffffffffda RBX: 0000000000000080 RCX:
00007fa5ba3694f3
[ 2581.543588] RDX: 0000000000000080 RSI: 000055e6370ec000 RDI:
0000000000000010
[ 2581.543589] RBP: 0000000000002300 R08: 000055e6370ec000 R09:
0000000000000884
[ 2581.543591] R10: 0000000000002300 R11: 0000000000000293 R12:
0000000000000080
[ 2581.543592] R13: 0000000040000000 R14: 000055e6351d8a00 R15:
000055e6370ec000
[ 2581.543596] INFO: task WTJourn.Flusher:1149 blocked for more than 120
seconds.
[ 2581.543642]       Tainted: P        W  O     4.15.7-1-ARCH #1
[ 2581.543677] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this
message.
[ 2581.543725] WTJourn.Flusher D    0  1149      1 0x00000000
[ 2581.543727] Call Trace:
[ 2581.543732]  ? __schedule+0x24b/0x8c0
[ 2581.543735]  ? preempt_count_add+0x68/0xa0
[ 2581.543738]  schedule+0x32/0x90
[ 2581.543766]  wait_ordered_extents.isra.3.constprop.7+0x337/0x3b0 [btrfs]
[ 2581.543771]  ? wait_woken+0x80/0x80
[ 2581.543799]  btrfs_log_changed_extents+0x256/0x610 [btrfs]
[ 2581.543829]  ? fill_inode_item.isra.2+0x22f/0x290 [btrfs]
[ 2581.543858]  btrfs_log_inode+0x9ba/0xf60 [btrfs]
[ 2581.543886]  ? btrfs_submit_bio_hook+0x8e/0x180 [btrfs]
[ 2581.543916]  btrfs_log_inode_parent+0x27f/0xa40 [btrfs]
[ 2581.543921]  ? preempt_count_add+0x68/0xa0
[ 2581.543923]  ? _raw_spin_lock+0x13/0x40
[ 2581.543925]  ? preempt_count_add+0x68/0xa0
[ 2581.543927]  ? _raw_spin_lock+0x13/0x40
[ 2581.543956]  btrfs_log_dentry_safe+0x58/0x80 [btrfs]
[ 2581.543984]  btrfs_sync_file+0x2eb/0x440 [btrfs]
[ 2581.543988]  do_fsync+0x38/0x60
[ 2581.543991]  SyS_fdatasync+0xf/0x20
[ 2581.543994]  do_syscall_64+0x74/0x190
[ 2581.543997]  entry_SYSCALL_64_after_hwframe+0x3d/0xa2
[ 2581.543999] RIP: 0033:0x7fa5ba08da7c
[ 2581.544001] RSP: 002b:00007fa5b32dc710 EFLAGS: 00000293 ORIG_RAX:
000000000000004b
[ 2581.544003] RAX: ffffffffffffffda RBX: 0000000000000010 RCX:
00007fa5ba08da7c
[ 2581.544005] RDX: 0000000000000000 RSI: 0000000000000010 RDI:
0000000000000010
[ 2581.544006] RBP: 000000000000000a R08: 0000000000000020 R09:
0000000000000010
[ 2581.544008] R10: 6769546465726957 R11: 0000000000000293 R12:
0000000000000001
[ 2581.544009] R13: 000055e6352ab2f0 R14: 000055e635208480 R15:
00007fa5bcc5b6a7
[ 2581.544027] INFO: task netdata:1301 blocked for more than 120 seconds.
[ 2581.544068]       Tainted: P        W  O     4.15.7-1-ARCH #1
[ 2581.544104] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this
message.
[ 2581.544151] netdata         D    0  1301      1 0x00000000
[ 2581.544154] Call Trace:
[ 2581.544158]  ? __schedule+0x24b/0x8c0
[ 2581.544162]  schedule+0x32/0x90
[ 2581.544165]  schedule_preempt_disabled+0x14/0x20
[ 2581.544168]  __mutex_lock.isra.0+0x274/0x520
[ 2581.544190]  ? btrfs_show_devname+0x28/0xf0 [btrfs]
[ 2581.544211]  btrfs_show_devname+0x28/0xf0 [btrfs]
[ 2581.544216]  show_mountinfo+0x1a2/0x290
[ 2581.544219]  seq_read+0x371/0x480
[ 2581.544224]  __vfs_read+0x36/0x170
[ 2581.544228]  vfs_read+0x91/0x130
[ 2581.544232]  SyS_read+0x52/0xc0
[ 2581.544235]  do_syscall_64+0x74/0x190
[ 2581.544238]  entry_SYSCALL_64_after_hwframe+0x3d/0xa2
[ 2581.544240] RIP: 0033:0x7fac0c978988
[ 2581.544242] RSP: 002b:00007fac0a564c90 EFLAGS: 00000246 ORIG_RAX:
0000000000000000
[ 2581.544244] RAX: ffffffffffffffda RBX: 000055dff2ac3ec0 RCX:
00007fac0c978988
[ 2581.544246] RDX: 0000000000000200 RSI: 000055dff2ac3ec0 RDI:
0000000000000027
[ 2581.544247] RBP: 0000000000000200 R08: 0000000000000000 R09:
00000000000040b0
[ 2581.544249] R10: 000055dff2062840 R11: 0000000000000246 R12:
000000005a9ffc5b
[ 2581.544250] R13: 00007fac0a565dd0 R14: 000055dff2aa6980 R15:
0000000000000001
[ 2665.927305] systemd[1]: systemd-journald.service: Processes still around
after SIGKILL. Ignoring.
[ 2704.426100] INFO: task btrfs-transacti:353 blocked for more than 120
seconds.
[ 2704.426175]       Tainted: P        W  O     4.15.7-1-ARCH #1
[ 2704.426228] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this
message.
[ 2704.426298] btrfs-transacti D    0   353      2 0x80000000
[ 2704.426304] Call Trace:
[ 2704.426318]  ? __schedule+0x24b/0x8c0
[ 2704.426323]  ? percpu_counter_add_batch+0x7e/0xb0
[ 2704.426329]  schedule+0x32/0x90
[ 2704.426335]  io_schedule+0x12/0x40
[ 2704.426342]  wait_on_page_bit+0xea/0x130
[ 2704.426348]  ? add_to_page_cache_lru+0xe0/0xe0
[ 2704.426353]  __filemap_fdatawait_range+0xbf/0x110
[ 2704.426360]  filemap_fdatawait_range+0xe/0x20
[ 2704.426411]  btrfs_wait_ordered_range+0x68/0x100 [btrfs]
[ 2704.426455]  __btrfs_wait_cache_io+0x42/0x1b0 [btrfs]
[ 2704.426490]  btrfs_start_dirty_block_groups+0x1a2/0x470 [btrfs]
[ 2704.426530]  btrfs_commit_transaction+0x117/0x930 [btrfs]
[ 2704.426568]  ? start_transaction+0x9e/0x420 [btrfs]
[ 2704.426605]  transaction_kthread+0x17b/0x1a0 [btrfs]
[ 2704.426643]  ? btrfs_cleanup_transaction+0x570/0x570 [btrfs]
[ 2704.426646]  kthread+0x113/0x130
[ 2704.426653]  ? kthread_create_on_node+0x70/0x70
[ 2704.426657]  ? do_syscall_64+0x74/0x190
[ 2704.426662]  ? SyS_exit_group+0x10/0x10
[ 2704.426666]  ret_from_fork+0x22/0x40
[ 2756.179973] systemd[1]: systemd-journald.service: State 'stop-final-sigterm'
timed out. Killing.
[ 2756.180023] systemd[1]: systemd-journald.service: Killing process 410
(systemd-journal) with signal SIGKILL.
[ 2846.432363] systemd[1]: systemd-journald.service: Processes still around
after final SIGKILL. Entering failed mode.
[ 2846.432373] systemd[1]: systemd-journald.service: Failed with result
'watchdog'.
[ 2846.432886] systemd[1]: systemd-journald.service: Service has no hold-off
time, scheduling restart.
[ 2846.433027] systemd[1]: systemd-journald.service: Scheduled restart job,
restart counter is at 2.
[ 2846.433355] systemd[1]: Stopped Flush Journal to Persistent Storage.
[ 2846.433373] systemd[1]: Stopping Flush Journal to Persistent Storage...
[ 2846.433513] systemd[1]: Stopped Journal Service.
[ 2846.433693] systemd[1]: systemd-journald.service: Found left-over process
410 (systemd-journal) in control group while starting unit. Ignoring.
[ 2846.433698] systemd[1]: This usually indicates unclean termination of a
previous run, or service implementation deficiencies.
[ 2846.434983] systemd[1]: Starting Journal Service...
[ 2936.684829] systemd[1]: systemd-journald.service: Start operation timed out.
Terminating.
[ 3026.937338] systemd[1]: systemd-journald.service: State 'stop-sigterm' timed
out. Killing.
[ 3026.937389] systemd[1]: systemd-journald.service: Killing process 7740
(systemd-journal) with signal SIGKILL.
[ 3026.937467] systemd[1]: systemd-journald.service: Killing process 410
(systemd-journal) with signal SIGKILL.
[ 3117.189653] systemd[1]: systemd-journald.service: Processes still around
after SIGKILL. Ignoring.
[ 3207.442117] systemd[1]: systemd-journald.service: State 'stop-final-sigterm'
timed out. Killing.
[ 3207.442168] systemd[1]: systemd-journald.service: Killing process 7740
(systemd-journal) with signal SIGKILL.
[ 3207.442243] systemd[1]: systemd-journald.service: Killing process 410
(systemd-journal) with signal SIGKILL.
[ 3297.694476] systemd[1]: systemd-journald.service: Processes still around
after final SIGKILL. Entering failed mode.
[ 3297.694486] systemd[1]: systemd-journald.service: Failed with result
'timeout'.
[ 3297.694767] systemd[1]: Failed to start Journal Service.
[ 3297.694867] systemd[1]: Dependency failed for Flush Journal to Persistent
Storage.
[ 3297.694910] systemd[1]: systemd-journal-flush.service: Job
systemd-journal-flush.service/start failed with result 'dependency'.
[ 3297.695487] systemd[1]: systemd-journald.service: Service has no hold-off
time, scheduling restart.
[ 3297.695550] systemd[1]: systemd-journald.service: Scheduled restart job,
restart counter is at 3.
[ 3297.695981] systemd[1]: Stopped Journal Service.
[ 3297.696113] systemd[1]: systemd-journald.service: Found left-over process
410 (systemd-journal) in control group while starting unit. Ignoring.
[ 3297.696117] systemd[1]: This usually indicates unclean termination of a
previous run, or service implementation deficiencies.
[ 3387.946813] systemd[1]: systemd-journald.service: Start operation timed out.
Terminating.
[ 3478.199155] systemd[1]: systemd-journald.service: State 'stop-sigterm' timed
out. Killing.
[ 3478.199208] systemd[1]: systemd-journald.service: Killing process 7773
(systemd-journal) with signal SIGKILL.
[ 3478.199289] systemd[1]: systemd-journald.service: Killing process 410
(systemd-journal) with signal SIGKILL.
[ 3478.199315] systemd[1]: systemd-journald.service: Killing process 7740
(systemd-journal) with signal SIGKILL.
[ 3568.451368] systemd[1]: systemd-journald.service: Processes still around
after SIGKILL. Ignoring.
[ 3658.703757] systemd[1]: systemd-journald.service: State 'stop-final-sigterm'
timed out. Killing.
[ 3658.703808] systemd[1]: systemd-journald.service: Killing process 7773
(systemd-journal) with signal SIGKILL.
[ 3658.703884] systemd[1]: systemd-journald.service: Killing process 410
(systemd-journal) with signal SIGKILL.
[ 3658.703912] systemd[1]: systemd-journald.service: Killing process 7740
(systemd-journal) with signal SIGKILL.
[ 3748.956054] systemd[1]: systemd-journald.service: Processes still around
after final SIGKILL. Entering failed mode.
[ 3748.956064] systemd[1]: systemd-journald.service: Failed with result
'timeout'.
[ 3748.956341] systemd[1]: Failed to start Journal Service.
[ 3748.957048] systemd[1]: systemd-journald.service: Service has no hold-off
time, scheduling restart.
[ 3748.957108] systemd[1]: systemd-journald.service: Scheduled restart job,
restart counter is at 4.
[ 3748.957516] systemd[1]: Stopped Journal Service.
[ 3748.957660] systemd[1]: systemd-journald.service: Found left-over process
410 (systemd-journal) in control group while starting unit. Ignoring.
[ 3748.957664] systemd[1]: This usually indicates unclean termination of a
previous run, or service implementation deficiencies.
[ 3748.957684] systemd[1]: systemd-journald.service: Found left-over process
7740 (systemd-journal) in control group while starting unit. Ignoring.
[ 3748.957687] systemd[1]: This usually indicates unclean termination of a
previous run, or service implementation deficiencies.
[ 3839.208349] systemd[1]: systemd-journald.service: Start operation timed out.
Terminating.
[ 3929.460618] systemd[1]: systemd-journald.service: State 'stop-sigterm' timed
out. Killing.
[ 3929.460670] systemd[1]: systemd-journald.service: Killing process 7793
(systemd-journal) with signal SIGKILL.
[ 3929.460752] systemd[1]: systemd-journald.service: Killing process 410
(systemd-journal) with signal SIGKILL.
[ 3929.460779] systemd[1]: systemd-journald.service: Killing process 7740
(systemd-journal) with signal SIGKILL.
[ 3929.460803] systemd[1]: systemd-journald.service: Killing process 7773
(systemd-journal) with signal SIGKILL.
[ 4019.712901] systemd[1]: systemd-journald.service: Processes still around
after SIGKILL. Ignoring.
[ 4109.965176] systemd[1]: systemd-journald.service: State 'stop-final-sigterm'
timed out. Killing.
[ 4109.965227] systemd[1]: systemd-journald.service: Killing process 7793
(systemd-journal) with signal SIGKILL.
[ 4109.965304] systemd[1]: systemd-journald.service: Killing process 410
(systemd-journal) with signal SIGKILL.
[ 4109.965331] systemd[1]: systemd-journald.service: Killing process 7740
(systemd-journal) with signal SIGKILL.
[ 4109.965356] systemd[1]: systemd-journald.service: Killing process 7773
(systemd-journal) with signal SIGKILL.
[ 4200.217351] systemd[1]: systemd-journald.service: Processes still around
after final SIGKILL. Entering failed mode.
[ 4200.217359] systemd[1]: systemd-journald.service: Failed with result
'timeout'.
[ 4200.217564] systemd[1]: Failed to start Journal Service.
[ 4200.218152] systemd[1]: systemd-journald.service: Service has no hold-off
time, scheduling restart.
[ 4200.218211] systemd[1]: systemd-journald.service: Scheduled restart job,
restart counter is at 5.
[ 4200.218618] systemd[1]: Stopped Journal Service.
[ 4200.218750] systemd[1]: systemd-journald.service: Found left-over process
410 (systemd-journal) in control group while starting unit. Ignoring.
[ 4200.218754] systemd[1]: This usually indicates unclean termination of a
previous run, or service implementation deficiencies.
[ 4200.218774] systemd[1]: systemd-journald.service: Found left-over process
7740 (systemd-journal) in control group while starting unit. Ignoring.
[ 4200.218777] systemd[1]: This usually indicates unclean termination of a
previous run, or service implementation deficiencies.
[ 4290.471350] systemd[1]: systemd-journald.service: Start operation timed out.
Terminating.
[ 4380.728501] systemd[1]: systemd-journald.service: State 'stop-sigterm' timed
out. Killing.
[ 4380.728553] systemd[1]: systemd-journald.service: Killing process 7841
(systemd-journal) with signal SIGKILL.
[ 4380.728636] systemd[1]: systemd-journald.service: Killing process 410
(systemd-journal) with signal SIGKILL.
[ 4380.728662] systemd[1]: systemd-journald.service: Killing process 7740
(systemd-journal) with signal SIGKILL.
[ 4380.728687] systemd[1]: systemd-journald.service: Killing process 7773
(systemd-journal) with signal SIGKILL.
[ 4380.728711] systemd[1]: systemd-journald.service: Killing process 7793
(systemd-journal) with signal SIGKILL.
[ 4470.985109] systemd[1]: systemd-journald.service: Processes still around
after SIGKILL. Ignoring.
[ 4561.241050] systemd[1]: systemd-journald.service: State 'stop-final-sigterm'
timed out. Killing.
[ 4561.241103] systemd[1]: systemd-journald.service: Killing process 7841
(systemd-journal) with signal SIGKILL.
[ 4561.241183] systemd[1]: systemd-journald.service: Killing process 410
(systemd-journal) with signal SIGKILL.
[ 4561.241209] systemd[1]: systemd-journald.service: Killing process 7740
(systemd-journal) with signal SIGKILL.
[ 4561.241234] systemd[1]: systemd-journald.service: Killing process 7773
(systemd-journal) with signal SIGKILL.
[ 4561.241258] systemd[1]: systemd-journald.service: Killing process 7793
(systemd-journal) with signal SIGKILL.
[ 4651.496495] systemd[1]: systemd-journald.service: Processes still around
after final SIGKILL. Entering failed mode.
[ 4651.496506] systemd[1]: systemd-journald.service: Failed with result
'timeout'.
[ 4651.496786] systemd[1]: Failed to start Journal Service.
[ 4651.497730] systemd[1]: systemd-journald.service: Service has no hold-off
time, scheduling restart.
[ 4651.497819] systemd[1]: systemd-journald.service: Scheduled restart job,
restart counter is at 6.
[ 4651.498567] systemd[1]: Stopped Journal Service.
[ 4651.498797] systemd[1]: systemd-journald.service: Found left-over process
410 (systemd-journal) in control group while starting unit. Ignoring.
[ 4651.498803] systemd[1]: This usually indicates unclean termination of a
previous run, or service implementation deficiencies.
[ 4651.498844] systemd[1]: systemd-journald.service: Found left-over process
7740 (systemd-journal) in control group while starting unit. Ignoring.
[ 4651.498850] systemd[1]: This usually indicates unclean termination of a
previous run, or service implementation deficiencies.
[ 4741.751516] systemd[1]: systemd-journald.service: Start operation timed out.
Terminating.
[ 4832.006159] systemd[1]: systemd-journald.service: State 'stop-sigterm' timed
out. Killing.
[ 4832.006211] systemd[1]: systemd-journald.service: Killing process 7867
(systemd-journal) with signal SIGKILL.
[ 4832.006295] systemd[1]: systemd-journald.service: Killing process 410
(systemd-journal) with signal SIGKILL.
[ 4832.006321] systemd[1]: systemd-journald.service: Killing process 7740
(systemd-journal) with signal SIGKILL.
[ 4832.006347] systemd[1]: systemd-journald.service: Killing process 7773
(systemd-journal) with signal SIGKILL.
[ 4832.006371] systemd[1]: systemd-journald.service: Killing process 7793
(systemd-journal) with signal SIGKILL.
[ 4832.006399] systemd[1]: systemd-journald.service: Killing process 7841
(systemd-journal) with signal SIGKILL.
[ 4922.260517] systemd[1]: systemd-journald.service: Processes still around
after SIGKILL. Ignoring.
[ 5012.514693] systemd[1]: systemd-journald.service: State 'stop-final-sigterm'
timed out. Killing.
[ 5012.514745] systemd[1]: systemd-journald.service: Killing process 7867
(systemd-journal) with signal SIGKILL.
[ 5012.514827] systemd[1]: systemd-journald.service: Killing process 410
(systemd-journal) with signal SIGKILL.
[ 5012.514853] systemd[1]: systemd-journald.service: Killing process 7740
(systemd-journal) with signal SIGKILL.
[ 5012.514878] systemd[1]: systemd-journald.service: Killing process 7773
(systemd-journal) with signal SIGKILL.
[ 5012.514901] systemd[1]: systemd-journald.service: Killing process 7793
(systemd-journal) with signal SIGKILL.
[ 5012.514929] systemd[1]: systemd-journald.service: Killing process 7841
(systemd-journal) with signal SIGKILL.
[ 5102.768688] systemd[1]: systemd-journald.service: Processes still around
after final SIGKILL. Entering failed mode.
[ 5102.768697] systemd[1]: systemd-journald.service: Failed with result
'timeout'.
[ 5102.768980] systemd[1]: Failed to start Journal Service.
[ 5102.769783] systemd[1]: systemd-journald.service: Service has no hold-off
time, scheduling restart.
[ 5102.769865] systemd[1]: systemd-journald.service: Scheduled restart job,
restart counter is at 7.
[ 5102.770505] systemd[1]: Stopped Journal Service.
[ 5102.770690] systemd[1]: systemd-journald.service: Found left-over process
410 (systemd-journal) in control group while starting unit. Ignoring.
[ 5102.770696] systemd[1]: This usually indicates unclean termination of a
previous run, or service implementation deficiencies.
[ 5102.770724] systemd[1]: systemd-journald.service: Found left-over process
7740 (systemd-journal) in control group while starting unit. Ignoring.
[ 5102.770729] systemd[1]: This usually indicates unclean termination of a
previous run, or service implementation deficiencies.
[ 5193.022451] systemd[1]: systemd-journald.service: Start operation timed out.
Terminating.
[ 5283.275997] systemd[1]: systemd-journald.service: State 'stop-sigterm' timed
out. Killing.
[ 5283.276050] systemd[1]: systemd-journald.service: Killing process 7894
(systemd-journal) with signal SIGKILL.
[ 5283.276135] systemd[1]: systemd-journald.service: Killing process 410
(systemd-journal) with signal SIGKILL.
[ 5283.276161] systemd[1]: systemd-journald.service: Killing process 7740
(systemd-journal) with signal SIGKILL.
[ 5283.276186] systemd[1]: systemd-journald.service: Killing process 7773
(systemd-journal) with signal SIGKILL.
[ 5283.276210] systemd[1]: systemd-journald.service: Killing process 7793
(systemd-journal) with signal SIGKILL.
[ 5283.276237] systemd[1]: systemd-journald.service: Killing process 7841
(systemd-journal) with signal SIGKILL.
[ 5283.276261] systemd[1]: systemd-journald.service: Killing process 7867
(systemd-journal) with signal SIGKILL.
[ 5373.529521] systemd[1]: systemd-journald.service: Processes still around
after SIGKILL. Ignoring.
[ 5463.782969] systemd[1]: systemd-journald.service: State 'stop-final-sigterm'
timed out. Killing.
[ 5463.783021] systemd[1]: systemd-journald.service: Killing process 7894
(systemd-journal) with signal SIGKILL.
[ 5463.783102] systemd[1]: systemd-journald.service: Killing process 410
(systemd-journal) with signal SIGKILL.
[ 5463.783128] systemd[1]: systemd-journald.service: Killing process 7740
(systemd-journal) with signal SIGKILL.
[ 5463.783154] systemd[1]: systemd-journald.service: Killing process 7773
(systemd-journal) with signal SIGKILL.
[ 5463.783178] systemd[1]: systemd-journald.service: Killing process 7793
(systemd-journal) with signal SIGKILL.
[ 5463.783205] systemd[1]: systemd-journald.service: Killing process 7841
(systemd-journal) with signal SIGKILL.
[ 5463.783230] systemd[1]: systemd-journald.service: Killing process 7867
(systemd-journal) with signal SIGKILL.
[ 5554.036287] systemd[1]: systemd-journald.service: Processes still around
after final SIGKILL. Entering failed mode.
[ 5554.036298] systemd[1]: systemd-journald.service: Failed with result
'timeout'.
[ 5554.036584] systemd[1]: Failed to start Journal Service.
[ 5554.037267] systemd[1]: systemd-journald.service: Service has no hold-off
time, scheduling restart.
[ 5554.037329] systemd[1]: systemd-journald.service: Scheduled restart job,
restart counter is at 8.
[ 5554.037739] systemd[1]: Stopped Journal Service.
[ 5554.037898] systemd[1]: systemd-journald.service: Found left-over process
410 (systemd-journal) in control group while starting unit. Ignoring.
[ 5554.037902] systemd[1]: This usually indicates unclean termination of a
previous run, or service implementation deficiencies.
[ 5554.037923] systemd[1]: systemd-journald.service: Found left-over process
7740 (systemd-journal) in control group while starting unit. Ignoring.
[ 5554.037926] systemd[1]: This usually indicates unclean termination of a
previous run, or service implementation deficiencies.
[ 5644.289537] systemd[1]: systemd-journald.service: Start operation timed out.
Terminating.
[ 5734.542720] systemd[1]: systemd-journald.service: State 'stop-sigterm' timed
out. Killing.
[ 5734.542771] systemd[1]: systemd-journald.service: Killing process 7915
(systemd-journal) with signal SIGKILL.
[ 5734.542856] systemd[1]: systemd-journald.service: Killing process 410
(systemd-journal) with signal SIGKILL.
[ 5734.542882] systemd[1]: systemd-journald.service: Killing process 7740
(systemd-journal) with signal SIGKILL.
[ 5734.542907] systemd[1]: systemd-journald.service: Killing process 7773
(systemd-journal) with signal SIGKILL.
[ 5734.542931] systemd[1]: systemd-journald.service: Killing process 7793
(systemd-journal) with signal SIGKILL.
[ 5734.542958] systemd[1]: systemd-journald.service: Killing process 7841
(systemd-journal) with signal SIGKILL.
[ 5734.542983] systemd[1]: systemd-journald.service: Killing process 7867
(systemd-journal) with signal SIGKILL.
[ 5734.543007] systemd[1]: systemd-journald.service: Killing process 7894
(systemd-journal) with signal SIGKILL.
[ 5824.795821] systemd[1]: systemd-journald.service: Processes still around
after SIGKILL. Ignoring.
[ 5915.048944] systemd[1]: systemd-journald.service: State 'stop-final-sigterm'
timed out. Killing.
[ 5915.048996] systemd[1]: systemd-journald.service: Killing process 7915
(systemd-journal) with signal SIGKILL.
[ 5915.049079] systemd[1]: systemd-journald.service: Killing process 410
(systemd-journal) with signal SIGKILL.
[ 5915.049105] systemd[1]: systemd-journald.service: Killing process 7740
(systemd-journal) with signal SIGKILL.
[ 5915.049130] systemd[1]: systemd-journald.service: Killing process 7773
(systemd-journal) with signal SIGKILL.
[ 5915.049155] systemd[1]: systemd-journald.service: Killing process 7793
(systemd-journal) with signal SIGKILL.
[ 5915.049182] systemd[1]: systemd-journald.service: Killing process 7841
(systemd-journal) with signal SIGKILL.
[ 5915.049206] systemd[1]: systemd-journald.service: Killing process 7867
(systemd-journal) with signal SIGKILL.
[ 5915.049230] systemd[1]: systemd-journald.service: Killing process 7894
(systemd-journal) with signal SIGKILL.
[ 6005.302033] systemd[1]: systemd-journald.service: Processes still around
after final SIGKILL. Entering failed mode.
[ 6005.302044] systemd[1]: systemd-journald.service: Failed with result
'timeout'.
[ 6005.302329] systemd[1]: Failed to start Journal Service.
[ 6005.303161] systemd[1]: systemd-journald.service: Service has no hold-off
time, scheduling restart.
[ 6005.303243] systemd[1]: systemd-journald.service: Scheduled restart job,
restart counter is at 9.
[ 6005.303854] systemd[1]: Stopped Journal Service.

-- 
You are receiving this mail because:
You are watching the assignee of the bug.

Powered by blists - more mailing lists