dlm: no local IP address has been set dlm: cannot start dlm lowcomms -107 ================================ WARNING: inconsistent lock state 4.14.178-syzkaller #0 Not tainted -------------------------------- inconsistent {SOFTIRQ-ON-W} -> {IN-SOFTIRQ-W} usage. ksoftirqd/0/7 [HC0[0]:SC1[1]:HE1:SE0] takes: (rxrpc_conn_id_lock){+.?.}, at: [] spin_lock include/linux/spinlock.h:317 [inline] (rxrpc_conn_id_lock){+.?.}, at: [] rxrpc_put_client_connection_id.part.0+0x15/0x70 net/rxrpc/conn_client.c:143 {SOFTIRQ-ON-W} state was registered at: lock_acquire+0x170/0x3f0 kernel/locking/lockdep.c:3998 __raw_spin_lock include/linux/spinlock_api_smp.h:142 [inline] _raw_spin_lock+0x2a/0x40 kernel/locking/spinlock.c:152 spin_lock include/linux/spinlock.h:317 [inline] rxrpc_get_client_connection_id net/rxrpc/conn_client.c:114 [inline] rxrpc_alloc_client_connection net/rxrpc/conn_client.c:198 [inline] rxrpc_get_client_conn net/rxrpc/conn_client.c:342 [inline] rxrpc_connect_call+0x7eb/0x3e50 net/rxrpc/conn_client.c:692 rxrpc_new_client_call+0x8d2/0x1410 net/rxrpc/call_object.c:276 rxrpc_new_client_call_for_sendmsg net/rxrpc/sendmsg.c:525 [inline] rxrpc_do_sendmsg+0x8a1/0x1019 net/rxrpc/sendmsg.c:577 rxrpc_sendmsg+0x47d/0x5a0 net/rxrpc/af_rxrpc.c:543 sock_sendmsg_nosec net/socket.c:646 [inline] sock_sendmsg+0xc5/0x100 net/socket.c:656 ___sys_sendmsg+0x349/0x840 net/socket.c:2062 __sys_sendmmsg+0x129/0x330 net/socket.c:2152 SYSC_sendmmsg net/socket.c:2183 [inline] SyS_sendmmsg+0x2f/0x50 net/socket.c:2178 do_syscall_64+0x1d5/0x640 arch/x86/entry/common.c:292 entry_SYSCALL_64_after_hwframe+0x42/0xb7 irq event stamp: 22637410 hardirqs last enabled at (22637410): [] __raw_spin_unlock_irqrestore include/linux/spinlock_api_smp.h:160 [inline] hardirqs last enabled at (22637410): [] _raw_spin_unlock_irqrestore+0x67/0xe0 kernel/locking/spinlock.c:192 hardirqs last disabled at (22637409): [] __raw_spin_lock_irqsave include/linux/spinlock_api_smp.h:108 [inline] hardirqs last disabled at (22637409): [] _raw_spin_lock_irqsave+0x66/0xbf kernel/locking/spinlock.c:160 softirqs last enabled at (22637264): [] __do_softirq+0x664/0x9bf kernel/softirq.c:314 softirqs last disabled at (22637269): [] run_ksoftirqd kernel/softirq.c:670 [inline] softirqs last disabled at (22637269): [] run_ksoftirqd+0x87/0x1a0 kernel/softirq.c:662 other info that might help us debug this: Possible unsafe locking scenario: CPU0 ---- lock(rxrpc_conn_id_lock); lock(rxrpc_conn_id_lock); *** DEADLOCK *** 1 lock held by ksoftirqd/0/7: #0: (rcu_callback){....}, at: [] __rcu_reclaim kernel/rcu/rcu.h:185 [inline] #0: (rcu_callback){....}, at: [] rcu_do_batch kernel/rcu/tree.c:2699 [inline] #0: (rcu_callback){....}, at: [] invoke_rcu_callbacks kernel/rcu/tree.c:2962 [inline] #0: (rcu_callback){....}, at: [] __rcu_process_callbacks kernel/rcu/tree.c:2929 [inline] #0: (rcu_callback){....}, at: [] rcu_process_callbacks+0x866/0x1190 kernel/rcu/tree.c:2946 stack backtrace: CPU: 0 PID: 7 Comm: ksoftirqd/0 Not tainted 4.14.178-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 Call Trace: __dump_stack lib/dump_stack.c:17 [inline] dump_stack+0x13e/0x194 lib/dump_stack.c:58 print_usage_bug.cold+0x327/0x425 kernel/locking/lockdep.c:2589 valid_state kernel/locking/lockdep.c:2602 [inline] mark_lock_irq kernel/locking/lockdep.c:2796 [inline] mark_lock+0xd21/0x10b0 kernel/locking/lockdep.c:3194 mark_irqflags kernel/locking/lockdep.c:3072 [inline] __lock_acquire+0xb57/0x4620 kernel/locking/lockdep.c:3448 lock_acquire+0x170/0x3f0 kernel/locking/lockdep.c:3998 __raw_spin_lock include/linux/spinlock_api_smp.h:142 [inline] _raw_spin_lock+0x2a/0x40 kernel/locking/spinlock.c:152 spin_lock include/linux/spinlock.h:317 [inline] rxrpc_put_client_connection_id.part.0+0x15/0x70 net/rxrpc/conn_client.c:143 rxrpc_put_client_connection_id include/linux/spinlock.h:358 [inline] rxrpc_put_one_client_conn net/rxrpc/conn_client.c:912 [inline] rxrpc_put_client_conn+0x550/0xa80 net/rxrpc/conn_client.c:957 rxrpc_put_connection net/rxrpc/ar-internal.h:862 [inline] rxrpc_rcu_destroy_call+0x83/0x190 net/rxrpc/call_object.c:642 __rcu_reclaim kernel/rcu/rcu.h:195 [inline] rcu_do_batch kernel/rcu/tree.c:2699 [inline] invoke_rcu_callbacks kernel/rcu/tree.c:2962 [inline] __rcu_process_callbacks kernel/rcu/tree.c:2929 [inline] rcu_process_callbacks+0x792/0x1190 kernel/rcu/tree.c:2946 __do_softirq+0x254/0x9bf kernel/softirq.c:288 run_ksoftirqd kernel/softirq.c:670 [inline] run_ksoftirqd+0x87/0x1a0 kernel/softirq.c:662 smpboot_thread_fn+0x5c1/0x920 kernel/smpboot.c:164 kthread+0x30d/0x420 kernel/kthread.c:232 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:404 hfs: umask requires a value hfs: unable to parse mount options dlm: no local IP address has been set dlm: cannot start dlm lowcomms -107 dlm: cannot start dlm_scand thread -4 dlm: cannot start dlm_scand thread -4 dlm: cannot start dlm_scand thread -4 EXT4-fs (loop5): ext4_check_descriptors: Inode table for group 0 overlaps superblock EXT4-fs (loop5): orphan cleanup on readonly fs EXT4-fs error (device loop5): ext4_orphan_get:1266: comm syz-executor.5: bad orphan inode 128 ext4_test_bit(bit=127, block=7) = 0 EXT4-fs (loop5): mounted filesystem without journal. Opts: ,errors=continue dlm: no local IP address has been set dlm: cannot start dlm lowcomms -107 dlm: no local IP address has been set dlm: cannot start dlm lowcomms -107 dlm: no local IP address has been set dlm: cannot start dlm lowcomms -107 dlm: cannot start dlm_scand thread -4 audit: type=1400 audit(1588618702.882:384): avc: denied { call } for pid=29769 comm="syz-executor.1" scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=binder permissive=1 binder: BINDER_SET_CONTEXT_MGR already set binder: BINDER_SET_CONTEXT_MGR already set binder: 29769:29782 ioctl 40046207 0 returned -16 binder: 29769:29771 ioctl 40046207 0 returned -16 audit: type=1400 audit(1588618702.882:385): avc: denied { transfer } for pid=29769 comm="syz-executor.1" scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=binder permissive=1 binder: unexpected work type, 4, not freed dlm: no local IP address has been set dlm: cannot start dlm lowcomms -107 binder: 29798:29822 unknown command 553631744 binder: 29798:29822 ioctl c0306201 20000540 returned -22 dlm: cannot start dlm_scand thread -4 dlm: no local IP address has been set dlm: cannot start dlm lowcomms -107 binder: 29830:29842 unknown command 553631744 binder: 29830:29842 ioctl c0306201 20000540 returned -22 dlm: no local IP address has been set dlm: cannot start dlm lowcomms -107 IPVS: ftp: loaded support on port[0] = 21 dlm: no local IP address has been set dlm: cannot start dlm lowcomms -107 binder: unexpected work type, 4, not freed dlm: Unknown command passed to DLM device : 0 dlm: Unknown command passed to DLM device : 0 dlm: Unknown command passed to DLM device : 0 binder_alloc: 30199: binder_alloc_buf, no vma binder_alloc: 30259: binder_alloc_buf, no vma