[29.786739] Initializing watchdogs
[29.786798]   /dev/watchdog0
[29.802346] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d51 Intel Meteorlake (Gen12) 
[29.819362] [001/162] (960s left) i915_module_load (load)
[29.940265] Starting subtest: load
[32.441132] Subtest load: SUCCESS (2.503s)
[32.508907] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[32.510960] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[32.521892] [002/162] (957s left) core_auth (basic-auth)
[33.875083] Starting subtest: basic-auth
[33.881700] Subtest basic-auth: SUCCESS (0.002s)
[34.041581] [003/162] (956s left) core_debugfs (read-all-entries)
[34.171442] Starting subtest: read-all-entries
[34.320632] Subtest read-all-entries: SUCCESS (0.171s)
[34.410168] [004/162] (956s left) core_sysfs (read-all-entries)
[34.484812] Starting subtest: read-all-entries
[34.501163] Subtest read-all-entries: SUCCESS (0.004s)
[34.561724] [005/162] (956s left) fbdev (eof)
[34.627763] Starting subtest: eof
[34.635903] Subtest eof: SUCCESS (0.000s)
[34.725889] [006/162] (955s left) fbdev (info)
[34.789517] Starting subtest: info
[34.801095] Subtest info: SUCCESS (0.000s)
[34.879632] [007/162] (955s left) fbdev (nullptr)
[34.947182] Starting subtest: nullptr
[34.953243] Subtest nullptr: SUCCESS (0.000s)
[35.028133] [008/162] (955s left) fbdev (read)
[35.100859] Starting subtest: read
[36.015038] Subtest read: SUCCESS (0.905s)
[36.102212] [009/162] (954s left) fbdev (write)
[36.153349] Starting subtest: write
[36.744121] Subtest write: SUCCESS (0.582s)
[36.870914] [010/162] (954s left) gem_basic (bad-close)
[36.954971] Starting subtest: bad-close
[36.977660] Subtest bad-close: SUCCESS (0.000s)
[37.059132] [011/162] (953s left) gem_basic (create-close)
[37.133271] Starting subtest: create-close
[37.155778] Subtest create-close: SUCCESS (0.000s)
[37.255618] [012/162] (953s left) gem_basic (create-fd-close)
[37.345163] Starting subtest: create-fd-close
[37.367881] Subtest create-fd-close: SUCCESS (0.000s)
[37.436227] [013/162] (953s left) gem_busy (busy@all-engines)
[37.512451] Starting subtest: busy
[37.518878] Starting dynamic subtest: all-engines
[37.553527] Dynamic subtest all-engines: SUCCESS (0.043s)
[37.560310] Subtest busy: SUCCESS (0.043s)
[38.909950] [014/162] (952s left) gem_close_race (basic-process)
[38.986199] Starting subtest: basic-process
[39.033314] Subtest basic-process: SUCCESS (0.049s)
[39.247107] [015/162] (952s left) gem_close_race (basic-threads)
[39.324133] Starting subtest: basic-threads
[40.551245] Subtest basic-threads: SUCCESS (1.235s)
[40.766478] [016/162] (950s left) gem_ctx_create (basic)
[40.828446] Starting subtest: basic
[40.835037] Subtest basic: SUCCESS (0.000s)
[41.025156] [017/162] (950s left) gem_ctx_create (basic-files)
[41.080102] Starting subtest: basic-files
[43.384330] Subtest basic-files: SUCCESS (2.294s)
[44.942027] [018/162] (946s left) gem_ctx_exec (basic)
[45.000601] Starting subtest: basic
[45.006903] Subtest basic: SUCCESS (0.008s)
[45.115077] [019/162] (946s left) gem_exec_basic (basic)
[45.169948] Starting subtest: basic
[45.176687] Starting dynamic subtest: rcs0-smem
[45.183312] Dynamic subtest rcs0-smem: SUCCESS (0.005s)
[45.199156] Starting dynamic subtest: bcs0-smem
[45.205644] Dynamic subtest bcs0-smem: SUCCESS (0.005s)
[45.221155] Starting dynamic subtest: vcs0-smem
[45.227751] Dynamic subtest vcs0-smem: SUCCESS (0.005s)
[45.243660] Starting dynamic subtest: vcs1-smem
[45.250251] Dynamic subtest vcs1-smem: SUCCESS (0.003s)
[45.267122] Starting dynamic subtest: vecs0-smem
[45.273918] Dynamic subtest vecs0-smem: SUCCESS (0.003s)
[45.289600] Starting dynamic subtest: ccs0-smem
[45.296127] Dynamic subtest ccs0-smem: SUCCESS (0.003s)
[45.302900] Subtest basic: SUCCESS (0.027s)
[46.955946] [020/162] (944s left) gem_exec_create (basic)
[47.019037] Starting subtest: basic
[47.025098] Starting dynamic subtest: smem
[50.846877] Dynamic subtest smem: SUCCESS (3.950s)
[50.854606] Subtest basic: SUCCESS (3.950s)
[51.043508] [021/162] (940s left) gem_exec_fence (basic-busy)
[51.225291] Starting subtest: basic-busy
[51.241537] Starting dynamic subtest: rcs0
[51.285597] Dynamic subtest rcs0: SUCCESS (0.063s)
[51.319118] Starting dynamic subtest: bcs0
[51.341709] Dynamic subtest bcs0: SUCCESS (0.052s)
[51.376364] Starting dynamic subtest: vcs0
[51.399097] Dynamic subtest vcs0: SUCCESS (0.051s)
[51.432150] Starting dynamic subtest: vcs1
[51.454821] Dynamic subtest vcs1: SUCCESS (0.051s)
[51.489492] Starting dynamic subtest: vecs0
[51.512177] Dynamic subtest vecs0: SUCCESS (0.049s)
[51.545632] Starting dynamic subtest: ccs0
[51.568208] Dynamic subtest ccs0: SUCCESS (0.052s)
[51.574664] Subtest basic-busy: SUCCESS (0.320s)
[52.945811] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[52.956706] [022/162] (938s left) gem_exec_fence (basic-wait)
[53.148121] Starting subtest: basic-wait
[53.156791] Starting dynamic subtest: rcs0
[53.215261] Dynamic subtest rcs0: SUCCESS (0.079s)
[53.234254] Starting dynamic subtest: bcs0
[53.271385] Dynamic subtest bcs0: SUCCESS (0.053s)
[53.282970] Starting dynamic subtest: vcs0
[53.320813] Dynamic subtest vcs0: SUCCESS (0.050s)
[53.340880] Starting dynamic subtest: vcs1
[53.365435] Dynamic subtest vcs1: SUCCESS (0.050s)
[53.384721] Starting dynamic subtest: vecs0
[53.415701] Dynamic subtest vecs0: SUCCESS (0.050s)
[53.430533] Starting dynamic subtest: ccs0
[53.468106] Dynamic subtest ccs0: SUCCESS (0.052s)
[53.474271] Subtest basic-wait: SUCCESS (0.335s)
[54.943787] [023/162] (936s left) gem_exec_fence (basic-await)
[55.131393] Starting subtest: basic-await
[55.142879] Starting dynamic subtest: rcs0
[55.216787] Dynamic subtest rcs0: SUCCESS (0.095s)
[55.235868] Starting dynamic subtest: bcs0
[55.307322] Dynamic subtest bcs0: SUCCESS (0.089s)
[55.323029] Starting dynamic subtest: vcs0
[55.398990] Dynamic subtest vcs0: SUCCESS (0.088s)
[55.415025] Starting dynamic subtest: vcs1
[55.479063] Dynamic subtest vcs1: SUCCESS (0.081s)
[55.500899] Starting dynamic subtest: vecs0
[55.555067] Dynamic subtest vecs0: SUCCESS (0.076s)
[55.575639] Starting dynamic subtest: ccs0
[55.634334] Dynamic subtest ccs0: SUCCESS (0.079s)
[55.640432] Subtest basic-await: SUCCESS (0.510s)
[57.955710] [024/162] (933s left) gem_exec_fence (nb-await)
[58.135509] Starting subtest: nb-await
[58.148827] Starting dynamic subtest: rcs0
[58.221486] Dynamic subtest rcs0: SUCCESS (0.083s)
[58.239135] Starting dynamic subtest: bcs0
[58.275915] Dynamic subtest bcs0: SUCCESS (0.060s)
[58.295592] Starting dynamic subtest: vcs0
[58.343440] Dynamic subtest vcs0: SUCCESS (0.062s)
[58.361124] Starting dynamic subtest: vcs1
[58.396544] Dynamic subtest vcs1: SUCCESS (0.059s)
[58.415899] Starting dynamic subtest: vecs0
[58.464024] Dynamic subtest vecs0: SUCCESS (0.062s)
[58.481718] Starting dynamic subtest: ccs0
[58.518415] Dynamic subtest ccs0: SUCCESS (0.061s)
[58.528792] Subtest nb-await: SUCCESS (0.388s)
[59.912942] [025/162] (932s left) gem_exec_gttfill (basic)
[59.981153] Starting subtest: basic
[64.219663] Subtest basic: SUCCESS (4.263s)
[64.425986] [026/162] (927s left) gem_exec_parallel (engines)
[64.505906] Starting subtest: engines
[64.512930] Starting dynamic subtest: basic
[67.870854] Dynamic subtest basic: SUCCESS (3.369s)
[67.883144] Starting dynamic subtest: contexts
[72.409881] Dynamic subtest contexts: SUCCESS (4.547s)
[72.427322] Starting dynamic subtest: fds
[77.896262] Dynamic subtest fds: SUCCESS (5.489s)
[77.917573] Starting dynamic subtest: userptr
[79.864719] Dynamic subtest userptr: SUCCESS (1.961s)
[79.871246] Subtest engines: SUCCESS (15.367s)
[80.075692] [027/162] (912s left) gem_exec_store (basic)
[80.192245] Starting subtest: basic
[80.256167] Subtest basic: SUCCESS (0.111s)
[80.467029] [028/162] (911s left) gem_flink_basic (bad-flink)
[80.541403] Starting subtest: bad-flink
[80.554747] Subtest bad-flink: SUCCESS (0.000s)
[80.632428] [029/162] (911s left) gem_flink_basic (bad-open)
[80.702108] Starting subtest: bad-open
[80.711967] Subtest bad-open: SUCCESS (0.000s)
[80.817162] [030/162] (911s left) gem_flink_basic (basic)
[80.903567] Starting subtest: basic
[80.910179] Subtest basic: SUCCESS (0.000s)
[80.998936] [031/162] (911s left) gem_flink_basic (double-flink)
[81.074625] Starting subtest: double-flink
[81.091141] Subtest double-flink: SUCCESS (0.000s)
[81.162695] [032/162] (911s left) gem_flink_basic (flink-lifetime)
[81.217687] Starting subtest: flink-lifetime
[81.224182] Subtest flink-lifetime: SUCCESS (0.001s)
[81.313035] [033/162] (911s left) gem_huc_copy (huc-copy)
[81.363399] Starting subtest: huc-copy
[81.369838] Subtest huc-copy: SUCCESS (0.005s)
[81.523939] [034/162] (911s left) gem_linear_blits (basic)
[81.675744] Starting subtest: basic
[81.692397] Subtest basic: SUCCESS (0.017s)
[81.829695] [035/162] (910s left) gem_mmap (basic)
[81.914525] Subtest basic: SKIP (0.000s)
[81.988729] [036/162] (910s left) gem_mmap_gtt (basic)
[82.077011] Subtest basic: SKIP (0.000s)
[82.140174] [037/162] (910s left) gem_render_linear_blits (basic)
[82.206290] Starting subtest: basic
[82.256075] Subtest basic: SUCCESS (0.044s)
[82.355840] [038/162] (910s left) gem_render_tiled_blits (basic)
[82.438379] Subtest basic: SKIP (0.000s)
[82.499972] [039/162] (910s left) gem_ringfill (basic-all)
[87.855129] Starting subtest: basic-all
[89.014035] Subtest basic-all: SUCCESS (1.172s)
[89.187951] [040/162] (903s left) gem_softpin (allocator-basic)
[89.279323] Starting subtest: allocator-basic
[89.348281] Subtest allocator-basic: SUCCESS (0.091s)
[89.527795] [041/162] (903s left) gem_softpin (allocator-basic-reserve)
[89.602760] Starting subtest: allocator-basic-reserve
[89.683359] Subtest allocator-basic-reserve: SUCCESS (0.090s)
[89.831196] [042/162] (903s left) gem_softpin (safe-alignment)
[89.910944] Starting subtest: safe-alignment
[89.930093] Subtest safe-alignment: SUCCESS (0.035s)
[91.869833] [043/162] (901s left) gem_sync (basic-all)
[92.034523] Starting subtest: basic-all
[95.301298] Subtest basic-all: SUCCESS (3.368s)
[95.530118] [044/162] (897s left) gem_sync (basic-each)
[95.689317] Starting subtest: basic-each
[98.193490] Subtest basic-each: SUCCESS (2.586s)
[98.403560] [045/162] (894s left) gem_tiled_blits (basic)
[98.495354] Subtest basic: SKIP (0.000s)
[98.570311] [046/162] (894s left) gem_tiled_fence_blits (basic)
[98.656432] Subtest basic: SKIP (0.000s)
[98.725214] [047/162] (894s left) gem_tiled_pread_basic (basic)
[98.815832] Subtest basic: SKIP (0.000s)
[98.878647] [048/162] (894s left) gem_wait (busy@all-engines)
[98.962073] Starting subtest: busy
[98.968305] Starting dynamic subtest: all-engines
[100.835428] Dynamic subtest all-engines: SUCCESS (1.876s)
[100.845377] Subtest busy: SUCCESS (1.876s)
[101.081385] [049/162] (892s left) gem_wait (wait@all-engines)
[101.163496] Starting subtest: wait
[101.169607] Starting dynamic subtest: all-engines
[102.814620] Dynamic subtest all-engines: SUCCESS (1.655s)
[102.821282] Subtest wait: SUCCESS (1.655s)
[103.054392] [050/162] (890s left) i915_getparams_basic (basic-eu-total)
[103.110963] Starting subtest: basic-eu-total
[103.123283] Subtest basic-eu-total: SUCCESS (0.000s)
[103.187787] [051/162] (890s left) i915_getparams_basic (basic-subslice-total)
[103.247645] Starting subtest: basic-subslice-total
[103.260297] Subtest basic-subslice-total: SUCCESS (0.000s)
[103.334190] [052/162] (890s left) i915_hangman (error-state-basic)
[103.389818] Starting subtest: error-state-basic
[103.525109] Subtest error-state-basic: SUCCESS (0.135s)
[103.640137] [053/162] (890s left) i915_pciid
[103.771341] [054/162] (890s left) intel_hwmon (hwmon-read)
[103.833533] Subtest hwmon-read: SKIP (0.000s)
[103.898470] [055/162] (890s left) intel_hwmon (hwmon-write)
[103.958487] Subtest hwmon-write: SKIP (0.000s)
[104.009488] [056/162] (890s left) kms_addfb_basic (addfb25-4-tiled)
[104.098064] Starting subtest: addfb25-4-tiled
[104.104404] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[104.222178] [057/162] (889s left) kms_addfb_basic (addfb25-bad-modifier)
[104.305539] Starting subtest: addfb25-bad-modifier
[104.322123] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[104.428902] [058/162] (889s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[104.532922] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[104.652944] [059/162] (889s left) kms_addfb_basic (addfb25-modifier-no-flag)
[104.738692] Starting subtest: addfb25-modifier-no-flag
[104.748562] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[104.855176] [060/162] (889s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[104.948011] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[105.050784] [061/162] (889s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[105.147911] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[105.265591] [062/162] (889s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[105.381339] Starting subtest: addfb25-yf-tiled-legacy
[105.387812] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[105.468690] [063/162] (889s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[105.570717] Starting subtest: addfb25-y-tiled-legacy
[105.579546] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[105.684713] [064/162] (888s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[105.792857] Starting subtest: addfb25-y-tiled-small-legacy
[105.815955] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[105.888108] [065/162] (888s left) kms_addfb_basic (bad-pitch-0)
[105.963098] Starting subtest: bad-pitch-0
[105.979539] Subtest bad-pitch-0: SUCCESS (0.000s)
[106.111888] [066/162] (888s left) kms_addfb_basic (bad-pitch-1024)
[106.202277] Starting subtest: bad-pitch-1024
[106.208791] Subtest bad-pitch-1024: SUCCESS (0.000s)
[106.312226] [067/162] (888s left) kms_addfb_basic (bad-pitch-128)
[106.391609] Starting subtest: bad-pitch-128
[106.400372] Subtest bad-pitch-128: SUCCESS (0.000s)
[106.521024] [068/162] (888s left) kms_addfb_basic (bad-pitch-256)
[106.611242] Starting subtest: bad-pitch-256
[106.624604] Subtest bad-pitch-256: SUCCESS (0.000s)
[106.757550] [069/162] (888s left) kms_addfb_basic (bad-pitch-32)
[106.844499] Starting subtest: bad-pitch-32
[106.850797] Subtest bad-pitch-32: SUCCESS (0.000s)
[106.968415] [070/162] (887s left) kms_addfb_basic (bad-pitch-63)
[107.047762] Starting subtest: bad-pitch-63
[107.056723] Subtest bad-pitch-63: SUCCESS (0.000s)
[107.172100] [071/162] (887s left) kms_addfb_basic (bad-pitch-65536)
[107.239985] Starting subtest: bad-pitch-65536
[107.251762] Subtest bad-pitch-65536: SUCCESS (0.000s)
[107.419333] [072/162] (887s left) kms_addfb_basic (bad-pitch-999)
[107.491935] Starting subtest: bad-pitch-999
[107.498195] Subtest bad-pitch-999: SUCCESS (0.000s)
[107.656348] [073/162] (887s left) kms_addfb_basic (basic)
[107.739103] Starting subtest: basic
[107.750859] Subtest basic: SUCCESS (0.000s)
[107.866901] [074/162] (887s left) kms_addfb_basic (basic-x-tiled-legacy)
[107.941491] Starting subtest: basic-x-tiled-legacy
[107.960524] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[108.067578] [075/162] (887s left) kms_addfb_basic (basic-y-tiled-legacy)
[108.139764] Starting subtest: basic-y-tiled-legacy
[108.157948] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[108.261387] [076/162] (887s left) kms_addfb_basic (bo-too-small)
[108.337838] Starting subtest: bo-too-small
[108.344614] Subtest bo-too-small: SUCCESS (0.000s)
[108.459563] [077/162] (886s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[108.532420] Starting subtest: bo-too-small-due-to-tiling
[108.544821] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[108.620372] [078/162] (886s left) kms_addfb_basic (clobberred-modifier)
[108.676656] Starting subtest: clobberred-modifier
[108.689943] Subtest clobberred-modifier: SKIP (0.000s)
[108.818314] [079/162] (886s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[108.879401] Starting subtest: framebuffer-vs-set-tiling
[108.892136] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[109.006927] [080/162] (886s left) kms_addfb_basic (invalid-get-prop)
[109.063517] Starting subtest: invalid-get-prop
[109.069949] Subtest invalid-get-prop: SUCCESS (0.000s)
[109.215690] [081/162] (886s left) kms_addfb_basic (invalid-get-prop-any)
[109.290640] Starting subtest: invalid-get-prop-any
[109.307195] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[109.449917] [082/162] (886s left) kms_addfb_basic (invalid-set-prop)
[109.522019] Starting subtest: invalid-set-prop
[109.538647] Subtest invalid-set-prop: SUCCESS (0.000s)
[109.666877] [083/162] (886s left) kms_addfb_basic (invalid-set-prop-any)
[109.741442] Starting subtest: invalid-set-prop-any
[109.757929] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[109.870273] [084/162] (885s left) kms_addfb_basic (no-handle)
[109.941851] Starting subtest: no-handle
[109.958657] Subtest no-handle: SUCCESS (0.000s)
[110.095941] [085/162] (885s left) kms_addfb_basic (size-max)
[110.193773] Starting subtest: size-max
[110.210249] Subtest size-max: SUCCESS (0.000s)
[110.325776] [086/162] (885s left) kms_addfb_basic (small-bo)
[110.413741] Starting subtest: small-bo
[110.427079] Subtest small-bo: SUCCESS (0.000s)
[110.544818] [087/162] (885s left) kms_addfb_basic (tile-pitch-mismatch)
[110.607735] Starting subtest: tile-pitch-mismatch
[110.620052] Subtest tile-pitch-mismatch: SKIP (0.000s)
[110.742959] [088/162] (885s left) kms_addfb_basic (too-high)
[110.840776] Starting subtest: too-high
[110.857242] Subtest too-high: SUCCESS (0.000s)
[110.951143] [089/162] (885s left) kms_addfb_basic (too-wide)
[111.022845] Starting subtest: too-wide
[111.035732] Subtest too-wide: SUCCESS (0.000s)
[111.139119] [090/162] (885s left) kms_addfb_basic (unused-handle)
[111.214881] Starting subtest: unused-handle
[111.231556] Subtest unused-handle: SUCCESS (0.000s)
[111.353807] [091/162] (884s left) kms_addfb_basic (unused-modifier)
[111.423023] Starting subtest: unused-modifier
[111.429461] Subtest unused-modifier: SUCCESS (0.000s)
[111.581781] [092/162] (884s left) kms_addfb_basic (unused-offsets)
[111.658110] Starting subtest: unused-offsets
[111.669673] Subtest unused-offsets: SUCCESS (0.000s)
[111.785314] [093/162] (884s left) kms_addfb_basic (unused-pitches)
[111.859915] Starting subtest: unused-pitches
[111.876441] Subtest unused-pitches: SUCCESS (0.000s)
[111.991623] [094/162] (884s left) kms_busy (basic)
[112.079010] Starting subtest: basic
[112.085345] Starting dynamic subtest: flip
[112.869584] Dynamic subtest flip: SUCCESS (0.797s)
[112.889785] Starting dynamic subtest: modeset
[116.424902] Dynamic subtest modeset: SUCCESS (3.540s)
[116.434622] Subtest basic: SUCCESS (4.340s)
[117.352165] [095/162] (879s left) kms_prop_blob (basic)
[117.435691] Starting subtest: basic
[117.445397] Subtest basic: SUCCESS (0.000s)
[117.634298] [096/162] (879s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[117.785090] Starting subtest: basic-busy-flip-before-cursor-atomic
[117.807127] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[117.944835] [097/162] (878s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[118.057927] Starting subtest: basic-busy-flip-before-cursor-legacy
[118.070490] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[118.192581] [098/162] (878s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[118.307997] Starting subtest: basic-flip-after-cursor-atomic
[119.544561] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.239s)
[120.455343] [099/162] (876s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[120.586321] Starting subtest: basic-flip-after-cursor-legacy
[121.785175] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.205s)
[122.697644] [100/162] (874s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[122.822270] Starting subtest: basic-flip-after-cursor-varying-size
[124.042108] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.222s)
[124.940338] [101/162] (872s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[125.070519] Starting subtest: basic-flip-before-cursor-atomic
[126.308559] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.247s)
[127.215774] [102/162] (869s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[127.342929] Starting subtest: basic-flip-before-cursor-legacy
[128.562498] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.224s)
[129.450071] [103/162] (867s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[129.566928] Starting subtest: basic-flip-before-cursor-varying-size
[130.784851] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.208s)
[131.657721] [104/162] (865s left) kms_dsc (dsc-basic)
[131.737877] Starting subtest: dsc-basic
[131.774503] Subtest dsc-basic: SKIP (0.000s)
[131.824162] [105/162] (865s left) kms_flip (basic-flip-vs-dpms)
[131.904200] Starting subtest: basic-flip-vs-dpms
[131.910318] Starting dynamic subtest: A-eDP1
[134.546238] Dynamic subtest A-eDP1: SUCCESS (2.639s)
[134.560322] Starting dynamic subtest: B-eDP1
[136.712466] Dynamic subtest B-eDP1: SUCCESS (2.166s)
[136.728533] Starting dynamic subtest: C-eDP1
[138.878268] Dynamic subtest C-eDP1: SUCCESS (2.167s)
[138.894310] Starting dynamic subtest: D-eDP1
[141.053254] Dynamic subtest D-eDP1: SUCCESS (2.172s)
[141.059933] Subtest basic-flip-vs-dpms: SUCCESS (9.152s)
[141.869487] [106/162] (855s left) kms_flip (basic-flip-vs-modeset)
[141.954577] Starting subtest: basic-flip-vs-modeset
[141.964507] Starting dynamic subtest: A-eDP1
[144.553307] Dynamic subtest A-eDP1: SUCCESS (2.598s)
[144.565934] Starting dynamic subtest: B-eDP1
[146.726754] Dynamic subtest B-eDP1: SUCCESS (2.172s)
[146.746963] Starting dynamic subtest: C-eDP1
[148.905153] Dynamic subtest C-eDP1: SUCCESS (2.172s)
[148.926888] Starting dynamic subtest: D-eDP1
[151.069238] Dynamic subtest D-eDP1: SUCCESS (2.165s)
[151.078938] Subtest basic-flip-vs-modeset: SUCCESS (9.116s)
[151.916635] [107/162] (845s left) kms_flip (basic-flip-vs-wf_vblank)
[152.010867] Starting subtest: basic-flip-vs-wf_vblank
[152.017212] Starting dynamic subtest: A-eDP1
[153.973303] Dynamic subtest A-eDP1: SUCCESS (1.972s)
[153.986810] Starting dynamic subtest: B-eDP1
[155.908756] Dynamic subtest B-eDP1: SUCCESS (1.939s)
[155.922207] Starting dynamic subtest: C-eDP1
[157.853375] Dynamic subtest C-eDP1: SUCCESS (1.930s)
[157.869659] Starting dynamic subtest: D-eDP1
[159.784078] Dynamic subtest D-eDP1: SUCCESS (1.929s)
[159.790663] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.778s)
[160.975514] [108/162] (836s left) kms_flip (basic-plain-flip)
[161.066603] Starting subtest: basic-plain-flip
[161.073656] Starting dynamic subtest: A-eDP1
[162.766560] Dynamic subtest A-eDP1: SUCCESS (1.707s)
[162.786669] Starting dynamic subtest: B-eDP1
[164.516927] Dynamic subtest B-eDP1: SUCCESS (1.742s)
[164.540066] Starting dynamic subtest: C-eDP1
[166.238955] Dynamic subtest C-eDP1: SUCCESS (1.716s)
[166.268659] Starting dynamic subtest: D-eDP1
[167.977276] Dynamic subtest D-eDP1: SUCCESS (1.733s)
[167.986088] Subtest basic-plain-flip: SUCCESS (6.910s)
[169.304196] [109/162] (828s left) kms_force_connector_basic (force-connector-state)
[169.400424] Starting subtest: force-connector-state
[169.980979] Subtest force-connector-state: SUCCESS (0.604s)
[170.997032] [110/162] (826s left) kms_force_connector_basic (force-edid)
[171.082041] Starting subtest: force-edid
[171.363066] Subtest force-edid: SUCCESS (0.291s)
[171.515346] [111/162] (826s left) kms_force_connector_basic (force-load-detect)
[171.590450] Starting subtest: force-load-detect
[171.606675] Subtest force-load-detect: SKIP (0.000s)
[171.749972] [112/162] (826s left) kms_force_connector_basic (prune-stale-modes)
[171.826033] Starting subtest: prune-stale-modes
[172.184789] Subtest prune-stale-modes: SUCCESS (0.356s)
[172.330544] [113/162] (825s left) kms_frontbuffer_tracking (basic)
[172.435661] Starting subtest: basic
[177.811080] Subtest basic: SUCCESS (5.386s)
[177.945778] [114/162] (820s left) kms_hdmi_inject (inject-audio)
[178.308012] Starting subtest: inject-audio
[178.563198] Subtest inject-audio: SUCCESS (0.252s)
[179.229627] [115/162] (818s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[179.323614] Starting subtest: compare-crc-sanitycheck-xr24
[179.336730] Starting dynamic subtest: pipe-A-eDP-1
[180.044121] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.735s)
[180.056990] Starting dynamic subtest: pipe-B-eDP-1
[181.397605] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.342s)
[181.415301] Starting dynamic subtest: pipe-C-eDP-1
[182.718102] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.318s)
[182.735768] Starting dynamic subtest: pipe-D-eDP-1
[184.035324] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.314s)
[184.048716] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.716s)
[184.888474] [116/162] (813s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[184.978083] Starting subtest: compare-crc-sanitycheck-nv12
[184.990612] Starting dynamic subtest: pipe-A-eDP-1
[185.899424] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.925s)
[185.917268] Starting dynamic subtest: pipe-B-eDP-1
[187.354685] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.451s)
[187.367987] Starting dynamic subtest: pipe-C-eDP-1
[188.697337] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.336s)
[188.710682] Starting dynamic subtest: pipe-D-eDP-1
[190.096252] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.387s)
[190.102772] Subtest compare-crc-sanitycheck-nv12: SUCCESS (5.110s)
[190.908468] [117/162] (807s left) kms_pipe_crc_basic (hang-read-crc)
[191.007227] Starting subtest: hang-read-crc
[191.023596] Starting dynamic subtest: pipe-A-eDP-1
[193.584386] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.590s)
[193.602048] Starting dynamic subtest: pipe-B-eDP-1
[196.695127] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.096s)
[196.716877] Starting dynamic subtest: pipe-C-eDP-1
[199.661659] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.962s)
[199.681041] Starting dynamic subtest: pipe-D-eDP-1
[202.606546] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.955s)
[202.623118] Subtest hang-read-crc: SUCCESS (11.613s)
[203.515384] [118/162] (794s left) kms_pipe_crc_basic (nonblocking-crc)
[203.603255] Starting subtest: nonblocking-crc
[203.609507] Starting dynamic subtest: pipe-A-eDP-1
[204.482082] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.871s)
[204.499644] Starting dynamic subtest: pipe-B-eDP-1
[205.947917] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.465s)
[205.965691] Starting dynamic subtest: pipe-C-eDP-1
[207.375738] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.436s)
[207.388722] Starting dynamic subtest: pipe-D-eDP-1
[208.907109] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.520s)
[208.923496] Subtest nonblocking-crc: SUCCESS (5.298s)
[209.828185] [119/162] (788s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[209.920820] Starting subtest: nonblocking-crc-frame-sequence
[209.927027] Starting dynamic subtest: pipe-A-eDP-1
[210.786020] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.872s)
[210.799223] Starting dynamic subtest: pipe-B-eDP-1
[212.346476] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.551s)
[212.360637] Starting dynamic subtest: pipe-C-eDP-1
[213.809125] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.465s)
[213.825009] Starting dynamic subtest: pipe-D-eDP-1
[215.313370] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.501s)
[215.329804] Subtest nonblocking-crc-frame-sequence: SUCCESS (5.395s)
[216.203542] [120/162] (782s left) kms_pipe_crc_basic (read-crc)
[216.302938] Starting subtest: read-crc
[216.319528] Starting dynamic subtest: pipe-A-eDP-1
[217.101008] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.808s)
[217.124790] Starting dynamic subtest: pipe-B-eDP-1
[218.605683] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.505s)
[218.619036] Starting dynamic subtest: pipe-C-eDP-1
[220.025417] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.409s)
[220.043075] Starting dynamic subtest: pipe-D-eDP-1
[221.416662] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.399s)
[221.423542] Subtest read-crc: SUCCESS (5.127s)
[222.298363] [121/162] (776s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[222.391181] Starting subtest: read-crc-frame-sequence
[222.397441] Starting dynamic subtest: pipe-A-eDP-1
[223.199981] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.808s)
[223.217761] Starting dynamic subtest: pipe-B-eDP-1
[224.693583] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.490s)
[224.711468] Starting dynamic subtest: pipe-C-eDP-1
[226.131905] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.443s)
[226.145561] Starting dynamic subtest: pipe-D-eDP-1
[227.524183] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.391s)
[227.531776] Subtest read-crc-frame-sequence: SUCCESS (5.138s)
[228.384283] [122/162] (770s left) kms_pm_backlight (basic-brightness)
[228.468939] Starting subtest: basic-brightness
[228.530415] Starting dynamic subtest: eDP-1
[228.854226] Dynamic subtest eDP-1: SUCCESS (0.327s)
[228.860884] Subtest basic-brightness: SUCCESS (0.389s)
[229.689205] [123/162] (768s left) kms_pm_rpm (basic-pci-d3-state)
[231.965303] Starting subtest: basic-pci-d3-state
[233.507107] Subtest basic-pci-d3-state: SUCCESS (1.534s)
[233.657573] [124/162] (764s left) kms_pm_rpm (basic-rte)
[233.719834] Starting subtest: basic-rte
[237.474232] Subtest basic-rte: SUCCESS (3.752s)
[239.118776] [125/162] (759s left) kms_psr (psr-primary-page-flip)
[239.214527] Starting subtest: psr-primary-page-flip
[239.223584] Starting dynamic subtest: eDP-1
[241.181327] Dynamic subtest eDP-1: SUCCESS (1.965s)
[241.197720] Subtest psr-primary-page-flip: SUCCESS (1.967s)
[242.008496] [126/162] (756s left) kms_psr (psr-cursor-plane-move)
[242.097500] Starting subtest: psr-cursor-plane-move
[242.105953] Starting dynamic subtest: eDP-1
[243.975191] Dynamic subtest eDP-1: SUCCESS (1.874s)
[243.991440] Subtest psr-cursor-plane-move: SUCCESS (1.875s)
[244.797417] [127/162] (754s left) kms_psr (psr-sprite-plane-onoff)
[244.889278] Starting subtest: psr-sprite-plane-onoff
[244.895556] Starting dynamic subtest: eDP-1
[246.815722] Dynamic subtest eDP-1: SUCCESS (1.927s)
[246.832070] Subtest psr-sprite-plane-onoff: SUCCESS (1.929s)
[247.697090] [128/162] (751s left) kms_psr (psr-primary-mmap-gtt)
[247.787847] Starting subtest: psr-primary-mmap-gtt
[247.803296] Starting dynamic subtest: eDP-1
[249.398954] Dynamic subtest eDP-1: SKIP (1.581s)
[249.420780] Subtest psr-primary-mmap-gtt: SKIP (1.583s)
[249.623508] [129/162] (749s left) kms_setmode (basic-clone-single-crtc)
[249.712306] Starting subtest: basic-clone-single-crtc
[249.741528] Subtest basic-clone-single-crtc: SKIP (0.000s)
[249.820734] [130/162] (749s left) i915_pm_rps (basic-api)
[249.910735] Starting subtest: basic-api
[249.932861] Subtest basic-api: SKIP (0.001s)
[250.019358] [131/162] (749s left) prime_self_import (basic-llseek-bad)
[250.081372] Starting subtest: basic-llseek-bad
[250.102357] Subtest basic-llseek-bad: SUCCESS (0.002s)
[250.207144] [132/162] (748s left) prime_self_import (basic-llseek-size)
[250.279880] Starting subtest: basic-llseek-size
[250.302333] Subtest basic-llseek-size: SUCCESS (0.002s)
[250.381644] [133/162] (748s left) prime_self_import (basic-with_fd_dup)
[250.455735] Starting subtest: basic-with_fd_dup
[250.478230] Subtest basic-with_fd_dup: SUCCESS (0.003s)
[250.577037] [134/162] (748s left) prime_self_import (basic-with_one_bo)
[250.643804] Starting subtest: basic-with_one_bo
[250.666448] Subtest basic-with_one_bo: SUCCESS (0.003s)
[250.769983] [135/162] (748s left) prime_self_import (basic-with_one_bo_two_files)
[250.825489] Starting subtest: basic-with_one_bo_two_files
[250.837754] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s)
[250.928181] [136/162] (748s left) prime_self_import (basic-with_two_bos)
[250.982273] Starting subtest: basic-with_two_bos
[250.994566] Subtest basic-with_two_bos: SUCCESS (0.003s)
[251.080529] [137/162] (748s left) prime_vgem (basic-fence-flip)
[251.148908] Starting subtest: basic-fence-flip
[251.585110] Subtest basic-fence-flip: SUCCESS (0.442s)
[251.764300] [138/162] (747s left) prime_vgem (basic-fence-mmap)
[251.875037] Starting subtest: basic-fence-mmap
[251.897659] Subtest basic-fence-mmap: SKIP (0.000s)
[251.994085] [139/162] (747s left) prime_vgem (basic-fence-read)
[252.091967] Starting subtest: basic-fence-read
[252.114680] Subtest basic-fence-read: SKIP (0.012s)
[252.196667] [140/162] (747s left) prime_vgem (basic-gtt)
[252.290267] Starting subtest: basic-gtt
[252.312978] Subtest basic-gtt: SKIP (0.000s)
[252.417684] [141/162] (747s left) prime_vgem (basic-read)
[252.522983] Starting subtest: basic-read
[252.539484] Subtest basic-read: SKIP (0.011s)
[252.665115] [142/162] (747s left) prime_vgem (basic-write)
[252.765692] Starting subtest: basic-write
[252.787676] Subtest basic-write: SKIP (0.011s)
[252.879991] [143/162] (747s left) vgem_basic (setversion)
[252.969064] Starting subtest: setversion
[252.991156] Subtest setversion: SUCCESS (0.000s)
[253.094941] [144/162] (746s left) vgem_basic (create)
[253.190325] Starting subtest: create
[253.206928] Subtest create: SUCCESS (0.000s)
[253.274100] [145/162] (746s left) vgem_basic (debugfs)
[253.355633] Starting subtest: debugfs
[253.368960] Subtest debugfs: SUCCESS (0.000s)
[253.439488] [146/162] (746s left) vgem_basic (dmabuf-export)
[253.530497] Starting subtest: dmabuf-export
[253.553703] Subtest dmabuf-export: SUCCESS (0.018s)
[253.669449] [147/162] (746s left) vgem_basic (dmabuf-fence)
[253.761343] Starting subtest: dmabuf-fence
[253.777936] Subtest dmabuf-fence: SUCCESS (0.000s)
[253.844154] [148/162] (746s left) vgem_basic (dmabuf-fence-before)
[253.933283] Starting subtest: dmabuf-fence-before
[253.946605] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[254.013736] [149/162] (746s left) vgem_basic (dmabuf-mmap)
[254.096559] Starting subtest: dmabuf-mmap
[254.103072] Subtest dmabuf-mmap: SUCCESS (0.019s)
[254.183208] [150/162] (746s left) vgem_basic (mmap)
[254.272981] Starting subtest: mmap
[254.279466] Subtest mmap: SUCCESS (0.012s)
[254.363765] [151/162] (746s left) vgem_basic (second-client)
[254.457240] Starting subtest: second-client
[254.496851] Subtest second-client: SUCCESS (0.033s)
[254.595859] [152/162] (746s left) vgem_basic (sysfs)
[254.688629] Starting subtest: sysfs
[254.701944] Subtest sysfs: SUCCESS (0.000s)
[254.801644] [153/162] (745s left) core_hotunplug (unbind-rebind)
[254.947533] Starting subtest: unbind-rebind
[261.035236] Subtest unbind-rebind: SUCCESS (6.096s)
[261.217685] [154/162] (739s left) vgem_basic (unload)
[261.287520] Starting subtest: unload
[290.268815] Subtest unload: SUCCESS (28.971s)
[290.442332] [155/162] (710s left) i915_module_load (reload)