[47.121641] Initializing watchdogs
[47.121821]   /dev/watchdog0
[47.165794] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:4e51 Intel Jasperlake (Gen11) 
[47.176169] [001/161] (960s left) i915_module_load (load)
[47.306385] Starting subtest: load
[51.439414] Subtest load: SUCCESS (4.130s)
[51.567210] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[51.573925] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[51.582933] [002/161] (956s left) core_auth (basic-auth)
[51.728510] Starting subtest: basic-auth
[51.732559] Subtest basic-auth: SUCCESS (0.002s)
[51.883054] [003/161] (956s left) debugfs_test (read_all_entries)
[52.018175] Starting subtest: read_all_entries
[52.178172] Subtest read_all_entries: SUCCESS (0.155s)
[52.500845] [004/161] (955s left) debugfs_test (basic-hwmon)
[52.661141] Starting subtest: basic-hwmon
[52.666215] Subtest basic-hwmon: SKIP (0.000s)
[52.895385] [005/161] (955s left) debugfs_test (sysfs)
[53.018348] Starting subtest: sysfs
[53.185231] Subtest sysfs: SUCCESS (0.167s)
[53.413934] [006/161] (954s left) fbdev (eof)
[53.539970] Starting subtest: eof
[53.542546] Subtest eof: SUCCESS (0.001s)
[53.655671] [007/161] (954s left) fbdev (info)
[53.775973] Starting subtest: info
[53.778066] Subtest info: SUCCESS (0.000s)
[53.906327] [008/161] (954s left) fbdev (nullptr)
[54.021126] Starting subtest: nullptr
[54.022991] Subtest nullptr: SUCCESS (0.000s)
[54.140153] [009/161] (954s left) fbdev (read)
[54.250447] Starting subtest: read
[62.396560] Subtest read: SUCCESS (8.145s)
[62.528985] [010/161] (946s left) fbdev (write)
[62.634807] Starting subtest: write
[66.805272] Subtest write: SUCCESS (4.170s)
[66.942814] [011/161] (941s left) gem_basic (bad-close)
[67.057951] Starting subtest: bad-close
[67.063370] Subtest bad-close: SUCCESS (0.000s)
[67.192764] [012/161] (941s left) gem_basic (create-close)
[67.303812] Starting subtest: create-close
[67.308984] Subtest create-close: SUCCESS (0.000s)
[67.465612] [013/161] (941s left) gem_basic (create-fd-close)
[67.577241] Starting subtest: create-fd-close
[67.581496] Subtest create-fd-close: SUCCESS (0.000s)
[67.728155] [014/161] (941s left) gem_busy (busy@all-engines)
[67.871610] Starting subtest: busy
[67.873985] Starting dynamic subtest: all-engines
[67.978318] Dynamic subtest all-engines: SUCCESS (0.108s)
[67.980913] Subtest busy: SUCCESS (0.108s)
[68.447499] [015/161] (940s left) gem_close_race (basic-process)
[68.594322] Starting subtest: basic-process
[68.694762] Subtest basic-process: SUCCESS (0.100s)
[68.964976] [016/161] (940s left) gem_close_race (basic-threads)
[69.113353] Starting subtest: basic-threads
[70.389144] Subtest basic-threads: SUCCESS (1.276s)
[70.693116] [017/161] (938s left) gem_ctx_create (basic)
[70.833910] Starting subtest: basic
[70.836691] Subtest basic: SUCCESS (0.000s)
[71.096165] [018/161] (938s left) gem_ctx_create (basic-files)
[71.233032] Starting subtest: basic-files
[73.269309] Subtest basic-files: SUCCESS (2.037s)
[73.585572] [019/161] (935s left) gem_ctx_exec (basic)
[73.702422] Starting subtest: basic
[73.708835] Subtest basic: SUCCESS (0.008s)
[73.881734] [020/161] (935s left) gem_exec_basic (basic)
[74.016144] Starting subtest: basic
[74.019373] Starting dynamic subtest: rcs0-smem
[74.022358] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[74.045582] Starting dynamic subtest: bcs0-smem
[74.047707] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[74.064361] Starting dynamic subtest: vcs0-smem
[74.066375] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[74.082760] Starting dynamic subtest: vecs0-smem
[74.084774] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[74.086725] Subtest basic: SUCCESS (0.012s)
[74.298695] [021/161] (935s left) gem_exec_create (basic)
[74.434443] Starting subtest: basic
[74.438362] Starting dynamic subtest: smem
[76.690729] Dynamic subtest smem: SUCCESS (2.253s)
[76.695552] Subtest basic: SUCCESS (2.254s)
[77.224657] [022/161] (932s left) gem_exec_fence (basic-busy)
[77.609210] Starting subtest: basic-busy
[77.612160] Starting dynamic subtest: rcs0
[77.883494] Dynamic subtest rcs0: SUCCESS (0.273s)
[77.907680] Starting dynamic subtest: bcs0
[78.156045] Dynamic subtest bcs0: SUCCESS (0.271s)
[78.179679] Starting dynamic subtest: vcs0
[78.283668] Dynamic subtest vcs0: SUCCESS (0.127s)
[78.306615] Starting dynamic subtest: vecs0
[78.420677] Dynamic subtest vecs0: SUCCESS (0.136s)
[78.423741] Subtest basic-busy: SUCCESS (0.812s)
[79.296015] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[79.303476] [023/161] (930s left) gem_exec_fence (basic-wait)
[79.675595] Starting subtest: basic-wait
[79.679020] Starting dynamic subtest: rcs0
[79.703895] Dynamic subtest rcs0: SUCCESS (0.032s)
[79.746205] Starting dynamic subtest: bcs0
[79.751555] Dynamic subtest bcs0: SUCCESS (0.042s)
[79.786565] Starting dynamic subtest: vcs0
[79.788798] Dynamic subtest vcs0: SUCCESS (0.030s)
[79.811726] Starting dynamic subtest: vecs0
[79.814297] Dynamic subtest vecs0: SUCCESS (0.032s)
[79.816728] Subtest basic-wait: SUCCESS (0.138s)
[80.471658] [024/161] (929s left) gem_exec_fence (basic-await)
[80.756259] Starting subtest: basic-await
[80.758881] Starting dynamic subtest: rcs0
[80.909061] Dynamic subtest rcs0: SUCCESS (0.154s)
[80.942815] Starting dynamic subtest: bcs0
[81.073401] Dynamic subtest bcs0: SUCCESS (0.163s)
[81.107633] Starting dynamic subtest: vcs0
[81.236611] Dynamic subtest vcs0: SUCCESS (0.162s)
[81.275923] Starting dynamic subtest: vecs0
[81.407502] Dynamic subtest vecs0: SUCCESS (0.170s)
[81.410787] Subtest basic-await: SUCCESS (0.653s)
[82.088934] [025/161] (928s left) gem_exec_fence (nb-await)
[82.366272] Starting subtest: nb-await
[82.369403] Starting dynamic subtest: rcs0
[82.440159] Dynamic subtest rcs0: SUCCESS (0.073s)
[82.470640] Starting dynamic subtest: bcs0
[82.516239] Dynamic subtest bcs0: SUCCESS (0.073s)
[82.556717] Starting dynamic subtest: vcs0
[82.593785] Dynamic subtest vcs0: SUCCESS (0.078s)
[82.635487] Starting dynamic subtest: vecs0
[82.672386] Dynamic subtest vecs0: SUCCESS (0.077s)
[82.675629] Subtest nb-await: SUCCESS (0.306s)
[83.357720] [026/161] (926s left) gem_exec_gttfill (basic)
[83.495088] Starting subtest: basic
[97.739716] Subtest basic: SUCCESS (14.244s)
[98.027410] [027/161] (912s left) gem_exec_parallel (engines)
[98.247711] Starting subtest: engines
[98.252035] Starting dynamic subtest: basic
[102.104758] Dynamic subtest basic: SUCCESS (3.860s)
[102.132940] Starting dynamic subtest: contexts
[109.484650] Dynamic subtest contexts: SUCCESS (7.379s)
[109.513159] Starting dynamic subtest: fds
[116.005993] Dynamic subtest fds: SUCCESS (6.521s)
[116.045889] Starting dynamic subtest: userptr
[120.714840] Dynamic subtest userptr: SUCCESS (4.708s)
[120.717252] Subtest engines: SUCCESS (22.470s)
[121.024097] [028/161] (889s left) gem_exec_store (basic)
[121.164799] Starting subtest: basic
[121.234668] Subtest basic: SUCCESS (0.070s)
[121.506913] [029/161] (889s left) gem_flink_basic (bad-flink)
[121.616952] Starting subtest: bad-flink
[121.619774] Subtest bad-flink: SUCCESS (0.000s)
[121.776871] [030/161] (889s left) gem_flink_basic (bad-open)
[121.886022] Starting subtest: bad-open
[121.888703] Subtest bad-open: SUCCESS (0.000s)
[122.041968] [031/161] (888s left) gem_flink_basic (basic)
[122.150240] Starting subtest: basic
[122.152881] Subtest basic: SUCCESS (0.000s)
[122.327825] [032/161] (888s left) gem_flink_basic (double-flink)
[122.437333] Starting subtest: double-flink
[122.439174] Subtest double-flink: SUCCESS (0.000s)
[122.605070] [033/161] (888s left) gem_flink_basic (flink-lifetime)
[122.711578] Starting subtest: flink-lifetime
[122.713749] Subtest flink-lifetime: SUCCESS (0.004s)
[122.892931] [034/161] (888s left) gem_huc_copy (huc-copy)
[123.014165] Starting subtest: huc-copy
[123.018956] Subtest huc-copy: SKIP (0.000s)
[123.190940] [035/161] (888s left) gem_linear_blits (basic)
[123.463892] Starting subtest: basic
[123.491791] Subtest basic: SUCCESS (0.028s)
[123.701729] [036/161] (887s left) gem_mmap (basic)
[123.875136] Starting subtest: basic
[123.885524] Subtest basic: SUCCESS (0.001s)
[124.042278] [037/161] (887s left) gem_mmap_gtt (basic)
[124.153560] Starting subtest: basic
[124.156078] Subtest basic: SUCCESS (0.002s)
[124.330369] [038/161] (887s left) gem_render_linear_blits (basic)
[124.488956] Starting subtest: basic
[124.561513] Subtest basic: SUCCESS (0.072s)
[124.702825] [039/161] (887s left) gem_render_tiled_blits (basic)
[124.820578] Starting subtest: basic
[124.919724] Subtest basic: SUCCESS (0.099s)
[125.068708] [040/161] (886s left) gem_ringfill (basic-all)
[125.414398] Starting subtest: basic-all
[126.678911] Subtest basic-all: SUCCESS (1.265s)
[126.853738] [041/161] (885s left) gem_softpin (allocator-basic)
[126.976692] Starting subtest: allocator-basic
[127.167319] Subtest allocator-basic: SUCCESS (0.189s)
[127.347374] [042/161] (884s left) gem_softpin (allocator-basic-reserve)
[127.469835] Starting subtest: allocator-basic-reserve
[127.661817] Subtest allocator-basic-reserve: SUCCESS (0.191s)
[127.870190] [043/161] (884s left) gem_softpin (safe-alignment)
[127.990930] Starting subtest: safe-alignment
[128.018482] Subtest safe-alignment: SUCCESS (0.027s)
[128.199796] [044/161] (884s left) gem_sync (basic-all)
[128.342795] Starting subtest: basic-all
[130.462793] Subtest basic-all: SUCCESS (2.117s)
[130.749849] [045/161] (881s left) gem_sync (basic-each)
[130.893025] Starting subtest: basic-each
[133.386393] Subtest basic-each: SUCCESS (2.489s)
[133.695152] [046/161] (878s left) gem_tiled_blits (basic)
[133.912176] Starting subtest: basic
[133.958819] Subtest basic: SUCCESS (0.045s)
[134.196650] [047/161] (878s left) gem_tiled_fence_blits (basic)
[134.510862] Starting subtest: basic
[134.552125] Subtest basic: SUCCESS (0.046s)
[134.779595] [048/161] (877s left) gem_tiled_pread_basic
[135.394054] [049/161] (877s left) gem_wait (busy@all-engines)
[135.551623] Starting subtest: busy
[135.554212] Starting dynamic subtest: all-engines
[136.083257] Dynamic subtest all-engines: SUCCESS (0.533s)
[136.086156] Subtest busy: SUCCESS (0.534s)
[136.409558] [050/161] (876s left) gem_wait (wait@all-engines)
[136.560592] Starting subtest: wait
[136.563422] Starting dynamic subtest: all-engines
[137.603716] Dynamic subtest all-engines: SUCCESS (1.043s)
[137.606635] Subtest wait: SUCCESS (1.044s)
[137.922241] [051/161] (875s left) i915_getparams_basic (basic-eu-total)
[138.035020] Starting subtest: basic-eu-total
[138.040295] Subtest basic-eu-total: SUCCESS (0.000s)
[138.191337] [052/161] (874s left) i915_getparams_basic (basic-subslice-total)
[138.299906] Starting subtest: basic-subslice-total
[138.305046] Subtest basic-subslice-total: SUCCESS (0.000s)
[138.455572] [053/161] (874s left) i915_hangman (error-state-basic)
[138.589774] Starting subtest: error-state-basic
[138.612440] Subtest error-state-basic: SUCCESS (0.019s)
[138.779026] [054/161] (874s left) i915_pciid
[139.042190] [055/161] (874s left) kms_addfb_basic (addfb25-4-tiled)
[139.222210] Starting subtest: addfb25-4-tiled
[139.224607] Subtest addfb25-4-tiled: SUCCESS (0.001s)
[139.435220] [056/161] (874s left) kms_addfb_basic (addfb25-bad-modifier)
[139.613420] Starting subtest: addfb25-bad-modifier
[139.615775] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[139.815730] [057/161] (873s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[139.986266] Starting subtest: addfb25-framebuffer-vs-set-tiling
[139.988616] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[140.153082] [058/161] (873s left) kms_addfb_basic (addfb25-modifier-no-flag)
[140.320637] Starting subtest: addfb25-modifier-no-flag
[140.323174] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[140.507471] [059/161] (873s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[140.678187] Starting subtest: addfb25-x-tiled-legacy
[140.680574] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[140.862176] [060/161] (873s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[141.032255] Starting subtest: addfb25-x-tiled-mismatch-legacy
[141.034639] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[141.212550] [061/161] (872s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[141.385142] Starting subtest: addfb25-yf-tiled-legacy
[141.387580] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[141.573919] [062/161] (872s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[141.745130] Starting subtest: addfb25-y-tiled-legacy
[141.747453] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[141.929598] [063/161] (872s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[142.100383] Starting subtest: addfb25-y-tiled-small-legacy
[142.102756] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s)
[142.302973] [064/161] (872s left) kms_addfb_basic (bad-pitch-0)
[142.416149] Starting subtest: bad-pitch-0
[142.418450] Subtest bad-pitch-0: SUCCESS (0.000s)
[142.665068] [065/161] (871s left) kms_addfb_basic (bad-pitch-1024)
[142.774392] Starting subtest: bad-pitch-1024
[142.776413] Subtest bad-pitch-1024: SUCCESS (0.000s)
[143.027973] [066/161] (871s left) kms_addfb_basic (bad-pitch-128)
[143.135935] Starting subtest: bad-pitch-128
[143.137987] Subtest bad-pitch-128: SUCCESS (0.000s)
[143.363448] [067/161] (871s left) kms_addfb_basic (bad-pitch-256)
[143.473310] Starting subtest: bad-pitch-256
[143.475282] Subtest bad-pitch-256: SUCCESS (0.000s)
[143.718920] [068/161] (871s left) kms_addfb_basic (bad-pitch-32)
[143.830764] Starting subtest: bad-pitch-32
[143.833169] Subtest bad-pitch-32: SUCCESS (0.000s)
[144.078984] [069/161] (870s left) kms_addfb_basic (bad-pitch-63)
[144.188507] Starting subtest: bad-pitch-63
[144.190506] Subtest bad-pitch-63: SUCCESS (0.000s)
[144.424204] [070/161] (870s left) kms_addfb_basic (bad-pitch-65536)
[144.531754] Starting subtest: bad-pitch-65536
[144.534304] Subtest bad-pitch-65536: SUCCESS (0.001s)
[144.758149] [071/161] (870s left) kms_addfb_basic (bad-pitch-999)
[144.865393] Starting subtest: bad-pitch-999
[144.867827] Subtest bad-pitch-999: SUCCESS (0.000s)
[145.112272] [072/161] (870s left) kms_addfb_basic (basic)
[145.221447] Starting subtest: basic
[145.223909] Subtest basic: SUCCESS (0.000s)
[145.463987] [073/161] (869s left) kms_addfb_basic (basic-x-tiled-legacy)
[145.574942] Starting subtest: basic-x-tiled-legacy
[145.576954] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[145.810346] [074/161] (869s left) kms_addfb_basic (basic-y-tiled-legacy)
[145.921614] Starting subtest: basic-y-tiled-legacy
[145.924226] Subtest basic-y-tiled-legacy: SUCCESS (0.001s)
[146.167740] [075/161] (869s left) kms_addfb_basic (bo-too-small)
[146.334328] Starting subtest: bo-too-small
[146.336830] Subtest bo-too-small: SUCCESS (0.001s)
[146.511232] [076/161] (869s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[146.680407] Starting subtest: bo-too-small-due-to-tiling
[146.682929] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[146.839201] [077/161] (868s left) kms_addfb_basic (clobberred-modifier)
[146.947382] Starting subtest: clobberred-modifier
[146.949945] Subtest clobberred-modifier: SUCCESS (0.000s)
[147.179655] [078/161] (868s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[147.292941] Starting subtest: framebuffer-vs-set-tiling
[147.294984] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[147.532971] [079/161] (868s left) kms_addfb_basic (invalid-get-prop)
[147.643367] Starting subtest: invalid-get-prop
[147.645845] Subtest invalid-get-prop: SUCCESS (0.000s)
[147.858412] [080/161] (868s left) kms_addfb_basic (invalid-get-prop-any)
[147.970384] Starting subtest: invalid-get-prop-any
[147.972739] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[148.218750] [081/161] (867s left) kms_addfb_basic (invalid-set-prop)
[148.329834] Starting subtest: invalid-set-prop
[148.332271] Subtest invalid-set-prop: SUCCESS (0.000s)
[148.561978] [082/161] (867s left) kms_addfb_basic (invalid-set-prop-any)
[148.671389] Starting subtest: invalid-set-prop-any
[148.673742] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[148.893331] [083/161] (867s left) kms_addfb_basic (no-handle)
[149.004315] Starting subtest: no-handle
[149.006591] Subtest no-handle: SUCCESS (0.000s)
[149.252739] [084/161] (867s left) kms_addfb_basic (size-max)
[149.419371] Starting subtest: size-max
[149.421854] Subtest size-max: SUCCESS (0.000s)
[149.600534] [085/161] (867s left) kms_addfb_basic (small-bo)
[149.769930] Starting subtest: small-bo
[149.772527] Subtest small-bo: SUCCESS (0.000s)
[149.954814] [086/161] (866s left) kms_addfb_basic (tile-pitch-mismatch)
[150.069588] Starting subtest: tile-pitch-mismatch
[150.071884] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[150.295265] [087/161] (866s left) kms_addfb_basic (too-high)
[150.463372] Starting subtest: too-high
[150.465916] Subtest too-high: SUCCESS (0.002s)
[150.651512] [088/161] (866s left) kms_addfb_basic (too-wide)
[150.816396] Starting subtest: too-wide
[150.818848] Subtest too-wide: SUCCESS (0.000s)
[151.022840] [089/161] (865s left) kms_addfb_basic (unused-handle)
[151.130574] Starting subtest: unused-handle
[151.133189] Subtest unused-handle: SUCCESS (0.000s)
[151.387177] [090/161] (865s left) kms_addfb_basic (unused-modifier)
[151.496649] Starting subtest: unused-modifier
[151.498652] Subtest unused-modifier: SUCCESS (0.000s)
[151.734360] [091/161] (865s left) kms_addfb_basic (unused-offsets)
[151.843277] Starting subtest: unused-offsets
[151.845569] Subtest unused-offsets: SUCCESS (0.000s)
[152.076434] [092/161] (865s left) kms_addfb_basic (unused-pitches)
[152.184798] Starting subtest: unused-pitches
[152.187248] Subtest unused-pitches: SUCCESS (0.000s)
[152.434555] [093/161] (864s left) kms_busy (basic)
[152.613623] Starting subtest: basic
[152.618778] Starting dynamic subtest: flip
[153.683221] Dynamic subtest flip: SUCCESS (1.061s)
[153.715269] Starting dynamic subtest: modeset
[157.699853] Dynamic subtest modeset: SUCCESS (4.017s)
[157.703193] Subtest basic: SUCCESS (5.082s)
[158.687314] [094/161] (858s left) kms_prop_blob (basic)
[158.798863] Starting subtest: basic
[158.801691] Subtest basic: SUCCESS (0.000s)
[158.941912] [095/161] (858s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[159.114790] Starting subtest: basic-busy-flip-before-cursor-atomic
[159.119643] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[159.259538] [096/161] (858s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[159.430259] Starting subtest: basic-busy-flip-before-cursor-legacy
[159.435248] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[159.575725] [097/161] (858s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[159.744867] Starting subtest: basic-flip-after-cursor-atomic
[161.021057] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.272s)
[161.972762] [098/161] (855s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[162.144576] Starting subtest: basic-flip-after-cursor-legacy
[163.407119] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.262s)
[164.419360] [099/161] (853s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[164.591525] Starting subtest: basic-flip-after-cursor-varying-size
[165.857409] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.266s)
[166.877188] [100/161] (851s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[167.046441] Starting subtest: basic-flip-before-cursor-atomic
[168.317505] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.270s)
[169.367310] [101/161] (848s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[169.557684] Starting subtest: basic-flip-before-cursor-legacy
[170.833817] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.275s)
[171.779891] [102/161] (846s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[171.948538] Starting subtest: basic-flip-before-cursor-varying-size
[173.221489] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.271s)
[174.228128] [103/161] (844s left) kms_dsc (dsc-basic)
[174.392264] Starting subtest: dsc-basic
[174.404695] Subtest dsc-basic: SKIP (0.001s)
[174.540416] [104/161] (844s left) kms_flip (basic-flip-vs-dpms)
[174.708408] Starting subtest: basic-flip-vs-dpms
[174.714032] Starting dynamic subtest: A-eDP1
[177.581512] Dynamic subtest A-eDP1: SUCCESS (2.866s)
[177.624814] Starting dynamic subtest: B-eDP1
[179.938614] Dynamic subtest B-eDP1: SUCCESS (2.352s)
[179.976483] Starting dynamic subtest: C-eDP1
[182.321608] Dynamic subtest C-eDP1: SUCCESS (2.382s)
[182.324682] Subtest basic-flip-vs-dpms: SUCCESS (7.615s)
[183.283063] [105/161] (835s left) kms_flip (basic-flip-vs-modeset)
[183.451551] Starting subtest: basic-flip-vs-modeset
[183.457290] Starting dynamic subtest: A-eDP1
[186.300731] Dynamic subtest A-eDP1: SUCCESS (2.841s)
[186.341174] Starting dynamic subtest: B-eDP1
[188.649587] Dynamic subtest B-eDP1: SUCCESS (2.348s)
[188.689109] Starting dynamic subtest: C-eDP1
[191.029485] Dynamic subtest C-eDP1: SUCCESS (2.374s)
[191.032803] Subtest basic-flip-vs-modeset: SUCCESS (7.580s)
[192.003616] [106/161] (826s left) kms_flip (basic-flip-vs-wf_vblank)
[192.172629] Starting subtest: basic-flip-vs-wf_vblank
[192.178659] Starting dynamic subtest: A-eDP1
[194.481405] Dynamic subtest A-eDP1: SUCCESS (2.303s)
[194.512431] Starting dynamic subtest: B-eDP1
[196.813225] Dynamic subtest B-eDP1: SUCCESS (2.330s)
[196.844717] Starting dynamic subtest: C-eDP1
[199.152776] Dynamic subtest C-eDP1: SUCCESS (2.337s)
[199.159896] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.984s)
[200.545292] [107/161] (818s left) kms_flip (basic-plain-flip)
[200.714806] Starting subtest: basic-plain-flip
[200.720551] Starting dynamic subtest: A-eDP1
[202.727871] Dynamic subtest A-eDP1: SUCCESS (2.008s)
[202.763042] Starting dynamic subtest: B-eDP1
[204.748749] Dynamic subtest B-eDP1: SUCCESS (2.018s)
[204.778522] Starting dynamic subtest: C-eDP1
[206.776706] Dynamic subtest C-eDP1: SUCCESS (2.023s)
[206.781073] Subtest basic-plain-flip: SUCCESS (6.064s)
[208.135701] [108/161] (810s left) kms_force_connector_basic (force-connector-state)
[208.278620] Starting subtest: force-connector-state
[209.198820] Subtest force-connector-state: SUCCESS (0.922s)
[210.178634] [109/161] (808s left) kms_force_connector_basic (force-edid)
[210.318154] Starting subtest: force-edid
[210.591535] Subtest force-edid: SUCCESS (0.276s)
[210.897539] [110/161] (808s left) kms_force_connector_basic (force-load-detect)
[211.037912] Starting subtest: force-load-detect
[211.043820] Subtest force-load-detect: SKIP (0.000s)
[211.272670] [111/161] (808s left) kms_force_connector_basic (prune-stale-modes)
[211.414151] Starting subtest: prune-stale-modes
[211.746820] Subtest prune-stale-modes: SUCCESS (0.335s)
[212.048782] [112/161] (807s left) kms_frontbuffer_tracking (basic)
[212.231614] Starting subtest: basic
[216.386451] Subtest basic: SUCCESS (4.156s)
[216.633363] [113/161] (802s left) kms_hdmi_inject (inject-audio)
[217.093683] Starting subtest: inject-audio
[217.563183] Subtest inject-audio: SUCCESS (0.472s)
[218.139125] [114/161] (801s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[218.310035] Starting subtest: compare-crc-sanitycheck-xr24
[218.312789] Starting dynamic subtest: pipe-A-eDP-1
[219.114237] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.800s)
[219.148907] Starting dynamic subtest: pipe-B-eDP-1
[220.499560] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.379s)
[220.547989] Starting dynamic subtest: pipe-C-eDP-1
[221.853320] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.345s)
[221.855964] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.543s)
[222.798827] [115/161] (797s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[222.968888] Starting subtest: compare-crc-sanitycheck-nv12
[222.971582] Starting dynamic subtest: pipe-A-eDP-1
[224.135601] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.162s)
[224.175275] Starting dynamic subtest: pipe-B-eDP-1
[225.581150] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.439s)
[225.630275] Starting dynamic subtest: pipe-C-eDP-1
[226.944557] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.351s)
[226.948657] Subtest compare-crc-sanitycheck-nv12: SUCCESS (3.973s)
[227.853111] [116/161] (792s left) kms_pipe_crc_basic (hang-read-crc)
[228.024922] Starting subtest: hang-read-crc
[228.027616] Starting dynamic subtest: pipe-A-eDP-1
[230.603114] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.574s)
[230.632723] Starting dynamic subtest: pipe-B-eDP-1
[233.678920] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.071s)
[233.728564] Starting dynamic subtest: pipe-C-eDP-1
[236.625703] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.940s)
[236.628906] Subtest hang-read-crc: SUCCESS (8.604s)
[237.530225] [117/161] (782s left) kms_pipe_crc_basic (nonblocking-crc)
[237.702411] Starting subtest: nonblocking-crc
[237.705181] Starting dynamic subtest: pipe-A-eDP-1
[238.716546] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.009s)
[238.764498] Starting dynamic subtest: pipe-B-eDP-1
[240.290168] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.566s)
[240.335761] Starting dynamic subtest: pipe-C-eDP-1
[241.848256] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.552s)
[241.851409] Subtest nonblocking-crc: SUCCESS (4.149s)
[242.792957] [118/161] (777s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[242.966101] Starting subtest: nonblocking-crc-frame-sequence
[242.968754] Starting dynamic subtest: pipe-A-eDP-1
[243.988580] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.019s)
[244.041168] Starting dynamic subtest: pipe-B-eDP-1
[245.564610] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.568s)
[245.605686] Starting dynamic subtest: pipe-C-eDP-1
[247.111211] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.535s)
[247.114501] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.144s)
[248.056078] [119/161] (772s left) kms_pipe_crc_basic (read-crc)
[248.228571] Starting subtest: read-crc
[248.231323] Starting dynamic subtest: pipe-A-eDP-1
[249.197990] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.967s)
[249.249438] Starting dynamic subtest: pipe-B-eDP-1
[250.737864] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.530s)
[250.790490] Starting dynamic subtest: pipe-C-eDP-1
[252.337903] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.589s)
[252.341226] Subtest read-crc: SUCCESS (4.109s)
[253.311748] [120/161] (767s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[253.486989] Starting subtest: read-crc-frame-sequence
[253.489645] Starting dynamic subtest: pipe-A-eDP-1
[254.446568] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.955s)
[254.498254] Starting dynamic subtest: pipe-B-eDP-1
[256.000907] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.545s)
[256.044377] Starting dynamic subtest: pipe-C-eDP-1
[257.566305] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.555s)
[257.569481] Subtest read-crc-frame-sequence: SUCCESS (4.079s)
[258.468590] [121/161] (761s left) kms_pm_backlight (basic-brightness)
[258.641039] Starting subtest: basic-brightness
[258.764177] Starting dynamic subtest: eDP-1
[259.334921] Dynamic subtest eDP-1: SUCCESS (0.568s)
[259.337930] Subtest basic-brightness: SUCCESS (0.694s)
[260.253914] [122/161] (760s left) kms_pm_rpm (basic-pci-d3-state)
[262.099475] Starting subtest: basic-pci-d3-state
[262.749644] Subtest basic-pci-d3-state: SUCCESS (0.654s)
[262.992158] [123/161] (757s left) kms_pm_rpm (basic-rte)
[263.104498] Starting subtest: basic-rte
[265.486760] Subtest basic-rte: SUCCESS (2.385s)
[266.808965] [124/161] (753s left) kms_psr (psr-primary-page-flip)
[266.985819] Starting subtest: psr-primary-page-flip
[266.988106] Starting dynamic subtest: eDP-1
[271.017254] Dynamic subtest eDP-1: SUCCESS (4.025s)
[271.020323] Subtest psr-primary-page-flip: SUCCESS (4.030s)
[271.933732] [125/161] (748s left) kms_psr (psr-cursor-plane-move)
[272.106794] Starting subtest: psr-cursor-plane-move
[272.109638] Starting dynamic subtest: eDP-1
[276.047515] Dynamic subtest eDP-1: SUCCESS (3.930s)
[276.051145] Subtest psr-cursor-plane-move: SUCCESS (3.936s)
[276.981369] [126/161] (744s left) kms_psr (psr-sprite-plane-onoff)
[277.163101] Starting subtest: psr-sprite-plane-onoff
[277.165791] Starting dynamic subtest: eDP-1
[281.183695] Dynamic subtest eDP-1: SUCCESS (4.020s)
[281.186576] Subtest psr-sprite-plane-onoff: SUCCESS (4.025s)
[282.142818] [127/161] (738s left) kms_psr (psr-primary-mmap-gtt)
[282.315146] Starting subtest: psr-primary-mmap-gtt
[282.317866] Starting dynamic subtest: eDP-1
[286.242707] Dynamic subtest eDP-1: SUCCESS (3.925s)
[286.245441] Subtest psr-primary-mmap-gtt: SUCCESS (3.929s)
[287.191476] [128/161] (734s left) kms_setmode (basic-clone-single-crtc)
[287.307250] Starting subtest: basic-clone-single-crtc
[287.314749] Subtest basic-clone-single-crtc: SKIP (0.000s)
[287.453610] [129/161] (733s left) i915_pm_rps (basic-api)
[287.580036] Starting subtest: basic-api
[287.587104] Subtest basic-api: SUCCESS (0.007s)
[287.754817] [130/161] (733s left) prime_self_import (basic-llseek-bad)
[287.866401] Starting subtest: basic-llseek-bad
[287.872043] Subtest basic-llseek-bad: SUCCESS (0.005s)
[288.041045] [131/161] (733s left) prime_self_import (basic-llseek-size)
[288.146988] Starting subtest: basic-llseek-size
[288.156278] Subtest basic-llseek-size: SUCCESS (0.008s)
[288.323976] [132/161] (733s left) prime_self_import (basic-with_fd_dup)
[288.433576] Starting subtest: basic-with_fd_dup
[288.443388] Subtest basic-with_fd_dup: SUCCESS (0.008s)
[288.623147] [133/161] (733s left) prime_self_import (basic-with_one_bo)
[288.730395] Starting subtest: basic-with_one_bo
[288.739659] Subtest basic-with_one_bo: SUCCESS (0.008s)
[288.888098] [134/161] (732s left) prime_self_import (basic-with_one_bo_two_files)
[288.998306] Starting subtest: basic-with_one_bo_two_files
[289.003113] Subtest basic-with_one_bo_two_files: SUCCESS (0.007s)
[289.169378] [135/161] (732s left) prime_self_import (basic-with_two_bos)
[289.279556] Starting subtest: basic-with_two_bos
[289.293218] Subtest basic-with_two_bos: SUCCESS (0.013s)
[289.486821] [136/161] (732s left) prime_vgem (basic-fence-flip)
[289.630212] Starting subtest: basic-fence-flip
[290.230336] Subtest basic-fence-flip: SUCCESS (0.600s)
[290.408806] [137/161] (731s left) prime_vgem (basic-fence-mmap)
[290.546837] Starting subtest: basic-fence-mmap
[290.608657] Subtest basic-fence-mmap: SUCCESS (0.059s)
[290.774220] [138/161] (731s left) prime_vgem (basic-fence-read)
[290.921764] Starting subtest: basic-fence-read
[291.030511] Subtest basic-fence-read: SUCCESS (0.108s)
[291.189908] [139/161] (731s left) prime_vgem (basic-gtt)
[291.329687] Starting subtest: basic-gtt
[291.358870] Subtest basic-gtt: SUCCESS (0.029s)
[291.531202] [140/161] (730s left) prime_vgem (basic-read)
[291.673988] Starting subtest: basic-read
[291.725575] Subtest basic-read: SUCCESS (0.051s)
[291.889432] [141/161] (730s left) prime_vgem (basic-write)
[292.040162] Starting subtest: basic-write
[292.108243] Subtest basic-write: SUCCESS (0.070s)
[292.274247] [142/161] (730s left) vgem_basic (setversion)
[292.399086] Starting subtest: setversion
[292.403803] Subtest setversion: SUCCESS (0.000s)
[292.541216] [143/161] (730s left) vgem_basic (create)
[292.666277] Starting subtest: create
[292.668792] Subtest create: SUCCESS (0.001s)
[292.807644] [144/161] (730s left) vgem_basic (debugfs)
[292.932343] Starting subtest: debugfs
[292.934720] Subtest debugfs: SUCCESS (0.001s)
[293.072179] [145/161] (729s left) vgem_basic (dmabuf-export)
[293.199186] Starting subtest: dmabuf-export
[293.204184] Subtest dmabuf-export: SUCCESS (0.005s)
[293.376285] [146/161] (729s left) vgem_basic (dmabuf-fence)
[293.503736] Starting subtest: dmabuf-fence
[293.506160] Subtest dmabuf-fence: SUCCESS (0.002s)
[293.639690] [147/161] (729s left) vgem_basic (dmabuf-fence-before)
[293.765931] Starting subtest: dmabuf-fence-before
[293.768530] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[293.906845] [148/161] (729s left) vgem_basic (dmabuf-mmap)
[294.032477] Starting subtest: dmabuf-mmap
[294.063933] Subtest dmabuf-mmap: SUCCESS (0.032s)
[294.206649] [149/161] (729s left) vgem_basic (mmap)
[294.332919] Starting subtest: mmap
[294.353927] Subtest mmap: SUCCESS (0.022s)
[294.504945] [150/161] (729s left) vgem_basic (second-client)
[294.632528] Starting subtest: second-client
[294.667612] Subtest second-client: SUCCESS (0.033s)
[294.809179] [151/161] (728s left) vgem_basic (sysfs)
[294.932987] Starting subtest: sysfs
[294.935480] Subtest sysfs: SUCCESS (0.001s)
[295.071803] [152/161] (728s left) core_hotunplug (unbind-rebind)
[295.284936] Starting subtest: unbind-rebind
[300.712459] Subtest unbind-rebind: SUCCESS (5.429s)
[300.824649] [153/161] (723s left) vgem_basic (unload)
[300.936903] Starting subtest: unload
[330.141061] Subtest unload: SUCCESS (29.202s)
[330.386727] [154/161] (693s left) i915_module_load (reload)
[330.497396] Starting subtest: reload
[335.792959] Subtest reload: SUCCESS (5.293s)
[335.946526] [155/161] (688s left) gem_lmem_swapping (basic)
[336.094593] Subtest basic: SKIP (0.000s)
[336.242997] [156/161] (688s left) gem_lmem_swapping (parallel-random-engines)
[336.368056] Subtest parallel-random-engines: SKIP (0.000s)
[336.498257] [157/161] (687s left) gem_lmem_swapping (random-engines)
[336.624253] Subtest random-engines: SKIP (0.000s)
[336.751862] [158/161] (687s left) gem_lmem_swapping (verify-random)
[336.874644] Subtest verify-random: SKIP (0.000s)
[336.996883] [159/161] (687s left) i915_pm_rpm (module-reload)
[349.583060] Starting subtest: module-reload
[383.806860] Subtest module-reload: SUCCESS (34.223s)
[383.883430] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[383.886254] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[383.891584] [160/161] (640s left) i915_selftest (live)
[384.019874] Starting subtest: live
[384.022488] Starting dynamic subtest: sanitycheck
[387.657360] Dynamic subtest sanitycheck: SUCCESS (3.641s)
[387.701450] Starting dynamic subtest: uncore
[391.277713] Dynamic subtest uncore: SUCCESS (3.615s)
[391.309949] Starting dynamic subtest: workarounds
[395.256571] Dynamic subtest workarounds: SUCCESS (3.973s)
[395.289673] Starting dynamic subtest: gt_engines
[399.320402] Dynamic subtest gt_engines: SUCCESS (4.058s)
[399.352932] Starting dynamic subtest: gt_timelines
[415.549708] Dynamic subtest gt_timelines: SUCCESS (16.224s)
[415.586846] Starting dynamic subtest: gt_contexts
[419.256939] Dynamic subtest gt_contexts: SUCCESS (3.702s)
[419.299416] Starting dynamic subtest: gt_lrc
[425.192743] Dynamic subtest gt_lrc: SUCCESS (5.931s)
[425.234702] Starting dynamic subtest: gt_mocs
[429.024543] Dynamic subtest gt_mocs: SUCCESS (3.826s)
[429.071686] Starting dynamic subtest: gt_pm
[439.201384] Dynamic subtest gt_pm: SUCCESS (10.171s)
[439.234150] Starting dynamic subtest: gt_heartbeat
[442.972367] Dynamic subtest gt_heartbeat: SUCCESS (3.766s)
[443.004824] Starting dynamic subtest: gt_tlb
[447.679594] Dynamic subtest gt_tlb: SUCCESS (4.702s)
[447.719755] Starting dynamic subtest: requests
[457.323105] Dynamic subtest requests: SUCCESS (9.640s)
[457.356276] Starting dynamic subtest: migrate
[463.839603] Dynamic subtest migrate: SUCCESS (6.511s)
[463.872042] Starting dynamic subtest: active
[467.445341] Dynamic subtest active: SUCCESS (3.601s)
[467.478355] Starting dynamic subtest: objects
[472.271447] Dynamic subtest objects: SUCCESS (4.820s)
[472.304472] Starting dynamic subtest: mman
[480.767574] Dynamic subtest mman: SUCCESS (8.491s)
[480.795067] Starting dynamic subtest: dmabuf
[484.394513] Dynamic subtest dmabuf: SUCCESS (3.622s)
[484.429319] Starting dynamic subtest: vma
[488.073337] Dynamic subtest vma: SUCCESS (3.674s)
[488.106412] Starting dynamic subtest: coherency
[493.916249] Dynamic subtest coherency: SUCCESS (5.838s)
[493.949700] Starting dynamic subtest: gtt
[505.658306] Dynamic subtest gtt: SUCCESS (11.736s)
[505.691055] Starting dynamic subtest: gem
[509.502383] Dynamic subtest gem: SUCCESS (3.839s)
[509.532888] Starting dynamic subtest: evict
[515.139466] Dynamic subtest evict: SUCCESS (5.632s)
[515.167622] Starting dynamic subtest: hugepages
[524.937950] Dynamic subtest hugepages: SUCCESS (9.793s)
[524.970308] Starting dynamic subtest: gem_contexts
[542.726565] Dynamic subtest gem_contexts: SUCCESS (17.783s)
[542.749970] Starting dynamic subtest: client
[546.480671] Dynamic subtest client: SUCCESS (3.749s)
[546.514363] Starting dynamic subtest: gem_migrate
[550.105679] Dynamic subtest gem_migrate: SUCCESS (3.620s)
[550.134906] Starting dynamic subtest: reset
[559.987882] Dynamic subtest reset: SUCCESS (9.876s)
[560.031032] Starting dynamic subtest: memory_region
[563.606357] Dynamic subtest memory_region: SUCCESS (3.613s)
[563.638762] Starting dynamic subtest: hangcheck
[590.139972] Dynamic subtest hangcheck: SUCCESS (26.527s)
[590.172789] Starting dynamic subtest: execlists
[603.362295] Dynamic subtest execlists: SUCCESS (13.216s)
[603.394327] Starting dynamic subtest: ring_submission
[607.036537] Dynamic subtest ring_submission: SUCCESS (3.669s)
[607.069514] Starting dynamic subtest: perf
[610.880398] Dynamic subtest perf: SUCCESS (3.838s)
[610.913398] Starting dynamic subtest: slpc
[614.512417] Dynamic subtest slpc: SUCCESS (3.627s)
[614.545524] Starting dynamic subtest: guc
[618.086432] Dynamic subtest guc: SUCCESS (3.569s)
[618.118840] Starting dynamic subtest: guc_multi_lrc
[621.743381] Dynamic subtest guc_multi_lrc: SUCCESS (3.652s)
[621.776732] Starting dynamic subtest: guc_hang
[625.335297] Dynamic subtest guc_hang: SUCCESS (3.586s)
[625.368123] Starting dynamic subtest: late_gt_pm
[629.015342] Dynamic subtest late_gt_pm: SUCCESS (3.675s)
[629.018681] Subtest live: SUCCESS (244.996s)
[629.105971] [161/161] (395s left) dmabuf (all-tests)
[629.227948] Starting subtest: all-tests
[629.231241] Starting dynamic subtest: sanitycheck
[629.321272] Dynamic subtest sanitycheck: SUCCESS (0.096s)
[629.354903] Starting dynamic subtest: dma_fence
[629.597765] Dynamic subtest dma_fence: SUCCESS (0.271s)
[629.629214] Starting dynamic subtest: dma_fence_chain
[644.684414] Dynamic subtest dma_fence_chain: SUCCESS (15.080s)
[644.715576] Starting dynamic subtest: dma_fence_unwrap
[644.787238] Dynamic subtest dma_fence_unwrap: SUCCESS (0.099s)
[644.818761] Starting dynamic subtest: dma_resv
[644.875336] Dynamic subtest dma_resv: SUCCESS (0.083s)
[644.878706] Subtest all-tests: SUCCESS (15.654s)
[644.963526] Closing watchdogs
Done.