Results for igt@perf@non-zero-reason@0-rcs0

Result: Fail

git-log-oneline i915_display_info24 igt_runner24 runtimes24 results24.json results24-i915-load.json guc_logs24.tar i915_display_info_post_exec24 boot24 dmesg24

Detail	Value
Duration	2.75 seconds
Hostname	shard-dg2-1
Igt-Version	IGT-Version: 2.4-gabf1b4463 (x86_64) (Linux: 7.1.0-rc3-CI_DRM_18486-ge54a14bbf920+ x86_64)
Out	Using IGT_SRANDOM=1778775837 for randomisation Opened device: /dev/dri/card0 Starting subtest: non-zero-reason Starting dynamic subtest: 0-rcs0 Stack trace: #0 ../lib/igt_core.c:2074 __igt_fail_assert() #1 ../tests/intel/perf.c:1232 gen8_sanity_check_test_oa_reports() #2 ../tests/intel/perf.c:3126 test_non_zero_reason() #3 ../tests/intel/perf.c:5955 __igt_unique____real_main5860() #4 ../tests/intel/perf.c:5860 main() #5 [__libc_init_first+0x8a] #6 [__libc_start_main+0x8b] #7 [_start+0x25] Dynamic subtest 0-rcs0: FAIL (2.749s) Subtest non-zero-reason: FAIL (2.750s)
Err	Starting subtest: non-zero-reason Starting dynamic subtest: 0-rcs0 [478.422116] (perf:6583) CRITICAL: Test assertion failure function gen8_sanity_check_test_oa_reports, file ../tests/intel/perf.c:1208: [478.422141] (perf:6583) CRITICAL: Failed assertion: b == clock_delta [478.422168] (perf:6583) CRITICAL: error: -639161 != 7986 Dynamic subtest 0-rcs0 failed. ** DEBUG [478.421980] (perf:6583) DEBUG: freq = 599 [478.421980] (perf:6583) DEBUG: clock delta = 7997 [478.421981] (perf:6583) DEBUG: A40_4: delta = 0 [478.421981] (perf:6583) DEBUG: A40_5: delta = 0 [478.421982] (perf:6583) DEBUG: A40_6: delta = 19 [478.421983] (perf:6583) DEBUG: A40_7: delta = 0 [478.421983] (perf:6583) DEBUG: A40_8: delta = 0 [478.421984] (perf:6583) DEBUG: A40_9: delta = 0 [478.421984] (perf:6583) DEBUG: A40_10: delta = 0 [478.421985] (perf:6583) DEBUG: A40_11: delta = 0 [478.421985] (perf:6583) DEBUG: A40_12: delta = 0 [478.421986] (perf:6583) DEBUG: A40_13: delta = 0 [478.421987] (perf:6583) DEBUG: A40_14: delta = 0 [478.421987] (perf:6583) DEBUG: A40_15: delta = 0 [478.421988] (perf:6583) DEBUG: A40_16: delta = 0 [478.421988] (perf:6583) DEBUG: A40_17: delta = 0 [478.421989] (perf:6583) DEBUG: A40_18: delta = 0 [478.421989] (perf:6583) DEBUG: A40_19: delta = 0 [478.421990] (perf:6583) DEBUG: A40_20: delta = 0 [478.421990] (perf:6583) DEBUG: A40_21: delta = 0 [478.421991] (perf:6583) DEBUG: A40_22: delta = 0 [478.421992] (perf:6583) DEBUG: A40_23: delta = 0 [478.421992] (perf:6583) DEBUG: A0: delta = 7997 [478.421993] (perf:6583) DEBUG: A1: delta = 0 [478.421993] (perf:6583) DEBUG: A2: delta = 0 [478.421994] (perf:6583) DEBUG: A3: delta = 0 [478.421994] (perf:6583) DEBUG: B0: delta = 0 [478.421995] (perf:6583) DEBUG: B1: delta = 7997 [478.421995] (perf:6583) DEBUG: B2: delta = 7997 [478.421996] (perf:6583) DEBUG: B3: delta = 3998 [478.421996] (perf:6583) DEBUG: B4: delta = 2666 [478.421997] (perf:6583) DEBUG: B5: delta = 2665 [478.421997] (perf:6583) DEBUG: B6: delta = 1333 [478.421998] (perf:6583) DEBUG: B7: delta = 5331 [478.421999] (perf:6583) DEBUG: C0: delta = 7997, max_delta=4094464 [478.421999] (perf:6583) DEBUG: C1: delta = 0, max_delta=4094464 [478.422000] (perf:6583) DEBUG: C2: delta = 0, max_delta=4094464 [478.422000] (perf:6583) DEBUG: C3: delta = 0, max_delta=4094464 [478.422001] (perf:6583) DEBUG: C4: delta = 0, max_delta=4094464 [478.422001] (perf:6583) DEBUG: C5: delta = 167, max_delta=4094464 [478.422002] (perf:6583) DEBUG: C6: delta = 7997, max_delta=4094464 [478.422003] (perf:6583) DEBUG: C7: delta = 166, max_delta=4094464 [478.422003] (perf:6583) DEBUG: report type: timer->timer [478.422004] (perf:6583) DEBUG: freq = 599 [478.422004] (perf:6583) DEBUG: clock delta = 7987 [478.422005] (perf:6583) DEBUG: A40_4: delta = 0 [478.422006] (perf:6583) DEBUG: A40_5: delta = 0 [478.422006] (perf:6583) DEBUG: A40_6: delta = 60 [478.422007] (perf:6583) DEBUG: A40_7: delta = 0 [478.422007] (perf:6583) DEBUG: A40_8: delta = 0 [478.422008] (perf:6583) DEBUG: A40_9: delta = 0 [478.422008] (perf:6583) DEBUG: A40_10: delta = 0 [478.422009] (perf:6583) DEBUG: A40_11: delta = 0 [478.422010] (perf:6583) DEBUG: A40_12: delta = 0 [478.422010] (perf:6583) DEBUG: A40_13: delta = 0 [478.422011] (perf:6583) DEBUG: A40_14: delta = 0 [478.422011] (perf:6583) DEBUG: A40_15: delta = 0 [478.422012] (perf:6583) DEBUG: A40_16: delta = 0 [478.422012] (perf:6583) DEBUG: A40_17: delta = 0 [478.422013] (perf:6583) DEBUG: A40_18: delta = 0 [478.422013] (perf:6583) DEBUG: A40_19: delta = 0 [478.422014] (perf:6583) DEBUG: A40_20: delta = 0 [478.422014] (perf:6583) DEBUG: A40_21: delta = 0 [478.422015] (perf:6583) DEBUG: A40_22: delta = 0 [478.422016] (perf:6583) DEBUG: A40_23: delta = 0 [478.422016] (perf:6583) DEBUG: A0: delta = 7987 [478.422017] (perf:6583) DEBUG: A1: delta = 0 [478.422017] (perf:6583) DEBUG: A2: delta = 0 [478.422018] (perf:6583) DEBUG: A3: delta = 0 [478.422018] (perf:6583) DEBUG: B0: delta = 0 [478.422019] (perf:6583) DEBUG: B1: delta = 7987 [478.422019] (perf:6583) DEBUG: B2: delta = 7987 [478.422020] (perf:6583) DEBUG: B3: delta = 3994 [478.422021] (perf:6583) DEBUG: B4: delta = 2662 [478.422021] (perf:6583) DEBUG: B5: delta = 2663 [478.422022] (perf:6583) DEBUG: B6: delta = 1331 [478.422022] (perf:6583) DEBUG: B7: delta = 5325 [478.422023] (perf:6583) DEBUG: C0: delta = 7987, max_delta=4089344 [478.422023] (perf:6583) DEBUG: C1: delta = 0, max_delta=4089344 [478.422024] (perf:6583) DEBUG: C2: delta = 0, max_delta=4089344 [478.422024] (perf:6583) DEBUG: C3: delta = 0, max_delta=4089344 [478.422025] (perf:6583) DEBUG: C4: delta = 0, max_delta=4089344 [478.422026] (perf:6583) DEBUG: C5: delta = 166, max_delta=4089344 [478.422026] (perf:6583) DEBUG: C6: delta = 7987, max_delta=4089344 [478.422027] (perf:6583) DEBUG: C7: delta = 167, max_delta=4089344 [478.422027] (perf:6583) DEBUG: report type: timer->timer [478.422028] (perf:6583) DEBUG: freq = 598 [478.422028] (perf:6583) DEBUG: clock delta = 7979 [478.422029] (perf:6583) DEBUG: A40_4: delta = 0 [478.422030] (perf:6583) DEBUG: A40_5: delta = 0 [478.422030] (perf:6583) DEBUG: A40_6: delta = 12 [478.422031] (perf:6583) DEBUG: A40_7: delta = 0 [478.422031] (perf:6583) DEBUG: A40_8: delta = 0 [478.422032] (perf:6583) DEBUG: A40_9: delta = 0 [478.422032] (perf:6583) DEBUG: A40_10: delta = 0 [478.422033] (perf:6583) DEBUG: A40_11: delta = 0 [478.422034] (perf:6583) DEBUG: A40_12: delta = 0 [478.422034] (perf:6583) DEBUG: A40_13: delta = 0 [478.422035] (perf:6583) DEBUG: A40_14: delta = 0 [478.422035] (perf:6583) DEBUG: A40_15: delta = 0 [478.422036] (perf:6583) DEBUG: A40_16: delta = 0 [478.422036] (perf:6583) DEBUG: A40_17: delta = 0 [478.422037] (perf:6583) DEBUG: A40_18: delta = 0 [478.422037] (perf:6583) DEBUG: A40_19: delta = 0 [478.422038] (perf:6583) DEBUG: A40_20: delta = 0 [478.422039] (perf:6583) DEBUG: A40_21: delta = 0 [478.422039] (perf:6583) DEBUG: A40_22: delta = 0 [478.422040] (perf:6583) DEBUG: A40_23: delta = 0 [478.422040] (perf:6583) DEBUG: A0: delta = 7979 [478.422041] (perf:6583) DEBUG: A1: delta = 0 [478.422041] (perf:6583) DEBUG: A2: delta = 0 [478.422042] (perf:6583) DEBUG: A3: delta = 0 [478.422042] (perf:6583) DEBUG: B0: delta = 0 [478.422043] (perf:6583) DEBUG: B1: delta = 7979 [478.422043] (perf:6583) DEBUG: B2: delta = 7979 [478.422044] (perf:6583) DEBUG: B3: delta = 3989 [478.422045] (perf:6583) DEBUG: B4: delta = 2660 [478.422045] (perf:6583) DEBUG: B5: delta = 2659 [478.422046] (perf:6583) DEBUG: B6: delta = 1330 [478.422046] (perf:6583) DEBUG: B7: delta = 5319 [478.422047] (perf:6583) DEBUG: C0: delta = 7979, max_delta=4085248 [478.422047] (perf:6583) DEBUG: C1: delta = 0, max_delta=4085248 [478.422048] (perf:6583) DEBUG: C2: delta = 0, max_delta=4085248 [478.422048] (perf:6583) DEBUG: C3: delta = 0, max_delta=4085248 [478.422049] (perf:6583) DEBUG: C4: delta = 0, max_delta=4085248 [478.422050] (perf:6583) DEBUG: C5: delta = 166, max_delta=4085248 [478.422050] (perf:6583) DEBUG: C6: delta = 7979, max_delta=4085248 [478.422051] (perf:6583) DEBUG: C7: delta = 166, max_delta=4085248 [478.422051] (perf:6583) DEBUG: report type: timer->timer [478.422052] (perf:6583) DEBUG: freq = 597 [478.422053] (perf:6583) DEBUG: clock delta = 7971 [478.422053] (perf:6583) DEBUG: A40_4: delta = 0 [478.422054] (perf:6583) DEBUG: A40_5: delta = 0 [478.422054] (perf:6583) DEBUG: A40_6: delta = 70 [478.422055] (perf:6583) DEBUG: A40_7: delta = 0 [478.422055] (perf:6583) DEBUG: A40_8: delta = 0 [478.422056] (perf:6583) DEBUG: A40_9: delta = 0 [478.422056] (perf:6583) DEBUG: A40_10: delta = 0 [478.422057] (perf:6583) DEBUG: A40_11: delta = 0 [478.422058] (perf:6583) DEBUG: A40_12: delta = 0 [478.422058] (perf:6583) DEBUG: A40_13: delta = 0 [478.422059] (perf:6583) DEBUG: A40_14: delta = 0 [478.422059] (perf:6583) DEBUG: A40_15: delta = 0 [478.422060] (perf:6583) DEBUG: A40_16: delta = 0 [478.422060] (perf:6583) DEBUG: A40_17: delta = 0 [478.422061] (perf:6583) DEBUG: A40_18: delta = 0 [478.422061] (perf:6583) DEBUG: A40_19: delta = 0 [478.422062] (perf:6583) DEBUG: A40_20: delta = 0 [478.422063] (perf:6583) DEBUG: A40_21: delta = 0 [478.422063] (perf:6583) DEBUG: A40_22: delta = 0 [478.422064] (perf:6583) DEBUG: A40_23: delta = 0 [478.422064] (perf:6583) DEBUG: A0: delta = 7971 [478.422065] (perf:6583) DEBUG: A1: delta = 0 [478.422065] (perf:6583) DEBUG: A2: delta = 0 [478.422066] (perf:6583) DEBUG: A3: delta = 0 [478.422066] (perf:6583) DEBUG: B0: delta = 0 [478.422067] (perf:6583) DEBUG: B1: delta = 7971 [478.422068] (perf:6583) DEBUG: B2: delta = 7971 [478.422068] (perf:6583) DEBUG: B3: delta = 3986 [478.422069] (perf:6583) DEBUG: B4: delta = 2657 [478.422069] (perf:6583) DEBUG: B5: delta = 2657 [478.422070] (perf:6583) DEBUG: B6: delta = 1328 [478.422070] (perf:6583) DEBUG: B7: delta = 5314 [478.422071] (perf:6583) DEBUG: C0: delta = 7971, max_delta=4081152 [478.422071] (perf:6583) DEBUG: C1: delta = 0, max_delta=4081152 [478.422072] (perf:6583) DEBUG: C2: delta = 0, max_delta=4081152 [478.422073] (perf:6583) DEBUG: C3: delta = 0, max_delta=4081152 [478.422073] (perf:6583) DEBUG: C4: delta = 0, max_delta=4081152 [478.422074] (perf:6583) DEBUG: C5: delta = 166, max_delta=4081152 [478.422074] (perf:6583) DEBUG: C6: delta = 7971, max_delta=4081152 [478.422075] (perf:6583) DEBUG: C7: delta = 166, max_delta=4081152 [478.422075] (perf:6583) DEBUG: report type: timer->timer [478.422076] (perf:6583) DEBUG: freq = 598 [478.422077] (perf:6583) DEBUG: clock delta = 7978 [478.422077] (perf:6583) DEBUG: A40_4: delta = 0 [478.422078] (perf:6583) DEBUG: A40_5: delta = 0 [478.422078] (perf:6583) DEBUG: A40_6: delta = 70 [478.422079] (perf:6583) DEBUG: A40_7: delta = 0 [478.422079] (perf:6583) DEBUG: A40_8: delta = 0 [478.422080] (perf:6583) DEBUG: A40_9: delta = 0 [478.422081] (perf:6583) DEBUG: A40_10: delta = 0 [478.422081] (perf:6583) DEBUG: A40_11: delta = 0 [478.422082] (perf:6583) DEBUG: A40_12: delta = 0 [478.422082] (perf:6583) DEBUG: A40_13: delta = 0 [478.422083] (perf:6583) DEBUG: A40_14: delta = 0 [478.422083] (perf:6583) DEBUG: A40_15: delta = 0 [478.422084] (perf:6583) DEBUG: A40_16: delta = 0 [478.422084] (perf:6583) DEBUG: A40_17: delta = 0 [478.422085] (perf:6583) DEBUG: A40_18: delta = 0 [478.422086] (perf:6583) DEBUG: A40_19: delta = 0 [478.422086] (perf:6583) DEBUG: A40_20: delta = 0 [478.422087] (perf:6583) DEBUG: A40_21: delta = 0 [478.422087] (perf:6583) DEBUG: A40_22: delta = 0 [478.422088] (perf:6583) DEBUG: A40_23: delta = 0 [478.422088] (perf:6583) DEBUG: A0: delta = 7978 [478.422089] (perf:6583) DEBUG: A1: delta = 0 [478.422089] (perf:6583) DEBUG: A2: delta = 0 [478.422090] (perf:6583) DEBUG: A3: delta = 0 [478.422091] (perf:6583) DEBUG: B0: delta = 0 [478.422091] (perf:6583) DEBUG: B1: delta = 7978 [478.422092] (perf:6583) DEBUG: B2: delta = 7978 [478.422092] (perf:6583) DEBUG: B3: delta = 3989 [478.422093] (perf:6583) DEBUG: B4: delta = 2659 [478.422093] (perf:6583) DEBUG: B5: delta = 2660 [478.422094] (perf:6583) DEBUG: B6: delta = 1330 [478.422094] (perf:6583) DEBUG: B7: delta = 5319 [478.422095] (perf:6583) DEBUG: C0: delta = 7978, max_delta=4084736 [478.422095] (perf:6583) DEBUG: C1: delta = 0, max_delta=4084736 [478.422096] (perf:6583) DEBUG: C2: delta = 0, max_delta=4084736 [478.422097] (perf:6583) DEBUG: C3: delta = 0, max_delta=4084736 [478.422097] (perf:6583) DEBUG: C4: delta = 0, max_delta=4084736 [478.422098] (perf:6583) DEBUG: C5: delta = 166, max_delta=4084736 [478.422098] (perf:6583) DEBUG: C6: delta = 7978, max_delta=4084736 [478.422099] (perf:6583) DEBUG: C7: delta = 166, max_delta=4084736 [478.422100] (perf:6583) DEBUG: report type: timer->timer [478.422100] (perf:6583) DEBUG: freq = 598 [478.422101] (perf:6583) DEBUG: clock delta = 7986 [478.422101] (perf:6583) DEBUG: A40_4: delta = 0 [478.422102] (perf:6583) DEBUG: A40_5: delta = 0 [478.422102] (perf:6583) DEBUG: A40_6: delta = 24 [478.422103] (perf:6583) DEBUG: A40_7: delta = 0 [478.422104] (perf:6583) DEBUG: A40_8: delta = 0 [478.422104] (perf:6583) DEBUG: A40_9: delta = 0 [478.422105] (perf:6583) DEBUG: A40_10: delta = 0 [478.422105] (perf:6583) DEBUG: A40_11: delta = 0 [478.422106] (perf:6583) DEBUG: A40_12: delta = 0 [478.422106] (perf:6583) DEBUG: A40_13: delta = 0 [478.422107] (perf:6583) DEBUG: A40_14: delta = 0 [478.422108] (perf:6583) DEBUG: A40_15: delta = 0 [478.422108] (perf:6583) DEBUG: A40_16: delta = 0 [478.422109] (perf:6583) DEBUG: A40_17: delta = 0 [478.422109] (perf:6583) DEBUG: A40_18: delta = 0 [478.422110] (perf:6583) DEBUG: A40_19: delta = 0 [478.422110] (perf:6583) DEBUG: A40_20: delta = 0 [478.422111] (perf:6583) DEBUG: A40_21: delta = 0 [478.422111] (perf:6583) DEBUG: A40_22: delta = 0 [478.422112] (perf:6583) DEBUG: A40_23: delta = 0 [478.422113] (perf:6583) DEBUG: A0: delta = 7986 [478.422113] (perf:6583) DEBUG: A1: delta = 0 [478.422114] (perf:6583) DEBUG: A2: delta = 0 [478.422114] (perf:6583) DEBUG: A3: delta = 0 [478.422115] (perf:6583) DEBUG: B0: delta = 0 [478.422115] (perf:6583) DEBUG: B1: delta = 4294328135 [478.422116] (perf:6583) CRITICAL: Test assertion failure function gen8_sanity_check_test_oa_reports, file ../tests/intel/perf.c:1208: [478.422141] (perf:6583) CRITICAL: Failed assertion: b == clock_delta [478.422168] (perf:6583) CRITICAL: error: -639161 != 7986 [478.424500] (perf:6583) igt_core-INFO: Stack trace: [478.433222] (perf:6583) igt_core-INFO: #0 ../lib/igt_core.c:2074 __igt_fail_assert() [478.435553] (perf:6583) igt_core-INFO: #1 ../tests/intel/perf.c:1232 gen8_sanity_check_test_oa_reports() [478.435594] (perf:6583) igt_core-INFO: #2 ../tests/intel/perf.c:3126 test_non_zero_reason() [478.435615] (perf:6583) igt_core-INFO: #3 ../tests/intel/perf.c:5955 __igt_unique____real_main5860() [478.435638] (perf:6583) igt_core-INFO: #4 ../tests/intel/perf.c:5860 main() [478.438992] (perf:6583) igt_core-INFO: #5 [__libc_init_first+0x8a] [478.439794] (perf:6583) igt_core-INFO: #6 [__libc_start_main+0x8b] [478.439998] (perf:6583) igt_core-INFO: #7 [_start+0x25] END ** Dynamic subtest 0-rcs0: FAIL (2.749s) Subtest non-zero-reason: FAIL (2.750s)
Dmesg	<6> [475.656117] Console: switching to colour dummy device 80x25 <6> [475.656678] [IGT] perf: executing <6> [475.672020] Console: switching to colour frame buffer device 240x67 <7> [475.721111] i915 0000:03:00.0: [drm:i915_gem_open [i915]] <7> [475.723062] i915 0000:03:00.0: [drm:i915_gem_open [i915]] <6> [475.827922] [IGT] perf: starting subtest non-zero-reason <6> [475.828579] [IGT] perf: starting dynamic subtest 0-rcs0 <7> [475.829218] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509 <7> [475.912148] i915 0000:03:00.0: [drm:i915_oa_stream_init.isra.0 [i915]] opening stream oa config uuid=7389b9c9-de73-468d-83a8-b27776215e6b <5> [475.914966] i915 0000:03:00.0: [drm] unlanded report(s) head=0x5500 tail=0x5500 hw_tail=0x5900 <5> [475.915005] i915 0000:03:00.0: [drm] unlanded report(s) head=0x5500 tail=0x5b00 hw_tail=0x5d00 <5> [475.915087] i915 0000:03:00.0: [drm] unlanded report(s) head=0x5f00 tail=0x6200 hw_tail=0x6400 <5> [475.915128] i915 0000:03:00.0: [drm] unlanded report(s) head=0x6200 tail=0x6500 hw_tail=0x6700 <5> [475.915168] i915 0000:03:00.0: [drm] unlanded report(s) head=0x6500 tail=0x6700 hw_tail=0x6a00 <5> [475.915244] i915 0000:03:00.0: [drm] unlanded report(s) head=0x6b00 tail=0x6d00 hw_tail=0x6f00 <5> [475.915287] i915 0000:03:00.0: [drm] unlanded report(s) head=0x6d00 tail=0x6f00 hw_tail=0x7300 <5> [475.915509] i915 0000:03:00.0: [drm] unlanded report(s) head=0x6f00 tail=0x8100 hw_tail=0x8300 <5> [475.915559] i915 0000:03:00.0: [drm] unlanded report(s) head=0x8100 tail=0x8500 hw_tail=0x8700 <5> [475.915599] i915 0000:03:00.0: [drm] unlanded report(s) head=0x8500 tail=0x8500 hw_tail=0x8a00 <6> [478.578178] [IGT] perf: finished subtest 0-rcs0, FAIL <6> [478.578941] [IGT] perf: finished subtest non-zero-reason, FAIL <7> [478.588699] i915 0000:03:00.0: [drm:drm_client_dev_restore] fbdev: ret=0 <6> [478.589157] [IGT] perf: exiting, ret=98

Created at 2026-05-14 22:52:05