[39.547673] Initializing watchdogs
[39.547733]   /dev/watchdog0
[39.565492] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d51 Intel Meteorlake (Gen12) 
[39.584522] [001/162] (960s left) i915_module_load (load)
[39.667837] Starting subtest: load
[43.045045] Subtest load: SUCCESS (3.405s)
[43.118998] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[43.122477] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[43.131681] [002/162] (957s left) core_auth (basic-auth)
[44.245883] Starting subtest: basic-auth
[44.252673] Subtest basic-auth: SUCCESS (0.002s)
[44.394484] [003/162] (955s left) core_debugfs (read-all-entries)
[44.527967] Starting subtest: read-all-entries
[44.677343] Subtest read-all-entries: SUCCESS (0.174s)
[44.821861] [004/162] (955s left) core_sysfs (read-all-entries)
[44.940390] Starting subtest: read-all-entries
[44.953588] Subtest read-all-entries: SUCCESS (0.013s)
[45.093979] [005/162] (955s left) fbdev (eof)
[45.208723] Starting subtest: eof
[45.215330] Subtest eof: SUCCESS (0.000s)
[45.351057] [006/162] (955s left) fbdev (info)
[45.447947] Starting subtest: info
[45.454627] Subtest info: SUCCESS (0.000s)
[45.583863] [007/162] (955s left) fbdev (nullptr)
[45.687730] Starting subtest: nullptr
[45.695129] Subtest nullptr: SUCCESS (0.000s)
[45.886192] [008/162] (954s left) fbdev (read)
[45.980966] Starting subtest: read
[47.504290] Subtest read: SUCCESS (1.517s)
[47.632437] [009/162] (953s left) fbdev (write)
[47.764322] Starting subtest: write
[48.851760] Subtest write: SUCCESS (1.085s)
[49.006709] [010/162] (952s left) gem_basic (bad-close)
[49.123352] Starting subtest: bad-close
[49.145433] Subtest bad-close: SUCCESS (0.000s)
[49.284285] [011/162] (951s left) gem_basic (create-close)
[49.411277] Starting subtest: create-close
[49.430359] Subtest create-close: SUCCESS (0.000s)
[49.579935] [012/162] (951s left) gem_basic (create-fd-close)
[49.688704] Starting subtest: create-fd-close
[49.711688] Subtest create-fd-close: SUCCESS (0.000s)
[49.851656] [013/162] (951s left) gem_busy (busy@all-engines)
[49.972115] Starting subtest: busy
[49.988680] Starting dynamic subtest: all-engines
[50.011960] Dynamic subtest all-engines: SUCCESS (0.043s)
[50.018277] Subtest busy: SUCCESS (0.043s)
[51.325924] [014/162] (950s left) gem_close_race (basic-process)
[51.429721] Starting subtest: basic-process
[51.474051] Subtest basic-process: SUCCESS (0.046s)
[51.761645] [015/162] (949s left) gem_close_race (basic-threads)
[51.835573] Starting subtest: basic-threads
[53.079699] Subtest basic-threads: SUCCESS (1.284s)
[53.305125] [016/162] (948s left) gem_ctx_create (basic)
[53.379662] Starting subtest: basic
[53.395782] Subtest basic: SUCCESS (0.000s)
[53.587075] [017/162] (948s left) gem_ctx_create (basic-files)
[53.657603] Starting subtest: basic-files
[55.669745] Subtest basic-files: SUCCESS (2.051s)
[57.323960] [018/162] (944s left) gem_ctx_exec (basic)
[57.406140] Starting subtest: basic
[57.412191] Subtest basic: SUCCESS (0.006s)
[57.576352] [019/162] (944s left) gem_exec_basic (basic)
[57.648636] Starting subtest: basic
[57.664911] Starting dynamic subtest: rcs0-smem
[57.671224] Dynamic subtest rcs0-smem: SUCCESS (0.004s)
[57.687542] Starting dynamic subtest: bcs0-smem
[57.693765] Dynamic subtest bcs0-smem: SUCCESS (0.003s)
[57.710066] Starting dynamic subtest: vcs0-smem
[57.716371] Dynamic subtest vcs0-smem: SUCCESS (0.003s)
[57.732851] Starting dynamic subtest: vcs1-smem
[57.739147] Dynamic subtest vcs1-smem: SUCCESS (0.003s)
[57.755554] Starting dynamic subtest: vecs0-smem
[57.761827] Dynamic subtest vecs0-smem: SUCCESS (0.004s)
[57.778059] Starting dynamic subtest: ccs0-smem
[57.784285] Dynamic subtest ccs0-smem: SUCCESS (0.004s)
[57.800435] Subtest basic: SUCCESS (0.023s)
[59.292654] [020/162] (942s left) gem_exec_create (basic)
[59.372477] Starting subtest: basic
[59.379577] Starting dynamic subtest: smem
[63.206272] Dynamic subtest smem: SUCCESS (3.879s)
[63.214224] Subtest basic: SUCCESS (3.879s)
[63.434941] [021/162] (938s left) gem_exec_fence (basic-busy)
[63.606220] Starting subtest: basic-busy
[63.612957] Starting dynamic subtest: rcs0
[63.688582] Dynamic subtest rcs0: SUCCESS (0.085s)
[63.720821] Starting dynamic subtest: bcs0
[63.744695] Dynamic subtest bcs0: SUCCESS (0.051s)
[63.775095] Starting dynamic subtest: vcs0
[63.788717] Dynamic subtest vcs0: SUCCESS (0.049s)
[63.820536] Starting dynamic subtest: vcs1
[63.841917] Dynamic subtest vcs1: SUCCESS (0.051s)
[63.874121] Starting dynamic subtest: vecs0
[63.895310] Dynamic subtest vecs0: SUCCESS (0.051s)
[63.929306] Starting dynamic subtest: ccs0
[63.953064] Dynamic subtest ccs0: SUCCESS (0.054s)
[63.959720] Subtest basic-busy: SUCCESS (0.343s)
[65.351169] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[65.359681] [022/162] (936s left) gem_exec_fence (basic-wait)
[65.527032] Starting subtest: basic-wait
[65.533394] Starting dynamic subtest: rcs0
[65.609545] Dynamic subtest rcs0: SUCCESS (0.086s)
[65.620914] Starting dynamic subtest: bcs0
[65.667811] Dynamic subtest bcs0: SUCCESS (0.058s)
[65.679493] Starting dynamic subtest: vcs0
[65.718148] Dynamic subtest vcs0: SUCCESS (0.050s)
[65.729470] Starting dynamic subtest: vcs1
[65.775960] Dynamic subtest vcs1: SUCCESS (0.058s)
[65.787196] Starting dynamic subtest: vecs0
[65.826805] Dynamic subtest vecs0: SUCCESS (0.051s)
[65.838022] Starting dynamic subtest: ccs0
[65.880443] Dynamic subtest ccs0: SUCCESS (0.054s)
[65.886640] Subtest basic-wait: SUCCESS (0.358s)
[67.345917] [023/162] (934s left) gem_exec_fence (basic-await)
[67.520374] Starting subtest: basic-await
[67.536700] Starting dynamic subtest: rcs0
[67.608445] Dynamic subtest rcs0: SUCCESS (0.094s)
[67.630361] Starting dynamic subtest: bcs0
[67.696542] Dynamic subtest bcs0: SUCCESS (0.083s)
[67.714333] Starting dynamic subtest: vcs0
[67.770255] Dynamic subtest vcs0: SUCCESS (0.080s)
[67.805529] Starting dynamic subtest: vcs1
[67.861408] Dynamic subtest vcs1: SUCCESS (0.085s)
[67.883383] Starting dynamic subtest: vecs0
[67.944572] Dynamic subtest vecs0: SUCCESS (0.083s)
[67.966049] Starting dynamic subtest: ccs0
[68.030886] Dynamic subtest ccs0: SUCCESS (0.086s)
[68.037668] Subtest basic-await: SUCCESS (0.513s)
[70.407438] [024/162] (931s left) gem_exec_fence (nb-await)
[70.591074] Starting subtest: nb-await
[70.607457] Starting dynamic subtest: rcs0
[70.677504] Dynamic subtest rcs0: SUCCESS (0.084s)
[70.695327] Starting dynamic subtest: bcs0
[70.738240] Dynamic subtest bcs0: SUCCESS (0.066s)
[70.757623] Starting dynamic subtest: vcs0
[70.808347] Dynamic subtest vcs0: SUCCESS (0.064s)
[70.826170] Starting dynamic subtest: vcs1
[70.866949] Dynamic subtest vcs1: SUCCESS (0.064s)
[70.886265] Starting dynamic subtest: vecs0
[70.927093] Dynamic subtest vecs0: SUCCESS (0.064s)
[70.938589] Starting dynamic subtest: ccs0
[70.990312] Dynamic subtest ccs0: SUCCESS (0.063s)
[70.996529] Subtest nb-await: SUCCESS (0.407s)
[72.457817] [025/162] (930s left) gem_exec_gttfill (basic)
[72.580957] Starting subtest: basic
[76.376801] Subtest basic: SUCCESS (3.805s)
[76.600237] [026/162] (925s left) gem_exec_parallel (engines)
[76.704908] Starting subtest: engines
[76.712673] Starting dynamic subtest: basic
[80.229298] Dynamic subtest basic: SUCCESS (3.528s)
[80.246623] Starting dynamic subtest: contexts
[84.996912] Dynamic subtest contexts: SUCCESS (4.766s)
[85.018931] Starting dynamic subtest: fds
[90.356679] Dynamic subtest fds: SUCCESS (5.362s)
[90.376025] Starting dynamic subtest: userptr
[92.266051] Dynamic subtest userptr: SUCCESS (1.904s)
[92.272385] Subtest engines: SUCCESS (15.562s)
[92.466694] [027/162] (910s left) gem_exec_store (basic)
[92.582682] Starting subtest: basic
[92.654926] Subtest basic: SUCCESS (0.120s)
[92.955947] [028/162] (909s left) gem_flink_basic (bad-flink)
[93.041877] Starting subtest: bad-flink
[93.047970] Subtest bad-flink: SUCCESS (0.000s)
[93.143634] [029/162] (909s left) gem_flink_basic (bad-open)
[93.210968] Starting subtest: bad-open
[93.217291] Subtest bad-open: SUCCESS (0.000s)
[93.315959] [030/162] (909s left) gem_flink_basic (basic)
[93.389378] Starting subtest: basic
[93.405801] Subtest basic: SUCCESS (0.000s)
[93.501379] [031/162] (909s left) gem_flink_basic (double-flink)
[93.577077] Starting subtest: double-flink
[93.586393] Subtest double-flink: SUCCESS (0.000s)
[93.665042] [032/162] (909s left) gem_flink_basic (flink-lifetime)
[93.747003] Starting subtest: flink-lifetime
[93.753111] Subtest flink-lifetime: SUCCESS (0.001s)
[93.856232] [033/162] (909s left) gem_huc_copy (huc-copy)
[93.948776] Starting subtest: huc-copy
[93.965286] Subtest huc-copy: SUCCESS (0.005s)
[94.076731] [034/162] (909s left) gem_linear_blits (basic)
[94.253207] Starting subtest: basic
[94.264753] Subtest basic: SUCCESS (0.021s)
[94.422371] [035/162] (908s left) gem_mmap (basic)
[94.530258] Subtest basic: SKIP (0.000s)
[94.608931] [036/162] (908s left) gem_mmap_gtt (basic)
[94.698384] Subtest basic: SKIP (0.000s)
[94.763058] [037/162] (908s left) gem_render_linear_blits (basic)
[94.842442] Starting subtest: basic
[94.895060] Subtest basic: SUCCESS (0.040s)
[95.000590] [038/162] (908s left) gem_render_tiled_blits (basic)
[95.087860] Subtest basic: SKIP (0.000s)
[95.150705] [039/162] (908s left) gem_ringfill (basic-all)
[101.301472] Starting subtest: basic-all
[102.459994] Subtest basic-all: SUCCESS (1.170s)
[102.609127] [040/162] (900s left) gem_softpin (allocator-basic)
[102.674961] Starting subtest: allocator-basic
[102.784728] Subtest allocator-basic: SUCCESS (0.109s)
[102.981105] [041/162] (900s left) gem_softpin (allocator-basic-reserve)
[103.056881] Starting subtest: allocator-basic-reserve
[103.158288] Subtest allocator-basic-reserve: SUCCESS (0.110s)
[103.323252] [042/162] (900s left) gem_softpin (safe-alignment)
[103.414744] Starting subtest: safe-alignment
[103.437645] Subtest safe-alignment: SUCCESS (0.038s)
[105.310771] [043/162] (898s left) gem_sync (basic-all)
[105.467124] Starting subtest: basic-all
[109.221249] Subtest basic-all: SUCCESS (3.844s)
[109.525407] [044/162] (894s left) gem_sync (basic-each)
[109.687994] Starting subtest: basic-each
[112.112580] Subtest basic-each: SUCCESS (2.517s)
[112.318905] [045/162] (891s left) gem_tiled_blits (basic)
[112.411435] Subtest basic: SKIP (0.000s)
[112.487053] [046/162] (891s left) gem_tiled_fence_blits (basic)
[112.572523] Subtest basic: SKIP (0.000s)
[112.643633] [047/162] (891s left) gem_tiled_pread_basic (basic)
[112.722552] Subtest basic: SKIP (0.000s)
[112.805819] [048/162] (891s left) gem_wait (busy@all-engines)
[112.880583] Starting subtest: busy
[112.897056] Starting dynamic subtest: all-engines
[114.219454] Dynamic subtest all-engines: SUCCESS (1.326s)
[114.228131] Subtest busy: SUCCESS (1.327s)
[114.452429] [049/162] (889s left) gem_wait (wait@all-engines)
[114.539605] Starting subtest: wait
[114.546194] Starting dynamic subtest: all-engines
[116.267226] Dynamic subtest all-engines: SUCCESS (1.725s)
[116.273850] Subtest wait: SUCCESS (1.725s)
[116.468156] [050/162] (887s left) i915_getparams_basic (basic-eu-total)
[116.552093] Starting subtest: basic-eu-total
[116.574081] Subtest basic-eu-total: SUCCESS (0.000s)
[116.668546] [051/162] (887s left) i915_getparams_basic (basic-subslice-total)
[116.759271] Starting subtest: basic-subslice-total
[116.781412] Subtest basic-subslice-total: SUCCESS (0.000s)
[116.863305] [052/162] (887s left) i915_hangman (error-state-basic)
[116.941681] Starting subtest: error-state-basic
[117.077966] Subtest error-state-basic: SUCCESS (0.131s)
[117.178017] [053/162] (887s left) i915_pciid
[117.353908] [054/162] (887s left) intel_hwmon (hwmon-read)
[117.433184] Subtest hwmon-read: SKIP (0.000s)
[117.512359] [055/162] (887s left) intel_hwmon (hwmon-write)
[117.604367] Subtest hwmon-write: SKIP (0.000s)
[117.669274] [056/162] (887s left) kms_addfb_basic (addfb25-4-tiled)
[117.783741] Starting subtest: addfb25-4-tiled
[117.797034] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[117.895453] [057/162] (887s left) kms_addfb_basic (addfb25-bad-modifier)
[117.992536] Starting subtest: addfb25-bad-modifier
[118.008962] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[118.114898] [058/162] (886s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[118.227917] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[118.321558] [059/162] (886s left) kms_addfb_basic (addfb25-modifier-no-flag)
[118.419396] Starting subtest: addfb25-modifier-no-flag
[118.435863] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[118.530966] [060/162] (886s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[118.635295] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[118.720130] [061/162] (886s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[118.823818] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[118.925821] [062/162] (886s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[119.033595] Starting subtest: addfb25-yf-tiled-legacy
[119.039697] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[119.133270] [063/162] (886s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[119.231043] Starting subtest: addfb25-y-tiled-legacy
[119.247449] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[119.334082] [064/162] (886s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[119.438407] Starting subtest: addfb25-y-tiled-small-legacy
[119.463434] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[119.542727] [065/162] (885s left) kms_addfb_basic (bad-pitch-0)
[119.613875] Starting subtest: bad-pitch-0
[119.626170] Subtest bad-pitch-0: SUCCESS (0.000s)
[119.766772] [066/162] (885s left) kms_addfb_basic (bad-pitch-1024)
[119.840575] Starting subtest: bad-pitch-1024
[119.856923] Subtest bad-pitch-1024: SUCCESS (0.000s)
[119.979518] [067/162] (885s left) kms_addfb_basic (bad-pitch-128)
[120.038701] Starting subtest: bad-pitch-128
[120.045423] Subtest bad-pitch-128: SUCCESS (0.000s)
[120.198162] [068/162] (885s left) kms_addfb_basic (bad-pitch-256)
[120.277415] Starting subtest: bad-pitch-256
[120.285976] Subtest bad-pitch-256: SUCCESS (0.000s)
[120.438507] [069/162] (885s left) kms_addfb_basic (bad-pitch-32)
[120.524708] Starting subtest: bad-pitch-32
[120.531069] Subtest bad-pitch-32: SUCCESS (0.000s)
[120.653035] [070/162] (885s left) kms_addfb_basic (bad-pitch-63)
[120.731987] Starting subtest: bad-pitch-63
[120.744611] Subtest bad-pitch-63: SUCCESS (0.000s)
[120.865865] [071/162] (884s left) kms_addfb_basic (bad-pitch-65536)
[120.956713] Starting subtest: bad-pitch-65536
[120.962797] Subtest bad-pitch-65536: SUCCESS (0.000s)
[121.086517] [072/162] (884s left) kms_addfb_basic (bad-pitch-999)
[121.149515] Starting subtest: bad-pitch-999
[121.158685] Subtest bad-pitch-999: SUCCESS (0.000s)
[121.295333] [073/162] (884s left) kms_addfb_basic (basic)
[121.369178] Starting subtest: basic
[121.385589] Subtest basic: SUCCESS (0.000s)
[121.509315] [074/162] (884s left) kms_addfb_basic (basic-x-tiled-legacy)
[121.582072] Starting subtest: basic-x-tiled-legacy
[121.604688] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[121.727728] [075/162] (884s left) kms_addfb_basic (basic-y-tiled-legacy)
[121.803762] Starting subtest: basic-y-tiled-legacy
[121.819874] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[121.929619] [076/162] (884s left) kms_addfb_basic (bo-too-small)
[122.014441] Starting subtest: bo-too-small
[122.027758] Subtest bo-too-small: SUCCESS (0.000s)
[122.141744] [077/162] (884s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[122.228799] Starting subtest: bo-too-small-due-to-tiling
[122.251496] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[122.340431] [078/162] (883s left) kms_addfb_basic (clobberred-modifier)
[122.423693] Starting subtest: clobberred-modifier
[122.442769] Subtest clobberred-modifier: SKIP (0.000s)
[122.545547] [079/162] (883s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[122.616605] Starting subtest: framebuffer-vs-set-tiling
[122.638507] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[122.752949] [080/162] (883s left) kms_addfb_basic (invalid-get-prop)
[122.815072] Starting subtest: invalid-get-prop
[122.821690] Subtest invalid-get-prop: SUCCESS (0.000s)
[122.960407] [081/162] (883s left) kms_addfb_basic (invalid-get-prop-any)
[123.034190] Starting subtest: invalid-get-prop-any
[123.050796] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[123.183108] [082/162] (883s left) kms_addfb_basic (invalid-set-prop)
[123.270841] Starting subtest: invalid-set-prop
[123.277052] Subtest invalid-set-prop: SUCCESS (0.000s)
[123.400194] [083/162] (883s left) kms_addfb_basic (invalid-set-prop-any)
[123.490746] Starting subtest: invalid-set-prop-any
[123.497051] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[123.594030] [084/162] (882s left) kms_addfb_basic (no-handle)
[123.679826] Starting subtest: no-handle
[123.696442] Subtest no-handle: SUCCESS (0.000s)
[123.804291] [085/162] (882s left) kms_addfb_basic (size-max)
[123.900062] Starting subtest: size-max
[123.916643] Subtest size-max: SUCCESS (0.000s)
[124.024704] [086/162] (882s left) kms_addfb_basic (small-bo)
[124.115259] Starting subtest: small-bo
[124.121507] Subtest small-bo: SUCCESS (0.000s)
[124.242204] [087/162] (882s left) kms_addfb_basic (tile-pitch-mismatch)
[124.304033] Starting subtest: tile-pitch-mismatch
[124.326081] Subtest tile-pitch-mismatch: SKIP (0.000s)
[124.455307] [088/162] (882s left) kms_addfb_basic (too-high)
[124.552726] Starting subtest: too-high
[124.569224] Subtest too-high: SUCCESS (0.001s)
[124.678728] [089/162] (882s left) kms_addfb_basic (too-wide)
[124.767053] Starting subtest: too-wide
[124.780351] Subtest too-wide: SUCCESS (0.000s)
[124.893559] [090/162] (882s left) kms_addfb_basic (unused-handle)
[124.960416] Starting subtest: unused-handle
[124.966623] Subtest unused-handle: SUCCESS (0.000s)
[125.097603] [091/162] (881s left) kms_addfb_basic (unused-modifier)
[125.165805] Starting subtest: unused-modifier
[125.172008] Subtest unused-modifier: SUCCESS (0.000s)
[125.317398] [092/162] (881s left) kms_addfb_basic (unused-offsets)
[125.384901] Starting subtest: unused-offsets
[125.391180] Subtest unused-offsets: SUCCESS (0.000s)
[125.528211] [093/162] (881s left) kms_addfb_basic (unused-pitches)
[125.602257] Starting subtest: unused-pitches
[125.616286] Subtest unused-pitches: SUCCESS (0.000s)
[125.731232] [094/162] (881s left) kms_busy (basic)
[125.819043] Starting subtest: basic
[125.825248] Starting dynamic subtest: flip
[126.599384] Dynamic subtest flip: SUCCESS (0.782s)
[126.643885] Starting dynamic subtest: modeset
[130.037713] Dynamic subtest modeset: SUCCESS (3.436s)
[130.054069] Subtest basic: SUCCESS (4.219s)
[130.860862] [095/162] (876s left) kms_prop_blob (basic)
[130.940190] Starting subtest: basic
[130.948839] Subtest basic: SUCCESS (0.000s)
[131.018790] [096/162] (876s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[131.133020] Starting subtest: basic-busy-flip-before-cursor-atomic
[131.152508] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[131.277975] [097/162] (876s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[131.401534] Starting subtest: basic-busy-flip-before-cursor-legacy
[131.420162] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[131.557168] [098/162] (875s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[131.692802] Starting subtest: basic-flip-after-cursor-atomic
[132.964281] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.266s)
[133.795164] [099/162] (873s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[133.916208] Starting subtest: basic-flip-after-cursor-legacy
[135.137757] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.223s)
[136.053927] [100/162] (871s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[136.179305] Starting subtest: basic-flip-after-cursor-varying-size
[137.406437] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.226s)
[138.363699] [101/162] (869s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[138.489443] Starting subtest: basic-flip-before-cursor-atomic
[139.720141] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.225s)
[140.688790] [102/162] (867s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[140.814843] Starting subtest: basic-flip-before-cursor-legacy
[142.022227] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.208s)
[142.932317] [103/162] (865s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[143.067307] Starting subtest: basic-flip-before-cursor-varying-size
[144.283930] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.224s)
[145.186950] [104/162] (862s left) kms_dsc (dsc-basic)
[145.280469] Starting subtest: dsc-basic
[145.349312] Subtest dsc-basic: SKIP (0.000s)
[145.415623] [105/162] (862s left) kms_flip (basic-flip-vs-dpms)
[145.517061] Starting subtest: basic-flip-vs-dpms
[145.525752] Starting dynamic subtest: A-eDP1
[148.063702] Dynamic subtest A-eDP1: SUCCESS (2.554s)
[148.078549] Starting dynamic subtest: B-eDP1
[150.231963] Dynamic subtest B-eDP1: SUCCESS (2.166s)
[150.249753] Starting dynamic subtest: C-eDP1
[152.391087] Dynamic subtest C-eDP1: SUCCESS (2.164s)
[152.408950] Starting dynamic subtest: D-eDP1
[154.570607] Dynamic subtest D-eDP1: SUCCESS (2.172s)
[154.587084] Subtest basic-flip-vs-dpms: SUCCESS (9.066s)
[155.476171] [106/162] (852s left) kms_flip (basic-flip-vs-modeset)
[155.587686] Starting subtest: basic-flip-vs-modeset
[155.594056] Starting dynamic subtest: A-eDP1
[158.159979] Dynamic subtest A-eDP1: SUCCESS (2.587s)
[158.175940] Starting dynamic subtest: B-eDP1
[160.320980] Dynamic subtest B-eDP1: SUCCESS (2.158s)
[160.334606] Starting dynamic subtest: C-eDP1
[162.471985] Dynamic subtest C-eDP1: SUCCESS (2.156s)
[162.489764] Starting dynamic subtest: D-eDP1
[164.642006] Dynamic subtest D-eDP1: SUCCESS (2.167s)
[164.658506] Subtest basic-flip-vs-modeset: SUCCESS (9.075s)
[165.458118] [107/162] (842s left) kms_flip (basic-flip-vs-wf_vblank)
[165.554859] Starting subtest: basic-flip-vs-wf_vblank
[165.564466] Starting dynamic subtest: A-eDP1
[167.552468] Dynamic subtest A-eDP1: SUCCESS (2.000s)
[167.599375] Starting dynamic subtest: B-eDP1
[169.694571] Dynamic subtest B-eDP1: SUCCESS (2.141s)
[169.717732] Starting dynamic subtest: C-eDP1
[171.727885] Dynamic subtest C-eDP1: SUCCESS (2.015s)
[171.750955] Starting dynamic subtest: D-eDP1
[173.768268] Dynamic subtest D-eDP1: SUCCESS (2.040s)
[173.776678] Subtest basic-flip-vs-wf_vblank: SUCCESS (8.213s)
[175.009659] [108/162] (833s left) kms_flip (basic-plain-flip)
[175.099511] Starting subtest: basic-plain-flip
[175.107748] Starting dynamic subtest: A-eDP1
[176.869799] Dynamic subtest A-eDP1: SUCCESS (1.764s)
[176.919662] Starting dynamic subtest: B-eDP1
[178.718651] Dynamic subtest B-eDP1: SUCCESS (1.846s)
[178.766126] Starting dynamic subtest: C-eDP1
[180.449070] Dynamic subtest C-eDP1: SUCCESS (1.716s)
[180.493593] Starting dynamic subtest: D-eDP1
[182.159667] Dynamic subtest D-eDP1: SUCCESS (1.728s)
[182.166192] Subtest basic-plain-flip: SUCCESS (7.071s)
[183.538692] [109/162] (825s left) kms_force_connector_basic (force-connector-state)
[183.610827] Starting subtest: force-connector-state
[184.205698] Subtest force-connector-state: SUCCESS (0.589s)
[185.177709] [110/162] (823s left) kms_force_connector_basic (force-edid)
[185.252237] Starting subtest: force-edid
[185.549973] Subtest force-edid: SUCCESS (0.295s)
[185.685900] [111/162] (823s left) kms_force_connector_basic (force-load-detect)
[185.774012] Starting subtest: force-load-detect
[185.786279] Subtest force-load-detect: SKIP (0.000s)
[185.871621] [112/162] (822s left) kms_force_connector_basic (prune-stale-modes)
[185.931298] Starting subtest: prune-stale-modes
[186.284808] Subtest prune-stale-modes: SUCCESS (0.356s)
[186.421699] [113/162] (822s left) kms_frontbuffer_tracking (basic)
[186.509288] Starting subtest: basic
[191.971853] Subtest basic: SUCCESS (5.468s)
[192.103085] [114/162] (816s left) kms_hdmi_inject (inject-audio)
[192.452159] Starting subtest: inject-audio
[192.709621] Subtest inject-audio: SUCCESS (0.254s)
[193.299297] [115/162] (815s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[193.378756] Starting subtest: compare-crc-sanitycheck-xr24
[193.385545] Starting dynamic subtest: pipe-A-eDP-1
[194.113820] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.731s)
[194.133743] Starting dynamic subtest: pipe-B-eDP-1
[195.600232] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.483s)
[195.630072] Starting dynamic subtest: pipe-C-eDP-1
[196.998130] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.397s)
[197.020046] Starting dynamic subtest: pipe-D-eDP-1
[198.387090] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.381s)
[198.396716] Subtest compare-crc-sanitycheck-xr24: SUCCESS (5.003s)
[199.313326] [116/162] (809s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[199.409650] Starting subtest: compare-crc-sanitycheck-nv12
[199.426178] Starting dynamic subtest: pipe-A-eDP-1
[200.331645] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.925s)
[200.346329] Starting dynamic subtest: pipe-B-eDP-1
[201.784078] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.439s)
[201.805844] Starting dynamic subtest: pipe-C-eDP-1
[203.157914] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.376s)
[203.174143] Starting dynamic subtest: pipe-D-eDP-1
[204.463704] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.311s)
[204.470174] Subtest compare-crc-sanitycheck-nv12: SUCCESS (5.062s)
[205.278434] [117/162] (803s left) kms_pipe_crc_basic (hang-read-crc)
[205.355477] Starting subtest: hang-read-crc
[205.362109] Starting dynamic subtest: pipe-A-eDP-1
[207.777225] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.417s)
[207.790791] Starting dynamic subtest: pipe-B-eDP-1
[210.859555] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.084s)
[210.877377] Starting dynamic subtest: pipe-C-eDP-1
[213.789648] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.926s)
[213.807277] Starting dynamic subtest: pipe-D-eDP-1
[216.800008] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.004s)
[216.806319] Subtest hang-read-crc: SUCCESS (11.441s)
[217.666666] [118/162] (791s left) kms_pipe_crc_basic (nonblocking-crc)
[217.745612] Starting subtest: nonblocking-crc
[217.751912] Starting dynamic subtest: pipe-A-eDP-1
[218.628580] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.876s)
[218.641866] Starting dynamic subtest: pipe-B-eDP-1
[220.107935] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.478s)
[220.121059] Starting dynamic subtest: pipe-C-eDP-1
[221.579382] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.465s)
[221.598078] Starting dynamic subtest: pipe-D-eDP-1
[223.080728] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.503s)
[223.086898] Subtest nonblocking-crc: SUCCESS (5.329s)
[223.953306] [119/162] (785s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[224.034669] Starting subtest: nonblocking-crc-frame-sequence
[224.041024] Starting dynamic subtest: pipe-A-eDP-1
[224.920314] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.881s)
[224.941169] Starting dynamic subtest: pipe-B-eDP-1
[226.425938] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.501s)
[226.450987] Starting dynamic subtest: pipe-C-eDP-1
[227.850458] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.432s)
[227.870478] Starting dynamic subtest: pipe-D-eDP-1
[229.355357] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.503s)
[229.361723] Subtest nonblocking-crc-frame-sequence: SUCCESS (5.323s)
[230.279948] [120/162] (779s left) kms_pipe_crc_basic (read-crc)
[230.357749] Starting subtest: read-crc
[230.363958] Starting dynamic subtest: pipe-A-eDP-1
[231.344526] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.973s)
[231.366159] Starting dynamic subtest: pipe-B-eDP-1
[232.834210] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.500s)
[232.851519] Starting dynamic subtest: pipe-C-eDP-1
[234.284623] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.445s)
[234.297677] Starting dynamic subtest: pipe-D-eDP-1
[235.782145] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.495s)
[235.797432] Subtest read-crc: SUCCESS (5.423s)
[236.665196] [121/162] (772s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[236.741811] Starting subtest: read-crc-frame-sequence
[236.748509] Starting dynamic subtest: pipe-A-eDP-1
[237.557960] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.811s)
[237.570958] Starting dynamic subtest: pipe-B-eDP-1
[239.053796] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.493s)
[239.067415] Starting dynamic subtest: pipe-C-eDP-1
[240.413772] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.365s)
[240.426954] Starting dynamic subtest: pipe-D-eDP-1
[241.792952] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.373s)
[241.805082] Subtest read-crc-frame-sequence: SUCCESS (5.048s)
[242.656593] [122/162] (766s left) kms_pm_backlight (basic-brightness)
[242.745849] Starting subtest: basic-brightness
[242.816399] Starting dynamic subtest: eDP-1
[243.137272] Dynamic subtest eDP-1: SUCCESS (0.329s)
[243.146878] Subtest basic-brightness: SUCCESS (0.393s)
[243.969732] [123/162] (765s left) kms_pm_rpm (basic-pci-d3-state)
[245.493520] Starting subtest: basic-pci-d3-state
[246.962467] Subtest basic-pci-d3-state: SUCCESS (1.467s)
[247.081922] [124/162] (762s left) kms_pm_rpm (basic-rte)
[247.137988] Starting subtest: basic-rte
[250.866457] Subtest basic-rte: SUCCESS (3.738s)
[252.652037] [125/162] (756s left) kms_psr (psr-primary-page-flip)
[252.731255] Starting subtest: psr-primary-page-flip
[252.737548] Starting dynamic subtest: eDP-1
[254.652738] Dynamic subtest eDP-1: SUCCESS (1.918s)
[254.658817] Subtest psr-primary-page-flip: SUCCESS (1.920s)
[255.574032] [126/162] (754s left) kms_psr (psr-cursor-plane-move)
[255.671828] Starting subtest: psr-cursor-plane-move
[255.688340] Starting dynamic subtest: eDP-1
[257.536919] Dynamic subtest eDP-1: SUCCESS (1.873s)
[257.553510] Subtest psr-cursor-plane-move: SUCCESS (1.875s)
[258.366284] [127/162] (751s left) kms_psr (psr-sprite-plane-onoff)
[258.455066] Starting subtest: psr-sprite-plane-onoff
[258.464319] Starting dynamic subtest: eDP-1
[260.385927] Dynamic subtest eDP-1: SUCCESS (1.931s)
[260.392394] Subtest psr-sprite-plane-onoff: SUCCESS (1.933s)
[261.281625] [128/162] (748s left) kms_psr (psr-primary-mmap-gtt)
[261.375548] Starting subtest: psr-primary-mmap-gtt
[261.387343] Starting dynamic subtest: eDP-1
[262.952210] Dynamic subtest eDP-1: SKIP (1.566s)
[262.964692] Subtest psr-primary-mmap-gtt: SKIP (1.567s)
[263.219640] [129/162] (746s left) kms_setmode (basic-clone-single-crtc)
[263.293962] Starting subtest: basic-clone-single-crtc
[263.327669] Subtest basic-clone-single-crtc: SKIP (0.000s)
[263.394277] [130/162] (746s left) i915_pm_rps (basic-api)
[263.477456] Starting subtest: basic-api
[263.496788] Subtest basic-api: SKIP (0.001s)
[263.586736] [131/162] (746s left) prime_self_import (basic-llseek-bad)
[263.663188] Starting subtest: basic-llseek-bad
[263.684481] Subtest basic-llseek-bad: SUCCESS (0.002s)
[263.771472] [132/162] (746s left) prime_self_import (basic-llseek-size)
[263.856642] Starting subtest: basic-llseek-size
[263.869852] Subtest basic-llseek-size: SUCCESS (0.002s)
[263.957531] [133/162] (746s left) prime_self_import (basic-with_fd_dup)
[264.027817] Starting subtest: basic-with_fd_dup
[264.050729] Subtest basic-with_fd_dup: SUCCESS (0.003s)
[264.140524] [134/162] (746s left) prime_self_import (basic-with_one_bo)
[264.214658] Starting subtest: basic-with_one_bo
[264.237312] Subtest basic-with_one_bo: SUCCESS (0.003s)
[264.341106] [135/162] (746s left) prime_self_import (basic-with_one_bo_two_files)
[264.422974] Starting subtest: basic-with_one_bo_two_files
[264.442026] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s)
[264.531124] [136/162] (745s left) prime_self_import (basic-with_two_bos)
[264.589038] Starting subtest: basic-with_two_bos
[264.611816] Subtest basic-with_two_bos: SUCCESS (0.002s)
[264.721593] [137/162] (745s left) prime_vgem (basic-fence-flip)
[264.809694] Starting subtest: basic-fence-flip
[265.224689] Subtest basic-fence-flip: SUCCESS (0.432s)
[265.399671] [138/162] (745s left) prime_vgem (basic-fence-mmap)
[265.491571] Starting subtest: basic-fence-mmap
[265.514087] Subtest basic-fence-mmap: SKIP (0.000s)
[265.615163] [139/162] (745s left) prime_vgem (basic-fence-read)
[265.712250] Starting subtest: basic-fence-read
[265.734253] Subtest basic-fence-read: SKIP (0.012s)
[265.816890] [140/162] (744s left) prime_vgem (basic-gtt)
[265.912762] Starting subtest: basic-gtt
[265.935366] Subtest basic-gtt: SKIP (0.000s)
[266.017926] [141/162] (744s left) prime_vgem (basic-read)
[266.105870] Starting subtest: basic-read
[266.127864] Subtest basic-read: SKIP (0.011s)
[266.212269] [142/162] (744s left) prime_vgem (basic-write)
[266.301046] Starting subtest: basic-write
[266.323557] Subtest basic-write: SKIP (0.010s)
[266.432571] [143/162] (744s left) vgem_basic (setversion)
[266.512678] Starting subtest: setversion
[266.535231] Subtest setversion: SUCCESS (0.000s)
[266.602054] [144/162] (744s left) vgem_basic (create)
[266.679655] Starting subtest: create
[266.688391] Subtest create: SUCCESS (0.000s)
[266.760255] [145/162] (744s left) vgem_basic (debugfs)
[266.851182] Starting subtest: debugfs
[266.857519] Subtest debugfs: SUCCESS (0.000s)
[266.938264] [146/162] (744s left) vgem_basic (dmabuf-export)
[267.020064] Starting subtest: dmabuf-export
[267.033423] Subtest dmabuf-export: SUCCESS (0.003s)
[267.119356] [147/162] (744s left) vgem_basic (dmabuf-fence)
[267.210654] Starting subtest: dmabuf-fence
[267.216830] Subtest dmabuf-fence: SUCCESS (0.000s)
[267.297742] [148/162] (744s left) vgem_basic (dmabuf-fence-before)
[267.387154] Starting subtest: dmabuf-fence-before
[267.393369] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[267.473355] [149/162] (743s left) vgem_basic (dmabuf-mmap)
[267.563240] Starting subtest: dmabuf-mmap
[267.569412] Subtest dmabuf-mmap: SUCCESS (0.020s)
[267.649221] [150/162] (743s left) vgem_basic (mmap)
[267.717857] Starting subtest: mmap
[267.724026] Subtest mmap: SUCCESS (0.012s)
[267.794548] [151/162] (743s left) vgem_basic (second-client)
[267.871438] Starting subtest: second-client
[267.903783] Subtest second-client: SUCCESS (0.033s)
[267.987413] [152/162] (743s left) vgem_basic (sysfs)
[268.079326] Starting subtest: sysfs
[268.085849] Subtest sysfs: SUCCESS (0.000s)
[268.205459] [153/162] (743s left) core_hotunplug (unbind-rebind)
[268.318662] Starting subtest: unbind-rebind
[274.621888] Subtest unbind-rebind: SUCCESS (6.314s)
[274.780603] [154/162] (737s left) vgem_basic (unload)
[274.840915] Starting subtest: unload
[303.968761] Subtest unload: SUCCESS (29.117s)
[304.648182] [155/162] (707s left) i915_module_load (reload)
[304.962274] Starting subtest: reload
[312.796269] Subtest reload: SUCCESS (7.837s)
[312.979632] [156/162] (699s left) gem_lmem_swapping (basic)
[313.156488] Subtest basic: SKIP (0.000s)
[313.309216] [157/162] (699s left) gem_lmem_swapping (parallel-random-engines)
[313.455556] Subtest parallel-random-engines: SKIP (0.000s)
[313.591740] [158/162] (699s left) gem_lmem_swapping (random-engines)
[313.745878] Subtest random-engines: SKIP (0.000s)
[313.880403] [159/162] (699s left) gem_lmem_swapping (verify-random)
[314.034311] Subtest verify-random: SKIP (0.000s)
[314.180183] [160/162] (698s left) i915_pm_rpm (module-reload)
[316.767112] Starting subtest: module-reload
[336.088434] Subtest module-reload: SUCCESS (19.303s)
[336.164632] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[336.166520] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[336.177112] [161/162] (676s left) i915_selftest (live)
[336.288882] Starting subtest: live
[336.302314] Starting dynamic subtest: sanitycheck
[341.648707] Dynamic subtest sanitycheck: SUCCESS (5.364s)
[341.668605] Starting dynamic subtest: uncore
[346.143844] Dynamic subtest uncore: SUCCESS (4.485s)
[346.164437] Starting dynamic subtest: workarounds
[351.324089] Dynamic subtest workarounds: SUCCESS (5.179s)
[351.346124] Starting dynamic subtest: gt_engines
[356.534554] Dynamic subtest gt_engines: SUCCESS (5.218s)
[356.550318] Starting dynamic subtest: gt_timelines