[39.053049] Initializing watchdogs
[39.053102]   /dev/watchdog0
[39.068475] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d51 Intel Meteorlake (Gen12) 
[39.083906] [001/162] (960s left) i915_module_load (load)
[39.157587] Starting subtest: load
[42.237184] Subtest load: SUCCESS (3.093s)
[42.291555] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[42.292856] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[42.303750] [002/162] (957s left) core_auth (basic-auth)
[43.854871] Starting subtest: basic-auth
[43.861432] Subtest basic-auth: SUCCESS (0.001s)
[43.964628] [003/162] (955s left) core_debugfs (read-all-entries)
[44.038728] Starting subtest: read-all-entries
[44.166044] Subtest read-all-entries: SUCCESS (0.133s)
[44.275440] [004/162] (955s left) core_sysfs (read-all-entries)
[44.354683] Starting subtest: read-all-entries
[44.363513] Subtest read-all-entries: SUCCESS (0.004s)
[44.463820] [005/162] (955s left) fbdev (eof)
[44.521191] Starting subtest: eof
[44.529966] Subtest eof: SUCCESS (0.000s)
[44.646676] [006/162] (955s left) fbdev (info)
[44.708386] Starting subtest: info
[44.715103] Subtest info: SUCCESS (0.000s)
[44.835612] [007/162] (955s left) fbdev (nullptr)
[44.908992] Starting subtest: nullptr
[44.915751] Subtest nullptr: SUCCESS (0.000s)
[45.092021] [008/162] (954s left) fbdev (read)
[45.178746] Starting subtest: read
[46.190266] Subtest read: SUCCESS (1.037s)
[46.307840] [009/162] (953s left) fbdev (write)
[46.379751] Starting subtest: write
[47.033916] Subtest write: SUCCESS (0.671s)
[47.160929] [010/162] (953s left) gem_basic (bad-close)
[47.237175] Starting subtest: bad-close
[47.259522] Subtest bad-close: SUCCESS (0.000s)
[47.338607] [011/162] (952s left) gem_basic (create-close)
[47.409816] Starting subtest: create-close
[47.431848] Subtest create-close: SUCCESS (0.000s)
[47.532813] [012/162] (952s left) gem_basic (create-fd-close)
[47.614807] Starting subtest: create-fd-close
[47.636958] Subtest create-fd-close: SUCCESS (0.000s)
[47.713028] [013/162] (952s left) gem_busy (busy@all-engines)
[47.769970] Starting subtest: busy
[47.776132] Starting dynamic subtest: all-engines
[47.806751] Dynamic subtest all-engines: SUCCESS (0.043s)
[47.812780] Subtest busy: SUCCESS (0.043s)
[49.925595] [014/162] (950s left) gem_close_race (basic-process)
[50.011771] Starting subtest: basic-process
[50.096562] Subtest basic-process: SUCCESS (0.090s)
[50.337131] [015/162] (950s left) gem_close_race (basic-threads)
[50.405602] Starting subtest: basic-threads
[51.736466] Subtest basic-threads: SUCCESS (1.362s)
[51.962852] [016/162] (948s left) gem_ctx_create (basic)
[52.016877] Starting subtest: basic
[52.023238] Subtest basic: SUCCESS (0.000s)
[52.226939] [017/162] (948s left) gem_ctx_create (basic-files)
[52.285918] Starting subtest: basic-files
[54.529454] Subtest basic-files: SUCCESS (2.276s)
[55.937734] [018/162] (944s left) gem_ctx_exec (basic)
[55.999291] Starting subtest: basic
[56.005435] Subtest basic: SUCCESS (0.007s)
[56.164154] [019/162] (944s left) gem_exec_basic (basic)
[56.217133] Starting subtest: basic
[56.223360] Starting dynamic subtest: rcs0-smem
[56.229515] Dynamic subtest rcs0-smem: SUCCESS (0.004s)
[56.240500] Starting dynamic subtest: bcs0-smem
[56.246606] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[56.257505] Starting dynamic subtest: vcs0-smem
[56.263594] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[56.274504] Starting dynamic subtest: vcs1-smem
[56.280645] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[56.291393] Starting dynamic subtest: vecs0-smem
[56.297430] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[56.308111] Starting dynamic subtest: ccs0-smem
[56.314269] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[56.320295] Subtest basic: SUCCESS (0.016s)
[57.884269] [020/162] (942s left) gem_exec_create (basic)
[57.939538] Starting subtest: basic
[57.946056] Starting dynamic subtest: smem
[61.855964] Dynamic subtest smem: SUCCESS (3.938s)
[61.862915] Subtest basic: SUCCESS (3.938s)
[62.081916] [021/162] (938s left) gem_exec_fence (basic-busy)
[62.256562] Starting subtest: basic-busy
[62.263104] Starting dynamic subtest: rcs0
[62.356675] Dynamic subtest rcs0: SUCCESS (0.101s)
[62.374402] Starting dynamic subtest: bcs0
[62.419774] Dynamic subtest bcs0: SUCCESS (0.063s)
[62.436479] Starting dynamic subtest: vcs0
[62.487218] Dynamic subtest vcs0: SUCCESS (0.067s)
[62.503387] Starting dynamic subtest: vcs1
[62.546335] Dynamic subtest vcs1: SUCCESS (0.059s)
[62.561856] Starting dynamic subtest: vecs0
[62.603501] Dynamic subtest vecs0: SUCCESS (0.057s)
[62.618908] Starting dynamic subtest: ccs0
[62.662453] Dynamic subtest ccs0: SUCCESS (0.059s)
[62.668734] Subtest basic-busy: SUCCESS (0.409s)
[64.978166] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[64.985013] [022/162] (935s left) gem_exec_fence (basic-wait)
[65.147205] Starting subtest: basic-wait
[65.153622] Starting dynamic subtest: rcs0
[65.239398] Dynamic subtest rcs0: SUCCESS (0.094s)
[65.251029] Starting dynamic subtest: bcs0
[65.302780] Dynamic subtest bcs0: SUCCESS (0.064s)
[65.314256] Starting dynamic subtest: vcs0
[65.358954] Dynamic subtest vcs0: SUCCESS (0.056s)
[65.370179] Starting dynamic subtest: vcs1
[65.413925] Dynamic subtest vcs1: SUCCESS (0.055s)
[65.425121] Starting dynamic subtest: vecs0
[65.473060] Dynamic subtest vecs0: SUCCESS (0.059s)
[65.484296] Starting dynamic subtest: ccs0
[65.539631] Dynamic subtest ccs0: SUCCESS (0.067s)
[65.545829] Subtest basic-wait: SUCCESS (0.395s)
[67.119086] [023/162] (933s left) gem_exec_fence (basic-await)
[67.412602] Starting subtest: basic-await
[67.419295] Starting dynamic subtest: rcs0
[67.520005] Dynamic subtest rcs0: SUCCESS (0.109s)
[67.532989] Starting dynamic subtest: bcs0
[67.623629] Dynamic subtest bcs0: SUCCESS (0.104s)
[67.635862] Starting dynamic subtest: vcs0
[67.711096] Dynamic subtest vcs0: SUCCESS (0.086s)
[67.725976] Starting dynamic subtest: vcs1
[67.795006] Dynamic subtest vcs1: SUCCESS (0.084s)
[67.807360] Starting dynamic subtest: vecs0
[67.871935] Dynamic subtest vecs0: SUCCESS (0.077s)
[67.884107] Starting dynamic subtest: ccs0
[67.954066] Dynamic subtest ccs0: SUCCESS (0.082s)
[67.960307] Subtest basic-await: SUCCESS (0.545s)
[70.027914] [024/162] (930s left) gem_exec_fence (nb-await)
[70.188995] Starting subtest: nb-await
[70.196282] Starting dynamic subtest: rcs0
[70.271664] Dynamic subtest rcs0: SUCCESS (0.085s)
[70.306793] Starting dynamic subtest: bcs0
[70.334032] Dynamic subtest bcs0: SUCCESS (0.062s)
[70.366534] Starting dynamic subtest: vcs0
[70.393159] Dynamic subtest vcs0: SUCCESS (0.059s)
[70.424197] Starting dynamic subtest: vcs1
[70.454433] Dynamic subtest vcs1: SUCCESS (0.062s)
[70.486029] Starting dynamic subtest: vecs0
[70.516485] Dynamic subtest vecs0: SUCCESS (0.062s)
[70.550086] Starting dynamic subtest: ccs0
[70.575503] Dynamic subtest ccs0: SUCCESS (0.058s)
[70.582280] Subtest nb-await: SUCCESS (0.390s)
[71.988960] [025/162] (929s left) gem_exec_gttfill (basic)
[72.046481] Starting subtest: basic
[75.549091] Subtest basic: SUCCESS (3.505s)
[75.778958] [026/162] (925s left) gem_exec_parallel (engines)
[75.864868] Starting subtest: engines
[75.873935] Starting dynamic subtest: basic
[77.882880] Dynamic subtest basic: SUCCESS (2.017s)
[77.900368] Starting dynamic subtest: contexts
[82.546882] Dynamic subtest contexts: SUCCESS (4.662s)
[82.564599] Starting dynamic subtest: fds
[87.916601] Dynamic subtest fds: SUCCESS (5.364s)
[87.938345] Starting dynamic subtest: userptr
[89.830566] Dynamic subtest userptr: SUCCESS (1.913s)
[89.843763] Subtest engines: SUCCESS (13.958s)
[90.121917] [027/162] (911s left) gem_exec_store (basic)
[90.240717] Starting subtest: basic
[90.307113] Subtest basic: SUCCESS (0.098s)
[90.560651] [028/162] (910s left) gem_flink_basic (bad-flink)
[90.644345] Starting subtest: bad-flink
[90.653263] Subtest bad-flink: SUCCESS (0.000s)
[90.813440] [029/162] (910s left) gem_flink_basic (bad-open)
[90.896120] Starting subtest: bad-open
[90.905032] Subtest bad-open: SUCCESS (0.000s)
[91.093800] [030/162] (910s left) gem_flink_basic (basic)
[91.164141] Starting subtest: basic
[91.180624] Subtest basic: SUCCESS (0.000s)
[91.355347] [031/162] (910s left) gem_flink_basic (double-flink)
[91.413542] Starting subtest: double-flink
[91.420228] Subtest double-flink: SUCCESS (0.000s)
[91.607688] [032/162] (910s left) gem_flink_basic (flink-lifetime)
[91.658737] Starting subtest: flink-lifetime
[91.665564] Subtest flink-lifetime: SUCCESS (0.001s)
[91.873794] [033/162] (910s left) gem_huc_copy (huc-copy)
[91.932975] Starting subtest: huc-copy
[91.939643] Subtest huc-copy: SUCCESS (0.004s)
[92.117941] [034/162] (909s left) gem_linear_blits (basic)
[92.256160] Starting subtest: basic
[92.275587] Subtest basic: SUCCESS (0.023s)
[92.493778] [035/162] (909s left) gem_mmap (basic)
[92.614378] Subtest basic: SKIP (0.000s)
[92.681246] [036/162] (909s left) gem_mmap_gtt (basic)
[92.763588] Subtest basic: SKIP (0.000s)
[92.838140] [037/162] (909s left) gem_render_linear_blits (basic)
[92.903861] Starting subtest: basic
[92.966509] Subtest basic: SUCCESS (0.048s)
[93.053702] [038/162] (909s left) gem_render_tiled_blits (basic)
[93.142183] Subtest basic: SKIP (0.000s)
[93.210193] [039/162] (909s left) gem_ringfill (basic-all)
[98.864214] Starting subtest: basic-all
[100.026999] Subtest basic-all: SUCCESS (1.177s)
[100.209347] [040/162] (902s left) gem_softpin (allocator-basic)
[100.296300] Starting subtest: allocator-basic
[100.363124] Subtest allocator-basic: SUCCESS (0.089s)
[100.586117] [041/162] (901s left) gem_softpin (allocator-basic-reserve)
[100.657975] Starting subtest: allocator-basic-reserve
[100.740119] Subtest allocator-basic-reserve: SUCCESS (0.089s)
[100.956732] [042/162] (901s left) gem_softpin (safe-alignment)
[101.044238] Starting subtest: safe-alignment
[101.067453] Subtest safe-alignment: SUCCESS (0.041s)
[102.901363] [043/162] (899s left) gem_sync (basic-all)
[103.050182] Starting subtest: basic-all
[106.852480] Subtest basic-all: SUCCESS (3.873s)
[107.067858] [044/162] (895s left) gem_sync (basic-each)
[107.227606] Starting subtest: basic-each
[109.485217] Subtest basic-each: SUCCESS (2.349s)
[109.732969] [045/162] (893s left) gem_tiled_blits (basic)
[109.821113] Subtest basic: SKIP (0.000s)
[109.888355] [046/162] (893s left) gem_tiled_fence_blits (basic)
[109.978883] Subtest basic: SKIP (0.000s)
[110.052927] [047/162] (892s left) gem_tiled_pread_basic (basic)
[110.139316] Subtest basic: SKIP (0.000s)
[110.207140] [048/162] (892s left) gem_wait (busy@all-engines)
[110.269093] Starting subtest: busy
[110.278275] Starting dynamic subtest: all-engines
[111.843802] Dynamic subtest all-engines: SUCCESS (1.575s)
[111.856948] Subtest busy: SUCCESS (1.575s)
[112.112132] [049/162] (890s left) gem_wait (wait@all-engines)
[112.199637] Starting subtest: wait
[112.206214] Starting dynamic subtest: all-engines
[113.833237] Dynamic subtest all-engines: SUCCESS (1.633s)
[113.843144] Subtest wait: SUCCESS (1.634s)
[114.100281] [050/162] (889s left) i915_getparams_basic (basic-eu-total)
[114.187034] Starting subtest: basic-eu-total
[114.210139] Subtest basic-eu-total: SUCCESS (0.000s)
[114.294211] [051/162] (888s left) i915_getparams_basic (basic-subslice-total)
[114.366679] Starting subtest: basic-subslice-total
[114.389640] Subtest basic-subslice-total: SUCCESS (0.000s)
[114.477402] [052/162] (888s left) i915_hangman (error-state-basic)
[114.558250] Starting subtest: error-state-basic
[114.681850] Subtest error-state-basic: SUCCESS (0.131s)
[114.805774] [053/162] (888s left) i915_pciid
[115.001707] [054/162] (888s left) intel_hwmon (hwmon-read)
[115.088358] Subtest hwmon-read: SKIP (0.000s)
[115.155228] [055/162] (888s left) intel_hwmon (hwmon-write)
[115.238390] Subtest hwmon-write: SKIP (0.000s)
[115.305755] [056/162] (888s left) kms_addfb_basic (addfb25-4-tiled)
[115.418723] Starting subtest: addfb25-4-tiled
[115.425047] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[115.557845] [057/162] (888s left) kms_addfb_basic (addfb25-bad-modifier)
[115.646256] Starting subtest: addfb25-bad-modifier
[115.659486] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[115.821163] [058/162] (887s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[115.919429] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[116.102530] [059/162] (887s left) kms_addfb_basic (addfb25-modifier-no-flag)
[116.196149] Starting subtest: addfb25-modifier-no-flag
[116.212609] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[116.369508] [060/162] (887s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[116.466540] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[116.654083] [061/162] (887s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[116.745795] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[117.019606] [062/162] (887s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[117.143800] Starting subtest: addfb25-yf-tiled-legacy
[117.152580] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[117.348224] [063/162] (886s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[117.457082] Starting subtest: addfb25-y-tiled-legacy
[117.463807] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[117.698522] [064/162] (886s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[117.780511] Starting subtest: addfb25-y-tiled-small-legacy
[117.793006] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[117.943446] [065/162] (886s left) kms_addfb_basic (bad-pitch-0)
[118.020152] Starting subtest: bad-pitch-0
[118.033557] Subtest bad-pitch-0: SUCCESS (0.000s)
[118.227675] [066/162] (886s left) kms_addfb_basic (bad-pitch-1024)
[118.314033] Starting subtest: bad-pitch-1024
[118.320476] Subtest bad-pitch-1024: SUCCESS (0.000s)
[118.493432] [067/162] (886s left) kms_addfb_basic (bad-pitch-128)
[118.562549] Starting subtest: bad-pitch-128
[118.569436] Subtest bad-pitch-128: SUCCESS (0.000s)
[118.733793] [068/162] (885s left) kms_addfb_basic (bad-pitch-256)
[118.797821] Starting subtest: bad-pitch-256
[118.814342] Subtest bad-pitch-256: SUCCESS (0.000s)
[118.979353] [069/162] (885s left) kms_addfb_basic (bad-pitch-32)
[119.051182] Starting subtest: bad-pitch-32
[119.067567] Subtest bad-pitch-32: SUCCESS (0.000s)
[119.214716] [070/162] (885s left) kms_addfb_basic (bad-pitch-63)
[119.286470] Starting subtest: bad-pitch-63
[119.292921] Subtest bad-pitch-63: SUCCESS (0.000s)
[119.449876] [071/162] (885s left) kms_addfb_basic (bad-pitch-65536)
[119.523613] Starting subtest: bad-pitch-65536
[119.540316] Subtest bad-pitch-65536: SUCCESS (0.000s)
[119.727867] [072/162] (885s left) kms_addfb_basic (bad-pitch-999)
[119.816780] Starting subtest: bad-pitch-999
[119.829151] Subtest bad-pitch-999: SUCCESS (0.000s)
[119.998107] [073/162] (884s left) kms_addfb_basic (basic)
[120.089043] Starting subtest: basic
[120.095434] Subtest basic: SUCCESS (0.000s)
[120.257113] [074/162] (884s left) kms_addfb_basic (basic-x-tiled-legacy)
[120.327895] Starting subtest: basic-x-tiled-legacy
[120.349878] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[120.536144] [075/162] (884s left) kms_addfb_basic (basic-y-tiled-legacy)
[120.628507] Starting subtest: basic-y-tiled-legacy
[120.651419] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[120.783698] [076/162] (884s left) kms_addfb_basic (bo-too-small)
[120.868255] Starting subtest: bo-too-small
[120.876159] Subtest bo-too-small: SUCCESS (0.000s)
[121.028768] [077/162] (884s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[121.119154] Starting subtest: bo-too-small-due-to-tiling
[121.141941] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[121.278119] [078/162] (884s left) kms_addfb_basic (clobberred-modifier)
[121.357149] Starting subtest: clobberred-modifier
[121.379147] Subtest clobberred-modifier: SKIP (0.000s)
[121.517029] [079/162] (883s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[121.600111] Starting subtest: framebuffer-vs-set-tiling
[121.616234] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[121.748906] [080/162] (883s left) kms_addfb_basic (invalid-get-prop)
[121.807064] Starting subtest: invalid-get-prop
[121.813793] Subtest invalid-get-prop: SUCCESS (0.000s)
[122.027761] [081/162] (883s left) kms_addfb_basic (invalid-get-prop-any)
[122.104050] Starting subtest: invalid-get-prop-any
[122.120459] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[122.366224] [082/162] (883s left) kms_addfb_basic (invalid-set-prop)
[122.453658] Starting subtest: invalid-set-prop
[122.459916] Subtest invalid-set-prop: SUCCESS (0.000s)
[122.609520] [083/162] (883s left) kms_addfb_basic (invalid-set-prop-any)
[122.679179] Starting subtest: invalid-set-prop-any
[122.690791] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[122.838079] [084/162] (882s left) kms_addfb_basic (no-handle)
[122.916550] Starting subtest: no-handle
[122.922803] Subtest no-handle: SUCCESS (0.000s)
[123.089847] [085/162] (882s left) kms_addfb_basic (size-max)
[123.164349] Starting subtest: size-max
[123.171522] Subtest size-max: SUCCESS (0.000s)
[123.342843] [086/162] (882s left) kms_addfb_basic (small-bo)
[123.431133] Starting subtest: small-bo
[123.444252] Subtest small-bo: SUCCESS (0.000s)
[123.581208] [087/162] (882s left) kms_addfb_basic (tile-pitch-mismatch)
[123.669357] Starting subtest: tile-pitch-mismatch
[123.691447] Subtest tile-pitch-mismatch: SKIP (0.000s)
[123.833478] [088/162] (882s left) kms_addfb_basic (too-high)
[123.908412] Starting subtest: too-high
[123.915540] Subtest too-high: SUCCESS (0.000s)
[124.100094] [089/162] (881s left) kms_addfb_basic (too-wide)
[124.189672] Starting subtest: too-wide
[124.202892] Subtest too-wide: SUCCESS (0.000s)
[124.383991] [090/162] (881s left) kms_addfb_basic (unused-handle)
[124.465797] Starting subtest: unused-handle
[124.474640] Subtest unused-handle: SUCCESS (0.000s)
[124.653775] [091/162] (881s left) kms_addfb_basic (unused-modifier)
[124.715038] Starting subtest: unused-modifier
[124.728535] Subtest unused-modifier: SUCCESS (0.000s)
[124.909274] [092/162] (881s left) kms_addfb_basic (unused-offsets)
[124.977336] Starting subtest: unused-offsets
[124.983857] Subtest unused-offsets: SUCCESS (0.000s)
[125.183510] [093/162] (881s left) kms_addfb_basic (unused-pitches)
[125.276189] Starting subtest: unused-pitches
[125.292779] Subtest unused-pitches: SUCCESS (0.000s)
[125.437354] [094/162] (881s left) kms_busy (basic)
[125.524028] Starting subtest: basic
[125.532784] Starting dynamic subtest: flip
[126.287821] Dynamic subtest flip: SUCCESS (0.759s)
[126.306515] Starting dynamic subtest: modeset
[129.693276] Dynamic subtest modeset: SUCCESS (3.410s)
[129.699550] Subtest basic: SUCCESS (4.170s)
[130.548541] [095/162] (875s left) kms_prop_blob (basic)
[130.602273] Starting subtest: basic
[130.609323] Subtest basic: SUCCESS (0.000s)
[130.738972] [096/162] (875s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[130.857810] Starting subtest: basic-busy-flip-before-cursor-atomic
[130.880314] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[131.013476] [097/162] (875s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[131.130612] Starting subtest: basic-busy-flip-before-cursor-legacy
[131.153451] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[131.291341] [098/162] (875s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[131.405655] Starting subtest: basic-flip-after-cursor-atomic
[132.620055] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.213s)
[133.483048] [099/162] (873s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[133.598290] Starting subtest: basic-flip-after-cursor-legacy
[134.809578] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.214s)
[135.718705] [100/162] (871s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[135.836768] Starting subtest: basic-flip-after-cursor-varying-size
[137.053953] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.212s)
[137.992425] [101/162] (868s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[138.113341] Starting subtest: basic-flip-before-cursor-atomic
[139.318809] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.213s)
[140.183398] [102/162] (866s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[140.307673] Starting subtest: basic-flip-before-cursor-legacy
[141.510999] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.209s)
[142.466939] [103/162] (864s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[142.593616] Starting subtest: basic-flip-before-cursor-varying-size
[143.797661] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.208s)
[144.659174] [104/162] (862s left) kms_dsc (dsc-basic)
[144.733757] Starting subtest: dsc-basic
[144.771174] Subtest dsc-basic: SKIP (0.001s)
[144.842431] [105/162] (862s left) kms_flip (basic-flip-vs-dpms)
[144.936306] Starting subtest: basic-flip-vs-dpms
[144.942506] Starting dynamic subtest: A-eDP1
[147.519786] Dynamic subtest A-eDP1: SUCCESS (2.593s)
[147.537610] Starting dynamic subtest: B-eDP1
[149.762153] Dynamic subtest B-eDP1: SUCCESS (2.231s)
[149.784123] Starting dynamic subtest: C-eDP1
[152.022326] Dynamic subtest C-eDP1: SUCCESS (2.265s)
[152.040018] Starting dynamic subtest: D-eDP1
[154.264259] Dynamic subtest D-eDP1: SUCCESS (2.250s)
[154.279508] Subtest basic-flip-vs-dpms: SUCCESS (9.350s)
[155.222872] [106/162] (851s left) kms_flip (basic-flip-vs-modeset)
[155.320107] Starting subtest: basic-flip-vs-modeset
[155.328814] Starting dynamic subtest: A-eDP1
[157.954242] Dynamic subtest A-eDP1: SUCCESS (2.640s)
[157.974837] Starting dynamic subtest: B-eDP1
[160.194685] Dynamic subtest B-eDP1: SUCCESS (2.241s)
[160.215457] Starting dynamic subtest: C-eDP1
[162.416350] Dynamic subtest C-eDP1: SUCCESS (2.224s)
[162.437092] Starting dynamic subtest: D-eDP1
[164.687325] Dynamic subtest D-eDP1: SUCCESS (2.271s)
[164.693908] Subtest basic-flip-vs-modeset: SUCCESS (9.390s)
[165.644562] [107/162] (841s left) kms_flip (basic-flip-vs-wf_vblank)
[165.732574] Starting subtest: basic-flip-vs-wf_vblank
[165.739254] Starting dynamic subtest: A-eDP1
[167.779688] Dynamic subtest A-eDP1: SUCCESS (2.049s)
[167.803055] Starting dynamic subtest: B-eDP1
[169.805781] Dynamic subtest B-eDP1: SUCCESS (2.023s)
[169.834736] Starting dynamic subtest: C-eDP1
[171.848366] Dynamic subtest C-eDP1: SUCCESS (2.021s)
[171.873787] Starting dynamic subtest: D-eDP1
[173.879817] Dynamic subtest D-eDP1: SUCCESS (2.033s)
[173.893231] Subtest basic-flip-vs-wf_vblank: SUCCESS (8.140s)
[175.210241] [108/162] (832s left) kms_flip (basic-plain-flip)
[175.300591] Starting subtest: basic-plain-flip
[175.307051] Starting dynamic subtest: A-eDP1
[176.986057] Dynamic subtest A-eDP1: SUCCESS (1.695s)
[177.009802] Starting dynamic subtest: B-eDP1
[178.714112] Dynamic subtest B-eDP1: SUCCESS (1.723s)
[178.737867] Starting dynamic subtest: C-eDP1
[180.444684] Dynamic subtest C-eDP1: SUCCESS (1.718s)
[180.474621] Starting dynamic subtest: D-eDP1
[182.173929] Dynamic subtest D-eDP1: SUCCESS (1.728s)
[182.182817] Subtest basic-plain-flip: SUCCESS (6.873s)
[183.478550] [109/162] (823s left) kms_force_connector_basic (force-connector-state)
[183.571906] Starting subtest: force-connector-state
[184.153668] Subtest force-connector-state: SUCCESS (0.602s)
[185.201266] [110/162] (822s left) kms_force_connector_basic (force-edid)
[185.262287] Starting subtest: force-edid
[185.550814] Subtest force-edid: SUCCESS (0.292s)
[185.736649] [111/162] (821s left) kms_force_connector_basic (force-load-detect)
[185.798127] Starting subtest: force-load-detect
[185.810888] Subtest force-load-detect: SKIP (0.000s)
[185.976833] [112/162] (821s left) kms_force_connector_basic (prune-stale-modes)
[186.036896] Starting subtest: prune-stale-modes
[186.407774] Subtest prune-stale-modes: SUCCESS (0.361s)
[186.591555] [113/162] (821s left) kms_frontbuffer_tracking (basic)
[186.692666] Starting subtest: basic
[192.076033] Subtest basic: SUCCESS (5.385s)
[192.233934] [114/162] (815s left) kms_hdmi_inject (inject-audio)
[192.581840] Starting subtest: inject-audio
[192.838311] Subtest inject-audio: SUCCESS (0.253s)
[193.515006] [115/162] (814s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[193.603281] Starting subtest: compare-crc-sanitycheck-xr24
[193.616636] Starting dynamic subtest: pipe-A-eDP-1
[194.344767] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.739s)
[194.366132] Starting dynamic subtest: pipe-B-eDP-1
[195.661334] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.319s)
[195.682865] Starting dynamic subtest: pipe-C-eDP-1
[196.972640] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.310s)
[196.993767] Starting dynamic subtest: pipe-D-eDP-1
[198.278943] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.303s)
[198.295169] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.678s)
[199.207208] [116/162] (808s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[199.304244] Starting subtest: compare-crc-sanitycheck-nv12
[199.314257] Starting dynamic subtest: pipe-A-eDP-1
[200.225563] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.921s)
[200.247672] Starting dynamic subtest: pipe-B-eDP-1
[201.647251] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.418s)
[201.669451] Starting dynamic subtest: pipe-C-eDP-1
[202.939838] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.297s)
[202.961720] Starting dynamic subtest: pipe-D-eDP-1
[204.336214] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.393s)
[204.352754] Subtest compare-crc-sanitycheck-nv12: SUCCESS (5.040s)
[205.195146] [117/162] (802s left) kms_pipe_crc_basic (hang-read-crc)
[205.276267] Starting subtest: hang-read-crc
[205.282965] Starting dynamic subtest: pipe-A-eDP-1
[207.628262] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.354s)
[207.646028] Starting dynamic subtest: pipe-B-eDP-1
[210.737443] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.103s)
[210.750637] Starting dynamic subtest: pipe-C-eDP-1
[213.670743] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.929s)
[213.684435] Starting dynamic subtest: pipe-D-eDP-1
[216.673102] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.004s)
[216.689497] Subtest hang-read-crc: SUCCESS (11.401s)
[217.577938] [118/162] (790s left) kms_pipe_crc_basic (nonblocking-crc)
[217.655881] Starting subtest: nonblocking-crc
[217.664048] Starting dynamic subtest: pipe-A-eDP-1
[218.536399] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.874s)
[218.552583] Starting dynamic subtest: pipe-B-eDP-1
[220.084854] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.553s)
[220.098458] Starting dynamic subtest: pipe-C-eDP-1
[221.547816] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.451s)
[221.565509] Starting dynamic subtest: pipe-D-eDP-1
[223.035430] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.489s)
[223.043201] Subtest nonblocking-crc: SUCCESS (5.375s)
[224.077169] [119/162] (784s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[224.171224] Starting subtest: nonblocking-crc-frame-sequence
[224.187755] Starting dynamic subtest: pipe-A-eDP-1
[225.039090] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.861s)
[225.061067] Starting dynamic subtest: pipe-B-eDP-1
[226.609594] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.572s)
[226.654423] Starting dynamic subtest: pipe-C-eDP-1
[228.029586] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.426s)
[228.067406] Starting dynamic subtest: pipe-D-eDP-1
[229.533831] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.502s)
[229.540639] Subtest nonblocking-crc-frame-sequence: SUCCESS (5.368s)
[230.571559] [120/162] (777s left) kms_pipe_crc_basic (read-crc)
[230.653951] Starting subtest: read-crc
[230.660488] Starting dynamic subtest: pipe-A-eDP-1
[231.448810] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.791s)
[231.468142] Starting dynamic subtest: pipe-B-eDP-1
[232.945070] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.495s)
[232.962845] Starting dynamic subtest: pipe-C-eDP-1
[234.363116] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.420s)
[234.376992] Starting dynamic subtest: pipe-D-eDP-1
[235.774130] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.403s)
[235.790655] Subtest read-crc: SUCCESS (5.114s)
[236.662797] [121/162] (771s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[236.751319] Starting subtest: read-crc-frame-sequence
[236.764645] Starting dynamic subtest: pipe-A-eDP-1
[237.562131] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.805s)
[237.580105] Starting dynamic subtest: pipe-B-eDP-1
[239.050152] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.495s)
[239.088998] Starting dynamic subtest: pipe-C-eDP-1
[240.494771] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.434s)
[240.515706] Starting dynamic subtest: pipe-D-eDP-1
[241.902939] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.406s)
[241.919475] Subtest read-crc-frame-sequence: SUCCESS (5.146s)
[242.804909] [122/162] (765s left) kms_pm_backlight (basic-brightness)
[242.901610] Starting subtest: basic-brightness
[242.955743] Starting dynamic subtest: eDP-1
[243.251887] Dynamic subtest eDP-1: SUCCESS (0.299s)
[243.259104] Subtest basic-brightness: SUCCESS (0.359s)
[244.176715] [123/162] (764s left) kms_pm_rpm (basic-pci-d3-state)
[246.035242] Starting subtest: basic-pci-d3-state
[247.564074] Subtest basic-pci-d3-state: SUCCESS (1.529s)
[247.732423] [124/162] (760s left) kms_pm_rpm (basic-rte)
[247.814317] Starting subtest: basic-rte
[251.409323] Subtest basic-rte: SUCCESS (3.613s)
[253.220688] [125/162] (755s left) kms_psr (psr-primary-page-flip)
[253.317333] Starting subtest: psr-primary-page-flip
[253.333829] Starting dynamic subtest: eDP-1
[255.228894] Dynamic subtest eDP-1: SUCCESS (1.921s)
[255.245284] Subtest psr-primary-page-flip: SUCCESS (1.923s)
[256.086473] [126/162] (752s left) kms_psr (psr-cursor-plane-move)
[256.175301] Starting subtest: psr-cursor-plane-move
[256.190997] Starting dynamic subtest: eDP-1
[258.117614] Dynamic subtest eDP-1: SUCCESS (1.944s)
[258.134049] Subtest psr-cursor-plane-move: SUCCESS (1.946s)
[259.002436] [127/162] (749s left) kms_psr (psr-sprite-plane-onoff)
[259.095599] Starting subtest: psr-sprite-plane-onoff
[259.112213] Starting dynamic subtest: eDP-1
[261.061042] Dynamic subtest eDP-1: SUCCESS (1.968s)
[261.077519] Subtest psr-sprite-plane-onoff: SUCCESS (1.970s)
[261.963144] [128/162] (746s left) kms_psr (psr-primary-mmap-gtt)
[262.054066] Starting subtest: psr-primary-mmap-gtt
[262.070683] Starting dynamic subtest: eDP-1
[263.636117] Dynamic subtest eDP-1: SKIP (1.570s)
[263.652117] Subtest psr-primary-mmap-gtt: SKIP (1.571s)
[263.856531] [129/162] (745s left) kms_setmode (basic-clone-single-crtc)
[263.919143] Starting subtest: basic-clone-single-crtc
[263.941699] Subtest basic-clone-single-crtc: SKIP (0.000s)
[264.049404] [130/162] (744s left) i915_pm_rps (basic-api)
[264.106641] Starting subtest: basic-api
[264.123225] Subtest basic-api: SKIP (0.001s)
[264.283872] [131/162] (744s left) prime_self_import (basic-llseek-bad)
[264.341243] Starting subtest: basic-llseek-bad
[264.357241] Subtest basic-llseek-bad: SUCCESS (0.006s)
[264.499900] [132/162] (744s left) prime_self_import (basic-llseek-size)
[264.556665] Starting subtest: basic-llseek-size
[264.569847] Subtest basic-llseek-size: SUCCESS (0.002s)
[264.702761] [133/162] (744s left) prime_self_import (basic-with_fd_dup)
[264.750628] Starting subtest: basic-with_fd_dup
[264.764222] Subtest basic-with_fd_dup: SUCCESS (0.002s)
[264.950275] [134/162] (744s left) prime_self_import (basic-with_one_bo)
[265.001883] Starting subtest: basic-with_one_bo
[265.015427] Subtest basic-with_one_bo: SUCCESS (0.002s)
[265.230579] [135/162] (744s left) prime_self_import (basic-with_one_bo_two_files)
[265.281999] Starting subtest: basic-with_one_bo_two_files
[265.295557] Subtest basic-with_one_bo_two_files: SUCCESS (0.004s)
[265.547182] [136/162] (744s left) prime_self_import (basic-with_two_bos)
[265.610765] Starting subtest: basic-with_two_bos
[265.634115] Subtest basic-with_two_bos: SUCCESS (0.002s)
[265.794327] [137/162] (744s left) prime_vgem (basic-fence-flip)
[265.907487] Starting subtest: basic-fence-flip
[266.378431] Subtest basic-fence-flip: SUCCESS (0.479s)
[266.585157] [138/162] (743s left) prime_vgem (basic-fence-mmap)
[266.687886] Starting subtest: basic-fence-mmap
[266.710971] Subtest basic-fence-mmap: SKIP (0.000s)
[266.841819] [139/162] (743s left) prime_vgem (basic-fence-read)
[266.934976] Starting subtest: basic-fence-read
[266.957069] Subtest basic-fence-read: SKIP (0.013s)
[267.088141] [140/162] (742s left) prime_vgem (basic-gtt)
[267.189693] Starting subtest: basic-gtt
[267.207284] Subtest basic-gtt: SKIP (0.000s)
[267.350452] [141/162] (742s left) prime_vgem (basic-read)
[267.431850] Starting subtest: basic-read
[267.447351] Subtest basic-read: SKIP (0.011s)
[267.597274] [142/162] (742s left) prime_vgem (basic-write)
[267.679440] Starting subtest: basic-write
[267.695017] Subtest basic-write: SKIP (0.011s)
[267.848119] [143/162] (742s left) vgem_basic (setversion)
[267.915099] Starting subtest: setversion
[267.930362] Subtest setversion: SUCCESS (0.000s)
[268.119379] [144/162] (742s left) vgem_basic (create)
[268.185267] Starting subtest: create
[268.191788] Subtest create: SUCCESS (0.000s)
[268.289151] [145/162] (742s left) vgem_basic (debugfs)
[268.351617] Starting subtest: debugfs
[268.358093] Subtest debugfs: SUCCESS (0.001s)
[268.478678] [146/162] (742s left) vgem_basic (dmabuf-export)
[268.536117] Starting subtest: dmabuf-export
[268.548924] Subtest dmabuf-export: SUCCESS (0.003s)
[268.717664] [147/162] (741s left) vgem_basic (dmabuf-fence)
[268.780642] Starting subtest: dmabuf-fence
[268.786953] Subtest dmabuf-fence: SUCCESS (0.000s)
[268.879986] [148/162] (741s left) vgem_basic (dmabuf-fence-before)
[268.936097] Starting subtest: dmabuf-fence-before
[268.942920] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[269.036811] [149/162] (741s left) vgem_basic (dmabuf-mmap)
[269.098685] Starting subtest: dmabuf-mmap
[269.112250] Subtest dmabuf-mmap: SUCCESS (0.021s)
[269.220619] [150/162] (741s left) vgem_basic (mmap)
[269.310229] Starting subtest: mmap
[269.320103] Subtest mmap: SUCCESS (0.012s)
[269.440790] [151/162] (741s left) vgem_basic (second-client)
[269.522922] Starting subtest: second-client
[269.544933] Subtest second-client: SUCCESS (0.033s)
[269.665912] [152/162] (741s left) vgem_basic (sysfs)
[269.752699] Starting subtest: sysfs
[269.759375] Subtest sysfs: SUCCESS (0.000s)
[269.874746] [153/162] (741s left) core_hotunplug (unbind-rebind)
[269.978516] Starting subtest: unbind-rebind
[276.473504] Subtest unbind-rebind: SUCCESS (6.492s)
[276.592546] [154/162] (734s left) vgem_basic (unload)
[276.686690] Starting subtest: unload
[305.811729] Subtest unload: SUCCESS (29.125s)
[306.027891] [155/162] (705s left) i915_module_load (reload)
[306.146905] Starting subtest: reload
[311.059519] Subtest reload: SUCCESS (4.937s)
[311.140264] [156/162] (700s left) gem_lmem_swapping (basic)
[311.238533] Subtest basic: SKIP (0.000s)
[311.337100] [157/162] (700s left) gem_lmem_swapping (parallel-random-engines)
[311.455743] Subtest parallel-random-engines: SKIP (0.000s)
[311.548833] [158/162] (700s left) gem_lmem_swapping (random-engines)
[311.682742] Subtest random-engines: SKIP (0.000s)
[311.807078] [159/162] (699s left) gem_lmem_swapping (verify-random)
[311.948878] Subtest verify-random: SKIP (0.000s)
[312.038963] [160/162] (699s left) i915_pm_rpm (module-reload)
[314.400913] Starting subtest: module-reload
[331.500487] Subtest module-reload: SUCCESS (17.094s)
[331.568016] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[331.569678] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[331.588084] [161/162] (680s left) i915_selftest (live)
[331.656493] Starting subtest: live
[331.669969] Starting dynamic subtest: sanitycheck
[334.440799] Dynamic subtest sanitycheck: SUCCESS (2.777s)
[334.462730] Starting dynamic subtest: uncore
[337.240908] Dynamic subtest uncore: SUCCESS (2.799s)
[337.262887] Starting dynamic subtest: workarounds
[361.812887] Dynamic subtest workarounds: FAIL (23.791s)
[361.838337] Starting dynamic subtest: gt_engines
[364.335561] Dynamic subtest gt_engines: SUCCESS (3.302s)
[364.355855] Starting dynamic subtest: gt_timelines
[384.139285] Dynamic subtest gt_timelines: SUCCESS (19.800s)
[384.161274] Starting dynamic subtest: gt_contexts
[389.200121] Dynamic subtest gt_contexts: SUCCESS (5.061s)
[389.220835] Starting dynamic subtest: gt_lrc
[395.949464] Dynamic subtest gt_lrc: SUCCESS (6.755s)
[395.965480] Starting dynamic subtest: gt_mocs
[399.215814] Dynamic subtest gt_mocs: SUCCESS (3.263s)
[399.235797] Starting dynamic subtest: gt_pm
[406.220179] Dynamic subtest gt_pm: SUCCESS (6.997s)
[406.240887] Starting dynamic subtest: gt_heartbeat
[411.758701] Dynamic subtest gt_heartbeat: SUCCESS (5.545s)
[411.780484] Starting dynamic subtest: gt_tlb
[422.360028] Dynamic subtest gt_tlb: SUCCESS (10.590s)
[422.381921] Starting dynamic subtest: requests
[436.435697] Dynamic subtest requests: SUCCESS (14.083s)
[436.451500] Starting dynamic subtest: migrate
[444.622739] Dynamic subtest migrate: SUCCESS (8.174s)
[444.643336] Starting dynamic subtest: active
[449.589800] Dynamic subtest active: SUCCESS (4.968s)
[449.610625] Starting dynamic subtest: objects
[453.539533] Dynamic subtest objects: SUCCESS (3.946s)
[453.561497] Starting dynamic subtest: mman
[458.832996] Dynamic subtest mman: SUCCESS (5.292s)
[458.853818] Starting dynamic subtest: dmabuf
[463.773112] Dynamic subtest dmabuf: SUCCESS (4.945s)
[463.790112] Starting dynamic subtest: vma
[469.064530] Dynamic subtest vma: SUCCESS (5.287s)
[469.084534] Starting dynamic subtest: coherency
[475.125714] Dynamic subtest coherency: SUCCESS (6.059s)
[475.143397] Starting dynamic subtest: gtt
[486.094662] Dynamic subtest gtt: SUCCESS (10.973s)
[486.110535] Starting dynamic subtest: gem
[494.696785] Dynamic subtest gem: SUCCESS (8.589s)
[494.718489] Starting dynamic subtest: evict
[500.905682] Dynamic subtest evict: SUCCESS (6.212s)
[500.925771] Starting dynamic subtest: hugepages
[513.027022] Dynamic subtest hugepages: SUCCESS (12.125s)
[513.043545] Starting dynamic subtest: gem_contexts
[540.973625] Dynamic subtest gem_contexts: SUCCESS (27.943s)
[540.989750] Starting dynamic subtest: client
[545.526368] Dynamic subtest client: SUCCESS (4.543s)
[545.547356] Starting dynamic subtest: gem_migrate