[41.451292] Initializing watchdogs [41.451347] /dev/watchdog0 [41.465174] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:46a6 Intel Alderlake_p (Gen12) Alder Lake-P GT2 [Iris Xe Graphics] [41.468051] [001/162] (960s left) i915_module_load (load) [41.586106] Starting subtest: load [47.152893] Subtest load: SUCCESS (5.567s) [47.176404] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [47.177575] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [47.179616] [002/162] (954s left) core_auth (basic-auth) [47.259204] Starting subtest: basic-auth [47.260262] Subtest basic-auth: SUCCESS (0.002s) [47.386347] [003/162] (954s left) core_debugfs (read-all-entries) [47.412086] Starting subtest: read-all-entries [47.519037] Subtest read-all-entries: SUCCESS (0.107s) [47.605406] [004/162] (954s left) core_sysfs (read-all-entries) [47.632524] Starting subtest: read-all-entries [47.634805] Subtest read-all-entries: SUCCESS (0.003s) [47.721818] [005/162] (954s left) fbdev (eof) [47.753666] Starting subtest: eof [47.754423] Subtest eof: SUCCESS (0.000s) [47.859413] [006/162] (954s left) fbdev (info) [47.886240] Starting subtest: info [47.886890] Subtest info: SUCCESS (0.000s) [48.001704] [007/162] (954s left) fbdev (nullptr) [48.036265] Starting subtest: nullptr [48.036920] Subtest nullptr: SUCCESS (0.000s) [48.099940] [008/162] (954s left) fbdev (read) [48.136889] Starting subtest: read [50.450267] Subtest read: SUCCESS (2.305s) [50.518528] [009/162] (951s left) fbdev (write) [50.552888] Starting subtest: write [52.111024] Subtest write: SUCCESS (1.549s) [52.178783] [010/162] (950s left) gem_basic (bad-close) [52.206119] Starting subtest: bad-close [52.207333] Subtest bad-close: SUCCESS (0.000s) [52.286314] [011/162] (949s left) gem_basic (create-close) [52.311955] Starting subtest: create-close [52.313359] Subtest create-close: SUCCESS (0.000s) [52.425920] [012/162] (949s left) gem_basic (create-fd-close) [52.451835] Starting subtest: create-fd-close [52.453839] Subtest create-fd-close: SUCCESS (0.000s) [52.604717] [013/162] (949s left) gem_busy (busy@all-engines) [52.641972] Starting subtest: busy [52.642776] Starting dynamic subtest: all-engines [52.665908] Dynamic subtest all-engines: SUCCESS (0.024s) [52.666728] Subtest busy: SUCCESS (0.024s) [53.043081] [014/162] (949s left) gem_close_race (basic-process) [53.076267] Starting subtest: basic-process [53.117910] Subtest basic-process: SUCCESS (0.041s) [53.324753] [015/162] (949s left) gem_close_race (basic-threads) [53.368298] Starting subtest: basic-threads [54.607653] Subtest basic-threads: SUCCESS (1.238s) [54.825259] [016/162] (947s left) gem_ctx_create (basic) [54.866492] Starting subtest: basic [54.867163] Subtest basic: SUCCESS (0.000s) [55.065015] [017/162] (947s left) gem_ctx_create (basic-files) [55.098386] Starting subtest: basic-files [57.107728] Subtest basic-files: SUCCESS (2.009s) [57.313397] [018/162] (945s left) gem_ctx_exec (basic) [57.348878] Starting subtest: basic [57.350019] Subtest basic: SUCCESS (0.002s) [57.466070] [019/162] (945s left) gem_exec_basic (basic) [57.495272] Starting subtest: basic [57.495886] Starting dynamic subtest: rcs0-smem [57.496455] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [57.502086] Starting dynamic subtest: bcs0-smem [57.502692] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [57.508103] Starting dynamic subtest: vcs0-smem [57.508722] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [57.514096] Starting dynamic subtest: vcs1-smem [57.514707] Dynamic subtest vcs1-smem: SUCCESS (0.000s) [57.519908] Starting dynamic subtest: vecs0-smem [57.520577] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [57.521171] Subtest basic: SUCCESS (0.003s) [57.699502] [020/162] (944s left) gem_exec_create (basic) [57.731337] Starting subtest: basic [57.732077] Starting dynamic subtest: smem [59.817138] Dynamic subtest smem: SUCCESS (2.085s) [59.818410] Subtest basic: SUCCESS (2.086s) [60.017763] [021/162] (942s left) gem_exec_fence (basic-busy) [60.174924] Starting subtest: basic-busy [60.175915] Starting dynamic subtest: rcs0 [60.255623] Dynamic subtest rcs0: SUCCESS (0.080s) [60.265293] Starting dynamic subtest: bcs0 [60.305723] Dynamic subtest bcs0: SUCCESS (0.049s) [60.318887] Starting dynamic subtest: vcs0 [60.354735] Dynamic subtest vcs0: SUCCESS (0.048s) [60.367533] Starting dynamic subtest: vcs1 [60.404739] Dynamic subtest vcs1: SUCCESS (0.049s) [60.417648] Starting dynamic subtest: vecs0 [60.456775] Dynamic subtest vecs0: SUCCESS (0.051s) [60.458104] Subtest basic-busy: SUCCESS (0.282s) [60.984150] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [60.985871] [022/162] (941s left) gem_exec_fence (basic-wait) [61.133057] Starting subtest: basic-wait [61.134671] Starting dynamic subtest: rcs0 [61.204697] Dynamic subtest rcs0: SUCCESS (0.071s) [61.218973] Starting dynamic subtest: bcs0 [61.259501] Dynamic subtest bcs0: SUCCESS (0.054s) [61.272239] Starting dynamic subtest: vcs0 [61.314772] Dynamic subtest vcs0: SUCCESS (0.054s) [61.328200] Starting dynamic subtest: vcs1 [61.365965] Dynamic subtest vcs1: SUCCESS (0.051s) [61.374854] Starting dynamic subtest: vecs0 [61.423790] Dynamic subtest vecs0: SUCCESS (0.057s) [61.425079] Subtest basic-wait: SUCCESS (0.291s) [61.926993] [023/162] (940s left) gem_exec_fence (basic-await) [62.073541] Starting subtest: basic-await [62.074596] Starting dynamic subtest: rcs0 [62.148801] Dynamic subtest rcs0: SUCCESS (0.075s) [62.157303] Starting dynamic subtest: bcs0 [62.220690] Dynamic subtest bcs0: SUCCESS (0.071s) [62.230553] Starting dynamic subtest: vcs0 [62.294916] Dynamic subtest vcs0: SUCCESS (0.072s) [62.305269] Starting dynamic subtest: vcs1 [62.368451] Dynamic subtest vcs1: SUCCESS (0.073s) [62.380919] Starting dynamic subtest: vecs0 [62.443745] Dynamic subtest vecs0: SUCCESS (0.074s) [62.445122] Subtest basic-await: SUCCESS (0.370s) [62.947948] [024/162] (939s left) gem_exec_fence (nb-await) [63.097694] Starting subtest: nb-await [63.098521] Starting dynamic subtest: rcs0 [63.155406] Dynamic subtest rcs0: SUCCESS (0.057s) [63.169310] Starting dynamic subtest: bcs0 [63.215937] Dynamic subtest bcs0: SUCCESS (0.060s) [63.226091] Starting dynamic subtest: vcs0 [63.273523] Dynamic subtest vcs0: SUCCESS (0.057s) [63.287790] Starting dynamic subtest: vcs1 [63.334261] Dynamic subtest vcs1: SUCCESS (0.060s) [63.347951] Starting dynamic subtest: vecs0 [63.394947] Dynamic subtest vecs0: SUCCESS (0.060s) [63.396323] Subtest nb-await: SUCCESS (0.298s) [63.930775] [025/162] (938s left) gem_exec_gttfill (basic) [63.965061] Starting subtest: basic [66.386271] Subtest basic: SUCCESS (2.421s) [66.594937] [026/162] (936s left) gem_exec_parallel (engines) [66.665136] Starting subtest: engines [66.665845] Starting dynamic subtest: basic [68.230962] Dynamic subtest basic: SUCCESS (1.565s) [68.237971] Starting dynamic subtest: contexts [70.054130] Dynamic subtest contexts: SUCCESS (1.814s) [70.060990] Starting dynamic subtest: fds [71.883135] Dynamic subtest fds: SUCCESS (1.829s) [71.890809] Starting dynamic subtest: userptr [73.211111] Dynamic subtest userptr: SUCCESS (1.336s) [73.212100] Subtest engines: SUCCESS (6.546s) [73.418737] [027/162] (929s left) gem_exec_store (basic) [73.456220] Starting subtest: basic [73.546232] Subtest basic: SUCCESS (0.089s) [73.749371] [028/162] (929s left) gem_flink_basic (bad-flink) [73.776426] Starting subtest: bad-flink [73.777214] Subtest bad-flink: SUCCESS (0.000s) [73.867936] [029/162] (928s left) gem_flink_basic (bad-open) [73.893575] Starting subtest: bad-open [73.894230] Subtest bad-open: SUCCESS (0.000s) [74.013233] [030/162] (928s left) gem_flink_basic (basic) [74.039434] Starting subtest: basic [74.040074] Subtest basic: SUCCESS (0.000s) [74.165424] [031/162] (928s left) gem_flink_basic (double-flink) [74.196636] Starting subtest: double-flink [74.197295] Subtest double-flink: SUCCESS (0.000s) [74.297898] [032/162] (928s left) gem_flink_basic (flink-lifetime) [74.328693] Starting subtest: flink-lifetime [74.330372] Subtest flink-lifetime: SUCCESS (0.001s) [74.447121] [033/162] (928s left) gem_huc_copy (huc-copy) [74.476583] Starting subtest: huc-copy [74.478213] Subtest huc-copy: SUCCESS (0.002s) [74.650788] [034/162] (928s left) gem_linear_blits (basic) [74.751043] Starting subtest: basic [74.756401] Subtest basic: SUCCESS (0.006s) [74.910161] [035/162] (928s left) gem_mmap (basic) [74.981050] Starting subtest: basic [74.984339] Subtest basic: SUCCESS (0.000s) [75.104439] [036/162] (927s left) gem_mmap_gtt (basic) [75.130541] Starting subtest: basic [75.131230] Subtest basic: SUCCESS (0.000s) [75.251976] [037/162] (927s left) gem_render_linear_blits (basic) [75.283814] Starting subtest: basic [75.304381] Subtest basic: SUCCESS (0.021s) [75.389756] [038/162] (927s left) gem_render_tiled_blits (basic) [75.417457] Starting subtest: basic [75.441054] Subtest basic: SUCCESS (0.024s) [75.522078] [039/162] (927s left) gem_ringfill (basic-all) [75.842426] Starting subtest: basic-all [76.967110] Subtest basic-all: SUCCESS (1.116s) [77.094845] [040/162] (926s left) gem_softpin (allocator-basic) [77.124083] Starting subtest: allocator-basic [77.178715] Subtest allocator-basic: SUCCESS (0.054s) [77.316156] [041/162] (925s left) gem_softpin (allocator-basic-reserve) [77.344563] Starting subtest: allocator-basic-reserve [77.400385] Subtest allocator-basic-reserve: SUCCESS (0.056s) [77.547418] [042/162] (925s left) gem_softpin (safe-alignment) [77.578765] Starting subtest: safe-alignment [77.586174] Subtest safe-alignment: SUCCESS (0.008s) [77.746922] [043/162] (925s left) gem_sync (basic-all) [77.781419] Starting subtest: basic-all [80.223694] Subtest basic-all: SUCCESS (2.441s) [80.427064] [044/162] (922s left) gem_sync (basic-each) [80.466618] Starting subtest: basic-each [82.604398] Subtest basic-each: SUCCESS (2.137s) [82.810165] [045/162] (920s left) gem_tiled_blits (basic) [82.899041] Starting subtest: basic [82.907722] Subtest basic: SUCCESS (0.009s) [83.055731] [046/162] (920s left) gem_tiled_fence_blits (basic) [83.190764] Starting subtest: basic [83.206950] Subtest basic: SUCCESS (0.016s) [83.381890] [047/162] (920s left) gem_tiled_pread_basic (basic) [83.445730] Subtest basic: SKIP (0.000s) [83.497045] [048/162] (919s left) gem_wait (busy@all-engines) [83.533867] Starting subtest: busy [83.534698] Starting dynamic subtest: all-engines [84.083786] Dynamic subtest all-engines: SUCCESS (0.549s) [84.085107] Subtest busy: SUCCESS (0.550s) [84.306391] [049/162] (919s left) gem_wait (wait@all-engines) [84.343947] Starting subtest: wait [84.344631] Starting dynamic subtest: all-engines [85.395475] Dynamic subtest all-engines: SUCCESS (1.051s) [85.396988] Subtest wait: SUCCESS (1.052s) [85.653009] [050/162] (917s left) i915_getparams_basic (basic-eu-total) [85.686608] Starting subtest: basic-eu-total [85.687807] Subtest basic-eu-total: SUCCESS (0.000s) [85.782056] [051/162] (917s left) i915_getparams_basic (basic-subslice-total) [85.809810] Starting subtest: basic-subslice-total [85.811113] Subtest basic-subslice-total: SUCCESS (0.000s) [85.897975] [052/162] (917s left) i915_hangman (error-state-basic) [85.938991] Starting subtest: error-state-basic [86.024829] Subtest error-state-basic: SUCCESS (0.085s) [86.121357] [053/162] (917s left) i915_pciid [86.238159] [054/162] (917s left) intel_hwmon (hwmon-read) [86.267933] Subtest hwmon-read: SKIP (0.000s) [86.313920] [055/162] (917s left) intel_hwmon (hwmon-write) [86.343756] Subtest hwmon-write: SKIP (0.000s) [86.391990] [056/162] (917s left) kms_addfb_basic (addfb25-4-tiled) [87.834582] Starting subtest: addfb25-4-tiled [87.835185] Subtest addfb25-4-tiled: SUCCESS (0.000s) [87.938709] [057/162] (915s left) kms_addfb_basic (addfb25-bad-modifier) [89.371700] Starting subtest: addfb25-bad-modifier [89.372414] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [89.498049] [058/162] (914s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [90.937403] Starting subtest: addfb25-framebuffer-vs-set-tiling [90.938063] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [91.088164] [059/162] (912s left) kms_addfb_basic (addfb25-modifier-no-flag) [92.519605] Starting subtest: addfb25-modifier-no-flag [92.520280] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [92.635967] [060/162] (911s left) kms_addfb_basic (addfb25-x-tiled-legacy) [94.068398] Starting subtest: addfb25-x-tiled-legacy [94.069048] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [94.226369] [061/162] (909s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [95.657272] Starting subtest: addfb25-x-tiled-mismatch-legacy [95.657878] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [95.775729] [062/162] (908s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [97.210063] Starting subtest: addfb25-yf-tiled-legacy [97.210671] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [97.375384] [063/162] (906s left) kms_addfb_basic (addfb25-y-tiled-legacy) [98.806514] Starting subtest: addfb25-y-tiled-legacy [98.807198] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [98.918655] [064/162] (905s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [100.354721] Starting subtest: addfb25-y-tiled-small-legacy [100.355390] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [100.505116] [065/162] (903s left) kms_addfb_basic (bad-pitch-0) [100.533626] Starting subtest: bad-pitch-0 [100.534404] Subtest bad-pitch-0: SUCCESS (0.000s) [102.065181] [066/162] (901s left) kms_addfb_basic (bad-pitch-1024) [102.092139] Starting subtest: bad-pitch-1024 [102.092874] Subtest bad-pitch-1024: SUCCESS (0.000s) [103.625737] [067/162] (900s left) kms_addfb_basic (bad-pitch-128) [103.653098] Starting subtest: bad-pitch-128 [103.653806] Subtest bad-pitch-128: SUCCESS (0.000s) [105.180271] [068/162] (898s left) kms_addfb_basic (bad-pitch-256) [105.207018] Starting subtest: bad-pitch-256 [105.207816] Subtest bad-pitch-256: SUCCESS (0.000s) [106.732928] [069/162] (897s left) kms_addfb_basic (bad-pitch-32) [106.759858] Starting subtest: bad-pitch-32 [106.760582] Subtest bad-pitch-32: SUCCESS (0.000s) [108.316144] [070/162] (895s left) kms_addfb_basic (bad-pitch-63) [108.343721] Starting subtest: bad-pitch-63 [108.344420] Subtest bad-pitch-63: SUCCESS (0.000s) [109.898617] [071/162] (894s left) kms_addfb_basic (bad-pitch-65536) [109.928752] Starting subtest: bad-pitch-65536 [109.929535] Subtest bad-pitch-65536: SUCCESS (0.000s) [111.452788] [072/162] (892s left) kms_addfb_basic (bad-pitch-999) [111.480078] Starting subtest: bad-pitch-999 [111.480735] Subtest bad-pitch-999: SUCCESS (0.000s) [113.050881] [073/162] (891s left) kms_addfb_basic (basic) [113.081644] Starting subtest: basic [113.082262] Subtest basic: SUCCESS (0.000s) [114.604731] [074/162] (889s left) kms_addfb_basic (basic-x-tiled-legacy) [114.632495] Starting subtest: basic-x-tiled-legacy [114.633180] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [116.146308] [075/162] (888s left) kms_addfb_basic (basic-y-tiled-legacy) [116.175271] Starting subtest: basic-y-tiled-legacy [116.175990] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [117.702842] [076/162] (886s left) kms_addfb_basic (bo-too-small) [119.132778] Starting subtest: bo-too-small [119.133483] Subtest bo-too-small: SUCCESS (0.000s) [119.294834] [077/162] (885s left) kms_addfb_basic (bo-too-small-due-to-tiling) [120.726157] Starting subtest: bo-too-small-due-to-tiling [120.726890] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [120.876557] [078/162] (883s left) kms_addfb_basic (clobberred-modifier) [120.904905] Starting subtest: clobberred-modifier [120.905607] Subtest clobberred-modifier: SUCCESS (0.000s) [122.428690] [079/162] (882s left) kms_addfb_basic (framebuffer-vs-set-tiling) [122.455387] Starting subtest: framebuffer-vs-set-tiling [122.456067] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [123.984982] [080/162] (880s left) kms_addfb_basic (invalid-get-prop) [124.017287] Starting subtest: invalid-get-prop [124.017898] Subtest invalid-get-prop: SUCCESS (0.000s) [125.539352] [081/162] (879s left) kms_addfb_basic (invalid-get-prop-any) [125.565941] Starting subtest: invalid-get-prop-any [125.566633] Subtest invalid-get-prop-any: SUCCESS (0.000s) [127.094843] [082/162] (877s left) kms_addfb_basic (invalid-set-prop) [127.122240] Starting subtest: invalid-set-prop [127.122921] Subtest invalid-set-prop: SUCCESS (0.000s) [128.640293] [083/162] (875s left) kms_addfb_basic (invalid-set-prop-any) [128.667254] Starting subtest: invalid-set-prop-any [128.667982] Subtest invalid-set-prop-any: SUCCESS (0.000s) [130.189086] [084/162] (874s left) kms_addfb_basic (no-handle) [130.218376] Starting subtest: no-handle [130.219067] Subtest no-handle: SUCCESS (0.000s) [131.777310] [085/162] (872s left) kms_addfb_basic (size-max) [133.210785] Starting subtest: size-max [133.211405] Subtest size-max: SUCCESS (0.000s) [133.332279] [086/162] (871s left) kms_addfb_basic (small-bo) [134.763213] Starting subtest: small-bo [134.763854] Subtest small-bo: SUCCESS (0.000s) [134.869704] [087/162] (869s left) kms_addfb_basic (tile-pitch-mismatch) [134.897432] Starting subtest: tile-pitch-mismatch [134.898212] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [136.417326] [088/162] (868s left) kms_addfb_basic (too-high) [137.848642] Starting subtest: too-high [137.849394] Subtest too-high: SUCCESS (0.001s) [137.971489] [089/162] (866s left) kms_addfb_basic (too-wide) [139.406207] Starting subtest: too-wide [139.406919] Subtest too-wide: SUCCESS (0.000s) [139.555104] [090/162] (865s left) kms_addfb_basic (unused-handle) [139.582537] Starting subtest: unused-handle [139.583211] Subtest unused-handle: SUCCESS (0.000s) [141.143073] [091/162] (863s left) kms_addfb_basic (unused-modifier) [141.177966] Starting subtest: unused-modifier [141.178641] Subtest unused-modifier: SUCCESS (0.000s) [142.688775] [092/162] (862s left) kms_addfb_basic (unused-offsets) [142.716061] Starting subtest: unused-offsets [142.716764] Subtest unused-offsets: SUCCESS (0.000s) [144.237318] [093/162] (860s left) kms_addfb_basic (unused-pitches) [144.265339] Starting subtest: unused-pitches [144.266103] Subtest unused-pitches: SUCCESS (0.000s) [145.797113] [094/162] (859s left) kms_busy (basic) [147.231634] Starting subtest: basic [147.232385] Starting dynamic subtest: flip [148.178450] Dynamic subtest flip: SUCCESS (0.945s) [148.185830] Starting dynamic subtest: modeset [151.819070] Dynamic subtest modeset: SUCCESS (3.639s) [151.819759] Subtest basic: SUCCESS (4.586s) [152.764128] [095/162] (852s left) kms_prop_blob (basic) [152.793587] Starting subtest: basic [152.794418] Subtest basic: SUCCESS (0.000s) [152.892090] [096/162] (852s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [154.360351] Starting subtest: basic-busy-flip-before-cursor-atomic [154.361692] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [154.480843] [097/162] (850s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [155.943469] Starting subtest: basic-busy-flip-before-cursor-legacy [155.944910] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [156.102210] [098/162] (848s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [157.560233] Starting subtest: basic-flip-after-cursor-atomic [158.808486] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.248s) [159.772401] [099/162] (845s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [161.246509] Starting subtest: basic-flip-after-cursor-legacy [162.495573] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.249s) [163.454497] [100/162] (841s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [164.912212] Starting subtest: basic-flip-after-cursor-varying-size [166.162992] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.250s) [167.159991] [101/162] (838s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [168.630790] Starting subtest: basic-flip-before-cursor-atomic [169.893743] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.263s) [170.861827] [102/162] (834s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [172.326192] Starting subtest: basic-flip-before-cursor-legacy [173.585201] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.259s) [174.584219] [103/162] (830s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [176.048501] Starting subtest: basic-flip-before-cursor-varying-size [177.304884] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.257s) [178.294287] [104/162] (827s left) kms_dsc (dsc-basic) [179.726663] Starting subtest: dsc-basic [179.727881] Starting dynamic subtest: pipe-A-DP-3 [180.530125] Dynamic subtest pipe-A-DP-3: SUCCESS (0.803s) [180.542763] Starting dynamic subtest: pipe-B-DP-3 [180.882573] Dynamic subtest pipe-B-DP-3: SUCCESS (0.351s) [180.891635] Starting dynamic subtest: pipe-C-DP-3 [181.223150] Dynamic subtest pipe-C-DP-3: SUCCESS (0.340s) [181.233627] Starting dynamic subtest: pipe-D-DP-3 [181.566210] Dynamic subtest pipe-D-DP-3: SUCCESS (0.342s) [181.566935] Subtest dsc-basic: SUCCESS (1.840s) [182.121498] [105/162] (823s left) kms_flip (basic-flip-vs-dpms) [183.552500] Starting subtest: basic-flip-vs-dpms [183.554202] Starting dynamic subtest: A-eDP1 [186.198284] Dynamic subtest A-eDP1: SUCCESS (2.643s) [186.210358] Starting dynamic subtest: B-eDP1 [188.453626] Dynamic subtest B-eDP1: SUCCESS (2.255s) [188.464973] Starting dynamic subtest: C-eDP1 [190.625233] Dynamic subtest C-eDP1: SUCCESS (2.169s) [190.634118] Starting dynamic subtest: D-eDP1 [192.889164] Dynamic subtest D-eDP1: SUCCESS (2.262s) [192.899760] Starting dynamic subtest: A-DP3 [193.625502] Dynamic subtest A-DP3: SUCCESS (0.736s) [193.633120] Starting dynamic subtest: B-DP3 [194.513214] Dynamic subtest B-DP3: SUCCESS (0.887s) [194.521690] Starting dynamic subtest: C-DP3 [195.410269] Dynamic subtest C-DP3: SUCCESS (0.895s) [195.418756] Starting dynamic subtest: D-DP3 [196.300119] Dynamic subtest D-DP3: SUCCESS (0.888s) [196.300720] Subtest basic-flip-vs-dpms: SUCCESS (12.747s) [196.785269] [106/162] (808s left) kms_flip (basic-flip-vs-modeset) [198.217495] Starting subtest: basic-flip-vs-modeset [198.218241] Starting dynamic subtest: A-eDP1 [200.888585] Dynamic subtest A-eDP1: SUCCESS (2.670s) [200.896627] Starting dynamic subtest: B-eDP1 [203.174426] Dynamic subtest B-eDP1: SUCCESS (2.285s) [203.189284] Starting dynamic subtest: C-eDP1 [205.454566] Dynamic subtest C-eDP1: SUCCESS (2.278s) [205.464387] Starting dynamic subtest: D-eDP1 [207.735780] Dynamic subtest D-eDP1: SUCCESS (2.281s) [207.749474] Starting dynamic subtest: A-DP3 [208.466729] Dynamic subtest A-DP3: SUCCESS (0.728s) [208.474983] Starting dynamic subtest: B-DP3 [209.176902] Dynamic subtest B-DP3: SUCCESS (0.709s) [209.185305] Starting dynamic subtest: C-DP3 [210.069266] Dynamic subtest C-DP3: SUCCESS (0.892s) [210.078841] Starting dynamic subtest: D-DP3 [210.778925] Dynamic subtest D-DP3: SUCCESS (0.708s) [210.779637] Subtest basic-flip-vs-modeset: SUCCESS (12.562s) [211.260224] [107/162] (794s left) kms_flip (basic-flip-vs-wf_vblank) [212.701495] Starting subtest: basic-flip-vs-wf_vblank [212.704261] Starting dynamic subtest: A-eDP1 [214.711516] Dynamic subtest A-eDP1: SUCCESS (2.006s) [214.727327] Starting dynamic subtest: B-eDP1 [216.753276] Dynamic subtest B-eDP1: SUCCESS (2.038s) [216.771927] Starting dynamic subtest: C-eDP1 [218.768900] Dynamic subtest C-eDP1: SUCCESS (2.011s) [218.786974] Starting dynamic subtest: D-eDP1 [220.805283] Dynamic subtest D-eDP1: SUCCESS (2.032s) [220.817999] Starting dynamic subtest: A-DP3 [222.109734] Dynamic subtest A-DP3: SUCCESS (1.299s) [222.124894] Starting dynamic subtest: B-DP3 [223.173077] Dynamic subtest B-DP3: SUCCESS (1.060s) [223.184953] Starting dynamic subtest: C-DP3 [224.228671] Dynamic subtest C-DP3: SUCCESS (1.052s) [224.243895] Starting dynamic subtest: D-DP3 [225.286928] Dynamic subtest D-DP3: SUCCESS (1.055s) [225.290895] Subtest basic-flip-vs-wf_vblank: SUCCESS (12.588s) [225.836247] [108/162] (779s left) kms_flip (basic-plain-flip) [227.271380] Starting subtest: basic-plain-flip [227.272869] Starting dynamic subtest: A-eDP1 [229.004021] Dynamic subtest A-eDP1: SUCCESS (1.730s) [229.022678] Starting dynamic subtest: B-eDP1 [230.746183] Dynamic subtest B-eDP1: SUCCESS (1.739s) [230.761899] Starting dynamic subtest: C-eDP1 [232.431526] Dynamic subtest C-eDP1: SUCCESS (1.681s) [232.448632] Starting dynamic subtest: D-eDP1 [234.154989] Dynamic subtest D-eDP1: SUCCESS (1.720s) [234.168238] Starting dynamic subtest: A-DP3 [235.200671] Dynamic subtest A-DP3: SUCCESS (1.041s) [235.215543] Starting dynamic subtest: B-DP3 [235.992290] Dynamic subtest B-DP3: SUCCESS (0.788s) [236.003875] Starting dynamic subtest: C-DP3 [236.778222] Dynamic subtest C-DP3: SUCCESS (0.783s) [236.790012] Starting dynamic subtest: D-DP3 [237.556543] Dynamic subtest D-DP3: SUCCESS (0.774s) [237.559878] Subtest basic-plain-flip: SUCCESS (10.287s) [238.093646] [109/162] (767s left) kms_force_connector_basic (force-connector-state) [238.138862] Starting subtest: force-connector-state [240.154801] Subtest force-connector-state: SUCCESS (2.017s) [242.679560] [110/162] (762s left) kms_force_connector_basic (force-edid) [242.722691] Starting subtest: force-edid [242.758807] Subtest force-edid: SUCCESS (0.037s) [244.318063] [111/162] (761s left) kms_force_connector_basic (force-load-detect) [244.366599] Starting subtest: force-load-detect [244.367978] Subtest force-load-detect: SKIP (0.000s) [245.199300] [112/162] (760s left) kms_force_connector_basic (prune-stale-modes) [245.240645] Starting subtest: prune-stale-modes [245.280753] Subtest prune-stale-modes: SUCCESS (0.040s) [246.834030] [113/162] (758s left) kms_frontbuffer_tracking (basic) [248.272569] Starting subtest: basic [252.531508] Subtest basic: SUCCESS (4.258s) [252.822695] [114/162] (752s left) kms_hdmi_inject (inject-audio) [253.250443] Starting subtest: inject-audio [253.362734] Subtest inject-audio: SUCCESS (0.113s) [254.914430] [115/162] (750s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [256.346172] Starting subtest: compare-crc-sanitycheck-xr24 [256.346945] Starting dynamic subtest: pipe-A-eDP-1 [257.207757] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.861s) [257.216814] Starting dynamic subtest: pipe-B-DP-3 [257.628292] Dynamic subtest pipe-B-DP-3: SUCCESS (0.419s) [257.637295] Starting dynamic subtest: pipe-C-DP-3 [258.060988] Dynamic subtest pipe-C-DP-3: SUCCESS (0.431s) [258.070185] Starting dynamic subtest: pipe-D-DP-3 [258.519901] Dynamic subtest pipe-D-DP-3: SUCCESS (0.457s) [258.520663] Subtest compare-crc-sanitycheck-xr24: SUCCESS (2.175s) [258.991174] [116/162] (746s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [260.421587] Starting subtest: compare-crc-sanitycheck-nv12 [260.422304] Starting dynamic subtest: pipe-A-eDP-1 [261.433166] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.011s) [261.442124] Starting dynamic subtest: pipe-B-DP-3 [262.002892] Dynamic subtest pipe-B-DP-3: SUCCESS (0.569s) [262.012064] Starting dynamic subtest: pipe-C-DP-3 [262.571561] Dynamic subtest pipe-C-DP-3: SUCCESS (0.567s) [262.580585] Starting dynamic subtest: pipe-D-DP-3 [263.131730] Dynamic subtest pipe-D-DP-3: SUCCESS (0.558s) [263.132453] Subtest compare-crc-sanitycheck-nv12: SUCCESS (2.711s) [263.614604] [117/162] (742s left) kms_pipe_crc_basic (hang-read-crc) [265.047549] Starting subtest: hang-read-crc [265.048231] Starting dynamic subtest: pipe-A-eDP-1 [267.384546] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.336s) [267.393708] Starting dynamic subtest: pipe-B-DP-3 [268.558658] Dynamic subtest pipe-B-DP-3: SUCCESS (1.173s) [268.568169] Starting dynamic subtest: pipe-C-DP-3 [269.726655] Dynamic subtest pipe-C-DP-3: SUCCESS (1.166s) [269.741333] Starting dynamic subtest: pipe-D-DP-3 [270.892665] Dynamic subtest pipe-D-DP-3: SUCCESS (1.164s) [270.893381] Subtest hang-read-crc: SUCCESS (5.845s) [271.344708] [118/162] (734s left) kms_pipe_crc_basic (nonblocking-crc) [272.783850] Starting subtest: nonblocking-crc [272.784526] Starting dynamic subtest: pipe-A-eDP-1 [273.813960] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.019s) [273.826505] Starting dynamic subtest: pipe-B-DP-3 [274.416612] Dynamic subtest pipe-B-DP-3: SUCCESS (0.611s) [274.425933] Starting dynamic subtest: pipe-C-DP-3 [275.030601] Dynamic subtest pipe-C-DP-3: SUCCESS (0.612s) [275.039632] Starting dynamic subtest: pipe-D-DP-3 [275.626778] Dynamic subtest pipe-D-DP-3: SUCCESS (0.594s) [275.627448] Subtest nonblocking-crc: SUCCESS (2.844s) [276.080889] [119/162] (729s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [277.512871] Starting subtest: nonblocking-crc-frame-sequence [277.513571] Starting dynamic subtest: pipe-A-eDP-1 [278.510923] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.997s) [278.519820] Starting dynamic subtest: pipe-B-DP-3 [279.120769] Dynamic subtest pipe-B-DP-3: SUCCESS (0.609s) [279.131975] Starting dynamic subtest: pipe-C-DP-3 [279.718321] Dynamic subtest pipe-C-DP-3: SUCCESS (0.595s) [279.726888] Starting dynamic subtest: pipe-D-DP-3 [280.320021] Dynamic subtest pipe-D-DP-3: SUCCESS (0.600s) [280.320701] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.808s) [280.770477] [120/162] (725s left) kms_pipe_crc_basic (read-crc) [282.220551] Starting subtest: read-crc [282.221249] Starting dynamic subtest: pipe-A-eDP-1 [283.149822] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.928s) [283.159848] Starting dynamic subtest: pipe-B-DP-3 [283.680789] Dynamic subtest pipe-B-DP-3: SUCCESS (0.529s) [283.688959] Starting dynamic subtest: pipe-C-DP-3 [284.207592] Dynamic subtest pipe-C-DP-3: SUCCESS (0.526s) [284.217578] Starting dynamic subtest: pipe-D-DP-3 [284.748244] Dynamic subtest pipe-D-DP-3: SUCCESS (0.540s) [284.748861] Subtest read-crc: SUCCESS (2.529s) [285.206317] [121/162] (720s left) kms_pipe_crc_basic (read-crc-frame-sequence) [286.645913] Starting subtest: read-crc-frame-sequence [286.646696] Starting dynamic subtest: pipe-A-eDP-1 [287.560022] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.913s) [287.573073] Starting dynamic subtest: pipe-B-DP-3 [288.098570] Dynamic subtest pipe-B-DP-3: SUCCESS (0.538s) [288.107386] Starting dynamic subtest: pipe-C-DP-3 [288.629953] Dynamic subtest pipe-C-DP-3: SUCCESS (0.530s) [288.642519] Starting dynamic subtest: pipe-D-DP-3 [289.162106] Dynamic subtest pipe-D-DP-3: SUCCESS (0.531s) [289.162767] Subtest read-crc-frame-sequence: SUCCESS (2.518s) [289.619932] [122/162] (716s left) kms_pm_backlight (basic-brightness) [291.055262] Starting subtest: basic-brightness [291.143902] Starting dynamic subtest: eDP-1 [291.462066] Dynamic subtest eDP-1: SUCCESS (0.319s) [291.462930] Subtest basic-brightness: SUCCESS (0.408s) [292.484358] [123/162] (713s left) kms_pm_rpm (basic-pci-d3-state) [296.154524] Starting subtest: basic-pci-d3-state [298.328748] Subtest basic-pci-d3-state: SUCCESS (2.174s) [299.303523] [124/162] (706s left) kms_pm_rpm (basic-rte) [299.337075] Starting subtest: basic-rte [305.079615] Subtest basic-rte: SUCCESS (5.743s) [308.388235] [125/162] (697s left) kms_psr (psr-primary-page-flip) [309.820245] Starting subtest: psr-primary-page-flip [309.820905] Starting dynamic subtest: eDP-1 [311.700619] Dynamic subtest eDP-1: SUCCESS (1.879s) [311.701293] Subtest psr-primary-page-flip: SUCCESS (1.880s) [312.686893] [126/162] (693s left) kms_psr (psr-cursor-plane-move) [314.121849] Starting subtest: psr-cursor-plane-move [314.122566] Starting dynamic subtest: eDP-1 [316.053285] Dynamic subtest eDP-1: SUCCESS (1.931s) [316.054161] Subtest psr-cursor-plane-move: SUCCESS (1.932s) [317.056167] [127/162] (689s left) kms_psr (psr-sprite-plane-onoff) [318.500236] Starting subtest: psr-sprite-plane-onoff [318.500885] Starting dynamic subtest: eDP-1 [320.499656] Dynamic subtest eDP-1: SUCCESS (1.998s) [320.500385] Subtest psr-sprite-plane-onoff: SUCCESS (2.000s) [321.449787] [128/162] (684s left) kms_psr (psr-primary-mmap-gtt) [322.883950] Starting subtest: psr-primary-mmap-gtt [322.884852] Starting dynamic subtest: eDP-1 [324.817446] Dynamic subtest eDP-1: SUCCESS (1.934s) [324.818121] Subtest psr-primary-mmap-gtt: SUCCESS (1.935s) [325.832877] [129/162] (680s left) kms_setmode (basic-clone-single-crtc) [325.864408] Starting subtest: basic-clone-single-crtc [326.303758] Subtest basic-clone-single-crtc: SKIP (0.438s) [327.128181] [130/162] (679s left) i915_pm_rps (basic-api) [327.173689] Starting subtest: basic-api [327.175372] Subtest basic-api: SKIP (0.000s) [327.269372] [131/162] (678s left) prime_self_import (basic-llseek-bad) [327.297245] Starting subtest: basic-llseek-bad [327.298618] Subtest basic-llseek-bad: SUCCESS (0.001s) [327.417438] [132/162] (678s left) prime_self_import (basic-llseek-size) [327.449068] Starting subtest: basic-llseek-size [327.450309] Subtest basic-llseek-size: SUCCESS (0.002s) [327.587531] [133/162] (678s left) prime_self_import (basic-with_fd_dup) [327.614557] Starting subtest: basic-with_fd_dup [327.615937] Subtest basic-with_fd_dup: SUCCESS (0.002s) [327.724605] [134/162] (678s left) prime_self_import (basic-with_one_bo) [327.749462] Starting subtest: basic-with_one_bo [327.752250] Subtest basic-with_one_bo: SUCCESS (0.002s) [327.908154] [135/162] (678s left) prime_self_import (basic-with_one_bo_two_files) [327.938490] Starting subtest: basic-with_one_bo_two_files [327.939790] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s) [328.055021] [136/162] (678s left) prime_self_import (basic-with_two_bos) [328.084485] Starting subtest: basic-with_two_bos [328.085922] Subtest basic-with_two_bos: SUCCESS (0.002s) [328.220377] [137/162] (678s left) prime_vgem (basic-fence-flip) [328.285602] Starting subtest: basic-fence-flip [330.057779] Subtest basic-fence-flip: SUCCESS (1.772s) [330.183014] [138/162] (676s left) prime_vgem (basic-fence-mmap) [330.257138] Starting subtest: basic-fence-mmap [330.276943] Subtest basic-fence-mmap: SUCCESS (0.020s) [330.401545] [139/162] (676s left) prime_vgem (basic-fence-read) [330.460558] Starting subtest: basic-fence-read [330.464222] Subtest basic-fence-read: SKIP (0.003s) [330.576323] [140/162] (675s left) prime_vgem (basic-gtt) [330.645915] Starting subtest: basic-gtt [330.654046] Subtest basic-gtt: SUCCESS (0.008s) [330.787077] [141/162] (675s left) prime_vgem (basic-read) [330.841887] Starting subtest: basic-read [330.845198] Subtest basic-read: SKIP (0.003s) [330.953415] [142/162] (675s left) prime_vgem (basic-write) [331.006163] Starting subtest: basic-write [331.009531] Subtest basic-write: SKIP (0.003s) [331.133242] [143/162] (675s left) vgem_basic (setversion) [331.175055] Starting subtest: setversion [331.176435] Subtest setversion: SUCCESS (0.000s) [331.248954] [144/162] (675s left) vgem_basic (create) [331.292527] Starting subtest: create [331.293289] Subtest create: SUCCESS (0.000s) [331.397064] [145/162] (675s left) vgem_basic (debugfs) [331.442913] Starting subtest: debugfs [331.443944] Subtest debugfs: SUCCESS (0.000s) [331.512936] [146/162] (675s left) vgem_basic (dmabuf-export) [331.558762] Starting subtest: dmabuf-export [331.576923] Subtest dmabuf-export: SUCCESS (0.017s) [331.682182] [147/162] (675s left) vgem_basic (dmabuf-fence) [331.725156] Starting subtest: dmabuf-fence [331.725880] Subtest dmabuf-fence: SUCCESS (0.000s) [331.802503] [148/162] (675s left) vgem_basic (dmabuf-fence-before) [331.841851] Starting subtest: dmabuf-fence-before [331.842520] Subtest dmabuf-fence-before: SUCCESS (0.000s) [331.930987] [149/162] (674s left) vgem_basic (dmabuf-mmap) [331.975557] Starting subtest: dmabuf-mmap [331.981129] Subtest dmabuf-mmap: SUCCESS (0.006s) [332.083238] [150/162] (674s left) vgem_basic (mmap) [332.125820] Starting subtest: mmap [332.129586] Subtest mmap: SUCCESS (0.004s) [332.195055] [151/162] (674s left) vgem_basic (second-client) [332.236264] Starting subtest: second-client [332.270274] Subtest second-client: SUCCESS (0.034s) [332.349410] [152/162] (674s left) vgem_basic (sysfs) [332.392753] Starting subtest: sysfs [332.393432] Subtest sysfs: SUCCESS (0.000s) [332.462560] [153/162] (674s left) core_hotunplug (unbind-rebind) [332.541766] Starting subtest: unbind-rebind [338.926290] Subtest unbind-rebind: SUCCESS (6.384s) [338.968101] [154/162] (668s left) vgem_basic (unload) [338.998964] Starting subtest: unload [368.041482] Subtest unload: SUCCESS (29.034s) [368.155893] [155/162] (638s left) i915_module_load (reload) [368.191606] Starting subtest: reload [374.271883] Subtest reload: SUCCESS (6.080s) [374.303995] [156/162] (632s left) gem_lmem_swapping (basic) [374.342277] Subtest basic: SKIP (0.000s) [374.382492] [157/162] (632s left) gem_lmem_swapping (parallel-random-engines) [374.412413] Subtest parallel-random-engines: SKIP (0.000s) [374.468068] [158/162] (632s left) gem_lmem_swapping (random-engines) [374.502928] Subtest random-engines: SKIP (0.000s) [374.552379] [159/162] (632s left) gem_lmem_swapping (verify-random) [374.585264] Subtest verify-random: SKIP (0.000s) [374.632966] [160/162] (632s left) i915_pm_rpm (module-reload) [379.690467] Starting subtest: module-reload [400.897429] Subtest module-reload: SUCCESS (21.198s) [400.921455] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [400.922212] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [400.926234] [161/162] (606s left) i915_selftest (live) [400.968162] Starting subtest: live [400.969119] Starting dynamic subtest: sanitycheck [402.865115] Dynamic subtest sanitycheck: SUCCESS (1.887s) [402.871066] Starting dynamic subtest: uncore [404.754990] Dynamic subtest uncore: SUCCESS (1.889s) [404.761691] Starting dynamic subtest: workarounds [407.488157] Dynamic subtest workarounds: SUCCESS (2.731s) [407.494198] Starting dynamic subtest: gt_engines [409.916048] Dynamic subtest gt_engines: SUCCESS (2.425s) [409.924402] Starting dynamic subtest: gt_timelines [420.870098] Dynamic subtest gt_timelines: SUCCESS (10.952s) [420.875951] Starting dynamic subtest: gt_contexts [422.784085] Dynamic subtest gt_contexts: SUCCESS (1.912s) [422.789895] Starting dynamic subtest: gt_lrc [427.100066] Dynamic subtest gt_lrc: SUCCESS (4.315s) [427.105946] Starting dynamic subtest: gt_mocs [429.411147] Dynamic subtest gt_mocs: SUCCESS (2.310s) [429.416886] Starting dynamic subtest: gt_pm