igt@gem_workarounds@[basic|reset]-.* - timeout - Per-test timeout exceeded. Killing the current test with SIGQUIT.
https://intel-gfx-ci.01.org/tree/drm-tip/IGTPW_6577/shard-snb6/igt@gem_workarounds@basic-read.html
Err
Starting subtest: basic-read
Received signal SIGQUIT.
Stack trace:
#0 [fatal_sig_handler+0xd6]
#1 [killpg+0x40]
#2 [workaround_fail_count+0x2e0]
#3 [__igt_unique____real_main239+0x507]
#4 [main+0x27]
#5 [__libc_start_main+0xf3]
#6 [_start+0x2a]
Dmesg
<6> [145.368561] Console: switching to colour dummy device 80x25
<6> [145.368810] [IGT] gem_workarounds: executing
<6> [145.383257] [IGT] gem_workarounds: starting subtest basic-read
<7> [151.064274] heartbeat rcs0 heartbeat {seqno:10:152411, prio:-2147483648} not ticking
<7> [151.064291] heartbeat Awake? 4
<7> [151.064293] heartbeat Barriers?: no
<7> [151.064295] heartbeat Latency: 212us
<7> [151.064297] heartbeat Forcewake: 0 domains, 0 active
<7> [151.064300] heartbeat Heartbeat: 3008 ms ago
<7> [151.064307] heartbeat Reset count: 0 (global 699)
<7> [151.064309] heartbeat Properties:
<7> [151.064311] heartbeat heartbeat_interval_ms: 2500 [default 2500]
<7> [151.064314] heartbeat max_busywait_duration_ns: 8000 [default 8000]
<7> [151.064316] heartbeat preempt_timeout_ms: 640 [default 640]
<7> [151.064317] heartbeat stop_timeout_ms: 100 [default 100]
<7> [151.064319] heartbeat timeslice_duration_ms: 1 [default 1]
<7> [151.064323] heartbeat Requests:
<7> [151.064849] heartbeat hungE 10:152410* @ 3670ms: gem_workarounds[1408]
<7> [151.064853] heartbeat ring->start: 0x00001000
<7> [151.064855] heartbeat ring->head: 0x00000000
<7> [151.064856] heartbeat ring->tail: 0x00000330
<7> [151.064858] heartbeat ring->emit: 0x00000330
<7> [151.064860] heartbeat ring->space: 0x00003c90
<7> [151.064861] heartbeat ring->hwsp: 0x7fffe100
<7> [151.064863] heartbeat [head 0038, postfix 0180, tail 01b8, batch 0x00000000_55c5a000]:
<7> [151.064909] heartbeat [0000] 7a000003 00100002 7ffff084 00000000 00000000 00000000 7a000003 00004000
<7> [151.064912] heartbeat [0020] 7ffff084 00000000 00000000 00000000 7a000002 00144c1c 7ffff084 00000000
<7> [151.064914] heartbeat [0040] 7a000003 00100002 7ffff084 00000000 00000000 00000000 7a000003 00004000
<7> [151.064917] heartbeat [0060] 7ffff084 00000000 00000000 00000000 7a000002 00101001 7ffff084 00000000
<7> [151.064919] heartbeat [0080] 11000001 00002220 ffffffff 11000001 00002228 7fdf0000 12400001 00002228
<7> [151.064922] heartbeat [00a0] 7ffff000 11000001 000020c0 02000200 7a000003 00100002 7ffff084 00000000
<7> [151.064924] heartbeat [00c0] 00000000 00000000 7a000003 00004000 7ffff084 00000000 00000000 00000000
<7> [151.064926] heartbeat [00e0] 7a000002 00101001 7ffff084 00000000 7a000003 00100002 7ffff084 00000000
<7> [151.064929] heartbeat [0100] 00000000 00000000 7a000003 00004000 7ffff084 00000000 00000000 00000000
<7> [151.064931] heartbeat [0120] 7a000002 00144c1c 7ffff084 00000000 00000000 0c000000 7fff810c 00000000
<7> [151.064933] heartbeat [0140] 18800100 55c5a000 7a000002 00100002 00000000 00000000 7a000002 00004000
<7> [151.064936] heartbeat [0160] 7ffff004 00000000 7a000002 00105021 7fffe104 0002535a 01000000 00000000
<7> [151.064971] heartbeat On hold?: 0
<7> [151.064973] heartbeat MMIO base: 0x00002000
<7> [151.065014] heartbeat CCID: 0x7fff610d
<7> [151.065017] heartbeat RING_START: 0x00001000
<7> [151.065020] heartbeat RING_HEAD: 0x00003fe0
<7> [151.065023] heartbeat RING_TAIL: 0x00000330
<7> [151.065027] heartbeat RING_CTL: 0x00003001
<7> [151.065031] heartbeat RING_MODE: 0x00006b6b [idle]
<7> [151.065034] heartbeat RING_IMR: 0xfffffffe
<7> [151.065038] heartbeat RING_ESR: 0x00000000
<7> [151.065040] heartbeat RING_EMR: 0xffffffff
<7> [151.065043] heartbeat RING_EIR: 0x00000000
<7> [151.065046] heartbeat ACTHD: 0x00000000_00001174
<7> [151.065049] heartbeat BBADDR: 0x00000000_00001175
<7> [151.065053] heartbeat DMA_FADDR: 0x00000000_00004fe0
<7> [151.065056] heartbeat IPEIR: 0x00000000
<7> [151.065059] heartbeat IPEHR: 0x6b6b6b6b
<7> [151.065061] heartbeat E 10:152410* @ 3670ms: gem_workarounds[1408]
<7> [151.065065] heartbeat E 10:152411 @ 3008ms: [i915]
<7> [151.065067] heartbeat HWSP:
<7> [151.065070] heartbeat [0000] 00000001 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a
<7> [151.065072] heartbeat [0020] 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a
<7> [151.065075] heartbeat *
<7> [151.065077] heartbeat [0100] 00025359 00000000 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a
<7> [151.065079] heartbeat [0120] 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a
<7> [151.065081] heartbeat *
<7> [151.065092] heartbeat Idle? no
<7> [151.065094] heartbeat IRQ: enabled
<6> [151.066961] i915 0000:00:02.0: [drm] GPU HANG: ecode 6:1:94949495, in gem_workarounds [1408]
<5> [151.068444] i915 0000:00:02.0: [drm] Resetting chip for stopped heartbeat on rcs0
<5> [151.068582] i915 0000:00:02.0: [drm] gem_workarounds[1408] context reset due to GPU hang
<7> [151.068622] i915 0000:00:02.0: [drm:__i915_request_reset.cold.65 [i915]] client gem_workarounds[1408]: gained 1 ban score, now 1
<4> [266.147131] [IGT] Per-test timeout exceeded. Killing the current test with SIGQUIT.
<6> [266.147171] sysrq: Show State
<6> [266.147244] task:systemd state:S stack:12280 pid: 1 ppid: 0 flags:0x00000000
<6> [266.147254] Call Trace:
<6> [266.147256] <TASK>
<6> [266.147261] __schedule+0x42c/0xa80
<6> [266.147273] schedule+0x3f/0xc0
<6> [266.147277] schedule_hrtimeout_range_clock+0x119/0x130
<6> [266.147281] ? do_epoll_wait+0x75f/0x910
<6> [266.147287] ? _raw_write_unlock_irq+0x1f/0x40
<6> [266.147291] ? lockdep_hardirqs_on+0xbf/0x130
<6> [266.147296] do_epoll_wait+0x770/0x910
<6> [266.147307] ? finish_wait+0x80/0x80
<6> [266.147316] __x64_sys_epoll_wait+0x50/0x90
<6> [266.147319] ? lockdep_hardirqs_on+0xbf/0x130
<6> [266.147325] do_syscall_64+0x3a/0xb0
<6> [266.147329] entry_SYSCALL_64_after_hwframe+0x44/0xae
<6> [266.147332] RIP: 0033:0x7ff4395125ce
<6> [266.147335] RSP: 002b:00007ffc627c7400 EFLAGS: 00000293 ORIG_RAX: 00000000000000e8
<6> [266.147339] RAX: ffffffffffffffda RBX: 00007ff439c76490 RCX: 00007ff4395125ce
<6> [266.147341] RDX: 0000000000000055 RSI: 00007ff439cc9da0 RDI: 0000000000000004
<6> [266.147343] RBP: ffffffffffffffff R08: 0000000000000000 R09: 0000000000000510
<6> [266.147345] R10: 00000000ffffffff R11: 0000000000000293 R12: 0000000000000001
<6> [266.147348] R13: 0000000000000055 R14: 00007ff43974a883 R15: 0000000000000000
<6> [266.147361] </TASK>
<6> [266.147363] task:kthreadd state:S stack:13904 pid: 2 ppid: 0 flags:0x00004000
<6> [266.147370] Call Trace:
<6> [266.147372] <TASK>
<6> [266.147377] __schedule+0x42c/0xa80
<6> [266.147380] ? kthreadd+0x129/0x160
<6> [266.147386] ? kthreadd+0x8b/0x160
<6> [266.147389] ? kthreadd+0x64/0x160
<6> [266.147391] schedule+0x3f/0xc0
<6> [266.147395] kthreadd+0x14b/0x160
<6> [266.147398] ? kthread_is_per_cpu+0x20/0x20
<6> [266.147403] ret_from_fork+0x22/0x30
<6> [266.147418] </TASK>
<6> [266.147419] task:rcu_gp state:I stack:15000 pid: 3 ppid: 2 flags:0x00004000
<6> [266.147426] Call Trace:
<6> [266.147428] <TASK>
<6> [266.147433] __schedule+0x42c/0xa80
<6> [266.147436] ? rescuer_thread+0x22f/0x380
<6> [266.147444] schedule+0x3f/0xc0
<6> [266.147448] rescuer_thread+0x24c/0x380
<6> [266.147452] ? _raw_spin_unlock_irqrestore+0x3d/0x60
<6> [266.147458] ? worker_thread+0x370/0x370
<6> [266.147461] kthread+0xef/0x120
<6> [266.147463] ? kthread_complete_and_exit+0x20/0x20
<6> [266.147469] ret_from_fork+0x22/0x30
<6> [266.147483] </TASK>
<6> [266.147484] task:rcu_par_gp state:I stack:15384 pid: 4 ppid: 2 flags:0x00004000
<6> [266.147491] Call Trace:
<6> [266.147492] <TASK>
<6> [266.147497] __schedule+0x42c/0xa80
<6> [266.147500] ? rescuer_thread+0x22f/0x380
<6> [266.147508] schedule+0x3f/0xc0
<6> [266.147511] rescuer_thread+0x24c/0x380
<6> [266.147516] ? _raw_spin_unlock_irqrestore+0x3d/0x60
<6> [266.147522] ? worker_thread+0x370/0x370
<6> [266.147525] kthread+0xef/0x120
<6> [266.147527] ? kthread_complete_and_exit+0x20/0x20
<6> [266.147532] ret_from_fork+0x22/0x30
<6> [266.147546] </TASK>
<6> [266.147547] task:kworker/0:0 state:I stack:14616 pid: 5 ppid: 2 flags:0x00004000
<6> [266.147553] Workqueue: 0x0 (pm)
<6> [266.147559] Call Trace:
<6> [266.147560] <TASK>
<6> [266.147565] __schedule+0x42c/0xa80
<6> [266.147568] ? worker_thread+0xb5/0x370
<6> [266.147576] schedule+0x3f/0xc0
<6> [266.147579] worker_thread+0xba/0x370
<6> [266.147585] ? process_one_work+0x5c0/0x5c0
<6> [266.147588] kthread+0xef/0x120
<6> [266.147590] ? kthread_complete_and_exit+0x20/0x20
<6> [266.147595] ret_from_fork+0x22/0x30
<6> [266.147609] </TASK>
Edited by SAI NANDAN