[69.140943] Initializing watchdogs [69.141089] /dev/watchdog0 [69.166527] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:4e71 Intel Jasperlake (Gen11) JasperLake [UHD Graphics] [69.174100] [001/162] (960s left) i915_module_load (load) [69.249364] Starting subtest: load [71.264971] Subtest load: SUCCESS (2.039s) [71.308445] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [71.310190] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [71.314804] [002/162] (958s left) core_auth (basic-auth) [71.377936] Starting subtest: basic-auth [71.379941] Subtest basic-auth: SUCCESS (0.001s) [71.515471] [003/162] (958s left) core_debugfs (read-all-entries) [71.573073] Starting subtest: read-all-entries [71.659438] Subtest read-all-entries: SUCCESS (0.088s) [71.768956] [004/162] (958s left) core_sysfs (read-all-entries) [71.827708] Starting subtest: read-all-entries [71.829568] Subtest read-all-entries: SUCCESS (0.004s) [71.930921] [005/162] (957s left) fbdev (eof) [72.007605] Starting subtest: eof [72.009808] Subtest eof: SUCCESS (0.001s) [72.132361] [006/162] (957s left) fbdev (info) [72.187988] Starting subtest: info [72.189785] Subtest info: SUCCESS (0.000s) [72.294228] [007/162] (957s left) fbdev (nullptr) [72.349531] Starting subtest: nullptr [72.351495] Subtest nullptr: SUCCESS (0.000s) [72.440204] [008/162] (957s left) fbdev (read) [72.497605] Starting subtest: read [83.513389] Subtest read: SUCCESS (11.073s) [83.614345] [009/162] (946s left) fbdev (write) [83.672692] Starting subtest: write [89.536102] Subtest write: SUCCESS (5.872s) [89.637837] [010/162] (940s left) gem_basic (bad-close) [89.696288] Starting subtest: bad-close [89.699582] Subtest bad-close: SUCCESS (0.000s) [89.790454] [011/162] (940s left) gem_basic (create-close) [89.846226] Starting subtest: create-close [89.849682] Subtest create-close: SUCCESS (0.000s) [89.960972] [012/162] (940s left) gem_basic (create-fd-close) [90.016437] Starting subtest: create-fd-close [90.019832] Subtest create-fd-close: SUCCESS (0.000s) [90.141883] [013/162] (940s left) gem_busy (busy@all-engines) [90.215874] Starting subtest: busy [90.217867] Starting dynamic subtest: all-engines [90.254071] Dynamic subtest all-engines: SUCCESS (0.038s) [90.255991] Subtest busy: SUCCESS (0.039s) [90.676719] [014/162] (939s left) gem_close_race (basic-process) [90.751363] Starting subtest: basic-process [90.810492] Subtest basic-process: SUCCESS (0.059s) [91.042547] [015/162] (939s left) gem_close_race (basic-threads) [91.113721] Starting subtest: basic-threads [92.254466] Subtest basic-threads: SUCCESS (1.142s) [92.519351] [016/162] (937s left) gem_ctx_create (basic) [92.602115] Starting subtest: basic [92.604109] Subtest basic: SUCCESS (0.000s) [92.832771] [017/162] (937s left) gem_ctx_create (basic-files) [92.913200] Starting subtest: basic-files [94.940185] Subtest basic-files: SUCCESS (2.028s) [95.233719] [018/162] (935s left) gem_ctx_exec (basic) [95.338478] Starting subtest: basic [95.343214] Subtest basic: SUCCESS (0.007s) [95.523525] [019/162] (935s left) gem_exec_basic (basic) [95.630119] Starting subtest: basic [95.632454] Starting dynamic subtest: rcs0-smem [95.634715] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [95.655428] Starting dynamic subtest: bcs0-smem [95.657452] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [95.676992] Starting dynamic subtest: vcs0-smem [95.679121] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [95.698670] Starting dynamic subtest: vecs0-smem [95.700744] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [95.702756] Subtest basic: SUCCESS (0.008s) [95.900693] [020/162] (934s left) gem_exec_create (basic) [96.009959] Starting subtest: basic [96.011910] Starting dynamic subtest: smem [98.058798] Dynamic subtest smem: SUCCESS (2.048s) [98.061418] Subtest basic: SUCCESS (2.049s) [98.337608] [021/162] (932s left) gem_exec_fence (basic-busy) [98.606767] Starting subtest: basic-busy [98.609238] Starting dynamic subtest: rcs0 [98.636295] Dynamic subtest rcs0: SUCCESS (0.029s) [98.658875] Starting dynamic subtest: bcs0 [98.665841] Dynamic subtest bcs0: SUCCESS (0.027s) [98.687280] Starting dynamic subtest: vcs0 [98.691507] Dynamic subtest vcs0: SUCCESS (0.023s) [98.711416] Starting dynamic subtest: vecs0 [98.715441] Dynamic subtest vecs0: SUCCESS (0.023s) [98.717205] Subtest basic-busy: SUCCESS (0.106s) [99.419994] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [99.424243] [022/162] (931s left) gem_exec_fence (basic-wait) [99.655438] Starting subtest: basic-wait [99.657231] Starting dynamic subtest: rcs0 [99.694547] Dynamic subtest rcs0: SUCCESS (0.039s) [99.716012] Starting dynamic subtest: bcs0 [99.724410] Dynamic subtest bcs0: SUCCESS (0.030s) [99.741321] Starting dynamic subtest: vcs0 [99.748190] Dynamic subtest vcs0: SUCCESS (0.023s) [99.764820] Starting dynamic subtest: vecs0 [99.772284] Dynamic subtest vecs0: SUCCESS (0.024s) [99.774364] Subtest basic-wait: SUCCESS (0.118s) [100.369764] [023/162] (930s left) gem_exec_fence (basic-await) [100.583158] Starting subtest: basic-await [100.585093] Starting dynamic subtest: rcs0 [100.671833] Dynamic subtest rcs0: SUCCESS (0.087s) [100.714770] Starting dynamic subtest: bcs0 [100.800666] Dynamic subtest bcs0: SUCCESS (0.127s) [100.846718] Starting dynamic subtest: vcs0 [100.937147] Dynamic subtest vcs0: SUCCESS (0.133s) [100.982237] Starting dynamic subtest: vecs0 [101.069746] Dynamic subtest vecs0: SUCCESS (0.135s) [101.072905] Subtest basic-await: SUCCESS (0.487s) [101.681252] [024/162] (929s left) gem_exec_fence (nb-await) [101.891395] Starting subtest: nb-await [101.893339] Starting dynamic subtest: rcs0 [101.955837] Dynamic subtest rcs0: SUCCESS (0.065s) [101.978448] Starting dynamic subtest: bcs0 [102.026349] Dynamic subtest bcs0: SUCCESS (0.069s) [102.070666] Starting dynamic subtest: vcs0 [102.109641] Dynamic subtest vcs0: SUCCESS (0.081s) [102.158161] Starting dynamic subtest: vecs0 [102.196471] Dynamic subtest vecs0: SUCCESS (0.085s) [102.199416] Subtest nb-await: SUCCESS (0.306s) [102.796152] [025/162] (928s left) gem_exec_gttfill (basic) [102.867173] Starting subtest: basic [109.694467] Subtest basic: SUCCESS (6.825s) [109.974476] [026/162] (921s left) gem_exec_parallel (engines) [110.134457] Starting subtest: engines [110.136755] Starting dynamic subtest: basic [113.606657] Dynamic subtest basic: SUCCESS (3.471s) [113.644898] Starting dynamic subtest: contexts [119.895751] Dynamic subtest contexts: SUCCESS (6.288s) [119.925354] Starting dynamic subtest: fds [128.212032] Dynamic subtest fds: SUCCESS (8.315s) [128.254636] Starting dynamic subtest: userptr [132.256353] Dynamic subtest userptr: SUCCESS (4.043s) [132.258696] Subtest engines: SUCCESS (22.120s) [132.584456] [027/162] (898s left) gem_exec_store (basic) [132.708748] Starting subtest: basic [132.778714] Subtest basic: SUCCESS (0.070s) [133.047964] [028/162] (898s left) gem_flink_basic (bad-flink) [133.132157] Starting subtest: bad-flink [133.134143] Subtest bad-flink: SUCCESS (0.000s) [133.277042] [029/162] (898s left) gem_flink_basic (bad-open) [133.357518] Starting subtest: bad-open [133.359494] Subtest bad-open: SUCCESS (0.000s) [133.492427] [030/162] (898s left) gem_flink_basic (basic) [133.571867] Starting subtest: basic [133.573988] Subtest basic: SUCCESS (0.000s) [133.722980] [031/162] (897s left) gem_flink_basic (double-flink) [133.795825] Starting subtest: double-flink [133.797895] Subtest double-flink: SUCCESS (0.000s) [133.935954] [032/162] (897s left) gem_flink_basic (flink-lifetime) [134.009156] Starting subtest: flink-lifetime [134.013723] Subtest flink-lifetime: SUCCESS (0.003s) [134.169457] [033/162] (897s left) gem_huc_copy (huc-copy) [134.250167] Starting subtest: huc-copy [134.253794] Subtest huc-copy: SKIP (0.000s) [134.400711] [034/162] (897s left) gem_linear_blits (basic) [134.566942] Starting subtest: basic [134.580209] Subtest basic: SUCCESS (0.014s) [134.759937] [035/162] (897s left) gem_mmap (basic) [134.876291] Starting subtest: basic [134.885628] Subtest basic: SUCCESS (0.000s) [135.016244] [036/162] (897s left) gem_mmap_gtt (basic) [135.087421] Starting subtest: basic [135.089523] Subtest basic: SUCCESS (0.001s) [135.234578] [037/162] (896s left) gem_render_linear_blits (basic) [135.312132] Starting subtest: basic [135.358147] Subtest basic: SUCCESS (0.045s) [135.466165] [038/162] (896s left) gem_render_tiled_blits (basic) [135.547980] Starting subtest: basic [135.601514] Subtest basic: SUCCESS (0.055s) [135.720917] [039/162] (896s left) gem_ringfill (basic-all) [135.982823] Starting subtest: basic-all [137.180550] Subtest basic-all: SUCCESS (1.196s) [137.402637] [040/162] (895s left) gem_softpin (allocator-basic) [137.532143] Starting subtest: allocator-basic [137.810142] Subtest allocator-basic: SUCCESS (0.276s) [138.018135] [041/162] (894s left) gem_softpin (allocator-basic-reserve) [138.122726] Starting subtest: allocator-basic-reserve [138.353855] Subtest allocator-basic-reserve: SUCCESS (0.231s) [138.536879] [042/162] (894s left) gem_softpin (safe-alignment) [138.635251] Starting subtest: safe-alignment [138.657295] Subtest safe-alignment: SUCCESS (0.022s) [138.830379] [043/162] (893s left) gem_sync (basic-all) [138.937328] Starting subtest: basic-all [141.381638] Subtest basic-all: SUCCESS (2.444s) [141.662042] [044/162] (891s left) gem_sync (basic-each) [141.778518] Starting subtest: basic-each [144.098465] Subtest basic-each: SUCCESS (2.319s) [144.439408] [045/162] (888s left) gem_tiled_blits (basic) [144.701622] Starting subtest: basic [144.738551] Subtest basic: SUCCESS (0.037s) [144.952833] [046/162] (888s left) gem_tiled_fence_blits (basic) [145.241488] Starting subtest: basic [145.283344] Subtest basic: SUCCESS (0.045s) [145.448951] [047/162] (887s left) gem_tiled_pread_basic (basic) [145.591321] Starting subtest: basic [145.974545] Subtest basic: SUCCESS (0.384s) [146.122929] [048/162] (887s left) gem_wait (busy@all-engines) [146.227069] Starting subtest: busy [146.229255] Starting dynamic subtest: all-engines [146.753762] Dynamic subtest all-engines: SUCCESS (0.526s) [146.756149] Subtest busy: SUCCESS (0.527s) [147.051839] [049/162] (886s left) gem_wait (wait@all-engines) [147.167030] Starting subtest: wait [147.169163] Starting dynamic subtest: all-engines [148.203623] Dynamic subtest all-engines: SUCCESS (1.037s) [148.206041] Subtest wait: SUCCESS (1.037s) [148.518596] [050/162] (884s left) i915_getparams_basic (basic-eu-total) [148.619616] Starting subtest: basic-eu-total [148.623122] Subtest basic-eu-total: SUCCESS (0.000s) [148.774148] [051/162] (884s left) i915_getparams_basic (basic-subslice-total) [148.866212] Starting subtest: basic-subslice-total [148.870423] Subtest basic-subslice-total: SUCCESS (0.000s) [149.019789] [052/162] (884s left) i915_hangman (error-state-basic) [149.129541] Starting subtest: error-state-basic [149.142562] Subtest error-state-basic: SUCCESS (0.012s) [149.297839] [053/162] (884s left) i915_pciid [149.514969] [054/162] (884s left) intel_hwmon (hwmon-read) [149.606867] Subtest hwmon-read: SKIP (0.000s) [149.708055] [055/162] (884s left) intel_hwmon (hwmon-write) [149.790812] Subtest hwmon-write: SKIP (0.000s) [149.892258] [056/162] (884s left) kms_addfb_basic (addfb25-4-tiled) [150.052333] Starting subtest: addfb25-4-tiled [150.054366] Subtest addfb25-4-tiled: SUCCESS (0.001s) [150.210567] [057/162] (883s left) kms_addfb_basic (addfb25-bad-modifier) [150.364428] Starting subtest: addfb25-bad-modifier [150.366590] Subtest addfb25-bad-modifier: SUCCESS (0.001s) [150.530405] [058/162] (883s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [150.684356] Starting subtest: addfb25-framebuffer-vs-set-tiling [150.686423] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [150.844109] [059/162] (883s left) kms_addfb_basic (addfb25-modifier-no-flag) [150.991277] Starting subtest: addfb25-modifier-no-flag [150.993267] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [151.143799] [060/162] (883s left) kms_addfb_basic (addfb25-x-tiled-legacy) [151.293337] Starting subtest: addfb25-x-tiled-legacy [151.295301] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [151.440515] [061/162] (882s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [151.587223] Starting subtest: addfb25-x-tiled-mismatch-legacy [151.589273] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [151.741454] [062/162] (882s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [151.890184] Starting subtest: addfb25-yf-tiled-legacy [151.892245] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [152.037536] [063/162] (882s left) kms_addfb_basic (addfb25-y-tiled-legacy) [152.185291] Starting subtest: addfb25-y-tiled-legacy [152.187190] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [152.339326] [064/162] (882s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [152.483847] Starting subtest: addfb25-y-tiled-small-legacy [152.485865] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s) [152.639096] [065/162] (882s left) kms_addfb_basic (bad-pitch-0) [152.714641] Starting subtest: bad-pitch-0 [152.716670] Subtest bad-pitch-0: SUCCESS (0.000s) [152.958377] [066/162] (881s left) kms_addfb_basic (bad-pitch-1024) [153.034099] Starting subtest: bad-pitch-1024 [153.036059] Subtest bad-pitch-1024: SUCCESS (0.000s) [153.257198] [067/162] (881s left) kms_addfb_basic (bad-pitch-128) [153.333267] Starting subtest: bad-pitch-128 [153.334939] Subtest bad-pitch-128: SUCCESS (0.000s) [153.557601] [068/162] (881s left) kms_addfb_basic (bad-pitch-256) [153.632782] Starting subtest: bad-pitch-256 [153.634460] Subtest bad-pitch-256: SUCCESS (0.000s) [153.856723] [069/162] (881s left) kms_addfb_basic (bad-pitch-32) [153.931170] Starting subtest: bad-pitch-32 [153.932853] Subtest bad-pitch-32: SUCCESS (0.000s) [154.152754] [070/162] (880s left) kms_addfb_basic (bad-pitch-63) [154.227383] Starting subtest: bad-pitch-63 [154.229453] Subtest bad-pitch-63: SUCCESS (0.000s) [154.458648] [071/162] (880s left) kms_addfb_basic (bad-pitch-65536) [154.533491] Starting subtest: bad-pitch-65536 [154.535183] Subtest bad-pitch-65536: SUCCESS (0.001s) [154.754082] [072/162] (880s left) kms_addfb_basic (bad-pitch-999) [154.828389] Starting subtest: bad-pitch-999 [154.830078] Subtest bad-pitch-999: SUCCESS (0.000s) [155.053751] [073/162] (880s left) kms_addfb_basic (basic) [155.128189] Starting subtest: basic [155.130262] Subtest basic: SUCCESS (0.000s) [155.340249] [074/162] (880s left) kms_addfb_basic (basic-x-tiled-legacy) [155.419510] Starting subtest: basic-x-tiled-legacy [155.421203] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [155.641199] [075/162] (879s left) kms_addfb_basic (basic-y-tiled-legacy) [155.721024] Starting subtest: basic-y-tiled-legacy [155.722725] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [155.940701] [076/162] (879s left) kms_addfb_basic (bo-too-small) [156.089360] Starting subtest: bo-too-small [156.091361] Subtest bo-too-small: SUCCESS (0.001s) [156.240665] [077/162] (879s left) kms_addfb_basic (bo-too-small-due-to-tiling) [156.390224] Starting subtest: bo-too-small-due-to-tiling [156.392206] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s) [156.574736] [078/162] (879s left) kms_addfb_basic (clobberred-modifier) [156.649766] Starting subtest: clobberred-modifier [156.651455] Subtest clobberred-modifier: SUCCESS (0.000s) [156.878410] [079/162] (878s left) kms_addfb_basic (framebuffer-vs-set-tiling) [156.954249] Starting subtest: framebuffer-vs-set-tiling [156.955919] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [157.177420] [080/162] (878s left) kms_addfb_basic (invalid-get-prop) [157.253019] Starting subtest: invalid-get-prop [157.255140] Subtest invalid-get-prop: SUCCESS (0.000s) [157.477471] [081/162] (878s left) kms_addfb_basic (invalid-get-prop-any) [157.552166] Starting subtest: invalid-get-prop-any [157.554166] Subtest invalid-get-prop-any: SUCCESS (0.000s) [157.773771] [082/162] (878s left) kms_addfb_basic (invalid-set-prop) [157.848820] Starting subtest: invalid-set-prop [157.850943] Subtest invalid-set-prop: SUCCESS (0.000s) [158.075037] [083/162] (878s left) kms_addfb_basic (invalid-set-prop-any) [158.150675] Starting subtest: invalid-set-prop-any [158.152742] Subtest invalid-set-prop-any: SUCCESS (0.000s) [158.374816] [084/162] (877s left) kms_addfb_basic (no-handle) [158.451023] Starting subtest: no-handle [158.453116] Subtest no-handle: SUCCESS (0.000s) [158.672893] [085/162] (877s left) kms_addfb_basic (size-max) [158.818291] Starting subtest: size-max [158.820272] Subtest size-max: SUCCESS (0.000s) [158.975605] [086/162] (877s left) kms_addfb_basic (small-bo) [159.120320] Starting subtest: small-bo [159.122293] Subtest small-bo: SUCCESS (0.000s) [159.290666] [087/162] (877s left) kms_addfb_basic (tile-pitch-mismatch) [159.372340] Starting subtest: tile-pitch-mismatch [159.374262] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [159.595591] [088/162] (876s left) kms_addfb_basic (too-high) [159.743774] Starting subtest: too-high [159.745904] Subtest too-high: SUCCESS (0.001s) [159.908281] [089/162] (876s left) kms_addfb_basic (too-wide) [160.054212] Starting subtest: too-wide [160.056300] Subtest too-wide: SUCCESS (0.000s) [160.204556] [090/162] (876s left) kms_addfb_basic (unused-handle) [160.280531] Starting subtest: unused-handle [160.282620] Subtest unused-handle: SUCCESS (0.000s) [160.505831] [091/162] (876s left) kms_addfb_basic (unused-modifier) [160.584429] Starting subtest: unused-modifier [160.586120] Subtest unused-modifier: SUCCESS (0.000s) [160.808579] [092/162] (876s left) kms_addfb_basic (unused-offsets) [160.884753] Starting subtest: unused-offsets [160.886884] Subtest unused-offsets: SUCCESS (0.000s) [161.106400] [093/162] (875s left) kms_addfb_basic (unused-pitches) [161.184640] Starting subtest: unused-pitches [161.186814] Subtest unused-pitches: SUCCESS (0.000s) [161.408346] [094/162] (875s left) kms_busy (basic) [161.567061] Starting subtest: basic [161.569210] Starting dynamic subtest: flip [162.633648] Dynamic subtest flip: SUCCESS (1.063s) [162.655815] Starting dynamic subtest: modeset [164.336100] Dynamic subtest modeset: SUCCESS (1.700s) [164.338846] Subtest basic: SUCCESS (2.767s) [164.799035] [095/162] (872s left) kms_prop_blob (basic) [164.878657] Starting subtest: basic [164.880750] Subtest basic: SUCCESS (0.000s) [165.013262] [096/162] (872s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [165.161233] Starting subtest: basic-busy-flip-before-cursor-atomic [165.164810] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [165.293655] [097/162] (871s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [165.442240] Starting subtest: basic-busy-flip-before-cursor-legacy [165.445816] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [165.578344] [098/162] (871s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [165.728212] Starting subtest: basic-flip-after-cursor-atomic [166.799576] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.071s) [167.214124] [099/162] (870s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [167.347129] Starting subtest: basic-flip-after-cursor-legacy [168.395540] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.049s) [168.805991] [100/162] (868s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [168.933149] Starting subtest: basic-flip-after-cursor-varying-size [169.944538] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.013s) [170.383029] [101/162] (867s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [170.504078] Starting subtest: basic-flip-before-cursor-atomic [171.514846] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.010s) [171.944873] [102/162] (865s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [172.066115] Starting subtest: basic-flip-before-cursor-legacy [173.098551] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.032s) [173.499140] [103/162] (864s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [173.621202] Starting subtest: basic-flip-before-cursor-varying-size [174.665169] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.044s) [175.061788] [104/162] (862s left) kms_dsc (dsc-basic) [175.185144] Starting subtest: dsc-basic [175.193850] Subtest dsc-basic: SKIP (0.000s) [175.298689] [105/162] (862s left) kms_flip (basic-flip-vs-dpms) [175.423093] Starting subtest: basic-flip-vs-dpms [175.424942] Starting dynamic subtest: A-HDMI-A1 [176.879187] Dynamic subtest A-HDMI-A1: SUCCESS (1.452s) [176.901667] Starting dynamic subtest: B-HDMI-A1 [178.205577] Dynamic subtest B-HDMI-A1: SUCCESS (1.325s) [178.230866] Starting dynamic subtest: C-HDMI-A1 [179.560816] Dynamic subtest C-HDMI-A1: SUCCESS (1.355s) [179.562968] Subtest basic-flip-vs-dpms: SUCCESS (4.140s) [180.096406] [106/162] (857s left) kms_flip (basic-flip-vs-modeset) [180.249230] Starting subtest: basic-flip-vs-modeset [180.253701] Starting dynamic subtest: A-HDMI-A1 [181.833442] Dynamic subtest A-HDMI-A1: SUCCESS (1.580s) [181.862429] Starting dynamic subtest: B-HDMI-A1 [183.198781] Dynamic subtest B-HDMI-A1: SUCCESS (1.364s) [183.227633] Starting dynamic subtest: C-HDMI-A1 [184.591614] Dynamic subtest C-HDMI-A1: SUCCESS (1.389s) [184.593432] Subtest basic-flip-vs-modeset: SUCCESS (4.342s) [185.067932] [107/162] (852s left) kms_flip (basic-flip-vs-wf_vblank) [185.224133] Starting subtest: basic-flip-vs-wf_vblank [185.229099] Starting dynamic subtest: A-HDMI-A1 [186.793766] Dynamic subtest A-HDMI-A1: SUCCESS (1.564s) [186.817662] Starting dynamic subtest: B-HDMI-A1 [188.232883] Dynamic subtest B-HDMI-A1: SUCCESS (1.436s) [188.258862] Starting dynamic subtest: C-HDMI-A1 [189.670349] Dynamic subtest C-HDMI-A1: SUCCESS (1.434s) [189.676635] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.450s) [190.160881] [108/162] (847s left) kms_flip (basic-plain-flip) [190.284388] Starting subtest: basic-plain-flip [190.286460] Starting dynamic subtest: A-HDMI-A1 [191.493132] Dynamic subtest A-HDMI-A1: SUCCESS (1.208s) [191.518704] Starting dynamic subtest: B-HDMI-A1 [192.647075] Dynamic subtest B-HDMI-A1: SUCCESS (1.151s) [192.671151] Starting dynamic subtest: C-HDMI-A1 [193.819581] Dynamic subtest C-HDMI-A1: SUCCESS (1.170s) [193.821699] Subtest basic-plain-flip: SUCCESS (3.540s) [194.294176] [109/162] (843s left) kms_force_connector_basic (force-connector-state) [194.470866] Starting subtest: force-connector-state [195.005418] Subtest force-connector-state: SUCCESS (0.533s) [195.636915] [110/162] (842s left) kms_force_connector_basic (force-edid) [195.818876] Starting subtest: force-edid [196.012751] Subtest force-edid: SUCCESS (0.193s) [196.286481] [111/162] (842s left) kms_force_connector_basic (force-load-detect) [196.481919] Starting subtest: force-load-detect [196.485609] Subtest force-load-detect: SKIP (0.000s) [196.783273] [112/162] (841s left) kms_force_connector_basic (prune-stale-modes) [196.984963] Starting subtest: prune-stale-modes [197.191367] Subtest prune-stale-modes: SUCCESS (0.205s) [197.466494] [113/162] (841s left) kms_frontbuffer_tracking (basic) [197.636379] Starting subtest: basic [201.668883] Subtest basic: SUCCESS (4.034s) [201.836486] [114/162] (836s left) kms_hdmi_inject (inject-audio) [201.977423] Starting subtest: inject-audio [202.374398] Subtest inject-audio: SUCCESS (0.398s) [202.812807] [115/162] (835s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [202.936617] Starting subtest: compare-crc-sanitycheck-xr24 [202.938712] Starting dynamic subtest: pipe-A-HDMI-A-1 [203.473470] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.534s) [203.505909] Starting dynamic subtest: pipe-B-HDMI-A-1 [204.176335] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.696s) [204.200900] Starting dynamic subtest: pipe-C-HDMI-A-1 [204.837774] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.657s) [204.839722] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.901s) [205.257802] [116/162] (833s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [205.395917] Starting subtest: compare-crc-sanitycheck-nv12 [205.398166] Starting dynamic subtest: pipe-A-HDMI-A-1 [206.336495] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.938s) [206.359019] Starting dynamic subtest: pipe-B-HDMI-A-1 [207.440738] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.103s) [207.465648] Starting dynamic subtest: pipe-C-HDMI-A-1 [208.515418] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.070s) [208.517451] Subtest compare-crc-sanitycheck-nv12: SUCCESS (3.121s) [208.942034] [117/162] (829s left) kms_pipe_crc_basic (hang-read-crc) [209.081789] Starting subtest: hang-read-crc [209.083945] Starting dynamic subtest: pipe-A-HDMI-A-1 [210.564531] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.480s) [210.588937] Starting dynamic subtest: pipe-B-HDMI-A-1 [212.231497] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.663s) [212.254566] Starting dynamic subtest: pipe-C-HDMI-A-1 [213.817837] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.583s) [213.820217] Subtest hang-read-crc: SUCCESS (4.737s) [214.212652] [118/162] (824s left) kms_pipe_crc_basic (nonblocking-crc) [214.348928] Starting subtest: nonblocking-crc [214.351112] Starting dynamic subtest: pipe-A-HDMI-A-1 [215.062725] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.712s) [215.081993] Starting dynamic subtest: pipe-B-HDMI-A-1 [215.964700] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.898s) [215.996941] Starting dynamic subtest: pipe-C-HDMI-A-1 [216.870278] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.903s) [216.872401] Subtest nonblocking-crc: SUCCESS (2.524s) [217.279362] [119/162] (821s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [217.405743] Starting subtest: nonblocking-crc-frame-sequence [217.407928] Starting dynamic subtest: pipe-A-HDMI-A-1 [218.136546] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.727s) [218.166732] Starting dynamic subtest: pipe-B-HDMI-A-1 [218.994430] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.855s) [219.017666] Starting dynamic subtest: pipe-C-HDMI-A-1 [219.869122] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.871s) [219.871482] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.466s) [220.263788] [120/162] (818s left) kms_pipe_crc_basic (read-crc) [220.396989] Starting subtest: read-crc [220.399208] Starting dynamic subtest: pipe-A-HDMI-A-1 [221.047962] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.648s) [221.074885] Starting dynamic subtest: pipe-B-HDMI-A-1 [221.855397] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.804s) [221.874500] Starting dynamic subtest: pipe-C-HDMI-A-1 [222.666142] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.810s) [222.668506] Subtest read-crc: SUCCESS (2.273s) [223.070901] [121/162] (815s left) kms_pipe_crc_basic (read-crc-frame-sequence) [223.202661] Starting subtest: read-crc-frame-sequence [223.204712] Starting dynamic subtest: pipe-A-HDMI-A-1 [223.866055] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.660s) [223.885300] Starting dynamic subtest: pipe-B-HDMI-A-1 [224.700053] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.831s) [224.721317] Starting dynamic subtest: pipe-C-HDMI-A-1 [225.492482] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.788s) [225.494543] Subtest read-crc-frame-sequence: SUCCESS (2.290s) [225.893566] [122/162] (813s left) kms_pm_backlight (basic-brightness) [226.022387] Subtest basic-brightness: SKIP (0.000s) [226.123143] [123/162] (813s left) kms_pm_rpm (basic-pci-d3-state) [227.675339] Starting subtest: basic-pci-d3-state [228.282467] Subtest basic-pci-d3-state: SUCCESS (0.612s) [228.503064] [124/162] (810s left) kms_pm_rpm (basic-rte) [228.559474] Starting subtest: basic-rte [230.599404] Subtest basic-rte: SUCCESS (2.040s) [231.481413] [125/162] (807s left) kms_psr (psr-primary-page-flip) [231.603343] Subtest psr-primary-page-flip: SKIP (0.000s) [231.686298] [126/162] (807s left) kms_psr (psr-cursor-plane-move) [231.808098] Subtest psr-cursor-plane-move: SKIP (0.000s) [231.889430] [127/162] (807s left) kms_psr (psr-sprite-plane-onoff) [232.015058] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [232.105278] [128/162] (807s left) kms_psr (psr-primary-mmap-gtt) [232.227425] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [232.322069] [129/162] (807s left) kms_setmode (basic-clone-single-crtc) [232.382061] Starting subtest: basic-clone-single-crtc [232.387657] Subtest basic-clone-single-crtc: SKIP (0.000s) [232.498814] [130/162] (807s left) i915_pm_rps (basic-api) [232.566302] Starting subtest: basic-api [232.570749] Subtest basic-api: SUCCESS (0.004s) [232.719332] [131/162] (806s left) prime_self_import (basic-llseek-bad) [232.776667] Starting subtest: basic-llseek-bad [232.780643] Subtest basic-llseek-bad: SUCCESS (0.003s) [232.917906] [132/162] (806s left) prime_self_import (basic-llseek-size) [232.977633] Starting subtest: basic-llseek-size [232.981564] Subtest basic-llseek-size: SUCCESS (0.004s) [233.120545] [133/162] (806s left) prime_self_import (basic-with_fd_dup) [233.178196] Starting subtest: basic-with_fd_dup [233.181809] Subtest basic-with_fd_dup: SUCCESS (0.004s) [233.321684] [134/162] (806s left) prime_self_import (basic-with_one_bo) [233.381062] Starting subtest: basic-with_one_bo [233.385110] Subtest basic-with_one_bo: SUCCESS (0.004s) [233.532923] [135/162] (806s left) prime_self_import (basic-with_one_bo_two_files) [233.594662] Starting subtest: basic-with_one_bo_two_files [233.598679] Subtest basic-with_one_bo_two_files: SUCCESS (0.004s) [233.742694] [136/162] (806s left) prime_self_import (basic-with_two_bos) [233.806058] Starting subtest: basic-with_two_bos [233.809747] Subtest basic-with_two_bos: SUCCESS (0.005s) [233.960675] [137/162] (806s left) prime_vgem (basic-fence-flip) [234.048840] Starting subtest: basic-fence-flip [234.680038] Subtest basic-fence-flip: SUCCESS (0.631s) [234.846506] [138/162] (805s left) prime_vgem (basic-fence-mmap) [234.930626] Starting subtest: basic-fence-mmap [234.969990] Subtest basic-fence-mmap: SUCCESS (0.039s) [235.096406] [139/162] (805s left) prime_vgem (basic-fence-read) [235.174570] Starting subtest: basic-fence-read [235.259411] Subtest basic-fence-read: SUCCESS (0.084s) [235.400450] [140/162] (804s left) prime_vgem (basic-gtt) [235.491966] Starting subtest: basic-gtt [235.515306] Subtest basic-gtt: SUCCESS (0.023s) [235.669458] [141/162] (804s left) prime_vgem (basic-read) [235.769093] Starting subtest: basic-read [235.810685] Subtest basic-read: SUCCESS (0.044s) [235.953435] [142/162] (804s left) prime_vgem (basic-write) [236.042466] Starting subtest: basic-write [236.102578] Subtest basic-write: SUCCESS (0.060s) [236.237416] [143/162] (804s left) vgem_basic (setversion) [236.315543] Starting subtest: setversion [236.319553] Subtest setversion: SUCCESS (0.000s) [236.473544] [144/162] (804s left) vgem_basic (create) [236.549137] Starting subtest: create [236.551233] Subtest create: SUCCESS (0.000s) [236.670241] [145/162] (804s left) vgem_basic (debugfs) [236.749297] Starting subtest: debugfs [236.751411] Subtest debugfs: SUCCESS (0.001s) [236.872540] [146/162] (803s left) vgem_basic (dmabuf-export) [236.966060] Starting subtest: dmabuf-export [236.977545] Subtest dmabuf-export: SUCCESS (0.010s) [237.155833] [147/162] (803s left) vgem_basic (dmabuf-fence) [237.249294] Starting subtest: dmabuf-fence [237.251322] Subtest dmabuf-fence: SUCCESS (0.001s) [237.369153] [148/162] (803s left) vgem_basic (dmabuf-fence-before) [237.452358] Starting subtest: dmabuf-fence-before [237.454058] Subtest dmabuf-fence-before: SUCCESS (0.001s) [237.573076] [149/162] (803s left) vgem_basic (dmabuf-mmap) [237.665775] Starting subtest: dmabuf-mmap [237.686085] Subtest dmabuf-mmap: SUCCESS (0.021s) [237.805699] [150/162] (803s left) vgem_basic (mmap) [237.902211] Starting subtest: mmap [237.911339] Subtest mmap: SUCCESS (0.013s) [238.039590] [151/162] (803s left) vgem_basic (second-client) [238.135241] Starting subtest: second-client [238.170529] Subtest second-client: SUCCESS (0.033s) [238.291803] [152/162] (802s left) vgem_basic (sysfs) [238.385162] Starting subtest: sysfs [238.387221] Subtest sysfs: SUCCESS (0.001s) [238.506392] [153/162] (802s left) core_hotunplug (unbind-rebind) [238.667220] Starting subtest: unbind-rebind [242.389212] Subtest unbind-rebind: SUCCESS (3.720s) [242.456794] [154/162] (798s left) vgem_basic (unload) [242.522747] Starting subtest: unload [271.509309] Subtest unload: SUCCESS (28.987s) [271.658716] [155/162] (769s left) i915_module_load (reload) [271.715547] Starting subtest: reload [274.579948] Subtest reload: SUCCESS (2.867s) [274.643597] [156/162] (766s left) gem_lmem_swapping (basic) [274.720752] Subtest basic: SKIP (0.000s) [274.821060] [157/162] (766s left) gem_lmem_swapping (parallel-random-engines) [274.885836] Subtest parallel-random-engines: SKIP (0.000s) [274.966401] [158/162] (766s left) gem_lmem_swapping (random-engines) [275.030493] Subtest random-engines: SKIP (0.000s) [275.117374] [159/162] (766s left) gem_lmem_swapping (verify-random) [275.179330] Subtest verify-random: SKIP (0.000s) [275.264900] [160/162] (766s left) i915_pm_rpm (module-reload) [277.175932] Starting subtest: module-reload [295.901291] Subtest module-reload: SUCCESS (18.726s) [295.952550] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [295.954189] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [295.958230] [161/162] (745s left) i915_selftest (live)