[90.336622] Initializing watchdogs [90.336664] /dev/watchdog0 [90.340485] [001/160] (960s left) i915_module_load (load) [90.368891] Starting subtest: load [96.937688] Subtest load: SUCCESS (6.569s) [96.944963] [002/160] (953s left) core_auth (basic-auth) [96.985950] Starting subtest: basic-auth [96.986840] Subtest basic-auth: SUCCESS (0.001s) [97.073210] [003/160] (953s left) debugfs_test (read_all_entries) [97.118373] Starting subtest: read_all_entries [97.256584] Subtest read_all_entries: SUCCESS (0.138s) [99.237894] [004/160] (951s left) debugfs_test (basic-hwmon) [99.288123] Starting subtest: basic-hwmon [99.289898] Subtest basic-hwmon: SKIP (0.000s) [101.271130] [005/160] (949s left) fbdev (eof) [101.305188] Starting subtest: eof [101.306180] Subtest eof: SUCCESS (0.000s) [101.352612] [006/160] (949s left) fbdev (info) [101.377416] Starting subtest: info [101.378213] Subtest info: SUCCESS (0.000s) [101.437276] [007/160] (949s left) fbdev (nullptr) [101.471717] Starting subtest: nullptr [101.472791] Subtest nullptr: SUCCESS (0.000s) [101.523744] [008/160] (949s left) fbdev (read) [101.572094] Starting subtest: read [104.058563] Subtest read: SUCCESS (2.478s) [104.103427] [009/160] (946s left) fbdev (write) [104.138391] Starting subtest: write [105.972983] Subtest write: SUCCESS (1.825s) [106.020288] [010/160] (944s left) gem_basic (bad-close) [106.057563] Starting subtest: bad-close [106.059046] Subtest bad-close: SUCCESS (0.000s) [106.125163] [011/160] (944s left) gem_basic (create-close) [106.161819] Starting subtest: create-close [106.163787] Subtest create-close: SUCCESS (0.000s) [106.225072] [012/160] (944s left) gem_basic (create-fd-close) [106.257772] Starting subtest: create-fd-close [106.259726] Subtest create-fd-close: SUCCESS (0.000s) [106.322774] [013/160] (944s left) gem_busy (busy@all-engines) [106.371851] Starting subtest: busy [106.372929] Starting dynamic subtest: all-engines [106.406083] Dynamic subtest all-engines: SUCCESS (0.034s) [106.406830] Subtest busy: SUCCESS (0.035s) [106.743604] [014/160] (944s left) gem_close_race (basic-process) [106.807867] Starting subtest: basic-process [106.841606] Subtest basic-process: SUCCESS (0.033s) [107.007987] [015/160] (943s left) gem_close_race (basic-threads) [107.064881] Starting subtest: basic-threads [108.256745] Subtest basic-threads: SUCCESS (1.192s) [108.440320] [016/160] (942s left) gem_ctx_create (basic) [108.486493] Starting subtest: basic [108.487608] Subtest basic: SUCCESS (0.000s) [108.656323] [017/160] (942s left) gem_ctx_create (basic-files) [108.709207] Starting subtest: basic-files [110.716657] Subtest basic-files: SUCCESS (2.008s) [110.990093] [018/160] (940s left) gem_ctx_exec (basic) [111.031811] Starting subtest: basic [111.034242] Subtest basic: SUCCESS (0.003s) [111.126758] [019/160] (939s left) gem_exec_basic (basic) [111.177864] Starting subtest: basic [111.179250] Starting dynamic subtest: rcs0-smem [111.180284] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [111.185475] Starting dynamic subtest: bcs0-smem [111.186246] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [111.190958] Starting dynamic subtest: vcs0-smem [111.191745] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [111.195324] Starting dynamic subtest: vcs1-smem [111.196180] Dynamic subtest vcs1-smem: SUCCESS (0.000s) [111.199702] Starting dynamic subtest: vecs0-smem [111.200646] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [111.201560] Subtest basic: SUCCESS (0.004s) [111.358757] [020/160] (939s left) gem_exec_create (basic) [111.412021] Starting subtest: basic [111.412869] Starting dynamic subtest: smem [113.502276] Dynamic subtest smem: SUCCESS (2.090s) [113.503559] Subtest basic: SUCCESS (2.090s) [113.676400] [021/160] (937s left) gem_exec_fence (basic-busy) [113.849975] Starting subtest: basic-busy [113.851045] Starting dynamic subtest: rcs0 [113.910019] Dynamic subtest rcs0: SUCCESS (0.069s) [113.916926] Starting dynamic subtest: bcs0 [113.961596] Dynamic subtest bcs0: SUCCESS (0.051s) [113.974232] Starting dynamic subtest: vcs0 [114.013966] Dynamic subtest vcs0: SUCCESS (0.052s) [114.027381] Starting dynamic subtest: vcs1 [114.061751] Dynamic subtest vcs1: SUCCESS (0.047s) [114.073768] Starting dynamic subtest: vecs0 [114.110072] Dynamic subtest vecs0: SUCCESS (0.048s) [114.111813] Subtest basic-busy: SUCCESS (0.269s) [114.610867] [022/160] (936s left) gem_exec_fence (basic-wait) [114.785526] Starting subtest: basic-wait [114.786443] Starting dynamic subtest: rcs0 [114.829595] Dynamic subtest rcs0: SUCCESS (0.052s) [114.837383] Starting dynamic subtest: bcs0 [114.882484] Dynamic subtest bcs0: SUCCESS (0.053s) [114.895211] Starting dynamic subtest: vcs0 [114.934297] Dynamic subtest vcs0: SUCCESS (0.051s) [114.945630] Starting dynamic subtest: vcs1 [114.982738] Dynamic subtest vcs1: SUCCESS (0.048s) [114.995139] Starting dynamic subtest: vecs0 [115.038379] Dynamic subtest vecs0: SUCCESS (0.055s) [115.040077] Subtest basic-wait: SUCCESS (0.261s) [115.493485] [023/160] (935s left) gem_exec_fence (basic-await) [115.667523] Starting subtest: basic-await [115.668353] Starting dynamic subtest: rcs0 [115.728423] Dynamic subtest rcs0: SUCCESS (0.069s) [115.735419] Starting dynamic subtest: bcs0 [115.799269] Dynamic subtest bcs0: SUCCESS (0.070s) [115.804544] Starting dynamic subtest: vcs0 [115.867898] Dynamic subtest vcs0: SUCCESS (0.068s) [115.876922] Starting dynamic subtest: vcs1 [115.940870] Dynamic subtest vcs1: SUCCESS (0.073s) [115.949278] Starting dynamic subtest: vecs0 [116.011884] Dynamic subtest vecs0: SUCCESS (0.071s) [116.013873] Subtest basic-await: SUCCESS (0.353s) [116.479282] [024/160] (934s left) gem_exec_fence (nb-await) [116.652688] Starting subtest: nb-await [116.653744] Starting dynamic subtest: rcs0 [116.701122] Dynamic subtest rcs0: SUCCESS (0.058s) [116.706262] Starting dynamic subtest: bcs0 [116.757729] Dynamic subtest bcs0: SUCCESS (0.057s) [116.764154] Starting dynamic subtest: vcs0 [116.815131] Dynamic subtest vcs0: SUCCESS (0.057s) [116.826386] Starting dynamic subtest: vcs1 [116.876939] Dynamic subtest vcs1: SUCCESS (0.062s) [116.882415] Starting dynamic subtest: vecs0 [116.934785] Dynamic subtest vecs0: SUCCESS (0.056s) [116.936496] Subtest nb-await: SUCCESS (0.291s) [117.414977] [025/160] (933s left) gem_exec_gttfill (basic) [117.468785] Starting subtest: basic [119.669745] Subtest basic: SUCCESS (2.192s) [119.847164] [026/160] (931s left) gem_exec_parallel (engines) [119.933339] Starting subtest: engines [119.934125] Starting dynamic subtest: basic [121.253992] Dynamic subtest basic: SUCCESS (1.320s) [121.262354] Starting dynamic subtest: contexts [123.067879] Dynamic subtest contexts: SUCCESS (1.805s) [123.072794] Starting dynamic subtest: fds [125.196881] Dynamic subtest fds: SUCCESS (2.138s) [125.202095] Starting dynamic subtest: userptr [126.492052] Dynamic subtest userptr: SUCCESS (1.295s) [126.493832] Subtest engines: SUCCESS (6.558s) [126.667504] [027/160] (924s left) gem_exec_store (basic) [126.711341] Starting subtest: basic [126.790467] Subtest basic: SUCCESS (0.078s) [126.963258] [028/160] (924s left) gem_flink_basic (bad-flink) [127.001811] Starting subtest: bad-flink [127.002883] Subtest bad-flink: SUCCESS (0.000s) [127.075439] [029/160] (924s left) gem_flink_basic (bad-open) [127.122013] Starting subtest: bad-open [127.123279] Subtest bad-open: SUCCESS (0.000s) [127.210476] [030/160] (923s left) gem_flink_basic (basic) [127.254917] Starting subtest: basic [127.256020] Subtest basic: SUCCESS (0.000s) [127.344252] [031/160] (923s left) gem_flink_basic (double-flink) [127.382814] Starting subtest: double-flink [127.383898] Subtest double-flink: SUCCESS (0.000s) [127.459991] [032/160] (923s left) gem_flink_basic (flink-lifetime) [127.506017] Starting subtest: flink-lifetime [127.506905] Subtest flink-lifetime: SUCCESS (0.001s) [127.575723] [033/160] (923s left) gem_huc_copy (huc-copy) [127.614546] Starting subtest: huc-copy [127.616261] Subtest huc-copy: SUCCESS (0.002s) [127.713599] [034/160] (923s left) gem_linear_blits (basic) [127.857871] Starting subtest: basic [127.863285] Subtest basic: SUCCESS (0.005s) [127.980206] [035/160] (923s left) gem_mmap (basic) [128.054500] Starting subtest: basic [128.058137] Subtest basic: SUCCESS (0.000s) [128.145623] [036/160] (923s left) gem_mmap_gtt (basic) [128.187661] Starting subtest: basic [128.188629] Subtest basic: SUCCESS (0.001s) [128.247406] [037/160] (922s left) gem_render_linear_blits (basic) [128.300844] Starting subtest: basic [128.323876] Subtest basic: SUCCESS (0.023s) [128.401933] [038/160] (922s left) gem_render_tiled_blits (basic) [128.444695] Starting subtest: basic [128.467748] Subtest basic: SUCCESS (0.023s) [128.528452] [039/160] (922s left) gem_ringfill (basic-all) [128.866053] Starting subtest: basic-all [130.009720] Subtest basic-all: SUCCESS (1.136s) [130.110420] [040/160] (921s left) gem_softpin (allocator-basic) [130.152615] Starting subtest: allocator-basic [130.199311] Subtest allocator-basic: SUCCESS (0.047s) [130.310423] [041/160] (920s left) gem_softpin (allocator-basic-reserve) [130.347581] Starting subtest: allocator-basic-reserve [130.394308] Subtest allocator-basic-reserve: SUCCESS (0.047s) [130.494629] [042/160] (920s left) gem_softpin (safe-alignment) [130.540156] Starting subtest: safe-alignment [130.548143] Subtest safe-alignment: SUCCESS (0.008s) [130.645436] [043/160] (920s left) gem_sync (basic-all) [130.706628] Starting subtest: basic-all [133.184761] Subtest basic-all: SUCCESS (2.478s) [133.365459] [044/160] (917s left) gem_sync (basic-each) [133.413875] Starting subtest: basic-each [135.702947] Subtest basic-each: SUCCESS (2.290s) [135.879299] [045/160] (915s left) gem_tiled_blits (basic) [135.997080] Starting subtest: basic [136.008854] Subtest basic: SUCCESS (0.012s) [136.133910] [046/160] (915s left) gem_tiled_fence_blits (basic) [136.282847] Starting subtest: basic [136.302529] Subtest basic: SUCCESS (0.019s) [136.403760] [047/160] (914s left) gem_tiled_pread_basic [136.531730] [048/160] (914s left) gem_wait (busy@all-engines) [136.585129] Starting subtest: busy [136.585974] Starting dynamic subtest: all-engines [137.141672] Dynamic subtest all-engines: SUCCESS (0.556s) [137.143251] Subtest busy: SUCCESS (0.556s) [137.329175] [049/160] (914s left) gem_wait (wait@all-engines) [137.372732] Starting subtest: wait [137.373598] Starting dynamic subtest: all-engines [138.425076] Dynamic subtest all-engines: SUCCESS (1.051s) [138.426805] Subtest wait: SUCCESS (1.052s) [138.629434] [050/160] (912s left) i915_getparams_basic (basic-eu-total) [138.669870] Starting subtest: basic-eu-total [138.671402] Subtest basic-eu-total: SUCCESS (0.000s) [138.744594] [051/160] (912s left) i915_getparams_basic (basic-subslice-total) [138.781776] Starting subtest: basic-subslice-total [138.783217] Subtest basic-subslice-total: SUCCESS (0.000s) [138.844430] [052/160] (912s left) i915_hangman (error-state-basic) [138.898723] Starting subtest: error-state-basic [138.985949] Subtest error-state-basic: SUCCESS (0.088s) [139.040289] [053/160] (912s left) i915_pciid [139.161171] [054/160] (912s left) kms_addfb_basic (addfb25-4-tiled) [141.134922] Starting subtest: addfb25-4-tiled [141.135917] Subtest addfb25-4-tiled: SUCCESS (0.000s) [141.209623] [055/160] (910s left) kms_addfb_basic (addfb25-bad-modifier) [141.254890] Starting subtest: addfb25-bad-modifier [141.255751] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [143.241790] [056/160] (908s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [143.289266] Starting subtest: addfb25-framebuffer-vs-set-tiling [143.290317] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [145.275339] [057/160] (906s left) kms_addfb_basic (addfb25-modifier-no-flag) [145.320363] Starting subtest: addfb25-modifier-no-flag [145.321391] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [147.308352] [058/160] (904s left) kms_addfb_basic (addfb25-x-tiled-legacy) [147.352038] Starting subtest: addfb25-x-tiled-legacy [147.352983] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [149.363288] [059/160] (902s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [149.400030] Starting subtest: addfb25-x-tiled-mismatch-legacy [149.400945] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [151.393687] [060/160] (900s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [153.356907] Starting subtest: addfb25-yf-tiled-legacy [153.358066] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [153.445806] [061/160] (898s left) kms_addfb_basic (addfb25-y-tiled-legacy) [155.420842] Starting subtest: addfb25-y-tiled-legacy [155.421720] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [155.494199] [062/160] (896s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [157.462792] Starting subtest: addfb25-y-tiled-small-legacy [157.463585] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [157.525243] [063/160] (893s left) kms_addfb_basic (bad-pitch-0) [157.563747] Starting subtest: bad-pitch-0 [157.564558] Subtest bad-pitch-0: SUCCESS (0.000s) [159.560685] [064/160] (891s left) kms_addfb_basic (bad-pitch-1024) [159.597695] Starting subtest: bad-pitch-1024 [159.598585] Subtest bad-pitch-1024: SUCCESS (0.000s) [161.593120] [065/160] (889s left) kms_addfb_basic (bad-pitch-128) [161.629811] Starting subtest: bad-pitch-128 [161.630673] Subtest bad-pitch-128: SUCCESS (0.000s) [163.629088] [066/160] (887s left) kms_addfb_basic (bad-pitch-256) [163.672161] Starting subtest: bad-pitch-256 [163.673336] Subtest bad-pitch-256: SUCCESS (0.000s) [165.678633] [067/160] (885s left) kms_addfb_basic (bad-pitch-32) [165.725404] Starting subtest: bad-pitch-32 [165.726391] Subtest bad-pitch-32: SUCCESS (0.000s) [167.709233] [068/160] (883s left) kms_addfb_basic (bad-pitch-63) [167.756392] Starting subtest: bad-pitch-63 [167.757344] Subtest bad-pitch-63: SUCCESS (0.000s) [169.743638] [069/160] (881s left) kms_addfb_basic (bad-pitch-65536) [169.791478] Starting subtest: bad-pitch-65536 [169.792468] Subtest bad-pitch-65536: SUCCESS (0.000s) [171.776917] [070/160] (879s left) kms_addfb_basic (bad-pitch-999) [171.820047] Starting subtest: bad-pitch-999 [171.821065] Subtest bad-pitch-999: SUCCESS (0.000s) [173.811626] [071/160] (877s left) kms_addfb_basic (basic) [173.851799] Starting subtest: basic [173.852619] Subtest basic: SUCCESS (0.000s) [175.844470] [072/160] (875s left) kms_addfb_basic (basic-x-tiled-legacy) [175.893124] Starting subtest: basic-x-tiled-legacy [175.893958] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [177.878317] [073/160] (873s left) kms_addfb_basic (basic-y-tiled-legacy) [177.922064] Starting subtest: basic-y-tiled-legacy [177.922986] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [179.909273] [074/160] (871s left) kms_addfb_basic (bo-too-small) [181.875816] Starting subtest: bo-too-small [181.876828] Subtest bo-too-small: SUCCESS (0.000s) [181.944535] [075/160] (869s left) kms_addfb_basic (bo-too-small-due-to-tiling) [183.907817] Starting subtest: bo-too-small-due-to-tiling [183.908812] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [183.997288] [076/160] (867s left) kms_addfb_basic (clobberred-modifier) [184.037954] Starting subtest: clobberred-modifier [184.038950] Subtest clobberred-modifier: SUCCESS (0.000s) [186.028143] [077/160] (865s left) kms_addfb_basic (framebuffer-vs-set-tiling) [186.069210] Starting subtest: framebuffer-vs-set-tiling [186.070153] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [188.080222] [078/160] (863s left) kms_addfb_basic (invalid-get-prop) [188.126183] Starting subtest: invalid-get-prop [188.127118] Subtest invalid-get-prop: SUCCESS (0.000s) [190.130073] [079/160] (861s left) kms_addfb_basic (invalid-get-prop-any) [190.169509] Starting subtest: invalid-get-prop-any [190.170324] Subtest invalid-get-prop-any: SUCCESS (0.000s) [192.145555] [080/160] (859s left) kms_addfb_basic (invalid-set-prop) [192.190129] Starting subtest: invalid-set-prop [192.191136] Subtest invalid-set-prop: SUCCESS (0.000s) [194.197663] [081/160] (857s left) kms_addfb_basic (invalid-set-prop-any) [194.253061] Starting subtest: invalid-set-prop-any [194.254144] Subtest invalid-set-prop-any: SUCCESS (0.000s) [196.246227] [082/160] (855s left) kms_addfb_basic (no-handle) [196.287153] Starting subtest: no-handle [196.288178] Subtest no-handle: SUCCESS (0.000s) [198.279182] [083/160] (853s left) kms_addfb_basic (size-max) [200.245589] Starting subtest: size-max [200.246623] Subtest size-max: SUCCESS (0.000s) [200.332877] [084/160] (851s left) kms_addfb_basic (small-bo) [202.295690] Starting subtest: small-bo [202.296465] Subtest small-bo: SUCCESS (0.000s) [202.381653] [085/160] (849s left) kms_addfb_basic (tile-pitch-mismatch) [202.424949] Starting subtest: tile-pitch-mismatch [202.425810] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [204.412380] [086/160] (847s left) kms_addfb_basic (too-high) [206.380661] Starting subtest: too-high [206.381621] Subtest too-high: SUCCESS (0.000s) [206.445853] [087/160] (845s left) kms_addfb_basic (too-wide) [208.407735] Starting subtest: too-wide [208.408792] Subtest too-wide: SUCCESS (0.000s) [208.499408] [088/160] (843s left) kms_addfb_basic (unused-handle) [208.553385] Starting subtest: unused-handle [208.554318] Subtest unused-handle: SUCCESS (0.000s) [210.567014] [089/160] (841s left) kms_addfb_basic (unused-modifier) [210.606883] Starting subtest: unused-modifier [210.607841] Subtest unused-modifier: SUCCESS (0.000s) [212.599030] [090/160] (839s left) kms_addfb_basic (unused-offsets) [212.640163] Starting subtest: unused-offsets [212.641203] Subtest unused-offsets: SUCCESS (0.000s) [214.630733] [091/160] (837s left) kms_addfb_basic (unused-pitches) [214.673094] Starting subtest: unused-pitches [214.674011] Subtest unused-pitches: SUCCESS (0.000s) [216.662954] [092/160] (835s left) kms_busy (basic) [218.622446] Starting subtest: basic [218.623286] Starting dynamic subtest: flip [219.188909] Dynamic subtest flip: SUCCESS (0.564s) [219.193567] Starting dynamic subtest: modeset [219.954521] Dynamic subtest modeset: SUCCESS (0.766s) [219.955377] Subtest basic: SUCCESS (1.332s) [220.132971] [093/160] (831s left) kms_prop_blob (basic) [220.171927] Starting subtest: basic [220.172881] Subtest basic: SUCCESS (0.000s) [220.252091] [094/160] (831s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [222.226047] Starting subtest: basic-busy-flip-before-cursor-atomic [222.228085] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [222.279559] [095/160] (829s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [224.249913] Starting subtest: basic-busy-flip-before-cursor-legacy [224.251922] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [224.314040] [096/160] (827s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [226.276509] Starting subtest: basic-flip-after-cursor-atomic [227.258066] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.982s) [227.428899] [097/160] (824s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [229.402960] Starting subtest: basic-flip-after-cursor-legacy [230.385025] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.981s) [230.540928] [098/160] (821s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [232.518902] Starting subtest: basic-flip-after-cursor-varying-size [233.483171] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.964s) [233.645430] [099/160] (818s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [235.613853] Starting subtest: basic-flip-before-cursor-atomic [236.587399] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.973s) [236.738123] [100/160] (815s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [238.707833] Starting subtest: basic-flip-before-cursor-legacy [239.693955] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.986s) [239.856020] [101/160] (812s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [241.819901] Starting subtest: basic-flip-before-cursor-varying-size [242.795833] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.976s) [242.960483] [102/160] (808s left) kms_dsc (dsc-basic) [244.927909] Starting subtest: dsc-basic [244.930041] Subtest dsc-basic: SKIP (0.000s) [244.980324] [103/160] (806s left) kms_flip (basic-flip-vs-dpms) [246.953763] Starting subtest: basic-flip-vs-dpms [246.955778] Starting dynamic subtest: A-DP1 [247.837951] Dynamic subtest A-DP1: SUCCESS (0.882s) [247.842772] Starting dynamic subtest: B-DP1 [248.589506] Dynamic subtest B-DP1: SUCCESS (0.751s) [248.594455] Starting dynamic subtest: C-DP1 [249.342920] Dynamic subtest C-DP1: SUCCESS (0.753s) [249.350388] Starting dynamic subtest: D-DP1 [250.091490] Dynamic subtest D-DP1: SUCCESS (0.748s) [250.093548] Subtest basic-flip-vs-dpms: SUCCESS (3.140s) [250.248341] [104/160] (801s left) kms_flip (basic-flip-vs-modeset) [252.213773] Starting subtest: basic-flip-vs-modeset [252.215503] Starting dynamic subtest: A-DP1 [253.112665] Dynamic subtest A-DP1: SUCCESS (0.897s) [253.118136] Starting dynamic subtest: B-DP1 [253.869612] Dynamic subtest B-DP1: SUCCESS (0.756s) [253.874714] Starting dynamic subtest: C-DP1 [254.624856] Dynamic subtest C-DP1: SUCCESS (0.754s) [254.629769] Starting dynamic subtest: D-DP1 [255.376893] Dynamic subtest D-DP1: SUCCESS (0.752s) [255.378964] Subtest basic-flip-vs-modeset: SUCCESS (3.165s) [255.529840] [105/160] (796s left) kms_flip (basic-flip-vs-wf_vblank) [257.503330] Starting subtest: basic-flip-vs-wf_vblank [257.505481] Starting dynamic subtest: A-DP1 [258.744722] Dynamic subtest A-DP1: SUCCESS (1.238s) [258.752525] Starting dynamic subtest: B-DP1 [259.760666] Dynamic subtest B-DP1: SUCCESS (1.011s) [259.769387] Starting dynamic subtest: C-DP1 [260.773053] Dynamic subtest C-DP1: SUCCESS (1.011s) [260.782599] Starting dynamic subtest: D-DP1 [261.789673] Dynamic subtest D-DP1: SUCCESS (1.015s) [261.795878] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.292s) [262.010819] [106/160] (789s left) kms_flip (basic-plain-flip) [263.974568] Starting subtest: basic-plain-flip [263.976606] Starting dynamic subtest: A-DP1 [264.754309] Dynamic subtest A-DP1: SUCCESS (0.777s) [264.764847] Starting dynamic subtest: B-DP1 [265.486644] Dynamic subtest B-DP1: SUCCESS (0.729s) [265.495591] Starting dynamic subtest: C-DP1 [266.219295] Dynamic subtest C-DP1: SUCCESS (0.728s) [266.227401] Starting dynamic subtest: D-DP1 [266.949105] Dynamic subtest D-DP1: SUCCESS (0.728s) [266.954941] Subtest basic-plain-flip: SUCCESS (2.981s) [267.168243] [107/160] (784s left) kms_force_connector_basic (force-connector-state) [267.240075] Starting subtest: force-connector-state [269.349813] Subtest force-connector-state: SUCCESS (2.110s) [271.512546] [108/160] (780s left) kms_force_connector_basic (force-edid) [271.584755] Starting subtest: force-edid [271.634323] Subtest force-edid: SUCCESS (0.050s) [273.712522] [109/160] (778s left) kms_force_connector_basic (force-load-detect) [273.779629] Starting subtest: force-load-detect [273.781063] Subtest force-load-detect: SKIP (0.000s) [274.864277] [110/160] (777s left) kms_force_connector_basic (prune-stale-modes) [274.928781] Starting subtest: prune-stale-modes [274.976989] Subtest prune-stale-modes: SUCCESS (0.048s) [277.028648] [111/160] (775s left) kms_frontbuffer_tracking (basic) [278.995359] Starting subtest: basic [282.445218] Subtest basic: SUCCESS (3.450s) [282.551721] [112/160] (769s left) kms_hdmi_inject (inject-audio) [282.673978] Starting subtest: inject-audio [282.808457] Subtest inject-audio: SUCCESS (0.136s) [284.005193] [113/160] (768s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [285.978111] Starting subtest: compare-crc-sanitycheck-xr24 [285.979175] Starting dynamic subtest: pipe-A-DP-1 [286.418348] Dynamic subtest pipe-A-DP-1: SUCCESS (0.436s) [286.425640] Starting dynamic subtest: pipe-B-DP-1 [286.814560] Dynamic subtest pipe-B-DP-1: SUCCESS (0.400s) [286.819463] Starting dynamic subtest: pipe-C-DP-1 [287.211863] Dynamic subtest pipe-C-DP-1: SUCCESS (0.396s) [287.216742] Starting dynamic subtest: pipe-D-DP-1 [287.610837] Dynamic subtest pipe-D-DP-1: SUCCESS (0.397s) [287.611680] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.633s) [287.770736] [114/160] (764s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [289.726782] Starting subtest: compare-crc-sanitycheck-nv12 [289.727668] Starting dynamic subtest: pipe-A-DP-1 [290.307135] Dynamic subtest pipe-A-DP-1: SUCCESS (0.579s) [290.311782] Starting dynamic subtest: pipe-B-DP-1 [290.856310] Dynamic subtest pipe-B-DP-1: SUCCESS (0.547s) [290.861179] Starting dynamic subtest: pipe-C-DP-1 [291.401705] Dynamic subtest pipe-C-DP-1: SUCCESS (0.544s) [291.406666] Starting dynamic subtest: pipe-D-DP-1 [291.947504] Dynamic subtest pipe-D-DP-1: SUCCESS (0.545s) [291.948334] Subtest compare-crc-sanitycheck-nv12: SUCCESS (2.220s) [292.108609] [115/160] (759s left) kms_pipe_crc_basic (hang-read-crc) [294.069834] Starting subtest: hang-read-crc [294.070669] Starting dynamic subtest: pipe-A-DP-1 [295.225663] Dynamic subtest pipe-A-DP-1: SUCCESS (1.155s) [295.231547] Starting dynamic subtest: pipe-B-DP-1 [296.321681] Dynamic subtest pipe-B-DP-1: SUCCESS (1.094s) [296.326524] Starting dynamic subtest: pipe-C-DP-1 [297.434095] Dynamic subtest pipe-C-DP-1: SUCCESS (1.112s) [297.439200] Starting dynamic subtest: pipe-D-DP-1 [298.540813] Dynamic subtest pipe-D-DP-1: SUCCESS (1.105s) [298.541646] Subtest hang-read-crc: SUCCESS (4.470s) [298.686050] [116/160] (753s left) kms_pipe_crc_basic (nonblocking-crc) [300.654112] Starting subtest: nonblocking-crc [300.655150] Starting dynamic subtest: pipe-A-DP-1 [301.288895] Dynamic subtest pipe-A-DP-1: SUCCESS (0.634s) [301.294770] Starting dynamic subtest: pipe-B-DP-1 [301.868026] Dynamic subtest pipe-B-DP-1: SUCCESS (0.577s) [301.875263] Starting dynamic subtest: pipe-C-DP-1 [302.442101] Dynamic subtest pipe-C-DP-1: SUCCESS (0.573s) [302.446892] Starting dynamic subtest: pipe-D-DP-1 [303.025823] Dynamic subtest pipe-D-DP-1: SUCCESS (0.582s) [303.026732] Subtest nonblocking-crc: SUCCESS (2.371s) [303.171629] [117/160] (748s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [305.146984] Starting subtest: nonblocking-crc-frame-sequence [305.148163] Starting dynamic subtest: pipe-A-DP-1 [305.756565] Dynamic subtest pipe-A-DP-1: SUCCESS (0.608s) [305.761486] Starting dynamic subtest: pipe-B-DP-1 [306.329778] Dynamic subtest pipe-B-DP-1: SUCCESS (0.573s) [306.334547] Starting dynamic subtest: pipe-C-DP-1 [306.905966] Dynamic subtest pipe-C-DP-1: SUCCESS (0.574s) [306.910829] Starting dynamic subtest: pipe-D-DP-1 [307.488537] Dynamic subtest pipe-D-DP-1: SUCCESS (0.581s) [307.489475] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.341s) [307.634094] [118/160] (744s left) kms_pipe_crc_basic (read-crc) [309.602026] Starting subtest: read-crc [309.603166] Starting dynamic subtest: pipe-A-DP-1 [310.180060] Dynamic subtest pipe-A-DP-1: SUCCESS (0.572s) [310.184869] Starting dynamic subtest: pipe-B-DP-1 [310.691278] Dynamic subtest pipe-B-DP-1: SUCCESS (0.509s) [310.696026] Starting dynamic subtest: pipe-C-DP-1 [311.195880] Dynamic subtest pipe-C-DP-1: SUCCESS (0.508s) [311.201109] Starting dynamic subtest: pipe-D-DP-1 [311.710881] Dynamic subtest pipe-D-DP-1: SUCCESS (0.514s) [311.714572] Subtest read-crc: SUCCESS (2.109s) [311.856676] [119/160] (740s left) kms_pipe_crc_basic (read-crc-frame-sequence) [313.822927] Starting subtest: read-crc-frame-sequence [313.824100] Starting dynamic subtest: pipe-A-DP-1 [314.358620] Dynamic subtest pipe-A-DP-1: SUCCESS (0.534s) [314.363344] Starting dynamic subtest: pipe-B-DP-1 [314.867565] Dynamic subtest pipe-B-DP-1: SUCCESS (0.508s) [314.872089] Starting dynamic subtest: pipe-C-DP-1 [315.379488] Dynamic subtest pipe-C-DP-1: SUCCESS (0.510s) [315.385559] Starting dynamic subtest: pipe-D-DP-1 [315.876008] Dynamic subtest pipe-D-DP-1: SUCCESS (0.495s) [315.876946] Subtest read-crc-frame-sequence: SUCCESS (2.053s) [316.019201] [120/160] (736s left) kms_pm_backlight (basic-brightness) [317.982494] Subtest basic-brightness: SKIP (0.000s) [318.005568] [121/160] (734s left) kms_pm_rpm (basic-pci-d3-state) [322.144335] Starting subtest: basic-pci-d3-state [324.917034] Subtest basic-pci-d3-state: SUCCESS (2.774s) [325.982198] [122/160] (726s left) kms_pm_rpm (basic-rte) [326.009266] Starting subtest: basic-rte [332.333961] Subtest basic-rte: SUCCESS (6.325s) [334.614077] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 1790 [max: 8192] direct dependencies: 18326 [max: 32768] indirect dependencies: 135881 all direct dependencies: 358699 dependency chains: 27203 [max: 131072] dependency chain hlocks used: 115302 [max: 655360] dependency chain hlocks lost: 0 in-hardirq chains: 271 in-softirq chains: 608 in-process chains: 26324 stack-trace entries: 174457 [max: 1048576] number of stack traces: 8759 number of stack hash chains: 6763 combined max dependencies: 65716304 hardirq-safe locks: 97 hardirq-unsafe locks: 1067 softirq-safe locks: 206 softirq-unsafe locks: 977 irq-safe locks: 222 irq-unsafe locks: 1067 hardirq-read-safe locks: 3 hardirq-read-unsafe locks: 326 softirq-read-safe locks: 7 softirq-read-unsafe locks: 321 irq-read-safe locks: 7 irq-read-unsafe locks: 326 uncategorized locks: 289 unused locks: 1 max locking depth: 16 max bfs queue depth: 430 max lock class index: 1789 chain lookup misses: 27640 chain lookup hits: 443694099 cyclic checks: 27815 redundant checks: 0 redundant links: 0 find-mask forwards checks: 4651 find-mask backwards checks: 2693 hardirq on events: 208981122 hardirq off events: 208981106 redundant hardirq ons: 48 redundant hardirq offs: 23 softirq on events: 1183105 softirq off events: 1183105 redundant softirq ons: 0 redundant softirq offs: 0 debug_locks: 0 zapped classes: 1 zapped lock chains: 107 large chain blocks: 1 [334.614982] Closing watchdogs Done.