102480 – [IGT] [APL/SKL] igt@perf@oa-exponents assertion: timestamp_delta == expected_timestamp_delta

Bug 102480 - [IGT] [APL/SKL] igt@perf@oa-exponents assertion: timestamp_delta == expected_timestamp_delta

Summary: [IGT] [APL/SKL] igt@perf@oa-exponents assertion: timestamp_delta == expected_...

Status:	CLOSED FIXED

Alias:	None

Product:	DRI
Classification:	Unclassified
Component:	DRM/Intel (show other bugs)
Version:	unspecified
Hardware:	x86-64 (AMD64) Linux (All)

Importance:	medium normal
Assignee:	Intel GFX Bugs mailing list
QA Contact:	Intel GFX Bugs mailing list

URL:
Whiteboard:	ReadyForDev
Keywords:

Depends on:
Blocks:

Reported:	2017-08-30 14:43 UTC by Armando Antonio
Modified:	2018-02-15 21:50 UTC (History)
CC List:	1 user (show)

See Also:
i915 platform:	BXT
i915 features:	Perf/OA

Attachments
kernel log (564.71 KB, text/plain) 2017-08-30 14:43 UTC, Armando Antonio	no flags	Details
test log (11.68 KB, text/plain) 2017-08-30 14:43 UTC, Armando Antonio	no flags	Details
dmes (407.38 KB, text/plain) 2017-08-30 14:44 UTC, Armando Antonio	no flags	Details
new test log (50.09 KB, text/plain) 2017-09-06 16:07 UTC, Armando Antonio	no flags	Details
output (GLK) (54.61 KB, text/plain) 2017-09-20 16:56 UTC, Hector Velazquez	no flags	Details
Dmesg (GLK) (420.64 KB, text/plain) 2017-09-20 16:57 UTC, Hector Velazquez	no flags	Details
Show Obsolete (1) View All

Description Armando Antonio 2017-08-30 14:43:25 UTC

Created attachment 133882 [details]
kernel log

Te following test fail on APL with latest configuration

====================================================
Test list
====================================================
igt@perf@oa-exponents


======================================
             Software
======================================
kernel version              : 4.13.0-rc6-drm-tip-ww35-commit-00b77f6+
hostname                    : gfx-desktop
architecture                : x86_64
os version                  : Ubuntu 17.04
os codename                 : zesty
[sudo] password for gfx: kernel driver               : i915
bios revision               : 5.6
bios release date           : 06/19/2017
ksc                         : 18.0
hardware acceleration       : disabled
swap partition              : enabled on (/dev/sda2)

======================================
        Graphic drivers
======================================
grep: /opt/X11R7/var/log/Xorg.0.log: No such file or directory
libdrm                      : 2.4.83
cairo                       : 1.15.7
intel-gpu-tools (tag)       : intel-gpu-tools-1.19-206-g60f6a121
intel-gpu-tools (commit)    : 60f6a121

======================================
             Hardware
======================================
motherboard model          : NUC6CAYS
motherboard id             : NUC6CAYB
form factor                : Desktop
manufacturer               : Intelcorporation
cpu family                 : Celeron
cpu family id              : 6
cpu information            : Intel(R) Celeron(R) CPU J3455 @ 1.50GHz
gpu card                   : Intel Corporation Device 5a85 (rev 0b) (prog-if 00 [VGA controller])
memory ram                 : 15.52 GB
max memory ram             : 32 GB
cpu thread                 : 4
cpu core                   : 4
cpu model                  : 92
cpu stepping               : 9
socket                     : Other
signature                  : Type 0, Family 6, Model 92, Stepping 9
hard drive                 : 74GiB (80GB)
current cd clock frequency : 288000 kHz
maximum cd clock frequency : 624000 kHz
displays connected         : DP-1 DP-2

======================================
             Firmware
======================================
dmc fw loaded             : yes
dmc version               : 1.7
guc fw loaded             : NONE
guc version wanted        : 0.0
guc version found         : 0.0

======================================

Comment 1 Armando Antonio 2017-08-30 14:43:53 UTC

Created attachment 133884 [details]
test log

Comment 2 Armando Antonio 2017-08-30 14:44:24 UTC

Created attachment 133885 [details]
dmes

Comment 3 Elizabeth 2017-09-01 19:59:47 UTC

Adding tag into "Whiteboard" field - ReadyForDev
*Status is correct
*Platform is included
*Feature is included
*Priority and Severity correctly set
*Logs included

Comment 4 Armando Antonio 2017-09-06 16:07:23 UTC

Sorry wrong test log, attached a new one. regards

Comment 5 Armando Antonio 2017-09-06 16:07:45 UTC

Created attachment 134012 [details]
new test log

Comment 6 Hector Velazquez 2017-09-06 18:54:17 UTC

The following tests FAIL on SKL 

Tests List:

igt@perf@oa-exponents



======================================
        Output
======================================
...
(perf:1478) DEBUG: read report: reason = 360ea01b, timestamp = 9294ed60, exponent mask=3f
(perf:1478) DEBUG: ITER 1: time delta = 5333(ns) clock delta = 2399 freq = 449(mhz)
(perf:1478) DEBUG: ITER 2: testing OA exponent 5 (period = 5333ns) with sysfs GT freq = 450mhz +- 45
(perf:1478) DEBUG: read restart: OA trigger collision / report lost
(perf:1478) DEBUG: read restart: OA trigger collision / report lost
(perf:1478) DEBUG: read report: reason = 360ea01b, timestamp = 9297e560, exponent mask=3f
(perf:1478) DEBUG: read report: reason = 360ea01b, timestamp = 9297e5a0, exponent mask=3f
(perf:1478) DEBUG: ITER 2: time delta = 5333(ns) clock delta = 2394 freq = 448(mhz)
(perf:1478) DEBUG: ITER 3: testing OA exponent 5 (period = 5333ns) with sysfs GT freq = 450mhz +- 45
(perf:1478) DEBUG: read restart: OA trigger collision / report lost
(perf:1478) DEBUG: read restart: OA trigger collision / report lost
(perf:1478) DEBUG: read report: reason = 360ea01b, timestamp = 929bd360, exponent mask=3f
(perf:1478) DEBUG: read report: reason = 360ea01b, timestamp = 929bd460, exponent mask=3f
(perf:1478) DEBUG: timestamp0 = 2459685728/0x929bd360
(perf:1478) DEBUG: timestamp1 = 2459685984/0x929bd460
(perf:1478) CRITICAL: Test assertion failure function test_oa_exponents, file perf.c:1482:
(perf:1478) CRITICAL: Failed assertion: timestamp_delta == expected_timestamp_delta
(perf:1478) CRITICAL: error: 256 != 64
(perf:1478) igt-core-INFO: Stack trace:
(perf:1478) igt-core-INFO:   #0 [__igt_fail_assert+0x101]
(perf:1478) igt-core-INFO:   #1 [test_oa_exponents+0x35d]
(perf:1478) igt-core-INFO:   #2 [<unknown>+0x35d]
****  END  ****
Stack trace:
  #0 [__igt_fail_assert+0x101]
  #1 [test_oa_exponents+0x35d]
  #2 [<unknown>+0x35d]
Subtest oa-exponents: FAIL (0.104s)
(perf:1478) DEBUG: restoring GT frequency range: min = 350mhz, max =950mhz, current: min=450mhz, max=450mhz
(perf:1478) igt-core-DEBUG: Exiting with status code 99


This is my configuration:

======================================
        Graphic stack
======================================

Component: drm
    tag: libdrm-2.4.81-52-g05a830d
    commit: 05a830d382382905d87b55af90aa109fb76e4c16

Component: cairo
    tag: 1.15.6-30-gc29db4f
    commit: c29db4f0de52727406a8b62f4da9a382084b5a79

Component: intel-gpu-tools
    tag: intel-gpu-tools-1.19-234-g490b386
    commit: 490b386ae36d393cdea514882a2437c6e964c13f

Component: piglit
    tag: piglit-v1
    commit: dab15137044c34023b1a843e72e781b03b17548b

======================================
	     Software
======================================
kernel version              : 4.13.0-drm-tip-ww36-commit-9dd459e+
hostname                    : gfx-desktop
architecture                : x86_64
os version                  : Ubuntu 16.10
os codename                 : yakkety
kernel driver               : i915
bios revision               : 5.6
bios release date           : 09/29/2016
hardware acceleration       : only available on X
swap partition              : enabled on (/dev/sda3)

======================================
	Graphic drivers
======================================
libdrm                      : 2.4.83
cairo                       : 1.15.9
intel-gpu-tools (tag)       : intel-gpu-tools-1.19-234-g490b386
intel-gpu-tools (commit)    : 490b386

======================================
	     Firmware
======================================
dmc fw loaded             : yes
dmc version               : 1.26
guc fw loaded             : SUCCESS
guc version wanted        : 6.1
guc version found         : 6.1
huc fw loaded             : yes

======================================
	     kernel parameters
======================================
quiet splash drm.debug=0x1e i915.enable_guc_submission=2 i915.enable_guc_loading=2 i915.alpha_support=1

======================================
	     Hardware
======================================
platform                   : Skylake Canyon
motherboard id             : NUC6i7KYB
form factor                : Desktop
cpu family                 : Core i7
cpu family id              : 6
cpu information            : Intel(R) Core(TM) i7-6770HQ CPU @ 2.60GHz
gpu card                   : Intel Corporation Iris Pro Graphics 580 (rev 09) (prog-if 00 [VGA controller])
memory ram                 : 31.31 GB
max memory ram             : 32 GB
cpu thread                 : 8
cpu core                   : 4
cpu model                  : 94
cpu stepping               : 3
socket                     : Other
signature                  : Type 0, Family 6, Model 94, Stepping 3
hard drive                 : 223GiB (240GB)
current cd clock frequency : 337500 kHz
maximum cd clock frequency : 675000 kHz
displays connected         : DP-1 DP-3

Comment 7 Hector Velazquez 2017-09-20 16:56:31 UTC

This test still fail on GLK QA

igt@perf@oa-exponents

====================================================
Output
====================================================
. . .
**** DEBUG ****
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 981cb280, exponent mask=ff
(perf:1466) DEBUG: ITER 2: time delta = 13333(ns) clock delta = 5976 freq = 448(mhz)
(perf:1466) DEBUG: ITER 3: testing OA exponent 7 (period = 13333ns) with sysfs GT freq = 450mhz +- 45
(perf:1466) DEBUG: read restart: OA trigger collision / report lost
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 98266480, exponent mask=ff
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 98266580, exponent mask=ff
(perf:1466) DEBUG: ITER 3: time delta = 13333(ns) clock delta = 5994 freq = 449(mhz)
(perf:1466) DEBUG: ITER 4: testing OA exponent 7 (period = 13333ns) with sysfs GT freq = 450mhz +- 45
(perf:1466) DEBUG: read restart: OA trigger collision / report lost
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 9831c380, exponent mask=ff
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 9831c480, exponent mask=ff
(perf:1466) DEBUG: ITER 4: time delta = 13333(ns) clock delta = 5994 freq = 449(mhz)
(perf:1466) DEBUG: ITER 5: testing OA exponent 7 (period = 13333ns) with sysfs GT freq = 450mhz +- 45
(perf:1466) DEBUG: read restart: OA trigger collision / report lost
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 983cdf80, exponent mask=ff
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 983ce080, exponent mask=ff
(perf:1466) DEBUG: ITER 5: time delta = 13333(ns) clock delta = 5976 freq = 448(mhz)
(perf:1466) DEBUG: ITER 6: testing OA exponent 7 (period = 13333ns) with sysfs GT freq = 450mhz +- 45
(perf:1466) DEBUG: read restart: OA trigger collision / report lost
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 98480580, exponent mask=ff
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 98480680, exponent mask=ff
(perf:1466) DEBUG: ITER 6: time delta = 13333(ns) clock delta = 5985 freq = 448(mhz)
(perf:1466) DEBUG: ITER 7: testing OA exponent 7 (period = 13333ns) with sysfs GT freq = 450mhz +- 45
(perf:1466) DEBUG: read restart: OA trigger collision / report lost
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 98532780, exponent mask=ff
(perf:1466) DEBUG: read report: reason = 360ed01b, timestamp = 98532880, exponent mask=ff
(perf:1466) DEBUG: ITER 7: time delta = 13333(ns) clock delta = 5985 freq = 448(mhz)
(perf:1466) DEBUG: ITER 8: testing OA exponent 7 (period = 13333ns) with sysfs GT freq = 450mhz +- 45
(perf:1466) DEBUG: read restart: OA trigger collision / report lost
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 985e9180, exponent mask=ff
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 985e9280, exponent mask=ff
(perf:1466) DEBUG: ITER 8: time delta = 13333(ns) clock delta = 5994 freq = 449(mhz)
(perf:1466) DEBUG: ITER 9: testing OA exponent 7 (period = 13333ns) with sysfs GT freq = 450mhz +- 45
(perf:1466) DEBUG: read restart: OA trigger collision / report lost
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 9869b980, exponent mask=ff
(perf:1466) DEBUG: read report: reason = 360ed01b, timestamp = 9869ba80, exponent mask=ff
(perf:1466) DEBUG: ITER 9: time delta = 13333(ns) clock delta = 5976 freq = 448(mhz)
(perf:1466) DEBUG: number of iterations with expected clock frequency = 10
(perf:1466) DEBUG: ITER 0: testing OA exponent 8 (period = 26666ns) with sysfs GT freq = 450mhz +- 45
(perf:1466) DEBUG: read restart: OA trigger collision / report lost
(perf:1466) DEBUG: read report: reason = 360ed01b, timestamp = 9874d900, exponent mask=1ff
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 9874db00, exponent mask=1ff
(perf:1466) DEBUG: ITER 0: time delta = 26666(ns) clock delta = 11966 freq = 448(mhz)
(perf:1466) DEBUG: ITER 1: testing OA exponent 8 (period = 26666ns) with sysfs GT freq = 450mhz +- 45
(perf:1466) DEBUG: read restart: OA trigger collision / report lost
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 987ffd00, exponent mask=1ff
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 987fff00, exponent mask=1ff
(perf:1466) DEBUG: ITER 1: time delta = 26666(ns) clock delta = 11961 freq = 448(mhz)
(perf:1466) DEBUG: ITER 2: testing OA exponent 8 (period = 26666ns) with sysfs GT freq = 450mhz +- 45
(perf:1466) DEBUG: read restart: OA trigger collision / report lost
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 988b2500, exponent mask=1ff
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 988b2700, exponent mask=1ff
(perf:1466) DEBUG: ITER 2: time delta = 26666(ns) clock delta = 11970 freq = 448(mhz)
(perf:1466) DEBUG: ITER 3: testing OA exponent 8 (period = 26666ns) with sysfs GT freq = 450mhz +- 45
(perf:1466) DEBUG: read restart: OA trigger collision / report lost
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 98963b00, exponent mask=1ff
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 98963d00, exponent mask=1ff
(perf:1466) DEBUG: ITER 3: time delta = 26666(ns) clock delta = 11970 freq = 448(mhz)
(perf:1466) DEBUG: ITER 4: testing OA exponent 8 (period = 26666ns) with sysfs GT freq = 450mhz +- 45
(perf:1466) DEBUG: read restart: OA trigger collision / report lost
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 98a15f00, exponent mask=1ff
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 98a16100, exponent mask=1ff
(perf:1466) DEBUG: ITER 4: time delta = 26666(ns) clock delta = 11970 freq = 448(mhz)
(perf:1466) DEBUG: ITER 5: testing OA exponent 8 (period = 26666ns) with sysfs GT freq = 450mhz +- 45
(perf:1466) DEBUG: read restart: OA trigger collision / report lost
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 98ac8100, exponent mask=1ff
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 98ac8300, exponent mask=1ff
(perf:1466) DEBUG: ITER 5: time delta = 26666(ns) clock delta = 11966 freq = 448(mhz)
(perf:1466) DEBUG: ITER 6: testing OA exponent 8 (period = 26666ns) with sysfs GT freq = 450mhz +- 45
(perf:1466) DEBUG: read restart: OA trigger collision / report lost
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 98b7a500, exponent mask=1ff
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 98b7a700, exponent mask=1ff
(perf:1466) DEBUG: ITER 6: time delta = 26666(ns) clock delta = 11965 freq = 448(mhz)
(perf:1466) DEBUG: ITER 7: testing OA exponent 8 (period = 26666ns) with sysfs GT freq = 450mhz +- 45
(perf:1466) DEBUG: read restart: OA trigger collision / report lost
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 98c2c500, exponent mask=1ff
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 98c2c700, exponent mask=1ff
(perf:1466) DEBUG: ITER 7: time delta = 26666(ns) clock delta = 11966 freq = 448(mhz)
(perf:1466) DEBUG: ITER 8: testing OA exponent 8 (period = 26666ns) with sysfs GT freq = 450mhz +- 45
(perf:1466) DEBUG: read restart: OA trigger collision / report lost
(perf:1466) DEBUG: read report: reason = 360ec81b, timestamp = 98cde100, exponent mask=1ff
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 98cde300, exponent mask=1ff
(perf:1466) DEBUG: ITER 8: time delta = 26666(ns) clock delta = 11966 freq = 448(mhz)
(perf:1466) DEBUG: ITER 9: testing OA exponent 8 (period = 26666ns) with sysfs GT freq = 450mhz +- 45
(perf:1466) DEBUG: read restart: OA trigger collision / report lost
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 98d90700, exponent mask=1ff
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 98d90900, exponent mask=1ff
(perf:1466) DEBUG: ITER 9: time delta = 26666(ns) clock delta = 11970 freq = 448(mhz)
(perf:1466) DEBUG: number of iterations with expected clock frequency = 10
(perf:1466) DEBUG: ITER 0: testing OA exponent 9 (period = 53333ns) with sysfs GT freq = 450mhz +- 45
(perf:1466) DEBUG: read restart: OA trigger collision / report lost
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 98e43a00, exponent mask=3ff
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 98e43e00, exponent mask=3ff
(perf:1466) DEBUG: ITER 0: time delta = 53333(ns) clock delta = 23940 freq = 448(mhz)
(perf:1466) DEBUG: ITER 1: testing OA exponent 9 (period = 53333ns) with sysfs GT freq = 450mhz +- 45
(perf:1466) DEBUG: read restart: OA trigger collision / report lost
(perf:1466) DEBUG: read report: reason = 360ec81b, timestamp = 98f0c600, exponent mask=3ff
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 98f0ca00, exponent mask=3ff
(perf:1466) DEBUG: ITER 1: time delta = 53333(ns) clock delta = 23922 freq = 448(mhz)
(perf:1466) DEBUG: ITER 2: testing OA exponent 9 (period = 53333ns) with sysfs GT freq = 450mhz +- 45
(perf:1466) DEBUG: read report: reason = 360ec81b, timestamp = 98fa7200, exponent mask=3ff
(perf:1466) DEBUG: read report: reason = 360ec81b, timestamp = 98fa7600, exponent mask=3ff
(perf:1466) DEBUG: ITER 2: time delta = 53333(ns) clock delta = 23944 freq = 448(mhz)
(perf:1466) DEBUG: ITER 3: testing OA exponent 9 (period = 53333ns) with sysfs GT freq = 450mhz +- 45
(perf:1466) DEBUG: read restart: OA trigger collision / report lost
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 9906fe00, exponent mask=3ff
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 99070200, exponent mask=3ff
(perf:1466) DEBUG: ITER 3: time delta = 53333(ns) clock delta = 23922 freq = 448(mhz)
(perf:1466) DEBUG: ITER 4: testing OA exponent 9 (period = 53333ns) with sysfs GT freq = 450mhz +- 45
(perf:1466) DEBUG: read restart: OA trigger collision / report lost
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 99121e00, exponent mask=3ff
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 99122200, exponent mask=3ff
(perf:1466) DEBUG: ITER 4: time delta = 53333(ns) clock delta = 23926 freq = 448(mhz)
(perf:1466) DEBUG: ITER 5: testing OA exponent 9 (period = 53333ns) with sysfs GT freq = 450mhz +- 45
(perf:1466) DEBUG: read restart: OA trigger collision / report lost
(perf:1466) DEBUG: read report: reason = 360ee01b, timestamp = 991d5200, exponent mask=3ff
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 991d5600, exponent mask=3ff
(perf:1466) DEBUG: ITER 5: time delta = 53333(ns) clock delta = 23931 freq = 448(mhz)
(perf:1466) DEBUG: ITER 6: testing OA exponent 9 (period = 53333ns) with sysfs GT freq = 450mhz +- 45
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 9926ee00, exponent mask=3ff
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 9926f200, exponent mask=3ff
(perf:1466) DEBUG: ITER 6: time delta = 53333(ns) clock delta = 23940 freq = 448(mhz)
(perf:1466) DEBUG: ITER 7: testing OA exponent 9 (period = 53333ns) with sysfs GT freq = 450mhz +- 45
(perf:1466) DEBUG: read restart: OA trigger collision / report lost
(perf:1466) DEBUG: read report: reason = 360ed01b, timestamp = 99334a00, exponent mask=3ff
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 99334e00, exponent mask=3ff
(perf:1466) DEBUG: ITER 7: time delta = 53333(ns) clock delta = 23940 freq = 448(mhz)
(perf:1466) DEBUG: ITER 8: testing OA exponent 9 (period = 53333ns) with sysfs GT freq = 450mhz +- 45
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 993cea00, exponent mask=3ff
(perf:1466) DEBUG: read report: reason = 360ee01b, timestamp = 993cee00, exponent mask=3ff
(perf:1466) DEBUG: ITER 8: time delta = 53333(ns) clock delta = 23940 freq = 448(mhz)
(perf:1466) DEBUG: ITER 9: testing OA exponent 9 (period = 53333ns) with sysfs GT freq = 450mhz +- 45
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 99481600, exponent mask=3ff
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 99481a00, exponent mask=3ff
(perf:1466) DEBUG: ITER 9: time delta = 53333(ns) clock delta = 23926 freq = 448(mhz)
(perf:1466) DEBUG: number of iterations with expected clock frequency = 10
(perf:1466) DEBUG: ITER 0: testing OA exponent 10 (period = 106666ns) with sysfs GT freq = 450mhz +- 45
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 99532c00, exponent mask=7ff
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 99533400, exponent mask=7ff
(perf:1466) DEBUG: ITER 0: time delta = 106666(ns) clock delta = 47876 freq = 448(mhz)
(perf:1466) DEBUG: ITER 1: testing OA exponent 10 (period = 106666ns) with sysfs GT freq = 450mhz +- 45
(perf:1466) DEBUG: read restart: OA trigger collision / report lost
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 995fc400, exponent mask=7ff
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 995fcc00, exponent mask=7ff
(perf:1466) DEBUG: ITER 1: time delta = 106666(ns) clock delta = 47866 freq = 448(mhz)
(perf:1466) DEBUG: ITER 2: testing OA exponent 10 (period = 106666ns) with sysfs GT freq = 450mhz +- 45
(perf:1466) DEBUG: read restart: OA trigger collision / report lost
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 996ae400, exponent mask=7ff
(perf:1466) DEBUG: read report: reason = 360ee01b, timestamp = 996aec00, exponent mask=7ff
(perf:1466) DEBUG: skipping OA reports pair due to GT frequency change according to sysfs
(perf:1466) DEBUG: ITER 3: testing OA exponent 10 (period = 106666ns) with sysfs GT freq = 450mhz +- 45
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 9974a400, exponent mask=7ff
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 9974ac00, exponent mask=7ff
(perf:1466) DEBUG: ITER 3: time delta = 106666(ns) clock delta = 47871 freq = 448(mhz)
(perf:1466) DEBUG: ITER 4: testing OA exponent 10 (period = 106666ns) with sysfs GT freq = 450mhz +- 45
(perf:1466) DEBUG: read report: reason = 360ee01b, timestamp = 997fbc00, exponent mask=7ff
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 997fc400, exponent mask=7ff
(perf:1466) DEBUG: ITER 4: time delta = 106666(ns) clock delta = 47858 freq = 448(mhz)
(perf:1466) DEBUG: ITER 5: testing OA exponent 10 (period = 106666ns) with sysfs GT freq = 450mhz +- 45
(perf:1466) DEBUG: read restart: OA trigger collision / report lost
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 998c4c00, exponent mask=7ff
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 998c5400, exponent mask=7ff
(perf:1466) DEBUG: ITER 5: time delta = 106666(ns) clock delta = 47862 freq = 448(mhz)
(perf:1466) DEBUG: ITER 6: testing OA exponent 10 (period = 106666ns) with sysfs GT freq = 450mhz +- 45
(perf:1466) DEBUG: read restart: OA trigger collision / report lost
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 99973c00, exponent mask=7ff
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 99974400, exponent mask=7ff
(perf:1466) DEBUG: ITER 6: time delta = 106666(ns) clock delta = 47862 freq = 448(mhz)
(perf:1466) DEBUG: ITER 7: testing OA exponent 10 (period = 106666ns) with sysfs GT freq = 450mhz +- 45
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 99a0d400, exponent mask=7ff
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 99a0dc00, exponent mask=7ff
(perf:1466) DEBUG: ITER 7: time delta = 106666(ns) clock delta = 47867 freq = 448(mhz)
(perf:1466) DEBUG: ITER 8: testing OA exponent 10 (period = 106666ns) with sysfs GT freq = 450mhz +- 45
(perf:1466) DEBUG: read report: reason = 360ee01b, timestamp = 99abfc00, exponent mask=7ff
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 99ac0400, exponent mask=7ff
(perf:1466) DEBUG: ITER 8: time delta = 106666(ns) clock delta = 47875 freq = 448(mhz)
(perf:1466) DEBUG: ITER 9: testing OA exponent 10 (period = 106666ns) with sysfs GT freq = 450mhz +- 45
(perf:1466) DEBUG: read restart: OA trigger collision / report lost
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 99b89400, exponent mask=7ff
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 99b89c00, exponent mask=7ff
(perf:1466) DEBUG: ITER 9: time delta = 106666(ns) clock delta = 47858 freq = 448(mhz)
(perf:1466) DEBUG: ITER 10: testing OA exponent 10 (period = 106666ns) with sysfs GT freq = 450mhz +- 45
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 99c23c00, exponent mask=7ff
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 99c24400, exponent mask=7ff
(perf:1466) DEBUG: ITER 10: time delta = 106666(ns) clock delta = 47875 freq = 448(mhz)
(perf:1466) DEBUG: number of iterations with expected clock frequency = 10
(perf:1466) DEBUG: ITER 0: testing OA exponent 11 (period = 213333ns) with sysfs GT freq = 450mhz +- 45
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 99cd6800, exponent mask=fff
(perf:1466) DEBUG: read report: reason = 360ee01b, timestamp = 99cd7800, exponent mask=fff
(perf:1466) DEBUG: ITER 0: time delta = 213333(ns) clock delta = 95733 freq = 448(mhz)
(perf:1466) DEBUG: ITER 1: testing OA exponent 11 (period = 213333ns) with sysfs GT freq = 450mhz +- 45
(perf:1466) DEBUG: read restart: OA trigger collision / report lost
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 99d9f800, exponent mask=fff
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 99da0800, exponent mask=fff
(perf:1466) DEBUG: ITER 1: time delta = 213333(ns) clock delta = 95738 freq = 448(mhz)
(perf:1466) DEBUG: ITER 2: testing OA exponent 11 (period = 213333ns) with sysfs GT freq = 450mhz +- 45
(perf:1466) DEBUG: read restart: OA trigger collision / report lost
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 99e4d800, exponent mask=fff
(perf:1466) DEBUG: read report: reason = 360ec81b, timestamp = 99e4e800, exponent mask=fff
(perf:1466) DEBUG: ITER 2: time delta = 213333(ns) clock delta = 95729 freq = 448(mhz)
(perf:1466) DEBUG: ITER 3: testing OA exponent 11 (period = 213333ns) with sysfs GT freq = 450mhz +- 45
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 99ee8800, exponent mask=fff
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 99ee9800, exponent mask=fff
(perf:1466) DEBUG: ITER 3: time delta = 213333(ns) clock delta = 95733 freq = 448(mhz)
(perf:1466) DEBUG: ITER 4: testing OA exponent 11 (period = 213333ns) with sysfs GT freq = 450mhz +- 45
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 99f9a800, exponent mask=fff
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 99f9b800, exponent mask=fff
(perf:1466) DEBUG: ITER 4: time delta = 213333(ns) clock delta = 95738 freq = 448(mhz)
(perf:1466) DEBUG: ITER 5: testing OA exponent 11 (period = 213333ns) with sysfs GT freq = 450mhz +- 45
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 9a04b800, exponent mask=fff
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 9a04c800, exponent mask=fff
(perf:1466) DEBUG: skipping OA reports pair due to GT frequency change according to sysfs
(perf:1466) DEBUG: ITER 6: testing OA exponent 11 (period = 213333ns) with sysfs GT freq = 450mhz +- 45
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 9a0fe800, exponent mask=fff
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 9a0ff800, exponent mask=fff
(perf:1466) DEBUG: ITER 6: time delta = 213333(ns) clock delta = 95738 freq = 448(mhz)
(perf:1466) DEBUG: ITER 7: testing OA exponent 11 (period = 213333ns) with sysfs GT freq = 450mhz +- 45
(perf:1466) DEBUG: read restart: OA trigger collision / report lost
(perf:1466) DEBUG: read report: reason = 360ec81b, timestamp = 9a1b1800, exponent mask=fff
(perf:1466) DEBUG: read report: reason = 360ee01b, timestamp = 9a1b2800, exponent mask=fff
(perf:1466) DEBUG: ITER 7: time delta = 213333(ns) clock delta = 95737 freq = 448(mhz)
(perf:1466) DEBUG: ITER 8: testing OA exponent 11 (period = 213333ns) with sysfs GT freq = 450mhz +- 45
(perf:1466) DEBUG: read restart: OA trigger collision / report lost
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 9a27a800, exponent mask=fff
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 9a27b800, exponent mask=fff
(perf:1466) DEBUG: ITER 8: time delta = 213333(ns) clock delta = 95733 freq = 448(mhz)
(perf:1466) DEBUG: ITER 9: testing OA exponent 11 (period = 213333ns) with sysfs GT freq = 450mhz +- 45
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 9a314800, exponent mask=fff
(perf:1466) DEBUG: read report: reason = 360ed01b, timestamp = 9a315800, exponent mask=fff
(perf:1466) DEBUG: skipping OA reports pair due to GT frequency change according to sysfs
(perf:1466) DEBUG: ITER 10: testing OA exponent 11 (period = 213333ns) with sysfs GT freq = 450mhz +- 45
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 9a3c6800, exponent mask=fff
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 9a3c7800, exponent mask=fff
(perf:1466) DEBUG: ITER 10: time delta = 213333(ns) clock delta = 95737 freq = 448(mhz)
(perf:1466) DEBUG: ITER 11: testing OA exponent 11 (period = 213333ns) with sysfs GT freq = 450mhz +- 45
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 9a475800, exponent mask=fff
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 9a476800, exponent mask=fff
(perf:1466) DEBUG: ITER 11: time delta = 213333(ns) clock delta = 95733 freq = 448(mhz)
(perf:1466) DEBUG: number of iterations with expected clock frequency = 10
(perf:1466) DEBUG: ITER 0: testing OA exponent 12 (period = 426666ns) with sysfs GT freq = 450mhz +- 45
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 9a527000, exponent mask=1fff
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 9a529000, exponent mask=1fff
(perf:1466) DEBUG: ITER 0: time delta = 426666(ns) clock delta = 191480 freq = 448(mhz)
(perf:1466) DEBUG: ITER 1: testing OA exponent 12 (period = 426666ns) with sysfs GT freq = 450mhz +- 45
(perf:1466) DEBUG: read report: reason = 360ec01b, timestamp = 9a5d5000, exponent mask=1fff
(perf:1466) DEBUG: read report: reason = 300ec018, timestamp = 9a5d709d, exponent mask=1fff
(perf:1466) DEBUG: timestamp0 = 2589806592/0x9a5d5000
(perf:1466) DEBUG: timestamp1 = 2589814941/0x9a5d709d
(perf:1466) CRITICAL: Test assertion failure function test_oa_exponents, file perf.c:1482:
(perf:1466) CRITICAL: Failed assertion: timestamp_delta == expected_timestamp_delta
(perf:1466) CRITICAL: error: 8349 != 8192
(perf:1466) igt-core-INFO: Stack trace:
(perf:1466) igt-core-INFO:   #0 [__igt_fail_assert+0x101]
(perf:1466) igt-core-INFO:   #1 [test_oa_exponents+0x35d]
(perf:1466) igt-core-INFO:   #2 [<unknown>+0x35d]
****  END  ****
. . .

This is my configuration:

====================================================
Graphic Stack
====================================================
Component: drm
    tag: libdrm-2.4.81-55-g76418c2
    commit: 76418c244d4c52a8dd20809e3e8b4e70501fc76f

Component: cairo
    tag: 1.15.6-38-g1220e3c
    commit: 1220e3c6b8f94a00ac7afee15f21e6782655d97c

Component: intel-gpu-tools
    tag: intel-gpu-tools-1.19-312-gda197b5
    commit: da197b5f3cb516aaaea72d0d60b0f5c1c81081dd

Component: piglit
    tag: piglit-v1
    commit: 2753955998d7deb90f681cf4cb1253c4519dfd1d


======================================
             Software
======================================
kernel version              : 4.14.0-rc1-drm-tip-ww38-commit-ab2e3a0+
hostname                    : gfx-desktop
architecture                : x86_64
os version                  : Ubuntu 16.10
os codename                 : yakkety
kernel driver               : i915
bios revision               : 62.30
bios release date           : 08/22/2017
ksc                         : 1.48
hardware acceleration       : disabled
swap partition              : enabled on (/dev/sda3)

======================================
        Graphic drivers
======================================
grep: /opt/X11R7/var/log/Xorg.0.log: No such file or directory
libdrm                      : 2.4.83
cairo                       : 1.15.9
intel-gpu-tools (tag)       : intel-gpu-tools-1.19-312-gda197b5
intel-gpu-tools (commit)    : da197b5

======================================
             Hardware
======================================
platform                   : Geminilake
motherboard model          : Geminilake
motherboard id             : GLKRVP1DDR4(05)
form factor                : Hand Held
manufacturer               : IntelCorp.
cpu family                 : Pentium
cpu family id              : 6
cpu information            : Intel(R) Pentium(R) Silver J5005 CPU @ 1.50GHz
gpu card                   : Intel Corporation Device 3184 (rev 03) (prog-if 00 [VGA controller])
memory ram                 : 7.6 GB
max memory ram             : 16 GB
cpu thread                 : 4
cpu core                   : 4
cpu model                  : 122
cpu stepping               : 1
socket                     : Other
signature                  : Type 0, Family 6, Model 122, Stepping 1
hard drive                 : 111GiB (120GB)
current cd clock frequency : 316800 kHz
maximum cd clock frequency : 316800 kHz
displays connected         : eDP-1 DP-1 HDMI-A-2

======================================
             Firmware
======================================
dmc fw loaded             : yes
dmc version               : 1.4
guc fw loaded             : SUCCESS
guc version wanted        : 10.56
guc version found         : 10.56
huc fw loaded             : yes

======================================
             kernel parameters
======================================
quiet splash drm.debug=0xe i915.enable_guc_submission=2 i915.enable_guc_loading=2 i915.alpha_support=1 resume=/dev/sda3

Comment 8 Hector Velazquez 2017-09-20 16:56:55 UTC

Created attachment 134377 [details]
output (GLK)

Comment 9 Hector Velazquez 2017-09-20 16:57:15 UTC

Created attachment 134378 [details]
Dmesg (GLK)

Comment 10 Hector Velazquez 2017-09-28 12:54:44 UTC

This test is still failing on GLK QA

Tests List:

igt@perf@oa-exponents


====================================================
Output
====================================================
. . .
**** DEBUG ****
(perf:1991) DEBUG: requesting pinned GT freq = 450mhz
(perf:1991) DEBUG: Testing OA timer exponents with requested GT frequency = 450mhz
(perf:1991) DEBUG: ITER 0: testing OA exponent 5 (period = 3333ns) with sysfs GT freq = 450mhz +- 45
(perf:1991) DEBUG: read restart: OA trigger collision / report lost
(perf:1991) DEBUG: read restart: OA trigger collision / report lost
(perf:1991) DEBUG: read report: reason = 2a0ea015, timestamp = 49adc620, exponent mask=3f
(perf:1991) DEBUG: read report: reason = 2a0ea015, timestamp = 49adc660, exponent mask=3f
(perf:1991) DEBUG: ITER 0: time delta = 3333(ns) clock delta = 1166 freq = 349(mhz)
(perf:1991) DEBUG: ITER 1: testing OA exponent 5 (period = 3333ns) with sysfs GT freq = 450mhz +- 45
(perf:1991) DEBUG: read restart: OA trigger collision / report lost
(perf:1991) DEBUG: read report: reason = 360ea01b, timestamp = 49b1d3a0, exponent mask=3f
(perf:1991) DEBUG: read report: reason = 360ea01b, timestamp = 49b1d3e0, exponent mask=3f
(perf:1991) DEBUG: ITER 1: time delta = 3333(ns) clock delta = 1494 freq = 448(mhz)
(perf:1991) DEBUG: ITER 2: testing OA exponent 5 (period = 3333ns) with sysfs GT freq = 450mhz +- 45
(perf:1991) DEBUG: read restart: OA trigger collision / report lost
(perf:1991) DEBUG: read restart: OA trigger collision / report lost
(perf:1991) DEBUG: read restart: OA trigger collision / report lost
(perf:1991) DEBUG: read report: reason = 240ea012, timestamp = 49ba2ae0, exponent mask=3f
(perf:1991) DEBUG: read report: reason = 240ea012, timestamp = 49ba2b20, exponent mask=3f
(perf:1991) DEBUG: ITER 2: time delta = 3333(ns) clock delta = 996 freq = 298(mhz)
(perf:1991) DEBUG: ITER 3: testing OA exponent 5 (period = 3333ns) with sysfs GT freq = 450mhz +- 45
(perf:1991) DEBUG: read restart: OA trigger collision / report lost
(perf:1991) DEBUG: read restart: OA trigger collision / report lost
(perf:1991) DEBUG: read report: reason = 240ea012, timestamp = 49bf5420, exponent mask=3f
(perf:1991) DEBUG: read report: reason = 240ea012, timestamp = 49bf5460, exponent mask=3f
(perf:1991) DEBUG: ITER 3: time delta = 3333(ns) clock delta = 996 freq = 298(mhz)
(perf:1991) DEBUG: ITER 4: testing OA exponent 5 (period = 3333ns) with sysfs GT freq = 450mhz +- 45
(perf:1991) DEBUG: read restart: OA trigger collision / report lost
(perf:1991) DEBUG: read restart: OA trigger collision / report lost
(perf:1991) DEBUG: read report: reason = 240ea012, timestamp = 49c706a0, exponent mask=3f
(perf:1991) DEBUG: read report: reason = 240ea012, timestamp = 49c706e0, exponent mask=3f
(perf:1991) DEBUG: ITER 4: time delta = 3333(ns) clock delta = 1002 freq = 300(mhz)
(perf:1991) DEBUG: ITER 5: testing OA exponent 5 (period = 3333ns) with sysfs GT freq = 450mhz +- 45
(perf:1991) DEBUG: read restart: OA trigger collision / report lost
(perf:1991) DEBUG: read restart: OA trigger collision / report lost
(perf:1991) DEBUG: read report: reason = 240ea012, timestamp = 49cc22e0, exponent mask=3f
(perf:1991) DEBUG: read report: reason = 240ea012, timestamp = 49cc2320, exponent mask=3f
(perf:1991) DEBUG: ITER 5: time delta = 3333(ns) clock delta = 999 freq = 299(mhz)
(perf:1991) DEBUG: ITER 6: testing OA exponent 5 (period = 3333ns) with sysfs GT freq = 450mhz +- 45
(perf:1991) DEBUG: read restart: OA trigger collision / report lost
(perf:1991) DEBUG: read restart: OA trigger collision / report lost
(perf:1991) DEBUG: read report: reason = 240ee012, timestamp = 49d33d20, exponent mask=3f
(perf:1991) DEBUG: read report: reason = 240ea012, timestamp = 49d33d60, exponent mask=3f
(perf:1991) DEBUG: ITER 6: time delta = 3333(ns) clock delta = 1002 freq = 300(mhz)
(perf:1991) DEBUG: ITER 7: testing OA exponent 5 (period = 3333ns) with sysfs GT freq = 450mhz +- 45
(perf:1991) DEBUG: read restart: OA trigger collision / report lost
(perf:1991) DEBUG: read restart: OA trigger collision / report lost
(perf:1991) DEBUG: read report: reason = 240ea012, timestamp = 49da7860, exponent mask=3f
(perf:1991) DEBUG: read report: reason = 240ea012, timestamp = 49da78a0, exponent mask=3f
(perf:1991) DEBUG: ITER 7: time delta = 3333(ns) clock delta = 996 freq = 298(mhz)
(perf:1991) DEBUG: ITER 8: testing OA exponent 5 (period = 3333ns) with sysfs GT freq = 450mhz +- 45
(perf:1991) DEBUG: read restart: OA trigger collision / report lost
(perf:1991) DEBUG: read restart: OA trigger collision / report lost
(perf:1991) DEBUG: read restart: OA trigger collision / report lost
(perf:1991) DEBUG: read report: reason = 2a0ea015, timestamp = 49e38460, exponent mask=3f
(perf:1991) DEBUG: read report: reason = 2a0ea015, timestamp = 49e384a0, exponent mask=3f
(perf:1991) DEBUG: ITER 8: time delta = 3333(ns) clock delta = 1169 freq = 350(mhz)
(perf:1991) DEBUG: ITER 9: testing OA exponent 5 (period = 3333ns) with sysfs GT freq = 450mhz +- 45
(perf:1991) DEBUG: read restart: OA trigger collision / report lost
(perf:1991) DEBUG: read restart: OA trigger collision / report lost
(perf:1991) DEBUG: read restart: OA trigger collision / report lost
(perf:1991) DEBUG: read report: reason = 240ea012, timestamp = 49eabf20, exponent mask=3f
(perf:1991) DEBUG: read report: reason = 240ea012, timestamp = 49eabf60, exponent mask=3f
(perf:1991) DEBUG: ITER 9: time delta = 3333(ns) clock delta = 996 freq = 298(mhz)
(perf:1991) DEBUG: number of iterations with expected clock frequency = 1
(perf:1991) CRITICAL: Test assertion failure function test_oa_exponents, file perf.c:1515:
(perf:1991) CRITICAL: Failed assertion: n_freq_matches >= 7
(perf:1991) igt-core-INFO: Stack trace:
(perf:1991) igt-core-INFO:   #0 [__igt_fail_assert+0x101]
(perf:1991) igt-core-INFO:   #1 [test_oa_exponents+0x3ab]
(perf:1991) igt-core-INFO:   #2 [__real_main3226+0x1452]
(perf:1991) igt-core-INFO:   #3 [main+0x23]
(perf:1991) igt-core-INFO:   #4 [__libc_start_main+0xf1]
(perf:1991) igt-core-INFO:   #5 [_start+0x29]
(perf:1991) igt-core-INFO:   #6 [<unknown>+0x29]
****  END  ****
. . .


This is my configuration:

======================================
        Graphic stack
======================================
Component: drm
    tag: libdrm-2.4.81-56-g7c71188
    commit: 7c71188610b4ceba0339c2bc884320bcb749adee

Component: cairo
    tag: 1.15.6-42-gdccbed7
    commit: dccbed7d78d32bd3b912e8810379451dd94e6a1f

Component: intel-gpu-tools
    tag: intel-gpu-tools-1.19-332-g0a91a5e
    commit: 0a91a5e9624d41d23b79e2540eda111cb56d42d9

Component: piglit
    tag: piglit-v1
    commit: 95e2f51a28b6cf7ff77d84e1234121c98f10ef64
	
======================================
             Software
======================================
kernel version              : 4.14.0-rc2-drm-tip-ww39-commit-d76cbbc+
hostname                    : GLK-2-GLKRVP1DDR405
architecture                : x86_64
os version                  : Ubuntu 16.10
os codename                 : yakkety
kernel driver               : i915
bios revision               : 62.30
bios release date           : 08/22/2017
ksc                         : 1.41
hardware acceleration       : disabled
swap partition              : enabled on (/dev/sda3)

======================================
        Graphic drivers
======================================
grep: /opt/X11R7/var/log/Xorg.0.log: No such file or directory
libdrm                      : 2.4.83
cairo                       : 1.15.9
intel-gpu-tools (tag)       : intel-gpu-tools-1.19-332-g0a91a5e
intel-gpu-tools (commit)    : 0a91a5e

======================================
             Hardware
======================================
. . .

======================================
             Firmware
======================================
dmc fw loaded             : yes
dmc version               : 1.4
guc fw loaded             : SUCCESS
guc version wanted        : 10.56
guc version found         : 10.56
huc fw loaded             : yes

======================================
             kernel parameters
======================================
quiet drm.debug=0xe pci=pcie_bus_safe i915.alpha_support=1 i915.enable_guc_loading=2 i915.enable_guc_submission=2 intel_iommu=igfx_off auto panic=1 nmi_watchdog=panic resume=/dev/sda3 fastboot

Comment 11 Hector Velazquez 2017-10-03 15:44:44 UTC

This tests still failing on GLK QA

Tests List:

igt@perf@oa-exponents


====================================================
Output 
====================================================
. . .
I

This is my configuration:

======================================
        Graphic stack
======================================
Component: drm
    tag: libdrm-2.4.81-57-g1dd84e0
    commit: 1dd84e01a972b1759839a7326009be24ab3e6de2

Component: cairo
    tag: 1.15.6-42-gdccbed7
    commit: dccbed7d78d32bd3b912e8810379451dd94e6a1f

Component: intel-gpu-tools
    tag: intel-gpu-tools-1.19-357-g1e99f8b
    commit: 1e99f8b8d2563d7f5c4e82932bab15abc5eacaef

Component: piglit
    tag: piglit-v1
    commit: 5aa6eea37f44f818632a3dad4c1a7478085bd56d

	
======================================
	     Software
======================================
kernel version              : 4.14.0-rc3-drm-tip-ww40-commit-2f14e31+
hostname                    : GLK-1-GLKRVP1DDR405
architecture                : x86_64
os version                  : Ubuntu 16.10
os codename                 : yakkety
kernel driver               : i915
bios revision               : 62.30
bios release date           : 08/22/2017
ksc                         : 1.41
hardware acceleration       : disabled
swap partition              : enabled on (/dev/sda3)

======================================
	Graphic drivers
======================================
libdrm                      : 2.4.83
cairo                       : 1.15.9
intel-gpu-tools (tag)       : intel-gpu-tools-1.19-357-g1e99f8b
intel-gpu-tools (commit)    : 1e99f8b

======================================
	     Hardware
======================================
. . .

======================================
	     Firmware
======================================
dmc fw loaded             : yes
dmc version               : 1.4
guc fw loaded             : SUCCESS
guc version wanted        : 10.56
guc version found         : 10.56

======================================
	     kernel parameters
======================================
quiet drm.debug=0x1e pci=pcie_bus_safe intel_iommu=igfx_off auto panic=1 nmi_watchdog=panic i915.alpha_support=1 i915.enable_guc_loading=2 i915.enable_guc_submission=2 resume=/dev/sda3 fastboot

Comment 12 mwa 2017-10-18 22:03:07 UTC

The oa-exponents test was recently reworked, might be worth trying:

commit 4a8d621cdf876bd3774cec719fd4e92b77ff86aa
Author: Lionel Landwerlin <lionel.g.landwerlin@intel.com>
Date:   Mon Apr 24 22:28:57 2017 -0700

    tests/perf: rework oa-exponent test
    
    New issues that were discovered while making the tests work on Gen8+ :
    
     - we need to measure timings between periodic reports and discard all
       other kind of reports
    
     - it seems periodicity of the reports can be affected outside of RC6
       (frequency change), we can detect this by looking at the amount of
       clock cycles per timestamp deltas

Comment 13 Octavio 2017-12-26 16:10:25 UTC

This test still fails on APL

igt@perf@oa-exponents

using IGT-Version: 1.20-g865a47c (x86_64) (Linux: 4.15.0-rc4-drm-intel-qa-ww51-commit-b480e79+ x86_64)

Comment 14 Elizabeth 2018-02-14 18:52:40 UTC

Removing SKL since last seen was more than 20 days ago.

Comment 15 Elizabeth 2018-02-14 19:05:30 UTC

This fail hasn't been seen in igt all for more than a month, and though same issue than bug 102254 was seen last week, the next one the issue wasn't present. So I'm closing this bug and if issue 102254 appear again will be reported on that bug.
Thanks.

Comment 16 Hector Velazquez 2018-02-15 21:50:29 UTC

This tests has passed successfully on GLK QA 

Tests List:

igt@perf@oa-exponents

IGT-Version: 1.21-g37bd27f (x86_64) (Linux: 4.15.0-drm-intel-qa-ww6-commit-6c10ba2+ x86_64)

Use of freedesktop.org services, including Bugzilla, is subject to our Code of Conduct. How we collect and use information is described in our Privacy Policy.