[42.870509] Initializing watchdogs [42.870561] /dev/watchdog0 [42.891804] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d51 Intel Meteorlake (Gen12) [42.910830] [001/162] (960s left) i915_module_load (load) [42.978336] Starting subtest: load [45.738772] Subtest load: SUCCESS (2.770s) [45.791833] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [45.792891] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [45.807572] [002/162] (957s left) core_auth (basic-auth) [46.854716] Starting subtest: basic-auth [46.868027] Subtest basic-auth: SUCCESS (0.001s) [46.957981] [003/162] (956s left) core_debugfs (read-all-entries) [47.029957] Starting subtest: read-all-entries [47.141660] Subtest read-all-entries: SUCCESS (0.119s) [47.274119] [004/162] (956s left) core_sysfs (read-all-entries) [47.347686] Starting subtest: read-all-entries [47.355989] Subtest read-all-entries: SUCCESS (0.004s) [47.451895] [005/162] (956s left) fbdev (eof) [47.510363] Starting subtest: eof [47.522511] Subtest eof: SUCCESS (0.000s) [47.665534] [006/162] (956s left) fbdev (info) [47.735097] Starting subtest: info [47.741736] Subtest info: SUCCESS (0.000s) [47.834773] [007/162] (955s left) fbdev (nullptr) [47.887761] Starting subtest: nullptr [47.901222] Subtest nullptr: SUCCESS (0.000s) [47.999063] [008/162] (955s left) fbdev (read) [48.047740] Starting subtest: read [48.943780] Subtest read: SUCCESS (0.894s) [49.042517] [009/162] (954s left) fbdev (write) [49.095735] Starting subtest: write [49.783278] Subtest write: SUCCESS (0.690s) [49.923485] [010/162] (954s left) gem_basic (bad-close) [49.980748] Starting subtest: bad-close [49.993727] Subtest bad-close: SUCCESS (0.000s) [50.070762] [011/162] (953s left) gem_basic (create-close) [50.124926] Starting subtest: create-close [50.138286] Subtest create-close: SUCCESS (0.000s) [50.289527] [012/162] (953s left) gem_basic (create-fd-close) [50.343570] Starting subtest: create-fd-close [50.356528] Subtest create-fd-close: SUCCESS (0.000s) [50.465145] [013/162] (953s left) gem_busy (busy@all-engines) [50.519236] Starting subtest: busy [50.526704] Starting dynamic subtest: all-engines [50.566714] Dynamic subtest all-engines: SUCCESS (0.047s) [50.572965] Subtest busy: SUCCESS (0.048s) [51.884823] [014/162] (952s left) gem_close_race (basic-process) [51.946912] Starting subtest: basic-process [52.019797] Subtest basic-process: SUCCESS (0.080s) [52.245129] [015/162] (951s left) gem_close_race (basic-threads) [52.302696] Starting subtest: basic-threads [53.623194] Subtest basic-threads: SUCCESS (1.325s) [53.860545] [016/162] (950s left) gem_ctx_create (basic) [53.928796] Starting subtest: basic [53.935103] Subtest basic: SUCCESS (0.000s) [54.129724] [017/162] (950s left) gem_ctx_create (basic-files) [54.198896] Starting subtest: basic-files [56.241092] Subtest basic-files: SUCCESS (2.034s) [57.944206] [018/162] (946s left) gem_ctx_exec (basic) [58.026086] Starting subtest: basic [58.034953] Subtest basic: SUCCESS (0.011s) [58.289506] [019/162] (946s left) gem_exec_basic (basic) [58.365827] Starting subtest: basic [58.382436] Starting dynamic subtest: rcs0-smem [58.390241] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [58.419790] Starting dynamic subtest: bcs0-smem [58.428687] Dynamic subtest bcs0-smem: SUCCESS (0.002s) [58.469688] Starting dynamic subtest: vcs0-smem [58.479671] Dynamic subtest vcs0-smem: SUCCESS (0.002s) [58.508783] Starting dynamic subtest: vcs1-smem [58.520174] Dynamic subtest vcs1-smem: SUCCESS (0.002s) [58.558956] Starting dynamic subtest: vecs0-smem [58.568868] Dynamic subtest vecs0-smem: SUCCESS (0.002s) [58.606632] Starting dynamic subtest: ccs0-smem [58.616652] Dynamic subtest ccs0-smem: SUCCESS (0.002s) [58.630128] Subtest basic: SUCCESS (0.014s) [59.913869] [020/162] (944s left) gem_exec_create (basic) [59.995838] Starting subtest: basic [60.004813] Starting dynamic subtest: smem [63.845174] Dynamic subtest smem: SUCCESS (3.853s) [63.852301] Subtest basic: SUCCESS (3.854s) [64.142268] [021/162] (940s left) gem_exec_fence (basic-busy) [64.326891] Starting subtest: basic-busy [64.335753] Starting dynamic subtest: rcs0 [64.419274] Dynamic subtest rcs0: SUCCESS (0.095s) [64.441411] Starting dynamic subtest: bcs0 [64.474483] Dynamic subtest bcs0: SUCCESS (0.062s) [64.489118] Starting dynamic subtest: vcs0 [64.536112] Dynamic subtest vcs0: SUCCESS (0.064s) [64.552915] Starting dynamic subtest: vcs1 [64.600468] Dynamic subtest vcs1: SUCCESS (0.061s) [64.619990] Starting dynamic subtest: vecs0 [64.667525] Dynamic subtest vecs0: SUCCESS (0.067s) [64.686986] Starting dynamic subtest: ccs0 [64.733797] Dynamic subtest ccs0: SUCCESS (0.064s) [64.740211] Subtest basic-busy: SUCCESS (0.414s) [66.995780] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [67.009780] [022/162] (937s left) gem_exec_fence (basic-wait) [67.200295] Starting subtest: basic-wait [67.213743] Starting dynamic subtest: rcs0 [67.267389] Dynamic subtest rcs0: SUCCESS (0.079s) [67.307975] Starting dynamic subtest: bcs0 [67.331389] Dynamic subtest bcs0: SUCCESS (0.055s) [67.366616] Starting dynamic subtest: vcs0 [67.376292] Dynamic subtest vcs0: SUCCESS (0.054s) [67.416510] Starting dynamic subtest: vcs1 [67.440076] Dynamic subtest vcs1: SUCCESS (0.056s) [67.475168] Starting dynamic subtest: vecs0 [67.498385] Dynamic subtest vecs0: SUCCESS (0.055s) [67.533762] Starting dynamic subtest: ccs0 [67.557037] Dynamic subtest ccs0: SUCCESS (0.059s) [67.566787] Subtest basic-wait: SUCCESS (0.361s) [68.993324] [023/162] (936s left) gem_exec_fence (basic-await) [69.170023] Starting subtest: basic-await [69.177019] Starting dynamic subtest: rcs0 [69.255610] Dynamic subtest rcs0: SUCCESS (0.093s) [69.285044] Starting dynamic subtest: bcs0 [69.343255] Dynamic subtest bcs0: SUCCESS (0.086s) [69.373509] Starting dynamic subtest: vcs0 [69.434428] Dynamic subtest vcs0: SUCCESS (0.085s) [69.470212] Starting dynamic subtest: vcs1 [69.516876] Dynamic subtest vcs1: SUCCESS (0.083s) [69.551966] Starting dynamic subtest: vecs0 [69.598721] Dynamic subtest vecs0: SUCCESS (0.082s) [69.635878] Starting dynamic subtest: ccs0 [69.682332] Dynamic subtest ccs0: SUCCESS (0.083s) [69.688995] Subtest basic-await: SUCCESS (0.513s) [72.183667] [024/162] (932s left) gem_exec_fence (nb-await) [72.398956] Starting subtest: nb-await [72.412273] Starting dynamic subtest: rcs0 [72.491394] Dynamic subtest rcs0: SUCCESS (0.097s) [72.513676] Starting dynamic subtest: bcs0 [72.553372] Dynamic subtest bcs0: SUCCESS (0.069s) [72.565542] Starting dynamic subtest: vcs0 [72.619022] Dynamic subtest vcs0: SUCCESS (0.066s) [72.631219] Starting dynamic subtest: vcs1 [72.678413] Dynamic subtest vcs1: SUCCESS (0.059s) [72.690801] Starting dynamic subtest: vecs0 [72.743278] Dynamic subtest vecs0: SUCCESS (0.065s) [72.754959] Starting dynamic subtest: ccs0 [72.802317] Dynamic subtest ccs0: SUCCESS (0.059s) [72.808812] Subtest nb-await: SUCCESS (0.417s) [74.989646] [025/162] (930s left) gem_exec_gttfill (basic) [75.048580] Starting subtest: basic [78.875983] Subtest basic: SUCCESS (3.825s) [79.162275] [026/162] (926s left) gem_exec_parallel (engines) [79.272657] Starting subtest: engines [79.279147] Starting dynamic subtest: basic [80.840128] Dynamic subtest basic: SUCCESS (1.586s) [80.861877] Starting dynamic subtest: contexts [85.466856] Dynamic subtest contexts: SUCCESS (4.614s) [85.488430] Starting dynamic subtest: fds [90.930549] Dynamic subtest fds: SUCCESS (5.463s) [90.955584] Starting dynamic subtest: userptr [92.857430] Dynamic subtest userptr: SUCCESS (1.924s) [92.865803] Subtest engines: SUCCESS (13.589s) [93.120104] [027/162] (912s left) gem_exec_store (basic) [93.234188] Starting subtest: basic [93.317337] Subtest basic: SUCCESS (0.126s) [93.553991] [028/162] (911s left) gem_flink_basic (bad-flink) [93.620847] Starting subtest: bad-flink [93.627039] Subtest bad-flink: SUCCESS (0.000s) [93.724361] [029/162] (911s left) gem_flink_basic (bad-open) [93.794569] Starting subtest: bad-open [93.806807] Subtest bad-open: SUCCESS (0.000s) [93.882976] [030/162] (911s left) gem_flink_basic (basic) [93.953303] Starting subtest: basic [93.963736] Subtest basic: SUCCESS (0.000s) [94.108339] [031/162] (911s left) gem_flink_basic (double-flink) [94.197391] Starting subtest: double-flink [94.203580] Subtest double-flink: SUCCESS (0.000s) [94.332186] [032/162] (911s left) gem_flink_basic (flink-lifetime) [94.399219] Starting subtest: flink-lifetime [94.409630] Subtest flink-lifetime: SUCCESS (0.001s) [94.531507] [033/162] (911s left) gem_huc_copy (huc-copy) [94.600600] Starting subtest: huc-copy [94.606759] Subtest huc-copy: SUCCESS (0.006s) [94.772821] [034/162] (911s left) gem_linear_blits (basic) [94.934056] Starting subtest: basic [94.953118] Subtest basic: SUCCESS (0.013s) [95.178385] [035/162] (910s left) gem_mmap (basic) [95.273171] Subtest basic: SKIP (0.000s) [95.341400] [036/162] (910s left) gem_mmap_gtt (basic) [95.421483] Subtest basic: SKIP (0.000s) [95.496921] [037/162] (910s left) gem_render_linear_blits (basic) [95.568495] Starting subtest: basic [95.613641] Subtest basic: SUCCESS (0.049s) [95.724489] [038/162] (910s left) gem_render_tiled_blits (basic) [95.813029] Subtest basic: SKIP (0.000s) [95.887758] [039/162] (910s left) gem_ringfill (basic-all) [101.872811] Starting subtest: basic-all [103.035033] Subtest basic-all: SUCCESS (1.174s) [103.217383] [040/162] (903s left) gem_softpin (allocator-basic) [103.308535] Starting subtest: allocator-basic [103.381937] Subtest allocator-basic: SUCCESS (0.095s) [103.593134] [041/162] (902s left) gem_softpin (allocator-basic-reserve) [103.681749] Starting subtest: allocator-basic-reserve [103.764531] Subtest allocator-basic-reserve: SUCCESS (0.103s) [103.968709] [042/162] (902s left) gem_softpin (safe-alignment) [104.057427] Starting subtest: safe-alignment [104.079893] Subtest safe-alignment: SUCCESS (0.050s) [105.920045] [043/162] (900s left) gem_sync (basic-all) [106.061857] Starting subtest: basic-all [109.137945] Subtest basic-all: SUCCESS (3.153s) [109.362222] [044/162] (897s left) gem_sync (basic-each) [109.526791] Starting subtest: basic-each [111.781635] Subtest basic-each: SUCCESS (2.352s) [112.055470] [045/162] (894s left) gem_tiled_blits (basic) [112.159760] Subtest basic: SKIP (0.000s) [112.231211] [046/162] (894s left) gem_tiled_fence_blits (basic) [112.318037] Subtest basic: SKIP (0.000s) [112.387524] [047/162] (894s left) gem_tiled_pread_basic [112.505834] [048/162] (894s left) gem_wait (busy@all-engines) [112.565084] Starting subtest: busy [112.571656] Starting dynamic subtest: all-engines [113.822354] Dynamic subtest all-engines: SUCCESS (1.252s) [113.832937] Subtest busy: SUCCESS (1.253s) [114.087184] [049/162] (892s left) gem_wait (wait@all-engines) [114.141709] Starting subtest: wait [114.147870] Starting dynamic subtest: all-engines [115.805826] Dynamic subtest all-engines: SUCCESS (1.655s) [115.812160] Subtest wait: SUCCESS (1.656s) [116.035357] [050/162] (890s left) i915_getparams_basic (basic-eu-total) [116.090143] Starting subtest: basic-eu-total [116.103718] Subtest basic-eu-total: SUCCESS (0.000s) [116.226721] [051/162] (890s left) i915_getparams_basic (basic-subslice-total) [116.276701] Starting subtest: basic-subslice-total [116.289743] Subtest basic-subslice-total: SUCCESS (0.000s) [116.383504] [052/162] (890s left) i915_hangman (error-state-basic) [116.437056] Starting subtest: error-state-basic [116.571715] Subtest error-state-basic: SUCCESS (0.131s) [116.686144] [053/162] (890s left) i915_pciid [116.848136] [054/162] (890s left) intel_hwmon (hwmon-read) [116.909098] Subtest hwmon-read: SKIP (0.000s) [116.965402] [055/162] (890s left) intel_hwmon (hwmon-write) [117.031369] Subtest hwmon-write: SKIP (0.000s) [117.086815] [056/162] (890s left) kms_addfb_basic (addfb25-4-tiled) [117.173497] Starting subtest: addfb25-4-tiled [117.184042] Subtest addfb25-4-tiled: SUCCESS (0.000s) [117.342110] [057/162] (889s left) kms_addfb_basic (addfb25-bad-modifier) [117.442154] Starting subtest: addfb25-bad-modifier [117.448639] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [117.608883] [058/162] (889s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [117.689654] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s) [117.855593] [059/162] (889s left) kms_addfb_basic (addfb25-modifier-no-flag) [117.935884] Starting subtest: addfb25-modifier-no-flag [117.952274] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [118.093084] [060/162] (889s left) kms_addfb_basic (addfb25-x-tiled-legacy) [118.188202] Subtest addfb25-x-tiled-legacy: SKIP (0.000s) [118.342797] [061/162] (889s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [118.437873] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s) [118.579177] [062/162] (889s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [118.664384] Starting subtest: addfb25-yf-tiled-legacy [118.680980] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [118.851838] [063/162] (888s left) kms_addfb_basic (addfb25-y-tiled-legacy) [118.967038] Starting subtest: addfb25-y-tiled-legacy [118.973486] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [119.113031] [064/162] (888s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [119.224739] Starting subtest: addfb25-y-tiled-small-legacy [119.247510] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [119.371111] [065/162] (888s left) kms_addfb_basic (bad-pitch-0) [119.441589] Starting subtest: bad-pitch-0 [119.454780] Subtest bad-pitch-0: SUCCESS (0.000s) [119.609762] [066/162] (888s left) kms_addfb_basic (bad-pitch-1024) [119.662860] Starting subtest: bad-pitch-1024 [119.669427] Subtest bad-pitch-1024: SUCCESS (0.000s) [119.836981] [067/162] (888s left) kms_addfb_basic (bad-pitch-128) [119.889241] Starting subtest: bad-pitch-128 [119.895837] Subtest bad-pitch-128: SUCCESS (0.000s) [120.059461] [068/162] (887s left) kms_addfb_basic (bad-pitch-256) [120.111945] Starting subtest: bad-pitch-256 [120.118717] Subtest bad-pitch-256: SUCCESS (0.000s) [120.288243] [069/162] (887s left) kms_addfb_basic (bad-pitch-32) [120.348242] Starting subtest: bad-pitch-32 [120.361731] Subtest bad-pitch-32: SUCCESS (0.000s) [120.533167] [070/162] (887s left) kms_addfb_basic (bad-pitch-63) [120.621668] Starting subtest: bad-pitch-63 [120.628178] Subtest bad-pitch-63: SUCCESS (0.000s) [120.777746] [071/162] (887s left) kms_addfb_basic (bad-pitch-65536) [120.851364] Starting subtest: bad-pitch-65536 [120.867778] Subtest bad-pitch-65536: SUCCESS (0.000s) [121.035697] [072/162] (887s left) kms_addfb_basic (bad-pitch-999) [121.098835] Starting subtest: bad-pitch-999 [121.105662] Subtest bad-pitch-999: SUCCESS (0.000s) [121.286575] [073/162] (886s left) kms_addfb_basic (basic) [121.358194] Starting subtest: basic [121.375261] Subtest basic: SUCCESS (0.000s) [121.535750] [074/162] (886s left) kms_addfb_basic (basic-x-tiled-legacy) [121.624402] Starting subtest: basic-x-tiled-legacy [121.647267] Subtest basic-x-tiled-legacy: SKIP (0.000s) [121.781882] [075/162] (886s left) kms_addfb_basic (basic-y-tiled-legacy) [121.854749] Starting subtest: basic-y-tiled-legacy [121.867835] Subtest basic-y-tiled-legacy: SKIP (0.000s) [122.025580] [076/162] (886s left) kms_addfb_basic (bo-too-small) [122.100769] Starting subtest: bo-too-small [122.107339] Subtest bo-too-small: SUCCESS (0.000s) [122.247791] [077/162] (886s left) kms_addfb_basic (bo-too-small-due-to-tiling) [122.322744] Starting subtest: bo-too-small-due-to-tiling [122.335837] Subtest bo-too-small-due-to-tiling: SKIP (0.000s) [122.482323] [078/162] (885s left) kms_addfb_basic (clobberred-modifier) [122.536774] Starting subtest: clobberred-modifier [122.549859] Subtest clobberred-modifier: SKIP (0.000s) [122.730121] [079/162] (885s left) kms_addfb_basic (framebuffer-vs-set-tiling) [122.801292] Starting subtest: framebuffer-vs-set-tiling [122.824405] Subtest framebuffer-vs-set-tiling: SKIP (0.000s) [122.970286] [080/162] (885s left) kms_addfb_basic (invalid-get-prop) [123.041929] Starting subtest: invalid-get-prop [123.059177] Subtest invalid-get-prop: SUCCESS (0.000s) [123.215610] [081/162] (885s left) kms_addfb_basic (invalid-get-prop-any) [123.287799] Starting subtest: invalid-get-prop-any [123.304252] Subtest invalid-get-prop-any: SUCCESS (0.000s) [123.460291] [082/162] (885s left) kms_addfb_basic (invalid-set-prop) [123.524758] Starting subtest: invalid-set-prop [123.531415] Subtest invalid-set-prop: SUCCESS (0.000s) [123.708748] [083/162] (885s left) kms_addfb_basic (invalid-set-prop-any) [123.780692] Starting subtest: invalid-set-prop-any [123.797230] Subtest invalid-set-prop-any: SUCCESS (0.000s) [123.957231] [084/162] (884s left) kms_addfb_basic (no-handle) [124.035829] Starting subtest: no-handle [124.042683] Subtest no-handle: SUCCESS (0.000s) [124.228802] [085/162] (884s left) kms_addfb_basic (size-max) [124.319684] Starting subtest: size-max [124.326116] Subtest size-max: SUCCESS (0.000s) [124.473839] [086/162] (884s left) kms_addfb_basic (small-bo) [124.548032] Starting subtest: small-bo [124.554451] Subtest small-bo: SUCCESS (0.000s) [124.710440] [087/162] (884s left) kms_addfb_basic (tile-pitch-mismatch) [124.764010] Starting subtest: tile-pitch-mismatch [124.777071] Subtest tile-pitch-mismatch: SKIP (0.000s) [124.935850] [088/162] (884s left) kms_addfb_basic (too-high) [125.009120] Starting subtest: too-high [125.015492] Subtest too-high: SUCCESS (0.000s) [125.163685] [089/162] (883s left) kms_addfb_basic (too-wide) [125.247691] Starting subtest: too-wide [125.259065] Subtest too-wide: SUCCESS (0.000s) [125.402014] [090/162] (883s left) kms_addfb_basic (unused-handle) [125.470858] Starting subtest: unused-handle [125.477408] Subtest unused-handle: SUCCESS (0.000s) [125.620053] [091/162] (883s left) kms_addfb_basic (unused-modifier) [125.695472] Starting subtest: unused-modifier [125.706964] Subtest unused-modifier: SUCCESS (0.000s) [125.862218] [092/162] (883s left) kms_addfb_basic (unused-offsets) [125.928603] Starting subtest: unused-offsets [125.941499] Subtest unused-offsets: SUCCESS (0.000s) [126.100492] [093/162] (883s left) kms_addfb_basic (unused-pitches) [126.168246] Starting subtest: unused-pitches [126.177972] Subtest unused-pitches: SUCCESS (0.000s) [126.342874] [094/162] (883s left) kms_busy (basic) [126.429582] Starting subtest: basic [126.439500] Starting dynamic subtest: flip [127.186160] Dynamic subtest flip: SUCCESS (0.756s) [127.198922] Starting dynamic subtest: modeset [130.588360] Dynamic subtest modeset: SUCCESS (3.398s) [130.601730] Subtest basic: SUCCESS (4.155s) [131.429664] [095/162] (877s left) kms_prop_blob (basic) [131.503519] Starting subtest: basic [131.520111] Subtest basic: SUCCESS (0.000s) [131.611404] [096/162] (877s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [131.734750] Starting subtest: basic-busy-flip-before-cursor-atomic [131.756734] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [131.891053] [097/162] (877s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [131.997087] Starting subtest: basic-busy-flip-before-cursor-legacy [132.019894] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [132.194613] [098/162] (877s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [132.318294] Starting subtest: basic-flip-after-cursor-atomic [133.523163] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.204s) [134.369079] [099/162] (875s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [134.485030] Starting subtest: basic-flip-after-cursor-legacy [135.699470] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.214s) [136.603503] [100/162] (873s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [136.726687] Starting subtest: basic-flip-after-cursor-varying-size [137.931749] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.213s) [138.824784] [101/162] (870s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [138.941997] Starting subtest: basic-flip-before-cursor-atomic [140.158919] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.214s) [141.070777] [102/162] (868s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [141.183347] Starting subtest: basic-flip-before-cursor-legacy [142.397015] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.213s) [143.292805] [103/162] (866s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [143.402531] Starting subtest: basic-flip-before-cursor-varying-size [144.617377] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.214s) [145.506970] [104/162] (864s left) kms_dsc (dsc-basic) [145.579743] Starting subtest: dsc-basic [145.637581] Subtest dsc-basic: SKIP (0.000s) [145.700665] [105/162] (864s left) kms_flip (basic-flip-vs-dpms) [145.798691] Starting subtest: basic-flip-vs-dpms [145.810355] Starting dynamic subtest: A-eDP1 [148.379662] Dynamic subtest A-eDP1: SUCCESS (2.586s) [148.397381] Starting dynamic subtest: B-eDP1 [150.544014] Dynamic subtest B-eDP1: SUCCESS (2.164s) [150.561807] Starting dynamic subtest: C-eDP1 [152.703743] Dynamic subtest C-eDP1: SUCCESS (2.157s) [152.721423] Starting dynamic subtest: D-eDP1 [154.876105] Dynamic subtest D-eDP1: SUCCESS (2.175s) [154.892700] Subtest basic-flip-vs-dpms: SUCCESS (9.091s) [155.733233] [106/162] (854s left) kms_flip (basic-flip-vs-modeset) [155.835637] Starting subtest: basic-flip-vs-modeset [155.846249] Starting dynamic subtest: A-eDP1 [158.366070] Dynamic subtest A-eDP1: SUCCESS (2.541s) [158.383451] Starting dynamic subtest: B-eDP1 [160.523642] Dynamic subtest B-eDP1: SUCCESS (2.161s) [160.536160] Starting dynamic subtest: C-eDP1 [162.682794] Dynamic subtest C-eDP1: SUCCESS (2.152s) [162.700437] Starting dynamic subtest: D-eDP1 [164.843644] Dynamic subtest D-eDP1: SUCCESS (2.160s) [164.855973] Subtest basic-flip-vs-modeset: SUCCESS (9.022s) [165.699521] [107/162] (844s left) kms_flip (basic-flip-vs-wf_vblank) [165.791107] Starting subtest: basic-flip-vs-wf_vblank [165.797463] Starting dynamic subtest: A-eDP1 [167.740488] Dynamic subtest A-eDP1: SUCCESS (1.958s) [167.753419] Starting dynamic subtest: B-eDP1 [169.962085] Dynamic subtest B-eDP1: SUCCESS (2.206s) [169.979083] Starting dynamic subtest: C-eDP1 [172.090909] Dynamic subtest C-eDP1: SUCCESS (2.118s) [172.112941] Starting dynamic subtest: D-eDP1 [174.061175] Dynamic subtest D-eDP1: SUCCESS (1.969s) [174.067601] Subtest basic-flip-vs-wf_vblank: SUCCESS (8.259s) [175.251433] [108/162] (834s left) kms_flip (basic-plain-flip) [175.364522] Starting subtest: basic-plain-flip [175.371082] Starting dynamic subtest: A-eDP1 [177.052686] Dynamic subtest A-eDP1: SUCCESS (1.712s) [177.073444] Starting dynamic subtest: B-eDP1 [178.778755] Dynamic subtest B-eDP1: SUCCESS (1.725s) [178.799808] Starting dynamic subtest: C-eDP1 [180.488462] Dynamic subtest C-eDP1: SUCCESS (1.714s) [180.507631] Starting dynamic subtest: D-eDP1 [182.225402] Dynamic subtest D-eDP1: SUCCESS (1.723s) [182.238760] Subtest basic-plain-flip: SUCCESS (6.881s) [183.525226] [109/162] (826s left) kms_force_connector_basic (force-connector-state) [183.617948] Starting subtest: force-connector-state [184.189607] Subtest force-connector-state: SUCCESS (0.589s) [185.366247] [110/162] (824s left) kms_force_connector_basic (force-edid) [185.442718] Starting subtest: force-edid [185.732411] Subtest force-edid: SUCCESS (0.292s) [185.928321] [111/162] (824s left) kms_force_connector_basic (force-load-detect) [186.004073] Starting subtest: force-load-detect [186.022965] Subtest force-load-detect: SKIP (0.000s) [186.156636] [112/162] (824s left) kms_force_connector_basic (prune-stale-modes) [186.235623] Starting subtest: prune-stale-modes [186.588695] Subtest prune-stale-modes: SUCCESS (0.364s) [186.747504] [113/162] (823s left) kms_frontbuffer_tracking (basic) [186.850745] Starting subtest: basic [192.252760] Subtest basic: SUCCESS (5.418s) [192.431722] [114/162] (818s left) kms_hdmi_inject (inject-audio) [192.787763] Starting subtest: inject-audio [193.030545] Subtest inject-audio: SUCCESS (0.249s) [193.654617] [115/162] (817s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [193.751925] Starting subtest: compare-crc-sanitycheck-xr24 [193.768382] Starting dynamic subtest: pipe-A-eDP-1 [194.636450] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.873s) [194.658200] Starting dynamic subtest: pipe-B-eDP-1 [196.135111] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.500s) [196.157220] Starting dynamic subtest: pipe-C-eDP-1 [197.500104] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.369s) [197.517701] Starting dynamic subtest: pipe-D-eDP-1 [198.900816] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.398s) [198.917622] Subtest compare-crc-sanitycheck-xr24: SUCCESS (5.152s) [199.824447] [116/162] (810s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [199.914576] Starting subtest: compare-crc-sanitycheck-nv12 [199.921086] Starting dynamic subtest: pipe-A-eDP-1 [200.843998] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.925s) [200.867131] Starting dynamic subtest: pipe-B-eDP-1 [202.252214] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.406s) [202.273970] Starting dynamic subtest: pipe-C-eDP-1 [203.601787] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.355s) [203.619599] Starting dynamic subtest: pipe-D-eDP-1 [204.977979] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.374s) [204.994345] Subtest compare-crc-sanitycheck-nv12: SUCCESS (5.070s) [205.834490] [117/162] (804s left) kms_pipe_crc_basic (hang-read-crc) [205.923275] Starting subtest: hang-read-crc [205.931208] Starting dynamic subtest: pipe-A-eDP-1 [208.285160] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.365s) [208.300275] Starting dynamic subtest: pipe-B-eDP-1 [211.386701] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.104s) [211.399524] Starting dynamic subtest: pipe-C-eDP-1 [214.349725] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.963s) [214.367292] Starting dynamic subtest: pipe-D-eDP-1 [217.354463] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.004s) [217.361178] Subtest hang-read-crc: SUCCESS (11.445s) [218.222396] [118/162] (792s left) kms_pipe_crc_basic (nonblocking-crc) [218.322538] Starting subtest: nonblocking-crc [218.336060] Starting dynamic subtest: pipe-A-eDP-1 [219.353662] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.043s) [219.371403] Starting dynamic subtest: pipe-B-eDP-1 [221.001067] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.639s) [221.016090] Starting dynamic subtest: pipe-C-eDP-1 [222.607327] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.608s) [222.625151] Starting dynamic subtest: pipe-D-eDP-1 [224.212900] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.595s) [224.223646] Subtest nonblocking-crc: SUCCESS (5.895s) [225.127479] [119/162] (785s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [225.205338] Starting subtest: nonblocking-crc-frame-sequence [225.211866] Starting dynamic subtest: pipe-A-eDP-1 [226.088098] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.873s) [226.110049] Starting dynamic subtest: pipe-B-eDP-1 [227.551089] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.463s) [227.573075] Starting dynamic subtest: pipe-C-eDP-1 [228.999750] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.444s) [229.021143] Starting dynamic subtest: pipe-D-eDP-1 [230.519990] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.521s) [230.536504] Subtest nonblocking-crc-frame-sequence: SUCCESS (5.307s) [231.447776] [120/162] (779s left) kms_pipe_crc_basic (read-crc) [231.540801] Starting subtest: read-crc [231.557419] Starting dynamic subtest: pipe-A-eDP-1 [232.364149] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.822s) [232.382066] Starting dynamic subtest: pipe-B-eDP-1 [233.786324] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.420s) [233.804179] Starting dynamic subtest: pipe-C-eDP-1 [235.220876] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.436s) [235.240172] Starting dynamic subtest: pipe-D-eDP-1 [236.621842] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.399s) [236.628761] Subtest read-crc: SUCCESS (5.083s) [237.519201] [121/162] (773s left) kms_pipe_crc_basic (read-crc-frame-sequence) [237.608877] Starting subtest: read-crc-frame-sequence [237.615275] Starting dynamic subtest: pipe-A-eDP-1 [238.416899] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.809s) [238.430682] Starting dynamic subtest: pipe-B-eDP-1 [239.886122] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.463s) [239.903926] Starting dynamic subtest: pipe-C-eDP-1 [241.330494] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.446s) [241.348125] Starting dynamic subtest: pipe-D-eDP-1 [242.721906] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.391s) [242.730515] Subtest read-crc-frame-sequence: SUCCESS (5.115s) [243.614895] [122/162] (767s left) kms_pm_backlight (basic-brightness) [243.688893] Starting subtest: basic-brightness [243.758599] Starting dynamic subtest: eDP-1 [244.088162] Dynamic subtest eDP-1: SUCCESS (0.333s) [244.094361] Subtest basic-brightness: SUCCESS (0.398s) [245.022779] [123/162] (766s left) kms_pm_rpm (basic-pci-d3-state) [246.951944] Starting subtest: basic-pci-d3-state [248.430020] Subtest basic-pci-d3-state: SUCCESS (1.473s) [248.568850] [124/162] (762s left) kms_pm_rpm (basic-rte) [248.642408] Starting subtest: basic-rte [251.554869] Subtest basic-rte: SUCCESS (2.931s) [253.334493] [125/162] (757s left) kms_psr (psr-primary-page-flip) [253.406429] Starting subtest: psr-primary-page-flip [253.412656] Starting dynamic subtest: eDP-1 [255.380569] Dynamic subtest eDP-1: SUCCESS (1.969s) [255.396976] Subtest psr-primary-page-flip: SUCCESS (1.971s) [256.221609] [126/162] (755s left) kms_psr (psr-cursor-plane-move) [256.312583] Starting subtest: psr-cursor-plane-move [256.329065] Starting dynamic subtest: eDP-1 [258.162649] Dynamic subtest eDP-1: SUCCESS (1.859s) [258.169086] Subtest psr-cursor-plane-move: SUCCESS (1.861s) [259.048048] [127/162] (752s left) kms_psr (psr-sprite-plane-onoff) [259.145182] Starting subtest: psr-sprite-plane-onoff [259.152167] Starting dynamic subtest: eDP-1 [261.146903] Dynamic subtest eDP-1: SUCCESS (2.006s) [261.156173] Subtest psr-sprite-plane-onoff: SUCCESS (2.008s) [262.099873] [128/162] (749s left) kms_psr (psr-primary-mmap-gtt) [262.201527] Starting subtest: psr-primary-mmap-gtt [262.218137] Starting dynamic subtest: eDP-1 [263.795522] Dynamic subtest eDP-1: SKIP (1.576s) [263.817634] Subtest psr-primary-mmap-gtt: SKIP (1.577s) [263.978700] [129/162] (747s left) kms_setmode (basic-clone-single-crtc) [264.067274] Starting subtest: basic-clone-single-crtc [264.102582] Subtest basic-clone-single-crtc: SKIP (0.000s) [264.175736] [130/162] (747s left) i915_pm_rps (basic-api) [264.266703] Starting subtest: basic-api [264.289770] Subtest basic-api: SKIP (0.001s) [264.374706] [131/162] (747s left) prime_self_import (basic-llseek-bad) [264.449017] Starting subtest: basic-llseek-bad [264.472133] Subtest basic-llseek-bad: SUCCESS (0.002s) [264.598161] [132/162] (747s left) prime_self_import (basic-llseek-size) [264.662503] Starting subtest: basic-llseek-size [264.684461] Subtest basic-llseek-size: SUCCESS (0.002s) [264.807113] [133/162] (747s left) prime_self_import (basic-with_fd_dup) [264.863388] Starting subtest: basic-with_fd_dup [264.886370] Subtest basic-with_fd_dup: SUCCESS (0.002s) [265.009954] [134/162] (746s left) prime_self_import (basic-with_one_bo) [265.071787] Starting subtest: basic-with_one_bo [265.093800] Subtest basic-with_one_bo: SUCCESS (0.002s) [265.216807] [135/162] (746s left) prime_self_import (basic-with_one_bo_two_files) [265.283153] Starting subtest: basic-with_one_bo_two_files [265.297987] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s) [265.438471] [136/162] (746s left) prime_self_import (basic-with_two_bos) [265.505418] Starting subtest: basic-with_two_bos [265.528264] Subtest basic-with_two_bos: SUCCESS (0.002s) [265.659718] [137/162] (746s left) prime_vgem (basic-fence-flip) [265.747670] Starting subtest: basic-fence-flip [266.181066] Subtest basic-fence-flip: SUCCESS (0.448s) [266.379341] [138/162] (745s left) prime_vgem (basic-fence-mmap) [266.469879] Starting subtest: basic-fence-mmap [266.483058] Subtest basic-fence-mmap: SKIP (0.000s) [266.606736] [139/162] (745s left) prime_vgem (basic-fence-read) [266.707890] Starting subtest: basic-fence-read [266.729985] Subtest basic-fence-read: SKIP (0.013s) [266.864559] [140/162] (745s left) prime_vgem (basic-gtt) [266.954404] Starting subtest: basic-gtt [266.977280] Subtest basic-gtt: SKIP (0.000s) [267.068597] [141/162] (745s left) prime_vgem (basic-read) [267.180306] Starting subtest: basic-read [267.192986] Subtest basic-read: SKIP (0.011s) [267.330292] [142/162] (745s left) prime_vgem (basic-write) [267.431253] Starting subtest: basic-write [267.453247] Subtest basic-write: SKIP (0.010s) [267.556634] [143/162] (744s left) vgem_basic (setversion) [267.636729] Starting subtest: setversion [267.658848] Subtest setversion: SUCCESS (0.000s) [267.740096] [144/162] (744s left) vgem_basic (create) [267.824076] Starting subtest: create [267.832824] Subtest create: SUCCESS (0.000s) [267.902958] [145/162] (744s left) vgem_basic (debugfs) [267.962559] Starting subtest: debugfs [267.969076] Subtest debugfs: SUCCESS (0.000s) [268.058959] [146/162] (744s left) vgem_basic (dmabuf-export) [268.111967] Starting subtest: dmabuf-export [268.124868] Subtest dmabuf-export: SUCCESS (0.003s) [268.259570] [147/162] (744s left) vgem_basic (dmabuf-fence) [268.325908] Starting subtest: dmabuf-fence [268.332289] Subtest dmabuf-fence: SUCCESS (0.000s) [268.426415] [148/162] (744s left) vgem_basic (dmabuf-fence-before) [268.492964] Starting subtest: dmabuf-fence-before [268.499428] Subtest dmabuf-fence-before: SUCCESS (0.000s) [268.592223] [149/162] (744s left) vgem_basic (dmabuf-mmap) [268.645972] Starting subtest: dmabuf-mmap [268.659677] Subtest dmabuf-mmap: SUCCESS (0.021s) [268.752918] [150/162] (744s left) vgem_basic (mmap) [268.823736] Starting subtest: mmap [268.836955] Subtest mmap: SUCCESS (0.012s) [268.926641] [151/162] (744s left) vgem_basic (second-client) [269.014572] Starting subtest: second-client [269.036353] Subtest second-client: SUCCESS (0.033s) [269.144099] [152/162] (743s left) vgem_basic (sysfs) [269.234210] Starting subtest: sysfs [269.240644] Subtest sysfs: SUCCESS (0.000s) [269.334656] [153/162] (743s left) core_hotunplug (unbind-rebind) [269.454400] Starting subtest: unbind-rebind [275.767816] Subtest unbind-rebind: SUCCESS (6.328s) [275.817862] [154/162] (737s left) vgem_basic (unload) [275.872644] Starting subtest: unload [304.976484] Subtest unload: SUCCESS (29.095s) [305.553337] [155/162] (707s left) i915_module_load (reload) [305.784516] Starting subtest: reload [311.703646] Subtest reload: SUCCESS (5.933s) [311.839480] [156/162] (701s left) gem_lmem_swapping (basic) [311.990475] Subtest basic: SKIP (0.000s) [312.136272] [157/162] (701s left) gem_lmem_swapping (parallel-random-engines) [312.281032] Subtest parallel-random-engines: SKIP (0.000s) [312.416875] [158/162] (701s left) gem_lmem_swapping (random-engines) [312.539098] Subtest random-engines: SKIP (0.000s) [312.655685] [159/162] (701s left) gem_lmem_swapping (verify-random) [312.793220] Subtest verify-random: SKIP (0.000s) [312.922734] [160/162] (701s left) i915_pm_rpm (module-reload) [315.366064] Starting subtest: module-reload [334.189310] Subtest module-reload: SUCCESS (18.824s) [334.251150] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [334.252710] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [334.262665] [161/162] (679s left) i915_selftest (live) [334.364165] Starting subtest: live [334.371962] Starting dynamic subtest: sanitycheck [337.193493] Dynamic subtest sanitycheck: SUCCESS (2.826s) [337.208914] Starting dynamic subtest: uncore [339.922662] Dynamic subtest uncore: SUCCESS (2.731s) [339.940537] Starting dynamic subtest: workarounds [364.453451] Dynamic subtest workarounds: FAIL (22.280s) [364.465695] Starting dynamic subtest: gt_engines [366.817261] Dynamic subtest gt_engines: SUCCESS (4.611s) [366.828231] Starting dynamic subtest: gt_timelines [403.177573] Warning: kernel log ringbuffer underflow, some records lost. [482.164781] Dynamic subtest gt_timelines: FAIL (114.916s) [482.177846] Subtest live: FAIL (147.371s) [482.191857] Killing the test because the kernel is tainted. [482.210826] Aborting: Kernel badly tainted (0x4240, 0x200) (check dmesg for details): TAINT_WARN: WARN_ON has happened. [482.243501] [FACT i915_selftest (live)] new: kernel.is_tainted.taint_warn: true [482.245218] Closing watchdogs