[40.148920] Initializing watchdogs
[40.148972]   /dev/watchdog0
[40.164142] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d51 Intel Meteorlake (Gen12) 
[40.177300] [001/162] (960s left) i915_module_load (load)
[40.242783] Starting subtest: load
[42.876649] Subtest load: SUCCESS (2.645s)
[42.938052] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[42.939507] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[42.953996] [002/162] (957s left) core_auth (basic-auth)
[44.810177] Starting subtest: basic-auth
[44.816995] Subtest basic-auth: SUCCESS (0.002s)
[44.976026] [003/162] (955s left) core_debugfs (read-all-entries)
[45.077485] Starting subtest: read-all-entries
[45.233255] Subtest read-all-entries: SUCCESS (0.170s)
[45.390932] [004/162] (955s left) core_sysfs (read-all-entries)
[45.451685] Starting subtest: read-all-entries
[45.457987] Subtest read-all-entries: SUCCESS (0.004s)
[45.546220] [005/162] (955s left) fbdev (eof)
[45.597367] Starting subtest: eof
[45.604375] Subtest eof: SUCCESS (0.000s)
[45.750907] [006/162] (955s left) fbdev (info)
[45.810646] Starting subtest: info
[45.819533] Subtest info: SUCCESS (0.000s)
[46.018439] [007/162] (955s left) fbdev (nullptr)
[46.084300] Starting subtest: nullptr
[46.097435] Subtest nullptr: SUCCESS (0.000s)
[46.272912] [008/162] (955s left) fbdev (read)
[46.346938] Starting subtest: read
[47.213955] Subtest read: SUCCESS (0.862s)
[47.352380] [009/162] (954s left) fbdev (write)
[47.408140] Starting subtest: write
[48.015374] Subtest write: SUCCESS (0.601s)
[48.141266] [010/162] (953s left) gem_basic (bad-close)
[48.214461] Starting subtest: bad-close
[48.237645] Subtest bad-close: SUCCESS (0.000s)
[48.333891] [011/162] (953s left) gem_basic (create-close)
[48.407041] Starting subtest: create-close
[48.429902] Subtest create-close: SUCCESS (0.000s)
[48.571793] [012/162] (953s left) gem_basic (create-fd-close)
[48.645809] Starting subtest: create-fd-close
[48.666039] Subtest create-fd-close: SUCCESS (0.000s)
[48.806536] [013/162] (952s left) gem_busy (busy@all-engines)
[48.870055] Starting subtest: busy
[48.880654] Starting dynamic subtest: all-engines
[48.907128] Dynamic subtest all-engines: SUCCESS (0.043s)
[48.921128] Subtest busy: SUCCESS (0.044s)
[50.964634] [014/162] (950s left) gem_close_race (basic-process)
[51.072315] Starting subtest: basic-process
[51.127799] Subtest basic-process: SUCCESS (0.066s)
[51.394384] [015/162] (950s left) gem_close_race (basic-threads)
[51.487174] Starting subtest: basic-threads
[52.811098] Subtest basic-threads: SUCCESS (1.327s)
[53.062217] [016/162] (948s left) gem_ctx_create (basic)
[53.143321] Starting subtest: basic
[53.151594] Subtest basic: SUCCESS (0.000s)
[53.380061] [017/162] (948s left) gem_ctx_create (basic-files)
[53.450587] Starting subtest: basic-files
[55.455544] Subtest basic-files: SUCCESS (2.016s)
[55.920620] [018/162] (946s left) gem_ctx_exec (basic)
[55.976820] Starting subtest: basic
[55.983642] Subtest basic: SUCCESS (0.005s)
[56.177578] [019/162] (945s left) gem_exec_basic (basic)
[56.229160] Starting subtest: basic
[56.236016] Starting dynamic subtest: rcs0-smem
[56.242967] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[56.262848] Starting dynamic subtest: bcs0-smem
[56.269813] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[56.299128] Starting dynamic subtest: vcs0-smem
[56.305949] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[56.334546] Starting dynamic subtest: vcs1-smem
[56.342036] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[56.370265] Starting dynamic subtest: vecs0-smem
[56.377247] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[56.405603] Starting dynamic subtest: ccs0-smem
[56.412632] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[56.419553] Subtest basic: SUCCESS (0.011s)
[57.981814] [020/162] (944s left) gem_exec_create (basic)
[58.039878] Starting subtest: basic
[58.046399] Starting dynamic subtest: smem
[61.796366] Dynamic subtest smem: SUCCESS (3.749s)
[61.810304] Subtest basic: SUCCESS (3.749s)
[62.037725] [021/162] (940s left) gem_exec_fence (basic-busy)
[62.218785] Starting subtest: basic-busy
[62.234427] Starting dynamic subtest: rcs0
[62.310712] Dynamic subtest rcs0: SUCCESS (0.102s)
[62.330089] Starting dynamic subtest: bcs0
[62.376150] Dynamic subtest bcs0: SUCCESS (0.062s)
[62.395760] Starting dynamic subtest: vcs0
[62.442713] Dynamic subtest vcs0: SUCCESS (0.063s)
[62.460331] Starting dynamic subtest: vcs1
[62.498219] Dynamic subtest vcs1: SUCCESS (0.063s)
[62.511806] Starting dynamic subtest: vecs0
[62.556364] Dynamic subtest vecs0: SUCCESS (0.058s)
[62.575564] Starting dynamic subtest: ccs0
[62.621842] Dynamic subtest ccs0: SUCCESS (0.067s)
[62.632645] Subtest basic-busy: SUCCESS (0.415s)
[65.012155] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[65.027382] [022/162] (937s left) gem_exec_fence (basic-wait)
[65.214094] Starting subtest: basic-wait
[65.229858] Starting dynamic subtest: rcs0
[65.289384] Dynamic subtest rcs0: SUCCESS (0.077s)
[65.307325] Starting dynamic subtest: bcs0
[65.343405] Dynamic subtest bcs0: SUCCESS (0.060s)
[65.362935] Starting dynamic subtest: vcs0
[65.405308] Dynamic subtest vcs0: SUCCESS (0.061s)
[65.418173] Starting dynamic subtest: vcs1
[65.463201] Dynamic subtest vcs1: SUCCESS (0.062s)
[65.479158] Starting dynamic subtest: vecs0
[65.526018] Dynamic subtest vecs0: SUCCESS (0.058s)
[65.542054] Starting dynamic subtest: ccs0
[65.585636] Dynamic subtest ccs0: SUCCESS (0.060s)
[65.593603] Subtest basic-wait: SUCCESS (0.379s)
[67.273282] [023/162] (935s left) gem_exec_fence (basic-await)
[67.471342] Starting subtest: basic-await
[67.482071] Starting dynamic subtest: rcs0
[67.578410] Dynamic subtest rcs0: SUCCESS (0.113s)
[67.612245] Starting dynamic subtest: bcs0
[67.682140] Dynamic subtest bcs0: SUCCESS (0.096s)
[67.721257] Starting dynamic subtest: vcs0
[67.770543] Dynamic subtest vcs0: SUCCESS (0.094s)
[67.806839] Starting dynamic subtest: vcs1
[67.853977] Dynamic subtest vcs1: SUCCESS (0.082s)
[67.887086] Starting dynamic subtest: vecs0
[67.935417] Dynamic subtest vecs0: SUCCESS (0.086s)
[67.964240] Starting dynamic subtest: ccs0
[68.021313] Dynamic subtest ccs0: SUCCESS (0.085s)
[68.028508] Subtest basic-await: SUCCESS (0.560s)
[69.967764] [024/162] (932s left) gem_exec_fence (nb-await)
[70.139071] Starting subtest: nb-await
[70.155530] Starting dynamic subtest: rcs0
[70.246688] Dynamic subtest rcs0: SUCCESS (0.110s)
[70.271472] Starting dynamic subtest: bcs0
[70.317989] Dynamic subtest bcs0: SUCCESS (0.069s)
[70.337341] Starting dynamic subtest: vcs0
[70.389220] Dynamic subtest vcs0: SUCCESS (0.070s)
[70.413036] Starting dynamic subtest: vcs1
[70.456635] Dynamic subtest vcs1: SUCCESS (0.068s)
[70.480603] Starting dynamic subtest: vecs0
[70.527240] Dynamic subtest vecs0: SUCCESS (0.070s)
[70.550672] Starting dynamic subtest: ccs0
[70.595963] Dynamic subtest ccs0: SUCCESS (0.069s)
[70.602450] Subtest nb-await: SUCCESS (0.460s)
[72.068912] [025/162] (930s left) gem_exec_gttfill (basic)
[72.151965] Starting subtest: basic
[75.840626] Subtest basic: SUCCESS (3.697s)
[76.134355] [026/162] (926s left) gem_exec_parallel (engines)
[76.228031] Starting subtest: engines
[76.240673] Starting dynamic subtest: basic
[77.901894] Dynamic subtest basic: SUCCESS (1.679s)
[77.922574] Starting dynamic subtest: contexts
[82.369434] Dynamic subtest contexts: SUCCESS (4.457s)
[82.391072] Starting dynamic subtest: fds
[87.898060] Dynamic subtest fds: SUCCESS (5.536s)
[87.921691] Starting dynamic subtest: userptr
[89.830755] Dynamic subtest userptr: SUCCESS (1.925s)
[89.843919] Subtest engines: SUCCESS (13.599s)
[90.100771] [027/162] (912s left) gem_exec_store (basic)
[90.237342] Starting subtest: basic
[90.333362] Subtest basic: SUCCESS (0.158s)
[90.572610] [028/162] (912s left) gem_flink_basic (bad-flink)
[90.639721] Starting subtest: bad-flink
[90.656203] Subtest bad-flink: SUCCESS (0.000s)
[90.728208] [029/162] (912s left) gem_flink_basic (bad-open)
[90.775315] Starting subtest: bad-open
[90.781695] Subtest bad-open: SUCCESS (0.000s)
[90.878239] [030/162] (912s left) gem_flink_basic (basic)
[90.932341] Starting subtest: basic
[90.938760] Subtest basic: SUCCESS (0.000s)
[91.079025] [031/162] (911s left) gem_flink_basic (double-flink)
[91.131594] Starting subtest: double-flink
[91.138167] Subtest double-flink: SUCCESS (0.000s)
[91.278184] [032/162] (911s left) gem_flink_basic (flink-lifetime)
[91.330883] Starting subtest: flink-lifetime
[91.337787] Subtest flink-lifetime: SUCCESS (0.001s)
[91.506311] [033/162] (911s left) gem_huc_copy (huc-copy)
[91.568949] Starting subtest: huc-copy
[91.577551] Subtest huc-copy: SUCCESS (0.003s)
[91.776091] [034/162] (911s left) gem_linear_blits (basic)
[91.923408] Starting subtest: basic
[91.941020] Subtest basic: SUCCESS (0.021s)
[92.189859] [035/162] (911s left) gem_mmap (basic)
[92.286970] Subtest basic: SKIP (0.000s)
[92.349962] [036/162] (911s left) gem_mmap_gtt (basic)
[92.422140] Subtest basic: SKIP (0.000s)
[92.485266] [037/162] (910s left) gem_render_linear_blits (basic)
[92.539738] Starting subtest: basic
[92.579764] Subtest basic: SUCCESS (0.044s)
[92.703547] [038/162] (910s left) gem_render_tiled_blits (basic)
[92.773625] Subtest basic: SKIP (0.000s)
[92.830405] [039/162] (910s left) gem_ringfill (basic-all)
[98.864042] Starting subtest: basic-all
[100.029309] Subtest basic-all: SUCCESS (1.180s)
[100.238746] [040/162] (903s left) gem_softpin (allocator-basic)
[100.322992] Starting subtest: allocator-basic
[100.397380] Subtest allocator-basic: SUCCESS (0.091s)
[100.656694] [041/162] (903s left) gem_softpin (allocator-basic-reserve)
[100.722976] Starting subtest: allocator-basic-reserve
[100.798077] Subtest allocator-basic-reserve: SUCCESS (0.084s)
[101.013528] [042/162] (902s left) gem_softpin (safe-alignment)
[101.070146] Starting subtest: safe-alignment
[101.105441] Subtest safe-alignment: SUCCESS (0.037s)
[102.897187] [043/162] (900s left) gem_sync (basic-all)
[102.999358] Starting subtest: basic-all
[106.846853] Subtest basic-all: SUCCESS (3.885s)
[107.196450] [044/162] (896s left) gem_sync (basic-each)
[107.346388] Starting subtest: basic-each
[109.701261] Subtest basic-each: SUCCESS (2.432s)
[109.939533] [045/162] (894s left) gem_tiled_blits (basic)
[110.030567] Subtest basic: SKIP (0.000s)
[110.098587] [046/162] (894s left) gem_tiled_fence_blits (basic)
[110.192476] Subtest basic: SKIP (0.000s)
[110.268526] [047/162] (893s left) gem_tiled_pread_basic
[110.432066] [048/162] (893s left) gem_wait (busy@all-engines)
[110.503737] Starting subtest: busy
[110.516208] Starting dynamic subtest: all-engines
[111.846247] Dynamic subtest all-engines: SUCCESS (1.333s)
[111.859513] Subtest busy: SUCCESS (1.333s)
[112.109747] [049/162] (892s left) gem_wait (wait@all-engines)
[112.172862] Starting subtest: wait
[112.179264] Starting dynamic subtest: all-engines
[113.821652] Dynamic subtest all-engines: SUCCESS (1.646s)
[113.828025] Subtest wait: SUCCESS (1.647s)
[114.051070] [050/162] (890s left) i915_getparams_basic (basic-eu-total)
[114.104164] Starting subtest: basic-eu-total
[114.117086] Subtest basic-eu-total: SUCCESS (0.000s)
[114.220330] [051/162] (890s left) i915_getparams_basic (basic-subslice-total)
[114.273555] Starting subtest: basic-subslice-total
[114.285858] Subtest basic-subslice-total: SUCCESS (0.000s)
[114.396196] [052/162] (890s left) i915_hangman (error-state-basic)
[114.446297] Starting subtest: error-state-basic
[114.581777] Subtest error-state-basic: SUCCESS (0.129s)
[114.736516] [053/162] (889s left) i915_pciid
[114.961861] [054/162] (889s left) intel_hwmon (hwmon-read)
[115.030089] Subtest hwmon-read: SKIP (0.000s)
[115.091404] [055/162] (889s left) intel_hwmon (hwmon-write)
[115.157178] Subtest hwmon-write: SKIP (0.000s)
[115.234337] [056/162] (889s left) kms_addfb_basic (addfb25-4-tiled)
[115.347293] Starting subtest: addfb25-4-tiled
[115.353484] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[115.500917] [057/162] (889s left) kms_addfb_basic (addfb25-bad-modifier)
[115.596309] Starting subtest: addfb25-bad-modifier
[115.602496] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[115.747027] [058/162] (889s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[115.828104] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[115.981270] [059/162] (888s left) kms_addfb_basic (addfb25-modifier-no-flag)
[116.053711] Starting subtest: addfb25-modifier-no-flag
[116.059933] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[116.194138] [060/162] (888s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[116.273363] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[116.472301] [061/162] (888s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[116.555311] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[116.713062] [062/162] (888s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[116.796756] Starting subtest: addfb25-yf-tiled-legacy
[116.802874] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[116.912076] [063/162] (888s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[116.989868] Starting subtest: addfb25-y-tiled-legacy
[116.996051] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[117.152062] [064/162] (888s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[117.230254] Starting subtest: addfb25-y-tiled-small-legacy
[117.242566] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[117.379447] [065/162] (887s left) kms_addfb_basic (bad-pitch-0)
[117.436955] Starting subtest: bad-pitch-0
[117.443197] Subtest bad-pitch-0: SUCCESS (0.000s)
[117.608497] [066/162] (887s left) kms_addfb_basic (bad-pitch-1024)
[117.667662] Starting subtest: bad-pitch-1024
[117.673969] Subtest bad-pitch-1024: SUCCESS (0.000s)
[117.874975] [067/162] (887s left) kms_addfb_basic (bad-pitch-128)
[117.931519] Starting subtest: bad-pitch-128
[117.937942] Subtest bad-pitch-128: SUCCESS (0.000s)
[118.208171] [068/162] (887s left) kms_addfb_basic (bad-pitch-256)
[118.301130] Starting subtest: bad-pitch-256
[118.317631] Subtest bad-pitch-256: SUCCESS (0.000s)
[118.473160] [069/162] (887s left) kms_addfb_basic (bad-pitch-32)
[118.562614] Starting subtest: bad-pitch-32
[118.579017] Subtest bad-pitch-32: SUCCESS (0.000s)
[118.712733] [070/162] (886s left) kms_addfb_basic (bad-pitch-63)
[118.785640] Starting subtest: bad-pitch-63
[118.802129] Subtest bad-pitch-63: SUCCESS (0.000s)
[118.943255] [071/162] (886s left) kms_addfb_basic (bad-pitch-65536)
[119.024401] Starting subtest: bad-pitch-65536
[119.030907] Subtest bad-pitch-65536: SUCCESS (0.000s)
[119.201947] [072/162] (886s left) kms_addfb_basic (bad-pitch-999)
[119.295628] Starting subtest: bad-pitch-999
[119.305933] Subtest bad-pitch-999: SUCCESS (0.000s)
[119.444117] [073/162] (886s left) kms_addfb_basic (basic)
[119.505943] Starting subtest: basic
[119.514627] Subtest basic: SUCCESS (0.000s)
[119.662508] [074/162] (886s left) kms_addfb_basic (basic-x-tiled-legacy)
[119.741877] Starting subtest: basic-x-tiled-legacy
[119.763848] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[119.918666] [075/162] (886s left) kms_addfb_basic (basic-y-tiled-legacy)
[119.987390] Starting subtest: basic-y-tiled-legacy
[120.009388] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[120.164387] [076/162] (885s left) kms_addfb_basic (bo-too-small)
[120.259077] Starting subtest: bo-too-small
[120.275574] Subtest bo-too-small: SUCCESS (0.000s)
[120.420866] [077/162] (885s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[120.513950] Starting subtest: bo-too-small-due-to-tiling
[120.535982] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[120.699141] [078/162] (885s left) kms_addfb_basic (clobberred-modifier)
[120.786397] Starting subtest: clobberred-modifier
[120.809575] Subtest clobberred-modifier: SKIP (0.000s)
[120.971626] [079/162] (885s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[121.059128] Starting subtest: framebuffer-vs-set-tiling
[121.082523] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[121.321989] [080/162] (885s left) kms_addfb_basic (invalid-get-prop)
[121.407334] Starting subtest: invalid-get-prop
[121.413816] Subtest invalid-get-prop: SUCCESS (0.000s)
[121.663054] [081/162] (884s left) kms_addfb_basic (invalid-get-prop-any)
[121.720107] Starting subtest: invalid-get-prop-any
[121.726786] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[121.864458] [082/162] (884s left) kms_addfb_basic (invalid-set-prop)
[121.918739] Starting subtest: invalid-set-prop
[121.925204] Subtest invalid-set-prop: SUCCESS (0.000s)
[122.104769] [083/162] (884s left) kms_addfb_basic (invalid-set-prop-any)
[122.158215] Starting subtest: invalid-set-prop-any
[122.164710] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[122.346811] [084/162] (884s left) kms_addfb_basic (no-handle)
[122.406041] Starting subtest: no-handle
[122.412492] Subtest no-handle: SUCCESS (0.000s)
[122.586142] [085/162] (884s left) kms_addfb_basic (size-max)
[122.660074] Starting subtest: size-max
[122.666435] Subtest size-max: SUCCESS (0.000s)
[122.820224] [086/162] (883s left) kms_addfb_basic (small-bo)
[122.893757] Starting subtest: small-bo
[122.900052] Subtest small-bo: SUCCESS (0.000s)
[123.046085] [087/162] (883s left) kms_addfb_basic (tile-pitch-mismatch)
[123.098571] Starting subtest: tile-pitch-mismatch
[123.111229] Subtest tile-pitch-mismatch: SKIP (0.000s)
[123.290850] [088/162] (883s left) kms_addfb_basic (too-high)
[123.379084] Starting subtest: too-high
[123.392566] Subtest too-high: SUCCESS (0.000s)
[123.555474] [089/162] (883s left) kms_addfb_basic (too-wide)
[123.644252] Starting subtest: too-wide
[123.650563] Subtest too-wide: SUCCESS (0.000s)
[123.814211] [090/162] (883s left) kms_addfb_basic (unused-handle)
[123.885386] Starting subtest: unused-handle
[123.898556] Subtest unused-handle: SUCCESS (0.000s)
[124.067245] [091/162] (882s left) kms_addfb_basic (unused-modifier)
[124.148161] Starting subtest: unused-modifier
[124.154492] Subtest unused-modifier: SUCCESS (0.000s)
[124.316587] [092/162] (882s left) kms_addfb_basic (unused-offsets)
[124.395840] Starting subtest: unused-offsets
[124.404573] Subtest unused-offsets: SUCCESS (0.000s)
[124.565948] [093/162] (882s left) kms_addfb_basic (unused-pitches)
[124.645344] Starting subtest: unused-pitches
[124.654055] Subtest unused-pitches: SUCCESS (0.000s)
[124.823023] [094/162] (882s left) kms_busy (basic)
[124.922305] Starting subtest: basic
[124.939021] Starting dynamic subtest: flip
[125.680757] Dynamic subtest flip: SUCCESS (0.759s)
[125.698430] Starting dynamic subtest: modeset
[129.115096] Dynamic subtest modeset: SUCCESS (3.438s)
[129.131644] Subtest basic: SUCCESS (4.198s)
[129.972402] [095/162] (877s left) kms_prop_blob (basic)
[130.051679] Starting subtest: basic
[130.060341] Subtest basic: SUCCESS (0.000s)
[130.181017] [096/162] (877s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[130.304787] Starting subtest: basic-busy-flip-before-cursor-atomic
[130.323845] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[130.490417] [097/162] (876s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[130.608159] Starting subtest: basic-busy-flip-before-cursor-legacy
[130.624261] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[130.786592] [098/162] (876s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[130.905383] Starting subtest: basic-flip-after-cursor-atomic
[132.116271] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.212s)
[133.002721] [099/162] (874s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[133.128105] Starting subtest: basic-flip-after-cursor-legacy
[134.335148] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.211s)
[135.338475] [100/162] (872s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[135.476515] Starting subtest: basic-flip-after-cursor-varying-size
[136.717117] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.247s)
[137.596372] [101/162] (870s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[137.712364] Starting subtest: basic-flip-before-cursor-atomic
[138.939375] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.216s)
[139.796878] [102/162] (868s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[139.912806] Starting subtest: basic-flip-before-cursor-legacy
[141.144885] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.229s)
[142.057717] [103/162] (865s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[142.186141] Starting subtest: basic-flip-before-cursor-varying-size
[143.386431] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.205s)
[144.301378] [104/162] (863s left) kms_dsc (dsc-basic)
[144.395253] Starting subtest: dsc-basic
[144.461955] Subtest dsc-basic: SKIP (0.000s)
[144.622214] [105/162] (863s left) kms_flip (basic-flip-vs-dpms)
[144.726599] Starting subtest: basic-flip-vs-dpms
[144.733088] Starting dynamic subtest: A-eDP1
[147.322664] Dynamic subtest A-eDP1: SUCCESS (2.614s)
[147.341697] Starting dynamic subtest: B-eDP1
[149.486356] Dynamic subtest B-eDP1: SUCCESS (2.163s)
[149.505618] Starting dynamic subtest: C-eDP1
[151.653283] Dynamic subtest C-eDP1: SUCCESS (2.166s)
[151.672365] Starting dynamic subtest: D-eDP1
[153.834599] Dynamic subtest D-eDP1: SUCCESS (2.170s)
[153.851044] Subtest basic-flip-vs-dpms: SUCCESS (9.120s)
[154.706453] [106/162] (853s left) kms_flip (basic-flip-vs-modeset)
[154.810492] Starting subtest: basic-flip-vs-modeset
[154.819328] Starting dynamic subtest: A-eDP1
[157.426116] Dynamic subtest A-eDP1: SUCCESS (2.621s)
[157.447042] Starting dynamic subtest: B-eDP1
[159.589364] Dynamic subtest B-eDP1: SUCCESS (2.159s)
[159.636459] Starting dynamic subtest: C-eDP1
[161.743459] Dynamic subtest C-eDP1: SUCCESS (2.156s)
[161.788947] Starting dynamic subtest: D-eDP1
[163.922260] Dynamic subtest D-eDP1: SUCCESS (2.174s)
[163.928577] Subtest basic-flip-vs-modeset: SUCCESS (9.120s)
[164.784967] [107/162] (843s left) kms_flip (basic-flip-vs-wf_vblank)
[164.886143] Starting subtest: basic-flip-vs-wf_vblank
[164.897710] Starting dynamic subtest: A-eDP1
[166.922043] Dynamic subtest A-eDP1: SUCCESS (2.037s)
[166.938051] Starting dynamic subtest: B-eDP1
[168.946778] Dynamic subtest B-eDP1: SUCCESS (2.032s)
[168.966355] Starting dynamic subtest: C-eDP1
[170.909343] Dynamic subtest C-eDP1: SUCCESS (1.942s)
[170.931162] Starting dynamic subtest: D-eDP1
[172.830669] Dynamic subtest D-eDP1: SUCCESS (1.940s)
[172.841124] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.959s)
[174.056080] [108/162] (834s left) kms_flip (basic-plain-flip)
[174.158144] Starting subtest: basic-plain-flip
[174.166900] Starting dynamic subtest: A-eDP1
[175.831586] Dynamic subtest A-eDP1: SUCCESS (1.689s)
[175.853546] Starting dynamic subtest: B-eDP1
[177.542451] Dynamic subtest B-eDP1: SUCCESS (1.709s)
[177.561956] Starting dynamic subtest: C-eDP1
[179.268565] Dynamic subtest C-eDP1: SUCCESS (1.717s)
[179.286325] Starting dynamic subtest: D-eDP1
[180.991419] Dynamic subtest D-eDP1: SUCCESS (1.726s)
[180.997708] Subtest basic-plain-flip: SUCCESS (6.849s)
[182.278971] [109/162] (826s left) kms_force_connector_basic (force-connector-state)
[182.358385] Starting subtest: force-connector-state
[182.952337] Subtest force-connector-state: SUCCESS (0.597s)
[183.939679] [110/162] (824s left) kms_force_connector_basic (force-edid)
[184.013289] Starting subtest: force-edid
[184.310160] Subtest force-edid: SUCCESS (0.297s)
[184.485978] [111/162] (824s left) kms_force_connector_basic (force-load-detect)
[184.567562] Starting subtest: force-load-detect
[184.590385] Subtest force-load-detect: SKIP (0.000s)
[184.715789] [112/162] (823s left) kms_force_connector_basic (prune-stale-modes)
[184.797798] Starting subtest: prune-stale-modes
[185.160331] Subtest prune-stale-modes: SUCCESS (0.367s)
[185.331620] [113/162] (823s left) kms_frontbuffer_tracking (basic)
[185.437919] Starting subtest: basic
[190.962440] Subtest basic: SUCCESS (5.536s)
[191.142690] [114/162] (817s left) kms_hdmi_inject (inject-audio)
[191.509482] Starting subtest: inject-audio
[191.756450] Subtest inject-audio: SUCCESS (0.251s)
[192.453401] [115/162] (816s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[192.535694] Starting subtest: compare-crc-sanitycheck-xr24
[192.544529] Starting dynamic subtest: pipe-A-eDP-1
[193.257813] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.719s)
[193.270740] Starting dynamic subtest: pipe-B-eDP-1
[194.579528] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.322s)
[194.595052] Starting dynamic subtest: pipe-C-eDP-1
[195.920643] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.337s)
[195.935837] Starting dynamic subtest: pipe-D-eDP-1
[197.222128] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.302s)
[197.238531] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.688s)
[198.115167] [116/162] (810s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[198.192812] Starting subtest: compare-crc-sanitycheck-nv12
[198.208023] Starting dynamic subtest: pipe-A-eDP-1
[199.113903] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.922s)
[199.131633] Starting dynamic subtest: pipe-B-eDP-1
[200.568080] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.452s)
[200.585786] Starting dynamic subtest: pipe-C-eDP-1
[201.891506] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.319s)
[201.909207] Starting dynamic subtest: pipe-D-eDP-1
[203.274500] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.379s)
[203.289741] Subtest compare-crc-sanitycheck-nv12: SUCCESS (5.083s)
[204.126816] [117/162] (804s left) kms_pipe_crc_basic (hang-read-crc)
[204.214867] Starting subtest: hang-read-crc
[204.228212] Starting dynamic subtest: pipe-A-eDP-1
[206.581616] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.357s)
[206.603456] Starting dynamic subtest: pipe-B-eDP-1
[209.594371] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.024s)
[209.607945] Starting dynamic subtest: pipe-C-eDP-1
[212.608555] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.011s)
[212.626254] Starting dynamic subtest: pipe-D-eDP-1
[215.639585] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.016s)
[215.646083] Subtest hang-read-crc: SUCCESS (11.418s)
[216.521168] [118/162] (792s left) kms_pipe_crc_basic (nonblocking-crc)
[216.609273] Starting subtest: nonblocking-crc
[216.622494] Starting dynamic subtest: pipe-A-eDP-1
[217.487637] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.873s)
[217.505501] Starting dynamic subtest: pipe-B-eDP-1
[219.066803] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.579s)
[219.082791] Starting dynamic subtest: pipe-C-eDP-1
[220.498244] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.428s)
[220.516041] Starting dynamic subtest: pipe-D-eDP-1
[221.982782] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.488s)
[221.996290] Subtest nonblocking-crc: SUCCESS (5.374s)
[222.917550] [119/162] (786s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[222.994317] Starting subtest: nonblocking-crc-frame-sequence
[223.000742] Starting dynamic subtest: pipe-A-eDP-1
[223.887850] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.892s)
[223.901292] Starting dynamic subtest: pipe-B-eDP-1
[225.431298] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.538s)
[225.448400] Starting dynamic subtest: pipe-C-eDP-1
[226.898945] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.466s)
[226.912401] Starting dynamic subtest: pipe-D-eDP-1
[228.372263] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.475s)
[228.378714] Subtest nonblocking-crc-frame-sequence: SUCCESS (5.378s)
[229.321668] [120/162] (779s left) kms_pipe_crc_basic (read-crc)
[229.410099] Starting subtest: read-crc
[229.423386] Starting dynamic subtest: pipe-A-eDP-1
[230.240320] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.830s)
[230.262359] Starting dynamic subtest: pipe-B-eDP-1
[231.767641] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.524s)
[231.788881] Starting dynamic subtest: pipe-C-eDP-1
[233.237442] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.468s)
[233.262435] Starting dynamic subtest: pipe-D-eDP-1
[234.703607] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.459s)
[234.710231] Subtest read-crc: SUCCESS (5.292s)
[235.645962] [121/162] (773s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[235.728485] Starting subtest: read-crc-frame-sequence
[235.735809] Starting dynamic subtest: pipe-A-eDP-1
[236.537599] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.806s)
[236.550878] Starting dynamic subtest: pipe-B-eDP-1
[237.974990] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.427s)
[237.994193] Starting dynamic subtest: pipe-C-eDP-1
[239.330168] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.355s)
[239.351095] Starting dynamic subtest: pipe-D-eDP-1
[240.702377] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.375s)
[240.713624] Subtest read-crc-frame-sequence: SUCCESS (4.970s)
[241.645612] [122/162] (767s left) kms_pm_backlight (basic-brightness)
[241.737346] Starting subtest: basic-brightness
[241.798239] Starting dynamic subtest: eDP-1
[242.137285] Dynamic subtest eDP-1: SUCCESS (0.333s)
[242.143766] Subtest basic-brightness: SUCCESS (0.393s)
[243.005239] [123/162] (766s left) kms_pm_rpm (basic-pci-d3-state)
[244.928889] Starting subtest: basic-pci-d3-state
[246.400715] Subtest basic-pci-d3-state: SUCCESS (1.459s)
[246.533468] [124/162] (762s left) kms_pm_rpm (basic-rte)
[246.612516] Starting subtest: basic-rte
[249.518912] Subtest basic-rte: SUCCESS (2.923s)
[251.317926] [125/162] (758s left) kms_psr (psr-primary-page-flip)
[251.410694] Starting subtest: psr-primary-page-flip
[251.422351] Starting dynamic subtest: eDP-1
[253.364676] Dynamic subtest eDP-1: SUCCESS (1.960s)
[253.381080] Subtest psr-primary-page-flip: SUCCESS (1.962s)
[254.220113] [126/162] (755s left) kms_psr (psr-cursor-plane-move)
[254.308229] Starting subtest: psr-cursor-plane-move
[254.321554] Starting dynamic subtest: eDP-1
[256.164238] Dynamic subtest eDP-1: SUCCESS (1.858s)
[256.170958] Subtest psr-cursor-plane-move: SUCCESS (1.859s)
[257.040341] [127/162] (752s left) kms_psr (psr-sprite-plane-onoff)
[257.133244] Starting subtest: psr-sprite-plane-onoff
[257.142782] Starting dynamic subtest: eDP-1
[259.139543] Dynamic subtest eDP-1: SUCCESS (2.007s)
[259.146376] Subtest psr-sprite-plane-onoff: SUCCESS (2.009s)
[260.058333] [128/162] (749s left) kms_psr (psr-primary-mmap-gtt)
[260.146421] Starting subtest: psr-primary-mmap-gtt
[260.162875] Starting dynamic subtest: eDP-1
[261.772753] Dynamic subtest eDP-1: SKIP (1.601s)
[261.795871] Subtest psr-primary-mmap-gtt: SKIP (1.602s)
[262.139515] [129/162] (747s left) kms_setmode (basic-clone-single-crtc)
[262.224747] Starting subtest: basic-clone-single-crtc
[262.254249] Subtest basic-clone-single-crtc: SKIP (0.000s)
[262.333958] [130/162] (747s left) i915_pm_rps (basic-api)
[262.421676] Starting subtest: basic-api
[262.443725] Subtest basic-api: SKIP (0.001s)
[262.535225] [131/162] (747s left) prime_self_import (basic-llseek-bad)
[262.602953] Starting subtest: basic-llseek-bad
[262.624486] Subtest basic-llseek-bad: SUCCESS (0.002s)
[262.764526] [132/162] (747s left) prime_self_import (basic-llseek-size)
[262.836783] Starting subtest: basic-llseek-size
[262.859866] Subtest basic-llseek-size: SUCCESS (0.002s)
[262.987746] [133/162] (747s left) prime_self_import (basic-with_fd_dup)
[263.055663] Starting subtest: basic-with_fd_dup
[263.078707] Subtest basic-with_fd_dup: SUCCESS (0.002s)
[263.205481] [134/162] (746s left) prime_self_import (basic-with_one_bo)
[263.272655] Starting subtest: basic-with_one_bo
[263.295680] Subtest basic-with_one_bo: SUCCESS (0.002s)
[263.422908] [135/162] (746s left) prime_self_import (basic-with_one_bo_two_files)
[263.491412] Starting subtest: basic-with_one_bo_two_files
[263.507926] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s)
[263.687666] [136/162] (746s left) prime_self_import (basic-with_two_bos)
[263.774420] Starting subtest: basic-with_two_bos
[263.797313] Subtest basic-with_two_bos: SUCCESS (0.002s)
[263.921896] [137/162] (746s left) prime_vgem (basic-fence-flip)
[264.015120] Starting subtest: basic-fence-flip
[264.441971] Subtest basic-fence-flip: SUCCESS (0.448s)
[264.630171] [138/162] (745s left) prime_vgem (basic-fence-mmap)
[264.721454] Starting subtest: basic-fence-mmap
[264.744671] Subtest basic-fence-mmap: SKIP (0.000s)
[264.859674] [139/162] (745s left) prime_vgem (basic-fence-read)
[264.946906] Starting subtest: basic-fence-read
[264.968942] Subtest basic-fence-read: SKIP (0.012s)
[265.167603] [140/162] (745s left) prime_vgem (basic-gtt)
[265.271290] Starting subtest: basic-gtt
[265.293377] Subtest basic-gtt: SKIP (0.000s)
[265.438634] [141/162] (745s left) prime_vgem (basic-read)
[265.533801] Starting subtest: basic-read
[265.555777] Subtest basic-read: SKIP (0.011s)
[265.741979] [142/162] (745s left) prime_vgem (basic-write)
[265.845690] Starting subtest: basic-write
[265.867638] Subtest basic-write: SKIP (0.011s)
[266.009394] [143/162] (744s left) vgem_basic (setversion)
[266.102894] Starting subtest: setversion
[266.125745] Subtest setversion: SUCCESS (0.000s)
[266.203818] [144/162] (744s left) vgem_basic (create)
[266.294385] Starting subtest: create
[266.300653] Subtest create: SUCCESS (0.000s)
[266.380921] [145/162] (744s left) vgem_basic (debugfs)
[266.449862] Starting subtest: debugfs
[266.458558] Subtest debugfs: SUCCESS (0.000s)
[266.554427] [146/162] (744s left) vgem_basic (dmabuf-export)
[266.644131] Starting subtest: dmabuf-export
[266.667082] Subtest dmabuf-export: SUCCESS (0.003s)
[266.780845] [147/162] (744s left) vgem_basic (dmabuf-fence)
[266.868344] Starting subtest: dmabuf-fence
[266.878840] Subtest dmabuf-fence: SUCCESS (0.000s)
[266.969343] [148/162] (744s left) vgem_basic (dmabuf-fence-before)
[267.052837] Starting subtest: dmabuf-fence-before
[267.061569] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[267.171551] [149/162] (744s left) vgem_basic (dmabuf-mmap)
[267.258256] Starting subtest: dmabuf-mmap
[267.264432] Subtest dmabuf-mmap: SUCCESS (0.020s)
[267.383810] [150/162] (743s left) vgem_basic (mmap)
[267.474132] Starting subtest: mmap
[267.480265] Subtest mmap: SUCCESS (0.012s)
[267.585370] [151/162] (743s left) vgem_basic (second-client)
[267.673257] Starting subtest: second-client
[267.702341] Subtest second-client: SUCCESS (0.033s)
[267.816474] [152/162] (743s left) vgem_basic (sysfs)
[267.903397] Starting subtest: sysfs
[267.909558] Subtest sysfs: SUCCESS (0.000s)
[268.018212] [153/162] (743s left) core_hotunplug (unbind-rebind)
[268.136353] Starting subtest: unbind-rebind
[274.469625] Subtest unbind-rebind: SUCCESS (6.347s)
[274.551242] [154/162] (737s left) vgem_basic (unload)
[274.627280] Starting subtest: unload
[303.801768] Subtest unload: SUCCESS (29.180s)
[304.212499] [155/162] (707s left) i915_module_load (reload)
[304.384207] Starting subtest: reload
[311.040771] Subtest reload: SUCCESS (6.664s)
[311.185408] [156/162] (700s left) gem_lmem_swapping (basic)
[311.328691] Subtest basic: SKIP (0.000s)
[311.456941] [157/162] (700s left) gem_lmem_swapping (parallel-random-engines)
[311.583687] Subtest parallel-random-engines: SKIP (0.000s)
[311.713665] [158/162] (700s left) gem_lmem_swapping (random-engines)
[311.857447] Subtest random-engines: SKIP (0.000s)
[311.980474] [159/162] (700s left) gem_lmem_swapping (verify-random)
[312.121544] Subtest verify-random: SKIP (0.000s)
[312.237886] [160/162] (700s left) i915_pm_rpm (module-reload)
[314.578820] Starting subtest: module-reload
[333.596351] Subtest module-reload: SUCCESS (19.017s)
[333.641011] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[333.641650] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[333.648564] [161/162] (678s left) i915_selftest (live)
[333.713443] Starting subtest: live
[333.719694] Starting dynamic subtest: sanitycheck
[338.426765] Dynamic subtest sanitycheck: SUCCESS (4.707s)
[338.447300] Starting dynamic subtest: uncore
[343.091834] Dynamic subtest uncore: SUCCESS (4.668s)
[343.106898] Starting dynamic subtest: workarounds
[346.748574] Dynamic subtest workarounds: SUCCESS (3.651s)
[346.769214] Starting dynamic subtest: gt_engines
[351.666590] Dynamic subtest gt_engines: SUCCESS (4.924s)
[351.682056] Starting dynamic subtest: gt_timelines