[37.079976] Initializing watchdogs
[37.080253]   /dev/watchdog0
[37.119951] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:4e51 Intel Jasperlake (Gen11) 
[37.129958] [001/161] (960s left) i915_module_load (load)
[37.430478] Starting subtest: load
[41.088696] Subtest load: SUCCESS (3.656s)
[41.164552] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[41.167864] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[41.173183] [002/161] (956s left) core_auth (basic-auth)
[41.309395] Starting subtest: basic-auth
[41.311993] Subtest basic-auth: SUCCESS (0.001s)
[41.453212] [003/161] (956s left) debugfs_test (read_all_entries)
[41.566543] Starting subtest: read_all_entries
[41.671329] Subtest read_all_entries: SUCCESS (0.105s)
[41.898634] [004/161] (956s left) debugfs_test (basic-hwmon)
[42.044720] Starting subtest: basic-hwmon
[42.047101] Subtest basic-hwmon: SKIP (0.000s)
[42.254241] [005/161] (955s left) debugfs_test (sysfs)
[42.361014] Starting subtest: sysfs
[42.476717] Subtest sysfs: SUCCESS (0.115s)
[42.680357] [006/161] (955s left) fbdev (eof)
[42.788499] Starting subtest: eof
[42.789577] Subtest eof: SUCCESS (0.001s)
[42.901391] [007/161] (955s left) fbdev (info)
[42.993821] Starting subtest: info
[42.995213] Subtest info: SUCCESS (0.000s)
[43.117721] [008/161] (955s left) fbdev (nullptr)
[43.239374] Starting subtest: nullptr
[43.240531] Subtest nullptr: SUCCESS (0.000s)
[43.362435] [009/161] (955s left) fbdev (read)
[43.468867] Starting subtest: read
[50.590774] Subtest read: SUCCESS (7.089s)
[50.688840] [010/161] (947s left) fbdev (write)
[50.801698] Starting subtest: write
[54.610152] Subtest write: SUCCESS (3.773s)
[54.702993] [011/161] (943s left) gem_basic (bad-close)
[54.799486] Starting subtest: bad-close
[54.801613] Subtest bad-close: SUCCESS (0.000s)
[54.939214] [012/161] (943s left) gem_basic (create-close)
[55.038408] Starting subtest: create-close
[55.040508] Subtest create-close: SUCCESS (0.000s)
[55.188729] [013/161] (943s left) gem_basic (create-fd-close)
[55.287282] Starting subtest: create-fd-close
[55.289308] Subtest create-fd-close: SUCCESS (0.000s)
[55.440646] [014/161] (943s left) gem_busy (busy@all-engines)
[55.565745] Starting subtest: busy
[55.566924] Starting dynamic subtest: all-engines
[55.642344] Dynamic subtest all-engines: SUCCESS (0.076s)
[55.643380] Subtest busy: SUCCESS (0.077s)
[56.106933] [015/161] (942s left) gem_close_race (basic-process)
[56.231635] Starting subtest: basic-process
[56.309335] Subtest basic-process: SUCCESS (0.078s)
[56.555761] [016/161] (942s left) gem_close_race (basic-threads)
[56.684457] Starting subtest: basic-threads
[57.890202] Subtest basic-threads: SUCCESS (1.206s)
[58.192798] [017/161] (940s left) gem_ctx_create (basic)
[58.312763] Starting subtest: basic
[58.313840] Subtest basic: SUCCESS (0.000s)
[58.575824] [018/161] (940s left) gem_ctx_create (basic-files)
[58.694180] Starting subtest: basic-files
[60.725743] Subtest basic-files: SUCCESS (2.032s)
[61.060988] [019/161] (938s left) gem_ctx_exec (basic)
[61.162190] Starting subtest: basic
[61.168687] Subtest basic: SUCCESS (0.006s)
[61.324341] [020/161] (937s left) gem_exec_basic (basic)
[61.434373] Starting subtest: basic
[61.435518] Starting dynamic subtest: rcs0-smem
[61.436554] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[61.454333] Starting dynamic subtest: bcs0-smem
[61.455334] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[61.471883] Starting dynamic subtest: vcs0-smem
[61.472942] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[61.489400] Starting dynamic subtest: vecs0-smem
[61.490432] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[61.491397] Subtest basic: SUCCESS (0.006s)
[61.691136] [021/161] (937s left) gem_exec_create (basic)
[61.808620] Starting subtest: basic
[61.809769] Starting dynamic subtest: smem
[63.872790] Dynamic subtest smem: SUCCESS (2.044s)
[63.873825] Subtest basic: SUCCESS (2.044s)
[64.148809] [022/161] (935s left) gem_exec_fence (basic-busy)
[64.416425] Starting subtest: basic-busy
[64.417662] Starting dynamic subtest: rcs0
[64.446565] Dynamic subtest rcs0: SUCCESS (0.031s)
[64.467213] Starting dynamic subtest: bcs0
[64.483436] Dynamic subtest bcs0: SUCCESS (0.037s)
[64.503139] Starting dynamic subtest: vcs0
[64.510288] Dynamic subtest vcs0: SUCCESS (0.026s)
[64.530826] Starting dynamic subtest: vecs0
[64.535313] Dynamic subtest vecs0: SUCCESS (0.025s)
[64.536357] Subtest basic-busy: SUCCESS (0.120s)
[65.233339] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[65.238284] [023/161] (934s left) gem_exec_fence (basic-wait)
[65.501744] Starting subtest: basic-wait
[65.502832] Starting dynamic subtest: rcs0
[65.535656] Dynamic subtest rcs0: SUCCESS (0.033s)
[65.555019] Starting dynamic subtest: bcs0
[65.557697] Dynamic subtest bcs0: SUCCESS (0.021s)
[65.576373] Starting dynamic subtest: vcs0
[65.587426] Dynamic subtest vcs0: SUCCESS (0.031s)
[65.606318] Starting dynamic subtest: vecs0
[65.612249] Dynamic subtest vecs0: SUCCESS (0.024s)
[65.614685] Subtest basic-wait: SUCCESS (0.111s)
[66.233642] [024/161] (933s left) gem_exec_fence (basic-await)
[66.498136] Starting subtest: basic-await
[66.499222] Starting dynamic subtest: rcs0
[66.629444] Dynamic subtest rcs0: SUCCESS (0.122s)
[66.650099] Starting dynamic subtest: bcs0
[66.744307] Dynamic subtest bcs0: SUCCESS (0.122s)
[66.785984] Starting dynamic subtest: vcs0
[66.889077] Dynamic subtest vcs0: SUCCESS (0.144s)
[66.926305] Starting dynamic subtest: vecs0
[67.025738] Dynamic subtest vecs0: SUCCESS (0.132s)
[67.027541] Subtest basic-await: SUCCESS (0.525s)
[67.666055] [025/161] (932s left) gem_exec_fence (nb-await)
[67.928133] Starting subtest: nb-await
[67.929192] Starting dynamic subtest: rcs0
[68.000294] Dynamic subtest rcs0: SUCCESS (0.070s)
[68.023551] Starting dynamic subtest: bcs0
[68.068956] Dynamic subtest bcs0: SUCCESS (0.069s)
[68.098458] Starting dynamic subtest: vcs0
[68.142048] Dynamic subtest vcs0: SUCCESS (0.072s)
[68.183978] Starting dynamic subtest: vecs0
[68.218313] Dynamic subtest vecs0: SUCCESS (0.075s)
[68.220307] Subtest nb-await: SUCCESS (0.290s)
[68.816296] [026/161] (931s left) gem_exec_gttfill (basic)
[68.943092] Starting subtest: basic
[82.345299] Subtest basic: SUCCESS (13.394s)
[82.607720] [027/161] (917s left) gem_exec_parallel (engines)
[82.811465] Starting subtest: engines
[82.812539] Starting dynamic subtest: basic
[86.335238] Dynamic subtest basic: SUCCESS (3.512s)
[86.377223] Starting dynamic subtest: contexts
[94.723382] Dynamic subtest contexts: SUCCESS (8.399s)
[94.751551] Starting dynamic subtest: fds
[106.228606] Dynamic subtest fds: SUCCESS (11.502s)
[106.278777] Starting dynamic subtest: userptr
[109.027137] Dynamic subtest userptr: SUCCESS (2.778s)
[109.028567] Subtest engines: SUCCESS (26.195s)
[109.312900] [028/161] (890s left) gem_exec_store (basic)
[109.435287] Starting subtest: basic
[109.494489] Subtest basic: SUCCESS (0.060s)
[109.755143] [029/161] (890s left) gem_flink_basic (bad-flink)
[109.853233] Starting subtest: bad-flink
[109.854414] Subtest bad-flink: SUCCESS (0.000s)
[110.005767] [030/161] (890s left) gem_flink_basic (bad-open)
[110.102750] Starting subtest: bad-open
[110.103921] Subtest bad-open: SUCCESS (0.000s)
[110.250766] [031/161] (890s left) gem_flink_basic (basic)
[110.347469] Starting subtest: basic
[110.348552] Subtest basic: SUCCESS (0.000s)
[110.503645] [032/161] (889s left) gem_flink_basic (double-flink)
[110.600061] Starting subtest: double-flink
[110.601165] Subtest double-flink: SUCCESS (0.000s)
[110.751779] [033/161] (889s left) gem_flink_basic (flink-lifetime)
[110.850718] Starting subtest: flink-lifetime
[110.853296] Subtest flink-lifetime: SUCCESS (0.003s)
[111.017021] [034/161] (889s left) gem_huc_copy (huc-copy)
[111.122641] Starting subtest: huc-copy
[111.124847] Subtest huc-copy: SKIP (0.000s)
[111.302121] [035/161] (889s left) gem_linear_blits (basic)
[111.559482] Starting subtest: basic
[111.571502] Subtest basic: SUCCESS (0.013s)
[111.780561] [036/161] (889s left) gem_mmap (basic)
[111.957571] Starting subtest: basic
[111.962264] Subtest basic: SUCCESS (0.001s)
[112.119198] [037/161] (888s left) gem_mmap_gtt (basic)
[112.221372] Starting subtest: basic
[112.222465] Subtest basic: SUCCESS (0.001s)
[112.365968] [038/161] (888s left) gem_render_linear_blits (basic)
[112.473923] Starting subtest: basic
[112.529468] Subtest basic: SUCCESS (0.055s)
[112.661602] [039/161] (888s left) gem_render_tiled_blits (basic)
[112.778898] Starting subtest: basic
[112.856543] Subtest basic: SUCCESS (0.076s)
[112.989992] [040/161] (888s left) gem_ringfill (basic-all)
[113.298850] Starting subtest: basic-all
[114.561352] Subtest basic-all: SUCCESS (1.257s)
[114.708175] [041/161] (886s left) gem_softpin (allocator-basic)
[114.813737] Starting subtest: allocator-basic
[114.997334] Subtest allocator-basic: SUCCESS (0.174s)
[115.174412] [042/161] (886s left) gem_softpin (allocator-basic-reserve)
[115.279808] Starting subtest: allocator-basic-reserve
[115.469250] Subtest allocator-basic-reserve: SUCCESS (0.181s)
[115.642082] [043/161] (885s left) gem_softpin (safe-alignment)
[115.747743] Starting subtest: safe-alignment
[115.766669] Subtest safe-alignment: SUCCESS (0.019s)
[115.937377] [044/161] (885s left) gem_sync (basic-all)
[116.060561] Starting subtest: basic-all
[118.513969] Subtest basic-all: SUCCESS (2.433s)
[118.756368] [045/161] (882s left) gem_sync (basic-each)
[118.876728] Starting subtest: basic-each
[121.211340] Subtest basic-each: SUCCESS (2.336s)
[121.529304] [046/161] (880s left) gem_tiled_blits (basic)
[121.733309] Starting subtest: basic
[121.769057] Subtest basic: SUCCESS (0.035s)
[121.978894] [047/161] (879s left) gem_tiled_fence_blits (basic)
[122.279417] Starting subtest: basic
[122.309361] Subtest basic: SUCCESS (0.030s)
[122.476772] [048/161] (879s left) gem_tiled_pread_basic
[123.075150] [049/161] (879s left) gem_wait (busy@all-engines)
[123.209255] Starting subtest: busy
[123.210387] Starting dynamic subtest: all-engines
[123.744354] Dynamic subtest all-engines: SUCCESS (0.535s)
[123.745469] Subtest busy: SUCCESS (0.536s)
[124.062310] [050/161] (878s left) gem_wait (wait@all-engines)
[124.191612] Starting subtest: wait
[124.192754] Starting dynamic subtest: all-engines
[125.228411] Dynamic subtest all-engines: SUCCESS (1.036s)
[125.230217] Subtest wait: SUCCESS (1.037s)
[125.539065] [051/161] (876s left) i915_getparams_basic (basic-eu-total)
[125.636273] Starting subtest: basic-eu-total
[125.638432] Subtest basic-eu-total: SUCCESS (0.000s)
[125.785888] [052/161] (876s left) i915_getparams_basic (basic-subslice-total)
[125.883565] Starting subtest: basic-subslice-total
[125.885728] Subtest basic-subslice-total: SUCCESS (0.000s)
[126.037972] [053/161] (876s left) i915_hangman (error-state-basic)
[126.155385] Starting subtest: error-state-basic
[126.168571] Subtest error-state-basic: SUCCESS (0.012s)
[126.319775] [054/161] (876s left) i915_pciid
[126.572239] [055/161] (876s left) kms_addfb_basic (addfb25-4-tiled)
[126.731632] Starting subtest: addfb25-4-tiled
[126.732701] Subtest addfb25-4-tiled: SUCCESS (0.001s)
[126.909989] [056/161] (875s left) kms_addfb_basic (addfb25-bad-modifier)
[127.057906] Starting subtest: addfb25-bad-modifier
[127.059157] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[127.251929] [057/161] (875s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[127.403216] Starting subtest: addfb25-framebuffer-vs-set-tiling
[127.404322] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[127.574119] [058/161] (875s left) kms_addfb_basic (addfb25-modifier-no-flag)
[127.726905] Starting subtest: addfb25-modifier-no-flag
[127.728106] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[127.888588] [059/161] (875s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[128.038183] Starting subtest: addfb25-x-tiled-legacy
[128.039244] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[128.208461] [060/161] (874s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[128.360039] Starting subtest: addfb25-x-tiled-mismatch-legacy
[128.361250] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[128.521664] [061/161] (874s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[128.673460] Starting subtest: addfb25-yf-tiled-legacy
[128.674535] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[128.848932] [062/161] (874s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[129.020418] Starting subtest: addfb25-y-tiled-legacy
[129.021512] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[129.217339] [063/161] (874s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[129.369452] Starting subtest: addfb25-y-tiled-small-legacy
[129.370519] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[129.545047] [064/161] (873s left) kms_addfb_basic (bad-pitch-0)
[129.641250] Starting subtest: bad-pitch-0
[129.642682] Subtest bad-pitch-0: SUCCESS (0.000s)
[129.875956] [065/161] (873s left) kms_addfb_basic (bad-pitch-1024)
[129.973617] Starting subtest: bad-pitch-1024
[129.974760] Subtest bad-pitch-1024: SUCCESS (0.000s)
[130.202051] [066/161] (873s left) kms_addfb_basic (bad-pitch-128)
[130.301238] Starting subtest: bad-pitch-128
[130.302250] Subtest bad-pitch-128: SUCCESS (0.000s)
[130.533477] [067/161] (873s left) kms_addfb_basic (bad-pitch-256)
[130.632689] Starting subtest: bad-pitch-256
[130.633734] Subtest bad-pitch-256: SUCCESS (0.000s)
[130.860436] [068/161] (873s left) kms_addfb_basic (bad-pitch-32)
[130.960310] Starting subtest: bad-pitch-32
[130.961326] Subtest bad-pitch-32: SUCCESS (0.000s)
[131.175221] [069/161] (872s left) kms_addfb_basic (bad-pitch-63)
[131.273807] Starting subtest: bad-pitch-63
[131.274867] Subtest bad-pitch-63: SUCCESS (0.000s)
[131.501595] [070/161] (872s left) kms_addfb_basic (bad-pitch-65536)
[131.601432] Starting subtest: bad-pitch-65536
[131.602445] Subtest bad-pitch-65536: SUCCESS (0.001s)
[131.821912] [071/161] (872s left) kms_addfb_basic (bad-pitch-999)
[131.919640] Starting subtest: bad-pitch-999
[131.920707] Subtest bad-pitch-999: SUCCESS (0.000s)
[132.154326] [072/161] (872s left) kms_addfb_basic (basic)
[132.252214] Starting subtest: basic
[132.253493] Subtest basic: SUCCESS (0.000s)
[132.472498] [073/161] (871s left) kms_addfb_basic (basic-x-tiled-legacy)
[132.573243] Starting subtest: basic-x-tiled-legacy
[132.574259] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[132.789069] [074/161] (871s left) kms_addfb_basic (basic-y-tiled-legacy)
[132.885219] Starting subtest: basic-y-tiled-legacy
[132.886469] Subtest basic-y-tiled-legacy: SUCCESS (0.001s)
[133.106898] [075/161] (871s left) kms_addfb_basic (bo-too-small)
[133.254862] Starting subtest: bo-too-small
[133.256233] Subtest bo-too-small: SUCCESS (0.001s)
[133.422391] [076/161] (871s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[133.573875] Starting subtest: bo-too-small-due-to-tiling
[133.575122] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[133.716909] [077/161] (871s left) kms_addfb_basic (clobberred-modifier)
[133.812932] Starting subtest: clobberred-modifier
[133.814262] Subtest clobberred-modifier: SUCCESS (0.000s)
[134.020971] [078/161] (870s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[134.122134] Starting subtest: framebuffer-vs-set-tiling
[134.123193] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[134.337018] [079/161] (870s left) kms_addfb_basic (invalid-get-prop)
[134.435033] Starting subtest: invalid-get-prop
[134.436138] Subtest invalid-get-prop: SUCCESS (0.000s)
[134.653389] [080/161] (870s left) kms_addfb_basic (invalid-get-prop-any)
[134.749450] Starting subtest: invalid-get-prop-any
[134.750498] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[134.991064] [081/161] (870s left) kms_addfb_basic (invalid-set-prop)
[135.089455] Starting subtest: invalid-set-prop
[135.090503] Subtest invalid-set-prop: SUCCESS (0.000s)
[135.313411] [082/161] (869s left) kms_addfb_basic (invalid-set-prop-any)
[135.413110] Starting subtest: invalid-set-prop-any
[135.414119] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[135.625226] [083/161] (869s left) kms_addfb_basic (no-handle)
[135.722362] Starting subtest: no-handle
[135.723437] Subtest no-handle: SUCCESS (0.000s)
[135.950047] [084/161] (869s left) kms_addfb_basic (size-max)
[136.100661] Starting subtest: size-max
[136.101880] Subtest size-max: SUCCESS (0.000s)
[136.273110] [085/161] (869s left) kms_addfb_basic (small-bo)
[136.423749] Starting subtest: small-bo
[136.424893] Subtest small-bo: SUCCESS (0.000s)
[136.594335] [086/161] (868s left) kms_addfb_basic (tile-pitch-mismatch)
[136.692374] Starting subtest: tile-pitch-mismatch
[136.693455] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[136.908479] [087/161] (868s left) kms_addfb_basic (too-high)
[137.058906] Starting subtest: too-high
[137.061516] Subtest too-high: SUCCESS (0.001s)
[137.252392] [088/161] (868s left) kms_addfb_basic (too-wide)
[137.404688] Starting subtest: too-wide
[137.405816] Subtest too-wide: SUCCESS (0.000s)
[137.576800] [089/161] (868s left) kms_addfb_basic (unused-handle)
[137.674426] Starting subtest: unused-handle
[137.675492] Subtest unused-handle: SUCCESS (0.000s)
[137.887981] [090/161] (868s left) kms_addfb_basic (unused-modifier)
[137.986129] Starting subtest: unused-modifier
[137.987223] Subtest unused-modifier: SUCCESS (0.000s)
[138.205496] [091/161] (867s left) kms_addfb_basic (unused-offsets)
[138.304425] Starting subtest: unused-offsets
[138.305445] Subtest unused-offsets: SUCCESS (0.000s)
[138.536956] [092/161] (867s left) kms_addfb_basic (unused-pitches)
[138.633343] Starting subtest: unused-pitches
[138.634401] Subtest unused-pitches: SUCCESS (0.000s)
[138.863768] [093/161] (867s left) kms_busy (basic)
[139.018547] Starting subtest: basic
[139.020871] Starting dynamic subtest: flip
[140.031293] Dynamic subtest flip: SUCCESS (1.010s)
[140.053882] Starting dynamic subtest: modeset
[143.825470] Dynamic subtest modeset: SUCCESS (3.793s)
[143.827420] Subtest basic: SUCCESS (4.807s)
[144.804735] [094/161] (861s left) kms_prop_blob (basic)
[144.905890] Starting subtest: basic
[144.907021] Subtest basic: SUCCESS (0.000s)
[145.052532] [095/161] (861s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[145.201269] Starting subtest: basic-busy-flip-before-cursor-atomic
[145.203378] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[145.357026] [096/161] (861s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[145.506404] Starting subtest: basic-busy-flip-before-cursor-legacy
[145.508552] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[145.651966] [097/161] (860s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[145.801314] Starting subtest: basic-flip-after-cursor-atomic
[147.065661] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.262s)
[147.983637] [098/161] (858s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[148.133162] Starting subtest: basic-flip-after-cursor-legacy
[149.390996] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.257s)
[150.318335] [099/161] (856s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[150.466287] Starting subtest: basic-flip-after-cursor-varying-size
[151.730572] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.263s)
[152.652991] [100/161] (854s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[152.803337] Starting subtest: basic-flip-before-cursor-atomic
[154.064775] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.261s)
[154.987356] [101/161] (851s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[155.138459] Starting subtest: basic-flip-before-cursor-legacy
[156.397698] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.258s)
[157.329203] [102/161] (849s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[157.479327] Starting subtest: basic-flip-before-cursor-varying-size
[158.741331] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.261s)
[159.673353] [103/161] (847s left) kms_dsc (dsc-basic)
[159.825801] Starting subtest: dsc-basic
[159.830982] Subtest dsc-basic: SKIP (0.001s)
[159.963828] [104/161] (847s left) kms_flip (basic-flip-vs-dpms)
[160.122453] Starting subtest: basic-flip-vs-dpms
[160.124568] Starting dynamic subtest: A-eDP1
[162.978571] Dynamic subtest A-eDP1: SUCCESS (2.853s)
[163.021126] Starting dynamic subtest: B-eDP1
[165.341475] Dynamic subtest B-eDP1: SUCCESS (2.359s)
[165.380482] Starting dynamic subtest: C-eDP1
[167.701155] Dynamic subtest C-eDP1: SUCCESS (2.358s)
[167.706315] Subtest basic-flip-vs-dpms: SUCCESS (7.584s)
[168.670802] [105/161] (838s left) kms_flip (basic-flip-vs-modeset)
[168.822895] Starting subtest: basic-flip-vs-modeset
[168.824979] Starting dynamic subtest: A-eDP1
[171.640762] Dynamic subtest A-eDP1: SUCCESS (2.814s)
[171.683749] Starting dynamic subtest: B-eDP1
[173.991372] Dynamic subtest B-eDP1: SUCCESS (2.348s)
[174.015296] Starting dynamic subtest: C-eDP1
[176.367398] Dynamic subtest C-eDP1: SUCCESS (2.373s)
[176.371775] Subtest basic-flip-vs-modeset: SUCCESS (7.548s)
[177.348135] [106/161] (830s left) kms_flip (basic-flip-vs-wf_vblank)
[177.498780] Starting subtest: basic-flip-vs-wf_vblank
[177.501173] Starting dynamic subtest: A-eDP1
[179.824887] Dynamic subtest A-eDP1: SUCCESS (2.322s)
[179.853817] Starting dynamic subtest: B-eDP1
[182.144342] Dynamic subtest B-eDP1: SUCCESS (2.316s)
[182.173318] Starting dynamic subtest: C-eDP1
[184.372805] Dynamic subtest C-eDP1: SUCCESS (2.225s)
[184.376501] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.878s)
[185.757129] [107/161] (821s left) kms_flip (basic-plain-flip)
[185.905855] Starting subtest: basic-plain-flip
[185.908203] Starting dynamic subtest: A-eDP1
[187.941813] Dynamic subtest A-eDP1: SUCCESS (2.032s)
[187.977319] Starting dynamic subtest: B-eDP1
[189.945233] Dynamic subtest B-eDP1: SUCCESS (2.001s)
[189.970099] Starting dynamic subtest: C-eDP1
[191.966965] Dynamic subtest C-eDP1: SUCCESS (2.020s)
[191.969786] Subtest basic-plain-flip: SUCCESS (6.065s)
[193.316655] [108/161] (814s left) kms_force_connector_basic (force-connector-state)
[193.445033] Starting subtest: force-connector-state
[194.306399] Subtest force-connector-state: SUCCESS (0.861s)
[195.300907] [109/161] (812s left) kms_force_connector_basic (force-edid)
[195.425201] Starting subtest: force-edid
[195.702742] Subtest force-edid: SUCCESS (0.277s)
[195.969707] [110/161] (811s left) kms_force_connector_basic (force-load-detect)
[196.091976] Starting subtest: force-load-detect
[196.094216] Subtest force-load-detect: SKIP (0.000s)
[196.322381] [111/161] (811s left) kms_force_connector_basic (prune-stale-modes)
[196.447940] Starting subtest: prune-stale-modes
[196.783835] Subtest prune-stale-modes: SUCCESS (0.335s)
[197.059230] [112/161] (810s left) kms_frontbuffer_tracking (basic)
[197.218542] Starting subtest: basic
[201.265246] Subtest basic: SUCCESS (4.044s)
[201.493051] [113/161] (806s left) kms_hdmi_inject (inject-audio)
[201.939433] Starting subtest: inject-audio
[202.263920] Subtest inject-audio: SUCCESS (0.325s)
[202.958980] [114/161] (805s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[203.113792] Starting subtest: compare-crc-sanitycheck-xr24
[203.114889] Starting dynamic subtest: pipe-A-eDP-1
[203.903061] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.786s)
[203.935140] Starting dynamic subtest: pipe-B-eDP-1
[205.249755] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.344s)
[205.295505] Starting dynamic subtest: pipe-C-eDP-1
[206.599127] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.341s)
[206.603049] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.487s)
[207.544031] [115/161] (800s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[207.696801] Starting subtest: compare-crc-sanitycheck-nv12
[207.698094] Starting dynamic subtest: pipe-A-eDP-1
[208.800429] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.100s)
[208.842705] Starting dynamic subtest: pipe-B-eDP-1
[210.230437] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.423s)
[210.277710] Starting dynamic subtest: pipe-C-eDP-1
[211.567869] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.330s)
[211.569853] Subtest compare-crc-sanitycheck-nv12: SUCCESS (3.873s)
[212.494479] [116/161] (795s left) kms_pipe_crc_basic (hang-read-crc)
[212.645907] Starting subtest: hang-read-crc
[212.647083] Starting dynamic subtest: pipe-A-eDP-1
[215.134558] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.483s)
[215.177837] Starting dynamic subtest: pipe-B-eDP-1
[218.130941] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.990s)
[218.178422] Starting dynamic subtest: pipe-C-eDP-1
[221.240828] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.104s)
[221.242606] Subtest hang-read-crc: SUCCESS (8.597s)
[222.164498] [117/161] (786s left) kms_pipe_crc_basic (nonblocking-crc)
[222.319996] Starting subtest: nonblocking-crc
[222.321131] Starting dynamic subtest: pipe-A-eDP-1
[223.304541] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.981s)
[223.355480] Starting dynamic subtest: pipe-B-eDP-1
[224.911175] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.598s)
[224.947453] Starting dynamic subtest: pipe-C-eDP-1
[226.477735] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.558s)
[226.479558] Subtest nonblocking-crc: SUCCESS (4.158s)
[227.432798] [118/161] (781s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[227.583016] Starting subtest: nonblocking-crc-frame-sequence
[227.586246] Starting dynamic subtest: pipe-A-eDP-1
[228.586673] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.998s)
[228.640017] Starting dynamic subtest: pipe-B-eDP-1
[230.160273] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.568s)
[230.210508] Starting dynamic subtest: pipe-C-eDP-1
[231.734171] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.564s)
[231.735929] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.152s)
[232.693607] [119/161] (776s left) kms_pipe_crc_basic (read-crc)
[232.849110] Starting subtest: read-crc
[232.850173] Starting dynamic subtest: pipe-A-eDP-1
[233.765770] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.912s)
[233.810089] Starting dynamic subtest: pipe-B-eDP-1
[235.262698] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.490s)
[235.310168] Starting dynamic subtest: pipe-C-eDP-1
[236.724165] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.452s)
[236.725951] Subtest read-crc: SUCCESS (3.876s)
[237.638533] [120/161] (771s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[237.793113] Starting subtest: read-crc-frame-sequence
[237.794374] Starting dynamic subtest: pipe-A-eDP-1
[238.778154] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.980s)
[238.828057] Starting dynamic subtest: pipe-B-eDP-1
[240.310555] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.525s)
[240.349929] Starting dynamic subtest: pipe-C-eDP-1
[241.820442] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.502s)
[241.822292] Subtest read-crc-frame-sequence: SUCCESS (4.030s)
[242.788812] [121/161] (766s left) kms_pm_backlight (basic-brightness)
[242.952079] Starting subtest: basic-brightness
[243.066971] Starting dynamic subtest: eDP-1
[243.678982] Dynamic subtest eDP-1: SUCCESS (0.617s)
[243.680908] Subtest basic-brightness: SUCCESS (0.731s)
[244.584859] [122/161] (764s left) kms_pm_rpm (basic-pci-d3-state)
[246.381097] Starting subtest: basic-pci-d3-state
[246.969037] Subtest basic-pci-d3-state: SUCCESS (0.591s)
[247.185867] [123/161] (761s left) kms_pm_rpm (basic-rte)
[247.285298] Starting subtest: basic-rte
[249.634560] Subtest basic-rte: SUCCESS (2.343s)
[250.959760] [124/161] (758s left) kms_psr (psr-primary-page-flip)
[251.117179] Starting subtest: psr-primary-page-flip
[251.118340] Starting dynamic subtest: eDP-1
[254.999846] Dynamic subtest eDP-1: SUCCESS (3.881s)
[255.001257] Subtest psr-primary-page-flip: SUCCESS (3.884s)
[255.951730] [125/161] (753s left) kms_psr (psr-cursor-plane-move)
[256.106329] Starting subtest: psr-cursor-plane-move
[256.107367] Starting dynamic subtest: eDP-1
[259.821953] Dynamic subtest eDP-1: SUCCESS (3.711s)
[259.826062] Subtest psr-cursor-plane-move: SUCCESS (3.716s)
[260.779113] [126/161] (748s left) kms_psr (psr-sprite-plane-onoff)
[260.933112] Starting subtest: psr-sprite-plane-onoff
[260.934205] Starting dynamic subtest: eDP-1
[264.857903] Dynamic subtest eDP-1: SUCCESS (3.919s)
[264.860305] Subtest psr-sprite-plane-onoff: SUCCESS (3.924s)
[265.835247] [127/161] (743s left) kms_psr (psr-primary-mmap-gtt)
[265.987106] Starting subtest: psr-primary-mmap-gtt
[265.988173] Starting dynamic subtest: eDP-1
[269.942225] Dynamic subtest eDP-1: SUCCESS (3.952s)
[269.944219] Subtest psr-primary-mmap-gtt: SUCCESS (3.957s)
[270.884107] [128/161] (738s left) kms_setmode (basic-clone-single-crtc)
[270.989929] Starting subtest: basic-clone-single-crtc
[270.993092] Subtest basic-clone-single-crtc: SKIP (0.000s)
[271.132176] [129/161] (738s left) i915_pm_rps (basic-api)
[271.240491] Starting subtest: basic-api
[271.245466] Subtest basic-api: SUCCESS (0.005s)
[271.399954] [130/161] (738s left) prime_self_import (basic-llseek-bad)
[271.496334] Starting subtest: basic-llseek-bad
[271.501213] Subtest basic-llseek-bad: SUCCESS (0.004s)
[271.682435] [131/161] (738s left) prime_self_import (basic-llseek-size)
[271.778827] Starting subtest: basic-llseek-size
[271.784148] Subtest basic-llseek-size: SUCCESS (0.005s)
[271.948994] [132/161] (738s left) prime_self_import (basic-with_fd_dup)
[272.041335] Starting subtest: basic-with_fd_dup
[272.046915] Subtest basic-with_fd_dup: SUCCESS (0.005s)
[272.217531] [133/161] (737s left) prime_self_import (basic-with_one_bo)
[272.312558] Starting subtest: basic-with_one_bo
[272.317361] Subtest basic-with_one_bo: SUCCESS (0.006s)
[272.465288] [134/161] (737s left) prime_self_import (basic-with_one_bo_two_files)
[272.560482] Starting subtest: basic-with_one_bo_two_files
[272.565408] Subtest basic-with_one_bo_two_files: SUCCESS (0.005s)
[272.730245] [135/161] (737s left) prime_self_import (basic-with_two_bos)
[272.830477] Starting subtest: basic-with_two_bos
[272.834983] Subtest basic-with_two_bos: SUCCESS (0.006s)
[272.998537] [136/161] (737s left) prime_vgem (basic-fence-flip)
[273.125454] Starting subtest: basic-fence-flip
[273.696418] Subtest basic-fence-flip: SUCCESS (0.571s)
[273.888602] [137/161] (736s left) prime_vgem (basic-fence-mmap)
[274.016086] Starting subtest: basic-fence-mmap
[274.074280] Subtest basic-fence-mmap: SUCCESS (0.058s)
[274.228710] [138/161] (736s left) prime_vgem (basic-fence-read)
[274.342192] Starting subtest: basic-fence-read
[274.451490] Subtest basic-fence-read: SUCCESS (0.100s)
[274.604287] [139/161] (736s left) prime_vgem (basic-gtt)
[274.733067] Starting subtest: basic-gtt
[274.758037] Subtest basic-gtt: SUCCESS (0.025s)
[274.933298] [140/161] (735s left) prime_vgem (basic-read)
[275.067749] Starting subtest: basic-read
[275.114748] Subtest basic-read: SUCCESS (0.047s)
[275.264024] [141/161] (735s left) prime_vgem (basic-write)
[275.375140] Starting subtest: basic-write
[275.439822] Subtest basic-write: SUCCESS (0.065s)
[275.599411] [142/161] (735s left) vgem_basic (setversion)
[275.715073] Starting subtest: setversion
[275.717274] Subtest setversion: SUCCESS (0.000s)
[275.849776] [143/161] (735s left) vgem_basic (create)
[275.966538] Starting subtest: create
[275.967641] Subtest create: SUCCESS (0.001s)
[276.099604] [144/161] (735s left) vgem_basic (debugfs)
[276.214807] Starting subtest: debugfs
[276.215913] Subtest debugfs: SUCCESS (0.001s)
[276.349461] [145/161] (734s left) vgem_basic (dmabuf-export)
[276.465242] Starting subtest: dmabuf-export
[276.470131] Subtest dmabuf-export: SUCCESS (0.004s)
[276.634117] [146/161] (734s left) vgem_basic (dmabuf-fence)
[276.748216] Starting subtest: dmabuf-fence
[276.751664] Subtest dmabuf-fence: SUCCESS (0.001s)
[276.881803] [147/161] (734s left) vgem_basic (dmabuf-fence-before)
[276.981679] Starting subtest: dmabuf-fence-before
[276.982802] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[277.114464] [148/161] (734s left) vgem_basic (dmabuf-mmap)
[277.216356] Starting subtest: dmabuf-mmap
[277.239123] Subtest dmabuf-mmap: SUCCESS (0.024s)
[277.364649] [149/161] (734s left) vgem_basic (mmap)
[277.483631] Starting subtest: mmap
[277.498410] Subtest mmap: SUCCESS (0.016s)
[277.630315] [150/161] (734s left) vgem_basic (second-client)
[277.731678] Starting subtest: second-client
[277.765849] Subtest second-client: SUCCESS (0.033s)
[277.904905] [151/161] (733s left) vgem_basic (sysfs)
[278.016638] Starting subtest: sysfs
[278.017724] Subtest sysfs: SUCCESS (0.001s)
[278.149074] [152/161] (733s left) core_hotunplug (unbind-rebind)
[278.332301] Starting subtest: unbind-rebind
[283.417340] Subtest unbind-rebind: SUCCESS (5.086s)
[283.519946] [153/161] (728s left) vgem_basic (unload)
[283.621453] Starting subtest: unload
[312.746316] Subtest unload: SUCCESS (29.114s)
[312.940459] [154/161] (699s left) i915_module_load (reload)
[313.040623] Starting subtest: reload
[318.075149] Subtest reload: SUCCESS (5.033s)
[318.181216] [155/161] (694s left) gem_lmem_swapping (basic)
[318.328541] Subtest basic: SKIP (0.000s)
[318.437715] [156/161] (693s left) gem_lmem_swapping (parallel-random-engines)
[318.544838] Subtest parallel-random-engines: SKIP (0.000s)
[318.653991] [157/161] (693s left) gem_lmem_swapping (random-engines)
[318.763974] Subtest random-engines: SKIP (0.000s)
[318.870035] [158/161] (693s left) gem_lmem_swapping (verify-random)
[318.979020] Subtest verify-random: SKIP (0.000s)
[319.086897] [159/161] (693s left) i915_pm_rpm (module-reload)
[331.568716] Starting subtest: module-reload
[365.146606] Subtest module-reload: SUCCESS (33.569s)
[365.210786] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[365.213536] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[365.219535] [160/161] (647s left) i915_selftest (live)
[365.328163] Starting subtest: live
[365.329245] Starting dynamic subtest: sanitycheck
[368.737484] Dynamic subtest sanitycheck: SUCCESS (3.399s)
[368.760132] Starting dynamic subtest: uncore
[372.038423] Dynamic subtest uncore: SUCCESS (3.296s)
[372.061445] Starting dynamic subtest: workarounds
[375.671465] Dynamic subtest workarounds: SUCCESS (3.628s)
[375.693815] Starting dynamic subtest: gt_engines
[379.424976] Dynamic subtest gt_engines: SUCCESS (3.749s)
[379.449383] Starting dynamic subtest: gt_timelines
[392.486122] Dynamic subtest gt_timelines: SUCCESS (13.058s)
[392.508220] Starting dynamic subtest: gt_contexts
[396.044435] Dynamic subtest gt_contexts: SUCCESS (3.553s)
[396.067068] Starting dynamic subtest: gt_lrc
[401.621965] Dynamic subtest gt_lrc: SUCCESS (5.579s)
[401.649358] Starting dynamic subtest: gt_mocs
[405.133790] Dynamic subtest gt_mocs: SUCCESS (3.499s)
[405.163847] Starting dynamic subtest: gt_pm
[415.015405] Dynamic subtest gt_pm: SUCCESS (9.877s)
[415.038040] Starting dynamic subtest: gt_heartbeat
[418.342316] Dynamic subtest gt_heartbeat: SUCCESS (3.322s)
[418.364530] Starting dynamic subtest: gt_tlb
[422.958473] Dynamic subtest gt_tlb: SUCCESS (4.611s)
[422.980695] Starting dynamic subtest: requests
[432.699307] Dynamic subtest requests: SUCCESS (9.733s)
[432.721685] Starting dynamic subtest: migrate
[438.890469] Dynamic subtest migrate: SUCCESS (6.188s)
[438.913195] Starting dynamic subtest: active
[442.255249] Dynamic subtest active: SUCCESS (3.360s)
[442.277592] Starting dynamic subtest: objects
[446.816423] Dynamic subtest objects: SUCCESS (4.556s)
[446.839116] Starting dynamic subtest: mman
[456.556485] Dynamic subtest mman: SUCCESS (9.735s)
[456.579317] Starting dynamic subtest: dmabuf
[460.020459] Dynamic subtest dmabuf: SUCCESS (3.459s)
[460.043417] Starting dynamic subtest: vma
[463.393610] Dynamic subtest vma: SUCCESS (3.368s)
[463.416183] Starting dynamic subtest: coherency
[468.711469] Dynamic subtest coherency: SUCCESS (5.310s)
[468.736030] Starting dynamic subtest: gtt
[480.528176] Dynamic subtest gtt: SUCCESS (11.817s)
[480.550570] Starting dynamic subtest: gem
[484.287479] Dynamic subtest gem: SUCCESS (3.754s)
[484.310218] Starting dynamic subtest: evict
[489.773119] Dynamic subtest evict: SUCCESS (5.481s)
[489.795441] Starting dynamic subtest: hugepages
[499.999742] Dynamic subtest hugepages: SUCCESS (10.222s)
[500.022142] Starting dynamic subtest: gem_contexts
[517.567318] Dynamic subtest gem_contexts: SUCCESS (17.538s)
[517.585359] Starting dynamic subtest: client
[520.916630] Dynamic subtest client: SUCCESS (3.370s)
[520.939375] Starting dynamic subtest: gem_migrate
[524.226189] Dynamic subtest gem_migrate: SUCCESS (3.309s)
[524.250673] Starting dynamic subtest: reset
[532.537396] Dynamic subtest reset: SUCCESS (8.301s)
[532.559803] Starting dynamic subtest: memory_region
[535.890557] Dynamic subtest memory_region: SUCCESS (3.348s)
[535.913810] Starting dynamic subtest: hangcheck
[562.090657] Dynamic subtest hangcheck: SUCCESS (26.194s)
[562.113108] Starting dynamic subtest: execlists
[575.204122] Dynamic subtest execlists: SUCCESS (13.108s)
[575.226346] Starting dynamic subtest: ring_submission
[578.532671] Dynamic subtest ring_submission: SUCCESS (3.324s)
[578.556208] Starting dynamic subtest: perf
[582.169416] Dynamic subtest perf: SUCCESS (3.632s)
[582.192460] Starting dynamic subtest: slpc
[585.453265] Dynamic subtest slpc: SUCCESS (3.279s)
[585.475869] Starting dynamic subtest: guc
[588.804483] Dynamic subtest guc: SUCCESS (3.346s)
[588.828062] Starting dynamic subtest: guc_multi_lrc
[592.162425] Dynamic subtest guc_multi_lrc: SUCCESS (3.353s)
[592.184877] Starting dynamic subtest: guc_hang
[595.470472] Dynamic subtest guc_hang: SUCCESS (3.303s)
[595.493622] Starting dynamic subtest: late_gt_pm
[598.861351] Dynamic subtest late_gt_pm: SUCCESS (3.386s)
[598.862647] Subtest live: SUCCESS (233.520s)
[598.934962] [161/161] (413s left) dmabuf (all-tests)
[599.042241] Starting subtest: all-tests
[599.043921] Starting dynamic subtest: sanitycheck
[599.161197] Dynamic subtest sanitycheck: SUCCESS (0.109s)
[599.181767] Starting dynamic subtest: dma_fence
[599.409320] Dynamic subtest dma_fence: SUCCESS (0.243s)
[599.427848] Starting dynamic subtest: dma_fence_chain
[613.567214] Dynamic subtest dma_fence_chain: SUCCESS (14.152s)
[613.586336] Starting dynamic subtest: dma_fence_unwrap
[613.652931] Dynamic subtest dma_fence_unwrap: SUCCESS (0.089s)
[613.679497] Starting dynamic subtest: dma_resv
[613.747910] Dynamic subtest dma_resv: SUCCESS (0.090s)
[613.754883] Subtest all-tests: SUCCESS (14.707s)
[613.825741] Closing watchdogs
Done.