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

Result: Fail

git-log-oneline i915_display_info2 igt_runner2 runtimes2 results2.json results2-i915-load.json guc_logs2.tar i915_display_info_post_exec2 boot2 dmesg2

Detail	Value
Duration	2.76 seconds
Hostname	shard-dg2-5
Igt-Version	IGT-Version: 2.4-g9187799ba (x86_64) (Linux: 7.1.0-rc3-CI_DRM_18484-g21b42374be17+ x86_64)
Out	Using IGT_SRANDOM=1778750597 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.757s) Subtest non-zero-reason: FAIL (2.758s)
Err	Starting subtest: non-zero-reason Starting dynamic subtest: 0-rcs0 [357.641933] (perf:2384) CRITICAL: Test assertion failure function gen8_sanity_check_test_oa_reports, file ../tests/intel/perf.c:1208: [357.641957] (perf:2384) CRITICAL: Failed assertion: b == clock_delta [357.641969] (perf:2384) CRITICAL: error: -701698 != 9327 Dynamic subtest 0-rcs0 failed. ** DEBUG [357.641793] (perf:2384) DEBUG: freq = 698 [357.641794] (perf:2384) DEBUG: clock delta = 9308 [357.641794] (perf:2384) DEBUG: A40_4: delta = 0 [357.641795] (perf:2384) DEBUG: A40_5: delta = 0 [357.641796] (perf:2384) DEBUG: A40_6: delta = 77 [357.641796] (perf:2384) DEBUG: A40_7: delta = 0 [357.641797] (perf:2384) DEBUG: A40_8: delta = 0 [357.641797] (perf:2384) DEBUG: A40_9: delta = 0 [357.641798] (perf:2384) DEBUG: A40_10: delta = 0 [357.641798] (perf:2384) DEBUG: A40_11: delta = 0 [357.641799] (perf:2384) DEBUG: A40_12: delta = 0 [357.641800] (perf:2384) DEBUG: A40_13: delta = 0 [357.641800] (perf:2384) DEBUG: A40_14: delta = 0 [357.641801] (perf:2384) DEBUG: A40_15: delta = 0 [357.641801] (perf:2384) DEBUG: A40_16: delta = 0 [357.641802] (perf:2384) DEBUG: A40_17: delta = 0 [357.641802] (perf:2384) DEBUG: A40_18: delta = 0 [357.641803] (perf:2384) DEBUG: A40_19: delta = 0 [357.641804] (perf:2384) DEBUG: A40_20: delta = 0 [357.641804] (perf:2384) DEBUG: A40_21: delta = 0 [357.641805] (perf:2384) DEBUG: A40_22: delta = 0 [357.641805] (perf:2384) DEBUG: A40_23: delta = 0 [357.641806] (perf:2384) DEBUG: A0: delta = 9308 [357.641806] (perf:2384) DEBUG: A1: delta = 0 [357.641807] (perf:2384) DEBUG: A2: delta = 0 [357.641807] (perf:2384) DEBUG: A3: delta = 0 [357.641808] (perf:2384) DEBUG: B0: delta = 0 [357.641809] (perf:2384) DEBUG: B1: delta = 9308 [357.641809] (perf:2384) DEBUG: B2: delta = 9308 [357.641810] (perf:2384) DEBUG: B3: delta = 4654 [357.641810] (perf:2384) DEBUG: B4: delta = 3103 [357.641811] (perf:2384) DEBUG: B5: delta = 3102 [357.641811] (perf:2384) DEBUG: B6: delta = 1551 [357.641812] (perf:2384) DEBUG: B7: delta = 6205 [357.641812] (perf:2384) DEBUG: C0: delta = 9308, max_delta=4765696 [357.641813] (perf:2384) DEBUG: C1: delta = 0, max_delta=4765696 [357.641814] (perf:2384) DEBUG: C2: delta = 193, max_delta=4765696 [357.641814] (perf:2384) DEBUG: C3: delta = 0, max_delta=4765696 [357.641815] (perf:2384) DEBUG: C4: delta = 9308, max_delta=4765696 [357.641815] (perf:2384) DEBUG: C5: delta = 0, max_delta=4765696 [357.641816] (perf:2384) DEBUG: C6: delta = 0, max_delta=4765696 [357.641817] (perf:2384) DEBUG: C7: delta = 0, max_delta=4765696 [357.641817] (perf:2384) DEBUG: report type: timer->timer [357.641818] (perf:2384) DEBUG: freq = 697 [357.641818] (perf:2384) DEBUG: clock delta = 9299 [357.641819] (perf:2384) DEBUG: A40_4: delta = 0 [357.641820] (perf:2384) DEBUG: A40_5: delta = 0 [357.641820] (perf:2384) DEBUG: A40_6: delta = 49 [357.641821] (perf:2384) DEBUG: A40_7: delta = 0 [357.641821] (perf:2384) DEBUG: A40_8: delta = 0 [357.641822] (perf:2384) DEBUG: A40_9: delta = 0 [357.641822] (perf:2384) DEBUG: A40_10: delta = 0 [357.641823] (perf:2384) DEBUG: A40_11: delta = 0 [357.641824] (perf:2384) DEBUG: A40_12: delta = 0 [357.641824] (perf:2384) DEBUG: A40_13: delta = 0 [357.641825] (perf:2384) DEBUG: A40_14: delta = 0 [357.641825] (perf:2384) DEBUG: A40_15: delta = 0 [357.641826] (perf:2384) DEBUG: A40_16: delta = 0 [357.641826] (perf:2384) DEBUG: A40_17: delta = 0 [357.641827] (perf:2384) DEBUG: A40_18: delta = 0 [357.641828] (perf:2384) DEBUG: A40_19: delta = 0 [357.641828] (perf:2384) DEBUG: A40_20: delta = 0 [357.641829] (perf:2384) DEBUG: A40_21: delta = 0 [357.641829] (perf:2384) DEBUG: A40_22: delta = 0 [357.641830] (perf:2384) DEBUG: A40_23: delta = 0 [357.641830] (perf:2384) DEBUG: A0: delta = 9299 [357.641831] (perf:2384) DEBUG: A1: delta = 0 [357.641832] (perf:2384) DEBUG: A2: delta = 0 [357.641832] (perf:2384) DEBUG: A3: delta = 0 [357.641833] (perf:2384) DEBUG: B0: delta = 0 [357.641833] (perf:2384) DEBUG: B1: delta = 9299 [357.641834] (perf:2384) DEBUG: B2: delta = 9299 [357.641834] (perf:2384) DEBUG: B3: delta = 4650 [357.641835] (perf:2384) DEBUG: B4: delta = 3099 [357.641835] (perf:2384) DEBUG: B5: delta = 3100 [357.641836] (perf:2384) DEBUG: B6: delta = 1550 [357.641836] (perf:2384) DEBUG: B7: delta = 6199 [357.641837] (perf:2384) DEBUG: C0: delta = 9299, max_delta=4761088 [357.641838] (perf:2384) DEBUG: C1: delta = 0, max_delta=4761088 [357.641838] (perf:2384) DEBUG: C2: delta = 194, max_delta=4761088 [357.641839] (perf:2384) DEBUG: C3: delta = 0, max_delta=4761088 [357.641839] (perf:2384) DEBUG: C4: delta = 9299, max_delta=4761088 [357.641840] (perf:2384) DEBUG: C5: delta = 0, max_delta=4761088 [357.641841] (perf:2384) DEBUG: C6: delta = 0, max_delta=4761088 [357.641841] (perf:2384) DEBUG: C7: delta = 0, max_delta=4761088 [357.641842] (perf:2384) DEBUG: report type: timer->timer [357.641842] (perf:2384) DEBUG: freq = 698 [357.641843] (perf:2384) DEBUG: clock delta = 9309 [357.641844] (perf:2384) DEBUG: A40_4: delta = 0 [357.641844] (perf:2384) DEBUG: A40_5: delta = 0 [357.641845] (perf:2384) DEBUG: A40_6: delta = 18 [357.641845] (perf:2384) DEBUG: A40_7: delta = 0 [357.641846] (perf:2384) DEBUG: A40_8: delta = 0 [357.641846] (perf:2384) DEBUG: A40_9: delta = 0 [357.641847] (perf:2384) DEBUG: A40_10: delta = 0 [357.641848] (perf:2384) DEBUG: A40_11: delta = 0 [357.641848] (perf:2384) DEBUG: A40_12: delta = 0 [357.641849] (perf:2384) DEBUG: A40_13: delta = 0 [357.641849] (perf:2384) DEBUG: A40_14: delta = 0 [357.641850] (perf:2384) DEBUG: A40_15: delta = 0 [357.641850] (perf:2384) DEBUG: A40_16: delta = 0 [357.641851] (perf:2384) DEBUG: A40_17: delta = 0 [357.641852] (perf:2384) DEBUG: A40_18: delta = 0 [357.641852] (perf:2384) DEBUG: A40_19: delta = 0 [357.641853] (perf:2384) DEBUG: A40_20: delta = 0 [357.641853] (perf:2384) DEBUG: A40_21: delta = 0 [357.641854] (perf:2384) DEBUG: A40_22: delta = 0 [357.641854] (perf:2384) DEBUG: A40_23: delta = 0 [357.641855] (perf:2384) DEBUG: A0: delta = 9309 [357.641856] (perf:2384) DEBUG: A1: delta = 0 [357.641856] (perf:2384) DEBUG: A2: delta = 0 [357.641857] (perf:2384) DEBUG: A3: delta = 0 [357.641857] (perf:2384) DEBUG: B0: delta = 0 [357.641858] (perf:2384) DEBUG: B1: delta = 9309 [357.641858] (perf:2384) DEBUG: B2: delta = 9309 [357.641859] (perf:2384) DEBUG: B3: delta = 4654 [357.641860] (perf:2384) DEBUG: B4: delta = 3103 [357.641860] (perf:2384) DEBUG: B5: delta = 3103 [357.641861] (perf:2384) DEBUG: B6: delta = 1551 [357.641861] (perf:2384) DEBUG: B7: delta = 6207 [357.641862] (perf:2384) DEBUG: C0: delta = 9309, max_delta=4766208 [357.641862] (perf:2384) DEBUG: C1: delta = 0, max_delta=4766208 [357.641863] (perf:2384) DEBUG: C2: delta = 194, max_delta=4766208 [357.641864] (perf:2384) DEBUG: C3: delta = 0, max_delta=4766208 [357.641864] (perf:2384) DEBUG: C4: delta = 9309, max_delta=4766208 [357.641865] (perf:2384) DEBUG: C5: delta = 0, max_delta=4766208 [357.641865] (perf:2384) DEBUG: C6: delta = 0, max_delta=4766208 [357.641866] (perf:2384) DEBUG: C7: delta = 0, max_delta=4766208 [357.641867] (perf:2384) DEBUG: report type: timer->timer [357.641867] (perf:2384) DEBUG: freq = 698 [357.641868] (perf:2384) DEBUG: clock delta = 9318 [357.641868] (perf:2384) DEBUG: A40_4: delta = 0 [357.641869] (perf:2384) DEBUG: A40_5: delta = 0 [357.641869] (perf:2384) DEBUG: A40_6: delta = 72 [357.641870] (perf:2384) DEBUG: A40_7: delta = 0 [357.641871] (perf:2384) DEBUG: A40_8: delta = 0 [357.641871] (perf:2384) DEBUG: A40_9: delta = 0 [357.641872] (perf:2384) DEBUG: A40_10: delta = 0 [357.641872] (perf:2384) DEBUG: A40_11: delta = 0 [357.641873] (perf:2384) DEBUG: A40_12: delta = 0 [357.641873] (perf:2384) DEBUG: A40_13: delta = 0 [357.641874] (perf:2384) DEBUG: A40_14: delta = 0 [357.641875] (perf:2384) DEBUG: A40_15: delta = 0 [357.641875] (perf:2384) DEBUG: A40_16: delta = 0 [357.641876] (perf:2384) DEBUG: A40_17: delta = 0 [357.641876] (perf:2384) DEBUG: A40_18: delta = 0 [357.641877] (perf:2384) DEBUG: A40_19: delta = 0 [357.641877] (perf:2384) DEBUG: A40_20: delta = 0 [357.641878] (perf:2384) DEBUG: A40_21: delta = 0 [357.641879] (perf:2384) DEBUG: A40_22: delta = 0 [357.641879] (perf:2384) DEBUG: A40_23: delta = 0 [357.641880] (perf:2384) DEBUG: A0: delta = 9318 [357.641880] (perf:2384) DEBUG: A1: delta = 0 [357.641881] (perf:2384) DEBUG: A2: delta = 0 [357.641881] (perf:2384) DEBUG: A3: delta = 0 [357.641882] (perf:2384) DEBUG: B0: delta = 0 [357.641883] (perf:2384) DEBUG: B1: delta = 9318 [357.641883] (perf:2384) DEBUG: B2: delta = 9318 [357.641884] (perf:2384) DEBUG: B3: delta = 4659 [357.641884] (perf:2384) DEBUG: B4: delta = 3106 [357.641885] (perf:2384) DEBUG: B5: delta = 3106 [357.641885] (perf:2384) DEBUG: B6: delta = 1553 [357.641886] (perf:2384) DEBUG: B7: delta = 6212 [357.641886] (perf:2384) DEBUG: C0: delta = 9318, max_delta=4770816 [357.641887] (perf:2384) DEBUG: C1: delta = 0, max_delta=4770816 [357.641888] (perf:2384) DEBUG: C2: delta = 194, max_delta=4770816 [357.641888] (perf:2384) DEBUG: C3: delta = 0, max_delta=4770816 [357.641889] (perf:2384) DEBUG: C4: delta = 9318, max_delta=4770816 [357.641889] (perf:2384) DEBUG: C5: delta = 0, max_delta=4770816 [357.641890] (perf:2384) DEBUG: C6: delta = 0, max_delta=4770816 [357.641891] (perf:2384) DEBUG: C7: delta = 0, max_delta=4770816 [357.641891] (perf:2384) DEBUG: report type: timer->timer [357.641892] (perf:2384) DEBUG: freq = 699 [357.641892] (perf:2384) DEBUG: clock delta = 9328 [357.641893] (perf:2384) DEBUG: A40_4: delta = 0 [357.641894] (perf:2384) DEBUG: A40_5: delta = 0 [357.641894] (perf:2384) DEBUG: A40_6: delta = 28 [357.641895] (perf:2384) DEBUG: A40_7: delta = 0 [357.641895] (perf:2384) DEBUG: A40_8: delta = 0 [357.641896] (perf:2384) DEBUG: A40_9: delta = 0 [357.641896] (perf:2384) DEBUG: A40_10: delta = 0 [357.641897] (perf:2384) DEBUG: A40_11: delta = 0 [357.641898] (perf:2384) DEBUG: A40_12: delta = 0 [357.641898] (perf:2384) DEBUG: A40_13: delta = 0 [357.641899] (perf:2384) DEBUG: A40_14: delta = 0 [357.641899] (perf:2384) DEBUG: A40_15: delta = 0 [357.641900] (perf:2384) DEBUG: A40_16: delta = 0 [357.641900] (perf:2384) DEBUG: A40_17: delta = 0 [357.641901] (perf:2384) DEBUG: A40_18: delta = 0 [357.641902] (perf:2384) DEBUG: A40_19: delta = 0 [357.641902] (perf:2384) DEBUG: A40_20: delta = 0 [357.641903] (perf:2384) DEBUG: A40_21: delta = 0 [357.641903] (perf:2384) DEBUG: A40_22: delta = 0 [357.641904] (perf:2384) DEBUG: A40_23: delta = 0 [357.641904] (perf:2384) DEBUG: A0: delta = 9328 [357.641905] (perf:2384) DEBUG: A1: delta = 0 [357.641906] (perf:2384) DEBUG: A2: delta = 0 [357.641906] (perf:2384) DEBUG: A3: delta = 0 [357.641907] (perf:2384) DEBUG: B0: delta = 0 [357.641907] (perf:2384) DEBUG: B1: delta = 9328 [357.641908] (perf:2384) DEBUG: B2: delta = 9328 [357.641908] (perf:2384) DEBUG: B3: delta = 4664 [357.641909] (perf:2384) DEBUG: B4: delta = 3110 [357.641909] (perf:2384) DEBUG: B5: delta = 3109 [357.641910] (perf:2384) DEBUG: B6: delta = 1555 [357.641910] (perf:2384) DEBUG: B7: delta = 6218 [357.641911] (perf:2384) DEBUG: C0: delta = 9328, max_delta=4775936 [357.641912] (perf:2384) DEBUG: C1: delta = 0, max_delta=4775936 [357.641912] (perf:2384) DEBUG: C2: delta = 195, max_delta=4775936 [357.641913] (perf:2384) DEBUG: C3: delta = 0, max_delta=4775936 [357.641913] (perf:2384) DEBUG: C4: delta = 9328, max_delta=4775936 [357.641914] (perf:2384) DEBUG: C5: delta = 0, max_delta=4775936 [357.641915] (perf:2384) DEBUG: C6: delta = 0, max_delta=4775936 [357.641915] (perf:2384) DEBUG: C7: delta = 0, max_delta=4775936 [357.641916] (perf:2384) DEBUG: report type: timer->timer [357.641916] (perf:2384) DEBUG: freq = 699 [357.641917] (perf:2384) DEBUG: clock delta = 9327 [357.641918] (perf:2384) DEBUG: A40_4: delta = 0 [357.641918] (perf:2384) DEBUG: A40_5: delta = 0 [357.641919] (perf:2384) DEBUG: A40_6: delta = 47 [357.641919] (perf:2384) DEBUG: A40_7: delta = 0 [357.641920] (perf:2384) DEBUG: A40_8: delta = 0 [357.641920] (perf:2384) DEBUG: A40_9: delta = 0 [357.641921] (perf:2384) DEBUG: A40_10: delta = 0 [357.641922] (perf:2384) DEBUG: A40_11: delta = 0 [357.641922] (perf:2384) DEBUG: A40_12: delta = 0 [357.641923] (perf:2384) DEBUG: A40_13: delta = 0 [357.641923] (perf:2384) DEBUG: A40_14: delta = 0 [357.641924] (perf:2384) DEBUG: A40_15: delta = 0 [357.641924] (perf:2384) DEBUG: A40_16: delta = 0 [357.641925] (perf:2384) DEBUG: A40_17: delta = 0 [357.641926] (perf:2384) DEBUG: A40_18: delta = 0 [357.641926] (perf:2384) DEBUG: A40_19: delta = 0 [357.641927] (perf:2384) DEBUG: A40_20: delta = 0 [357.641927] (perf:2384) DEBUG: A40_21: delta = 0 [357.641928] (perf:2384) DEBUG: A40_22: delta = 0 [357.641928] (perf:2384) DEBUG: A40_23: delta = 0 [357.641929] (perf:2384) DEBUG: A0: delta = 9327 [357.641930] (perf:2384) DEBUG: A1: delta = 0 [357.641930] (perf:2384) DEBUG: A2: delta = 0 [357.641931] (perf:2384) DEBUG: A3: delta = 0 [357.641931] (perf:2384) DEBUG: B0: delta = 0 [357.641932] (perf:2384) DEBUG: B1: delta = 4294265598 [357.641933] (perf:2384) CRITICAL: Test assertion failure function gen8_sanity_check_test_oa_reports, file ../tests/intel/perf.c:1208: [357.641957] (perf:2384) CRITICAL: Failed assertion: b == clock_delta [357.641969] (perf:2384) CRITICAL: error: -701698 != 9327 [357.643982] (perf:2384) igt_core-INFO: Stack trace: [357.647476] (perf:2384) igt_core-INFO: #0 ../lib/igt_core.c:2074 __igt_fail_assert() [357.649140] (perf:2384) igt_core-INFO: #1 ../tests/intel/perf.c:1232 gen8_sanity_check_test_oa_reports() [357.649179] (perf:2384) igt_core-INFO: #2 ../tests/intel/perf.c:3126 test_non_zero_reason() [357.649200] (perf:2384) igt_core-INFO: #3 ../tests/intel/perf.c:5955 __igt_unique____real_main5860() [357.649223] (perf:2384) igt_core-INFO: #4 ../tests/intel/perf.c:5860 main() [357.653655] (perf:2384) igt_core-INFO: #5 [__libc_init_first+0x8a] [357.654388] (perf:2384) igt_core-INFO: #6 [__libc_start_main+0x8b] [357.654691] (perf:2384) igt_core-INFO: #7 [_start+0x25] END ** Dynamic subtest 0-rcs0: FAIL (2.757s) Subtest non-zero-reason: FAIL (2.758s)
Dmesg	<6> [354.869443] Console: switching to colour dummy device 80x25 <6> [354.869843] [IGT] perf: executing <6> [354.880585] Console: switching to colour frame buffer device 240x67 <7> [354.929526] i915 0000:03:00.0: [drm:i915_gem_open [i915]] <7> [354.931836] i915 0000:03:00.0: [drm:i915_gem_open [i915]] <6> [355.030361] [IGT] perf: starting subtest non-zero-reason <6> [355.030805] [IGT] perf: starting dynamic subtest 0-rcs0 <7> [355.031481] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509 <7> [355.125751] i915 0000:03:00.0: [drm:i915_oa_stream_init.isra.0 [i915]] opening stream oa config uuid=7389b9c9-de73-468d-83a8-b27776215e6b <5> [355.127818] i915 0000:03:00.0: [drm] unlanded report(s) head=0x0 tail=0xe00 hw_tail=0x1100 <5> [355.128592] i915 0000:03:00.0: [drm] unlanded report(s) head=0x4a00 tail=0x4b00 hw_tail=0x4e00 <5> [355.128631] i915 0000:03:00.0: [drm] unlanded report(s) head=0x4b00 tail=0x4f00 hw_tail=0x5100 <5> [355.128711] i915 0000:03:00.0: [drm] unlanded report(s) head=0x5300 tail=0x5500 hw_tail=0x5700 <5> [355.128821] i915 0000:03:00.0: [drm] unlanded report(s) head=0x5b00 tail=0x5d00 hw_tail=0x5f00 <5> [355.128859] i915 0000:03:00.0: [drm] unlanded report(s) head=0x5d00 tail=0x5d00 hw_tail=0x6200 <5> [355.128938] i915 0000:03:00.0: [drm] unlanded report(s) head=0x6400 tail=0x6600 hw_tail=0x6800 <5> [355.129101] i915 0000:03:00.0: [drm] unlanded report(s) head=0x7000 tail=0x7100 hw_tail=0x7400 <5> [355.129139] i915 0000:03:00.0: [drm] unlanded report(s) head=0x7100 tail=0x7400 hw_tail=0x7700 <5> [355.129216] i915 0000:03:00.0: [drm] unlanded report(s) head=0x7900 tail=0x7a00 hw_tail=0x7c00 <6> [357.788432] [IGT] perf: finished subtest 0-rcs0, FAIL <6> [357.788874] [IGT] perf: finished subtest non-zero-reason, FAIL <7> [357.797209] i915 0000:03:00.0: [drm:drm_client_dev_restore] fbdev: ret=0 <6> [357.797690] [IGT] perf: exiting, ret=98

Created at 2026-05-14 16:33:23