[ OK ] Started Update UTMP about System Runlevel Changes. Debian GNU/Linux 9 syzkaller ttyS0 syzkaller login: [ 29.906946] cc1 (6692) used greatest stack depth: 23392 bytes left [ 30.411106] IPVS: ftp: loaded support on port[0] = 21 [ 30.717347] tipc: TX() has been purged, node left! [ 62.461066] can: request_module (can-proto-0) failed. [ 62.471029] can: request_module (can-proto-0) failed. Warning: Permanently added '10.128.10.62' (ECDSA) to the list of known hosts. 2020/05/16 15:18:24 parsed 1 programs 2020/05/16 15:18:25 executed programs: 0 [ 72.791118] IPVS: ftp: loaded support on port[0] = 21 [ 72.872014] IPVS: ftp: loaded support on port[0] = 21 [ 72.889244] IPVS: ftp: loaded support on port[0] = 21 [ 72.981467] IPVS: ftp: loaded support on port[0] = 21 [ 73.009528] IPVS: ftp: loaded support on port[0] = 21 [ 73.009552] IPVS: ftp: loaded support on port[0] = 21 [ 73.915957] bridge0: port 1(bridge_slave_0) entered blocking state [ 73.943776] bridge0: port 1(bridge_slave_0) entered disabled state [ 73.959018] device bridge_slave_0 entered promiscuous mode [ 74.044659] bridge0: port 2(bridge_slave_1) entered blocking state [ 74.063534] bridge0: port 2(bridge_slave_1) entered disabled state [ 74.071169] device bridge_slave_1 entered promiscuous mode [ 74.176669] bridge0: port 1(bridge_slave_0) entered blocking state [ 74.186542] bridge0: port 1(bridge_slave_0) entered disabled state [ 74.197794] device bridge_slave_0 entered promiscuous mode [ 74.281457] bridge0: port 2(bridge_slave_1) entered blocking state [ 74.289499] bridge0: port 2(bridge_slave_1) entered disabled state [ 74.297729] device bridge_slave_1 entered promiscuous mode [ 74.305118] bridge0: port 1(bridge_slave_0) entered blocking state [ 74.313028] bridge0: port 1(bridge_slave_0) entered disabled state [ 74.320440] device bridge_slave_0 entered promiscuous mode [ 74.346293] bridge0: port 1(bridge_slave_0) entered blocking state [ 74.353671] bridge0: port 1(bridge_slave_0) entered disabled state [ 74.366124] device bridge_slave_0 entered promiscuous mode [ 74.373388] bridge0: port 1(bridge_slave_0) entered blocking state [ 74.381409] bridge0: port 1(bridge_slave_0) entered disabled state [ 74.388702] device bridge_slave_0 entered promiscuous mode [ 74.401756] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 74.423138] bridge0: port 2(bridge_slave_1) entered blocking state [ 74.431154] bridge0: port 2(bridge_slave_1) entered disabled state [ 74.444110] device bridge_slave_1 entered promiscuous mode [ 74.451909] bridge0: port 2(bridge_slave_1) entered blocking state [ 74.458440] bridge0: port 2(bridge_slave_1) entered disabled state [ 74.465494] device bridge_slave_1 entered promiscuous mode [ 74.473697] bridge0: port 2(bridge_slave_1) entered blocking state [ 74.481072] bridge0: port 2(bridge_slave_1) entered disabled state [ 74.491072] device bridge_slave_1 entered promiscuous mode [ 74.500669] bridge0: port 1(bridge_slave_0) entered blocking state [ 74.509362] bridge0: port 1(bridge_slave_0) entered disabled state [ 74.517581] device bridge_slave_0 entered promiscuous mode [ 74.534855] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 74.614697] bridge0: port 2(bridge_slave_1) entered blocking state [ 74.625741] bridge0: port 2(bridge_slave_1) entered disabled state [ 74.638073] device bridge_slave_1 entered promiscuous mode [ 74.648128] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 74.674438] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_bond: link becomes ready [ 74.728814] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 74.747085] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 74.775512] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 74.797308] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 74.809581] team0: Port device team_slave_0 added [ 74.822527] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_bond: link becomes ready [ 74.839938] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 74.859601] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 74.875249] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_bond: link becomes ready [ 74.896214] team0: Port device team_slave_1 added [ 74.909231] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_bond: link becomes ready [ 74.931667] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 74.979824] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready [ 75.000214] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 75.033381] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready [ 75.061107] team0: Port device team_slave_0 added [ 75.073105] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 75.111508] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 75.128212] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_bridge: link becomes ready [ 75.151435] team0: Port device team_slave_0 added [ 75.159673] team0: Port device team_slave_1 added [ 75.171071] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 75.184158] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_bridge: link becomes ready [ 75.224575] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready [ 75.248613] team0: Port device team_slave_1 added [ 75.264024] team0: Port device team_slave_0 added [ 75.285353] team0: Port device team_slave_0 added [ 75.305885] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready [ 75.331609] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready [ 75.342577] team0: Port device team_slave_1 added [ 75.353408] team0: Port device team_slave_1 added [ 75.369254] ip (8078) used greatest stack depth: 22928 bytes left [ 75.371180] team0: Port device team_slave_0 added [ 75.387651] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 75.395835] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_bridge: link becomes ready [ 75.414503] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready [ 75.433688] team0: Port device team_slave_1 added [ 75.455973] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 75.467042] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_bridge: link becomes ready [ 75.480017] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready [ 75.488193] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready [ 75.499994] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 75.509540] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_bridge: link becomes ready [ 75.530201] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready [ 75.560459] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready [ 75.569155] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready [ 75.579419] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 75.590610] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_bridge: link becomes ready [ 75.603012] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 75.614654] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_bridge: link becomes ready [ 75.629819] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 75.638290] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_bridge: link becomes ready [ 75.650547] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready [ 75.672487] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 75.695592] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_bridge: link becomes ready [ 75.707235] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 75.715001] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_bridge: link becomes ready [ 75.736104] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 75.744864] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_bridge: link becomes ready [ 75.771381] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 75.798695] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_bridge: link becomes ready [ 75.869295] bridge0: port 2(bridge_slave_1) entered blocking state [ 75.875767] bridge0: port 2(bridge_slave_1) entered forwarding state [ 75.882973] bridge0: port 1(bridge_slave_0) entered blocking state [ 75.889354] bridge0: port 1(bridge_slave_0) entered forwarding state [ 76.155047] bridge0: port 2(bridge_slave_1) entered blocking state [ 76.162730] bridge0: port 2(bridge_slave_1) entered forwarding state [ 76.170049] bridge0: port 1(bridge_slave_0) entered blocking state [ 76.177609] bridge0: port 1(bridge_slave_0) entered forwarding state [ 76.260546] bridge0: port 2(bridge_slave_1) entered blocking state [ 76.266984] bridge0: port 2(bridge_slave_1) entered forwarding state [ 76.273793] bridge0: port 1(bridge_slave_0) entered blocking state [ 76.280241] bridge0: port 1(bridge_slave_0) entered forwarding state [ 76.308070] bridge0: port 2(bridge_slave_1) entered blocking state [ 76.314648] bridge0: port 2(bridge_slave_1) entered forwarding state [ 76.321390] bridge0: port 1(bridge_slave_0) entered blocking state [ 76.327972] bridge0: port 1(bridge_slave_0) entered forwarding state [ 76.337953] bridge0: port 2(bridge_slave_1) entered blocking state [ 76.344343] bridge0: port 2(bridge_slave_1) entered forwarding state [ 76.351076] bridge0: port 1(bridge_slave_0) entered blocking state [ 76.357580] bridge0: port 1(bridge_slave_0) entered forwarding state [ 76.367031] bridge0: port 2(bridge_slave_1) entered blocking state [ 76.375338] bridge0: port 2(bridge_slave_1) entered forwarding state [ 76.382570] bridge0: port 1(bridge_slave_0) entered blocking state [ 76.389017] bridge0: port 1(bridge_slave_0) entered forwarding state [ 76.676651] IPv6: ADDRCONF(NETDEV_CHANGE): bridge0: link becomes ready [ 76.684257] IPv6: ADDRCONF(NETDEV_CHANGE): bridge0: link becomes ready [ 76.702233] IPv6: ADDRCONF(NETDEV_CHANGE): bridge0: link becomes ready [ 76.710846] IPv6: ADDRCONF(NETDEV_CHANGE): bridge0: link becomes ready [ 76.718753] IPv6: ADDRCONF(NETDEV_CHANGE): bridge0: link becomes ready [ 76.726078] IPv6: ADDRCONF(NETDEV_CHANGE): bridge0: link becomes ready [ 77.606834] ip (8604) used greatest stack depth: 22768 bytes left [ 77.858794] 8021q: adding VLAN 0 to HW filter on device bond0 [ 78.167882] 8021q: adding VLAN 0 to HW filter on device bond0 [ 78.193306] IPv6: ADDRCONF(NETDEV_CHANGE): veth1: link becomes ready [ 78.203787] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 78.280177] 8021q: adding VLAN 0 to HW filter on device bond0 [ 78.298806] 8021q: adding VLAN 0 to HW filter on device bond0 [ 78.338695] 8021q: adding VLAN 0 to HW filter on device bond0 [ 78.353351] 8021q: adding VLAN 0 to HW filter on device team0 [ 78.396064] 8021q: adding VLAN 0 to HW filter on device bond0 [ 78.519619] IPv6: ADDRCONF(NETDEV_CHANGE): veth1: link becomes ready [ 78.532383] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 78.624919] IPv6: ADDRCONF(NETDEV_CHANGE): veth1: link becomes ready [ 78.637327] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 78.679798] 8021q: adding VLAN 0 to HW filter on device team0 [ 78.704616] IPv6: ADDRCONF(NETDEV_CHANGE): veth1: link becomes ready [ 78.713764] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 78.739704] IPv6: ADDRCONF(NETDEV_CHANGE): veth1: link becomes ready [ 78.752958] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 78.793576] IPv6: ADDRCONF(NETDEV_CHANGE): veth1: link becomes ready [ 78.804375] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 78.824537] 8021q: adding VLAN 0 to HW filter on device team0 [ 78.906525] 8021q: adding VLAN 0 to HW filter on device team0 [ 78.914962] 8021q: adding VLAN 0 to HW filter on device team0 [ 78.997198] 8021q: adding VLAN 0 to HW filter on device team0 [ 79.620093] TCP: request_sock_TCPv6: Possible SYN flooding on port 20002. Sending cookies. Check SNMP counters. [ 79.799470] TCP: request_sock_TCPv6: Possible SYN flooding on port 20002. Sending cookies. Check SNMP counters. [ 79.905968] TCP: request_sock_TCPv6: Possible SYN flooding on port 20002. Sending cookies. Check SNMP counters. [ 80.068978] TCP: request_sock_TCPv6: Possible SYN flooding on port 20002. Sending cookies. Check SNMP counters. [ 80.112911] TCP: request_sock_TCPv6: Possible SYN flooding on port 20002. Sending cookies. Check SNMP counters. [ 80.213862] TCP: request_sock_TCPv6: Possible SYN flooding on port 20002. Sending cookies. Check SNMP counters. 2020/05/16 15:18:33 executed programs: 6 [ 80.469712] TCP: request_sock_TCPv6: Possible SYN flooding on port 20002. Sending cookies. Check SNMP counters. [ 227.455742] INFO: task syz-executor2:9196 blocked for more than 143 seconds. [ 227.463196] Not tainted 5.7.0-rc5-syzkaller #0 [ 227.468865] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 227.476933] syz-executor2 D28136 9196 6830 0x00000004 [ 227.482829] Call Trace: [ 227.485593] __schedule+0x85b/0x1960 [ 227.489423] ? __sched_text_start+0x8/0x8 [ 227.493561] schedule+0xc3/0x2b0 [ 227.496998] schedule_timeout+0x47a/0x710 [ 227.501159] ? __kasan_check_read+0x11/0x20 [ 227.505460] ? mark_lock+0xbf/0x630 [ 227.509175] ? usleep_range+0x130/0x130 [ 227.513217] ? mark_held_locks+0xb8/0x130 [ 227.517428] ? do_raw_spin_lock+0x132/0x2e0 [ 227.521748] ? _raw_spin_unlock_irq+0x22/0x80 [ 227.526310] ? wait_for_completion+0x169/0x280 [ 227.530892] ? lockdep_hardirqs_on+0x481/0x620 [ 227.535456] ? _raw_spin_unlock_irq+0x22/0x80 [ 227.540065] ? trace_hardirqs_on+0x28/0x1b0 [ 227.544387] wait_for_completion+0x171/0x280 [ 227.548848] ? wait_for_completion_interruptible+0x320/0x320 [ 227.554734] ? lockdep_hardirqs_on+0x481/0x620 [ 227.559394] ? __kasan_check_read+0x11/0x20 [ 227.563709] __flush_work+0x3f7/0x8c0 [ 227.567564] ? __kasan_check_read+0x11/0x20 [ 227.571888] ? max_active_store+0x100/0x100 [ 227.576270] ? __kasan_check_read+0x11/0x20 [ 227.580588] ? init_pwq+0x330/0x330 [ 227.584229] ? lockdep_hardirqs_on+0x481/0x620 [ 227.588879] ? __cancel_work_timer+0x159/0x440 [ 227.594178] ? trace_hardirqs_on+0x28/0x1b0 [ 227.598590] __cancel_work_timer+0x308/0x440 [ 227.603008] ? mod_delayed_work_on+0x1a0/0x1a0 [ 227.607657] ? mark_held_locks+0x130/0x130 [ 227.615961] ? __kasan_check_read+0x11/0x20 [ 227.620365] ? mark_lock+0xbf/0x630 [ 227.624042] ? lock_acquire+0x209/0x9e0 [ 227.628087] ? __sock_release+0x7d/0x280 [ 227.632153] cancel_delayed_work_sync+0xe/0x10 [ 227.636894] tls_sw_cancel_work_tx+0x63/0x70 [ 227.641299] tls_sk_proto_close+0x400/0x9a0 [ 227.645688] ? wait_on_pending_writer+0x3b0/0x3b0 [ 227.650539] ? __kasan_check_write+0x14/0x20 [ 227.654939] ? down_write+0xdc/0x150 [ 227.658747] inet_release+0xc6/0x1c0 [ 227.662478] inet6_release+0x46/0x60 [ 227.666256] __sock_release+0xc7/0x280 [ 227.670171] sock_close+0x13/0x20 [ 227.673652] __fput+0x2aa/0x790 [ 227.677001] ____fput+0x9/0x10 [ 227.680205] task_work_run+0xd4/0x170 [ 227.683986] exit_to_usermode_loop+0x1be/0x210 [ 227.688633] do_syscall_64+0x53d/0x630 [ 227.692526] entry_SYSCALL_64_after_hwframe+0x49/0xb3 [ 227.697810] RIP: 0033:0x411211 [ 227.701018] Code: Bad RIP value. [ 227.704373] RSP: 002b:00007fffc4366f10 EFLAGS: 00000293 ORIG_RAX: 0000000000000003 [ 227.712131] RAX: 0000000000000000 RBX: 0000000000000005 RCX: 0000000000411211 [ 227.719490] RDX: 0000000000000000 RSI: 0000000000740b80 RDI: 0000000000000004 [ 227.726815] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 227.734095] R10: 00007fffc4366e40 R11: 0000000000000293 R12: 0000000000000000 [ 227.741450] R13: 0000000000000001 R14: 0000000000000000 R15: 0000000000000002 [ 227.748844] INFO: task syz-executor5:9212 blocked for more than 143 seconds. [ 227.756088] Not tainted 5.7.0-rc5-syzkaller #0 [ 227.761205] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 227.769226] syz-executor5 D28136 9212 6840 0x00000004 [ 227.774852] Call Trace: [ 227.777593] __schedule+0x85b/0x1960 [ 227.781320] ? __sched_text_start+0x8/0x8 [ 227.785542] schedule+0xc3/0x2b0 [ 227.788922] schedule_timeout+0x47a/0x710 [ 227.793046] ? __kasan_check_read+0x11/0x20 [ 227.797439] ? mark_lock+0xbf/0x630 [ 227.801074] ? usleep_range+0x130/0x130 [ 227.805027] ? mark_held_locks+0xb8/0x130 [ 227.809226] ? do_raw_spin_lock+0x132/0x2e0 [ 227.813551] ? _raw_spin_unlock_irq+0x22/0x80 [ 227.818197] ? wait_for_completion+0x169/0x280 [ 227.822773] ? lockdep_hardirqs_on+0x481/0x620 [ 227.827397] ? _raw_spin_unlock_irq+0x22/0x80 [ 227.831886] ? trace_hardirqs_on+0x28/0x1b0 [ 227.836281] wait_for_completion+0x171/0x280 [ 227.840693] ? wait_for_completion_interruptible+0x320/0x320 [ 227.846626] ? lockdep_hardirqs_on+0x481/0x620 [ 227.851207] ? __kasan_check_read+0x11/0x20 [ 227.855604] __flush_work+0x3f7/0x8c0 [ 227.859396] ? __kasan_check_read+0x11/0x20 [ 227.863763] ? max_active_store+0x100/0x100 [ 227.868134] ? __kasan_check_read+0x11/0x20 [ 227.872471] ? init_pwq+0x330/0x330 [ 227.876173] ? lockdep_hardirqs_on+0x481/0x620 [ 227.880771] ? __cancel_work_timer+0x159/0x440 [ 227.885929] ? trace_hardirqs_on+0x28/0x1b0 [ 227.890260] __cancel_work_timer+0x308/0x440 [ 227.894832] ? mod_delayed_work_on+0x1a0/0x1a0 [ 227.899548] ? mark_held_locks+0x130/0x130 [ 227.903785] ? __kasan_check_read+0x11/0x20 [ 227.908289] ? mark_lock+0xbf/0x630 [ 227.911956] ? lock_acquire+0x209/0x9e0 [ 227.916039] ? __sock_release+0x7d/0x280 [ 227.920106] cancel_delayed_work_sync+0xe/0x10 [ 227.924674] tls_sw_cancel_work_tx+0x63/0x70 [ 227.929144] tls_sk_proto_close+0x400/0x9a0 [ 227.933465] ? wait_on_pending_writer+0x3b0/0x3b0 [ 227.938431] ? __kasan_check_write+0x14/0x20 [ 227.942857] ? down_write+0xdc/0x150 [ 227.946630] inet_release+0xc6/0x1c0 [ 227.951190] inet6_release+0x46/0x60 [ 227.954891] __sock_release+0xc7/0x280 [ 227.958860] sock_close+0x13/0x20 [ 227.962308] __fput+0x2aa/0x790 [ 227.965645] ____fput+0x9/0x10 [ 227.968851] task_work_run+0xd4/0x170 [ 227.972641] exit_to_usermode_loop+0x1be/0x210 [ 227.977875] do_syscall_64+0x53d/0x630 [ 227.981782] entry_SYSCALL_64_after_hwframe+0x49/0xb3 [ 227.987020] RIP: 0033:0x411211 [ 227.990218] Code: Bad RIP value. [ 227.993557] RSP: 002b:00007fff1869c320 EFLAGS: 00000293 ORIG_RAX: 0000000000000003 [ 228.001926] RAX: 0000000000000000 RBX: 0000000000000005 RCX: 0000000000411211 [ 228.009273] RDX: 0000000000000000 RSI: 0000000000740b80 RDI: 0000000000000004 [ 228.016615] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 228.023877] R10: 00007fff1869c250 R11: 0000000000000293 R12: 0000000000000000 [ 228.031276] R13: 0000000000000001 R14: 0000000000000000 R15: 0000000000000005 [ 228.038697] INFO: task syz-executor3:9238 blocked for more than 143 seconds. [ 228.045965] Not tainted 5.7.0-rc5-syzkaller #0 [ 228.051057] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 228.059090] syz-executor3 D28136 9238 6818 0x00000004 [ 228.064721] Call Trace: [ 228.067386] __schedule+0x85b/0x1960 [ 228.071099] ? __sched_text_start+0x8/0x8 [ 228.075231] schedule+0xc3/0x2b0 [ 228.078673] schedule_timeout+0x47a/0x710 [ 228.082813] ? __kasan_check_read+0x11/0x20 [ 228.087190] ? mark_lock+0xbf/0x630 [ 228.090829] ? usleep_range+0x130/0x130 [ 228.094782] ? mark_held_locks+0xb8/0x130 [ 228.099005] ? do_raw_spin_lock+0x132/0x2e0 [ 228.103335] ? _raw_spin_unlock_irq+0x22/0x80 [ 228.108103] ? wait_for_completion+0x169/0x280 [ 228.112872] ? lockdep_hardirqs_on+0x481/0x620 [ 228.117539] ? _raw_spin_unlock_irq+0x22/0x80 [ 228.122120] ? trace_hardirqs_on+0x28/0x1b0 [ 228.126519] wait_for_completion+0x171/0x280 [ 228.130946] ? wait_for_completion_interruptible+0x320/0x320 [ 228.136832] ? lockdep_hardirqs_on+0x481/0x620 [ 228.141417] ? __kasan_check_read+0x11/0x20 [ 228.145796] __flush_work+0x3f7/0x8c0 [ 228.149607] ? __kasan_check_read+0x11/0x20 [ 228.153926] ? max_active_store+0x100/0x100 [ 228.158318] ? __kasan_check_read+0x11/0x20 [ 228.162632] ? init_pwq+0x330/0x330 [ 228.166336] ? lockdep_hardirqs_on+0x481/0x620 [ 228.170939] ? __cancel_work_timer+0x159/0x440 [ 228.175594] ? trace_hardirqs_on+0x28/0x1b0 [ 228.179937] __cancel_work_timer+0x308/0x440 [ 228.184340] ? mod_delayed_work_on+0x1a0/0x1a0 [ 228.188974] ? mark_held_locks+0x130/0x130 [ 228.193216] ? __kasan_check_read+0x11/0x20 [ 228.197609] ? mark_lock+0xbf/0x630 [ 228.201264] ? lock_acquire+0x209/0x9e0 [ 228.205217] ? __sock_release+0x7d/0x280 [ 228.209434] cancel_delayed_work_sync+0xe/0x10 [ 228.214022] tls_sw_cancel_work_tx+0x63/0x70 [ 228.218513] tls_sk_proto_close+0x400/0x9a0 [ 228.222939] ? wait_on_pending_writer+0x3b0/0x3b0 [ 228.227841] ? __kasan_check_write+0x14/0x20 [ 228.232252] ? down_write+0xdc/0x150 [ 228.236044] inet_release+0xc6/0x1c0 [ 228.240284] inet6_release+0x46/0x60 [ 228.243981] __sock_release+0xc7/0x280 [ 228.247926] sock_close+0x13/0x20 [ 228.251377] __fput+0x2aa/0x790 [ 228.254638] ____fput+0x9/0x10 [ 228.257894] task_work_run+0xd4/0x170 [ 228.261693] exit_to_usermode_loop+0x1be/0x210 [ 228.266441] do_syscall_64+0x53d/0x630 [ 228.270357] entry_SYSCALL_64_after_hwframe+0x49/0xb3 [ 228.275618] RIP: 0033:0x411211 [ 228.278816] Code: Bad RIP value. [ 228.282610] RSP: 002b:00007ffd37f1a7c0 EFLAGS: 00000293 ORIG_RAX: 0000000000000003 [ 228.290401] RAX: 0000000000000000 RBX: 0000000000000005 RCX: 0000000000411211 [ 228.297874] RDX: 0000000000000000 RSI: 0000000000740b80 RDI: 0000000000000004 [ 228.305165] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 228.312540] R10: 00007ffd37f1a6f0 R11: 0000000000000293 R12: 0000000000000000 [ 228.319909] R13: 0000000000000001 R14: 0000000000000000 R15: 0000000000000003 [ 228.327836] INFO: task syz-executor4:9243 blocked for more than 144 seconds. [ 228.335024] Not tainted 5.7.0-rc5-syzkaller #0 [ 228.340251] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 228.348291] syz-executor4 D28136 9243 6835 0x00000004 [ 228.354004] Call Trace: [ 228.356655] __schedule+0x85b/0x1960 [ 228.360384] ? __sched_text_start+0x8/0x8 [ 228.364515] schedule+0xc3/0x2b0 [ 228.367956] schedule_timeout+0x47a/0x710 [ 228.372099] ? __kasan_check_read+0x11/0x20 [ 228.376488] ? mark_lock+0xbf/0x630 [ 228.380125] ? usleep_range+0x130/0x130 [ 228.384078] ? mark_held_locks+0xb8/0x130 [ 228.388337] ? do_raw_spin_lock+0x132/0x2e0 [ 228.392692] ? _raw_spin_unlock_irq+0x22/0x80 [ 228.397288] ? wait_for_completion+0x169/0x280 [ 228.401872] ? lockdep_hardirqs_on+0x481/0x620 [ 228.406526] ? _raw_spin_unlock_irq+0x22/0x80 [ 228.411196] ? trace_hardirqs_on+0x28/0x1b0 [ 228.415609] wait_for_completion+0x171/0x280 [ 228.420023] ? wait_for_completion_interruptible+0x320/0x320 [ 228.426007] ? lockdep_hardirqs_on+0x481/0x620 [ 228.430825] ? __kasan_check_read+0x11/0x20 [ 228.435169] __flush_work+0x3f7/0x8c0 [ 228.439064] ? __kasan_check_read+0x11/0x20 [ 228.443504] ? max_active_store+0x100/0x100 [ 228.447916] ? __kasan_check_read+0x11/0x20 [ 228.452238] ? init_pwq+0x330/0x330 [ 228.455967] ? lockdep_hardirqs_on+0x481/0x620 [ 228.460546] ? __cancel_work_timer+0x159/0x440 [ 228.465212] ? trace_hardirqs_on+0x28/0x1b0 [ 228.469642] __cancel_work_timer+0x308/0x440 [ 228.474060] ? mod_delayed_work_on+0x1a0/0x1a0 [ 228.478744] ? mark_held_locks+0x130/0x130 [ 228.483397] ? __kasan_check_read+0x11/0x20 [ 228.487821] ? mark_lock+0xbf/0x630 [ 228.491471] ? lock_acquire+0x209/0x9e0 [ 228.495581] ? __sock_release+0x7d/0x280 [ 228.499781] cancel_delayed_work_sync+0xe/0x10 [ 228.504367] tls_sw_cancel_work_tx+0x63/0x70 [ 228.508955] tls_sk_proto_close+0x400/0x9a0 [ 228.513532] ? wait_on_pending_writer+0x3b0/0x3b0 [ 228.518587] ? __kasan_check_write+0x14/0x20 [ 228.523000] ? down_write+0xdc/0x150 [ 228.526779] inet_release+0xc6/0x1c0 [ 228.530491] inet6_release+0x46/0x60 [ 228.534185] __sock_release+0xc7/0x280 [ 228.538152] sock_close+0x13/0x20 [ 228.541603] __fput+0x2aa/0x790 [ 228.544864] ____fput+0x9/0x10 [ 228.548126] task_work_run+0xd4/0x170 [ 228.551936] exit_to_usermode_loop+0x1be/0x210 [ 228.556606] do_syscall_64+0x53d/0x630 [ 228.560509] entry_SYSCALL_64_after_hwframe+0x49/0xb3 [ 228.565749] RIP: 0033:0x411211 [ 228.568943] Code: Bad RIP value. [ 228.572287] RSP: 002b:00007fffbace64b0 EFLAGS: 00000293 ORIG_RAX: 0000000000000003 [ 228.580085] RAX: 0000000000000000 RBX: 0000000000000005 RCX: 0000000000411211 [ 228.587434] RDX: 0000000000000000 RSI: 0000000000740b80 RDI: 0000000000000004 [ 228.594700] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 228.602067] R10: 00007fffbace63e0 R11: 0000000000000293 R12: 0000000000000000 [ 228.609420] R13: 0000000000000001 R14: 0000000000000000 R15: 0000000000000004 [ 228.616835] INFO: task syz-executor1:9250 blocked for more than 144 seconds. [ 228.624028] Not tainted 5.7.0-rc5-syzkaller #0 [ 228.630695] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 228.638753] syz-executor1 D28136 9250 6829 0x00000004 [ 228.644390] Call Trace: [ 228.647024] __schedule+0x85b/0x1960 [ 228.650767] ? __sched_text_start+0x8/0x8 [ 228.654916] schedule+0xc3/0x2b0 [ 228.658365] schedule_timeout+0x47a/0x710 [ 228.662866] ? __kasan_check_read+0x11/0x20 [ 228.667270] ? mark_lock+0xbf/0x630 [ 228.670901] ? usleep_range+0x130/0x130 [ 228.674872] ? mark_held_locks+0xb8/0x130 [ 228.679089] ? do_raw_spin_lock+0x132/0x2e0 [ 228.683416] ? _raw_spin_unlock_irq+0x22/0x80 [ 228.688013] ? wait_for_completion+0x169/0x280 [ 228.692600] ? lockdep_hardirqs_on+0x481/0x620 [ 228.697402] ? _raw_spin_unlock_irq+0x22/0x80 [ 228.701907] ? trace_hardirqs_on+0x28/0x1b0 [ 228.706311] wait_for_completion+0x171/0x280 [ 228.710826] ? wait_for_completion_interruptible+0x320/0x320 [ 228.716712] ? lockdep_hardirqs_on+0x481/0x620 [ 228.721296] ? __kasan_check_read+0x11/0x20 [ 228.725695] __flush_work+0x3f7/0x8c0 [ 228.729493] ? __kasan_check_read+0x11/0x20 [ 228.733866] ? max_active_store+0x100/0x100 [ 228.739106] ? __kasan_check_read+0x11/0x20 [ 228.743465] ? init_pwq+0x330/0x330 [ 228.747201] ? lockdep_hardirqs_on+0x481/0x620 [ 228.751816] ? __cancel_work_timer+0x159/0x440 [ 228.756476] ? trace_hardirqs_on+0x28/0x1b0 [ 228.760800] __cancel_work_timer+0x308/0x440 [ 228.765214] ? mod_delayed_work_on+0x1a0/0x1a0 [ 228.769861] ? mark_held_locks+0x130/0x130 [ 228.774124] ? __kasan_check_read+0x11/0x20 [ 228.778533] ? mark_lock+0xbf/0x630 [ 228.782183] ? lock_acquire+0x209/0x9e0 [ 228.786227] ? __sock_release+0x7d/0x280 [ 228.790309] cancel_delayed_work_sync+0xe/0x10 [ 228.794873] tls_sw_cancel_work_tx+0x63/0x70 [ 228.799351] tls_sk_proto_close+0x400/0x9a0 [ 228.803895] ? wait_on_pending_writer+0x3b0/0x3b0 [ 228.808875] ? __kasan_check_write+0x14/0x20 [ 228.813307] ? down_write+0xdc/0x150 [ 228.817153] inet_release+0xc6/0x1c0 [ 228.820918] inet6_release+0x46/0x60 [ 228.824622] __sock_release+0xc7/0x280 [ 228.828629] sock_close+0x13/0x20 [ 228.832113] __fput+0x2aa/0x790 [ 228.835490] ____fput+0x9/0x10 [ 228.838784] task_work_run+0xd4/0x170 [ 228.842589] exit_to_usermode_loop+0x1be/0x210 [ 228.847238] do_syscall_64+0x53d/0x630 [ 228.851153] entry_SYSCALL_64_after_hwframe+0x49/0xb3 [ 228.856493] RIP: 0033:0x411211 [ 228.859700] Code: Bad RIP value. [ 228.863145] RSP: 002b:00007ffc4cf0efc0 EFLAGS: 00000293 ORIG_RAX: 0000000000000003 [ 228.870922] RAX: 0000000000000000 RBX: 0000000000000005 RCX: 0000000000411211 [ 228.878320] RDX: 0000000000000000 RSI: 0000000000740b80 RDI: 0000000000000004 [ 228.885673] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 228.892946] R10: 00007ffc4cf0eef0 R11: 0000000000000293 R12: 0000000000000000 [ 228.900290] R13: 0000000000000001 R14: 0000000000000000 R15: 0000000000000001 [ 228.907800] INFO: task syz-executor0:9260 blocked for more than 144 seconds. [ 228.914979] Not tainted 5.7.0-rc5-syzkaller #0 [ 228.920203] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 228.928257] syz-executor0 D28136 9260 6819 0x00000004 [ 228.933886] Call Trace: [ 228.936559] __schedule+0x85b/0x1960 [ 228.940457] ? __sched_text_start+0x8/0x8 [ 228.944612] schedule+0xc3/0x2b0 [ 228.948051] schedule_timeout+0x47a/0x710 [ 228.952215] ? __kasan_check_read+0x11/0x20 [ 228.956728] ? mark_lock+0xbf/0x630 [ 228.960369] ? usleep_range+0x130/0x130 [ 228.964329] ? mark_held_locks+0xb8/0x130 [ 228.968540] ? do_raw_spin_lock+0x132/0x2e0 [ 228.972881] ? _raw_spin_unlock_irq+0x22/0x80 [ 228.977517] ? wait_for_completion+0x169/0x280 [ 228.982102] ? lockdep_hardirqs_on+0x481/0x620 [ 228.986751] ? _raw_spin_unlock_irq+0x22/0x80 [ 228.991244] ? trace_hardirqs_on+0x28/0x1b0 [ 228.995659] wait_for_completion+0x171/0x280 [ 229.000510] ? wait_for_completion_interruptible+0x320/0x320 [ 229.006378] ? lockdep_hardirqs_on+0x481/0x620 [ 229.010975] ? __kasan_check_read+0x11/0x20 [ 229.015452] __flush_work+0x3f7/0x8c0 [ 229.019264] ? __kasan_check_read+0x11/0x20 [ 229.023847] ? max_active_store+0x100/0x100 [ 229.028409] ? __kasan_check_read+0x11/0x20 [ 229.033058] ? init_pwq+0x330/0x330 [ 229.036878] ? lockdep_hardirqs_on+0x481/0x620 [ 229.041884] ? __cancel_work_timer+0x159/0x440 [ 229.047007] ? trace_hardirqs_on+0x28/0x1b0 [ 229.051982] __cancel_work_timer+0x308/0x440 [ 229.056578] ? mod_delayed_work_on+0x1a0/0x1a0 [ 229.061749] ? mark_held_locks+0x130/0x130 [ 229.066298] ? __kasan_check_read+0x11/0x20 [ 229.070644] ? mark_lock+0xbf/0x630 [ 229.074278] ? lock_acquire+0x209/0x9e0 [ 229.078344] ? __sock_release+0x7d/0x280 [ 229.082582] cancel_delayed_work_sync+0xe/0x10 [ 229.087592] tls_sw_cancel_work_tx+0x63/0x70 [ 229.092175] tls_sk_proto_close+0x400/0x9a0 [ 229.096771] ? wait_on_pending_writer+0x3b0/0x3b0 [ 229.101717] ? __kasan_check_write+0x14/0x20 [ 229.106367] ? down_write+0xdc/0x150 [ 229.110110] inet_release+0xc6/0x1c0 [ 229.113852] inet6_release+0x46/0x60 [ 229.117657] __sock_release+0xc7/0x280 [ 229.121563] sock_close+0x13/0x20 [ 229.125189] __fput+0x2aa/0x790 [ 229.128559] ____fput+0x9/0x10 [ 229.131837] task_work_run+0xd4/0x170 [ 229.135737] exit_to_usermode_loop+0x1be/0x210 [ 229.140330] do_syscall_64+0x53d/0x630 [ 229.144220] entry_SYSCALL_64_after_hwframe+0x49/0xb3 [ 229.149481] RIP: 0033:0x411211 [ 229.152715] Code: Bad RIP value. [ 229.156159] RSP: 002b:00007ffe54ff2910 EFLAGS: 00000293 ORIG_RAX: 0000000000000003 [ 229.163882] RAX: 0000000000000000 RBX: 0000000000000005 RCX: 0000000000411211 [ 229.171264] RDX: 0000000000000000 RSI: 0000000000740b80 RDI: 0000000000000004 [ 229.178688] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 229.186851] R10: 00007ffe54ff2840 R11: 0000000000000293 R12: 0000000000000000 [ 229.194134] R13: 0000000000000001 R14: 0000000000000001 R15: 0000000000000000 [ 229.201540] [ 229.201540] Showing all locks held in the system: [ 229.207955] 1 lock held by khungtaskd/1058: [ 229.212388] #0: ffffffff885b6640 (rcu_read_lock){....}-{1:2}, at: debug_show_all_locks+0x5b/0x275 [ 229.221658] 3 locks held by kworker/0:3/2537: [ 229.226233] #0: ffff8881da026d38 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0x7a6/0x1690 [ 229.235958] #1: ffff8881cf907de8 ((work_completion)(&(&sw_ctx_tx->tx_work.work)->work)){+.+.}-{0:0}, at: process_one_work+0x7d7/0x1690 [ 229.248447] #2: ffff8881d677e0d8 (&ctx->tx_lock){+.+.}-{3:3}, at: tx_work_handler+0xf5/0x150 [ 229.257218] 3 locks held by kworker/0:7/2558: [ 229.261754] #0: ffff8881da026d38 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0x7a6/0x1690 [ 229.271469] #1: ffff8881cfae7de8 ((work_completion)(&(&sw_ctx_tx->tx_work.work)->work)){+.+.}-{0:0}, at: process_one_work+0x7d7/0x1690 [ 229.283895] #2: ffff8881cea558d8 (&ctx->tx_lock){+.+.}-{3:3}, at: tx_work_handler+0xf5/0x150 [ 229.292638] 3 locks held by kworker/1:6/2566: [ 229.297224] #0: ffff8881da026d38 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0x7a6/0x1690 [ 229.306943] #1: ffff8881cf41fde8 ((work_completion)(&(&sw_ctx_tx->tx_work.work)->work)){+.+.}-{0:0}, at: process_one_work+0x7d7/0x1690 [ 229.319475] #2: ffff8881d6f4c8d8 (&ctx->tx_lock){+.+.}-{3:3}, at: tx_work_handler+0xf5/0x150 [ 229.328252] 3 locks held by kworker/0:9/2706: [ 229.332751] #0: ffff8881da026d38 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0x7a6/0x1690 [ 229.342560] #1: ffff8881ce42fde8 ((work_completion)(&(&sw_ctx_tx->tx_work.work)->work)){+.+.}-{0:0}, at: process_one_work+0x7d7/0x1690 [ 229.354996] #2: ffff8881c61d5cd8 (&ctx->tx_lock){+.+.}-{3:3}, at: tx_work_handler+0xf5/0x150 [ 229.363764] 3 locks held by kworker/0:10/2717: [ 229.368956] #0: ffff8881da026d38 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0x7a6/0x1690 [ 229.378681] #1: ffff8881ce56fde8 ((work_completion)(&(&sw_ctx_tx->tx_work.work)->work)){+.+.}-{0:0}, at: process_one_work+0x7d7/0x1690 [ 229.391103] #2: ffff8881d88030d8 (&ctx->tx_lock){+.+.}-{3:3}, at: tx_work_handler+0xf5/0x150 [ 229.399893] 3 locks held by kworker/0:11/2719: [ 229.404468] #0: ffff8881da026d38 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0x7a6/0x1690 [ 229.414163] #1: ffff8881ce597de8 ((work_completion)(&(&sw_ctx_tx->tx_work.work)->work)){+.+.}-{0:0}, at: process_one_work+0x7d7/0x1690 [ 229.426578] #2: ffff8881d1b078d8 (&ctx->tx_lock){+.+.}-{3:3}, at: tx_work_handler+0xf5/0x150 [ 229.435419] 1 lock held by syz-executor2/9196: [ 229.440018] #0: ffff8881a1c77750 (&sb->s_type->i_mutex_key#14){+.+.}-{3:3}, at: __sock_release+0x7d/0x280 [ 229.449903] 1 lock held by syz-executor5/9212: [ 229.454494] #0: ffff8881a1c85c90 (&sb->s_type->i_mutex_key#14){+.+.}-{3:3}, at: __sock_release+0x7d/0x280 [ 229.464540] 1 lock held by syz-executor3/9238: [ 229.469222] #0: ffff8881a1122c90 (&sb->s_type->i_mutex_key#14){+.+.}-{3:3}, at: __sock_release+0x7d/0x280 [ 229.479088] 1 lock held by syz-executor4/9243: [ 229.483671] #0: ffff8881a1123c90 (&sb->s_type->i_mutex_key#14){+.+.}-{3:3}, at: __sock_release+0x7d/0x280 [ 229.493727] 1 lock held by syz-executor1/9250: [ 229.498403] #0: ffff8881a112b210 (&sb->s_type->i_mutex_key#14){+.+.}-{3:3}, at: __sock_release+0x7d/0x280 [ 229.508308] 1 lock held by syz-executor0/9260: [ 229.512917] #0: ffff8881a1132750 (&sb->s_type->i_mutex_key#14){+.+.}-{3:3}, at: __sock_release+0x7d/0x280 [ 229.522902] [ 229.524524] ============================================= [ 229.524524] [ 229.531636] NMI backtrace for cpu 1 [ 229.535367] CPU: 1 PID: 1058 Comm: khungtaskd Not tainted 5.7.0-rc5-syzkaller #0 [ 229.542900] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [ 229.552254] Call Trace: [ 229.554841] dump_stack+0x12d/0x187 [ 229.558555] nmi_cpu_backtrace.cold.7+0x4b/0x84 [ 229.563385] ? lapic_can_unplug_cpu.cold.30+0x3f/0x3f [ 229.568556] nmi_trigger_cpumask_backtrace+0x18b/0x1b7 [ 229.573812] arch_trigger_cpumask_backtrace+0x14/0x20 [ 229.579186] watchdog+0x611/0xc50 [ 229.582642] kthread+0x357/0x420 [ 229.586154] ? hungtask_pm_notify+0x40/0x40 [ 229.590485] ? kthread_mod_delayed_work+0x190/0x190 [ 229.595492] ret_from_fork+0x3a/0x50 [ 229.599374] Sending NMI from CPU 1 to CPUs 0: [ 229.603943] NMI backtrace for cpu 0 skipped: idling at native_safe_halt+0x12/0x20 [ 229.604893] Kernel panic - not syncing: hung_task: blocked tasks [ 229.617857] CPU: 1 PID: 1058 Comm: khungtaskd Not tainted 5.7.0-rc5-syzkaller #0 [ 229.625367] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [ 229.634714] Call Trace: [ 229.637300] dump_stack+0x12d/0x187 [ 229.640907] panic+0x22a/0x4f5 [ 229.644074] ? add_taint.cold.7+0x11/0x11 [ 229.648212] ? cpumask_next+0x21/0x30 [ 229.651999] watchdog+0x622/0xc50 [ 229.655440] kthread+0x357/0x420 [ 229.658883] ? hungtask_pm_notify+0x40/0x40 [ 229.663197] ? kthread_mod_delayed_work+0x190/0x190 [ 229.668195] ret_from_fork+0x3a/0x50 [ 229.672813] Kernel Offset: disabled [ 229.676440] Rebooting in 86400 seconds..