Results for igt@perf@non-zero-reason

Machine description: shard-dg2-9

Result: Fail

git-log-oneline i915_display_info3 igt_runner3 runtimes3 results3.json results3-i915-load.json i915_display_info_post_exec3 boot3 dmesg3

DetailValue
Duration 2.73 seconds
Hostname
shard-dg2-9
Igt-Version
IGT-Version: 1.30-gccabe5b43 (x86_64) (Linux: 6.14.0-rc6-CI_DRM_16261-g003c44ec0b7d+ x86_64)
Out
Using IGT_SRANDOM=1741666952 for randomisation
Opened device: /dev/dri/card0
Starting subtest: non-zero-reason
Starting dynamic subtest: 0-rcs0
Stack trace:
  #0 ../lib/igt_core.c:2055 __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.732s)
Subtest non-zero-reason: FAIL (2.733s)
Err
Starting subtest: non-zero-reason
Starting dynamic subtest: 0-rcs0
(perf:2242) CRITICAL: Test assertion failure function gen8_sanity_check_test_oa_reports, file ../tests/intel/perf.c:1208:
(perf:2242) CRITICAL: Failed assertion: b == clock_delta
(perf:2242) CRITICAL: error: -606178 != 7996
Dynamic subtest 0-rcs0 failed.
**** DEBUG ****
(perf:2242) DEBUG: freq = 599
(perf:2242) DEBUG: clock delta = 7987
(perf:2242) DEBUG: A40_4: delta = 0
(perf:2242) DEBUG: A40_5: delta = 0
(perf:2242) DEBUG: A40_6: delta = 16
(perf:2242) DEBUG: A40_7: delta = 0
(perf:2242) DEBUG: A40_8: delta = 0
(perf:2242) DEBUG: A40_9: delta = 0
(perf:2242) DEBUG: A40_10: delta = 0
(perf:2242) DEBUG: A40_11: delta = 0
(perf:2242) DEBUG: A40_12: delta = 0
(perf:2242) DEBUG: A40_13: delta = 0
(perf:2242) DEBUG: A40_14: delta = 0
(perf:2242) DEBUG: A40_15: delta = 0
(perf:2242) DEBUG: A40_16: delta = 0
(perf:2242) DEBUG: A40_17: delta = 0
(perf:2242) DEBUG: A40_18: delta = 0
(perf:2242) DEBUG: A40_19: delta = 0
(perf:2242) DEBUG: A40_20: delta = 0
(perf:2242) DEBUG: A40_21: delta = 0
(perf:2242) DEBUG: A40_22: delta = 0
(perf:2242) DEBUG: A40_23: delta = 0
(perf:2242) DEBUG: A0: delta = 7987
(perf:2242) DEBUG: A1: delta = 0
(perf:2242) DEBUG: A2: delta = 0
(perf:2242) DEBUG: A3: delta = 0
(perf:2242) DEBUG: B0: delta = 0
(perf:2242) DEBUG: B1: delta = 7987
(perf:2242) DEBUG: B2: delta = 7987
(perf:2242) DEBUG: B3: delta = 3993
(perf:2242) DEBUG: B4: delta = 2662
(perf:2242) DEBUG: B5: delta = 2663
(perf:2242) DEBUG: B6: delta = 1332
(perf:2242) DEBUG: B7: delta = 5325
(perf:2242) DEBUG: C0: delta = 7987, max_delta=4089344
(perf:2242) DEBUG: C1: delta = 0, max_delta=4089344
(perf:2242) DEBUG: C2: delta = 0, max_delta=4089344
(perf:2242) DEBUG: C3: delta = 0, max_delta=4089344
(perf:2242) DEBUG: C4: delta = 7987, max_delta=4089344
(perf:2242) DEBUG: C5: delta = 0, max_delta=4089344
(perf:2242) DEBUG: C6: delta = 0, max_delta=4089344
(perf:2242) DEBUG: C7: delta = 0, max_delta=4089344
(perf:2242) DEBUG: report type: timer->timer
(perf:2242) DEBUG: freq = 598
(perf:2242) DEBUG: clock delta = 7979
(perf:2242) DEBUG: A40_4: delta = 0
(perf:2242) DEBUG: A40_5: delta = 0
(perf:2242) DEBUG: A40_6: delta = 39
(perf:2242) DEBUG: A40_7: delta = 0
(perf:2242) DEBUG: A40_8: delta = 0
(perf:2242) DEBUG: A40_9: delta = 0
(perf:2242) DEBUG: A40_10: delta = 0
(perf:2242) DEBUG: A40_11: delta = 0
(perf:2242) DEBUG: A40_12: delta = 0
(perf:2242) DEBUG: A40_13: delta = 0
(perf:2242) DEBUG: A40_14: delta = 0
(perf:2242) DEBUG: A40_15: delta = 0
(perf:2242) DEBUG: A40_16: delta = 0
(perf:2242) DEBUG: A40_17: delta = 0
(perf:2242) DEBUG: A40_18: delta = 0
(perf:2242) DEBUG: A40_19: delta = 0
(perf:2242) DEBUG: A40_20: delta = 0
(perf:2242) DEBUG: A40_21: delta = 0
(perf:2242) DEBUG: A40_22: delta = 0
(perf:2242) DEBUG: A40_23: delta = 0
(perf:2242) DEBUG: A0: delta = 7979
(perf:2242) DEBUG: A1: delta = 0
(perf:2242) DEBUG: A2: delta = 0
(perf:2242) DEBUG: A3: delta = 0
(perf:2242) DEBUG: B0: delta = 0
(perf:2242) DEBUG: B1: delta = 7979
(perf:2242) DEBUG: B2: delta = 7979
(perf:2242) DEBUG: B3: delta = 3990
(perf:2242) DEBUG: B4: delta = 2660
(perf:2242) DEBUG: B5: delta = 2659
(perf:2242) DEBUG: B6: delta = 1329
(perf:2242) DEBUG: B7: delta = 5319
(perf:2242) DEBUG: C0: delta = 7979, max_delta=4085248
(perf:2242) DEBUG: C1: delta = 0, max_delta=4085248
(perf:2242) DEBUG: C2: delta = 0, max_delta=4085248
(perf:2242) DEBUG: C3: delta = 0, max_delta=4085248
(perf:2242) DEBUG: C4: delta = 7979, max_delta=4085248
(perf:2242) DEBUG: C5: delta = 0, max_delta=4085248
(perf:2242) DEBUG: C6: delta = 0, max_delta=4085248
(perf:2242) DEBUG: C7: delta = 0, max_delta=4085248
(perf:2242) DEBUG: report type: timer->timer
(perf:2242) DEBUG: freq = 597
(perf:2242) DEBUG: clock delta = 7972
(perf:2242) DEBUG: A40_4: delta = 0
(perf:2242) DEBUG: A40_5: delta = 0
(perf:2242) DEBUG: A40_6: delta = 28
(perf:2242) DEBUG: A40_7: delta = 0
(perf:2242) DEBUG: A40_8: delta = 0
(perf:2242) DEBUG: A40_9: delta = 0
(perf:2242) DEBUG: A40_10: delta = 0
(perf:2242) DEBUG: A40_11: delta = 0
(perf:2242) DEBUG: A40_12: delta = 0
(perf:2242) DEBUG: A40_13: delta = 0
(perf:2242) DEBUG: A40_14: delta = 0
(perf:2242) DEBUG: A40_15: delta = 0
(perf:2242) DEBUG: A40_16: delta = 0
(perf:2242) DEBUG: A40_17: delta = 0
(perf:2242) DEBUG: A40_18: delta = 0
(perf:2242) DEBUG: A40_19: delta = 0
(perf:2242) DEBUG: A40_20: delta = 0
(perf:2242) DEBUG: A40_21: delta = 0
(perf:2242) DEBUG: A40_22: delta = 0
(perf:2242) DEBUG: A40_23: delta = 0
(perf:2242) DEBUG: A0: delta = 7972
(perf:2242) DEBUG: A1: delta = 0
(perf:2242) DEBUG: A2: delta = 0
(perf:2242) DEBUG: A3: delta = 0
(perf:2242) DEBUG: B0: delta = 0
(perf:2242) DEBUG: B1: delta = 7972
(perf:2242) DEBUG: B2: delta = 7972
(perf:2242) DEBUG: B3: delta = 3986
(perf:2242) DEBUG: B4: delta = 2657
(perf:2242) DEBUG: B5: delta = 2658
(perf:2242) DEBUG: B6: delta = 1329
(perf:2242) DEBUG: B7: delta = 5315
(perf:2242) DEBUG: C0: delta = 7972, max_delta=4081664
(perf:2242) DEBUG: C1: delta = 0, max_delta=4081664
(perf:2242) DEBUG: C2: delta = 0, max_delta=4081664
(perf:2242) DEBUG: C3: delta = 0, max_delta=4081664
(perf:2242) DEBUG: C4: delta = 7972, max_delta=4081664
(perf:2242) DEBUG: C5: delta = 0, max_delta=4081664
(perf:2242) DEBUG: C6: delta = 0, max_delta=4081664
(perf:2242) DEBUG: C7: delta = 0, max_delta=4081664
(perf:2242) DEBUG: report type: timer->timer
(perf:2242) DEBUG: freq = 598
(perf:2242) DEBUG: clock delta = 7979
(perf:2242) DEBUG: A40_4: delta = 0
(perf:2242) DEBUG: A40_5: delta = 0
(perf:2242) DEBUG: A40_6: delta = 39
(perf:2242) DEBUG: A40_7: delta = 0
(perf:2242) DEBUG: A40_8: delta = 0
(perf:2242) DEBUG: A40_9: delta = 0
(perf:2242) DEBUG: A40_10: delta = 0
(perf:2242) DEBUG: A40_11: delta = 0
(perf:2242) DEBUG: A40_12: delta = 0
(perf:2242) DEBUG: A40_13: delta = 0
(perf:2242) DEBUG: A40_14: delta = 0
(perf:2242) DEBUG: A40_15: delta = 0
(perf:2242) DEBUG: A40_16: delta = 0
(perf:2242) DEBUG: A40_17: delta = 0
(perf:2242) DEBUG: A40_18: delta = 0
(perf:2242) DEBUG: A40_19: delta = 0
(perf:2242) DEBUG: A40_20: delta = 0
(perf:2242) DEBUG: A40_21: delta = 0
(perf:2242) DEBUG: A40_22: delta = 0
(perf:2242) DEBUG: A40_23: delta = 0
(perf:2242) DEBUG: A0: delta = 7979
(perf:2242) DEBUG: A1: delta = 0
(perf:2242) DEBUG: A2: delta = 0
(perf:2242) DEBUG: A3: delta = 0
(perf:2242) DEBUG: B0: delta = 0
(perf:2242) DEBUG: B1: delta = 7979
(perf:2242) DEBUG: B2: delta = 7979
(perf:2242) DEBUG: B3: delta = 3989
(perf:2242) DEBUG: B4: delta = 2660
(perf:2242) DEBUG: B5: delta = 2659
(perf:2242) DEBUG: B6: delta = 1330
(perf:2242) DEBUG: B7: delta = 5319
(perf:2242) DEBUG: C0: delta = 7979, max_delta=4085248
(perf:2242) DEBUG: C1: delta = 0, max_delta=4085248
(perf:2242) DEBUG: C2: delta = 0, max_delta=4085248
(perf:2242) DEBUG: C3: delta = 0, max_delta=4085248
(perf:2242) DEBUG: C4: delta = 7979, max_delta=4085248
(perf:2242) DEBUG: C5: delta = 0, max_delta=4085248
(perf:2242) DEBUG: C6: delta = 0, max_delta=4085248
(perf:2242) DEBUG: C7: delta = 0, max_delta=4085248
(perf:2242) DEBUG: report type: timer->timer
(perf:2242) DEBUG: freq = 598
(perf:2242) DEBUG: clock delta = 7986
(perf:2242) DEBUG: A40_4: delta = 0
(perf:2242) DEBUG: A40_5: delta = 0
(perf:2242) DEBUG: A40_6: delta = 15
(perf:2242) DEBUG: A40_7: delta = 0
(perf:2242) DEBUG: A40_8: delta = 0
(perf:2242) DEBUG: A40_9: delta = 0
(perf:2242) DEBUG: A40_10: delta = 0
(perf:2242) DEBUG: A40_11: delta = 0
(perf:2242) DEBUG: A40_12: delta = 0
(perf:2242) DEBUG: A40_13: delta = 0
(perf:2242) DEBUG: A40_14: delta = 0
(perf:2242) DEBUG: A40_15: delta = 0
(perf:2242) DEBUG: A40_16: delta = 0
(perf:2242) DEBUG: A40_17: delta = 0
(perf:2242) DEBUG: A40_18: delta = 0
(perf:2242) DEBUG: A40_19: delta = 0
(perf:2242) DEBUG: A40_20: delta = 0
(perf:2242) DEBUG: A40_21: delta = 0
(perf:2242) DEBUG: A40_22: delta = 0
(perf:2242) DEBUG: A40_23: delta = 0
(perf:2242) DEBUG: A0: delta = 7986
(perf:2242) DEBUG: A1: delta = 0
(perf:2242) DEBUG: A2: delta = 0
(perf:2242) DEBUG: A3: delta = 0
(perf:2242) DEBUG: B0: delta = 0
(perf:2242) DEBUG: B1: delta = 7986
(perf:2242) DEBUG: B2: delta = 7986
(perf:2242) DEBUG: B3: delta = 3993
(perf:2242) DEBUG: B4: delta = 2662
(perf:2242) DEBUG: B5: delta = 2662
(perf:2242) DEBUG: B6: delta = 1331
(perf:2242) DEBUG: B7: delta = 5324
(perf:2242) DEBUG: C0: delta = 7986, max_delta=4088832
(perf:2242) DEBUG: C1: delta = 0, max_delta=4088832
(perf:2242) DEBUG: C2: delta = 0, max_delta=4088832
(perf:2242) DEBUG: C3: delta = 0, max_delta=4088832
(perf:2242) DEBUG: C4: delta = 7986, max_delta=4088832
(perf:2242) DEBUG: C5: delta = 0, max_delta=4088832
(perf:2242) DEBUG: C6: delta = 0, max_delta=4088832
(perf:2242) DEBUG: C7: delta = 0, max_delta=4088832
(perf:2242) DEBUG: report type: timer->timer
(perf:2242) DEBUG: freq = 599
(perf:2242) DEBUG: clock delta = 7996
(perf:2242) DEBUG: A40_4: delta = 0
(perf:2242) DEBUG: A40_5: delta = 0
(perf:2242) DEBUG: A40_6: delta = 47
(perf:2242) DEBUG: A40_7: delta = 0
(perf:2242) DEBUG: A40_8: delta = 0
(perf:2242) DEBUG: A40_9: delta = 0
(perf:2242) DEBUG: A40_10: delta = 0
(perf:2242) DEBUG: A40_11: delta = 0
(perf:2242) DEBUG: A40_12: delta = 0
(perf:2242) DEBUG: A40_13: delta = 0
(perf:2242) DEBUG: A40_14: delta = 0
(perf:2242) DEBUG: A40_15: delta = 0
(perf:2242) DEBUG: A40_16: delta = 0
(perf:2242) DEBUG: A40_17: delta = 0
(perf:2242) DEBUG: A40_18: delta = 0
(perf:2242) DEBUG: A40_19: delta = 0
(perf:2242) DEBUG: A40_20: delta = 0
(perf:2242) DEBUG: A40_21: delta = 0
(perf:2242) DEBUG: A40_22: delta = 0
(perf:2242) DEBUG: A40_23: delta = 0
(perf:2242) DEBUG: A0: delta = 7996
(perf:2242) DEBUG: A1: delta = 0
(perf:2242) DEBUG: A2: delta = 0
(perf:2242) DEBUG: A3: delta = 0
(perf:2242) DEBUG: B0: delta = 0
(perf:2242) DEBUG: B1: delta = 4294361118
(perf:2242) CRITICAL: Test assertion failure function gen8_sanity_check_test_oa_reports, file ../tests/intel/perf.c:1208:
(perf:2242) CRITICAL: Failed assertion: b == clock_delta
(perf:2242) CRITICAL: error: -606178 != 7996
(perf:2242) igt_core-INFO: Stack trace:
(perf:2242) igt_core-INFO:   #0 ../lib/igt_core.c:2055 __igt_fail_assert()
(perf:2242) igt_core-INFO:   #1 ../tests/intel/perf.c:1232 gen8_sanity_check_test_oa_reports()
(perf:2242) igt_core-INFO:   #2 ../tests/intel/perf.c:3126 test_non_zero_reason()
(perf:2242) igt_core-INFO:   #3 ../tests/intel/perf.c:5955 __igt_unique____real_main5860()
(perf:2242) igt_core-INFO:   #4 ../tests/intel/perf.c:5860 main()
(perf:2242) igt_core-INFO:   #5 [__libc_init_first+0x8a]
(perf:2242) igt_core-INFO:   #6 [__libc_start_main+0x8b]
(perf:2242) igt_core-INFO:   #7 [_start+0x25]
****  END  ****
Dynamic subtest 0-rcs0: FAIL (2.732s)
Subtest non-zero-reason: FAIL (2.733s)
Dmesg
<6> [379.207046] Console: switching to colour dummy device 80x25
<6> [379.207478] [IGT] perf: executing
<6> [379.229313] Console: switching to colour frame buffer device 240x67
<7> [379.278489] i915 0000:03:00.0: [drm:i915_gem_open [i915]]
<7> [379.279840] i915 0000:03:00.0: [drm:i915_gem_open [i915]]
<6> [379.368982] [IGT] perf: starting subtest non-zero-reason
<6> [379.369489] [IGT] perf: starting dynamic subtest 0-rcs0
<7> [379.370073] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [379.453094] i915 0000:03:00.0: [drm:i915_oa_stream_init.isra.0 [i915]] opening stream oa config uuid=7389b9c9-de73-468d-83a8-b27776215e6b
<5> [379.455452] i915 0000:03:00.0: [drm] unlanded report(s) head=0x0 tail=0x1b00 hw_tail=0x1e00
<5> [379.455793] i915 0000:03:00.0: [drm] unlanded report(s) head=0x1b00 tail=0x3800 hw_tail=0x3a00
<5> [379.455970] i915 0000:03:00.0: [drm] unlanded report(s) head=0x4300 tail=0x4500 hw_tail=0x4700
<5> [379.456010] i915 0000:03:00.0: [drm] unlanded report(s) head=0x4500 tail=0x4600 hw_tail=0x4a00
<5> [379.456054] i915 0000:03:00.0: [drm] unlanded report(s) head=0x4600 tail=0x4b00 hw_tail=0x4e00
<5> [379.456093] i915 0000:03:00.0: [drm] unlanded report(s) head=0x4b00 tail=0x4d00 hw_tail=0x5100
<5> [379.456133] i915 0000:03:00.0: [drm] unlanded report(s) head=0x4d00 tail=0x5000 hw_tail=0x5400
<5> [379.456175] i915 0000:03:00.0: [drm] unlanded report(s) head=0x5000 tail=0x5300 hw_tail=0x5700
<5> [379.456215] i915 0000:03:00.0: [drm] unlanded report(s) head=0x5300 tail=0x5800 hw_tail=0x5a00
<5> [379.456255] i915 0000:03:00.0: [drm] unlanded report(s) head=0x5800 tail=0x5900 hw_tail=0x5d00
<6> [382.101739] [IGT] perf: finished subtest 0-rcs0, FAIL
<6> [382.102292] [IGT] perf: finished subtest non-zero-reason, FAIL
<7> [382.112470] i915 0000:03:00.0: [drm:drm_client_dev_restore] fbdev: ret=0
<6> [382.112910] [IGT] perf: exiting, ret=98
Created at 2025-03-11 05:40:40