Re: i915drmkms0: notice: Resetting chip for stopped heartbeat on rcs0

To: NetBSD current-users <current-users%NetBSD.org@localhost>
Subject: Re: i915drmkms0: notice: Resetting chip for stopped heartbeat on rcs0
From: Paul Ripke <stix%stix.id.au@localhost>
Date: Mon, 26 Aug 2024 21:39:21 +1000
And another - weird slow torn updates starting after:

Aug 25 21:39:53 slave /netbsd: [ 2764221.4905408] heartbeat rcs0 heartbeat {prio:-2147483645} not ticking
Aug 25 21:39:53 slave /netbsd: [ 2764221.4905408] heartbeat     Awake? 6
Aug 25 21:39:53 slave /netbsd: [ 2764221.4905408] heartbeat     Barriers?: no
Aug 25 21:39:53 slave /netbsd: [ 2764221.4905408] heartbeat     Latency: 15us
Aug 25 21:39:53 slave /netbsd: [ 2764221.4905408] heartbeat     Heartbeat: 3000 ms ago
Aug 25 21:39:53 slave /netbsd: [ 2764221.4905408] heartbeat     Reset count: 0 (global 0)
Aug 25 21:39:53 slave /netbsd: [ 2764221.4905408] heartbeat     Requests:
Aug 25 21:39:53 slave /netbsd: [ 2764221.4905408] heartbeat             active  2:21d0058*  @ 5992ms: chrome[5355]
Aug 25 21:39:53 slave /netbsd: [ 2764221.4905408] heartbeat             ring->start:  0x7fffa000
Aug 25 21:39:53 slave /netbsd: [ 2764221.4905408] heartbeat             ring->head:   0x00003df0
Aug 25 21:39:53 slave /netbsd: [ 2764221.4905408] heartbeat             ring->tail:   0x00001028
Aug 25 21:39:53 slave /netbsd: [ 2764221.4905408] heartbeat             ring->emit:   0x00001320
Aug 25 21:39:53 slave /netbsd: [ 2764221.4905408] heartbeat             ring->taice:  0x00002a90
Aug 25 21:39:53 slave /netbsd: [ 2764221.4905408] heartbeat             ring->hwsp:   0x7fffe100
Aug 25 21:39:53 slave /netbsd: [ 2764221.4905408] heartbeat [head 3e28, postfix 3f70, tail 3fa8, batch 0x00000000_1ba50000]:
Aug 25 21:39:53 slave /netbsd: [ 2764221.4905408] warning: /home/netbsd/netbsd-10/src/sys/external/bsd/drm2/dist/drm/i915/gt/intel_engine_cs.c:1234: WARN_ON_ONCE(hex_dump_to_buffer(buf + pos, len - pos, rowsize, sizeof(u32), line, sizeof(line), 0) >= sizeof(line))
Aug 25 21:39:53 slave /netbsd: [ 2764221.4905408] heartbeat [0000] 0300007a 02001000 84f0ff7f 00000000 00000000 00000000 0300007a 00400000
Aug 25 21:39:53 slave /netbsd: [ 2764221.4905408] 84f0ff7f 00000000 00000000 00000000 0200007a 1c4c1400 8
Aug 25 21:39:53 slave /netbsd: [ 2764221.4905408] heartbeat [0020] 84f0ff7f 00000000 00000000 00000000 0200007a 1c4c1400 84f0ff7f 00000000
Aug 25 21:39:53 slave /netbsd: [ 2764221.4905408] heartbeat [0020] 84f0fff7f 00000000 00000000 00000000 0
Aug 25 21:39:53 slave /netbsd: [ 2764221.4905408] heartbeat [0040] 0300007a 02001000 84f0ff7f 00000000 00000000 00000000 0300007a 00400000
Aug 25 21:39:53 slave /netbsd: [ 2764221.4905408] 84f0ff7f 00000000 00000000 00000000 0200007a 01101000 8
Aug 25 21:39:53 slave /netbsd: [ 2764221.4905408] heartbeat [0060] 84f0ff7f 00000000 00000000 00000000 0200007a 01101000 84f0ff7f 00000000
Aug 25 21:39:53 slave /netbsd: [ 2764221.4905408] 01000011 20220000 ffffffff 01000011 28220000 0000df7f 0
Aug 25 21:39:53 slave /netbsd: [ 2764221.4905408] heartbeat [0080] 01000011 20220000 ffffffff 01000011 28220000 0000df7f 01004012 28220000
Aug 25 21:39:53 slave /netbsd: [ 2764221.4905408] 00f0ff7f 01000011 c0200000 00020002 0300007a 02001000 8
Aug 25 21:39:53 slave /netbsd: [ 2764221.4905408] heartbeat [00a0] 00f0ff7f 01000011 c0200000 00020002 0300007a 02001000 84f0ff7f 00000000
Aug 25 21:39:53 slave /netbsd: [ 2764221.4905408] 00000000 00000000 0300007a 00400000 84f0ff7f 00000000 0
Aug 25 21:39:53 slave /netbsd: [ 2764221.4905408] heartbeat [00c0] 00000000 00000000 0300007a 00400000 84f0ff7f 00000000 00000000 00000000
Aug 25 21:39:53 slave /netbsd: [ 2764221.4905408] 0200007a 01101000 84f0ff7f 00000000 0300007a 02001000 8
Aug 25 21:39:53 slave /netbsd: [ 2764221.4905408] heartbeat [00e0] 0200007a 01101000 84f0ff7f 00000000 0300007a 02001000 84f0ff7f 00000000
Aug 25 21:39:53 slave /netbsd: [ 2764221.4905408] 00000000 00000000 0300007a 00400000 84f0ff7f 00000000 0
Aug 25 21:39:53 slave /netbsd: [ 2764221.4905408] heartbeat [0100] 00000000 00000000 0300007a 00400000 84f0ff7f 00000000 00000000 00000000
Aug 25 21:39:53 slave /netbsd: [ 2764221.4905408] 0200007a 1c4c1400 84f0ff7f 00000000 00000000 0000000c 0
Aug 25 21:39:53 slave /netbsd: [ 2764221.4905408] heartbeat [0120] 0200007a 1c4c1400 84f0ff7f 00000000 00000000 0000000c 0ca1de7f 00000000
Aug 25 21:39:53 slave /netbsd: [ 2764221.4905408] 00018018 0000a51b 0200007a 02001000 00000000 00000000 0
Aug 25 21:39:53 slave /netbsd: [ 2764221.4905408] heartbeat [0140] 00018018 0000a51b 0200007a 02001000 00000000 00000000 0200007a 00400000
Aug 25 21:39:53 slave /netbsd: [ 2764221.4905408] 04f0ff7f 00000000 0200007a 21501000 04e1ff7f 58001d02 0
Aug 25 21:39:53 slave /netbsd: [ 2764221.4905408] heartbeat [0160] 04f0ff7f 00000000 0200007a 21501000 04e1ff7f 58001d02 00000001 00000000
Aug 25 21:39:53 slave /netbsd:
Aug 25 21:39:53 slave /netbsd: [ 2764221.4905408] heartbeat     MMIO base:  0x00002000
Aug 25 21:39:53 slave /netbsd: [ 2764221.4905408] heartbeat     CCID: 0x7fdea10d
Aug 25 21:39:53 slave /netbsd: [ 2764221.4905408] heartbeat     RING_START: 0x7fffa000
Aug 25 21:39:53 slave /netbsd: [ 2764221.4905408] heartbeat     RING_HEAD:  0x00003f70
Aug 25 21:39:53 slave /netbsd: [ 2764221.4905408] heartbeat     RING_TAIL:  0x00001028
Aug 25 21:39:53 slave /netbsd: [ 2764221.4905408] heartbeat     RING_CTL:   0x00003001
Aug 25 21:39:53 slave /netbsd: [ 2764221.4905408] heartbeat     RING_MODE:  0x00004040
Aug 25 21:39:53 slave /netbsd: [ 2764221.4905408] heartbeat     RING_IMR: fffffffe
Aug 25 21:39:53 slave /netbsd: [ 2764221.4905408] heartbeat     ACTHD:  0x00000000_1ba50168
Aug 25 21:39:53 slave /netbsd: [ 2764221.4905408] heartbeat     BBADDR: 0x00000000_1ba50169
Aug 25 21:39:53 slave /netbsd: [ 2764221.4915426] heartbeat     DMA_FADDR: 0x00000000_1ba50300
Aug 25 21:39:53 slave /netbsd: [ 2764221.4915426] heartbeat     IPEIR: 0x00000000
Aug 25 21:39:53 slave /netbsd: [ 2764221.4915426] heartbeat     IPEHR: 0x16060720
Aug 25 21:39:53 slave /netbsd: [ 2764221.4915426] heartbeat             E  2:21d0058*  @ 5993ms: chrome[5355]
Aug 25 21:39:53 slave /netbsd: [ 2764221.4915426] heartbeat             E  2:21d0059  @ 5993ms: chrome[5355]
Aug 25 21:39:53 slave /netbsd: [ 2764221.4915426] heartbeat             E  2:21d005a  @ 5973ms: chrome[5355]
Aug 25 21:39:53 slave /netbsd: [ 2764221.4915426] heartbeat             E  2:21d005b  @ 5973ms: chrome[5355]
Aug 25 21:39:53 slave /netbsd: [ 2764221.4915426] heartbeat             E  2:21d005c  @ 5973ms: chrome[5355]
Aug 25 21:39:53 slave /netbsd: [ 2764221.4915426] heartbeat             E  2:21d005d  @ 5973ms: chrome[5355]
Aug 25 21:39:53 slave /netbsd: [ 2764221.4915426] heartbeat             E  2:21d005e  @ 5973ms: chrome[5355]
Aug 25 21:39:53 slave /netbsd: [ 2764221.4915426] heartbeat             ...skipping 4 executing requests...
Aug 25 21:39:53 slave /netbsd: [ 2764221.4915426] heartbeat             E  2:21d0063-  @ 5633ms: X[1529]
Aug 25 21:39:53 slave /netbsd: [ 2764221.4915426] heartbeat HWSP:
Aug 25 21:39:53 slave /netbsd: [ 2764221.4915426] heartbeat [0000] 01000000 00000000 00000000 00000000 2400a51b 00000000 00000000 00000000
Aug 25 21:39:53 slave /netbsd: [ 2764221.4915426] 00000000 00000000 00000000 00000000 00000000 00000000 0
Aug 25 21:39:53 slave /netbsd: [ 2764221.4915426] heartbeat [0020] 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000
Aug 25 21:39:53 slave /netbsd: [ 2764221.4915426] 00000000 00000000 00000000 00000000 00000000 00000000 0
Aug 25 21:39:53 slave /netbsd: [ 2764221.4915426] heartbeat *
Aug 25 21:39:53 slave /netbsd: [ 2764221.4915426] heartbeat [0100] 57001d02 00000000 00000000 00000000 00000000 00000000 00000000 00000000
Aug 25 21:39:53 slave /netbsd: [ 2764221.4915426] 00000000 00000000 00000000 00000000 00000000 00000000 0
Aug 25 21:39:53 slave /netbsd: [ 2764221.4915426] heartbeat [0120] 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000
Aug 25 21:39:53 slave /netbsd: [ 2764221.4915426] 00000000 00000000 00000000 00000000 00000000 00000000 0
Aug 25 21:39:53 slave /netbsd: [ 2764221.4915426] heartbeat *
Aug 25 21:39:53 slave /netbsd: [ 2764221.4915426] heartbeat Idle? no
Aug 25 21:39:53 slave /netbsd: [ 2764221.4915426] heartbeat Signals:
Aug 25 21:39:53 slave /netbsd: [ 2764221.4915426] heartbeat     [2:21d0062] @ 5970ms
Aug 25 21:39:53 slave /netbsd: [ 2764221.4915426] heartbeat     [2:21d0063] @ 5633ms
Aug 25 21:39:53 slave /netbsd: [ 2764221.4915426] i915drmkms0: notice: Resetting chip for stopped heartbeat on rcs0
Aug 25 21:39:53 slave /netbsd: [ 2764221.4935401] i915drmkms0: notice: chrome[5355] context reset due to GPU hang
Aug 25 21:39:53 slave /netbsd: [ 2764221.4935401] heartbeat bcs0 heartbeat {prio:-2147483645} not ticking
Aug 25 21:39:53 slave /netbsd: [ 2764221.4935401] heartbeat     Awake? 4
Aug 25 21:39:53 slave /netbsd: [ 2764221.4935401] heartbeat     Awake? 4y: 69us
Aug 25 21:39:53 slave /netbsd: [ 2764221.4935401] heartbeat     Heartbeat: 3002 ms ago
Aug 25 21:39:53 slave /netbsd: [ 2764221.4935401] heartbeat     Reset count: 0 (global 1)
Aug 25 21:39:53 slave /netbsd: [ 2764221.4935401] heartbeat     Requests:
Aug 25 21:39:53 slave /netbsd: [ 2764221.4935401] heartbeat     On hold?: 0
Aug 25 21:39:53 slave /netbsd: [ 2764221.4935401] heartbeat     MMIO base:  0x00022000
Aug 25 21:39:53 slave /netbsd: [ 2764221.4935401] heartbeat     RING_START: 0x7fff3000
Aug 25 21:39:53 slave /netbsd: [ 2764221.4935401] heartbeat     RING_HEAD:  0x00000fe0
Aug 25 21:39:53 slave /netbsd: [ 2764221.4935401] heartbeat     RING_TAIL:  0x00000fe0
Aug 25 21:39:53 slave /netbsd: [ 2764221.4935401] heartbeat     RING_CTL:   0x00003001
Aug 25 21:39:53 slave /netbsd: [ 2764221.4935401] heartbeat     RING_MODE:  0x00000200 [idle]
Aug 25 21:39:53 slave /netbsd: [ 2764221.4935401] heartbeat     RING_IMR: ffffffff
Aug 25 21:39:53 slave /netbsd: [ 2764221.4935401] heartbeat     ACTHD:  0x00000000_00000fe0
Aug 25 21:39:53 slave /netbsd: [ 2764221.4935401] heartbeat     BBADDR: 0x00000000_00000000
Aug 25 21:39:53 slave /netbsd: [ 2764221.4935401] heartbeat     DMA_FADDR: 0x00000000_00000000
Aug 25 21:39:53 slave /netbsd: [ 2764221.4935401] heartbeat     IPEIR: 0x00000000
Aug 25 21:39:53 slave /netbsd: [ 2764221.4935401] heartbeat     IPEHR: 0x00000000
Aug 25 21:39:53 slave /netbsd: [ 2764221.4935401] heartbeat HWSP:
Aug 25 21:39:53 slave /netbsd: [ 2764221.4935401] heartbeat [0000] 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000
Aug 25 21:39:53 slave /netbsd: [ 2764221.4935401] 00000000 00000000 00000000 00000000 00000000 00000000 0
Aug 25 21:39:53 slave /netbsd: [ 2764221.4935401] heartbeat *
Aug 25 21:39:53 slave /netbsd: [ 2764221.4935401] heartbeat *[ 2764221.4935401] 00000000 00000000 00000000 00000000 00000000 00000000 0
Aug 25 21:39:53 slave /netbsd: [ 2764221.4935401] heartbeat [0120] 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000
Aug 25 21:39:53 slave /netbsd: [ 2764221.4935401] 00000000 00000000 00000000 00000000 00000000 00000000 0
Aug 25 21:39:53 slave /netbsd: [ 2764221.4935401] heartbeat *
Aug 25 21:39:53 slave /netbsd: [ 2764221.4935401] heartbeat Idle? yes
Aug 25 21:39:53 slave /netbsd: [ 2764221.4945403] i915drmkms0: notice: Resetting chip for stopped heartbeat on bcs0
Aug 25 21:39:53 slave /netbsd: [ 2764221.4955402] i915drmkms0: notice: X[1529] context reset due to GPU hang

-- 
Paul Ripke
"Great minds discuss ideas, average minds discuss events, small minds
 discuss people."
-- Disputed: Often attributed to Eleanor Roosevelt. 1948.
References:
- i915drmkms0: notice: Resetting chip for stopped heartbeat on rcs0
  - From: Paul Ripke
Prev by Date: daily CVS update output
Next by Date: daily CVS update output
Previous by Thread: i915drmkms0: notice: Resetting chip for stopped heartbeat on rcs0
Next by Thread: binary in dtrace output
Indexes:
Home | Main Index | Thread Index | Old Index