[101.883272] Initializing watchdogs [101.883896] /dev/watchdog0 [102.036928] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:46d3 Intel Alderlake_n (Gen12) [102.077158] [001/161] (960s left) i915_module_load (load) [103.246934] Starting subtest: load [113.046297] Subtest load: SUCCESS (9.769s) [113.361843] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [113.379377] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [113.409962] [002/161] (949s left) core_auth (basic-auth) [113.998785] Starting subtest: basic-auth [114.016433] Subtest basic-auth: SUCCESS (0.017s) [114.487713] [003/161] (948s left) debugfs_test (read_all_entries) [114.959330] Starting subtest: read_all_entries [116.492608] Subtest read_all_entries: SUCCESS (1.535s) [116.971951] [004/161] (946s left) debugfs_test (basic-hwmon) [117.386765] Starting subtest: basic-hwmon [117.393210] Subtest basic-hwmon: SKIP (0.000s) [117.860892] [005/161] (946s left) debugfs_test (sysfs) [118.291079] Starting subtest: sysfs [118.754712] Subtest sysfs: SUCCESS (0.461s) [119.232329] [006/161] (945s left) fbdev (eof) [119.641418] Starting subtest: eof [119.648526] Subtest eof: SUCCESS (0.004s) [120.006541] [007/161] (944s left) fbdev (info) [120.387954] Starting subtest: info [120.391236] Subtest info: SUCCESS (0.000s) [120.762666] [008/161] (944s left) fbdev (nullptr) [121.153296] Starting subtest: nullptr [121.156400] Subtest nullptr: SUCCESS (0.000s) [121.507231] [009/161] (943s left) fbdev (read) [121.906996] Starting subtest: read [125.737102] Subtest read: SUCCESS (3.798s) [126.072326] [010/161] (939s left) fbdev (write) [126.476142] Starting subtest: write [128.465692] Subtest write: SUCCESS (1.984s) [128.827720] [011/161] (937s left) gem_basic (bad-close) [129.216294] Starting subtest: bad-close [129.223101] Subtest bad-close: SUCCESS (0.000s) [129.588530] [012/161] (936s left) gem_basic (create-close) [129.977269] Starting subtest: create-close [129.983308] Subtest create-close: SUCCESS (0.001s) [130.345968] [013/161] (936s left) gem_basic (create-fd-close) [130.730261] Starting subtest: create-fd-close [130.737972] Subtest create-fd-close: SUCCESS (0.001s) [131.129922] [014/161] (935s left) gem_busy (busy@all-engines) [131.618927] Starting subtest: busy [131.622375] Starting dynamic subtest: all-engines [131.959118] Dynamic subtest all-engines: SUCCESS (0.337s) [131.962264] Subtest busy: SUCCESS (0.339s) [132.781215] [015/161] (934s left) gem_close_race (basic-process) [133.276256] Starting subtest: basic-process [133.437050] Subtest basic-process: SUCCESS (0.161s) [133.942611] [016/161] (933s left) gem_close_race (basic-threads) [134.444668] Starting subtest: basic-threads [135.880587] Subtest basic-threads: SUCCESS (1.429s) [136.387617] [017/161] (931s left) gem_ctx_create (basic) [136.866861] Starting subtest: basic [136.870174] Subtest basic: SUCCESS (0.000s) [137.376981] [018/161] (930s left) gem_ctx_create (basic-files) [137.858291] Starting subtest: basic-files [140.000312] Subtest basic-files: SUCCESS (2.132s) [140.669683] [019/161] (927s left) gem_ctx_exec (basic) [141.076618] Starting subtest: basic [141.098176] Subtest basic: SUCCESS (0.024s) [141.529750] [020/161] (927s left) gem_exec_basic (basic) [141.980085] Starting subtest: basic [141.983106] Starting dynamic subtest: rcs0-smem [141.991833] Dynamic subtest rcs0-smem: SUCCESS (0.010s) [142.052844] Starting dynamic subtest: bcs0-smem [142.056108] Dynamic subtest bcs0-smem: SUCCESS (0.004s) [142.111370] Starting dynamic subtest: vcs0-smem [142.114539] Dynamic subtest vcs0-smem: SUCCESS (0.004s) [142.173427] Starting dynamic subtest: vecs0-smem [142.176648] Dynamic subtest vecs0-smem: SUCCESS (0.004s) [142.179804] Subtest basic: SUCCESS (0.030s) [142.589546] [021/161] (926s left) gem_exec_create (basic) [143.065323] Starting subtest: basic [143.068645] Starting dynamic subtest: smem [145.311118] Dynamic subtest smem: SUCCESS (2.246s) [145.314547] Subtest basic: SUCCESS (2.248s) [145.828502] [022/161] (923s left) gem_exec_fence (basic-busy) [146.509197] Starting subtest: basic-busy [146.512719] Starting dynamic subtest: rcs0 [146.592368] Dynamic subtest rcs0: SUCCESS (0.082s) [146.649678] Starting dynamic subtest: bcs0 [146.656245] Dynamic subtest bcs0: SUCCESS (0.059s) [146.717441] Starting dynamic subtest: vcs0 [146.723390] Dynamic subtest vcs0: SUCCESS (0.057s) [146.780417] Starting dynamic subtest: vecs0 [146.787197] Dynamic subtest vecs0: SUCCESS (0.064s) [146.790349] Subtest basic-busy: SUCCESS (0.270s) [148.249631] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [148.270803] [023/161] (921s left) gem_exec_fence (basic-wait) [148.960280] Starting subtest: basic-wait [148.963673] Starting dynamic subtest: rcs0 [149.075327] Dynamic subtest rcs0: SUCCESS (0.114s) [149.138863] Starting dynamic subtest: bcs0 [149.147546] Dynamic subtest bcs0: SUCCESS (0.058s) [149.206983] Starting dynamic subtest: vcs0 [149.210379] Dynamic subtest vcs0: SUCCESS (0.068s) [149.269085] Starting dynamic subtest: vecs0 [149.272574] Dynamic subtest vecs0: SUCCESS (0.067s) [149.275894] Subtest basic-wait: SUCCESS (0.314s) [150.535494] [024/161] (919s left) gem_exec_fence (basic-await) [151.216655] Starting subtest: basic-await [151.219683] Starting dynamic subtest: rcs0 [151.567755] Dynamic subtest rcs0: SUCCESS (0.353s) [151.628211] Starting dynamic subtest: bcs0 [151.888573] Dynamic subtest bcs0: SUCCESS (0.315s) [151.948599] Starting dynamic subtest: vcs0 [152.199540] Dynamic subtest vcs0: SUCCESS (0.312s) [152.261316] Starting dynamic subtest: vecs0 [152.514227] Dynamic subtest vecs0: SUCCESS (0.311s) [152.517519] Subtest basic-await: SUCCESS (1.300s) [153.785539] [025/161] (916s left) gem_exec_fence (nb-await) [154.466176] Starting subtest: nb-await [154.469306] Starting dynamic subtest: rcs0 [154.592765] Dynamic subtest rcs0: SUCCESS (0.116s) [154.652280] Starting dynamic subtest: bcs0 [154.679279] Dynamic subtest bcs0: SUCCESS (0.093s) [154.746382] Starting dynamic subtest: vcs0 [154.782954] Dynamic subtest vcs0: SUCCESS (0.097s) [154.853460] Starting dynamic subtest: vecs0 [154.902456] Dynamic subtest vecs0: SUCCESS (0.110s) [154.906215] Subtest nb-await: SUCCESS (0.434s) [156.187561] [026/161] (914s left) gem_exec_gttfill (basic) [156.664231] Starting subtest: basic [195.719576] Subtest basic: SUCCESS (39.021s) [196.299843] [027/161] (875s left) gem_exec_parallel (engines) [196.962459] Starting subtest: engines [196.965931] Starting dynamic subtest: basic [204.116556] Dynamic subtest basic: SUCCESS (7.133s) [204.183753] Starting dynamic subtest: contexts [215.837867] Dynamic subtest contexts: SUCCESS (11.723s) [215.908421] Starting dynamic subtest: fds [228.452603] Dynamic subtest fds: SUCCESS (12.613s) [228.523566] Starting dynamic subtest: userptr [234.780313] Dynamic subtest userptr: SUCCESS (6.336s) [234.783893] Subtest engines: SUCCESS (37.823s) [235.374667] [028/161] (836s left) gem_exec_store (basic) [235.859651] Starting subtest: basic [236.002658] Subtest basic: SUCCESS (0.144s) [236.559724] [029/161] (835s left) gem_flink_basic (bad-flink) [236.944608] Starting subtest: bad-flink [236.947803] Subtest bad-flink: SUCCESS (0.000s) [237.352265] [030/161] (835s left) gem_flink_basic (bad-open) [237.740408] Starting subtest: bad-open [237.743926] Subtest bad-open: SUCCESS (0.000s) [238.149366] [031/161] (834s left) gem_flink_basic (basic) [238.536515] Starting subtest: basic [238.539721] Subtest basic: SUCCESS (0.001s) [238.964822] [032/161] (834s left) gem_flink_basic (double-flink) [239.350174] Starting subtest: double-flink [239.353712] Subtest double-flink: SUCCESS (0.001s) [239.778891] [033/161] (833s left) gem_flink_basic (flink-lifetime) [240.172554] Starting subtest: flink-lifetime [240.181099] Subtest flink-lifetime: SUCCESS (0.010s) [240.616576] [034/161] (833s left) gem_huc_copy (huc-copy) [241.049913] Starting subtest: huc-copy [241.066912] Subtest huc-copy: SUCCESS (0.021s) [241.520845] [035/161] (832s left) gem_linear_blits (basic) [242.405815] Starting subtest: basic [242.443858] Subtest basic: SUCCESS (0.049s) [242.978922] [036/161] (831s left) gem_mmap (basic) [243.553833] Starting subtest: basic [243.567674] Subtest basic: SUCCESS (0.003s) [243.972385] [037/161] (831s left) gem_mmap_gtt (basic) [244.362603] Starting subtest: basic [244.365620] Subtest basic: SUCCESS (0.005s) [244.795966] [038/161] (830s left) gem_render_linear_blits (basic) [245.237218] Starting subtest: basic [245.463778] Subtest basic: SUCCESS (0.228s) [245.901917] [039/161] (829s left) gem_render_tiled_blits (basic) [246.318261] Starting subtest: basic [246.608428] Subtest basic: SUCCESS (0.289s) [247.032126] [040/161] (829s left) gem_ringfill (basic-all) [247.947651] Starting subtest: basic-all [249.440327] Subtest basic-all: SUCCESS (1.483s) [249.891812] [041/161] (826s left) gem_softpin (allocator-basic) [250.306752] Starting subtest: allocator-basic [251.006913] Subtest allocator-basic: SUCCESS (0.691s) [251.498249] [042/161] (825s left) gem_softpin (allocator-basic-reserve) [251.921867] Starting subtest: allocator-basic-reserve [252.619719] Subtest allocator-basic-reserve: SUCCESS (0.689s) [253.138838] [043/161] (824s left) gem_softpin (safe-alignment) [253.561405] Starting subtest: safe-alignment [253.651257] Subtest safe-alignment: SUCCESS (0.090s) [254.100666] [044/161] (823s left) gem_sync (basic-all) [254.587990] Starting subtest: basic-all [262.012158] Subtest basic-all: SUCCESS (7.427s) [262.572655] [045/161] (815s left) gem_sync (basic-each) [263.056162] Starting subtest: basic-each [266.864142] Subtest basic-each: SUCCESS (3.807s) [267.417656] [046/161] (810s left) gem_tiled_blits (basic) [268.194280] Starting subtest: basic [268.332714] Subtest basic: SUCCESS (0.134s) [268.822462] [047/161] (809s left) gem_tiled_fence_blits (basic) [269.819979] Starting subtest: basic [269.901622] Subtest basic: SUCCESS (0.082s) [270.433124] [048/161] (808s left) gem_tiled_pread_basic [271.408285] [049/161] (808s left) gem_wait (busy@all-engines) [271.960558] Starting subtest: busy [271.963744] Starting dynamic subtest: all-engines [272.572381] Dynamic subtest all-engines: SUCCESS (0.622s) [272.575732] Subtest busy: SUCCESS (0.624s) [273.265655] [050/161] (806s left) gem_wait (wait@all-engines) [273.790234] Starting subtest: wait [273.793259] Starting dynamic subtest: all-engines [274.896367] Dynamic subtest all-engines: SUCCESS (1.111s) [274.899664] Subtest wait: SUCCESS (1.113s) [275.591271] [051/161] (804s left) i915_getparams_basic (basic-eu-total) [275.974667] Starting subtest: basic-eu-total [275.980984] Subtest basic-eu-total: SUCCESS (0.000s) [276.391750] [052/161] (804s left) i915_getparams_basic (basic-subslice-total) [276.776925] Starting subtest: basic-subslice-total [276.782754] Subtest basic-subslice-total: SUCCESS (0.000s) [277.186829] [053/161] (803s left) i915_hangman (error-state-basic) [277.653961] Starting subtest: error-state-basic [278.497610] Subtest error-state-basic: SUCCESS (0.845s) [278.961242] [054/161] (802s left) i915_pciid [279.758754] [055/161] (802s left) kms_addfb_basic (addfb25-4-tiled) [280.295724] Starting subtest: addfb25-4-tiled [280.298858] Subtest addfb25-4-tiled: SUCCESS (0.002s) [280.728225] [056/161] (801s left) kms_addfb_basic (addfb25-bad-modifier) [281.220734] Starting subtest: addfb25-bad-modifier [281.224847] Subtest addfb25-bad-modifier: SUCCESS (0.002s) [281.633919] [057/161] (800s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [282.125769] Starting subtest: addfb25-framebuffer-vs-set-tiling [282.128965] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.002s) [282.567701] [058/161] (800s left) kms_addfb_basic (addfb25-modifier-no-flag) [283.059830] Starting subtest: addfb25-modifier-no-flag [283.063692] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [283.476988] [059/161] (799s left) kms_addfb_basic (addfb25-x-tiled-legacy) [283.970568] Starting subtest: addfb25-x-tiled-legacy [283.973639] Subtest addfb25-x-tiled-legacy: SUCCESS (0.001s) [284.404055] [060/161] (799s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [284.897995] Starting subtest: addfb25-x-tiled-mismatch-legacy [284.901440] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.002s) [285.335710] [061/161] (798s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [285.831211] Starting subtest: addfb25-yf-tiled-legacy [285.834256] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.002s) [286.277568] [062/161] (798s left) kms_addfb_basic (addfb25-y-tiled-legacy) [286.774276] Starting subtest: addfb25-y-tiled-legacy [286.777461] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s) [287.210270] [063/161] (797s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [287.700888] Starting subtest: addfb25-y-tiled-small-legacy [287.704488] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.002s) [288.127880] [064/161] (796s left) kms_addfb_basic (bad-pitch-0) [288.523054] Starting subtest: bad-pitch-0 [288.526253] Subtest bad-pitch-0: SUCCESS (0.000s) [289.052909] [065/161] (796s left) kms_addfb_basic (bad-pitch-1024) [289.441686] Starting subtest: bad-pitch-1024 [289.444795] Subtest bad-pitch-1024: SUCCESS (0.000s) [289.993651] [066/161] (795s left) kms_addfb_basic (bad-pitch-128) [290.387239] Starting subtest: bad-pitch-128 [290.390816] Subtest bad-pitch-128: SUCCESS (0.000s) [290.928612] [067/161] (795s left) kms_addfb_basic (bad-pitch-256) [291.312289] Starting subtest: bad-pitch-256 [291.315366] Subtest bad-pitch-256: SUCCESS (0.000s) [291.845923] [068/161] (794s left) kms_addfb_basic (bad-pitch-32) [292.239554] Starting subtest: bad-pitch-32 [292.242360] Subtest bad-pitch-32: SUCCESS (0.000s) [292.774896] [069/161] (794s left) kms_addfb_basic (bad-pitch-63) [293.165087] Starting subtest: bad-pitch-63 [293.168136] Subtest bad-pitch-63: SUCCESS (0.000s) [293.701500] [070/161] (793s left) kms_addfb_basic (bad-pitch-65536) [294.091686] Starting subtest: bad-pitch-65536 [294.095254] Subtest bad-pitch-65536: SUCCESS (0.002s) [294.626217] [071/161] (793s left) kms_addfb_basic (bad-pitch-999) [295.018383] Starting subtest: bad-pitch-999 [295.021379] Subtest bad-pitch-999: SUCCESS (0.000s) [295.568597] [072/161] (792s left) kms_addfb_basic (basic) [295.956928] Starting subtest: basic [295.959913] Subtest basic: SUCCESS (0.000s) [296.500909] [073/161] (791s left) kms_addfb_basic (basic-x-tiled-legacy) [296.893088] Starting subtest: basic-x-tiled-legacy [296.896443] Subtest basic-x-tiled-legacy: SUCCESS (0.001s) [297.428574] [074/161] (791s left) kms_addfb_basic (basic-y-tiled-legacy) [297.823105] Starting subtest: basic-y-tiled-legacy [297.825816] Subtest basic-y-tiled-legacy: SUCCESS (0.002s) [298.354949] [075/161] (790s left) kms_addfb_basic (bo-too-small) [298.843429] Starting subtest: bo-too-small [298.846668] Subtest bo-too-small: SUCCESS (0.002s) [299.276867] [076/161] (790s left) kms_addfb_basic (bo-too-small-due-to-tiling) [299.766429] Starting subtest: bo-too-small-due-to-tiling [299.769348] Subtest bo-too-small-due-to-tiling: SUCCESS (0.002s) [300.193909] [077/161] (789s left) kms_addfb_basic (clobberred-modifier) [300.580043] Starting subtest: clobberred-modifier [300.582850] Subtest clobberred-modifier: SUCCESS (0.001s) [301.117411] [078/161] (789s left) kms_addfb_basic (framebuffer-vs-set-tiling) [301.508194] Starting subtest: framebuffer-vs-set-tiling [301.511221] Subtest framebuffer-vs-set-tiling: SUCCESS (0.001s) [302.034889] [079/161] (788s left) kms_addfb_basic (invalid-get-prop) [302.426140] Starting subtest: invalid-get-prop [302.429322] Subtest invalid-get-prop: SUCCESS (0.000s) [302.970476] [080/161] (788s left) kms_addfb_basic (invalid-get-prop-any) [303.362455] Starting subtest: invalid-get-prop-any [303.365947] Subtest invalid-get-prop-any: SUCCESS (0.000s) [303.898444] [081/161] (787s left) kms_addfb_basic (invalid-set-prop) [304.285965] Starting subtest: invalid-set-prop [304.289384] Subtest invalid-set-prop: SUCCESS (0.000s) [304.867421] [082/161] (786s left) kms_addfb_basic (invalid-set-prop-any) [305.409079] Starting subtest: invalid-set-prop-any [305.412307] Subtest invalid-set-prop-any: SUCCESS (0.000s) [306.024877] [083/161] (786s left) kms_addfb_basic (no-handle) [306.514253] Starting subtest: no-handle [306.521430] Subtest no-handle: SUCCESS (0.001s) [307.231683] [084/161] (785s left) kms_addfb_basic (size-max) [307.879526] Starting subtest: size-max [307.883939] Subtest size-max: SUCCESS (0.001s) [308.319562] [085/161] (784s left) kms_addfb_basic (small-bo) [308.857034] Starting subtest: small-bo [308.860367] Subtest small-bo: SUCCESS (0.000s) [309.302381] [086/161] (784s left) kms_addfb_basic (tile-pitch-mismatch) [309.716157] Starting subtest: tile-pitch-mismatch [309.718774] Subtest tile-pitch-mismatch: SUCCESS (0.002s) [310.268309] [087/161] (783s left) kms_addfb_basic (too-high) [310.762293] Starting subtest: too-high [310.770748] Subtest too-high: SUCCESS (0.006s) [311.224497] [088/161] (782s left) kms_addfb_basic (too-wide) [311.717696] Starting subtest: too-wide [311.720536] Subtest too-wide: SUCCESS (0.000s) [312.142370] [089/161] (782s left) kms_addfb_basic (unused-handle) [312.530894] Starting subtest: unused-handle [312.534221] Subtest unused-handle: SUCCESS (0.000s) [313.070562] [090/161] (781s left) kms_addfb_basic (unused-modifier) [313.457696] Starting subtest: unused-modifier [313.460948] Subtest unused-modifier: SUCCESS (0.000s) [313.999744] [091/161] (781s left) kms_addfb_basic (unused-offsets) [314.388894] Starting subtest: unused-offsets [314.392523] Subtest unused-offsets: SUCCESS (0.000s) [314.919640] [092/161] (780s left) kms_addfb_basic (unused-pitches) [315.302417] Starting subtest: unused-pitches [315.305739] Subtest unused-pitches: SUCCESS (0.000s) [315.853429] [093/161] (780s left) kms_busy (basic) [316.371107] Starting subtest: basic [316.376395] Starting dynamic subtest: flip [318.042217] Dynamic subtest flip: SUCCESS (1.662s) [318.121680] Starting dynamic subtest: modeset [322.892109] Dynamic subtest modeset: SUCCESS (4.845s) [322.899458] Subtest basic: SUCCESS (6.519s) [324.279459] [094/161] (772s left) kms_prop_blob (basic) [324.667825] Starting subtest: basic [324.671576] Subtest basic: SUCCESS (0.000s) [325.078232] [095/161] (771s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [325.725062] Starting subtest: basic-busy-flip-before-cursor-atomic [325.730786] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [326.313549] [096/161] (770s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [326.932138] Starting subtest: basic-busy-flip-before-cursor-legacy [326.937596] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.001s) [327.479964] [097/161] (770s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [328.106207] Starting subtest: basic-flip-after-cursor-atomic [329.071369] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.963s) [330.337943] [098/161] (767s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [330.958683] Starting subtest: basic-flip-after-cursor-legacy [331.900151] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.944s) [333.365546] [099/161] (764s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [333.985890] Starting subtest: basic-flip-after-cursor-varying-size [334.936467] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.945s) [336.152663] [100/161] (762s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [336.782592] Starting subtest: basic-flip-before-cursor-atomic [337.717471] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.937s) [338.938590] [101/161] (760s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [339.550256] Starting subtest: basic-flip-before-cursor-legacy [340.492831] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.938s) [341.738917] [102/161] (757s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [342.361939] Starting subtest: basic-flip-before-cursor-varying-size [343.305408] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.941s) [344.525946] [103/161] (755s left) kms_dsc (dsc-basic) [345.020391] Starting subtest: dsc-basic [345.035444] Subtest dsc-basic: SKIP (0.003s) [345.435819] [104/161] (754s left) kms_flip (basic-flip-vs-dpms) [345.929824] Starting subtest: basic-flip-vs-dpms [345.943135] Starting dynamic subtest: A-eDP1 [349.379384] Dynamic subtest A-eDP1: SUCCESS (3.436s) [349.458748] Starting dynamic subtest: B-eDP1 [352.226644] Dynamic subtest B-eDP1: SUCCESS (2.838s) [352.307351] Starting dynamic subtest: C-eDP1 [354.958197] Dynamic subtest C-eDP1: SUCCESS (2.729s) [354.965263] Subtest basic-flip-vs-dpms: SUCCESS (9.035s) [356.176292] [105/161] (744s left) kms_flip (basic-flip-vs-modeset) [356.683068] Starting subtest: basic-flip-vs-modeset [356.693995] Starting dynamic subtest: A-eDP1 [360.004418] Dynamic subtest A-eDP1: SUCCESS (3.309s) [360.088810] Starting dynamic subtest: B-eDP1 [362.658181] Dynamic subtest B-eDP1: SUCCESS (2.646s) [362.738562] Starting dynamic subtest: C-eDP1 [365.214941] Dynamic subtest C-eDP1: SUCCESS (2.554s) [365.225422] Subtest basic-flip-vs-modeset: SUCCESS (8.545s) [366.384521] [106/161] (734s left) kms_flip (basic-flip-vs-wf_vblank) [366.880961] Starting subtest: basic-flip-vs-wf_vblank [366.892632] Starting dynamic subtest: A-eDP1 [369.307214] Dynamic subtest A-eDP1: SUCCESS (2.414s) [369.396090] Starting dynamic subtest: B-eDP1 [371.669433] Dynamic subtest B-eDP1: SUCCESS (2.356s) [371.753758] Starting dynamic subtest: C-eDP1 [374.150189] Dynamic subtest C-eDP1: SUCCESS (2.474s) [374.160811] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.283s) [376.320076] [107/161] (725s left) kms_flip (basic-plain-flip) [376.820149] Starting subtest: basic-plain-flip [376.832217] Starting dynamic subtest: A-eDP1 [379.097315] Dynamic subtest A-eDP1: SUCCESS (2.266s) [379.182329] Starting dynamic subtest: B-eDP1 [381.249618] Dynamic subtest B-eDP1: SUCCESS (2.146s) [381.334519] Starting dynamic subtest: C-eDP1 [383.410798] Dynamic subtest C-eDP1: SUCCESS (2.155s) [383.425067] Subtest basic-plain-flip: SUCCESS (6.606s) [385.368154] [108/161] (716s left) kms_force_connector_basic (force-connector-state) [385.787315] Starting subtest: force-connector-state [386.570816] Subtest force-connector-state: SUCCESS (0.785s) [388.290316] [109/161] (713s left) kms_force_connector_basic (force-edid) [388.712675] Starting subtest: force-edid [388.811386] Subtest force-edid: SUCCESS (0.102s) [389.402854] [110/161] (713s left) kms_force_connector_basic (force-load-detect) [389.817109] Starting subtest: force-load-detect [389.824226] Subtest force-load-detect: SKIP (0.000s) [390.348097] [111/161] (712s left) kms_force_connector_basic (prune-stale-modes) [390.761221] Starting subtest: prune-stale-modes [390.866754] Subtest prune-stale-modes: SUCCESS (0.106s) [391.468527] [112/161] (711s left) kms_frontbuffer_tracking (basic) [391.998985] Starting subtest: basic [406.321095] Subtest basic: SUCCESS (14.320s) [406.810785] [113/161] (696s left) kms_hdmi_inject (inject-audio) [407.635926] Starting subtest: inject-audio [408.191124] Subtest inject-audio: SUCCESS (0.547s) [409.253039] [114/161] (694s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [409.788956] Starting subtest: compare-crc-sanitycheck-xr24 [409.805332] Starting dynamic subtest: pipe-A-eDP-1 [411.116419] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.317s) [411.205933] Starting dynamic subtest: pipe-B-eDP-1 [413.191184] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.058s) [413.283762] Starting dynamic subtest: pipe-C-eDP-1 [414.996907] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.795s) [415.000628] Subtest compare-crc-sanitycheck-xr24: SUCCESS (5.211s) [416.214121] [115/161] (688s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [416.707295] Starting subtest: compare-crc-sanitycheck-nv12 [416.723127] Starting dynamic subtest: pipe-A-eDP-1 [418.399975] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.681s) [418.489097] Starting dynamic subtest: pipe-B-eDP-1 [420.569844] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.154s) [420.664882] Starting dynamic subtest: pipe-C-eDP-1 [422.702083] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.119s) [422.704683] Subtest compare-crc-sanitycheck-nv12: SUCCESS (5.996s) [423.875984] [116/161] (680s left) kms_pipe_crc_basic (hang-read-crc) [424.366937] Starting subtest: hang-read-crc [424.377676] Starting dynamic subtest: pipe-A-eDP-1 [428.533084] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.154s) [428.624332] Starting dynamic subtest: pipe-B-eDP-1 [433.250837] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.700s) [433.340760] Starting dynamic subtest: pipe-C-eDP-1 [437.957186] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.690s) [437.960222] Subtest hang-read-crc: SUCCESS (13.589s) [439.210639] [117/161] (665s left) kms_pipe_crc_basic (nonblocking-crc) [439.721476] Starting subtest: nonblocking-crc [439.738517] Starting dynamic subtest: pipe-A-eDP-1 [441.235152] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.492s) [441.322431] Starting dynamic subtest: pipe-B-eDP-1 [443.508249] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.257s) [443.599772] Starting dynamic subtest: pipe-C-eDP-1 [445.738491] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.215s) [445.741869] Subtest nonblocking-crc: SUCCESS (6.016s) [446.976521] [118/161] (658s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [447.478840] Starting subtest: nonblocking-crc-frame-sequence [447.486400] Starting dynamic subtest: pipe-A-eDP-1 [448.947473] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.460s) [449.050559] Starting dynamic subtest: pipe-B-eDP-1 [451.261335] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.292s) [451.349471] Starting dynamic subtest: pipe-C-eDP-1 [453.504997] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.227s) [453.508181] Subtest nonblocking-crc-frame-sequence: SUCCESS (6.028s) [454.739975] [119/161] (651s left) kms_pipe_crc_basic (read-crc) [455.260994] Starting subtest: read-crc [455.271890] Starting dynamic subtest: pipe-A-eDP-1 [456.693266] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.417s) [456.788832] Starting dynamic subtest: pipe-B-eDP-1 [458.998931] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.294s) [459.092531] Starting dynamic subtest: pipe-C-eDP-1 [461.006157] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.990s) [461.017189] Subtest read-crc: SUCCESS (5.752s) [462.267189] [120/161] (644s left) kms_pipe_crc_basic (read-crc-frame-sequence) [462.764790] Starting subtest: read-crc-frame-sequence [462.776560] Starting dynamic subtest: pipe-A-eDP-1 [464.203155] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.425s) [464.296467] Starting dynamic subtest: pipe-B-eDP-1 [466.222703] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.999s) [466.314102] Starting dynamic subtest: pipe-C-eDP-1 [468.258280] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.012s) [468.261740] Subtest read-crc-frame-sequence: SUCCESS (5.495s) [469.481101] [121/161] (637s left) kms_pm_backlight (basic-brightness) [470.020764] Starting subtest: basic-brightness [470.264337] Starting dynamic subtest: eDP-1 [470.949621] Dynamic subtest eDP-1: SUCCESS (0.692s) [470.952299] Subtest basic-brightness: SUCCESS (0.933s) [472.388101] [122/161] (634s left) kms_pm_rpm (basic-pci-d3-state) [474.671372] Starting subtest: basic-pci-d3-state [476.617307] Subtest basic-pci-d3-state: SUCCESS (1.941s) [477.155545] [123/161] (630s left) kms_pm_rpm (basic-rte) [477.542603] Starting subtest: basic-rte [484.542522] Subtest basic-rte: SUCCESS (7.004s) [489.446334] [124/161] (618s left) kms_psr (psr-primary-page-flip) [489.945709] Starting subtest: psr-primary-page-flip [489.956683] Starting dynamic subtest: eDP-1 [492.334377] Dynamic subtest eDP-1: SUCCESS (2.375s) [492.337089] Subtest psr-primary-page-flip: SUCCESS (2.387s) [493.524544] [125/161] (614s left) kms_psr (psr-cursor-plane-move) [494.029695] Starting subtest: psr-cursor-plane-move [494.032705] Starting dynamic subtest: eDP-1 [496.228987] Dynamic subtest eDP-1: SUCCESS (2.197s) [496.238998] Subtest psr-cursor-plane-move: SUCCESS (2.210s) [497.431241] [126/161] (611s left) kms_psr (psr-sprite-plane-onoff) [497.939844] Starting subtest: psr-sprite-plane-onoff [497.942998] Starting dynamic subtest: eDP-1 [500.467477] Dynamic subtest eDP-1: SUCCESS (2.526s) [500.478392] Subtest psr-sprite-plane-onoff: SUCCESS (2.538s) [501.683530] [127/161] (607s left) kms_psr (psr-primary-mmap-gtt) [502.185946] Starting subtest: psr-primary-mmap-gtt [502.196880] Starting dynamic subtest: eDP-1 [504.373867] Dynamic subtest eDP-1: SUCCESS (2.177s) [504.377050] Subtest psr-primary-mmap-gtt: SUCCESS (2.189s) [505.570770] [128/161] (603s left) kms_setmode (basic-clone-single-crtc) [505.971894] Starting subtest: basic-clone-single-crtc [505.980607] Subtest basic-clone-single-crtc: SKIP (0.001s) [506.400233] [129/161] (603s left) i915_pm_rps (basic-api) [506.830481] Starting subtest: basic-api [506.844946] Subtest basic-api: SKIP (0.004s) [507.292361] [130/161] (602s left) prime_self_import (basic-llseek-bad) [507.675964] Starting subtest: basic-llseek-bad [507.692162] Subtest basic-llseek-bad: SUCCESS (0.015s) [508.136306] [131/161] (602s left) prime_self_import (basic-llseek-size) [508.521712] Starting subtest: basic-llseek-size [508.535219] Subtest basic-llseek-size: SUCCESS (0.023s) [508.985847] [132/161] (602s left) prime_self_import (basic-with_fd_dup) [509.366140] Starting subtest: basic-with_fd_dup [509.388708] Subtest basic-with_fd_dup: SUCCESS (0.021s) [509.837545] [133/161] (601s left) prime_self_import (basic-with_one_bo) [510.215535] Starting subtest: basic-with_one_bo [510.237769] Subtest basic-with_one_bo: SUCCESS (0.022s) [510.702322] [134/161] (601s left) prime_self_import (basic-with_one_bo_two_files) [511.083226] Starting subtest: basic-with_one_bo_two_files [511.105307] Subtest basic-with_one_bo_two_files: SUCCESS (0.019s) [511.548312] [135/161] (600s left) prime_self_import (basic-with_two_bos) [511.928438] Starting subtest: basic-with_two_bos [511.950738] Subtest basic-with_two_bos: SUCCESS (0.021s) [512.402812] [136/161] (600s left) prime_vgem (basic-fence-flip) [512.865769] Starting subtest: basic-fence-flip [513.654853] Subtest basic-fence-flip: SUCCESS (0.793s) [514.149723] [137/161] (598s left) prime_vgem (basic-fence-mmap) [514.602752] Starting subtest: basic-fence-mmap [514.814572] Subtest basic-fence-mmap: SUCCESS (0.214s) [515.272478] [138/161] (598s left) prime_vgem (basic-fence-read) [515.726460] Starting subtest: basic-fence-read [515.779131] Subtest basic-fence-read: SKIP (0.057s) [516.237285] [139/161] (597s left) prime_vgem (basic-gtt) [516.689153] Starting subtest: basic-gtt [516.778402] Subtest basic-gtt: SUCCESS (0.089s) [517.227637] [140/161] (596s left) prime_vgem (basic-read) [517.673803] Starting subtest: basic-read [517.733129] Subtest basic-read: SKIP (0.056s) [518.205810] [141/161] (596s left) prime_vgem (basic-write) [518.657168] Starting subtest: basic-write [518.716987] Subtest basic-write: SKIP (0.057s) [519.182903] [142/161] (595s left) vgem_basic (setversion) [519.595958] Starting subtest: setversion [519.602392] Subtest setversion: SUCCESS (0.000s) [520.005998] [143/161] (595s left) vgem_basic (create) [520.413351] Starting subtest: create [520.416759] Subtest create: SUCCESS (0.002s) [520.832909] [144/161] (594s left) vgem_basic (debugfs) [521.243509] Starting subtest: debugfs [521.246762] Subtest debugfs: SUCCESS (0.003s) [521.668399] [145/161] (594s left) vgem_basic (dmabuf-export) [522.075497] Starting subtest: dmabuf-export [522.091371] Subtest dmabuf-export: SUCCESS (0.020s) [522.532850] [146/161] (593s left) vgem_basic (dmabuf-fence) [522.945515] Starting subtest: dmabuf-fence [522.950207] Subtest dmabuf-fence: SUCCESS (0.003s) [523.363950] [147/161] (593s left) vgem_basic (dmabuf-fence-before) [523.773525] Starting subtest: dmabuf-fence-before [523.776779] Subtest dmabuf-fence-before: SUCCESS (0.003s) [524.205350] [148/161] (593s left) vgem_basic (dmabuf-mmap) [524.614994] Starting subtest: dmabuf-mmap [524.709981] Subtest dmabuf-mmap: SUCCESS (0.099s) [525.142781] [149/161] (592s left) vgem_basic (mmap) [525.553081] Starting subtest: mmap [525.613864] Subtest mmap: SUCCESS (0.066s) [526.042701] [150/161] (592s left) vgem_basic (second-client) [526.453309] Starting subtest: second-client [526.492251] Subtest second-client: SUCCESS (0.038s) [526.903059] [151/161] (591s left) vgem_basic (sysfs) [527.309666] Starting subtest: sysfs [527.313215] Subtest sysfs: SUCCESS (0.004s) [527.733164] [152/161] (591s left) core_hotunplug (unbind-rebind) [528.439938] Starting subtest: unbind-rebind [537.804744] Subtest unbind-rebind: SUCCESS (9.366s) [538.203199] [153/161] (581s left) vgem_basic (unload) [538.591312] Starting subtest: unload [568.253649] Subtest unload: SUCCESS (29.627s) [568.823504] [154/161] (550s left) i915_module_load (reload) [569.213587] Starting subtest: reload [583.586522] Subtest reload: SUCCESS (14.366s) [584.000707] [155/161] (536s left) gem_lmem_swapping (basic) [584.592689] Subtest basic: SKIP (0.000s) [585.004952] [156/161] (535s left) gem_lmem_swapping (parallel-random-engines) [585.432590] Subtest parallel-random-engines: SKIP (0.000s) [585.835580] [157/161] (535s left) gem_lmem_swapping (random-engines) [586.259692] Subtest random-engines: SKIP (0.000s) [586.646895] [158/161] (534s left) gem_lmem_swapping (verify-random) [587.071110] Subtest verify-random: SKIP (0.000s) [587.467222] [159/161] (534s left) i915_pm_rpm (module-reload) [590.591619] Starting subtest: module-reload [627.530403] Subtest module-reload: SUCCESS (36.928s) [627.777364] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [627.791064] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [627.813794] [160/161] (494s left) i915_selftest (live) [628.233996] Starting subtest: live [628.237360] Starting dynamic subtest: sanitycheck [638.611400] Dynamic subtest sanitycheck: SUCCESS (10.371s) [638.675631] Starting dynamic subtest: uncore [648.908899] Dynamic subtest uncore: SUCCESS (10.288s) [648.972136] Starting dynamic subtest: workarounds [661.902887] Dynamic subtest workarounds: SUCCESS (12.984s) [661.969535] Starting dynamic subtest: gt_engines [672.916230] Dynamic subtest gt_engines: SUCCESS (11.004s) [672.979480] Starting dynamic subtest: gt_timelines [718.029108] Dynamic subtest gt_timelines: SUCCESS (45.100s) [718.095220] Starting dynamic subtest: gt_contexts [729.616415] Dynamic subtest gt_contexts: SUCCESS (11.550s) [729.686345] Starting dynamic subtest: gt_lrc [743.831891] Dynamic subtest gt_lrc: SUCCESS (14.231s) [743.895312] Starting dynamic subtest: gt_mocs [755.429738] Dynamic subtest gt_mocs: SUCCESS (11.587s) [755.500779] Starting dynamic subtest: gt_pm [767.874253] Dynamic subtest gt_pm: SUCCESS (12.436s) [767.943194] Starting dynamic subtest: gt_heartbeat [778.412413] Dynamic subtest gt_heartbeat: SUCCESS (10.530s) [778.476444] Starting dynamic subtest: gt_tlb [790.055724] Dynamic subtest gt_tlb: SUCCESS (11.634s) [790.119568] Starting dynamic subtest: requests [810.570191] Dynamic subtest requests: SUCCESS (20.468s) [810.633326] Starting dynamic subtest: migrate [825.211111] Dynamic subtest migrate: SUCCESS (14.657s) [825.276432] Starting dynamic subtest: active [835.692369] Dynamic subtest active: SUCCESS (10.473s) [835.780450] Starting dynamic subtest: objects [850.278268] Dynamic subtest objects: SUCCESS (14.577s) [850.342311] Starting dynamic subtest: mman [872.044760] Dynamic subtest mman: SUCCESS (21.755s) [872.112350] Starting dynamic subtest: dmabuf [882.650370] Dynamic subtest dmabuf: SUCCESS (10.596s) [882.718141] Starting dynamic subtest: vma [893.157274] Dynamic subtest vma: SUCCESS (10.498s) [893.221460] Starting dynamic subtest: coherency [922.313767] Dynamic subtest coherency: SUCCESS (29.146s) [922.395624] Starting dynamic subtest: gtt [940.927373] Dynamic subtest gtt: SUCCESS (18.613s) [941.035854] Starting dynamic subtest: gem [952.832640] Dynamic subtest gem: SUCCESS (11.887s) [952.896271] Starting dynamic subtest: evict [971.382652] Dynamic subtest evict: SUCCESS (18.539s) [971.448977] Starting dynamic subtest: hugepages [988.400447] Dynamic subtest hugepages: SUCCESS (17.010s) [988.466495] Starting dynamic subtest: gem_contexts [1029.026089] Dynamic subtest gem_contexts: SUCCESS (40.621s) [1029.096841] Starting dynamic subtest: client [1039.554701] Dynamic subtest client: SUCCESS (10.512s) [1039.621655] Starting dynamic subtest: gem_migrate [1049.956264] Dynamic subtest gem_migrate: SUCCESS (10.393s) [1050.018133] Starting dynamic subtest: reset [1063.900345] Dynamic subtest reset: SUCCESS (13.935s) [1063.968381] Starting dynamic subtest: memory_region [1074.482133] Dynamic subtest memory_region: SUCCESS (10.568s) [1074.553168] Starting dynamic subtest: hangcheck [1105.753410] Dynamic subtest hangcheck: SUCCESS (31.263s) [1105.821218] Starting dynamic subtest: execlists [1112.937545] Abort requested by sudo IGT_PING_HOSTNAME=10.211.124.1 IGT_CI_META_TEST=yes IGT_REBOOT_ON_FATAL_ERROR=yes LD_LIBRARY_PATH=/opt/igt/lib:/op [1163] via Terminated, terminating children [1118.679951] Aborting: Kernel badly tainted (0x240, 0x200) (check dmesg for details): TAINT_WARN: WARN_ON has happened. [1118.849804] [FACT i915_selftest (live)] new: kernel.is_tainted.taint_warn: true [1118.853095] [FACT i915_selftest (live)] new: kernel.kmod_is_loaded.i915: true [1118.865162] Closing watchdogs Done.