[27.167813] Initializing watchdogs
[27.167870]   /dev/watchdog0
[27.187128] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d67 Intel Meteorlake (Gen12) 
[27.197728] [001/162] (960s left) i915_module_load (load)
[27.242934] Starting subtest: load
[29.977777] Subtest load: SUCCESS (2.731s)
[30.018342] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[30.019592] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[30.026453] [002/162] (957s left) core_auth (basic-auth)
[31.282526] Starting subtest: basic-auth
[31.290821] Subtest basic-auth: SUCCESS (0.002s)
[31.377558] [003/162] (956s left) core_debugfs (read-all-entries)
[31.431046] Starting subtest: read-all-entries
[31.507509] Subtest read-all-entries: SUCCESS (0.075s)
[31.647973] [004/162] (956s left) core_sysfs (read-all-entries)
[31.704382] Starting subtest: read-all-entries
[31.713003] Subtest read-all-entries: SUCCESS (0.003s)
[31.830959] [005/162] (956s left) fbdev (eof)
[31.886907] Starting subtest: eof
[31.892333] Subtest eof: SUCCESS (0.000s)
[31.976873] [006/162] (955s left) fbdev (info)
[32.022109] Starting subtest: info
[32.027499] Subtest info: SUCCESS (0.000s)
[32.092214] [007/162] (955s left) fbdev (nullptr)
[32.136569] Starting subtest: nullptr
[32.141966] Subtest nullptr: SUCCESS (0.000s)
[32.244696] [008/162] (955s left) fbdev (read)
[32.289758] Starting subtest: read
[33.019907] Subtest read: SUCCESS (0.724s)
[33.067515] [009/162] (954s left) fbdev (write)
[33.121534] Starting subtest: write
[33.648957] Subtest write: SUCCESS (0.520s)
[33.721584] [010/162] (954s left) gem_basic (bad-close)
[33.781657] Starting subtest: bad-close
[33.792416] Subtest bad-close: SUCCESS (0.000s)
[33.895021] [011/162] (954s left) gem_basic (create-close)
[33.951103] Starting subtest: create-close
[33.962036] Subtest create-close: SUCCESS (0.000s)
[34.044142] [012/162] (954s left) gem_basic (create-fd-close)
[34.104918] Starting subtest: create-fd-close
[34.115924] Subtest create-fd-close: SUCCESS (0.000s)
[34.228756] [013/162] (954s left) gem_busy (busy@all-engines)
[34.294185] Starting subtest: busy
[34.299625] Starting dynamic subtest: all-engines
[34.326400] Dynamic subtest all-engines: SUCCESS (0.038s)
[34.331679] Subtest busy: SUCCESS (0.038s)
[36.357744] [014/162] (951s left) gem_close_race (basic-process)
[36.434143] Starting subtest: basic-process
[36.479834] Subtest basic-process: SUCCESS (0.044s)
[36.703567] [015/162] (951s left) gem_close_race (basic-threads)
[36.780919] Starting subtest: basic-threads
[38.166450] Subtest basic-threads: SUCCESS (1.384s)
[38.379728] [016/162] (950s left) gem_ctx_create (basic)
[38.459046] Starting subtest: basic
[38.464634] Subtest basic: SUCCESS (0.000s)
[38.648401] [017/162] (949s left) gem_ctx_create (basic-files)
[38.713480] Starting subtest: basic-files
[40.728870] Subtest basic-files: SUCCESS (2.011s)
[42.295926] [018/162] (946s left) gem_ctx_exec (basic)
[42.366886] Starting subtest: basic
[42.372244] Subtest basic: SUCCESS (0.008s)
[42.546664] [019/162] (946s left) gem_exec_basic (basic)
[42.619812] Starting subtest: basic
[42.625114] Starting dynamic subtest: rcs0-smem
[42.630406] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[42.641547] Starting dynamic subtest: bcs0-smem
[42.649139] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[42.662544] Starting dynamic subtest: vcs0-smem
[42.667856] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[42.678638] Starting dynamic subtest: vcs1-smem
[42.687340] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[42.698236] Starting dynamic subtest: vecs0-smem
[42.703651] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[42.714412] Starting dynamic subtest: ccs0-smem
[42.719742] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[42.725285] Subtest basic: SUCCESS (0.014s)
[44.349101] [020/162] (944s left) gem_exec_create (basic)
[44.429966] Starting subtest: basic
[44.435475] Starting dynamic subtest: smem
[48.330764] Dynamic subtest smem: SUCCESS (3.893s)
[48.339368] Subtest basic: SUCCESS (3.894s)
[48.533458] [021/162] (940s left) gem_exec_fence (basic-busy)
[48.728904] Starting subtest: basic-busy
[48.734649] Starting dynamic subtest: rcs0
[48.807347] Dynamic subtest rcs0: SUCCESS (0.086s)
[48.819452] Starting dynamic subtest: bcs0
[48.862603] Dynamic subtest bcs0: SUCCESS (0.056s)
[48.873708] Starting dynamic subtest: vcs0
[48.911673] Dynamic subtest vcs0: SUCCESS (0.050s)
[48.922568] Starting dynamic subtest: vcs1
[48.966579] Dynamic subtest vcs1: SUCCESS (0.054s)
[48.977262] Starting dynamic subtest: vecs0
[49.034083] Dynamic subtest vecs0: SUCCESS (0.064s)
[49.045783] Starting dynamic subtest: ccs0
[49.095759] Dynamic subtest ccs0: SUCCESS (0.064s)
[49.104343] Subtest basic-busy: SUCCESS (0.379s)
[51.336980] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[51.346713] [022/162] (937s left) gem_exec_fence (basic-wait)
[51.534928] Starting subtest: basic-wait
[51.542809] Starting dynamic subtest: rcs0
[51.607753] Dynamic subtest rcs0: SUCCESS (0.076s)
[51.624362] Starting dynamic subtest: bcs0
[51.670505] Dynamic subtest bcs0: SUCCESS (0.060s)
[51.683160] Starting dynamic subtest: vcs0
[51.726499] Dynamic subtest vcs0: SUCCESS (0.054s)
[51.739497] Starting dynamic subtest: vcs1
[51.776021] Dynamic subtest vcs1: SUCCESS (0.048s)
[51.788409] Starting dynamic subtest: vecs0
[51.831156] Dynamic subtest vecs0: SUCCESS (0.054s)
[51.843718] Starting dynamic subtest: ccs0
[51.890869] Dynamic subtest ccs0: SUCCESS (0.059s)
[51.896974] Subtest basic-wait: SUCCESS (0.356s)
[53.311173] [023/162] (935s left) gem_exec_fence (basic-await)
[53.497147] Starting subtest: basic-await
[53.502550] Starting dynamic subtest: rcs0
[53.578307] Dynamic subtest rcs0: SUCCESS (0.083s)
[53.590012] Starting dynamic subtest: bcs0
[53.656167] Dynamic subtest bcs0: SUCCESS (0.077s)
[53.668273] Starting dynamic subtest: vcs0
[53.734379] Dynamic subtest vcs0: SUCCESS (0.077s)
[53.745977] Starting dynamic subtest: vcs1
[53.813083] Dynamic subtest vcs1: SUCCESS (0.076s)
[53.824871] Starting dynamic subtest: vecs0
[53.886166] Dynamic subtest vecs0: SUCCESS (0.074s)
[53.897664] Starting dynamic subtest: ccs0
[53.962898] Dynamic subtest ccs0: SUCCESS (0.076s)
[53.968570] Subtest basic-await: SUCCESS (0.468s)
[55.317535] [024/162] (933s left) gem_exec_fence (nb-await)
[55.496921] Starting subtest: nb-await
[55.502863] Starting dynamic subtest: rcs0
[55.563540] Dynamic subtest rcs0: SUCCESS (0.067s)
[55.575908] Starting dynamic subtest: bcs0
[55.622342] Dynamic subtest bcs0: SUCCESS (0.060s)
[55.634612] Starting dynamic subtest: vcs0
[55.683209] Dynamic subtest vcs0: SUCCESS (0.060s)
[55.695132] Starting dynamic subtest: vcs1
[55.742185] Dynamic subtest vcs1: SUCCESS (0.058s)
[55.753957] Starting dynamic subtest: vecs0
[55.803561] Dynamic subtest vecs0: SUCCESS (0.059s)
[55.815211] Starting dynamic subtest: ccs0
[55.863180] Dynamic subtest ccs0: SUCCESS (0.057s)
[55.869175] Subtest nb-await: SUCCESS (0.367s)
[57.290661] [025/162] (931s left) gem_exec_gttfill (basic)
[57.361964] Starting subtest: basic
[59.711584] Subtest basic: SUCCESS (2.344s)
[59.913874] [026/162] (928s left) gem_exec_parallel (engines)
[60.002977] Starting subtest: engines
[60.008396] Starting dynamic subtest: basic
[63.310076] Dynamic subtest basic: SUCCESS (3.291s)
[63.321372] Starting dynamic subtest: contexts
[65.642716] Dynamic subtest contexts: SUCCESS (2.333s)
[65.656692] Starting dynamic subtest: fds
[67.637641] Dynamic subtest fds: SUCCESS (1.990s)
[67.648266] Starting dynamic subtest: userptr
[69.324113] Dynamic subtest userptr: SUCCESS (1.685s)
[69.329895] Subtest engines: SUCCESS (9.301s)
[69.509126] [027/162] (919s left) gem_exec_store (basic)
[69.589625] Starting subtest: basic
[69.673379] Subtest basic: SUCCESS (0.096s)
[69.873539] [028/162] (919s left) gem_flink_basic (bad-flink)
[69.931251] Starting subtest: bad-flink
[69.936746] Subtest bad-flink: SUCCESS (0.000s)
[70.032512] [029/162] (918s left) gem_flink_basic (bad-open)
[70.086011] Starting subtest: bad-open
[70.091537] Subtest bad-open: SUCCESS (0.000s)
[70.204713] [030/162] (918s left) gem_flink_basic (basic)
[70.269808] Starting subtest: basic
[70.275327] Subtest basic: SUCCESS (0.000s)
[70.391878] [031/162] (918s left) gem_flink_basic (double-flink)
[70.457790] Starting subtest: double-flink
[70.463204] Subtest double-flink: SUCCESS (0.000s)
[70.573099] [032/162] (918s left) gem_flink_basic (flink-lifetime)
[70.630373] Starting subtest: flink-lifetime
[70.635796] Subtest flink-lifetime: SUCCESS (0.002s)
[70.757795] [033/162] (918s left) gem_huc_copy (huc-copy)
[70.819685] Starting subtest: huc-copy
[70.824961] Subtest huc-copy: SUCCESS (0.003s)
[70.940493] [034/162] (918s left) gem_linear_blits (basic)
[71.116066] Starting subtest: basic
[71.126972] Subtest basic: SUCCESS (0.006s)
[71.248969] [035/162] (918s left) gem_mmap (basic)
[71.336488] Subtest basic: SKIP (0.000s)
[71.391807] [036/162] (917s left) gem_mmap_gtt (basic)
[71.454349] Subtest basic: SKIP (0.000s)
[71.522947] [037/162] (917s left) gem_render_linear_blits (basic)
[71.586814] Starting subtest: basic
[71.619321] Subtest basic: SUCCESS (0.030s)
[71.698194] [038/162] (917s left) gem_render_tiled_blits (basic)
[71.769068] Subtest basic: SKIP (0.000s)
[71.823849] [039/162] (917s left) gem_ringfill (basic-all)
[77.263458] Starting subtest: basic-all
[78.411717] Subtest basic-all: SUCCESS (1.152s)
[78.511241] [040/162] (911s left) gem_softpin (allocator-basic)
[78.575218] Starting subtest: allocator-basic
[78.654967] Subtest allocator-basic: SUCCESS (0.084s)
[78.766439] [041/162] (910s left) gem_softpin (allocator-basic-reserve)
[78.828281] Starting subtest: allocator-basic-reserve
[78.908122] Subtest allocator-basic-reserve: SUCCESS (0.080s)
[79.034298] [042/162] (910s left) gem_softpin (safe-alignment)
[79.095903] Starting subtest: safe-alignment
[79.117299] Subtest safe-alignment: SUCCESS (0.024s)
[80.332987] [043/162] (909s left) gem_sync (basic-all)
[80.436778] Starting subtest: basic-all
[84.299958] Subtest basic-all: SUCCESS (3.888s)
[84.496847] [044/162] (905s left) gem_sync (basic-each)
[84.594655] Starting subtest: basic-each
[86.880874] Subtest basic-each: SUCCESS (2.317s)
[87.082702] [045/162] (902s left) gem_tiled_blits (basic)
[87.149189] Subtest basic: SKIP (0.000s)
[87.214887] [046/162] (902s left) gem_tiled_fence_blits (basic)
[87.273910] Subtest basic: SKIP (0.000s)
[87.339508] [047/162] (902s left) gem_tiled_pread_basic (basic)
[87.398838] Subtest basic: SKIP (0.000s)
[87.462495] [048/162] (902s left) gem_wait (busy@all-engines)
[87.541398] Starting subtest: busy
[87.546891] Starting dynamic subtest: all-engines
[89.224786] Dynamic subtest all-engines: SUCCESS (1.680s)
[89.230801] Subtest busy: SUCCESS (1.681s)
[89.421590] [049/162] (900s left) gem_wait (wait@all-engines)
[89.487644] Starting subtest: wait
[89.493258] Starting dynamic subtest: all-engines
[91.272227] Dynamic subtest all-engines: SUCCESS (1.776s)
[91.278155] Subtest wait: SUCCESS (1.777s)
[91.499273] [050/162] (898s left) i915_getparams_basic (basic-eu-total)
[91.560204] Starting subtest: basic-eu-total
[91.571457] Subtest basic-eu-total: SUCCESS (0.000s)
[91.665342] [051/162] (898s left) i915_getparams_basic (basic-subslice-total)
[91.726069] Starting subtest: basic-subslice-total
[91.737359] Subtest basic-subslice-total: SUCCESS (0.000s)
[91.830629] [052/162] (898s left) i915_hangman (error-state-basic)
[91.895816] Starting subtest: error-state-basic
[92.008727] Subtest error-state-basic: SUCCESS (0.110s)
[92.084566] [053/162] (898s left) i915_pciid
[92.264490] [054/162] (897s left) intel_hwmon (hwmon-read)
[92.333532] Subtest hwmon-read: SKIP (0.000s)
[92.399010] [055/162] (897s left) intel_hwmon (hwmon-write)
[92.466621] Subtest hwmon-write: SKIP (0.000s)
[92.533411] [056/162] (897s left) kms_addfb_basic (addfb25-4-tiled)
[92.649845] Starting subtest: addfb25-4-tiled
[92.655233] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[92.788553] [057/162] (897s left) kms_addfb_basic (addfb25-bad-modifier)
[92.902843] Starting subtest: addfb25-bad-modifier
[92.908567] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[92.997069] [058/162] (897s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[93.117070] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[93.216391] [059/162] (897s left) kms_addfb_basic (addfb25-modifier-no-flag)
[93.332717] Starting subtest: addfb25-modifier-no-flag
[93.338209] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[93.431252] [060/162] (897s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[93.546824] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[93.648540] [061/162] (896s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[93.767605] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[93.886130] [062/162] (896s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[94.009142] Starting subtest: addfb25-yf-tiled-legacy
[94.015161] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[94.114204] [063/162] (896s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[94.233875] Starting subtest: addfb25-y-tiled-legacy
[94.239274] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[94.343770] [064/162] (896s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[94.463986] Starting subtest: addfb25-y-tiled-small-legacy
[94.477819] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[94.560490] [065/162] (896s left) kms_addfb_basic (bad-pitch-0)
[94.628399] Starting subtest: bad-pitch-0
[94.633833] Subtest bad-pitch-0: SUCCESS (0.000s)
[94.774272] [066/162] (896s left) kms_addfb_basic (bad-pitch-1024)
[94.838402] Starting subtest: bad-pitch-1024
[94.843796] Subtest bad-pitch-1024: SUCCESS (0.000s)
[94.996600] [067/162] (895s left) kms_addfb_basic (bad-pitch-128)
[95.056577] Starting subtest: bad-pitch-128
[95.062059] Subtest bad-pitch-128: SUCCESS (0.000s)
[95.202657] [068/162] (895s left) kms_addfb_basic (bad-pitch-256)
[95.257230] Starting subtest: bad-pitch-256
[95.262647] Subtest bad-pitch-256: SUCCESS (0.000s)
[95.413778] [069/162] (895s left) kms_addfb_basic (bad-pitch-32)
[95.472246] Starting subtest: bad-pitch-32
[95.477652] Subtest bad-pitch-32: SUCCESS (0.000s)
[95.619211] [070/162] (895s left) kms_addfb_basic (bad-pitch-63)
[95.674167] Starting subtest: bad-pitch-63
[95.679455] Subtest bad-pitch-63: SUCCESS (0.000s)
[95.831068] [071/162] (895s left) kms_addfb_basic (bad-pitch-65536)
[95.888773] Starting subtest: bad-pitch-65536
[95.894178] Subtest bad-pitch-65536: SUCCESS (0.000s)
[96.037043] [072/162] (895s left) kms_addfb_basic (bad-pitch-999)
[96.097680] Starting subtest: bad-pitch-999
[96.102986] Subtest bad-pitch-999: SUCCESS (0.000s)
[96.265067] [073/162] (894s left) kms_addfb_basic (basic)
[96.331851] Starting subtest: basic
[96.340831] Subtest basic: SUCCESS (0.000s)
[96.477201] [074/162] (894s left) kms_addfb_basic (basic-x-tiled-legacy)
[96.537320] Starting subtest: basic-x-tiled-legacy
[96.547934] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[96.698028] [075/162] (894s left) kms_addfb_basic (basic-y-tiled-legacy)
[96.753150] Starting subtest: basic-y-tiled-legacy
[96.763850] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[96.901562] [076/162] (894s left) kms_addfb_basic (bo-too-small)
[97.022558] Starting subtest: bo-too-small
[97.028110] Subtest bo-too-small: SUCCESS (0.000s)
[97.137130] [077/162] (894s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[97.252821] Starting subtest: bo-too-small-due-to-tiling
[97.263703] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[97.343020] [078/162] (893s left) kms_addfb_basic (clobberred-modifier)
[97.406741] Starting subtest: clobberred-modifier
[97.417484] Subtest clobberred-modifier: SKIP (0.000s)
[97.563721] [079/162] (893s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[97.624244] Starting subtest: framebuffer-vs-set-tiling
[97.635111] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[97.781522] [080/162] (893s left) kms_addfb_basic (invalid-get-prop)
[97.843983] Starting subtest: invalid-get-prop
[97.849422] Subtest invalid-get-prop: SUCCESS (0.000s)
[97.997110] [081/162] (893s left) kms_addfb_basic (invalid-get-prop-any)
[98.054315] Starting subtest: invalid-get-prop-any
[98.059995] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[98.185640] [082/162] (893s left) kms_addfb_basic (invalid-set-prop)
[98.242662] Starting subtest: invalid-set-prop
[98.248159] Subtest invalid-set-prop: SUCCESS (0.000s)
[98.401879] [083/162] (893s left) kms_addfb_basic (invalid-set-prop-any)
[98.452173] Starting subtest: invalid-set-prop-any
[98.459969] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[98.604068] [084/162] (892s left) kms_addfb_basic (no-handle)
[98.666569] Starting subtest: no-handle
[98.671947] Subtest no-handle: SUCCESS (0.000s)
[98.808323] [085/162] (892s left) kms_addfb_basic (size-max)
[98.930969] Starting subtest: size-max
[98.939052] Subtest size-max: SUCCESS (0.000s)
[99.043998] [086/162] (892s left) kms_addfb_basic (small-bo)
[99.162384] Starting subtest: small-bo
[99.167875] Subtest small-bo: SUCCESS (0.000s)
[99.264390] [087/162] (892s left) kms_addfb_basic (tile-pitch-mismatch)
[99.321677] Starting subtest: tile-pitch-mismatch
[99.332406] Subtest tile-pitch-mismatch: SKIP (0.000s)
[99.473595] [088/162] (892s left) kms_addfb_basic (too-high)
[99.590807] Starting subtest: too-high
[99.596198] Subtest too-high: SUCCESS (0.001s)
[99.708582] [089/162] (892s left) kms_addfb_basic (too-wide)
[99.821949] Starting subtest: too-wide
[99.827627] Subtest too-wide: SUCCESS (0.000s)
[99.936948] [090/162] (891s left) kms_addfb_basic (unused-handle)
[99.994932] Starting subtest: unused-handle
[100.000302] Subtest unused-handle: SUCCESS (0.000s)
[100.148069] [091/162] (891s left) kms_addfb_basic (unused-modifier)
[100.205050] Starting subtest: unused-modifier
[100.210530] Subtest unused-modifier: SUCCESS (0.000s)
[100.357301] [092/162] (891s left) kms_addfb_basic (unused-offsets)
[100.417315] Starting subtest: unused-offsets
[100.422749] Subtest unused-offsets: SUCCESS (0.000s)
[100.581433] [093/162] (891s left) kms_addfb_basic (unused-pitches)
[100.641250] Starting subtest: unused-pitches
[100.646833] Subtest unused-pitches: SUCCESS (0.000s)
[100.768921] [094/162] (891s left) kms_busy (basic)
[100.887148] Starting subtest: basic
[100.892469] Starting dynamic subtest: flip
[101.555336] Dynamic subtest flip: SUCCESS (0.670s)
[101.568049] Starting dynamic subtest: modeset
[102.407179] Dynamic subtest modeset: SUCCESS (0.852s)
[102.412483] Subtest basic: SUCCESS (1.523s)
[102.609945] [095/162] (889s left) kms_prop_blob (basic)
[102.679917] Starting subtest: basic
[102.685425] Subtest basic: SUCCESS (0.000s)
[102.795095] [096/162] (889s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[102.909384] Starting subtest: basic-busy-flip-before-cursor-atomic
[102.920145] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[102.998262] [097/162] (889s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[103.109683] Starting subtest: basic-busy-flip-before-cursor-legacy
[103.120559] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[103.193233] [098/162] (889s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[103.299669] Starting subtest: basic-flip-after-cursor-atomic
[104.314270] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.014s)
[104.489278] [099/162] (887s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[104.597959] Starting subtest: basic-flip-after-cursor-legacy
[105.601440] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.004s)
[105.792959] [100/162] (886s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[105.912952] Starting subtest: basic-flip-after-cursor-varying-size
[106.916121] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.004s)
[107.108334] [101/162] (885s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[107.219892] Starting subtest: basic-flip-before-cursor-atomic
[108.212534] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.993s)
[108.410582] [102/162] (884s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[108.525921] Starting subtest: basic-flip-before-cursor-legacy
[109.507191] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.982s)
[109.690951] [103/162] (882s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[109.802257] Starting subtest: basic-flip-before-cursor-varying-size
[110.825707] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.027s)
[111.019031] [104/162] (881s left) kms_dsc (dsc-basic)
[111.136961] Starting subtest: dsc-basic
[111.169317] Subtest dsc-basic: SKIP (0.000s)
[111.222280] [105/162] (881s left) kms_flip (basic-flip-vs-dpms)
[111.335506] Starting subtest: basic-flip-vs-dpms
[111.340877] Starting dynamic subtest: A-HDMI-A2
[112.157703] Dynamic subtest A-HDMI-A2: SUCCESS (0.820s)
[112.173619] Starting dynamic subtest: B-HDMI-A2
[112.911276] Dynamic subtest B-HDMI-A2: SUCCESS (0.758s)
[112.922102] Starting dynamic subtest: C-HDMI-A2
[113.741306] Dynamic subtest C-HDMI-A2: SUCCESS (0.829s)
[113.752429] Starting dynamic subtest: D-HDMI-A2
[114.577464] Dynamic subtest D-HDMI-A2: SUCCESS (0.835s)
[114.582970] Subtest basic-flip-vs-dpms: SUCCESS (3.247s)
[114.772040] [106/162] (877s left) kms_flip (basic-flip-vs-modeset)
[114.892050] Starting subtest: basic-flip-vs-modeset
[114.897695] Starting dynamic subtest: A-HDMI-A2
[115.736088] Dynamic subtest A-HDMI-A2: SUCCESS (0.846s)
[115.748985] Starting dynamic subtest: B-HDMI-A2
[116.508122] Dynamic subtest B-HDMI-A2: SUCCESS (0.771s)
[116.520810] Starting dynamic subtest: C-HDMI-A2
[117.215201] Dynamic subtest C-HDMI-A2: SUCCESS (0.706s)
[117.227925] Starting dynamic subtest: D-HDMI-A2
[117.928587] Dynamic subtest D-HDMI-A2: SUCCESS (0.713s)
[117.934104] Subtest basic-flip-vs-modeset: SUCCESS (3.042s)
[118.117608] [107/162] (874s left) kms_flip (basic-flip-vs-wf_vblank)
[118.240946] Starting subtest: basic-flip-vs-wf_vblank
[118.246354] Starting dynamic subtest: A-HDMI-A2
[119.317320] Dynamic subtest A-HDMI-A2: SUCCESS (1.082s)
[119.330923] Starting dynamic subtest: B-HDMI-A2
[120.555134] Dynamic subtest B-HDMI-A2: SUCCESS (1.235s)
[120.569140] Starting dynamic subtest: C-HDMI-A2
[121.778287] Dynamic subtest C-HDMI-A2: SUCCESS (1.216s)
[121.792104] Starting dynamic subtest: D-HDMI-A2
[122.830135] Dynamic subtest D-HDMI-A2: SUCCESS (1.051s)
[122.835626] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.596s)
[123.081717] [108/162] (869s left) kms_flip (basic-plain-flip)
[123.197739] Starting subtest: basic-plain-flip
[123.203276] Starting dynamic subtest: A-HDMI-A2
[123.987165] Dynamic subtest A-HDMI-A2: SUCCESS (0.794s)
[123.998374] Starting dynamic subtest: B-HDMI-A2
[124.756148] Dynamic subtest B-HDMI-A2: SUCCESS (0.766s)
[124.767259] Starting dynamic subtest: C-HDMI-A2
[125.530523] Dynamic subtest C-HDMI-A2: SUCCESS (0.767s)
[125.541508] Starting dynamic subtest: D-HDMI-A2
[126.299143] Dynamic subtest D-HDMI-A2: SUCCESS (0.767s)
[126.305040] Subtest basic-plain-flip: SUCCESS (3.104s)
[126.536728] [109/162] (866s left) kms_force_connector_basic (force-connector-state)
[126.676813] Starting subtest: force-connector-state
[126.930730] Subtest force-connector-state: SUCCESS (0.252s)
[127.231097] [110/162] (865s left) kms_force_connector_basic (force-edid)
[127.354567] Starting subtest: force-edid
[127.389243] Subtest force-edid: SUCCESS (0.032s)
[127.630830] [111/162] (865s left) kms_force_connector_basic (force-load-detect)
[127.754206] Starting subtest: force-load-detect
[127.765021] Subtest force-load-detect: SKIP (0.000s)
[127.947888] [112/162] (864s left) kms_force_connector_basic (prune-stale-modes)
[128.063038] Starting subtest: prune-stale-modes
[128.097743] Subtest prune-stale-modes: SUCCESS (0.033s)
[128.317659] [113/162] (864s left) kms_frontbuffer_tracking (basic)
[128.450463] Starting subtest: basic
[131.951279] Subtest basic: SUCCESS (3.517s)
[132.089794] [114/162] (860s left) kms_hdmi_inject (inject-audio)
[132.232708] Starting subtest: inject-audio
[132.382154] Subtest inject-audio: SUCCESS (0.149s)
[132.659032] [115/162] (860s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[132.780991] Starting subtest: compare-crc-sanitycheck-xr24
[132.786299] Starting dynamic subtest: pipe-A-HDMI-A-2
[133.251980] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.471s)
[133.265407] Starting dynamic subtest: pipe-B-HDMI-A-2
[133.721143] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.467s)
[133.736186] Starting dynamic subtest: pipe-C-HDMI-A-2
[134.172169] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.451s)
[134.185580] Starting dynamic subtest: pipe-D-HDMI-A-2
[134.619677] Dynamic subtest pipe-D-HDMI-A-2: SUCCESS (0.437s)
[134.627369] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.833s)
[134.802057] [116/162] (858s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[134.919600] Starting subtest: compare-crc-sanitycheck-nv12
[134.925096] Starting dynamic subtest: pipe-A-HDMI-A-2
[135.471810] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.547s)
[135.485145] Starting dynamic subtest: pipe-B-HDMI-A-2
[135.994614] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.522s)
[136.009407] Starting dynamic subtest: pipe-C-HDMI-A-2
[136.475465] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.481s)
[136.490473] Starting dynamic subtest: pipe-D-HDMI-A-2
[136.965087] Dynamic subtest pipe-D-HDMI-A-2: SUCCESS (0.486s)
[136.970571] Subtest compare-crc-sanitycheck-nv12: SUCCESS (2.042s)
[137.150894] [117/162] (856s left) kms_pipe_crc_basic (hang-read-crc)
[137.271208] Starting subtest: hang-read-crc
[137.279112] Starting dynamic subtest: pipe-A-HDMI-A-2
[138.605362] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.334s)
[138.620972] Starting dynamic subtest: pipe-B-HDMI-A-2
[139.892386] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.284s)
[139.908020] Starting dynamic subtest: pipe-C-HDMI-A-2
[141.113598] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.222s)
[141.128906] Starting dynamic subtest: pipe-D-HDMI-A-2
[142.335696] Dynamic subtest pipe-D-HDMI-A-2: SUCCESS (1.221s)
[142.341308] Subtest hang-read-crc: SUCCESS (5.065s)
[142.526060] [118/162] (850s left) kms_pipe_crc_basic (nonblocking-crc)
[142.638423] Starting subtest: nonblocking-crc
[142.643793] Starting dynamic subtest: pipe-A-HDMI-A-2
[143.299829] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.661s)
[143.313266] Starting dynamic subtest: pipe-B-HDMI-A-2
[143.958544] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.653s)
[143.971738] Starting dynamic subtest: pipe-C-HDMI-A-2
[144.579880] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.623s)
[144.593066] Starting dynamic subtest: pipe-D-HDMI-A-2
[145.189755] Dynamic subtest pipe-D-HDMI-A-2: SUCCESS (0.608s)
[145.195136] Subtest nonblocking-crc: SUCCESS (2.553s)
[145.388387] [119/162] (847s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[145.512817] Starting subtest: nonblocking-crc-frame-sequence
[145.518136] Starting dynamic subtest: pipe-A-HDMI-A-2
[146.170179] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.661s)
[146.183014] Starting dynamic subtest: pipe-B-HDMI-A-2
[146.822764] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.652s)
[146.835575] Starting dynamic subtest: pipe-C-HDMI-A-2
[147.429108] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.605s)
[147.445237] Starting dynamic subtest: pipe-D-HDMI-A-2
[148.041128] Dynamic subtest pipe-D-HDMI-A-2: SUCCESS (0.609s)
[148.046487] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.534s)
[148.234597] [120/162] (845s left) kms_pipe_crc_basic (read-crc)
[148.358865] Starting subtest: read-crc
[148.364966] Starting dynamic subtest: pipe-A-HDMI-A-2
[148.966389] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.606s)
[148.979195] Starting dynamic subtest: pipe-B-HDMI-A-2
[149.547974] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.586s)
[149.560882] Starting dynamic subtest: pipe-C-HDMI-A-2
[150.111986] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.555s)
[150.124964] Starting dynamic subtest: pipe-D-HDMI-A-2
[150.634973] Dynamic subtest pipe-D-HDMI-A-2: SUCCESS (0.525s)
[150.643207] Subtest read-crc: SUCCESS (2.279s)
[150.841078] [121/162] (842s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[150.953384] Starting subtest: read-crc-frame-sequence
[150.958809] Starting dynamic subtest: pipe-A-HDMI-A-2
[151.546789] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.595s)
[151.559637] Starting dynamic subtest: pipe-B-HDMI-A-2
[152.139253] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.585s)
[152.152049] Starting dynamic subtest: pipe-C-HDMI-A-2
[152.661023] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.523s)
[152.673883] Starting dynamic subtest: pipe-D-HDMI-A-2
[153.204929] Dynamic subtest pipe-D-HDMI-A-2: SUCCESS (0.542s)
[153.213732] Subtest read-crc-frame-sequence: SUCCESS (2.253s)
[153.407607] [122/162] (840s left) kms_pm_backlight (basic-brightness)
[153.553555] Subtest basic-brightness: SKIP (0.000s)
[153.604983] [123/162] (839s left) kms_pm_rpm (basic-pci-d3-state)
[155.460855] Starting subtest: basic-pci-d3-state
[156.773057] Subtest basic-pci-d3-state: SUCCESS (1.307s)
[156.920651] [124/162] (836s left) kms_pm_rpm (basic-rte)
[156.971086] Starting subtest: basic-rte
[159.659881] Subtest basic-rte: SUCCESS (2.694s)
[161.063734] [125/162] (832s left) kms_psr (psr-primary-page-flip)
[161.183510] Subtest psr-primary-page-flip: SKIP (0.000s)
[161.239494] [126/162] (832s left) kms_psr (psr-cursor-plane-move)
[161.366198] Subtest psr-cursor-plane-move: SKIP (0.000s)
[161.422469] [127/162] (832s left) kms_psr (psr-sprite-plane-onoff)
[161.542425] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[161.590315] [128/162] (832s left) kms_psr (psr-primary-mmap-gtt)
[161.706408] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[161.761509] [129/162] (832s left) kms_setmode (basic-clone-single-crtc)
[161.818713] Starting subtest: basic-clone-single-crtc
[161.834816] Subtest basic-clone-single-crtc: SKIP (0.000s)
[161.919702] [130/162] (831s left) i915_pm_rps (basic-api)
[161.978594] Starting subtest: basic-api
[161.989342] Subtest basic-api: SKIP (0.001s)
[162.079200] [131/162] (831s left) prime_self_import (basic-llseek-bad)
[162.133522] Starting subtest: basic-llseek-bad
[162.144346] Subtest basic-llseek-bad: SUCCESS (0.016s)
[162.253303] [132/162] (831s left) prime_self_import (basic-llseek-size)
[162.305353] Starting subtest: basic-llseek-size
[162.316219] Subtest basic-llseek-size: SUCCESS (0.012s)
[162.395719] [133/162] (831s left) prime_self_import (basic-with_fd_dup)
[162.444550] Starting subtest: basic-with_fd_dup
[162.455329] Subtest basic-with_fd_dup: SUCCESS (0.015s)
[162.569687] [134/162] (831s left) prime_self_import (basic-with_one_bo)
[162.621938] Starting subtest: basic-with_one_bo
[162.632858] Subtest basic-with_one_bo: SUCCESS (0.013s)
[162.770866] [135/162] (831s left) prime_self_import (basic-with_one_bo_two_files)
[162.813585] Starting subtest: basic-with_one_bo_two_files
[162.824848] Subtest basic-with_one_bo_two_files: SUCCESS (0.014s)
[162.911174] [136/162] (831s left) prime_self_import (basic-with_two_bos)
[162.965358] Starting subtest: basic-with_two_bos
[162.976227] Subtest basic-with_two_bos: SUCCESS (0.021s)
[163.086740] [137/162] (831s left) prime_vgem (basic-fence-flip)
[163.163419] Starting subtest: basic-fence-flip
[163.623895] Subtest basic-fence-flip: SUCCESS (0.466s)
[163.747403] [138/162] (830s left) prime_vgem (basic-fence-mmap)
[163.834383] Starting subtest: basic-fence-mmap
[163.845166] Subtest basic-fence-mmap: SKIP (0.000s)
[163.943205] [139/162] (830s left) prime_vgem (basic-fence-read)
[164.019270] Starting subtest: basic-fence-read
[164.042766] Subtest basic-fence-read: SKIP (0.014s)
[164.158505] [140/162] (830s left) prime_vgem (basic-gtt)
[164.226666] Starting subtest: basic-gtt
[164.237489] Subtest basic-gtt: SKIP (0.000s)
[164.344161] [141/162] (830s left) prime_vgem (basic-read)
[164.412461] Starting subtest: basic-read
[164.431594] Subtest basic-read: SKIP (0.011s)
[164.538883] [142/162] (829s left) prime_vgem (basic-write)
[164.614283] Starting subtest: basic-write
[164.636700] Subtest basic-write: SKIP (0.011s)
[164.740761] [143/162] (829s left) vgem_basic (setversion)
[164.800335] Starting subtest: setversion
[164.811163] Subtest setversion: SUCCESS (0.000s)
[164.867885] [144/162] (829s left) vgem_basic (create)
[164.932750] Starting subtest: create
[164.938268] Subtest create: SUCCESS (0.000s)
[165.002807] [145/162] (829s left) vgem_basic (debugfs)
[165.068016] Starting subtest: debugfs
[165.073663] Subtest debugfs: SUCCESS (0.000s)
[165.130472] [146/162] (829s left) vgem_basic (dmabuf-export)
[165.198881] Starting subtest: dmabuf-export
[165.223874] Subtest dmabuf-export: SUCCESS (0.030s)
[165.337874] [147/162] (829s left) vgem_basic (dmabuf-fence)
[165.400567] Starting subtest: dmabuf-fence
[165.408564] Subtest dmabuf-fence: SUCCESS (0.000s)
[165.468878] [148/162] (829s left) vgem_basic (dmabuf-fence-before)
[165.532903] Starting subtest: dmabuf-fence-before
[165.538457] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[165.602960] [149/162] (829s left) vgem_basic (dmabuf-mmap)
[165.667374] Starting subtest: dmabuf-mmap
[165.678443] Subtest dmabuf-mmap: SUCCESS (0.018s)
[165.757139] [150/162] (829s left) vgem_basic (mmap)
[165.821744] Starting subtest: mmap
[165.827162] Subtest mmap: SUCCESS (0.011s)
[165.888826] [151/162] (828s left) vgem_basic (second-client)
[165.947202] Starting subtest: second-client
[165.987039] Subtest second-client: SUCCESS (0.033s)
[166.057232] [152/162] (828s left) vgem_basic (sysfs)
[166.124871] Starting subtest: sysfs
[166.130360] Subtest sysfs: SUCCESS (0.000s)
[166.182481] [153/162] (828s left) core_hotunplug (unbind-rebind)
[166.281779] Starting subtest: unbind-rebind
[171.075038] Subtest unbind-rebind: SUCCESS (4.799s)
[171.118736] [154/162] (823s left) vgem_basic (unload)
[171.175145] Starting subtest: unload
[200.175066] Subtest unload: SUCCESS (29.000s)
[200.287107] [155/162] (794s left) i915_module_load (reload)
[200.349067] Starting subtest: reload
[203.813848] Subtest reload: SUCCESS (3.472s)
[203.866730] [156/162] (791s left) gem_lmem_swapping (basic)
[203.940575] Subtest basic: SKIP (0.000s)
[204.000792] [157/162] (791s left) gem_lmem_swapping (parallel-random-engines)
[204.054850] Subtest parallel-random-engines: SKIP (0.000s)
[204.114483] [158/162] (791s left) gem_lmem_swapping (random-engines)
[204.179488] Subtest random-engines: SKIP (0.000s)
[204.231668] [159/162] (791s left) gem_lmem_swapping (verify-random)
[204.289957] Subtest verify-random: SKIP (0.000s)
[204.343854] [160/162] (790s left) i915_pm_rpm (module-reload)
[215.855559] Starting subtest: module-reload
[249.665192] Subtest module-reload: SUCCESS (33.803s)
[249.697383] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[249.698019] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[249.704641] [161/162] (745s left) i915_selftest (live)