[36.687795] Initializing watchdogs
[36.687848]   /dev/watchdog0
[36.704232] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d51 Intel Meteorlake (Gen12) 
[36.713299] [001/162] (960s left) i915_module_load (load)
[36.762693] Starting subtest: load
[39.891178] Subtest load: SUCCESS (3.119s)
[39.939601] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[39.941082] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[39.958830] [002/162] (957s left) core_auth (basic-auth)
[41.194615] Starting subtest: basic-auth
[41.207653] Subtest basic-auth: SUCCESS (0.001s)
[41.305424] [003/162] (956s left) core_debugfs (read-all-entries)
[41.381447] Starting subtest: read-all-entries
[41.502173] Subtest read-all-entries: SUCCESS (0.130s)
[41.588810] [004/162] (955s left) core_sysfs (read-all-entries)
[41.679179] Starting subtest: read-all-entries
[41.685324] Subtest read-all-entries: SUCCESS (0.004s)
[41.760738] [005/162] (955s left) fbdev (eof)
[41.833670] Starting subtest: eof
[41.850266] Subtest eof: SUCCESS (0.000s)
[41.918109] [006/162] (955s left) fbdev (info)
[41.960576] Starting subtest: info
[41.977094] Subtest info: SUCCESS (0.000s)
[42.058333] [007/162] (955s left) fbdev (nullptr)
[42.131289] Starting subtest: nullptr
[42.147777] Subtest nullptr: SUCCESS (0.000s)
[42.208293] [008/162] (955s left) fbdev (read)
[42.274368] Starting subtest: read
[43.172135] Subtest read: SUCCESS (0.888s)
[43.272696] [009/162] (954s left) fbdev (write)
[43.359772] Starting subtest: write
[43.926836] Subtest write: SUCCESS (0.581s)
[44.024479] [010/162] (953s left) gem_basic (bad-close)
[44.088836] Starting subtest: bad-close
[44.102448] Subtest bad-close: SUCCESS (0.000s)
[44.175878] [011/162] (953s left) gem_basic (create-close)
[44.250132] Starting subtest: create-close
[44.272119] Subtest create-close: SUCCESS (0.000s)
[44.373656] [012/162] (953s left) gem_basic (create-fd-close)
[44.439363] Starting subtest: create-fd-close
[44.461349] Subtest create-fd-close: SUCCESS (0.000s)
[44.549748] [013/162] (953s left) gem_busy (busy@all-engines)
[44.640941] Starting subtest: busy
[44.647361] Starting dynamic subtest: all-engines
[44.673661] Dynamic subtest all-engines: SUCCESS (0.056s)
[44.687171] Subtest busy: SUCCESS (0.056s)
[46.337693] [014/162] (951s left) gem_close_race (basic-process)
[46.444936] Starting subtest: basic-process
[46.487646] Subtest basic-process: SUCCESS (0.047s)
[46.727951] [015/162] (951s left) gem_close_race (basic-threads)
[46.818580] Starting subtest: basic-threads
[48.135023] Subtest basic-threads: SUCCESS (1.318s)
[48.357273] [016/162] (949s left) gem_ctx_create (basic)
[48.427996] Starting subtest: basic
[48.443976] Subtest basic: SUCCESS (0.000s)
[48.631972] [017/162] (949s left) gem_ctx_create (basic-files)
[48.719186] Starting subtest: basic-files
[50.713998] Subtest basic-files: SUCCESS (2.009s)
[52.295847] [018/162] (946s left) gem_ctx_exec (basic)
[52.369097] Starting subtest: basic
[52.375286] Subtest basic: SUCCESS (0.010s)
[52.500868] [019/162] (945s left) gem_exec_basic (basic)
[52.558786] Starting subtest: basic
[52.574067] Starting dynamic subtest: rcs0-smem
[52.580183] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[52.598169] Starting dynamic subtest: bcs0-smem
[52.604392] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[52.620985] Starting dynamic subtest: vcs0-smem
[52.627175] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[52.638205] Starting dynamic subtest: vcs1-smem
[52.647018] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[52.660170] Starting dynamic subtest: vecs0-smem
[52.668896] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[52.682488] Starting dynamic subtest: ccs0-smem
[52.691061] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[52.697316] Subtest basic: SUCCESS (0.013s)
[54.279756] [020/162] (944s left) gem_exec_create (basic)
[54.363499] Starting subtest: basic
[54.372327] Starting dynamic subtest: smem
[58.256454] Dynamic subtest smem: SUCCESS (3.906s)
[58.269402] Subtest basic: SUCCESS (3.907s)
[58.587708] [021/162] (940s left) gem_exec_fence (basic-busy)
[58.762584] Starting subtest: basic-busy
[58.772499] Starting dynamic subtest: rcs0
[58.816708] Dynamic subtest rcs0: SUCCESS (0.062s)
[58.856572] Starting dynamic subtest: bcs0
[58.890438] Dynamic subtest bcs0: SUCCESS (0.056s)
[58.929659] Starting dynamic subtest: vcs0
[58.953028] Dynamic subtest vcs0: SUCCESS (0.048s)
[58.988044] Starting dynamic subtest: vcs1
[59.011320] Dynamic subtest vcs1: SUCCESS (0.050s)
[59.046042] Starting dynamic subtest: vecs0
[59.069305] Dynamic subtest vecs0: SUCCESS (0.055s)
[59.104152] Starting dynamic subtest: ccs0
[59.127328] Dynamic subtest ccs0: SUCCESS (0.055s)
[59.137031] Subtest basic-busy: SUCCESS (0.328s)
[61.371521] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[61.382634] [022/162] (937s left) gem_exec_fence (basic-wait)
[61.564433] Starting subtest: basic-wait
[61.573256] Starting dynamic subtest: rcs0
[61.630923] Dynamic subtest rcs0: SUCCESS (0.076s)
[61.665091] Starting dynamic subtest: bcs0
[61.687182] Dynamic subtest bcs0: SUCCESS (0.050s)
[61.721480] Starting dynamic subtest: vcs0
[61.743633] Dynamic subtest vcs0: SUCCESS (0.052s)
[61.777552] Starting dynamic subtest: vcs1
[61.790837] Dynamic subtest vcs1: SUCCESS (0.048s)
[61.830922] Starting dynamic subtest: vecs0
[61.840927] Dynamic subtest vecs0: SUCCESS (0.050s)
[61.881576] Starting dynamic subtest: ccs0
[61.891483] Dynamic subtest ccs0: SUCCESS (0.051s)
[61.904933] Subtest basic-wait: SUCCESS (0.329s)
[63.387667] [023/162] (935s left) gem_exec_fence (basic-await)
[63.575231] Starting subtest: basic-await
[63.591743] Starting dynamic subtest: rcs0
[63.660263] Dynamic subtest rcs0: SUCCESS (0.088s)
[63.681813] Starting dynamic subtest: bcs0
[63.748445] Dynamic subtest bcs0: SUCCESS (0.087s)
[63.766909] Starting dynamic subtest: vcs0
[63.821629] Dynamic subtest vcs0: SUCCESS (0.079s)
[63.840599] Starting dynamic subtest: vcs1
[63.909994] Dynamic subtest vcs1: SUCCESS (0.087s)
[63.931569] Starting dynamic subtest: vecs0
[63.982218] Dynamic subtest vecs0: SUCCESS (0.077s)
[63.994041] Starting dynamic subtest: ccs0
[64.072154] Dynamic subtest ccs0: SUCCESS (0.089s)
[64.079068] Subtest basic-await: SUCCESS (0.509s)
[66.370226] [024/162] (932s left) gem_exec_fence (nb-await)
[66.535406] Starting subtest: nb-await
[66.541897] Starting dynamic subtest: rcs0
[66.614985] Dynamic subtest rcs0: SUCCESS (0.081s)
[66.626393] Starting dynamic subtest: bcs0
[66.681676] Dynamic subtest bcs0: SUCCESS (0.066s)
[66.693286] Starting dynamic subtest: vcs0
[66.745495] Dynamic subtest vcs0: SUCCESS (0.064s)
[66.757115] Starting dynamic subtest: vcs1
[66.804194] Dynamic subtest vcs1: SUCCESS (0.059s)
[66.815387] Starting dynamic subtest: vecs0
[66.865582] Dynamic subtest vecs0: SUCCESS (0.061s)
[66.877292] Starting dynamic subtest: ccs0
[66.929778] Dynamic subtest ccs0: SUCCESS (0.064s)
[66.936004] Subtest nb-await: SUCCESS (0.396s)
[68.330969] [025/162] (930s left) gem_exec_gttfill (basic)
[68.407685] Starting subtest: basic
[72.195164] Subtest basic: SUCCESS (3.791s)
[72.484883] [026/162] (926s left) gem_exec_parallel (engines)
[72.649938] Starting subtest: engines
[72.656772] Starting dynamic subtest: basic
[76.244413] Dynamic subtest basic: SUCCESS (3.588s)
[76.267703] Starting dynamic subtest: contexts
[80.772094] Dynamic subtest contexts: SUCCESS (4.529s)
[80.794208] Starting dynamic subtest: fds
[86.325532] Dynamic subtest fds: SUCCESS (5.553s)
[86.348030] Starting dynamic subtest: userptr
[88.222465] Dynamic subtest userptr: SUCCESS (1.899s)
[88.235600] Subtest engines: SUCCESS (15.571s)
[88.463552] [027/162] (910s left) gem_exec_store (basic)
[88.579376] Starting subtest: basic
[88.674957] Subtest basic: SUCCESS (0.141s)
[88.888286] [028/162] (910s left) gem_flink_basic (bad-flink)
[88.964546] Starting subtest: bad-flink
[88.976134] Subtest bad-flink: SUCCESS (0.000s)
[89.045866] [029/162] (910s left) gem_flink_basic (bad-open)
[89.130243] Starting subtest: bad-open
[89.136510] Subtest bad-open: SUCCESS (0.000s)
[89.215209] [030/162] (910s left) gem_flink_basic (basic)
[89.286605] Starting subtest: basic
[89.300017] Subtest basic: SUCCESS (0.000s)
[89.392097] [031/162] (910s left) gem_flink_basic (double-flink)
[89.463763] Starting subtest: double-flink
[89.480366] Subtest double-flink: SUCCESS (0.000s)
[89.559419] [032/162] (910s left) gem_flink_basic (flink-lifetime)
[89.633819] Starting subtest: flink-lifetime
[89.650539] Subtest flink-lifetime: SUCCESS (0.001s)
[89.745740] [033/162] (909s left) gem_huc_copy (huc-copy)
[89.809697] Starting subtest: huc-copy
[89.826267] Subtest huc-copy: SUCCESS (0.004s)
[89.947978] [034/162] (909s left) gem_linear_blits (basic)
[90.117097] Starting subtest: basic
[90.140693] Subtest basic: SUCCESS (0.016s)
[90.294220] [035/162] (909s left) gem_mmap (basic)
[90.450484] Subtest basic: SKIP (0.000s)
[90.548586] [036/162] (909s left) gem_mmap_gtt (basic)
[90.623252] Subtest basic: SKIP (0.000s)
[90.681958] [037/162] (909s left) gem_render_linear_blits (basic)
[90.766336] Starting subtest: basic
[90.818643] Subtest basic: SUCCESS (0.038s)
[90.900203] [038/162] (909s left) gem_render_tiled_blits (basic)
[90.979892] Subtest basic: SKIP (0.000s)
[91.048214] [039/162] (909s left) gem_ringfill (basic-all)
[97.244162] Starting subtest: basic-all
[98.412450] Subtest basic-all: SUCCESS (1.177s)
[98.561656] [040/162] (901s left) gem_softpin (allocator-basic)
[98.637093] Starting subtest: allocator-basic
[98.723630] Subtest allocator-basic: SUCCESS (0.097s)
[98.901808] [041/162] (901s left) gem_softpin (allocator-basic-reserve)
[98.975348] Starting subtest: allocator-basic-reserve
[99.065424] Subtest allocator-basic-reserve: SUCCESS (0.100s)
[99.255548] [042/162] (901s left) gem_softpin (safe-alignment)
[99.336822] Starting subtest: safe-alignment
[99.365020] Subtest safe-alignment: SUCCESS (0.040s)
[101.255019] [043/162] (899s left) gem_sync (basic-all)
[101.413017] Starting subtest: basic-all
[104.238846] Subtest basic-all: SUCCESS (2.913s)
[104.459410] [044/162] (895s left) gem_sync (basic-each)
[104.582623] Starting subtest: basic-each
[107.210674] Subtest basic-each: SUCCESS (2.679s)
[107.428597] [045/162] (893s left) gem_tiled_blits (basic)
[107.535977] Subtest basic: SKIP (0.000s)
[107.601936] [046/162] (892s left) gem_tiled_fence_blits (basic)
[107.680607] Subtest basic: SKIP (0.000s)
[107.756275] [047/162] (892s left) gem_tiled_pread_basic (basic)
[107.848357] Subtest basic: SKIP (0.000s)
[107.950885] [048/162] (892s left) gem_wait (busy@all-engines)
[108.033427] Starting subtest: busy
[108.042076] Starting dynamic subtest: all-engines
[109.194665] Dynamic subtest all-engines: SUCCESS (1.163s)
[109.210524] Subtest busy: SUCCESS (1.163s)
[109.451587] [049/162] (891s left) gem_wait (wait@all-engines)
[109.518892] Starting subtest: wait
[109.525871] Starting dynamic subtest: all-engines
[111.240206] Dynamic subtest all-engines: SUCCESS (1.722s)
[111.246783] Subtest wait: SUCCESS (1.722s)
[111.438476] [050/162] (889s left) i915_getparams_basic (basic-eu-total)
[111.500638] Starting subtest: basic-eu-total
[111.512952] Subtest basic-eu-total: SUCCESS (0.000s)
[111.569814] [051/162] (889s left) i915_getparams_basic (basic-subslice-total)
[111.622510] Starting subtest: basic-subslice-total
[111.634818] Subtest basic-subslice-total: SUCCESS (0.000s)
[111.707580] [052/162] (889s left) i915_hangman (error-state-basic)
[111.760837] Starting subtest: error-state-basic
[111.899316] Subtest error-state-basic: SUCCESS (0.134s)
[112.004770] [053/162] (889s left) i915_pciid
[112.124857] [054/162] (888s left) intel_hwmon (hwmon-read)
[112.186029] Subtest hwmon-read: SKIP (0.000s)
[112.249501] [055/162] (888s left) intel_hwmon (hwmon-write)
[112.310692] Subtest hwmon-write: SKIP (0.000s)
[112.368065] [056/162] (888s left) kms_addfb_basic (addfb25-4-tiled)
[112.458928] Starting subtest: addfb25-4-tiled
[112.465450] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[112.569946] [057/162] (888s left) kms_addfb_basic (addfb25-bad-modifier)
[112.643846] Starting subtest: addfb25-bad-modifier
[112.650026] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[112.755822] [058/162] (888s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[112.836186] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[112.940541] [059/162] (888s left) kms_addfb_basic (addfb25-modifier-no-flag)
[113.014525] Starting subtest: addfb25-modifier-no-flag
[113.020808] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[113.125593] [060/162] (888s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[113.206169] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[113.317608] [061/162] (888s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[113.405808] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[113.526892] [062/162] (887s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[113.615234] Starting subtest: addfb25-yf-tiled-legacy
[113.622277] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[113.722888] [063/162] (887s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[113.811105] Starting subtest: addfb25-y-tiled-legacy
[113.818252] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[113.922503] [064/162] (887s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[114.009567] Starting subtest: addfb25-y-tiled-small-legacy
[114.025725] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[114.121191] [065/162] (887s left) kms_addfb_basic (bad-pitch-0)
[114.183140] Starting subtest: bad-pitch-0
[114.192111] Subtest bad-pitch-0: SUCCESS (0.000s)
[114.314049] [066/162] (887s left) kms_addfb_basic (bad-pitch-1024)
[114.384112] Starting subtest: bad-pitch-1024
[114.393539] Subtest bad-pitch-1024: SUCCESS (0.000s)
[114.523523] [067/162] (887s left) kms_addfb_basic (bad-pitch-128)
[114.614539] Starting subtest: bad-pitch-128
[114.620982] Subtest bad-pitch-128: SUCCESS (0.000s)
[114.732920] [068/162] (887s left) kms_addfb_basic (bad-pitch-256)
[114.824945] Starting subtest: bad-pitch-256
[114.831642] Subtest bad-pitch-256: SUCCESS (0.000s)
[114.944264] [069/162] (886s left) kms_addfb_basic (bad-pitch-32)
[115.016094] Starting subtest: bad-pitch-32
[115.029218] Subtest bad-pitch-32: SUCCESS (0.000s)
[115.145262] [070/162] (886s left) kms_addfb_basic (bad-pitch-63)
[115.215298] Starting subtest: bad-pitch-63
[115.221738] Subtest bad-pitch-63: SUCCESS (0.000s)
[115.345855] [071/162] (886s left) kms_addfb_basic (bad-pitch-65536)
[115.428361] Starting subtest: bad-pitch-65536
[115.434850] Subtest bad-pitch-65536: SUCCESS (0.000s)
[115.558378] [072/162] (886s left) kms_addfb_basic (bad-pitch-999)
[115.633767] Starting subtest: bad-pitch-999
[115.650319] Subtest bad-pitch-999: SUCCESS (0.000s)
[115.766642] [073/162] (886s left) kms_addfb_basic (basic)
[115.843447] Starting subtest: basic
[115.860074] Subtest basic: SUCCESS (0.000s)
[115.976345] [074/162] (886s left) kms_addfb_basic (basic-x-tiled-legacy)
[116.045517] Starting subtest: basic-x-tiled-legacy
[116.068903] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[116.182135] [075/162] (886s left) kms_addfb_basic (basic-y-tiled-legacy)
[116.259861] Starting subtest: basic-y-tiled-legacy
[116.283180] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[116.404881] [076/162] (885s left) kms_addfb_basic (bo-too-small)
[116.489434] Starting subtest: bo-too-small
[116.502661] Subtest bo-too-small: SUCCESS (0.000s)
[116.619818] [077/162] (885s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[116.717779] Starting subtest: bo-too-small-due-to-tiling
[116.741021] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[116.829856] [078/162] (885s left) kms_addfb_basic (clobberred-modifier)
[116.908159] Starting subtest: clobberred-modifier
[116.931393] Subtest clobberred-modifier: SKIP (0.000s)
[117.047394] [079/162] (885s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[117.123322] Starting subtest: framebuffer-vs-set-tiling
[117.146189] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[117.277066] [080/162] (885s left) kms_addfb_basic (invalid-get-prop)
[117.337957] Starting subtest: invalid-get-prop
[117.344258] Subtest invalid-get-prop: SUCCESS (0.000s)
[117.478023] [081/162] (885s left) kms_addfb_basic (invalid-get-prop-any)
[117.543435] Starting subtest: invalid-get-prop-any
[117.549770] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[117.665776] [082/162] (885s left) kms_addfb_basic (invalid-set-prop)
[117.727253] Starting subtest: invalid-set-prop
[117.733533] Subtest invalid-set-prop: SUCCESS (0.000s)
[117.861448] [083/162] (884s left) kms_addfb_basic (invalid-set-prop-any)
[117.916564] Starting subtest: invalid-set-prop-any
[117.922848] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[118.048620] [084/162] (884s left) kms_addfb_basic (no-handle)
[118.103424] Starting subtest: no-handle
[118.109756] Subtest no-handle: SUCCESS (0.000s)
[118.240229] [085/162] (884s left) kms_addfb_basic (size-max)
[118.313811] Starting subtest: size-max
[118.319990] Subtest size-max: SUCCESS (0.000s)
[118.433679] [086/162] (884s left) kms_addfb_basic (small-bo)
[118.507619] Starting subtest: small-bo
[118.513802] Subtest small-bo: SUCCESS (0.000s)
[118.620751] [087/162] (884s left) kms_addfb_basic (tile-pitch-mismatch)
[118.675408] Starting subtest: tile-pitch-mismatch
[118.688092] Subtest tile-pitch-mismatch: SKIP (0.000s)
[118.818526] [088/162] (884s left) kms_addfb_basic (too-high)
[118.891977] Starting subtest: too-high
[118.898325] Subtest too-high: SUCCESS (0.000s)
[119.003631] [089/162] (884s left) kms_addfb_basic (too-wide)
[119.077787] Starting subtest: too-wide
[119.084043] Subtest too-wide: SUCCESS (0.000s)
[119.192851] [090/162] (883s left) kms_addfb_basic (unused-handle)
[119.247872] Starting subtest: unused-handle
[119.254402] Subtest unused-handle: SUCCESS (0.000s)
[119.385539] [091/162] (883s left) kms_addfb_basic (unused-modifier)
[119.438978] Starting subtest: unused-modifier
[119.445161] Subtest unused-modifier: SUCCESS (0.000s)
[119.563418] [092/162] (883s left) kms_addfb_basic (unused-offsets)
[119.617451] Starting subtest: unused-offsets
[119.623673] Subtest unused-offsets: SUCCESS (0.000s)
[119.757556] [093/162] (883s left) kms_addfb_basic (unused-pitches)
[119.831534] Starting subtest: unused-pitches
[119.847952] Subtest unused-pitches: SUCCESS (0.000s)
[119.979201] [094/162] (883s left) kms_busy (basic)
[120.062944] Starting subtest: basic
[120.079439] Starting dynamic subtest: flip
[120.845489] Dynamic subtest flip: SUCCESS (0.777s)
[120.863615] Starting dynamic subtest: modeset
[124.256808] Dynamic subtest modeset: SUCCESS (3.410s)
[124.273422] Subtest basic: SUCCESS (4.188s)
[125.083660] [095/162] (878s left) kms_prop_blob (basic)
[125.157341] Starting subtest: basic
[125.173826] Subtest basic: SUCCESS (0.000s)
[125.238545] [096/162] (878s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[125.362435] Starting subtest: basic-busy-flip-before-cursor-atomic
[125.378166] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[125.500150] [097/162] (878s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[125.620728] Starting subtest: basic-busy-flip-before-cursor-legacy
[125.643912] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[125.768405] [098/162] (877s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[125.892467] Starting subtest: basic-flip-after-cursor-atomic
[127.110646] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.223s)
[128.035814] [099/162] (875s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[128.151218] Starting subtest: basic-flip-after-cursor-legacy
[129.376924] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.222s)
[130.275922] [100/162] (873s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[130.401693] Starting subtest: basic-flip-after-cursor-varying-size
[131.610690] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.208s)
[132.585580] [101/162] (871s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[132.726054] Starting subtest: basic-flip-before-cursor-atomic
[133.946683] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.221s)
[134.798536] [102/162] (869s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[134.926424] Starting subtest: basic-flip-before-cursor-legacy
[136.132097] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.206s)
[137.027285] [103/162] (867s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[137.157501] Starting subtest: basic-flip-before-cursor-varying-size
[138.361168] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.206s)
[139.366656] [104/162] (864s left) kms_dsc (dsc-basic)
[139.463723] Starting subtest: dsc-basic
[139.530142] Subtest dsc-basic: SKIP (0.001s)
[139.720185] [105/162] (864s left) kms_flip (basic-flip-vs-dpms)
[139.829026] Starting subtest: basic-flip-vs-dpms
[139.835484] Starting dynamic subtest: A-eDP1
[142.520980] Dynamic subtest A-eDP1: SUCCESS (2.704s)
[142.542795] Starting dynamic subtest: B-eDP1
[144.793945] Dynamic subtest B-eDP1: SUCCESS (2.276s)
[144.810540] Starting dynamic subtest: C-eDP1
[147.038634] Dynamic subtest C-eDP1: SUCCESS (2.250s)
[147.051510] Starting dynamic subtest: D-eDP1
[149.318728] Dynamic subtest D-eDP1: SUCCESS (2.276s)
[149.325562] Subtest basic-flip-vs-dpms: SUCCESS (9.518s)
[150.239833] [106/162] (854s left) kms_flip (basic-flip-vs-modeset)
[150.335904] Starting subtest: basic-flip-vs-modeset
[150.345594] Starting dynamic subtest: A-eDP1
[152.939233] Dynamic subtest A-eDP1: SUCCESS (2.613s)
[152.959882] Starting dynamic subtest: B-eDP1
[155.221788] Dynamic subtest B-eDP1: SUCCESS (2.278s)
[155.245121] Starting dynamic subtest: C-eDP1
[157.493628] Dynamic subtest C-eDP1: SUCCESS (2.274s)
[157.514638] Starting dynamic subtest: D-eDP1
[159.786446] Dynamic subtest D-eDP1: SUCCESS (2.278s)
[159.796220] Subtest basic-flip-vs-modeset: SUCCESS (9.454s)
[160.703288] [107/162] (843s left) kms_flip (basic-flip-vs-wf_vblank)
[160.808774] Starting subtest: basic-flip-vs-wf_vblank
[160.817464] Starting dynamic subtest: A-eDP1
[162.769205] Dynamic subtest A-eDP1: SUCCESS (1.970s)
[162.787466] Starting dynamic subtest: B-eDP1
[164.695586] Dynamic subtest B-eDP1: SUCCESS (1.930s)
[164.711651] Starting dynamic subtest: C-eDP1
[166.733378] Dynamic subtest C-eDP1: SUCCESS (2.026s)
[166.748142] Starting dynamic subtest: D-eDP1
[168.674710] Dynamic subtest D-eDP1: SUCCESS (1.926s)
[168.680938] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.860s)
[169.911587] [108/162] (834s left) kms_flip (basic-plain-flip)
[170.007550] Starting subtest: basic-plain-flip
[170.013959] Starting dynamic subtest: A-eDP1
[171.784046] Dynamic subtest A-eDP1: SUCCESS (1.782s)
[171.809255] Starting dynamic subtest: B-eDP1
[173.517273] Dynamic subtest B-eDP1: SUCCESS (1.740s)
[173.541329] Starting dynamic subtest: C-eDP1
[175.253299] Dynamic subtest C-eDP1: SUCCESS (1.725s)
[175.274529] Starting dynamic subtest: D-eDP1
[176.986116] Dynamic subtest D-eDP1: SUCCESS (1.739s)
[176.993044] Subtest basic-plain-flip: SUCCESS (7.000s)
[178.298128] [109/162] (826s left) kms_force_connector_basic (force-connector-state)
[178.369280] Starting subtest: force-connector-state
[178.961844] Subtest force-connector-state: SUCCESS (0.593s)
[180.063460] [110/162] (824s left) kms_force_connector_basic (force-edid)
[180.155666] Starting subtest: force-edid
[180.442764] Subtest force-edid: SUCCESS (0.293s)
[180.575403] [111/162] (824s left) kms_force_connector_basic (force-load-detect)
[180.666092] Starting subtest: force-load-detect
[180.688928] Subtest force-load-detect: SKIP (0.000s)
[180.776439] [112/162] (824s left) kms_force_connector_basic (prune-stale-modes)
[180.855567] Starting subtest: prune-stale-modes
[181.222796] Subtest prune-stale-modes: SUCCESS (0.364s)
[181.432920] [113/162] (823s left) kms_frontbuffer_tracking (basic)
[181.552850] Starting subtest: basic
[186.866930] Subtest basic: SUCCESS (5.328s)
[187.004802] [114/162] (818s left) kms_hdmi_inject (inject-audio)
[187.366801] Starting subtest: inject-audio
[187.627478] Subtest inject-audio: SUCCESS (0.251s)
[188.236657] [115/162] (816s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[188.336053] Starting subtest: compare-crc-sanitycheck-xr24
[188.352382] Starting dynamic subtest: pipe-A-eDP-1
[189.065642] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.736s)
[189.083336] Starting dynamic subtest: pipe-B-eDP-1
[190.383702] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.324s)
[190.396762] Starting dynamic subtest: pipe-C-eDP-1
[191.724302] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.331s)
[191.737625] Starting dynamic subtest: pipe-D-eDP-1
[193.033305] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.308s)
[193.049709] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.707s)
[193.900710] [116/162] (811s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[193.990088] Starting subtest: compare-crc-sanitycheck-nv12
[193.996401] Starting dynamic subtest: pipe-A-eDP-1
[194.887352] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.898s)
[194.905110] Starting dynamic subtest: pipe-B-eDP-1
[196.265075] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.375s)
[196.279338] Starting dynamic subtest: pipe-C-eDP-1
[197.602578] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.317s)
[197.621878] Starting dynamic subtest: pipe-D-eDP-1
[198.908025] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.322s)
[198.914103] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.924s)
[199.807496] [117/162] (805s left) kms_pipe_crc_basic (hang-read-crc)
[199.906393] Starting subtest: hang-read-crc
[199.923009] Starting dynamic subtest: pipe-A-eDP-1
[202.295153] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.398s)
[202.307834] Starting dynamic subtest: pipe-B-eDP-1
[205.376106] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.081s)
[205.393777] Starting dynamic subtest: pipe-C-eDP-1
[208.317183] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.934s)
[208.330265] Starting dynamic subtest: pipe-D-eDP-1
[211.329324] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.001s)
[211.335380] Subtest hang-read-crc: SUCCESS (11.424s)
[212.191996] [118/162] (793s left) kms_pipe_crc_basic (nonblocking-crc)
[212.265904] Starting subtest: nonblocking-crc
[212.272456] Starting dynamic subtest: pipe-A-eDP-1
[213.146385] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.875s)
[213.159303] Starting dynamic subtest: pipe-B-eDP-1
[214.656025] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.502s)
[214.673589] Starting dynamic subtest: pipe-C-eDP-1
[216.078933] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.424s)
[216.096636] Starting dynamic subtest: pipe-D-eDP-1
[217.502034] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.428s)
[217.508286] Subtest nonblocking-crc: SUCCESS (5.236s)
[218.384328] [119/162] (787s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[218.459572] Starting subtest: nonblocking-crc-frame-sequence
[218.465776] Starting dynamic subtest: pipe-A-eDP-1
[219.367383] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.899s)
[219.385034] Starting dynamic subtest: pipe-B-eDP-1
[220.840856] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.476s)
[220.858515] Starting dynamic subtest: pipe-C-eDP-1
[222.286285] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.440s)
[222.303952] Starting dynamic subtest: pipe-D-eDP-1
[223.793086] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.503s)
[223.809647] Subtest nonblocking-crc-frame-sequence: SUCCESS (5.325s)
[224.689084] [120/162] (780s left) kms_pipe_crc_basic (read-crc)
[224.778621] Starting subtest: read-crc
[224.787468] Starting dynamic subtest: pipe-A-eDP-1
[225.589654] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.814s)
[225.607349] Starting dynamic subtest: pipe-B-eDP-1
[227.087099] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.499s)
[227.104843] Starting dynamic subtest: pipe-C-eDP-1
[228.534213] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.439s)
[228.552151] Starting dynamic subtest: pipe-D-eDP-1
[229.920197] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.386s)
[229.933696] Subtest read-crc: SUCCESS (5.145s)
[230.914568] [121/162] (774s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[231.011115] Starting subtest: read-crc-frame-sequence
[231.027844] Starting dynamic subtest: pipe-A-eDP-1
[231.821381] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.805s)
[231.846931] Starting dynamic subtest: pipe-B-eDP-1
[233.291139] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.469s)
[233.313126] Starting dynamic subtest: pipe-C-eDP-1
[234.745500] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.462s)
[234.765626] Starting dynamic subtest: pipe-D-eDP-1
[236.123991] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.370s)
[236.133541] Subtest read-crc-frame-sequence: SUCCESS (5.112s)
[237.019097] [122/162] (768s left) kms_pm_backlight (basic-brightness)
[237.106638] Starting subtest: basic-brightness
[237.174423] Starting dynamic subtest: eDP-1
[237.499379] Dynamic subtest eDP-1: SUCCESS (0.330s)
[237.508742] Subtest basic-brightness: SUCCESS (0.392s)
[238.376519] [123/162] (767s left) kms_pm_rpm (basic-pci-d3-state)
[240.306381] Starting subtest: basic-pci-d3-state
[241.786315] Subtest basic-pci-d3-state: SUCCESS (1.472s)
[241.896281] [124/162] (763s left) kms_pm_rpm (basic-rte)
[241.970351] Starting subtest: basic-rte
[244.886983] Subtest basic-rte: SUCCESS (2.936s)
[246.666366] [125/162] (759s left) kms_psr (psr-primary-page-flip)
[246.743555] Starting subtest: psr-primary-page-flip
[246.750052] Starting dynamic subtest: eDP-1
[248.670879] Dynamic subtest eDP-1: SUCCESS (1.926s)
[248.683656] Subtest psr-primary-page-flip: SUCCESS (1.928s)
[249.500200] [126/162] (756s left) kms_psr (psr-cursor-plane-move)
[249.602836] Starting subtest: psr-cursor-plane-move
[249.615449] Starting dynamic subtest: eDP-1
[251.478883] Dynamic subtest eDP-1: SUCCESS (1.887s)
[251.485010] Subtest psr-cursor-plane-move: SUCCESS (1.888s)
[252.291681] [127/162] (753s left) kms_psr (psr-sprite-plane-onoff)
[252.372187] Starting subtest: psr-sprite-plane-onoff
[252.378394] Starting dynamic subtest: eDP-1
[254.314254] Dynamic subtest eDP-1: SUCCESS (1.944s)
[254.320497] Subtest psr-sprite-plane-onoff: SUCCESS (1.946s)
[255.184796] [128/162] (750s left) kms_psr (psr-primary-mmap-gtt)
[255.277513] Starting subtest: psr-primary-mmap-gtt
[255.294189] Starting dynamic subtest: eDP-1
[256.878559] Dynamic subtest eDP-1: SKIP (1.583s)
[256.901337] Subtest psr-primary-mmap-gtt: SKIP (1.585s)
[257.111629] [129/162] (749s left) kms_setmode (basic-clone-single-crtc)
[257.195410] Starting subtest: basic-clone-single-crtc
[257.234515] Subtest basic-clone-single-crtc: SKIP (0.000s)
[257.306605] [130/162] (748s left) i915_pm_rps (basic-api)
[257.369864] Starting subtest: basic-api
[257.384708] Subtest basic-api: SKIP (0.001s)
[257.455964] [131/162] (748s left) prime_self_import (basic-llseek-bad)
[257.498655] Starting subtest: basic-llseek-bad
[257.511008] Subtest basic-llseek-bad: SUCCESS (0.002s)
[257.605694] [132/162] (748s left) prime_self_import (basic-llseek-size)
[257.653297] Starting subtest: basic-llseek-size
[257.665624] Subtest basic-llseek-size: SUCCESS (0.002s)
[257.738993] [133/162] (748s left) prime_self_import (basic-with_fd_dup)
[257.786125] Starting subtest: basic-with_fd_dup
[257.798412] Subtest basic-with_fd_dup: SUCCESS (0.002s)
[257.888329] [134/162] (748s left) prime_self_import (basic-with_one_bo)
[257.935592] Starting subtest: basic-with_one_bo
[257.947912] Subtest basic-with_one_bo: SUCCESS (0.002s)
[258.058302] [135/162] (748s left) prime_self_import (basic-with_one_bo_two_files)
[258.111921] Starting subtest: basic-with_one_bo_two_files
[258.124122] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s)
[258.205403] [136/162] (748s left) prime_self_import (basic-with_two_bos)
[258.252773] Starting subtest: basic-with_two_bos
[258.265101] Subtest basic-with_two_bos: SUCCESS (0.002s)
[258.372495] [137/162] (748s left) prime_vgem (basic-fence-flip)
[258.445596] Starting subtest: basic-fence-flip
[258.873094] Subtest basic-fence-flip: SUCCESS (0.427s)
[259.032635] [138/162] (747s left) prime_vgem (basic-fence-mmap)
[259.101488] Starting subtest: basic-fence-mmap
[259.113676] Subtest basic-fence-mmap: SKIP (0.000s)
[259.210306] [139/162] (747s left) prime_vgem (basic-fence-read)
[259.311911] Starting subtest: basic-fence-read
[259.334663] Subtest basic-fence-read: SKIP (0.012s)
[259.420276] [140/162] (747s left) prime_vgem (basic-gtt)
[259.516402] Starting subtest: basic-gtt
[259.538970] Subtest basic-gtt: SKIP (0.000s)
[259.628518] [141/162] (747s left) prime_vgem (basic-read)
[259.720789] Starting subtest: basic-read
[259.742648] Subtest basic-read: SKIP (0.012s)
[259.847493] [142/162] (747s left) prime_vgem (basic-write)
[259.930951] Starting subtest: basic-write
[259.953562] Subtest basic-write: SKIP (0.011s)
[260.049538] [143/162] (746s left) vgem_basic (setversion)
[260.124069] Starting subtest: setversion
[260.146744] Subtest setversion: SUCCESS (0.000s)
[260.226902] [144/162] (746s left) vgem_basic (create)
[260.317437] Starting subtest: create
[260.324072] Subtest create: SUCCESS (0.000s)
[260.430936] [145/162] (746s left) vgem_basic (debugfs)
[260.519977] Starting subtest: debugfs
[260.526487] Subtest debugfs: SUCCESS (0.000s)
[260.606723] [146/162] (746s left) vgem_basic (dmabuf-export)
[260.687991] Starting subtest: dmabuf-export
[260.710968] Subtest dmabuf-export: SUCCESS (0.003s)
[260.796059] [147/162] (746s left) vgem_basic (dmabuf-fence)
[260.870118] Starting subtest: dmabuf-fence
[260.886608] Subtest dmabuf-fence: SUCCESS (0.000s)
[260.952923] [148/162] (746s left) vgem_basic (dmabuf-fence-before)
[261.041070] Starting subtest: dmabuf-fence-before
[261.054521] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[261.118512] [149/162] (746s left) vgem_basic (dmabuf-mmap)
[261.181146] Starting subtest: dmabuf-mmap
[261.188393] Subtest dmabuf-mmap: SUCCESS (0.020s)
[261.270177] [150/162] (746s left) vgem_basic (mmap)
[261.350193] Starting subtest: mmap
[261.358899] Subtest mmap: SUCCESS (0.012s)
[261.429881] [151/162] (746s left) vgem_basic (second-client)
[261.521564] Starting subtest: second-client
[261.551264] Subtest second-client: SUCCESS (0.033s)
[261.642059] [152/162] (745s left) vgem_basic (sysfs)
[261.723751] Starting subtest: sysfs
[261.730747] Subtest sysfs: SUCCESS (0.000s)
[261.796873] [153/162] (745s left) core_hotunplug (unbind-rebind)
[261.893273] Starting subtest: unbind-rebind
[268.255618] Subtest unbind-rebind: SUCCESS (6.366s)
[268.327024] [154/162] (739s left) vgem_basic (unload)
[268.403373] Starting subtest: unload
[297.471063] Subtest unload: SUCCESS (29.069s)
[298.172556] [155/162] (709s left) i915_module_load (reload)
[298.486110] Starting subtest: reload
[306.381828] Subtest reload: SUCCESS (7.909s)
[306.511629] [156/162] (701s left) gem_lmem_swapping (basic)
[306.670131] Subtest basic: SKIP (0.000s)
[306.829346] [157/162] (701s left) gem_lmem_swapping (parallel-random-engines)
[306.982587] Subtest parallel-random-engines: SKIP (0.000s)
[307.123442] [158/162] (701s left) gem_lmem_swapping (random-engines)
[307.271470] Subtest random-engines: SKIP (0.000s)
[307.405242] [159/162] (701s left) gem_lmem_swapping (verify-random)
[307.548679] Subtest verify-random: SKIP (0.000s)
[307.679117] [160/162] (701s left) i915_pm_rpm (module-reload)
[310.048919] Starting subtest: module-reload
[329.209290] Subtest module-reload: SUCCESS (19.149s)
[329.285397] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[329.286981] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[329.301839] [161/162] (679s left) i915_selftest (live)