igt@gem_exec_gttfill@basic - fail - Failed assertion: !"GPU hung", IPEHR: 0x00000000
https://intel-gfx-ci.01.org/tree/drm-tip/CI_DRM_10065/fi-ilk-m540/igt@gem_exec_gttfill@basic.html
- Err
- Starting subtest: basic
- (gem_exec_gttfill:1138) igt_aux-CRITICAL: Test assertion failure function sig_abort, file ../lib/igt_aux.c:502:
- (gem_exec_gttfill:1138) igt_aux-CRITICAL: Failed assertion: !"GPU hung"
- Subtest basic failed.
- **** DEBUG ****
- (gem_exec_gttfill:1138) DEBUG: Test requirement passed: nengine
- (gem_exec_gttfill:1138) DEBUG: Test requirement passed: size < (1ull<<32) * BATCH_SIZE
- (gem_exec_gttfill:1138) DEBUG: Using 513 batches to fill 2147483648 aperture on 2 engines
- (gem_exec_gttfill:1138) intel_os-DEBUG: Checking 513 surfaces of size 4194304 bytes (total 2155880448) against RAM
- (gem_exec_gttfill:1138) drmtest-DEBUG: Test requirement passed: !(fd<0)
- (gem_exec_gttfill:1138) igt_debugfs-DEBUG: Opening debugfs directory '/sys/kernel/debug/dri/0'
- (gem_exec_gttfill:1138) igt_debugfs-DEBUG: Opening debugfs directory '/sys/kernel/debug/dri/0'
- (gem_exec_gttfill:1138) intel_os-DEBUG: Test requirement passed: sufficient_memory
- (gem_exec_gttfill:1138) igt_debugfs-DEBUG: Opening debugfs directory '/sys/kernel/debug/dri/0'
- (gem_exec_gttfill:1138) igt_debugfs-DEBUG: Opening debugfs directory '/sys/kernel/debug/dri/0'
- (gem_exec_gttfill:1138) igt_aux-CRITICAL: Test assertion failure function sig_abort, file ../lib/igt_aux.c:502:
- (gem_exec_gttfill:1138) igt_aux-CRITICAL: Failed assertion: !"GPU hung"
- (gem_exec_gttfill:1138) igt_core-INFO: Stack trace:
- (gem_exec_gttfill:1138) igt_core-INFO: #0 ../lib/igt_core.c:1745 __igt_fail_assert()
- (gem_exec_gttfill:1138) igt_core-INFO: #1 [sig_abort+0x3a]
- (gem_exec_gttfill:1138) igt_core-INFO: #2 [killpg+0x40]
- (gem_exec_gttfill:1138) igt_core-INFO: #3 ../sysdeps/unix/syscall-template.S:78 ioctl()
- (gem_exec_gttfill:1138) igt_core-INFO: #4 ../xf86drm.c:207 drmIoctl()
- (gem_exec_gttfill:1138) igt_core-INFO: #5 ../lib/ioctl_wrappers.c:607 __gem_execbuf()
- (gem_exec_gttfill:1138) igt_core-INFO: #6 ../lib/ioctl_wrappers.c:625 gem_execbuf()
- (gem_exec_gttfill:1138) igt_core-INFO: #7 ../tests/i915/gem_exec_gttfill.c:90 submit()
- (gem_exec_gttfill:1138) igt_core-INFO: #8 ../tests/i915/gem_exec_gttfill.c:170 fillgtt()
- (gem_exec_gttfill:1138) igt_core-INFO: #9 ../tests/i915/gem_exec_gttfill.c:219 __real_main208()
- (gem_exec_gttfill:1138) igt_core-INFO: #10 ../tests/i915/gem_exec_gttfill.c:208 main()
- (gem_exec_gttfill:1138) igt_core-INFO: #11 ../csu/libc-start.c:344 __libc_start_main()
- (gem_exec_gttfill:1138) igt_core-INFO: #12 [_start+0x2a]
- **** END ****
- Subtest basic: FAIL (6.852s)
- Dmesg
- <6> [60.413662] Console: switching to colour dummy device 80x25
- <6> [60.413780] [IGT] gem_exec_gttfill: executing
- <6> [60.433837] [IGT] gem_exec_gttfill: starting subtest basic
- <6> [60.435246] gem_exec_gttfil (1138): drop_caches: 4
- <7> [67.029296] heartbeat rcs0 heartbeat {seqno:3:9609, prio:-2147483648} not ticking
- <7> [67.029313] heartbeat Awake? 4
- <7> [67.029318] heartbeat Barriers?: no
- <7> [67.029324] heartbeat Latency: 54us
- <7> [67.029329] heartbeat Forcewake: 0 domains, 0 active
- <7> [67.029335] heartbeat Heartbeat: 3008 ms ago
- <7> [67.029342] heartbeat Reset count: 0 (global 3)
- <7> [67.029347] heartbeat Properties:
- <7> [67.029352] heartbeat heartbeat_interval_ms: 2500 [default 2500]
- <7> [67.029359] heartbeat max_busywait_duration_ns: 8000 [default 8000]
- <7> [67.029365] heartbeat preempt_timeout_ms: 640 [default 640]
- <7> [67.029371] heartbeat stop_timeout_ms: 100 [default 100]
- <7> [67.029377] heartbeat timeslice_duration_ms: 1 [default 1]
- <7> [67.029383] heartbeat Requests:
- <7> [67.029393] heartbeat active E 3:9571* @ 5735ms: gem_exec_gttfil[1138]
- <7> [67.029402] heartbeat ring->start: 0x00004000
- <7> [67.029407] heartbeat ring->head: 0x000028c0
- <7> [67.029412] heartbeat ring->tail: 0x000019c0
- <7> [67.029416] heartbeat ring->emit: 0x000019c0
- <7> [67.029421] heartbeat ring->space: 0x00000ec0
- <7> [67.029426] heartbeat ring->hwsp: 0x00002100
- <7> [67.029430] heartbeat [head 28c0, postfix 2938, tail 2a00, batch 0x00000000_00590000]:
- <7> [67.029463] heartbeat [0000] 02000022 7a004002 7fffe004 00000000 00000000 02000000 02000000 02000000
- <7> [67.029471] heartbeat [0020] 02000000 02000000 02000000 02000000 02000000 02000000 02000000 02000000
- <7> [67.029478] heartbeat [0040] 02000000 7a004002 7fffe004 00000000 00000000 02000022 05800001 00000000
- <7> [67.029484] heartbeat [0060] 0c000000 0058f10c 00000000 05800000 18800080 00590000 02000000 10800001
- <7> [67.029491] heartbeat [0080] 00000200 00002563 10800001 00000200 00002563 10800001 00000200 00002563
- <7> [67.029498] heartbeat [00a0] 10800001 00000200 00002563 10800001 00000200 00002563 10800001 00000200
- <7> [67.029504] heartbeat [00c0] 00002563 10800001 00000200 00002563 10800001 00000200 00002563 10800001
- <7> [67.029511] heartbeat [00e0] 00000100 00002563 10800001 00000100 00002563 10800001 00000100 00002563
- <7> [67.029517] heartbeat [0100] 10800001 00000100 00002563 10800001 00000100 00002563 10800001 00000100
- <7> [67.029524] heartbeat [0120] 00002563 10800001 00000100 00002563 10800001 00000100 00002563 01000000
- <7> [67.029538] heartbeat On hold?: 0
- <7> [67.029543] heartbeat MMIO base: 0x00002000
- <7> [67.029552] heartbeat CCID: 0x0058f10d
- <7> [67.029558] heartbeat RING_START: 0x00004000
- <7> [67.029564] heartbeat RING_HEAD: 0x00002938
- <7> [67.029571] heartbeat RING_TAIL: 0x000019c0
- <7> [67.029577] heartbeat RING_CTL: 0x00003001
- <7> [67.029584] heartbeat RING_MODE: 0x00000040
- <7> [67.029590] heartbeat ACTHD: 0x00000000_80002000
- <7> [67.029596] heartbeat BBADDR: 0x00000000_80002003
- <7> [67.029602] heartbeat DMA_FADDR: 0x00000000_800021c0
- <7> [67.029608] heartbeat IPEIR: 0x00000000
- <7> [67.029613] heartbeat IPEHR: 0x00000000
- <7> [67.029621] heartbeat E 3:9571* @ 5735ms: gem_exec_gttfil[1138]
- <7> [67.029629] heartbeat E 3:9572 @ 5718ms: gem_exec_gttfil[1138]
- <7> [67.029636] heartbeat E 3:9573 @ 5701ms: gem_exec_gttfil[1138]
- <7> [67.029643] heartbeat E 3:9574 @ 5684ms: gem_exec_gttfil[1138]
- <7> [67.029650] heartbeat E 3:9575 @ 5667ms: gem_exec_gttfil[1138]
- <7> [67.029656] heartbeat E 3:9576 @ 5650ms: gem_exec_gttfil[1138]
- <7> [67.029663] heartbeat E 3:9577 @ 5633ms: gem_exec_gttfil[1138]
- <7> [67.029673] heartbeat ...skipping 31 executing requests...
- <7> [67.029678] heartbeat E 3:9609 @ 3008ms: [i915]
- <7> [67.029686] heartbeat HWSP:
- <7> [67.029693] heartbeat [0000] 00000000 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a
- <7> [67.029700] heartbeat [0020] 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a
- <7> [67.029705] heartbeat *
- <7> [67.029712] heartbeat [0100] 00002562 00000000 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a
- <7> [67.029719] heartbeat [0120] 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a
- <7> [67.029724] heartbeat *
- <7> [67.029730] heartbeat [0200] 00002562 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a
- <7> [67.029737] heartbeat [0220] 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a
- <7> [67.029742] heartbeat *
- <7> [67.029755] heartbeat Idle? no
- <7> [67.029760] heartbeat IRQ: enabled
- <7> [67.029765] heartbeat Signals:
- <7> [67.029771] heartbeat [3:2570] @ 5515ms
- <6> [67.105310] i915 0000:00:02.0: [drm] GPU HANG: ecode 5:1:ffffffff, in gem_exec_gttfil [1138]
- <5> [67.106497] i915 0000:00:02.0: [drm] Resetting chip for stopped heartbeat on rcs0
- <5> [67.209302] i915 0000:00:02.0: [drm] gem_exec_gttfil[1138] context reset due to GPU hang
- <7> [67.209313] i915 0000:00:02.0: [drm:__i915_request_reset.cold.64 [i915]] client gem_exec_gttfil[1138]: gained 1 ban score, now 1