[89.162025] Initializing watchdogs
[89.162155]   /dev/watchdog0
[89.198782] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d51 Intel Meteorlake (Gen12) 
[89.210995] [001/162] (960s left) i915_module_load (load)
[89.306455] Starting subtest: load
[92.641111] Subtest load: SUCCESS (3.341s)
[92.711959] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[92.715694] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[92.730167] [002/162] (957s left) core_auth (basic-auth)
[93.843047] Starting subtest: basic-auth
[93.851976] Subtest basic-auth: SUCCESS (0.002s)
[94.014858] [003/162] (955s left) core_debugfs (read-all-entries)
[94.128237] Starting subtest: read-all-entries
[94.276346] Subtest read-all-entries: SUCCESS (0.156s)
[94.519203] [004/162] (955s left) core_sysfs (read-all-entries)
[94.643526] Starting subtest: read-all-entries
[94.656601] Subtest read-all-entries: SUCCESS (0.010s)
[94.827080] [005/162] (955s left) fbdev (eof)
[94.948760] Starting subtest: eof
[94.958422] Subtest eof: SUCCESS (0.000s)
[95.104514] [006/162] (955s left) fbdev (info)
[95.215496] Starting subtest: info
[95.228756] Subtest info: SUCCESS (0.000s)
[95.360681] [007/162] (955s left) fbdev (nullptr)
[95.473163] Starting subtest: nullptr
[95.482947] Subtest nullptr: SUCCESS (0.000s)
[95.657446] [008/162] (954s left) fbdev (read)
[95.755076] Starting subtest: read
[97.145312] Subtest read: SUCCESS (1.388s)
[97.299559] [009/162] (953s left) fbdev (write)
[97.413292] Starting subtest: write
[98.288502] Subtest write: SUCCESS (0.881s)
[98.450668] [010/162] (952s left) gem_basic (bad-close)
[98.576436] Starting subtest: bad-close
[98.598453] Subtest bad-close: SUCCESS (0.000s)
[98.746819] [011/162] (952s left) gem_basic (create-close)
[98.870557] Starting subtest: create-close
[98.893424] Subtest create-close: SUCCESS (0.000s)
[99.069709] [012/162] (951s left) gem_basic (create-fd-close)
[99.192207] Starting subtest: create-fd-close
[99.214908] Subtest create-fd-close: SUCCESS (0.000s)
[99.387824] [013/162] (951s left) gem_busy (busy@all-engines)
[99.511220] Starting subtest: busy
[99.527862] Starting dynamic subtest: all-engines
[99.599642] Dynamic subtest all-engines: SUCCESS (0.083s)
[99.606111] Subtest busy: SUCCESS (0.083s)
[100.959747] [014/162] (950s left) gem_close_race (basic-process)
[101.070443] Starting subtest: basic-process
[101.135974] Subtest basic-process: SUCCESS (0.071s)
[101.411963] [015/162] (949s left) gem_close_race (basic-threads)
[101.513372] Starting subtest: basic-threads
[102.826745] Subtest basic-threads: SUCCESS (1.323s)
[103.098740] [016/162] (948s left) gem_ctx_create (basic)
[103.172678] Starting subtest: basic
[103.189165] Subtest basic: SUCCESS (0.000s)
[103.414610] [017/162] (947s left) gem_ctx_create (basic-files)
[103.487242] Starting subtest: basic-files
[105.502095] Subtest basic-files: SUCCESS (2.015s)
[106.941853] [018/162] (944s left) gem_ctx_exec (basic)
[107.008826] Starting subtest: basic
[107.022736] Subtest basic: SUCCESS (0.008s)
[107.186516] [019/162] (944s left) gem_exec_basic (basic)
[107.256040] Starting subtest: basic
[107.262284] Starting dynamic subtest: rcs0-smem
[107.276159] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[107.288975] Starting dynamic subtest: bcs0-smem
[107.300553] Dynamic subtest bcs0-smem: SUCCESS (0.004s)
[107.318353] Starting dynamic subtest: vcs0-smem
[107.324575] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[107.343357] Starting dynamic subtest: vcs1-smem
[107.349562] Dynamic subtest vcs1-smem: SUCCESS (0.003s)
[107.365914] Starting dynamic subtest: vecs0-smem
[107.372163] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[107.388092] Starting dynamic subtest: ccs0-smem
[107.394280] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[107.406930] Subtest basic: SUCCESS (0.016s)
[109.000126] [020/162] (942s left) gem_exec_create (basic)
[109.070372] Starting subtest: basic
[109.076555] Starting dynamic subtest: smem
[112.865234] Dynamic subtest smem: SUCCESS (3.791s)
[112.871661] Subtest basic: SUCCESS (3.791s)
[113.103353] [021/162] (938s left) gem_exec_fence (basic-busy)
[113.275794] Starting subtest: basic-busy
[113.288445] Starting dynamic subtest: rcs0
[113.337995] Dynamic subtest rcs0: SUCCESS (0.065s)
[113.350887] Starting dynamic subtest: bcs0
[113.389894] Dynamic subtest bcs0: SUCCESS (0.057s)
[113.408930] Starting dynamic subtest: vcs0
[113.455704] Dynamic subtest vcs0: SUCCESS (0.061s)
[113.473567] Starting dynamic subtest: vcs1
[113.517327] Dynamic subtest vcs1: SUCCESS (0.059s)
[113.528339] Starting dynamic subtest: vecs0
[113.565902] Dynamic subtest vecs0: SUCCESS (0.055s)
[113.576908] Starting dynamic subtest: ccs0
[113.624730] Dynamic subtest ccs0: SUCCESS (0.059s)
[113.631170] Subtest basic-busy: SUCCESS (0.357s)
[116.025337] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[116.033723] [022/162] (935s left) gem_exec_fence (basic-wait)
[116.199744] Starting subtest: basic-wait
[116.206431] Starting dynamic subtest: rcs0
[116.286380] Dynamic subtest rcs0: SUCCESS (0.079s)
[116.308518] Starting dynamic subtest: bcs0
[116.330571] Dynamic subtest bcs0: SUCCESS (0.053s)
[116.350205] Starting dynamic subtest: vcs0
[116.389625] Dynamic subtest vcs0: SUCCESS (0.059s)
[116.411220] Starting dynamic subtest: vcs1
[116.454020] Dynamic subtest vcs1: SUCCESS (0.057s)
[116.472557] Starting dynamic subtest: vecs0
[116.500884] Dynamic subtest vecs0: SUCCESS (0.050s)
[116.521133] Starting dynamic subtest: ccs0
[116.563479] Dynamic subtest ccs0: SUCCESS (0.063s)
[116.576941] Subtest basic-wait: SUCCESS (0.363s)
[117.988370] [023/162] (933s left) gem_exec_fence (basic-await)
[118.170433] Starting subtest: basic-await
[118.182860] Starting dynamic subtest: rcs0
[118.256441] Dynamic subtest rcs0: SUCCESS (0.090s)
[118.275155] Starting dynamic subtest: bcs0
[118.329748] Dynamic subtest bcs0: SUCCESS (0.077s)
[118.347039] Starting dynamic subtest: vcs0
[118.405951] Dynamic subtest vcs0: SUCCESS (0.077s)
[118.417967] Starting dynamic subtest: vcs1
[118.483356] Dynamic subtest vcs1: SUCCESS (0.076s)
[118.502783] Starting dynamic subtest: vecs0
[118.564351] Dynamic subtest vecs0: SUCCESS (0.077s)
[118.582701] Starting dynamic subtest: ccs0
[118.638263] Dynamic subtest ccs0: SUCCESS (0.077s)
[118.651365] Subtest basic-await: SUCCESS (0.476s)
[120.952356] [024/162] (930s left) gem_exec_fence (nb-await)
[121.138997] Starting subtest: nb-await
[121.145931] Starting dynamic subtest: rcs0
[121.211785] Dynamic subtest rcs0: SUCCESS (0.082s)
[121.232420] Starting dynamic subtest: bcs0
[121.281361] Dynamic subtest bcs0: SUCCESS (0.064s)
[121.303545] Starting dynamic subtest: vcs0
[121.338312] Dynamic subtest vcs0: SUCCESS (0.061s)
[121.357141] Starting dynamic subtest: vcs1
[121.407574] Dynamic subtest vcs1: SUCCESS (0.069s)
[121.429562] Starting dynamic subtest: vecs0
[121.478859] Dynamic subtest vecs0: SUCCESS (0.066s)
[121.501083] Starting dynamic subtest: ccs0
[121.545144] Dynamic subtest ccs0: SUCCESS (0.066s)
[121.552036] Subtest nb-await: SUCCESS (0.410s)
[123.045722] [025/162] (928s left) gem_exec_gttfill (basic)
[123.121504] Starting subtest: basic
[126.726527] Subtest basic: SUCCESS (3.605s)
[126.985466] [026/162] (925s left) gem_exec_parallel (engines)
[127.072511] Starting subtest: engines
[127.079024] Starting dynamic subtest: basic
[128.911266] Dynamic subtest basic: SUCCESS (1.836s)
[128.928544] Starting dynamic subtest: contexts
[133.391608] Dynamic subtest contexts: SUCCESS (4.479s)
[133.409340] Starting dynamic subtest: fds
[138.939909] Dynamic subtest fds: SUCCESS (5.555s)
[138.981759] Starting dynamic subtest: userptr
[140.859413] Dynamic subtest userptr: SUCCESS (1.910s)
[140.868104] Subtest engines: SUCCESS (13.783s)
[141.149712] [027/162] (911s left) gem_exec_store (basic)
[141.237187] Starting subtest: basic
[141.360397] Subtest basic: SUCCESS (0.144s)
[141.588949] [028/162] (910s left) gem_flink_basic (bad-flink)
[141.658342] Starting subtest: bad-flink
[141.664750] Subtest bad-flink: SUCCESS (0.000s)
[141.770947] [029/162] (910s left) gem_flink_basic (bad-open)
[141.835123] Starting subtest: bad-open
[141.847244] Subtest bad-open: SUCCESS (0.000s)
[141.955269] [030/162] (910s left) gem_flink_basic (basic)
[142.016566] Starting subtest: basic
[142.022889] Subtest basic: SUCCESS (0.000s)
[142.159231] [031/162] (910s left) gem_flink_basic (double-flink)
[142.224075] Starting subtest: double-flink
[142.237463] Subtest double-flink: SUCCESS (0.000s)
[142.404649] [032/162] (910s left) gem_flink_basic (flink-lifetime)
[142.494879] Starting subtest: flink-lifetime
[142.508218] Subtest flink-lifetime: SUCCESS (0.001s)
[142.644888] [033/162] (909s left) gem_huc_copy (huc-copy)
[142.730787] Starting subtest: huc-copy
[142.737104] Subtest huc-copy: SUCCESS (0.005s)
[142.925044] [034/162] (909s left) gem_linear_blits (basic)
[143.071719] Starting subtest: basic
[143.094985] Subtest basic: SUCCESS (0.019s)
[143.312700] [035/162] (909s left) gem_mmap (basic)
[143.440637] Subtest basic: SKIP (0.000s)
[143.509164] [036/162] (909s left) gem_mmap_gtt (basic)
[143.600467] Subtest basic: SKIP (0.000s)
[143.665084] [037/162] (909s left) gem_render_linear_blits (basic)
[143.735353] Starting subtest: basic
[143.793026] Subtest basic: SUCCESS (0.053s)
[143.893021] [038/162] (909s left) gem_render_tiled_blits (basic)
[143.975608] Subtest basic: SKIP (0.000s)
[144.049897] [039/162] (908s left) gem_ringfill (basic-all)
[149.873622] Starting subtest: basic-all
[151.031463] Subtest basic-all: SUCCESS (1.171s)
[151.212276] [040/162] (901s left) gem_softpin (allocator-basic)
[151.300918] Starting subtest: allocator-basic
[151.360338] Subtest allocator-basic: SUCCESS (0.081s)
[151.602686] [041/162] (901s left) gem_softpin (allocator-basic-reserve)
[151.684370] Starting subtest: allocator-basic-reserve
[151.752769] Subtest allocator-basic-reserve: SUCCESS (0.086s)
[151.990848] [042/162] (901s left) gem_softpin (safe-alignment)
[152.071840] Starting subtest: safe-alignment
[152.101236] Subtest safe-alignment: SUCCESS (0.043s)
[153.918682] [043/162] (899s left) gem_sync (basic-all)
[154.054921] Starting subtest: basic-all
[157.824813] Subtest basic-all: SUCCESS (3.830s)
[158.124110] [044/162] (895s left) gem_sync (basic-each)
[158.284863] Starting subtest: basic-each
[160.561806] Subtest basic-each: SUCCESS (2.363s)
[160.829788] [045/162] (892s left) gem_tiled_blits (basic)
[160.928788] Subtest basic: SKIP (0.000s)
[161.030760] [046/162] (892s left) gem_tiled_fence_blits (basic)
[161.121126] Subtest basic: SKIP (0.000s)
[161.267685] [047/162] (892s left) gem_tiled_pread_basic
[161.438605] [048/162] (892s left) gem_wait (busy@all-engines)
[161.522168] Starting subtest: busy
[161.531806] Starting dynamic subtest: all-engines
[162.855072] Dynamic subtest all-engines: SUCCESS (1.333s)
[162.867211] Subtest busy: SUCCESS (1.334s)
[163.129658] [049/162] (890s left) gem_wait (wait@all-engines)
[163.216931] Starting subtest: wait
[163.223409] Starting dynamic subtest: all-engines
[164.841057] Dynamic subtest all-engines: SUCCESS (1.623s)
[164.849629] Subtest wait: SUCCESS (1.623s)
[165.072495] [050/162] (888s left) i915_getparams_basic (basic-eu-total)
[165.160812] Starting subtest: basic-eu-total
[165.182976] Subtest basic-eu-total: SUCCESS (0.000s)
[165.265401] [051/162] (888s left) i915_getparams_basic (basic-subslice-total)
[165.329678] Starting subtest: basic-subslice-total
[165.342345] Subtest basic-subslice-total: SUCCESS (0.000s)
[165.428769] [052/162] (888s left) i915_hangman (error-state-basic)
[165.480838] Starting subtest: error-state-basic
[165.629475] Subtest error-state-basic: SUCCESS (0.144s)
[165.768688] [053/162] (888s left) i915_pciid
[165.924896] [054/162] (888s left) intel_hwmon (hwmon-read)
[165.977879] Subtest hwmon-read: SKIP (0.000s)
[166.039160] [055/162] (888s left) intel_hwmon (hwmon-write)
[166.105565] Subtest hwmon-write: SKIP (0.000s)
[166.178146] [056/162] (888s left) kms_addfb_basic (addfb25-4-tiled)
[166.291285] Starting subtest: addfb25-4-tiled
[166.297571] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[166.448946] [057/162] (887s left) kms_addfb_basic (addfb25-bad-modifier)
[166.521373] Starting subtest: addfb25-bad-modifier
[166.537883] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[166.713534] [058/162] (887s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[166.826085] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[166.959580] [059/162] (887s left) kms_addfb_basic (addfb25-modifier-no-flag)
[167.052706] Starting subtest: addfb25-modifier-no-flag
[167.065911] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[167.215702] [060/162] (887s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[167.307902] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[167.453946] [061/162] (887s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[167.537453] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[167.684602] [062/162] (887s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[167.774871] Starting subtest: addfb25-yf-tiled-legacy
[167.782519] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[167.939532] [063/162] (886s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[168.049652] Starting subtest: addfb25-y-tiled-legacy
[168.055907] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[168.197483] [064/162] (886s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[168.290152] Starting subtest: addfb25-y-tiled-small-legacy
[168.312118] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[168.440740] [065/162] (886s left) kms_addfb_basic (bad-pitch-0)
[168.505600] Starting subtest: bad-pitch-0
[168.513232] Subtest bad-pitch-0: SUCCESS (0.000s)
[168.686465] [066/162] (886s left) kms_addfb_basic (bad-pitch-1024)
[168.758243] Starting subtest: bad-pitch-1024
[168.774773] Subtest bad-pitch-1024: SUCCESS (0.000s)
[168.941601] [067/162] (886s left) kms_addfb_basic (bad-pitch-128)
[169.008755] Starting subtest: bad-pitch-128
[169.015039] Subtest bad-pitch-128: SUCCESS (0.000s)
[169.175114] [068/162] (885s left) kms_addfb_basic (bad-pitch-256)
[169.245475] Starting subtest: bad-pitch-256
[169.258667] Subtest bad-pitch-256: SUCCESS (0.000s)
[169.417217] [069/162] (885s left) kms_addfb_basic (bad-pitch-32)
[169.470261] Starting subtest: bad-pitch-32
[169.477200] Subtest bad-pitch-32: SUCCESS (0.000s)
[169.659170] [070/162] (885s left) kms_addfb_basic (bad-pitch-63)
[169.712795] Starting subtest: bad-pitch-63
[169.719688] Subtest bad-pitch-63: SUCCESS (0.000s)
[169.905525] [071/162] (885s left) kms_addfb_basic (bad-pitch-65536)
[169.962570] Starting subtest: bad-pitch-65536
[169.969335] Subtest bad-pitch-65536: SUCCESS (0.000s)
[170.129208] [072/162] (885s left) kms_addfb_basic (bad-pitch-999)
[170.201632] Starting subtest: bad-pitch-999
[170.212927] Subtest bad-pitch-999: SUCCESS (0.000s)
[170.370313] [073/162] (884s left) kms_addfb_basic (basic)
[170.447697] Starting subtest: basic
[170.459856] Subtest basic: SUCCESS (0.000s)
[170.621840] [074/162] (884s left) kms_addfb_basic (basic-x-tiled-legacy)
[170.692877] Starting subtest: basic-x-tiled-legacy
[170.711521] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[170.870752] [075/162] (884s left) kms_addfb_basic (basic-y-tiled-legacy)
[170.948540] Starting subtest: basic-y-tiled-legacy
[170.967608] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[171.108904] [076/162] (884s left) kms_addfb_basic (bo-too-small)
[171.188948] Starting subtest: bo-too-small
[171.198119] Subtest bo-too-small: SUCCESS (0.000s)
[171.383487] [077/162] (884s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[171.473574] Starting subtest: bo-too-small-due-to-tiling
[171.487911] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[171.621663] [078/162] (884s left) kms_addfb_basic (clobberred-modifier)
[171.675712] Starting subtest: clobberred-modifier
[171.688427] Subtest clobberred-modifier: SKIP (0.000s)
[171.844766] [079/162] (883s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[171.898138] Starting subtest: framebuffer-vs-set-tiling
[171.910834] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[172.064160] [080/162] (883s left) kms_addfb_basic (invalid-get-prop)
[172.116787] Starting subtest: invalid-get-prop
[172.123257] Subtest invalid-get-prop: SUCCESS (0.000s)
[172.296144] [081/162] (883s left) kms_addfb_basic (invalid-get-prop-any)
[172.357492] Starting subtest: invalid-get-prop-any
[172.364323] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[172.498075] [082/162] (883s left) kms_addfb_basic (invalid-set-prop)
[172.552194] Starting subtest: invalid-set-prop
[172.558564] Subtest invalid-set-prop: SUCCESS (0.000s)
[172.696311] [083/162] (883s left) kms_addfb_basic (invalid-set-prop-any)
[172.748849] Starting subtest: invalid-set-prop-any
[172.755626] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[172.926256] [084/162] (883s left) kms_addfb_basic (no-handle)
[172.977354] Starting subtest: no-handle
[172.983839] Subtest no-handle: SUCCESS (0.000s)
[173.150570] [085/162] (882s left) kms_addfb_basic (size-max)
[173.238496] Starting subtest: size-max
[173.244868] Subtest size-max: SUCCESS (0.000s)
[173.395773] [086/162] (882s left) kms_addfb_basic (small-bo)
[173.490898] Starting subtest: small-bo
[173.507379] Subtest small-bo: SUCCESS (0.000s)
[173.645209] [087/162] (882s left) kms_addfb_basic (tile-pitch-mismatch)
[173.716655] Starting subtest: tile-pitch-mismatch
[173.739359] Subtest tile-pitch-mismatch: SKIP (0.000s)
[173.887280] [088/162] (882s left) kms_addfb_basic (too-high)
[173.977746] Starting subtest: too-high
[173.984214] Subtest too-high: SUCCESS (0.000s)
[174.171839] [089/162] (882s left) kms_addfb_basic (too-wide)
[174.260258] Starting subtest: too-wide
[174.272468] Subtest too-wide: SUCCESS (0.000s)
[174.430963] [090/162] (881s left) kms_addfb_basic (unused-handle)
[174.502839] Starting subtest: unused-handle
[174.519376] Subtest unused-handle: SUCCESS (0.000s)
[174.681553] [091/162] (881s left) kms_addfb_basic (unused-modifier)
[174.747066] Starting subtest: unused-modifier
[174.753599] Subtest unused-modifier: SUCCESS (0.000s)
[174.943929] [092/162] (881s left) kms_addfb_basic (unused-offsets)
[175.024690] Starting subtest: unused-offsets
[175.033562] Subtest unused-offsets: SUCCESS (0.000s)
[175.183417] [093/162] (881s left) kms_addfb_basic (unused-pitches)
[175.256728] Starting subtest: unused-pitches
[175.273085] Subtest unused-pitches: SUCCESS (0.000s)
[175.444218] [094/162] (881s left) kms_busy (basic)
[175.526797] Starting subtest: basic
[175.539583] Starting dynamic subtest: flip
[176.261862] Dynamic subtest flip: SUCCESS (0.723s)
[176.305539] Starting dynamic subtest: modeset
[179.662474] Dynamic subtest modeset: SUCCESS (3.401s)
[179.679412] Subtest basic: SUCCESS (4.126s)
[180.532570] [095/162] (876s left) kms_prop_blob (basic)
[180.606715] Starting subtest: basic
[180.620151] Subtest basic: SUCCESS (0.000s)
[180.788974] [096/162] (876s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[180.907596] Starting subtest: basic-busy-flip-before-cursor-atomic
[180.920777] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[181.178951] [097/162] (875s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[181.312070] Starting subtest: basic-busy-flip-before-cursor-legacy
[181.334777] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[181.498472] [098/162] (875s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[181.616638] Starting subtest: basic-flip-after-cursor-atomic
[182.823917] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.213s)
[183.740321] [099/162] (873s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[183.858920] Starting subtest: basic-flip-after-cursor-legacy
[185.064191] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.212s)
[185.964703] [100/162] (871s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[186.084100] Starting subtest: basic-flip-after-cursor-varying-size
[187.290243] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.214s)
[188.202695] [101/162] (868s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[188.322349] Starting subtest: basic-flip-before-cursor-atomic
[189.530889] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.213s)
[190.459182] [102/162] (866s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[190.584145] Starting subtest: basic-flip-before-cursor-legacy
[191.801919] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.213s)
[192.764114] [103/162] (864s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[192.902138] Starting subtest: basic-flip-before-cursor-varying-size
[194.149660] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.245s)
[194.996018] [104/162] (862s left) kms_dsc (dsc-basic)
[195.090156] Starting subtest: dsc-basic
[195.155318] Subtest dsc-basic: SKIP (0.001s)
[195.223217] [105/162] (862s left) kms_flip (basic-flip-vs-dpms)
[195.326170] Starting subtest: basic-flip-vs-dpms
[195.332423] Starting dynamic subtest: A-eDP1
[197.949452] Dynamic subtest A-eDP1: SUCCESS (2.625s)
[197.968695] Starting dynamic subtest: B-eDP1
[200.112587] Dynamic subtest B-eDP1: SUCCESS (2.166s)
[200.131746] Starting dynamic subtest: C-eDP1
[202.284028] Dynamic subtest C-eDP1: SUCCESS (2.173s)
[202.301664] Starting dynamic subtest: D-eDP1
[204.454090] Dynamic subtest D-eDP1: SUCCESS (2.169s)
[204.470463] Subtest basic-flip-vs-dpms: SUCCESS (9.141s)
[205.295723] [106/162] (852s left) kms_flip (basic-flip-vs-modeset)
[205.393043] Starting subtest: basic-flip-vs-modeset
[205.399695] Starting dynamic subtest: A-eDP1
[207.986767] Dynamic subtest A-eDP1: SUCCESS (2.590s)
[208.008711] Starting dynamic subtest: B-eDP1
[210.242036] Dynamic subtest B-eDP1: SUCCESS (2.257s)
[210.263402] Starting dynamic subtest: C-eDP1
[212.432988] Dynamic subtest C-eDP1: SUCCESS (2.190s)
[212.454910] Starting dynamic subtest: D-eDP1
[214.698605] Dynamic subtest D-eDP1: SUCCESS (2.262s)
[214.705409] Subtest basic-flip-vs-modeset: SUCCESS (9.313s)
[215.563085] [107/162] (842s left) kms_flip (basic-flip-vs-wf_vblank)
[215.648365] Starting subtest: basic-flip-vs-wf_vblank
[215.654805] Starting dynamic subtest: A-eDP1
[217.697777] Dynamic subtest A-eDP1: SUCCESS (2.055s)
[217.717245] Starting dynamic subtest: B-eDP1
[219.736479] Dynamic subtest B-eDP1: SUCCESS (2.037s)
[219.756599] Starting dynamic subtest: C-eDP1
[221.761590] Dynamic subtest C-eDP1: SUCCESS (2.018s)
[221.780759] Starting dynamic subtest: D-eDP1
[223.797413] Dynamic subtest D-eDP1: SUCCESS (2.034s)
[223.803968] Subtest basic-flip-vs-wf_vblank: SUCCESS (8.157s)
[225.147397] [108/162] (832s left) kms_flip (basic-plain-flip)
[225.230598] Starting subtest: basic-plain-flip
[225.236979] Starting dynamic subtest: A-eDP1
[226.925101] Dynamic subtest A-eDP1: SUCCESS (1.700s)
[226.944363] Starting dynamic subtest: B-eDP1
[228.636766] Dynamic subtest B-eDP1: SUCCESS (1.710s)
[228.656406] Starting dynamic subtest: C-eDP1
[230.354135] Dynamic subtest C-eDP1: SUCCESS (1.709s)
[230.373466] Starting dynamic subtest: D-eDP1
[232.110398] Dynamic subtest D-eDP1: SUCCESS (1.747s)
[232.116496] Subtest basic-plain-flip: SUCCESS (6.878s)
[233.424804] [109/162] (824s left) kms_force_connector_basic (force-connector-state)
[233.512374] Starting subtest: force-connector-state
[234.095626] Subtest force-connector-state: SUCCESS (0.595s)
[235.137287] [110/162] (822s left) kms_force_connector_basic (force-edid)
[235.198348] Starting subtest: force-edid
[235.491874] Subtest force-edid: SUCCESS (0.291s)
[235.703962] [111/162] (822s left) kms_force_connector_basic (force-load-detect)
[235.783904] Starting subtest: force-load-detect
[235.801979] Subtest force-load-detect: SKIP (0.000s)
[235.961883] [112/162] (822s left) kms_force_connector_basic (prune-stale-modes)
[236.029028] Starting subtest: prune-stale-modes
[236.387540] Subtest prune-stale-modes: SUCCESS (0.358s)
[236.558907] [113/162] (821s left) kms_frontbuffer_tracking (basic)
[236.652828] Starting subtest: basic
[242.031228] Subtest basic: SUCCESS (5.386s)
[242.233889] [114/162] (815s left) kms_hdmi_inject (inject-audio)
[242.580284] Starting subtest: inject-audio
[242.833919] Subtest inject-audio: SUCCESS (0.249s)
[243.478237] [115/162] (814s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[243.551108] Starting subtest: compare-crc-sanitycheck-xr24
[243.558240] Starting dynamic subtest: pipe-A-eDP-1
[244.271100] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.720s)
[244.284734] Starting dynamic subtest: pipe-B-eDP-1
[245.622328] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.347s)
[245.640150] Starting dynamic subtest: pipe-C-eDP-1
[246.958302] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.333s)
[246.976017] Starting dynamic subtest: pipe-D-eDP-1
[248.220537] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.263s)
[248.226747] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.671s)
[249.136452] [116/162] (809s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[249.213523] Starting subtest: compare-crc-sanitycheck-nv12
[249.220173] Starting dynamic subtest: pipe-A-eDP-1
[250.133047] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.918s)
[250.146789] Starting dynamic subtest: pipe-B-eDP-1
[251.600374] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.464s)
[251.613683] Starting dynamic subtest: pipe-C-eDP-1
[252.904787] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.300s)
[252.922793] Starting dynamic subtest: pipe-D-eDP-1
[254.234702] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.314s)
[254.241259] Subtest compare-crc-sanitycheck-nv12: SUCCESS (5.007s)
[255.159478] [117/162] (803s left) kms_pipe_crc_basic (hang-read-crc)
[255.245503] Starting subtest: hang-read-crc
[255.256243] Starting dynamic subtest: pipe-A-eDP-1
[257.633985] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.385s)
[257.648907] Starting dynamic subtest: pipe-B-eDP-1
[260.824749] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.193s)
[260.842659] Starting dynamic subtest: pipe-C-eDP-1
[263.835530] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.007s)
[263.853206] Starting dynamic subtest: pipe-D-eDP-1
[266.874060] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.036s)
[266.890779] Subtest hang-read-crc: SUCCESS (11.631s)
[267.750304] [118/162] (790s left) kms_pipe_crc_basic (nonblocking-crc)
[267.823464] Starting subtest: nonblocking-crc
[267.829716] Starting dynamic subtest: pipe-A-eDP-1
[268.707478] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.882s)
[268.720494] Starting dynamic subtest: pipe-B-eDP-1
[270.338908] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.629s)
[270.356599] Starting dynamic subtest: pipe-C-eDP-1
[271.932075] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.589s)
[271.949855] Starting dynamic subtest: pipe-D-eDP-1
[273.535405] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.603s)
[273.541525] Subtest nonblocking-crc: SUCCESS (5.712s)
[274.459111] [119/162] (783s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[274.553151] Starting subtest: nonblocking-crc-frame-sequence
[274.570349] Starting dynamic subtest: pipe-A-eDP-1
[275.433459] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.886s)
[275.454280] Starting dynamic subtest: pipe-B-eDP-1
[277.145720] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.714s)
[277.167239] Starting dynamic subtest: pipe-C-eDP-1
[278.718854] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.568s)
[278.739637] Starting dynamic subtest: pipe-D-eDP-1
[280.324830] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.604s)
[280.341106] Subtest nonblocking-crc-frame-sequence: SUCCESS (5.781s)
[281.275168] [120/162] (777s left) kms_pipe_crc_basic (read-crc)
[281.365694] Starting subtest: read-crc
[281.372037] Starting dynamic subtest: pipe-A-eDP-1
[282.169859] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.810s)
[282.187776] Starting dynamic subtest: pipe-B-eDP-1
[283.611750] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.441s)
[283.629537] Starting dynamic subtest: pipe-C-eDP-1
[285.060459] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.447s)
[285.079925] Starting dynamic subtest: pipe-D-eDP-1
[286.464517] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.404s)
[286.472112] Subtest read-crc: SUCCESS (5.109s)
[287.346211] [121/162] (771s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[287.434991] Starting subtest: read-crc-frame-sequence
[287.441896] Starting dynamic subtest: pipe-A-eDP-1
[288.247982] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.813s)
[288.267991] Starting dynamic subtest: pipe-B-eDP-1
[289.716503] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.462s)
[289.743757] Starting dynamic subtest: pipe-C-eDP-1
[291.144899] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.428s)
[291.166571] Starting dynamic subtest: pipe-D-eDP-1
[292.546938] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.404s)
[292.563397] Subtest read-crc-frame-sequence: SUCCESS (5.113s)
[293.469647] [122/162] (765s left) kms_pm_backlight (basic-brightness)
[293.547399] Starting subtest: basic-brightness
[293.618603] Starting dynamic subtest: eDP-1
[293.945880] Dynamic subtest eDP-1: SUCCESS (0.331s)
[293.952620] Subtest basic-brightness: SUCCESS (0.396s)
[294.881567] [123/162] (763s left) kms_pm_rpm (basic-pci-d3-state)
[296.950485] Starting subtest: basic-pci-d3-state
[298.598191] Subtest basic-pci-d3-state: SUCCESS (1.649s)
[298.787538] [124/162] (760s left) kms_pm_rpm (basic-rte)
[298.839847] Starting subtest: basic-rte
[302.440912] Subtest basic-rte: SUCCESS (3.598s)
[304.395243] [125/162] (754s left) kms_psr (psr-primary-page-flip)
[304.482268] Starting subtest: psr-primary-page-flip
[304.493944] Starting dynamic subtest: eDP-1
[306.399973] Dynamic subtest eDP-1: SUCCESS (1.915s)
[306.406449] Subtest psr-primary-page-flip: SUCCESS (1.917s)
[307.246571] [126/162] (751s left) kms_psr (psr-cursor-plane-move)
[307.318065] Starting subtest: psr-cursor-plane-move
[307.324644] Starting dynamic subtest: eDP-1
[309.199123] Dynamic subtest eDP-1: SUCCESS (1.875s)
[309.205623] Subtest psr-cursor-plane-move: SUCCESS (1.876s)
[310.037605] [127/162] (749s left) kms_psr (psr-sprite-plane-onoff)
[310.128755] Starting subtest: psr-sprite-plane-onoff
[310.135261] Starting dynamic subtest: eDP-1
[312.034746] Dynamic subtest eDP-1: SUCCESS (1.912s)
[312.041750] Subtest psr-sprite-plane-onoff: SUCCESS (1.913s)
[312.931142] [128/162] (746s left) kms_psr (psr-primary-mmap-gtt)
[313.006252] Starting subtest: psr-primary-mmap-gtt
[313.013032] Starting dynamic subtest: eDP-1
[314.594441] Dynamic subtest eDP-1: SKIP (1.573s)
[314.607323] Subtest psr-primary-mmap-gtt: SKIP (1.575s)
[314.807923] [129/162] (744s left) kms_setmode (basic-clone-single-crtc)
[314.896640] Starting subtest: basic-clone-single-crtc
[314.931116] Subtest basic-clone-single-crtc: SKIP (0.000s)
[314.998878] [130/162] (744s left) i915_pm_rps (basic-api)
[315.067087] Starting subtest: basic-api
[315.090306] Subtest basic-api: SKIP (0.001s)
[315.201528] [131/162] (744s left) prime_self_import (basic-llseek-bad)
[315.262781] Starting subtest: basic-llseek-bad
[315.282283] Subtest basic-llseek-bad: SUCCESS (0.002s)
[315.508979] [132/162] (743s left) prime_self_import (basic-llseek-size)
[315.588100] Starting subtest: basic-llseek-size
[315.610161] Subtest basic-llseek-size: SUCCESS (0.004s)
[315.744187] [133/162] (743s left) prime_self_import (basic-with_fd_dup)
[315.810301] Starting subtest: basic-with_fd_dup
[315.832361] Subtest basic-with_fd_dup: SUCCESS (0.002s)
[315.969329] [134/162] (743s left) prime_self_import (basic-with_one_bo)
[316.038851] Starting subtest: basic-with_one_bo
[316.061869] Subtest basic-with_one_bo: SUCCESS (0.002s)
[316.273028] [135/162] (743s left) prime_self_import (basic-with_one_bo_two_files)
[316.339120] Starting subtest: basic-with_one_bo_two_files
[316.359712] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s)
[316.529618] [136/162] (743s left) prime_self_import (basic-with_two_bos)
[316.605510] Starting subtest: basic-with_two_bos
[316.627476] Subtest basic-with_two_bos: SUCCESS (0.002s)
[316.769843] [137/162] (743s left) prime_vgem (basic-fence-flip)
[316.834126] Starting subtest: basic-fence-flip
[317.263569] Subtest basic-fence-flip: SUCCESS (0.440s)
[317.453974] [138/162] (742s left) prime_vgem (basic-fence-mmap)
[317.546145] Starting subtest: basic-fence-mmap
[317.559533] Subtest basic-fence-mmap: SKIP (0.000s)
[317.793312] [139/162] (742s left) prime_vgem (basic-fence-read)
[317.881659] Starting subtest: basic-fence-read
[317.910122] Subtest basic-fence-read: SKIP (0.018s)
[318.063054] [140/162] (742s left) prime_vgem (basic-gtt)
[318.146562] Starting subtest: basic-gtt
[318.167253] Subtest basic-gtt: SKIP (0.000s)
[318.306743] [141/162] (742s left) prime_vgem (basic-read)
[318.399014] Starting subtest: basic-read
[318.417508] Subtest basic-read: SKIP (0.011s)
[318.551092] [142/162] (741s left) prime_vgem (basic-write)
[318.624740] Starting subtest: basic-write
[318.643619] Subtest basic-write: SKIP (0.011s)
[318.808269] [143/162] (741s left) vgem_basic (setversion)
[318.891389] Starting subtest: setversion
[318.903721] Subtest setversion: SUCCESS (0.000s)
[318.985275] [144/162] (741s left) vgem_basic (create)
[319.051617] Starting subtest: create
[319.057786] Subtest create: SUCCESS (0.000s)
[319.157583] [145/162] (741s left) vgem_basic (debugfs)
[319.236697] Starting subtest: debugfs
[319.242935] Subtest debugfs: SUCCESS (0.000s)
[319.336208] [146/162] (741s left) vgem_basic (dmabuf-export)
[319.405182] Starting subtest: dmabuf-export
[319.424480] Subtest dmabuf-export: SUCCESS (0.003s)
[319.571583] [147/162] (741s left) vgem_basic (dmabuf-fence)
[319.655703] Starting subtest: dmabuf-fence
[319.672306] Subtest dmabuf-fence: SUCCESS (0.000s)
[319.755742] [148/162] (741s left) vgem_basic (dmabuf-fence-before)
[319.839461] Starting subtest: dmabuf-fence-before
[319.845678] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[319.946850] [149/162] (740s left) vgem_basic (dmabuf-mmap)
[320.034019] Starting subtest: dmabuf-mmap
[320.040184] Subtest dmabuf-mmap: SUCCESS (0.019s)
[320.151576] [150/162] (740s left) vgem_basic (mmap)
[320.221966] Starting subtest: mmap
[320.235362] Subtest mmap: SUCCESS (0.012s)
[320.337459] [151/162] (740s left) vgem_basic (second-client)
[320.426984] Starting subtest: second-client
[320.455988] Subtest second-client: SUCCESS (0.033s)
[320.570060] [152/162] (740s left) vgem_basic (sysfs)
[320.657544] Starting subtest: sysfs
[320.663681] Subtest sysfs: SUCCESS (0.000s)
[320.772469] [153/162] (740s left) core_hotunplug (unbind-rebind)
[320.890275] Starting subtest: unbind-rebind
[327.192362] Subtest unbind-rebind: SUCCESS (6.320s)
[327.272121] [154/162] (733s left) vgem_basic (unload)
[327.348203] Starting subtest: unload
[356.500487] Subtest unload: SUCCESS (29.144s)
[357.155618] [155/162] (704s left) i915_module_load (reload)
[357.423064] Starting subtest: reload
[363.704454] Subtest reload: SUCCESS (6.297s)
[363.846938] [156/162] (697s left) gem_lmem_swapping (basic)
[363.998093] Subtest basic: SKIP (0.000s)
[364.145935] [157/162] (697s left) gem_lmem_swapping (parallel-random-engines)
[364.261775] Subtest parallel-random-engines: SKIP (0.000s)
[364.388200] [158/162] (697s left) gem_lmem_swapping (random-engines)
[364.527996] Subtest random-engines: SKIP (0.000s)
[364.653520] [159/162] (697s left) gem_lmem_swapping (verify-random)
[364.794103] Subtest verify-random: SKIP (0.000s)
[364.925182] [160/162] (697s left) i915_pm_rpm (module-reload)
[367.361257] Starting subtest: module-reload
[386.305412] Subtest module-reload: SUCCESS (18.938s)
[386.368290] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[386.369842] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[386.380745] [161/162] (675s left) i915_selftest (live)
[386.491855] Starting subtest: live
[386.505052] Starting dynamic subtest: sanitycheck
[391.671286] Dynamic subtest sanitycheck: SUCCESS (5.174s)
[391.693208] Starting dynamic subtest: uncore
[396.930883] Dynamic subtest uncore: SUCCESS (5.268s)
[396.946786] Starting dynamic subtest: workarounds
[402.379386] Dynamic subtest workarounds: SUCCESS (5.447s)
[402.394789] Starting dynamic subtest: gt_engines
[406.994967] Dynamic subtest gt_engines: SUCCESS (4.614s)
[407.010401] Starting dynamic subtest: gt_timelines
[425.004237] Dynamic subtest gt_timelines: SUCCESS (18.001s)
[425.024787] Starting dynamic subtest: gt_contexts
[429.350675] Dynamic subtest gt_contexts: SUCCESS (4.345s)
[429.371033] Starting dynamic subtest: gt_lrc
[435.633161] Dynamic subtest gt_lrc: SUCCESS (6.280s)
[435.652056] Starting dynamic subtest: gt_mocs
[439.200512] Dynamic subtest gt_mocs: SUCCESS (3.568s)
[439.220439] Starting dynamic subtest: gt_pm
[443.974926] Dynamic subtest gt_pm: SUCCESS (4.770s)
[443.990093] Starting dynamic subtest: gt_heartbeat
[446.683473] Dynamic subtest gt_heartbeat: SUCCESS (2.700s)
[446.704352] Starting dynamic subtest: gt_tlb
[456.076513] Dynamic subtest gt_tlb: SUCCESS (9.399s)
[456.096334] Starting dynamic subtest: requests