[38.095441] Initializing watchdogs
[38.095617]   /dev/watchdog0
[38.119119] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:5926 Intel Kabylake (Gen9) Iris Plus Graphics 640
[38.124986] [001/161] (960s left) i915_module_load (load)
[38.200518] Starting subtest: load
[40.611894] Subtest load: SUCCESS (2.410s)
[40.701727] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[40.705156] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[40.712136] [002/161] (958s left) core_auth (basic-auth)
[40.882380] Starting subtest: basic-auth
[40.883430] Subtest basic-auth: SUCCESS (0.004s)
[40.948543] [003/161] (957s left) debugfs_test (read_all_entries)
[41.035493] Starting subtest: read_all_entries
[41.079846] Subtest read_all_entries: SUCCESS (0.045s)
[41.372501] [004/161] (957s left) debugfs_test (basic-hwmon)
[41.449096] Starting subtest: basic-hwmon
[41.451321] Subtest basic-hwmon: SKIP (0.000s)
[41.733269] [005/161] (957s left) debugfs_test (sysfs)
[41.807197] Starting subtest: sysfs
[41.876187] Subtest sysfs: SUCCESS (0.069s)
[42.152648] [006/161] (956s left) fbdev (eof)
[45.822359] Subtest eof: SKIP (0.000s)
[45.875434] [FACT fbdev (eof)] new: kernel.kmod_is_loaded.amdgpu: true
[45.877039] [FACT fbdev (eof)] new: kernel.kmod_is_loaded.xe: true
[45.879460] [007/161] (953s left) fbdev (info)
[45.961498] Subtest info: SKIP (0.000s)
[46.006787] [008/161] (953s left) fbdev (nullptr)
[46.086059] Subtest nullptr: SKIP (0.000s)
[46.130354] [009/161] (953s left) fbdev (read)
[46.208668] Subtest read: SKIP (0.000s)
[46.253680] [010/161] (953s left) fbdev (write)
[46.332712] Subtest write: SKIP (0.000s)
[46.378481] [011/161] (952s left) gem_basic (bad-close)
[46.445826] Starting subtest: bad-close
[46.534076] Subtest bad-close: SUCCESS (0.000s)
[46.602305] [012/161] (952s left) gem_basic (create-close)
[46.715524] Starting subtest: create-close
[46.717761] Subtest create-close: SUCCESS (0.000s)
[46.799589] [013/161] (952s left) gem_basic (create-fd-close)
[46.869196] Starting subtest: create-fd-close
[46.871645] Subtest create-fd-close: SUCCESS (0.000s)
[46.943044] [014/161] (952s left) gem_busy (busy@all-engines)
[47.029824] Starting subtest: busy
[47.031074] Starting dynamic subtest: all-engines
[47.115969] Dynamic subtest all-engines: SUCCESS (0.086s)
[47.117127] Subtest busy: SUCCESS (0.086s)
[47.539952] [015/161] (952s left) gem_close_race (basic-process)
[47.634559] Starting subtest: basic-process
[47.698975] Subtest basic-process: SUCCESS (0.065s)
[47.904442] [016/161] (951s left) gem_close_race (basic-threads)
[47.993674] Starting subtest: basic-threads
[49.181393] Subtest basic-threads: SUCCESS (1.195s)
[49.393009] [017/161] (950s left) gem_ctx_create (basic)
[49.523385] Starting subtest: basic
[49.524363] Subtest basic: SUCCESS (0.000s)
[49.697930] [018/161] (950s left) gem_ctx_create (basic-files)
[49.783395] Starting subtest: basic-files
[51.805190] Subtest basic-files: SUCCESS (2.073s)
[52.052438] [019/161] (947s left) gem_ctx_exec (basic)
[52.122466] Starting subtest: basic
[52.128985] Subtest basic: SUCCESS (0.007s)
[52.208078] [020/161] (947s left) gem_exec_basic (basic)
[52.289231] Starting subtest: basic
[52.290660] Starting dynamic subtest: rcs0-smem
[52.293079] Dynamic subtest rcs0-smem: SUCCESS (0.004s)
[52.302096] Starting dynamic subtest: bcs0-smem
[52.303273] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[52.311041] Starting dynamic subtest: vcs0-smem
[52.312313] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[52.320037] Starting dynamic subtest: vcs1-smem
[52.321325] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[52.329048] Starting dynamic subtest: vecs0-smem
[52.330330] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[52.331591] Subtest basic: SUCCESS (0.010s)
[52.532084] [021/161] (947s left) gem_exec_create (basic)
[52.620369] Starting subtest: basic
[52.622107] Starting dynamic subtest: smem
[54.701413] Dynamic subtest smem: SUCCESS (2.081s)
[54.703313] Subtest basic: SUCCESS (2.082s)
[54.846542] [022/161] (945s left) gem_exec_fence (basic-busy)
[55.087885] Starting subtest: basic-busy
[55.089094] Starting dynamic subtest: rcs0
[55.117428] Dynamic subtest rcs0: SUCCESS (0.030s)
[55.125909] Starting dynamic subtest: bcs0
[55.144409] Dynamic subtest bcs0: SUCCESS (0.027s)
[55.152834] Starting dynamic subtest: vcs0
[55.169223] Dynamic subtest vcs0: SUCCESS (0.024s)
[55.177496] Starting dynamic subtest: vcs1
[55.189728] Dynamic subtest vcs1: SUCCESS (0.021s)
[55.197918] Starting dynamic subtest: vecs0
[55.213415] Dynamic subtest vecs0: SUCCESS (0.024s)
[55.214656] Subtest basic-busy: SUCCESS (0.128s)
[55.949560] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[55.952360] [023/161] (944s left) gem_exec_fence (basic-wait)
[56.201689] Starting subtest: basic-wait
[56.203428] Starting dynamic subtest: rcs0
[56.229393] Dynamic subtest rcs0: SUCCESS (0.028s)
[56.238544] Starting dynamic subtest: bcs0
[56.256050] Dynamic subtest bcs0: SUCCESS (0.026s)
[56.266054] Starting dynamic subtest: vcs0
[56.278495] Dynamic subtest vcs0: SUCCESS (0.023s)
[56.287949] Starting dynamic subtest: vcs1
[56.301369] Dynamic subtest vcs1: SUCCESS (0.023s)
[56.310478] Starting dynamic subtest: vecs0
[56.325516] Dynamic subtest vecs0: SUCCESS (0.024s)
[56.326794] Subtest basic-wait: SUCCESS (0.126s)
[56.980783] [024/161] (943s left) gem_exec_fence (basic-await)
[57.226830] Starting subtest: basic-await
[57.228177] Starting dynamic subtest: rcs0
[57.406732] Dynamic subtest rcs0: SUCCESS (0.125s)
[57.416008] Starting dynamic subtest: bcs0
[57.474601] Dynamic subtest bcs0: SUCCESS (0.124s)
[57.488894] Starting dynamic subtest: vcs0
[57.658516] Dynamic subtest vcs0: SUCCESS (0.126s)
[57.668429] Starting dynamic subtest: vcs1
[57.715027] Dynamic subtest vcs1: SUCCESS (0.116s)
[57.727801] Starting dynamic subtest: vecs0
[57.896920] Dynamic subtest vecs0: SUCCESS (0.125s)
[57.899986] Subtest basic-await: SUCCESS (0.619s)
[58.537475] [025/161] (941s left) gem_exec_fence (nb-await)
[58.776314] Starting subtest: nb-await
[58.777738] Starting dynamic subtest: rcs0
[58.844447] Dynamic subtest rcs0: SUCCESS (0.068s)
[58.862039] Starting dynamic subtest: bcs0
[58.922523] Dynamic subtest bcs0: SUCCESS (0.075s)
[58.946690] Starting dynamic subtest: vcs0
[59.002771] Dynamic subtest vcs0: SUCCESS (0.082s)
[59.027796] Starting dynamic subtest: vcs1
[59.088149] Dynamic subtest vcs1: SUCCESS (0.085s)
[59.113596] Starting dynamic subtest: vecs0
[59.173148] Dynamic subtest vecs0: SUCCESS (0.085s)
[59.175292] Subtest nb-await: SUCCESS (0.400s)
[59.882955] [026/161] (940s left) gem_exec_gttfill (basic)
[59.973249] Starting subtest: basic
[70.278579] Subtest basic: SUCCESS (10.291s)
[70.395535] [027/161] (929s left) gem_exec_parallel (engines)
[70.758663] Starting subtest: engines
[70.759639] Starting dynamic subtest: basic
[73.207514] Dynamic subtest basic: SUCCESS (2.412s)
[73.217072] Starting dynamic subtest: contexts
[80.941374] Dynamic subtest contexts: SUCCESS (7.768s)
[80.953891] Starting dynamic subtest: fds
[88.201472] Dynamic subtest fds: SUCCESS (7.246s)
[88.214740] Starting dynamic subtest: userptr
[91.462458] Dynamic subtest userptr: SUCCESS (3.235s)
[91.464664] Subtest engines: SUCCESS (20.663s)
[91.607223] [028/161] (908s left) gem_exec_store (basic)
[91.699851] Starting subtest: basic
[91.763831] Subtest basic: SUCCESS (0.064s)
[91.961883] [029/161] (908s left) gem_flink_basic (bad-flink)
[92.031252] Starting subtest: bad-flink
[92.032331] Subtest bad-flink: SUCCESS (0.000s)
[92.088552] [030/161] (908s left) gem_flink_basic (bad-open)
[92.157481] Starting subtest: bad-open
[92.158649] Subtest bad-open: SUCCESS (0.000s)
[92.210767] [031/161] (908s left) gem_flink_basic (basic)
[92.417611] Starting subtest: basic
[92.420027] Subtest basic: SUCCESS (0.000s)
[92.502673] [032/161] (907s left) gem_flink_basic (double-flink)
[92.569295] Starting subtest: double-flink
[92.570356] Subtest double-flink: SUCCESS (0.000s)
[92.641300] [033/161] (907s left) gem_flink_basic (flink-lifetime)
[92.708149] Starting subtest: flink-lifetime
[92.709662] Subtest flink-lifetime: SUCCESS (0.002s)
[92.782799] [034/161] (907s left) gem_huc_copy (huc-copy)
[92.858914] Starting subtest: huc-copy
[92.860913] Subtest huc-copy: SKIP (0.000s)
[92.943907] [035/161] (907s left) gem_linear_blits (basic)
[93.160525] Starting subtest: basic
[93.161973] Subtest basic: SUCCESS (0.012s)
[93.345548] [036/161] (907s left) gem_mmap (basic)
[93.520321] Starting subtest: basic
[93.524731] Subtest basic: SUCCESS (0.001s)
[93.626266] [037/161] (907s left) gem_mmap_gtt (basic)
[93.693454] Starting subtest: basic
[93.694456] Subtest basic: SUCCESS (0.001s)
[93.749767] [038/161] (907s left) gem_render_linear_blits (basic)
[93.825750] Starting subtest: basic
[93.859293] Subtest basic: SUCCESS (0.033s)
[93.932861] [039/161] (906s left) gem_render_tiled_blits (basic)
[94.008247] Starting subtest: basic
[94.055055] Subtest basic: SUCCESS (0.046s)
[94.121537] [040/161] (906s left) gem_ringfill (basic-all)
[94.417187] Starting subtest: basic-all
[95.659677] Subtest basic-all: SUCCESS (1.188s)
[95.712261] [041/161] (905s left) gem_softpin (allocator-basic)
[95.791419] Starting subtest: allocator-basic
[95.993495] Subtest allocator-basic: SUCCESS (0.145s)
[96.043254] [042/161] (905s left) gem_softpin (allocator-basic-reserve)
[96.127887] Starting subtest: allocator-basic-reserve
[96.330152] Subtest allocator-basic-reserve: SUCCESS (0.145s)
[96.381356] [043/161] (904s left) gem_softpin (safe-alignment)
[96.461390] Starting subtest: safe-alignment
[96.480249] Subtest safe-alignment: SUCCESS (0.019s)
[96.576997] [044/161] (904s left) gem_sync (basic-all)
[96.670157] Starting subtest: basic-all
[98.960814] Subtest basic-all: SUCCESS (2.253s)
[99.148787] [045/161] (902s left) gem_sync (basic-each)
[99.240210] Starting subtest: basic-each
[101.538777] Subtest basic-each: SUCCESS (2.298s)
[101.799550] [046/161] (899s left) gem_tiled_blits (basic)
[101.942966] Starting subtest: basic
[101.967547] Subtest basic: SUCCESS (0.025s)
[102.114908] [047/161] (899s left) gem_tiled_fence_blits (basic)
[102.628727] Starting subtest: basic
[102.630370] Subtest basic: SUCCESS (0.014s)
[102.739661] [048/161] (898s left) gem_tiled_pread_basic
[103.051769] [049/161] (898s left) gem_wait (busy@all-engines)
[103.150207] Starting subtest: busy
[103.151176] Starting dynamic subtest: all-engines
[103.721419] Dynamic subtest all-engines: SUCCESS (0.570s)
[103.723267] Subtest busy: SUCCESS (0.571s)
[104.007582] [050/161] (897s left) gem_wait (wait@all-engines)
[104.104578] Starting subtest: wait
[104.105757] Starting dynamic subtest: all-engines
[105.196107] Dynamic subtest all-engines: SUCCESS (1.048s)
[105.198381] Subtest wait: SUCCESS (1.049s)
[105.391243] [051/161] (896s left) i915_getparams_basic (basic-eu-total)
[105.463829] Starting subtest: basic-eu-total
[105.465980] Subtest basic-eu-total: SUCCESS (0.000s)
[105.519883] [052/161] (896s left) i915_getparams_basic (basic-subslice-total)
[105.587398] Starting subtest: basic-subslice-total
[105.589627] Subtest basic-subslice-total: SUCCESS (0.000s)
[105.645963] [053/161] (896s left) i915_hangman (error-state-basic)
[105.731789] Starting subtest: error-state-basic
[105.741539] Subtest error-state-basic: SUCCESS (0.008s)
[105.906132] [054/161] (896s left) i915_pciid
[106.076829] [055/161] (895s left) kms_addfb_basic (addfb25-4-tiled)
[106.348318] Starting subtest: addfb25-4-tiled
[106.350603] Subtest addfb25-4-tiled: SUCCESS (0.001s)
[106.434242] [056/161] (895s left) kms_addfb_basic (addfb25-bad-modifier)
[106.693151] Starting subtest: addfb25-bad-modifier
[106.694827] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[106.791201] [057/161] (895s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[107.059982] Starting subtest: addfb25-framebuffer-vs-set-tiling
[107.062844] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[107.160227] [058/161] (895s left) kms_addfb_basic (addfb25-modifier-no-flag)
[107.430498] Starting subtest: addfb25-modifier-no-flag
[107.432403] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[107.543985] [059/161] (894s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[107.813428] Starting subtest: addfb25-x-tiled-legacy
[107.816246] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[107.933683] [060/161] (894s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[108.200885] Starting subtest: addfb25-x-tiled-mismatch-legacy
[108.203249] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[108.324131] [061/161] (894s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[108.580953] Starting subtest: addfb25-yf-tiled-legacy
[108.583348] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[108.679144] [062/161] (893s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[108.942295] Starting subtest: addfb25-y-tiled-legacy
[108.944552] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[109.031245] [063/161] (893s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[109.294048] Starting subtest: addfb25-y-tiled-small-legacy
[109.295934] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s)
[109.405041] [064/161] (893s left) kms_addfb_basic (bad-pitch-0)
[109.473760] Starting subtest: bad-pitch-0
[109.474819] Subtest bad-pitch-0: SUCCESS (0.000s)
[109.781171] [065/161] (892s left) kms_addfb_basic (bad-pitch-1024)
[109.848416] Starting subtest: bad-pitch-1024
[109.849419] Subtest bad-pitch-1024: SUCCESS (0.000s)
[110.164839] [066/161] (892s left) kms_addfb_basic (bad-pitch-128)
[110.232989] Starting subtest: bad-pitch-128
[110.233999] Subtest bad-pitch-128: SUCCESS (0.000s)
[110.545833] [067/161] (892s left) kms_addfb_basic (bad-pitch-256)
[110.615491] Starting subtest: bad-pitch-256
[110.616988] Subtest bad-pitch-256: SUCCESS (0.000s)
[110.920640] [068/161] (892s left) kms_addfb_basic (bad-pitch-32)
[110.992429] Starting subtest: bad-pitch-32
[110.993414] Subtest bad-pitch-32: SUCCESS (0.000s)
[111.268480] [069/161] (891s left) kms_addfb_basic (bad-pitch-63)
[111.337523] Starting subtest: bad-pitch-63
[111.338417] Subtest bad-pitch-63: SUCCESS (0.000s)
[111.645111] [070/161] (891s left) kms_addfb_basic (bad-pitch-65536)
[111.711546] Starting subtest: bad-pitch-65536
[111.712904] Subtest bad-pitch-65536: SUCCESS (0.000s)
[112.032962] [071/161] (891s left) kms_addfb_basic (bad-pitch-999)
[112.100202] Starting subtest: bad-pitch-999
[112.101193] Subtest bad-pitch-999: SUCCESS (0.000s)
[112.397646] [072/161] (890s left) kms_addfb_basic (basic)
[112.466389] Starting subtest: basic
[112.467367] Subtest basic: SUCCESS (0.000s)
[112.771162] [073/161] (890s left) kms_addfb_basic (basic-x-tiled-legacy)
[112.840980] Starting subtest: basic-x-tiled-legacy
[112.842141] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[113.148362] [074/161] (890s left) kms_addfb_basic (basic-y-tiled-legacy)
[113.219203] Starting subtest: basic-y-tiled-legacy
[113.220180] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[113.522276] [075/161] (890s left) kms_addfb_basic (bo-too-small)
[113.784409] Starting subtest: bo-too-small
[113.786596] Subtest bo-too-small: SUCCESS (0.001s)
[113.888075] [076/161] (889s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[114.145256] Starting subtest: bo-too-small-due-to-tiling
[114.146540] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[114.252240] [077/161] (889s left) kms_addfb_basic (clobberred-modifier)
[114.320724] Starting subtest: clobberred-modifier
[114.321710] Subtest clobberred-modifier: SUCCESS (0.000s)
[114.649976] [078/161] (889s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[114.733128] Starting subtest: framebuffer-vs-set-tiling
[114.734199] Subtest framebuffer-vs-set-tiling: SUCCESS (0.001s)
[115.136537] [079/161] (888s left) kms_addfb_basic (invalid-get-prop)
[115.232400] Starting subtest: invalid-get-prop
[115.233708] Subtest invalid-get-prop: SUCCESS (0.000s)
[115.535906] [080/161] (888s left) kms_addfb_basic (invalid-get-prop-any)
[115.609482] Starting subtest: invalid-get-prop-any
[115.610642] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[115.898654] [081/161] (888s left) kms_addfb_basic (invalid-set-prop)
[116.013944] Starting subtest: invalid-set-prop
[116.015065] Subtest invalid-set-prop: SUCCESS (0.000s)
[116.326665] [082/161] (887s left) kms_addfb_basic (invalid-set-prop-any)
[116.398094] Starting subtest: invalid-set-prop-any
[116.399053] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[116.699482] [083/161] (887s left) kms_addfb_basic (no-handle)
[116.768788] Starting subtest: no-handle
[116.769809] Subtest no-handle: SUCCESS (0.000s)
[117.093459] [084/161] (887s left) kms_addfb_basic (size-max)
[117.368555] Starting subtest: size-max
[117.370810] Subtest size-max: SUCCESS (0.000s)
[117.490097] [085/161] (886s left) kms_addfb_basic (small-bo)
[117.758184] Starting subtest: small-bo
[117.760218] Subtest small-bo: SUCCESS (0.000s)
[117.885963] [086/161] (886s left) kms_addfb_basic (tile-pitch-mismatch)
[117.968439] Starting subtest: tile-pitch-mismatch
[117.969435] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[118.307408] [087/161] (886s left) kms_addfb_basic (too-high)
[118.560668] Starting subtest: too-high
[118.562117] Subtest too-high: SUCCESS (0.001s)
[118.655972] [088/161] (886s left) kms_addfb_basic (too-wide)
[118.922518] Starting subtest: too-wide
[118.924287] Subtest too-wide: SUCCESS (0.000s)
[119.046829] [089/161] (885s left) kms_addfb_basic (unused-handle)
[119.117025] Starting subtest: unused-handle
[119.118132] Subtest unused-handle: SUCCESS (0.000s)
[119.404538] [090/161] (885s left) kms_addfb_basic (unused-modifier)
[119.474497] Starting subtest: unused-modifier
[119.475375] Subtest unused-modifier: SUCCESS (0.000s)
[119.750616] [091/161] (885s left) kms_addfb_basic (unused-offsets)
[119.819317] Starting subtest: unused-offsets
[119.820287] Subtest unused-offsets: SUCCESS (0.000s)
[120.131547] [092/161] (884s left) kms_addfb_basic (unused-pitches)
[120.198652] Starting subtest: unused-pitches
[120.199809] Subtest unused-pitches: SUCCESS (0.000s)
[120.499692] [093/161] (884s left) kms_busy (basic)
[120.762806] Subtest basic: SKIP (0.000s)
[120.931413] [094/161] (884s left) kms_prop_blob (basic)
[121.015241] Starting subtest: basic
[121.016270] Subtest basic: SUCCESS (0.000s)
[121.073663] [095/161] (884s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[121.344709] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[121.397375] [096/161] (883s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[121.664965] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[121.723419] [097/161] (883s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[121.994786] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[122.064470] [098/161] (883s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[122.329048] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s)
[122.389418] [099/161] (883s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[122.664977] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s)
[122.716666] [100/161] (882s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[122.994460] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[123.048996] [101/161] (882s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[123.317157] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s)
[123.369268] [102/161] (882s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[123.639034] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s)
[123.692099] [103/161] (882s left) kms_dsc (dsc-basic)
[123.955059] Subtest dsc-basic: SKIP (0.000s)
[124.014156] [104/161] (881s left) kms_flip (basic-flip-vs-dpms)
[124.275857] Starting subtest: basic-flip-vs-dpms
[124.278241] Subtest basic-flip-vs-dpms: SKIP (0.002s)
[124.361420] [105/161] (881s left) kms_flip (basic-flip-vs-modeset)
[124.623990] Starting subtest: basic-flip-vs-modeset
[124.625895] Subtest basic-flip-vs-modeset: SKIP (0.002s)
[124.703373] [106/161] (881s left) kms_flip (basic-flip-vs-wf_vblank)
[124.967276] Starting subtest: basic-flip-vs-wf_vblank
[124.971191] Subtest basic-flip-vs-wf_vblank: SKIP (0.002s)
[125.048375] [107/161] (881s left) kms_flip (basic-plain-flip)
[125.305195] Starting subtest: basic-plain-flip
[125.307283] Subtest basic-plain-flip: SKIP (0.002s)
[125.384857] [108/161] (880s left) kms_force_connector_basic (force-connector-state)
[125.734054] Starting subtest: force-connector-state
[126.422653] Subtest force-connector-state: SUCCESS (0.686s)
[126.971929] [109/161] (879s left) kms_force_connector_basic (force-edid)
[127.315068] Starting subtest: force-edid
[127.858924] Subtest force-edid: SUCCESS (0.544s)
[128.324581] [110/161] (877s left) kms_force_connector_basic (force-load-detect)
[128.678051] Starting subtest: force-load-detect
[128.680812] Subtest force-load-detect: SKIP (0.000s)
[129.019921] [111/161] (877s left) kms_force_connector_basic (prune-stale-modes)
[129.375206] Starting subtest: prune-stale-modes
[129.997066] Subtest prune-stale-modes: SUCCESS (0.622s)
[130.450946] [112/161] (875s left) kms_frontbuffer_tracking (basic)
[130.709827] Subtest basic: SKIP (0.000s)
[130.794566] [113/161] (875s left) kms_hdmi_inject (inject-audio)
[130.871405] Starting subtest: inject-audio
[131.436179] Subtest inject-audio: SUCCESS (0.562s)
[131.720086] [114/161] (874s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[131.976620] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s)
[132.057462] [115/161] (874s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[132.313087] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s)
[132.375221] [116/161] (874s left) kms_pipe_crc_basic (hang-read-crc)
[132.640855] Subtest hang-read-crc: SKIP (0.000s)
[132.713943] [117/161] (874s left) kms_pipe_crc_basic (nonblocking-crc)
[132.977973] Subtest nonblocking-crc: SKIP (0.000s)
[133.072746] [118/161] (873s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[133.342964] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s)
[133.431943] [119/161] (873s left) kms_pipe_crc_basic (read-crc)
[133.693858] Subtest read-crc: SKIP (0.000s)
[133.844152] [120/161] (873s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[134.100844] Subtest read-crc-frame-sequence: SKIP (0.000s)
[134.175674] [121/161] (872s left) kms_pm_backlight (basic-brightness)
[134.431958] Subtest basic-brightness: SKIP (0.000s)
[134.539919] [122/161] (872s left) kms_pm_rpm (basic-pci-d3-state)
[136.203071] Starting subtest: basic-pci-d3-state
[136.497247] Subtest basic-pci-d3-state: SUCCESS (0.300s)
[136.735934] [123/161] (870s left) kms_pm_rpm (basic-rte)
[136.806716] Starting subtest: basic-rte
[138.659527] Subtest basic-rte: SUCCESS (1.852s)
[139.176956] [124/161] (868s left) kms_psr (psr-primary-page-flip)
[139.608505] Subtest psr-primary-page-flip: SKIP (0.000s)
[139.724083] [125/161] (867s left) kms_psr (psr-cursor-plane-move)
[139.983521] Subtest psr-cursor-plane-move: SKIP (0.000s)
[140.079184] [126/161] (867s left) kms_psr (psr-sprite-plane-onoff)
[140.333176] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[140.412707] [127/161] (867s left) kms_psr (psr-primary-mmap-gtt)
[140.666557] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[140.742497] [128/161] (866s left) kms_setmode (basic-clone-single-crtc)
[140.813273] Starting subtest: basic-clone-single-crtc
[140.816200] Subtest basic-clone-single-crtc: SKIP (0.000s)
[140.881345] [129/161] (866s left) i915_pm_rps (basic-api)
[140.961813] Starting subtest: basic-api
[140.966881] Subtest basic-api: SUCCESS (0.005s)
[141.044890] [130/161] (866s left) prime_self_import (basic-llseek-bad)
[141.115223] Starting subtest: basic-llseek-bad
[141.117185] Subtest basic-llseek-bad: SUCCESS (0.002s)
[141.198026] [131/161] (866s left) prime_self_import (basic-llseek-size)
[141.264763] Starting subtest: basic-llseek-size
[141.268858] Subtest basic-llseek-size: SUCCESS (0.005s)
[141.342248] [132/161] (866s left) prime_self_import (basic-with_fd_dup)
[141.409902] Starting subtest: basic-with_fd_dup
[141.412324] Subtest basic-with_fd_dup: SUCCESS (0.004s)
[141.489427] [133/161] (866s left) prime_self_import (basic-with_one_bo)
[141.557051] Starting subtest: basic-with_one_bo
[141.561260] Subtest basic-with_one_bo: SUCCESS (0.004s)
[141.626589] [134/161] (866s left) prime_self_import (basic-with_one_bo_two_files)
[141.694736] Starting subtest: basic-with_one_bo_two_files
[141.696915] Subtest basic-with_one_bo_two_files: SUCCESS (0.004s)
[141.774262] [135/161] (866s left) prime_self_import (basic-with_two_bos)
[141.843453] Starting subtest: basic-with_two_bos
[141.846286] Subtest basic-with_two_bos: SUCCESS (0.004s)
[141.929295] [136/161] (866s left) prime_vgem (basic-fence-flip)
[142.007170] Starting subtest: basic-fence-flip
[142.191932] Subtest basic-fence-flip: SKIP (0.183s)
[142.262731] [137/161] (865s left) prime_vgem (basic-fence-mmap)
[142.345404] Starting subtest: basic-fence-mmap
[142.383653] Subtest basic-fence-mmap: SUCCESS (0.038s)
[142.471921] [138/161] (865s left) prime_vgem (basic-fence-read)
[142.563622] Starting subtest: basic-fence-read
[142.634595] Subtest basic-fence-read: SUCCESS (0.072s)
[142.726803] [139/161] (865s left) prime_vgem (basic-gtt)
[142.817129] Starting subtest: basic-gtt
[142.833932] Subtest basic-gtt: SUCCESS (0.017s)
[142.921052] [140/161] (865s left) prime_vgem (basic-read)
[143.007515] Starting subtest: basic-read
[143.039561] Subtest basic-read: SUCCESS (0.033s)
[143.128114] [141/161] (865s left) prime_vgem (basic-write)
[143.207404] Starting subtest: basic-write
[143.242495] Subtest basic-write: SUCCESS (0.035s)
[143.309960] [142/161] (865s left) vgem_basic (setversion)
[143.382351] Starting subtest: setversion
[143.384243] Subtest setversion: SUCCESS (0.000s)
[143.441916] [143/161] (865s left) vgem_basic (create)
[143.513206] Starting subtest: create
[143.514200] Subtest create: SUCCESS (0.000s)
[143.575389] [144/161] (865s left) vgem_basic (debugfs)
[143.647449] Starting subtest: debugfs
[143.648375] Subtest debugfs: SUCCESS (0.001s)
[143.708542] [145/161] (864s left) vgem_basic (dmabuf-export)
[143.780818] Starting subtest: dmabuf-export
[143.783030] Subtest dmabuf-export: SUCCESS (0.002s)
[143.865349] [146/161] (864s left) vgem_basic (dmabuf-fence)
[143.936257] Starting subtest: dmabuf-fence
[143.937304] Subtest dmabuf-fence: SUCCESS (0.001s)
[143.998163] [147/161] (864s left) vgem_basic (dmabuf-fence-before)
[144.070443] Starting subtest: dmabuf-fence-before
[144.071425] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[144.129026] [148/161] (864s left) vgem_basic (dmabuf-mmap)
[144.200420] Starting subtest: dmabuf-mmap
[144.212329] Subtest dmabuf-mmap: SUCCESS (0.013s)
[144.278360] [149/161] (864s left) vgem_basic (mmap)
[144.349249] Starting subtest: mmap
[144.360933] Subtest mmap: SUCCESS (0.012s)
[144.423310] [150/161] (864s left) vgem_basic (second-client)
[144.495062] Starting subtest: second-client
[144.499356] Subtest second-client: SUCCESS (0.004s)
[144.559967] [151/161] (864s left) vgem_basic (sysfs)
[144.630933] Starting subtest: sysfs
[144.631975] Subtest sysfs: SUCCESS (0.001s)
[144.691898] [152/161] (864s left) core_hotunplug (unbind-rebind)
[144.852648] Starting subtest: unbind-rebind
[149.141893] Subtest unbind-rebind: SUCCESS (4.285s)
[149.196020] [153/161] (859s left) vgem_basic (unload)
[149.265091] Starting subtest: unload
[178.408049] Subtest unload: SUCCESS (29.087s)
[178.466733] [154/161] (830s left) i915_module_load (reload)
[178.537437] Starting subtest: reload
[182.597583] Subtest reload: SUCCESS (4.040s)
[182.678489] [FACT i915_module_load (reload)] deleted: kernel.kmod_is_loaded.vgem: true
[182.678593] [FACT i915_module_load (reload)] deleted: kernel.kmod_is_loaded.xe: true
[182.678624] [FACT i915_module_load (reload)] deleted: kernel.kmod_is_loaded.amdgpu: true
[182.684495] [155/161] (826s left) gem_lmem_swapping (basic)
[182.807754] Subtest basic: SKIP (0.000s)
[182.859317] [156/161] (826s left) gem_lmem_swapping (parallel-random-engines)
[182.933998] Subtest parallel-random-engines: SKIP (0.000s)
[182.985689] [157/161] (826s left) gem_lmem_swapping (random-engines)
[183.060976] Subtest random-engines: SKIP (0.000s)
[183.111966] [158/161] (826s left) gem_lmem_swapping (verify-random)
[183.188176] Subtest verify-random: SKIP (0.000s)
[183.238818] [159/161] (826s left) i915_pm_rpm (module-reload)
[186.520954] Starting subtest: module-reload
[201.983248] Subtest module-reload: SUCCESS (15.411s)
[202.042653] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[202.046738] [160/161] (807s left) i915_selftest (live)
[202.123904] Starting subtest: live
[202.125108] Starting dynamic subtest: sanitycheck
[204.802780] Dynamic subtest sanitycheck: SUCCESS (2.644s)
[204.814271] Starting dynamic subtest: uncore
[207.459103] Dynamic subtest uncore: SUCCESS (2.632s)
[207.470298] Starting dynamic subtest: workarounds
[210.524827] Dynamic subtest workarounds: SUCCESS (3.060s)
[210.533457] Starting dynamic subtest: gt_engines
[213.631312] Dynamic subtest gt_engines: SUCCESS (3.104s)
[213.641449] Starting dynamic subtest: gt_timelines
[227.863932] Dynamic subtest gt_timelines: SUCCESS (14.230s)
[227.874948] Starting dynamic subtest: gt_contexts
[230.596805] Dynamic subtest gt_contexts: SUCCESS (2.729s)
[230.607047] Starting dynamic subtest: gt_lrc
[236.415899] Dynamic subtest gt_lrc: SUCCESS (5.815s)
[236.426800] Starting dynamic subtest: gt_mocs
[239.135304] Dynamic subtest gt_mocs: SUCCESS (2.718s)
[239.145616] Starting dynamic subtest: gt_pm
[250.378112] Dynamic subtest gt_pm: SUCCESS (11.240s)
[250.386938] Starting dynamic subtest: gt_heartbeat
[252.939676] Dynamic subtest gt_heartbeat: SUCCESS (2.558s)
[252.948434] Starting dynamic subtest: gt_tlb
[256.559217] Dynamic subtest gt_tlb: SUCCESS (3.618s)
[256.568060] Starting dynamic subtest: requests
[266.833665] Dynamic subtest requests: SUCCESS (10.273s)
[266.844839] Starting dynamic subtest: migrate
[272.611354] Dynamic subtest migrate: SUCCESS (5.773s)
[272.622794] Starting dynamic subtest: active
[275.219480] Dynamic subtest active: SUCCESS (2.606s)
[275.230932] Starting dynamic subtest: objects
[278.668050] Dynamic subtest objects: SUCCESS (3.447s)
[278.676835] Starting dynamic subtest: mman
[284.959563] Dynamic subtest mman: SUCCESS (6.289s)
[284.968536] Starting dynamic subtest: dmabuf
[287.625220] Dynamic subtest dmabuf: SUCCESS (2.663s)
[287.634060] Starting dynamic subtest: vma
[290.165611] Dynamic subtest vma: SUCCESS (2.538s)
[290.174407] Starting dynamic subtest: coherency
[294.058500] Dynamic subtest coherency: SUCCESS (3.890s)
[294.068790] Starting dynamic subtest: gtt
[303.966630] Dynamic subtest gtt: SUCCESS (9.905s)
[303.977639] Starting dynamic subtest: gem
[307.053065] Dynamic subtest gem: SUCCESS (3.084s)
[307.061996] Starting dynamic subtest: evict
[311.866241] Dynamic subtest evict: SUCCESS (4.811s)
[311.875136] Starting dynamic subtest: hugepages
[320.459468] Dynamic subtest hugepages: SUCCESS (8.590s)
[320.470043] Starting dynamic subtest: gem_contexts
[340.290559] Dynamic subtest gem_contexts: SUCCESS (19.825s)
[340.299415] Starting dynamic subtest: client
[343.003578] Dynamic subtest client: SUCCESS (2.710s)
[343.012649] Starting dynamic subtest: gem_migrate
[345.605302] Dynamic subtest gem_migrate: SUCCESS (2.600s)
[345.615190] Starting dynamic subtest: reset
[348.572746] Dynamic subtest reset: SUCCESS (2.965s)
[348.581722] Starting dynamic subtest: memory_region
[351.208635] Dynamic subtest memory_region: SUCCESS (2.633s)
[351.219693] Starting dynamic subtest: hangcheck
[382.591953] Dynamic subtest hangcheck: SUCCESS (31.380s)
[382.604655] Starting dynamic subtest: execlists
[398.331594] Dynamic subtest execlists: SUCCESS (15.738s)
[398.343173] Starting dynamic subtest: ring_submission
[400.997334] Dynamic subtest ring_submission: SUCCESS (2.660s)
[401.009510] Starting dynamic subtest: perf
[403.845209] Dynamic subtest perf: SUCCESS (2.846s)
[403.856348] Starting dynamic subtest: slpc
[406.474587] Dynamic subtest slpc: SUCCESS (2.626s)
[406.485833] Starting dynamic subtest: guc
[409.049109] Dynamic subtest guc: SUCCESS (2.572s)
[409.058209] Starting dynamic subtest: guc_multi_lrc
[411.572085] Dynamic subtest guc_multi_lrc: SUCCESS (2.520s)
[411.587160] Starting dynamic subtest: guc_hang
[414.188320] Dynamic subtest guc_hang: SUCCESS (2.614s)
[414.201173] Starting dynamic subtest: late_gt_pm
[416.890765] Dynamic subtest late_gt_pm: SUCCESS (2.700s)
[416.893496] Subtest live: SUCCESS (214.707s)
[417.167658] [161/161] (592s left) dmabuf (all-tests)
[417.245791] Starting subtest: all-tests
[417.247141] Starting dynamic subtest: sanitycheck
[417.362212] Dynamic subtest sanitycheck: SUCCESS (0.110s)
[417.382991] Starting dynamic subtest: dma_fence
[417.585633] Dynamic subtest dma_fence: SUCCESS (0.222s)
[417.612181] Starting dynamic subtest: dma_fence_chain
[430.219280] Dynamic subtest dma_fence_chain: SUCCESS (12.578s)
[430.228345] Starting dynamic subtest: dma_fence_unwrap
[430.265596] Dynamic subtest dma_fence_unwrap: SUCCESS (0.098s)
[430.280082] Starting dynamic subtest: dma_resv
[430.382605] Dynamic subtest dma_resv: SUCCESS (0.114s)
[430.384756] Subtest all-tests: SUCCESS (13.138s)
[430.454593] Closing watchdogs
Done.