[40.417248] Initializing watchdogs
[40.417308]   /dev/watchdog0
[40.460590] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d51 Intel Meteorlake (Gen12) 
[40.473557] [001/162] (960s left) i915_module_load (load)
[40.598683] Starting subtest: load
[43.630038] Subtest load: SUCCESS (3.034s)
[43.693034] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[43.695847] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[43.714443] [002/162] (957s left) core_auth (basic-auth)
[45.273242] Starting subtest: basic-auth
[45.286734] Subtest basic-auth: SUCCESS (0.002s)
[45.440053] [003/162] (955s left) core_debugfs (read-all-entries)
[45.548630] Starting subtest: read-all-entries
[45.703609] Subtest read-all-entries: SUCCESS (0.164s)
[45.836969] [004/162] (955s left) core_sysfs (read-all-entries)
[45.938404] Starting subtest: read-all-entries
[45.945459] Subtest read-all-entries: SUCCESS (0.011s)
[46.122487] [005/162] (955s left) fbdev (eof)
[46.222670] Starting subtest: eof
[46.229328] Subtest eof: SUCCESS (0.000s)
[46.374894] [006/162] (955s left) fbdev (info)
[46.417654] Starting subtest: info
[46.424074] Subtest info: SUCCESS (0.000s)
[46.492064] [007/162] (954s left) fbdev (nullptr)
[46.562169] Starting subtest: nullptr
[46.575637] Subtest nullptr: SUCCESS (0.000s)
[46.644267] [008/162] (954s left) fbdev (read)
[46.710352] Starting subtest: read
[47.604705] Subtest read: SUCCESS (0.889s)
[47.700975] [009/162] (953s left) fbdev (write)
[47.760741] Starting subtest: write
[48.358165] Subtest write: SUCCESS (0.602s)
[48.487404] [010/162] (953s left) gem_basic (bad-close)
[48.554921] Starting subtest: bad-close
[48.568636] Subtest bad-close: SUCCESS (0.000s)
[48.765369] [011/162] (953s left) gem_basic (create-close)
[48.851625] Starting subtest: create-close
[48.874589] Subtest create-close: SUCCESS (0.000s)
[48.958314] [012/162] (952s left) gem_basic (create-fd-close)
[49.046616] Starting subtest: create-fd-close
[49.068483] Subtest create-fd-close: SUCCESS (0.000s)
[49.169340] [013/162] (952s left) gem_busy (busy@all-engines)
[49.244612] Starting subtest: busy
[49.257989] Starting dynamic subtest: all-engines
[49.293845] Dynamic subtest all-engines: SUCCESS (0.057s)
[49.302912] Subtest busy: SUCCESS (0.057s)
[51.329772] [014/162] (950s left) gem_close_race (basic-process)
[51.440202] Starting subtest: basic-process
[51.489448] Subtest basic-process: SUCCESS (0.052s)
[51.732036] [015/162] (950s left) gem_close_race (basic-threads)
[51.833260] Starting subtest: basic-threads
[53.158132] Subtest basic-threads: SUCCESS (1.346s)
[53.399017] [016/162] (948s left) gem_ctx_create (basic)
[53.469029] Starting subtest: basic
[53.482211] Subtest basic: SUCCESS (0.000s)
[53.663820] [017/162] (948s left) gem_ctx_create (basic-files)
[53.746139] Starting subtest: basic-files
[55.874400] Subtest basic-files: SUCCESS (2.146s)
[57.319646] [018/162] (945s left) gem_ctx_exec (basic)
[57.393145] Starting subtest: basic
[57.409690] Subtest basic: SUCCESS (0.009s)
[57.548009] [019/162] (944s left) gem_exec_basic (basic)
[57.615440] Starting subtest: basic
[57.621786] Starting dynamic subtest: rcs0-smem
[57.638185] Dynamic subtest rcs0-smem: SUCCESS (0.004s)
[57.660456] Starting dynamic subtest: bcs0-smem
[57.666728] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[57.684624] Starting dynamic subtest: vcs0-smem
[57.697856] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[57.719874] Starting dynamic subtest: vcs1-smem
[57.728623] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[57.749150] Starting dynamic subtest: vecs0-smem
[57.762564] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[57.784531] Starting dynamic subtest: ccs0-smem
[57.793280] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[57.806567] Subtest basic: SUCCESS (0.013s)
[59.309590] [020/162] (943s left) gem_exec_create (basic)
[59.372649] Starting subtest: basic
[59.385977] Starting dynamic subtest: smem
[63.205588] Dynamic subtest smem: SUCCESS (3.835s)
[63.218708] Subtest basic: SUCCESS (3.835s)
[63.420930] [021/162] (939s left) gem_exec_fence (basic-busy)
[63.602913] Starting subtest: basic-busy
[63.619363] Starting dynamic subtest: rcs0
[63.667693] Dynamic subtest rcs0: SUCCESS (0.071s)
[63.689523] Starting dynamic subtest: bcs0
[63.718974] Dynamic subtest bcs0: SUCCESS (0.053s)
[63.730732] Starting dynamic subtest: vcs0
[63.772450] Dynamic subtest vcs0: SUCCESS (0.054s)
[63.786373] Starting dynamic subtest: vcs1
[63.820939] Dynamic subtest vcs1: SUCCESS (0.050s)
[63.842831] Starting dynamic subtest: vecs0
[63.875526] Dynamic subtest vecs0: SUCCESS (0.050s)
[63.890244] Starting dynamic subtest: ccs0
[63.931838] Dynamic subtest ccs0: SUCCESS (0.056s)
[63.938269] Subtest basic-busy: SUCCESS (0.336s)
[65.375775] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[65.393680] [022/162] (937s left) gem_exec_fence (basic-wait)
[65.579134] Starting subtest: basic-wait
[65.588474] Starting dynamic subtest: rcs0
[65.669508] Dynamic subtest rcs0: SUCCESS (0.094s)
[65.691408] Starting dynamic subtest: bcs0
[65.717291] Dynamic subtest bcs0: SUCCESS (0.053s)
[65.735169] Starting dynamic subtest: vcs0
[65.772668] Dynamic subtest vcs0: SUCCESS (0.048s)
[65.784306] Starting dynamic subtest: vcs1
[65.825096] Dynamic subtest vcs1: SUCCESS (0.055s)
[65.846791] Starting dynamic subtest: vecs0
[65.871106] Dynamic subtest vecs0: SUCCESS (0.048s)
[65.890436] Starting dynamic subtest: ccs0
[65.935554] Dynamic subtest ccs0: SUCCESS (0.058s)
[65.942083] Subtest basic-wait: SUCCESS (0.357s)
[67.348209] [023/162] (935s left) gem_exec_fence (basic-await)
[67.513531] Starting subtest: basic-await
[67.519711] Starting dynamic subtest: rcs0
[67.602605] Dynamic subtest rcs0: SUCCESS (0.090s)
[67.614618] Starting dynamic subtest: bcs0
[67.688136] Dynamic subtest bcs0: SUCCESS (0.085s)
[67.700192] Starting dynamic subtest: vcs0
[67.769454] Dynamic subtest vcs0: SUCCESS (0.081s)
[67.781659] Starting dynamic subtest: vcs1
[67.847485] Dynamic subtest vcs1: SUCCESS (0.077s)
[67.859694] Starting dynamic subtest: vecs0
[67.928714] Dynamic subtest vecs0: SUCCESS (0.081s)
[67.941716] Starting dynamic subtest: ccs0
[68.011299] Dynamic subtest ccs0: SUCCESS (0.082s)
[68.018155] Subtest basic-await: SUCCESS (0.499s)
[69.425788] [024/162] (933s left) gem_exec_fence (nb-await)
[69.591295] Starting subtest: nb-await
[69.597712] Starting dynamic subtest: rcs0
[69.670873] Dynamic subtest rcs0: SUCCESS (0.081s)
[69.683047] Starting dynamic subtest: bcs0
[69.729435] Dynamic subtest bcs0: SUCCESS (0.058s)
[69.741292] Starting dynamic subtest: vcs0
[69.788070] Dynamic subtest vcs0: SUCCESS (0.059s)
[69.799864] Starting dynamic subtest: vcs1
[69.850601] Dynamic subtest vcs1: SUCCESS (0.059s)
[69.864500] Starting dynamic subtest: vecs0
[69.911773] Dynamic subtest vecs0: SUCCESS (0.061s)
[69.926039] Starting dynamic subtest: ccs0
[69.981575] Dynamic subtest ccs0: SUCCESS (0.063s)
[69.987966] Subtest nb-await: SUCCESS (0.383s)
[71.422505] [025/162] (931s left) gem_exec_gttfill (basic)
[71.504670] Starting subtest: basic
[75.525256] Subtest basic: SUCCESS (4.029s)
[75.763226] [026/162] (927s left) gem_exec_parallel (engines)
[75.848319] Starting subtest: engines
[75.854897] Starting dynamic subtest: basic
[79.264345] Dynamic subtest basic: SUCCESS (3.414s)
[79.282357] Starting dynamic subtest: contexts
[83.977037] Dynamic subtest contexts: SUCCESS (4.713s)
[83.989278] Starting dynamic subtest: fds
[89.313238] Dynamic subtest fds: SUCCESS (5.336s)
[89.326091] Starting dynamic subtest: userptr
[91.233349] Dynamic subtest userptr: SUCCESS (1.919s)
[91.240194] Subtest engines: SUCCESS (15.384s)
[91.467420] [027/162] (911s left) gem_exec_store (basic)
[91.547756] Starting subtest: basic
[91.625684] Subtest basic: SUCCESS (0.100s)
[91.832821] [028/162] (911s left) gem_flink_basic (bad-flink)
[91.888782] Starting subtest: bad-flink
[91.895086] Subtest bad-flink: SUCCESS (0.000s)
[91.985500] [029/162] (911s left) gem_flink_basic (bad-open)
[92.040701] Starting subtest: bad-open
[92.046969] Subtest bad-open: SUCCESS (0.000s)
[92.107257] [030/162] (911s left) gem_flink_basic (basic)
[92.160191] Starting subtest: basic
[92.166605] Subtest basic: SUCCESS (0.000s)
[92.257693] [031/162] (911s left) gem_flink_basic (double-flink)
[92.313166] Starting subtest: double-flink
[92.319608] Subtest double-flink: SUCCESS (0.000s)
[92.406439] [032/162] (911s left) gem_flink_basic (flink-lifetime)
[92.462275] Starting subtest: flink-lifetime
[92.468577] Subtest flink-lifetime: SUCCESS (0.001s)
[92.556640] [033/162] (910s left) gem_huc_copy (huc-copy)
[92.615885] Starting subtest: huc-copy
[92.622201] Subtest huc-copy: SUCCESS (0.005s)
[92.750880] [034/162] (910s left) gem_linear_blits (basic)
[92.926624] Starting subtest: basic
[92.939843] Subtest basic: SUCCESS (0.020s)
[93.151161] [035/162] (910s left) gem_mmap (basic)
[93.240967] Subtest basic: SKIP (0.000s)
[93.296638] [036/162] (910s left) gem_mmap_gtt (basic)
[93.356986] Subtest basic: SKIP (0.000s)
[93.412594] [037/162] (910s left) gem_render_linear_blits (basic)
[93.460897] Starting subtest: basic
[93.498677] Subtest basic: SUCCESS (0.039s)
[93.609299] [038/162] (910s left) gem_render_tiled_blits (basic)
[93.697347] Subtest basic: SKIP (0.000s)
[93.782190] [039/162] (910s left) gem_ringfill (basic-all)
[99.316123] Starting subtest: basic-all
[100.489836] Subtest basic-all: SUCCESS (1.181s)
[100.660098] [040/162] (903s left) gem_softpin (allocator-basic)
[100.734622] Starting subtest: allocator-basic
[100.835273] Subtest allocator-basic: SUCCESS (0.105s)
[101.032288] [041/162] (903s left) gem_softpin (allocator-basic-reserve)
[101.110759] Starting subtest: allocator-basic-reserve
[101.193547] Subtest allocator-basic-reserve: SUCCESS (0.101s)
[101.368824] [042/162] (902s left) gem_softpin (safe-alignment)
[101.423923] Starting subtest: safe-alignment
[101.465953] Subtest safe-alignment: SUCCESS (0.044s)
[103.315084] [043/162] (900s left) gem_sync (basic-all)
[103.407878] Starting subtest: basic-all
[107.197389] Subtest basic-all: SUCCESS (3.824s)
[107.387301] [044/162] (896s left) gem_sync (basic-each)
[107.493372] Starting subtest: basic-each
[109.941920] Subtest basic-each: SUCCESS (2.506s)
[110.144453] [045/162] (894s left) gem_tiled_blits (basic)
[110.219515] Subtest basic: SKIP (0.000s)
[110.278176] [046/162] (894s left) gem_tiled_fence_blits (basic)
[110.351100] Subtest basic: SKIP (0.000s)
[110.409119] [047/162] (894s left) gem_tiled_pread_basic (basic)
[110.501570] Subtest basic: SKIP (0.000s)
[110.573277] [048/162] (893s left) gem_wait (busy@all-engines)
[110.644720] Starting subtest: busy
[110.651170] Starting dynamic subtest: all-engines
[112.227104] Dynamic subtest all-engines: SUCCESS (1.574s)
[112.236433] Subtest busy: SUCCESS (1.575s)
[112.431829] [049/162] (892s left) gem_wait (wait@all-engines)
[112.488248] Starting subtest: wait
[112.495059] Starting dynamic subtest: all-engines
[114.207839] Dynamic subtest all-engines: SUCCESS (1.710s)
[114.214525] Subtest wait: SUCCESS (1.711s)
[114.406467] [050/162] (890s left) i915_getparams_basic (basic-eu-total)
[114.460896] Starting subtest: basic-eu-total
[114.473580] Subtest basic-eu-total: SUCCESS (0.000s)
[114.538443] [051/162] (890s left) i915_getparams_basic (basic-subslice-total)
[114.593898] Starting subtest: basic-subslice-total
[114.607471] Subtest basic-subslice-total: SUCCESS (0.000s)
[114.678671] [052/162] (890s left) i915_hangman (error-state-basic)
[114.728841] Starting subtest: error-state-basic
[114.875887] Subtest error-state-basic: SUCCESS (0.133s)
[114.978763] [053/162] (889s left) i915_pciid
[115.158589] [054/162] (889s left) intel_hwmon (hwmon-read)
[115.250025] Subtest hwmon-read: SKIP (0.000s)
[115.315137] [055/162] (889s left) intel_hwmon (hwmon-write)
[115.394316] Subtest hwmon-write: SKIP (0.000s)
[115.472980] [056/162] (889s left) kms_addfb_basic (addfb25-4-tiled)
[115.588179] Starting subtest: addfb25-4-tiled
[115.598014] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[115.693451] [057/162] (889s left) kms_addfb_basic (addfb25-bad-modifier)
[115.782463] Starting subtest: addfb25-bad-modifier
[115.795644] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[115.916797] [058/162] (889s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[116.026361] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[116.127602] [059/162] (889s left) kms_addfb_basic (addfb25-modifier-no-flag)
[116.224557] Starting subtest: addfb25-modifier-no-flag
[116.240979] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[116.324072] [060/162] (888s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[116.406926] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[116.498407] [061/162] (888s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[116.580231] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[116.697558] [062/162] (888s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[116.778329] Starting subtest: addfb25-yf-tiled-legacy
[116.784860] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[116.887241] [063/162] (888s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[116.968879] Starting subtest: addfb25-y-tiled-legacy
[116.975446] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[117.090691] [064/162] (888s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[117.173341] Starting subtest: addfb25-y-tiled-small-legacy
[117.186348] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[117.285403] [065/162] (888s left) kms_addfb_basic (bad-pitch-0)
[117.340136] Starting subtest: bad-pitch-0
[117.346856] Subtest bad-pitch-0: SUCCESS (0.000s)
[117.507534] [066/162] (888s left) kms_addfb_basic (bad-pitch-1024)
[117.561446] Starting subtest: bad-pitch-1024
[117.568055] Subtest bad-pitch-1024: SUCCESS (0.000s)
[117.692026] [067/162] (887s left) kms_addfb_basic (bad-pitch-128)
[117.753468] Starting subtest: bad-pitch-128
[117.759961] Subtest bad-pitch-128: SUCCESS (0.000s)
[117.878501] [068/162] (887s left) kms_addfb_basic (bad-pitch-256)
[117.940475] Starting subtest: bad-pitch-256
[117.947181] Subtest bad-pitch-256: SUCCESS (0.000s)
[118.066178] [069/162] (887s left) kms_addfb_basic (bad-pitch-32)
[118.120770] Starting subtest: bad-pitch-32
[118.127681] Subtest bad-pitch-32: SUCCESS (0.000s)
[118.260883] [070/162] (887s left) kms_addfb_basic (bad-pitch-63)
[118.314670] Starting subtest: bad-pitch-63
[118.321273] Subtest bad-pitch-63: SUCCESS (0.000s)
[118.442245] [071/162] (887s left) kms_addfb_basic (bad-pitch-65536)
[118.496648] Starting subtest: bad-pitch-65536
[118.503200] Subtest bad-pitch-65536: SUCCESS (0.000s)
[118.629997] [072/162] (887s left) kms_addfb_basic (bad-pitch-999)
[118.692089] Starting subtest: bad-pitch-999
[118.698616] Subtest bad-pitch-999: SUCCESS (0.000s)
[118.836850] [073/162] (887s left) kms_addfb_basic (basic)
[118.908445] Starting subtest: basic
[118.921561] Subtest basic: SUCCESS (0.000s)
[119.061775] [074/162] (886s left) kms_addfb_basic (basic-x-tiled-legacy)
[119.135693] Starting subtest: basic-x-tiled-legacy
[119.158486] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[119.270437] [075/162] (886s left) kms_addfb_basic (basic-y-tiled-legacy)
[119.340623] Starting subtest: basic-y-tiled-legacy
[119.353919] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[119.476138] [076/162] (886s left) kms_addfb_basic (bo-too-small)
[119.564798] Starting subtest: bo-too-small
[119.578037] Subtest bo-too-small: SUCCESS (0.000s)
[119.690445] [077/162] (886s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[119.788305] Starting subtest: bo-too-small-due-to-tiling
[119.811303] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[119.892748] [078/162] (886s left) kms_addfb_basic (clobberred-modifier)
[119.972111] Starting subtest: clobberred-modifier
[119.994170] Subtest clobberred-modifier: SKIP (0.000s)
[120.125101] [079/162] (886s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[120.202679] Starting subtest: framebuffer-vs-set-tiling
[120.222477] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[120.338292] [080/162] (886s left) kms_addfb_basic (invalid-get-prop)
[120.414064] Starting subtest: invalid-get-prop
[120.430546] Subtest invalid-get-prop: SUCCESS (0.000s)
[120.559548] [081/162] (885s left) kms_addfb_basic (invalid-get-prop-any)
[120.633536] Starting subtest: invalid-get-prop-any
[120.649875] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[120.783125] [082/162] (885s left) kms_addfb_basic (invalid-set-prop)
[120.857093] Starting subtest: invalid-set-prop
[120.868447] Subtest invalid-set-prop: SUCCESS (0.000s)
[120.996570] [083/162] (885s left) kms_addfb_basic (invalid-set-prop-any)
[121.077916] Starting subtest: invalid-set-prop-any
[121.085820] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[121.221962] [084/162] (885s left) kms_addfb_basic (no-handle)
[121.300385] Starting subtest: no-handle
[121.313811] Subtest no-handle: SUCCESS (0.000s)
[121.462740] [085/162] (885s left) kms_addfb_basic (size-max)
[121.551880] Starting subtest: size-max
[121.558191] Subtest size-max: SUCCESS (0.000s)
[121.667050] [086/162] (885s left) kms_addfb_basic (small-bo)
[121.755104] Starting subtest: small-bo
[121.768256] Subtest small-bo: SUCCESS (0.000s)
[121.879349] [087/162] (884s left) kms_addfb_basic (tile-pitch-mismatch)
[121.969956] Starting subtest: tile-pitch-mismatch
[121.992800] Subtest tile-pitch-mismatch: SKIP (0.000s)
[122.100413] [088/162] (884s left) kms_addfb_basic (too-high)
[122.196895] Starting subtest: too-high
[122.213460] Subtest too-high: SUCCESS (0.000s)
[122.294937] [089/162] (884s left) kms_addfb_basic (too-wide)
[122.385027] Starting subtest: too-wide
[122.393773] Subtest too-wide: SUCCESS (0.000s)
[122.507646] [090/162] (884s left) kms_addfb_basic (unused-handle)
[122.582470] Starting subtest: unused-handle
[122.599097] Subtest unused-handle: SUCCESS (0.000s)
[122.719803] [091/162] (884s left) kms_addfb_basic (unused-modifier)
[122.788756] Starting subtest: unused-modifier
[122.795370] Subtest unused-modifier: SUCCESS (0.000s)
[122.965980] [092/162] (884s left) kms_addfb_basic (unused-offsets)
[123.041362] Starting subtest: unused-offsets
[123.050099] Subtest unused-offsets: SUCCESS (0.000s)
[123.181970] [093/162] (884s left) kms_addfb_basic (unused-pitches)
[123.259832] Starting subtest: unused-pitches
[123.273274] Subtest unused-pitches: SUCCESS (0.000s)
[123.427383] [094/162] (883s left) kms_busy (basic)
[123.517625] Starting subtest: basic
[123.530893] Starting dynamic subtest: flip
[124.253309] Dynamic subtest flip: SUCCESS (0.729s)
[124.271087] Starting dynamic subtest: modeset
[127.719501] Dynamic subtest modeset: SUCCESS (3.466s)
[127.727038] Subtest basic: SUCCESS (4.197s)
[128.530576] [095/162] (878s left) kms_prop_blob (basic)
[128.589187] Starting subtest: basic
[128.595555] Subtest basic: SUCCESS (0.000s)
[128.703709] [096/162] (878s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[128.812573] Starting subtest: basic-busy-flip-before-cursor-atomic
[128.835577] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[128.982614] [097/162] (878s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[129.104088] Starting subtest: basic-busy-flip-before-cursor-legacy
[129.127142] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[129.250904] [098/162] (878s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[129.366464] Starting subtest: basic-flip-after-cursor-atomic
[130.585859] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.209s)
[131.509895] [099/162] (876s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[131.623240] Starting subtest: basic-flip-after-cursor-legacy
[132.837820] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.207s)
[133.703703] [100/162] (874s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[133.824113] Starting subtest: basic-flip-after-cursor-varying-size
[135.031321] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.212s)
[135.865894] [101/162] (871s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[135.983411] Starting subtest: basic-flip-before-cursor-atomic
[137.194205] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.204s)
[138.102895] [102/162] (869s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[138.219984] Starting subtest: basic-flip-before-cursor-legacy
[139.430899] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.205s)
[140.337956] [103/162] (867s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[140.461591] Starting subtest: basic-flip-before-cursor-varying-size
[141.665266] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.205s)
[142.563554] [104/162] (865s left) kms_dsc (dsc-basic)
[142.653096] Starting subtest: dsc-basic
[142.718884] Subtest dsc-basic: SKIP (0.000s)
[142.790246] [105/162] (865s left) kms_flip (basic-flip-vs-dpms)
[142.905868] Starting subtest: basic-flip-vs-dpms
[142.912254] Starting dynamic subtest: A-eDP1
[145.434110] Dynamic subtest A-eDP1: SUCCESS (2.549s)
[145.451088] Starting dynamic subtest: B-eDP1
[147.598470] Dynamic subtest B-eDP1: SUCCESS (2.162s)
[147.615566] Starting dynamic subtest: C-eDP1
[149.755553] Dynamic subtest C-eDP1: SUCCESS (2.166s)
[149.769296] Starting dynamic subtest: D-eDP1
[151.931547] Dynamic subtest D-eDP1: SUCCESS (2.172s)
[151.937866] Subtest basic-flip-vs-dpms: SUCCESS (9.057s)
[152.758982] [106/162] (855s left) kms_flip (basic-flip-vs-modeset)
[152.857413] Starting subtest: basic-flip-vs-modeset
[152.866135] Starting dynamic subtest: A-eDP1
[155.429976] Dynamic subtest A-eDP1: SUCCESS (2.581s)
[155.447833] Starting dynamic subtest: B-eDP1
[157.591499] Dynamic subtest B-eDP1: SUCCESS (2.154s)
[157.606342] Starting dynamic subtest: C-eDP1
[159.751966] Dynamic subtest C-eDP1: SUCCESS (2.166s)
[159.769852] Starting dynamic subtest: D-eDP1
[161.933121] Dynamic subtest D-eDP1: SUCCESS (2.173s)
[161.947440] Subtest basic-flip-vs-modeset: SUCCESS (9.082s)
[162.751690] [107/162] (845s left) kms_flip (basic-flip-vs-wf_vblank)
[162.853786] Starting subtest: basic-flip-vs-wf_vblank
[162.862606] Starting dynamic subtest: A-eDP1
[164.831997] Dynamic subtest A-eDP1: SUCCESS (1.994s)
[164.851591] Starting dynamic subtest: B-eDP1
[166.873589] Dynamic subtest B-eDP1: SUCCESS (2.040s)
[166.894418] Starting dynamic subtest: C-eDP1
[168.904049] Dynamic subtest C-eDP1: SUCCESS (2.021s)
[168.923433] Starting dynamic subtest: D-eDP1
[170.960610] Dynamic subtest D-eDP1: SUCCESS (2.038s)
[170.973867] Subtest basic-flip-vs-wf_vblank: SUCCESS (8.107s)
[172.182440] [108/162] (836s left) kms_flip (basic-plain-flip)
[172.291096] Starting subtest: basic-plain-flip
[172.307483] Starting dynamic subtest: A-eDP1
[173.942441] Dynamic subtest A-eDP1: SUCCESS (1.666s)
[173.963484] Starting dynamic subtest: B-eDP1
[175.664990] Dynamic subtest B-eDP1: SUCCESS (1.725s)
[175.679021] Starting dynamic subtest: C-eDP1
[177.384614] Dynamic subtest C-eDP1: SUCCESS (1.710s)
[177.403033] Starting dynamic subtest: D-eDP1
[179.025734] Dynamic subtest D-eDP1: SUCCESS (1.633s)
[179.034497] Subtest basic-plain-flip: SUCCESS (6.742s)
[180.194015] [109/162] (828s left) kms_force_connector_basic (force-connector-state)
[180.284214] Starting subtest: force-connector-state
[180.869638] Subtest force-connector-state: SUCCESS (0.596s)
[181.816267] [110/162] (826s left) kms_force_connector_basic (force-edid)
[181.892121] Starting subtest: force-edid
[182.193114] Subtest force-edid: SUCCESS (0.294s)
[182.338288] [111/162] (826s left) kms_force_connector_basic (force-load-detect)
[182.429856] Starting subtest: force-load-detect
[182.451929] Subtest force-load-detect: SKIP (0.000s)
[182.542946] [112/162] (825s left) kms_force_connector_basic (prune-stale-modes)
[182.632872] Starting subtest: prune-stale-modes
[182.982419] Subtest prune-stale-modes: SUCCESS (0.360s)
[183.111211] [113/162] (825s left) kms_frontbuffer_tracking (basic)
[183.193742] Starting subtest: basic
[188.573631] Subtest basic: SUCCESS (5.371s)
[188.704508] [114/162] (819s left) kms_hdmi_inject (inject-audio)
[189.035491] Starting subtest: inject-audio
[189.289168] Subtest inject-audio: SUCCESS (0.248s)
[189.979880] [115/162] (818s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[190.063558] Starting subtest: compare-crc-sanitycheck-xr24
[190.070766] Starting dynamic subtest: pipe-A-eDP-1
[190.790250] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.728s)
[190.803761] Starting dynamic subtest: pipe-B-eDP-1
[192.095596] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.296s)
[192.112577] Starting dynamic subtest: pipe-C-eDP-1
[193.345902] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.248s)
[193.363291] Starting dynamic subtest: pipe-D-eDP-1
[194.645568] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.302s)
[194.662122] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.584s)
[195.523420] [116/162] (813s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[195.620006] Starting subtest: compare-crc-sanitycheck-nv12
[195.636569] Starting dynamic subtest: pipe-A-eDP-1
[196.498191] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.892s)
[196.515965] Starting dynamic subtest: pipe-B-eDP-1
[197.928954] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.412s)
[197.951045] Starting dynamic subtest: pipe-C-eDP-1
[199.294858] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.377s)
[199.312592] Starting dynamic subtest: pipe-D-eDP-1
[200.601223] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.301s)
[200.617544] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.994s)
[201.433727] [117/162] (807s left) kms_pipe_crc_basic (hang-read-crc)
[201.529406] Starting subtest: hang-read-crc
[201.545827] Starting dynamic subtest: pipe-A-eDP-1
[203.914421] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.393s)
[203.935425] Starting dynamic subtest: pipe-B-eDP-1
[207.014109] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.094s)
[207.039080] Starting dynamic subtest: pipe-C-eDP-1
[210.030444] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.016s)
[210.051507] Starting dynamic subtest: pipe-D-eDP-1
[213.032499] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.999s)
[213.049120] Subtest hang-read-crc: SUCCESS (11.513s)
[213.964344] [118/162] (794s left) kms_pipe_crc_basic (nonblocking-crc)
[214.060079] Starting subtest: nonblocking-crc
[214.076743] Starting dynamic subtest: pipe-A-eDP-1
[215.069895] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.014s)
[215.087564] Starting dynamic subtest: pipe-B-eDP-1
[216.675760] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.605s)
[216.693524] Starting dynamic subtest: pipe-C-eDP-1
[218.211468] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.535s)
[218.224386] Starting dynamic subtest: pipe-D-eDP-1
[219.805658] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.588s)
[219.822132] Subtest nonblocking-crc: SUCCESS (5.751s)
[220.645462] [119/162] (788s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[220.759966] Starting subtest: nonblocking-crc-frame-sequence
[220.776326] Starting dynamic subtest: pipe-A-eDP-1
[221.623932] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.877s)
[221.663191] Starting dynamic subtest: pipe-B-eDP-1
[223.156186] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.524s)
[223.197463] Starting dynamic subtest: pipe-C-eDP-1
[224.617317] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.448s)
[224.663484] Starting dynamic subtest: pipe-D-eDP-1
[226.107951] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.492s)
[226.116733] Subtest nonblocking-crc-frame-sequence: SUCCESS (5.348s)
[227.123830] [120/162] (782s left) kms_pipe_crc_basic (read-crc)
[227.230410] Starting subtest: read-crc
[227.243699] Starting dynamic subtest: pipe-A-eDP-1
[229.019862] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.789s)
[229.033255] Starting dynamic subtest: pipe-B-eDP-1
[230.176791] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.154s)
[230.191696] Starting dynamic subtest: pipe-C-eDP-1
[231.624202] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.454s)
[231.637615] Starting dynamic subtest: pipe-D-eDP-1
[233.104772] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.477s)
[233.111201] Subtest read-crc: SUCCESS (5.888s)
[234.069097] [121/162] (775s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[234.150971] Starting subtest: read-crc-frame-sequence
[234.157326] Starting dynamic subtest: pipe-A-eDP-1
[234.965920] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.810s)
[234.983798] Starting dynamic subtest: pipe-B-eDP-1
[236.413132] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.447s)
[236.427111] Starting dynamic subtest: pipe-C-eDP-1
[237.836859] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.425s)
[237.850749] Starting dynamic subtest: pipe-D-eDP-1
[239.243201] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.400s)
[239.256569] Subtest read-crc-frame-sequence: SUCCESS (5.089s)
[240.110632] [122/162] (769s left) kms_pm_backlight (basic-brightness)
[240.205072] Starting subtest: basic-brightness
[240.274263] Starting dynamic subtest: eDP-1
[240.596985] Dynamic subtest eDP-1: SUCCESS (0.332s)
[240.604764] Subtest basic-brightness: SUCCESS (0.395s)
[241.454613] [123/162] (767s left) kms_pm_rpm (basic-pci-d3-state)
[243.411618] Starting subtest: basic-pci-d3-state
[244.920474] Subtest basic-pci-d3-state: SUCCESS (1.516s)
[245.071231] [124/162] (764s left) kms_pm_rpm (basic-rte)
[245.123693] Starting subtest: basic-rte
[248.039197] Subtest basic-rte: SUCCESS (2.925s)
[249.809763] [125/162] (759s left) kms_psr (psr-primary-page-flip)
[249.879937] Starting subtest: psr-primary-page-flip
[249.886219] Starting dynamic subtest: eDP-1
[251.799093] Dynamic subtest eDP-1: SUCCESS (1.913s)
[251.805797] Subtest psr-primary-page-flip: SUCCESS (1.914s)
[252.625344] [126/162] (757s left) kms_psr (psr-cursor-plane-move)
[252.716462] Starting subtest: psr-cursor-plane-move
[252.733090] Starting dynamic subtest: eDP-1
[254.583045] Dynamic subtest eDP-1: SUCCESS (1.868s)
[254.599531] Subtest psr-cursor-plane-move: SUCCESS (1.870s)
[255.405917] [127/162] (754s left) kms_psr (psr-sprite-plane-onoff)
[255.498194] Starting subtest: psr-sprite-plane-onoff
[255.504388] Starting dynamic subtest: eDP-1
[257.438122] Dynamic subtest eDP-1: SUCCESS (1.939s)
[257.454446] Subtest psr-sprite-plane-onoff: SUCCESS (1.941s)
[258.309935] [128/162] (751s left) kms_psr (psr-primary-mmap-gtt)
[258.406064] Starting subtest: psr-primary-mmap-gtt
[258.422552] Starting dynamic subtest: eDP-1
[259.993234] Dynamic subtest eDP-1: SKIP (1.572s)
[260.009053] Subtest psr-primary-mmap-gtt: SKIP (1.574s)
[260.182006] [129/162] (749s left) kms_setmode (basic-clone-single-crtc)
[260.261739] Starting subtest: basic-clone-single-crtc
[260.292543] Subtest basic-clone-single-crtc: SKIP (0.000s)
[260.363536] [130/162] (749s left) i915_pm_rps (basic-api)
[260.434431] Starting subtest: basic-api
[260.456389] Subtest basic-api: SKIP (0.001s)
[260.539314] [131/162] (749s left) prime_self_import (basic-llseek-bad)
[260.606390] Starting subtest: basic-llseek-bad
[260.629194] Subtest basic-llseek-bad: SUCCESS (0.002s)
[260.722352] [132/162] (749s left) prime_self_import (basic-llseek-size)
[260.764899] Starting subtest: basic-llseek-size
[260.778798] Subtest basic-llseek-size: SUCCESS (0.002s)
[260.909572] [133/162] (749s left) prime_self_import (basic-with_fd_dup)
[260.985767] Starting subtest: basic-with_fd_dup
[261.007839] Subtest basic-with_fd_dup: SUCCESS (0.002s)
[261.099774] [134/162] (749s left) prime_self_import (basic-with_one_bo)
[261.186896] Starting subtest: basic-with_one_bo
[261.208204] Subtest basic-with_one_bo: SUCCESS (0.002s)
[261.304607] [135/162] (748s left) prime_self_import (basic-with_one_bo_two_files)
[261.366799] Starting subtest: basic-with_one_bo_two_files
[261.385829] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s)
[261.476934] [136/162] (748s left) prime_self_import (basic-with_two_bos)
[261.526889] Starting subtest: basic-with_two_bos
[261.541892] Subtest basic-with_two_bos: SUCCESS (0.003s)
[261.624738] [137/162] (748s left) prime_vgem (basic-fence-flip)
[261.697932] Starting subtest: basic-fence-flip
[262.123138] Subtest basic-fence-flip: SUCCESS (0.438s)
[262.284700] [138/162] (748s left) prime_vgem (basic-fence-mmap)
[262.365118] Starting subtest: basic-fence-mmap
[262.379701] Subtest basic-fence-mmap: SKIP (0.000s)
[262.470222] [139/162] (747s left) prime_vgem (basic-fence-read)
[262.573394] Starting subtest: basic-fence-read
[262.594491] Subtest basic-fence-read: SKIP (0.013s)
[262.712354] [140/162] (747s left) prime_vgem (basic-gtt)
[262.810109] Starting subtest: basic-gtt
[262.832804] Subtest basic-gtt: SKIP (0.000s)
[262.934445] [141/162] (747s left) prime_vgem (basic-read)
[263.030808] Starting subtest: basic-read
[263.053538] Subtest basic-read: SKIP (0.011s)
[263.136180] [142/162] (747s left) prime_vgem (basic-write)
[263.224909] Starting subtest: basic-write
[263.237492] Subtest basic-write: SKIP (0.011s)
[263.341268] [143/162] (747s left) vgem_basic (setversion)
[263.433311] Starting subtest: setversion
[263.456257] Subtest setversion: SUCCESS (0.000s)
[263.520518] [144/162] (747s left) vgem_basic (create)
[263.612486] Starting subtest: create
[263.618913] Subtest create: SUCCESS (0.000s)
[263.698933] [145/162] (747s left) vgem_basic (debugfs)
[263.789356] Starting subtest: debugfs
[263.795851] Subtest debugfs: SUCCESS (0.000s)
[263.875582] [146/162] (747s left) vgem_basic (dmabuf-export)
[263.949585] Starting subtest: dmabuf-export
[263.972779] Subtest dmabuf-export: SUCCESS (0.003s)
[264.053050] [147/162] (746s left) vgem_basic (dmabuf-fence)
[264.127560] Starting subtest: dmabuf-fence
[264.144044] Subtest dmabuf-fence: SUCCESS (0.000s)
[264.209932] [148/162] (746s left) vgem_basic (dmabuf-fence-before)
[264.276797] Starting subtest: dmabuf-fence-before
[264.292126] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[264.358864] [149/162] (746s left) vgem_basic (dmabuf-mmap)
[264.446049] Starting subtest: dmabuf-mmap
[264.459249] Subtest dmabuf-mmap: SUCCESS (0.021s)
[264.564301] [150/162] (746s left) vgem_basic (mmap)
[264.656218] Starting subtest: mmap
[264.662795] Subtest mmap: SUCCESS (0.012s)
[264.758176] [151/162] (746s left) vgem_basic (second-client)
[264.834116] Starting subtest: second-client
[264.861766] Subtest second-client: SUCCESS (0.033s)
[264.938989] [152/162] (746s left) vgem_basic (sysfs)
[265.014711] Starting subtest: sysfs
[265.031081] Subtest sysfs: SUCCESS (0.000s)
[265.097135] [153/162] (746s left) core_hotunplug (unbind-rebind)
[265.219340] Starting subtest: unbind-rebind
[271.392319] Subtest unbind-rebind: SUCCESS (6.195s)
[271.481160] [154/162] (739s left) vgem_basic (unload)
[271.541964] Starting subtest: unload
[300.587554] Subtest unload: SUCCESS (29.033s)
[301.113380] [155/162] (710s left) i915_module_load (reload)
[301.384260] Starting subtest: reload
[308.876861] Subtest reload: SUCCESS (7.519s)
[309.012196] [156/162] (702s left) gem_lmem_swapping (basic)
[309.169617] Subtest basic: SKIP (0.000s)
[309.302357] [157/162] (702s left) gem_lmem_swapping (parallel-random-engines)
[309.448134] Subtest parallel-random-engines: SKIP (0.000s)
[309.590809] [158/162] (702s left) gem_lmem_swapping (random-engines)
[309.738448] Subtest random-engines: SKIP (0.000s)
[309.875709] [159/162] (702s left) gem_lmem_swapping (verify-random)
[310.025221] Subtest verify-random: SKIP (0.000s)
[310.166993] [160/162] (702s left) i915_pm_rpm (module-reload)
[312.719243] Starting subtest: module-reload
[331.360568] Subtest module-reload: SUCCESS (18.625s)
[331.436420] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[331.438317] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[331.453810] [161/162] (681s left) i915_selftest (live)
[331.571620] Starting subtest: live
[331.588213] Starting dynamic subtest: sanitycheck
[336.718138] Dynamic subtest sanitycheck: SUCCESS (5.141s)
[336.740145] Starting dynamic subtest: uncore
[341.358299] Dynamic subtest uncore: SUCCESS (4.637s)
[341.380269] Starting dynamic subtest: workarounds
[345.357567] Dynamic subtest workarounds: SUCCESS (3.999s)
[345.379489] Starting dynamic subtest: gt_engines
[348.405256] Dynamic subtest gt_engines: SUCCESS (3.056s)
[348.421790] Starting dynamic subtest: gt_timelines