[35.757139] Initializing watchdogs
[35.757294]   /dev/watchdog0
[35.780720] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:5926 Intel Kabylake (Gen9) Iris Plus Graphics 640
[35.787746] [001/161] (960s left) i915_module_load (load)
[35.851249] Starting subtest: load
[38.169564] Subtest load: SUCCESS (2.318s)
[38.228774] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[38.231964] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[38.237079] [002/161] (958s left) core_auth (basic-auth)
[38.398501] Starting subtest: basic-auth
[38.399535] Subtest basic-auth: SUCCESS (0.001s)
[38.443270] [003/161] (957s left) debugfs_test (read_all_entries)
[38.518346] Starting subtest: read_all_entries
[38.561324] Subtest read_all_entries: SUCCESS (0.043s)
[38.859647] [004/161] (957s left) debugfs_test (basic-hwmon)
[38.925357] Starting subtest: basic-hwmon
[38.927420] Subtest basic-hwmon: SKIP (0.000s)
[39.165878] [005/161] (957s left) debugfs_test (sysfs)
[39.233709] Starting subtest: sysfs
[39.311969] Subtest sysfs: SUCCESS (0.077s)
[39.580628] [006/161] (957s left) fbdev (eof)
[43.004152] Subtest eof: SKIP (0.000s)
[43.052458] [FACT fbdev (eof)] new: kernel.kmod_is_loaded.amdgpu: true
[43.054190] [FACT fbdev (eof)] new: kernel.kmod_is_loaded.xe: true
[43.057028] [007/161] (953s left) fbdev (info)
[43.134281] Subtest info: SKIP (0.000s)
[43.178610] [008/161] (953s left) fbdev (nullptr)
[43.249952] Subtest nullptr: SKIP (0.000s)
[43.293950] [009/161] (953s left) fbdev (read)
[43.367421] Subtest read: SKIP (0.000s)
[43.413090] [010/161] (953s left) fbdev (write)
[43.485380] Subtest write: SKIP (0.000s)
[43.529173] [011/161] (953s left) gem_basic (bad-close)
[43.672792] Starting subtest: bad-close
[43.676322] Subtest bad-close: SUCCESS (0.000s)
[43.743347] [012/161] (953s left) gem_basic (create-close)
[43.887252] Starting subtest: create-close
[43.889770] Subtest create-close: SUCCESS (0.000s)
[43.946542] [013/161] (953s left) gem_basic (create-fd-close)
[44.048052] Starting subtest: create-fd-close
[44.050313] Subtest create-fd-close: SUCCESS (0.000s)
[44.120106] [014/161] (952s left) gem_busy (busy@all-engines)
[44.198758] Starting subtest: busy
[44.199819] Starting dynamic subtest: all-engines
[44.269783] Dynamic subtest all-engines: SUCCESS (0.071s)
[44.270998] Subtest busy: SUCCESS (0.071s)
[44.652015] [015/161] (952s left) gem_close_race (basic-process)
[44.739086] Starting subtest: basic-process
[44.812037] Subtest basic-process: SUCCESS (0.073s)
[44.996014] [016/161] (952s left) gem_close_race (basic-threads)
[45.078665] Starting subtest: basic-threads
[46.322273] Subtest basic-threads: SUCCESS (1.203s)
[46.481954] [017/161] (950s left) gem_ctx_create (basic)
[46.561568] Starting subtest: basic
[46.562703] Subtest basic: SUCCESS (0.000s)
[46.748337] [018/161] (950s left) gem_ctx_create (basic-files)
[46.821990] Starting subtest: basic-files
[48.840097] Subtest basic-files: SUCCESS (2.018s)
[49.071145] [019/161] (948s left) gem_ctx_exec (basic)
[49.138151] Starting subtest: basic
[49.143961] Subtest basic: SUCCESS (0.007s)
[49.221562] [020/161] (948s left) gem_exec_basic (basic)
[49.293273] Starting subtest: basic
[49.294988] Starting dynamic subtest: rcs0-smem
[49.297550] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[49.307874] Starting dynamic subtest: bcs0-smem
[49.309086] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[49.316915] Starting dynamic subtest: vcs0-smem
[49.318121] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[49.325890] Starting dynamic subtest: vcs1-smem
[49.327122] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[49.334871] Starting dynamic subtest: vecs0-smem
[49.336137] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[49.337333] Subtest basic: SUCCESS (0.008s)
[49.507823] [021/161] (947s left) gem_exec_create (basic)
[49.740318] Starting subtest: basic
[49.741815] Starting dynamic subtest: smem
[51.826242] Dynamic subtest smem: SUCCESS (2.020s)
[51.828345] Subtest basic: SUCCESS (2.020s)
[51.977160] [022/161] (945s left) gem_exec_fence (basic-busy)
[52.185967] Starting subtest: basic-busy
[52.187594] Starting dynamic subtest: rcs0
[52.217645] Dynamic subtest rcs0: SUCCESS (0.031s)
[52.230718] Starting dynamic subtest: bcs0
[52.242567] Dynamic subtest bcs0: SUCCESS (0.024s)
[52.253484] Starting dynamic subtest: vcs0
[52.267485] Dynamic subtest vcs0: SUCCESS (0.024s)
[52.277029] Starting dynamic subtest: vcs1
[52.294394] Dynamic subtest vcs1: SUCCESS (0.026s)
[52.303449] Starting dynamic subtest: vecs0
[52.314485] Dynamic subtest vecs0: SUCCESS (0.020s)
[52.315655] Subtest basic-busy: SUCCESS (0.127s)
[53.009613] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[53.012287] [023/161] (944s left) gem_exec_fence (basic-wait)
[53.251103] Starting subtest: basic-wait
[53.252785] Starting dynamic subtest: rcs0
[53.282592] Dynamic subtest rcs0: SUCCESS (0.034s)
[53.294345] Starting dynamic subtest: bcs0
[53.311517] Dynamic subtest bcs0: SUCCESS (0.028s)
[53.323325] Starting dynamic subtest: vcs0
[53.337645] Dynamic subtest vcs0: SUCCESS (0.026s)
[53.348539] Starting dynamic subtest: vcs1
[53.360534] Dynamic subtest vcs1: SUCCESS (0.022s)
[53.371180] Starting dynamic subtest: vecs0
[53.383638] Dynamic subtest vecs0: SUCCESS (0.023s)
[53.384886] Subtest basic-wait: SUCCESS (0.135s)
[54.032768] [024/161] (943s left) gem_exec_fence (basic-await)
[54.262115] Starting subtest: basic-await
[54.264315] Starting dynamic subtest: rcs0
[54.377308] Dynamic subtest rcs0: SUCCESS (0.107s)
[54.387311] Starting dynamic subtest: bcs0
[54.477883] Dynamic subtest bcs0: SUCCESS (0.107s)
[54.487910] Starting dynamic subtest: vcs0
[54.586715] Dynamic subtest vcs0: SUCCESS (0.107s)
[54.596602] Starting dynamic subtest: vcs1
[54.697546] Dynamic subtest vcs1: SUCCESS (0.110s)
[54.707314] Starting dynamic subtest: vecs0
[54.808473] Dynamic subtest vecs0: SUCCESS (0.109s)
[54.809889] Subtest basic-await: SUCCESS (0.542s)
[55.467711] [025/161] (942s left) gem_exec_fence (nb-await)
[55.678743] Starting subtest: nb-await
[55.680680] Starting dynamic subtest: rcs0
[55.756662] Dynamic subtest rcs0: SUCCESS (0.077s)
[55.770095] Starting dynamic subtest: bcs0
[55.827556] Dynamic subtest bcs0: SUCCESS (0.069s)
[55.856710] Starting dynamic subtest: vcs0
[55.918377] Dynamic subtest vcs0: SUCCESS (0.087s)
[55.943289] Starting dynamic subtest: vcs1
[56.000928] Dynamic subtest vcs1: SUCCESS (0.084s)
[56.025741] Starting dynamic subtest: vecs0
[56.085148] Dynamic subtest vecs0: SUCCESS (0.082s)
[56.087508] Subtest nb-await: SUCCESS (0.402s)
[56.753106] [026/161] (941s left) gem_exec_gttfill (basic)
[56.841296] Starting subtest: basic
[66.225584] Subtest basic: SUCCESS (9.292s)
[66.337319] [027/161] (931s left) gem_exec_parallel (engines)
[66.734885] Starting subtest: engines
[66.736059] Starting dynamic subtest: basic
[70.358023] Dynamic subtest basic: SUCCESS (3.571s)
[70.370320] Starting dynamic subtest: contexts
[77.313422] Dynamic subtest contexts: SUCCESS (6.987s)
[77.323489] Starting dynamic subtest: fds
[84.845626] Dynamic subtest fds: SUCCESS (7.518s)
[84.855688] Starting dynamic subtest: userptr
[87.829698] Dynamic subtest userptr: SUCCESS (2.955s)
[87.831893] Subtest engines: SUCCESS (21.033s)
[88.005709] [028/161] (910s left) gem_exec_store (basic)
[88.086356] Starting subtest: basic
[88.153143] Subtest basic: SUCCESS (0.066s)
[88.355318] [029/161] (909s left) gem_flink_basic (bad-flink)
[88.416776] Starting subtest: bad-flink
[88.417941] Subtest bad-flink: SUCCESS (0.000s)
[88.469202] [030/161] (909s left) gem_flink_basic (bad-open)
[88.526584] Starting subtest: bad-open
[88.527751] Subtest bad-open: SUCCESS (0.000s)
[88.579103] [031/161] (909s left) gem_flink_basic (basic)
[88.815696] Starting subtest: basic
[88.818214] Subtest basic: SUCCESS (0.001s)
[88.901181] [032/161] (909s left) gem_flink_basic (double-flink)
[88.959926] Starting subtest: double-flink
[88.960991] Subtest double-flink: SUCCESS (0.000s)
[89.029112] [033/161] (909s left) gem_flink_basic (flink-lifetime)
[89.085467] Starting subtest: flink-lifetime
[89.087389] Subtest flink-lifetime: SUCCESS (0.002s)
[89.159152] [034/161] (909s left) gem_huc_copy (huc-copy)
[89.227412] Starting subtest: huc-copy
[89.229566] Subtest huc-copy: SKIP (0.000s)
[89.309772] [035/161] (909s left) gem_linear_blits (basic)
[89.498798] Starting subtest: basic
[89.513051] Subtest basic: SUCCESS (0.015s)
[89.624419] [036/161] (908s left) gem_mmap (basic)
[89.804986] Starting subtest: basic
[89.809824] Subtest basic: SUCCESS (0.000s)
[89.877175] [037/161] (908s left) gem_mmap_gtt (basic)
[89.935702] Starting subtest: basic
[89.936748] Subtest basic: SUCCESS (0.001s)
[89.991276] [038/161] (908s left) gem_render_linear_blits (basic)
[90.059667] Starting subtest: basic
[90.094221] Subtest basic: SUCCESS (0.034s)
[90.156406] [039/161] (908s left) gem_render_tiled_blits (basic)
[90.228220] Starting subtest: basic
[90.273643] Subtest basic: SUCCESS (0.045s)
[90.340967] [040/161] (908s left) gem_ringfill (basic-all)
[90.620133] Starting subtest: basic-all
[91.850836] Subtest basic-all: SUCCESS (1.173s)
[91.907807] [041/161] (906s left) gem_softpin (allocator-basic)
[91.977430] Starting subtest: allocator-basic
[92.192040] Subtest allocator-basic: SUCCESS (0.159s)
[92.246646] [042/161] (906s left) gem_softpin (allocator-basic-reserve)
[92.324179] Starting subtest: allocator-basic-reserve
[92.531917] Subtest allocator-basic-reserve: SUCCESS (0.152s)
[92.583652] [043/161] (906s left) gem_softpin (safe-alignment)
[92.659619] Starting subtest: safe-alignment
[92.677301] Subtest safe-alignment: SUCCESS (0.018s)
[92.754883] [044/161] (906s left) gem_sync (basic-all)
[92.831387] Starting subtest: basic-all
[95.075890] Subtest basic-all: SUCCESS (2.201s)
[95.240828] [045/161] (903s left) gem_sync (basic-each)
[95.320444] Starting subtest: basic-each
[97.574631] Subtest basic-each: SUCCESS (2.254s)
[97.825520] [046/161] (901s left) gem_tiled_blits (basic)
[97.980924] Starting subtest: basic
[98.009430] Subtest basic: SUCCESS (0.028s)
[98.143165] [047/161] (901s left) gem_tiled_fence_blits (basic)
[98.605357] Starting subtest: basic
[98.617855] Subtest basic: SUCCESS (0.012s)
[98.735795] [048/161] (900s left) gem_tiled_pread_basic
[99.028750] [049/161] (900s left) gem_wait (busy@all-engines)
[99.112352] Starting subtest: busy
[99.113312] Starting dynamic subtest: all-engines
[99.685894] Dynamic subtest all-engines: SUCCESS (0.528s)
[99.687593] Subtest busy: SUCCESS (0.528s)
[99.853967] [050/161] (899s left) gem_wait (wait@all-engines)
[99.944391] Starting subtest: wait
[99.945723] Starting dynamic subtest: all-engines
[101.031230] Dynamic subtest all-engines: SUCCESS (1.035s)
[101.034085] Subtest wait: SUCCESS (1.035s)
[101.204167] [051/161] (898s left) i915_getparams_basic (basic-eu-total)
[101.271510] Starting subtest: basic-eu-total
[101.273654] Subtest basic-eu-total: SUCCESS (0.000s)
[101.326644] [052/161] (898s left) i915_getparams_basic (basic-subslice-total)
[101.386097] Starting subtest: basic-subslice-total
[101.388276] Subtest basic-subslice-total: SUCCESS (0.000s)
[101.438962] [053/161] (898s left) i915_hangman (error-state-basic)
[101.526290] Starting subtest: error-state-basic
[101.534689] Subtest error-state-basic: SUCCESS (0.007s)
[101.705706] [054/161] (898s left) i915_pciid
[101.913606] [055/161] (897s left) kms_addfb_basic (addfb25-4-tiled)
[102.215067] Starting subtest: addfb25-4-tiled
[102.216754] Subtest addfb25-4-tiled: SUCCESS (0.001s)
[102.304650] [056/161] (897s left) kms_addfb_basic (addfb25-bad-modifier)
[102.553750] Starting subtest: addfb25-bad-modifier
[102.555769] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[102.651117] [057/161] (897s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[102.912991] Starting subtest: addfb25-framebuffer-vs-set-tiling
[102.916548] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[103.039217] [058/161] (896s left) kms_addfb_basic (addfb25-modifier-no-flag)
[103.287292] Starting subtest: addfb25-modifier-no-flag
[103.288411] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[103.389989] [059/161] (896s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[103.643956] Starting subtest: addfb25-x-tiled-legacy
[103.645939] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[103.734117] [060/161] (896s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[103.979771] Starting subtest: addfb25-x-tiled-mismatch-legacy
[103.981143] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[104.079969] [061/161] (896s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[104.335406] Starting subtest: addfb25-yf-tiled-legacy
[104.337720] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[104.441719] [062/161] (895s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[104.695617] Starting subtest: addfb25-y-tiled-legacy
[104.697833] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[104.811605] [063/161] (895s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[105.080038] Starting subtest: addfb25-y-tiled-small-legacy
[105.083815] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.002s)
[105.200279] [064/161] (895s left) kms_addfb_basic (bad-pitch-0)
[105.259420] Starting subtest: bad-pitch-0
[105.260327] Subtest bad-pitch-0: SUCCESS (0.000s)
[105.537445] [065/161] (895s left) kms_addfb_basic (bad-pitch-1024)
[105.595459] Starting subtest: bad-pitch-1024
[105.596416] Subtest bad-pitch-1024: SUCCESS (0.000s)
[105.884398] [066/161] (894s left) kms_addfb_basic (bad-pitch-128)
[105.942346] Starting subtest: bad-pitch-128
[105.943232] Subtest bad-pitch-128: SUCCESS (0.000s)
[106.233961] [067/161] (894s left) kms_addfb_basic (bad-pitch-256)
[106.296088] Starting subtest: bad-pitch-256
[106.296983] Subtest bad-pitch-256: SUCCESS (0.000s)
[106.563751] [068/161] (894s left) kms_addfb_basic (bad-pitch-32)
[106.623635] Starting subtest: bad-pitch-32
[106.624916] Subtest bad-pitch-32: SUCCESS (0.000s)
[106.946817] [069/161] (893s left) kms_addfb_basic (bad-pitch-63)
[107.006350] Starting subtest: bad-pitch-63
[107.007249] Subtest bad-pitch-63: SUCCESS (0.000s)
[107.309943] [070/161] (893s left) kms_addfb_basic (bad-pitch-65536)
[107.376264] Starting subtest: bad-pitch-65536
[107.377539] Subtest bad-pitch-65536: SUCCESS (0.000s)
[107.665929] [071/161] (893s left) kms_addfb_basic (bad-pitch-999)
[107.726427] Starting subtest: bad-pitch-999
[107.727361] Subtest bad-pitch-999: SUCCESS (0.000s)
[108.003980] [072/161] (893s left) kms_addfb_basic (basic)
[108.064982] Starting subtest: basic
[108.065996] Subtest basic: SUCCESS (0.000s)
[108.391404] [073/161] (892s left) kms_addfb_basic (basic-x-tiled-legacy)
[108.457585] Starting subtest: basic-x-tiled-legacy
[108.458562] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[108.757428] [074/161] (892s left) kms_addfb_basic (basic-y-tiled-legacy)
[108.817209] Starting subtest: basic-y-tiled-legacy
[108.818861] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[109.152456] [075/161] (892s left) kms_addfb_basic (bo-too-small)
[109.398430] Starting subtest: bo-too-small
[109.399437] Subtest bo-too-small: SUCCESS (0.001s)
[109.490231] [076/161] (891s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[109.743362] Starting subtest: bo-too-small-due-to-tiling
[109.745408] Subtest bo-too-small-due-to-tiling: SUCCESS (0.002s)
[109.850344] [077/161] (891s left) kms_addfb_basic (clobberred-modifier)
[109.911460] Starting subtest: clobberred-modifier
[109.912484] Subtest clobberred-modifier: SUCCESS (0.000s)
[110.181654] [078/161] (891s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[110.245230] Starting subtest: framebuffer-vs-set-tiling
[110.246235] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[110.591894] [079/161] (891s left) kms_addfb_basic (invalid-get-prop)
[110.650719] Starting subtest: invalid-get-prop
[110.652019] Subtest invalid-get-prop: SUCCESS (0.000s)
[110.936144] [080/161] (890s left) kms_addfb_basic (invalid-get-prop-any)
[110.995410] Starting subtest: invalid-get-prop-any
[110.996415] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[111.287801] [081/161] (890s left) kms_addfb_basic (invalid-set-prop)
[111.346939] Starting subtest: invalid-set-prop
[111.348234] Subtest invalid-set-prop: SUCCESS (0.000s)
[111.642847] [082/161] (890s left) kms_addfb_basic (invalid-set-prop-any)
[111.701339] Starting subtest: invalid-set-prop-any
[111.702287] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[112.014545] [083/161] (889s left) kms_addfb_basic (no-handle)
[112.075414] Starting subtest: no-handle
[112.076301] Subtest no-handle: SUCCESS (0.000s)
[112.378408] [084/161] (889s left) kms_addfb_basic (size-max)
[112.626280] Starting subtest: size-max
[112.628130] Subtest size-max: SUCCESS (0.000s)
[112.751269] [085/161] (889s left) kms_addfb_basic (small-bo)
[113.015661] Starting subtest: small-bo
[113.017605] Subtest small-bo: SUCCESS (0.000s)
[113.159654] [086/161] (889s left) kms_addfb_basic (tile-pitch-mismatch)
[113.218828] Starting subtest: tile-pitch-mismatch
[113.219864] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[113.488194] [087/161] (888s left) kms_addfb_basic (too-high)
[113.740782] Starting subtest: too-high
[113.743606] Subtest too-high: SUCCESS (0.002s)
[113.843601] [088/161] (888s left) kms_addfb_basic (too-wide)
[114.087545] Starting subtest: too-wide
[114.088770] Subtest too-wide: SUCCESS (0.000s)
[114.174969] [089/161] (888s left) kms_addfb_basic (unused-handle)
[114.238685] Starting subtest: unused-handle
[114.239594] Subtest unused-handle: SUCCESS (0.000s)
[114.517351] [090/161] (888s left) kms_addfb_basic (unused-modifier)
[114.576452] Starting subtest: unused-modifier
[114.577355] Subtest unused-modifier: SUCCESS (0.000s)
[114.861773] [091/161] (887s left) kms_addfb_basic (unused-offsets)
[114.918394] Starting subtest: unused-offsets
[114.919423] Subtest unused-offsets: SUCCESS (0.000s)
[115.197549] [092/161] (887s left) kms_addfb_basic (unused-pitches)
[115.255338] Starting subtest: unused-pitches
[115.256403] Subtest unused-pitches: SUCCESS (0.000s)
[115.573623] [093/161] (887s left) kms_busy (basic)
[115.835162] Subtest basic: SKIP (0.000s)
[115.931956] [094/161] (886s left) kms_prop_blob (basic)
[115.992046] Starting subtest: basic
[115.993028] Subtest basic: SUCCESS (0.000s)
[116.049139] [095/161] (886s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[116.321917] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[116.384144] [096/161] (886s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[116.669629] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[116.766086] [097/161] (886s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[117.020239] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[117.077518] [098/161] (886s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[117.351897] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s)
[117.463404] [099/161] (885s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[117.719887] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s)
[117.784683] [100/161] (885s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[118.065753] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[118.156898] [101/161] (885s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[118.419112] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s)
[118.490814] [102/161] (884s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[118.747090] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s)
[118.813786] [103/161] (884s left) kms_dsc (dsc-basic)
[119.058397] Subtest dsc-basic: SKIP (0.000s)
[119.121263] [104/161] (884s left) kms_flip (basic-flip-vs-dpms)
[119.368890] Starting subtest: basic-flip-vs-dpms
[119.372774] Subtest basic-flip-vs-dpms: SKIP (0.005s)
[119.466944] [105/161] (884s left) kms_flip (basic-flip-vs-modeset)
[119.716067] Starting subtest: basic-flip-vs-modeset
[119.721452] Subtest basic-flip-vs-modeset: SKIP (0.004s)
[119.805101] [106/161] (883s left) kms_flip (basic-flip-vs-wf_vblank)
[120.053835] Starting subtest: basic-flip-vs-wf_vblank
[120.059650] Subtest basic-flip-vs-wf_vblank: SKIP (0.006s)
[120.136991] [107/161] (883s left) kms_flip (basic-plain-flip)
[120.379968] Starting subtest: basic-plain-flip
[120.385352] Subtest basic-plain-flip: SKIP (0.004s)
[120.464968] [108/161] (883s left) kms_force_connector_basic (force-connector-state)
[120.810324] Starting subtest: force-connector-state
[121.501616] Subtest force-connector-state: SUCCESS (0.691s)
[122.049146] [109/161] (881s left) kms_force_connector_basic (force-edid)
[122.392046] Starting subtest: force-edid
[122.952606] Subtest force-edid: SUCCESS (0.560s)
[123.391722] [110/161] (880s left) kms_force_connector_basic (force-load-detect)
[123.742362] Starting subtest: force-load-detect
[123.744530] Subtest force-load-detect: SKIP (0.000s)
[124.086157] [111/161] (879s left) kms_force_connector_basic (prune-stale-modes)
[124.422466] Starting subtest: prune-stale-modes
[125.053643] Subtest prune-stale-modes: SUCCESS (0.632s)
[125.494815] [112/161] (878s left) kms_frontbuffer_tracking (basic)
[125.745305] Subtest basic: SKIP (0.000s)
[125.822073] [113/161] (878s left) kms_hdmi_inject (inject-audio)
[125.886116] Starting subtest: inject-audio
[126.445317] Subtest inject-audio: SUCCESS (0.557s)
[126.732919] [114/161] (877s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[126.981129] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s)
[127.052476] [115/161] (877s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[127.300321] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s)
[127.371815] [116/161] (876s left) kms_pipe_crc_basic (hang-read-crc)
[127.620748] Subtest hang-read-crc: SKIP (0.000s)
[127.692192] [117/161] (876s left) kms_pipe_crc_basic (nonblocking-crc)
[127.940278] Subtest nonblocking-crc: SKIP (0.000s)
[128.018396] [118/161] (876s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[128.278897] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s)
[128.359775] [119/161] (876s left) kms_pipe_crc_basic (read-crc)
[128.607918] Subtest read-crc: SKIP (0.000s)
[128.684163] [120/161] (875s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[128.937918] Subtest read-crc-frame-sequence: SKIP (0.000s)
[129.005638] [121/161] (875s left) kms_pm_backlight (basic-brightness)
[129.255224] Subtest basic-brightness: SKIP (0.000s)
[129.328966] [122/161] (875s left) kms_pm_rpm (basic-pci-d3-state)
[130.962616] Starting subtest: basic-pci-d3-state
[131.285228] Subtest basic-pci-d3-state: SUCCESS (0.316s)
[131.605236] [123/161] (873s left) kms_pm_rpm (basic-rte)
[131.757524] Starting subtest: basic-rte
[133.583927] Subtest basic-rte: SUCCESS (1.825s)
[134.113810] [124/161] (870s left) kms_psr (psr-primary-page-flip)
[134.477361] Subtest psr-primary-page-flip: SKIP (0.000s)
[134.549172] [125/161] (870s left) kms_psr (psr-cursor-plane-move)
[134.801742] Subtest psr-cursor-plane-move: SKIP (0.000s)
[134.877308] [126/161] (870s left) kms_psr (psr-sprite-plane-onoff)
[135.127536] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[135.201811] [127/161] (870s left) kms_psr (psr-primary-mmap-gtt)
[135.457951] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[135.531176] [128/161] (869s left) kms_setmode (basic-clone-single-crtc)
[135.591017] Starting subtest: basic-clone-single-crtc
[135.593815] Subtest basic-clone-single-crtc: SKIP (0.000s)
[135.656620] [129/161] (869s left) i915_pm_rps (basic-api)
[135.726515] Starting subtest: basic-api
[135.730925] Subtest basic-api: SUCCESS (0.004s)
[135.810753] [130/161] (869s left) prime_self_import (basic-llseek-bad)
[135.868311] Starting subtest: basic-llseek-bad
[135.871645] Subtest basic-llseek-bad: SUCCESS (0.002s)
[135.955626] [131/161] (869s left) prime_self_import (basic-llseek-size)
[136.012480] Starting subtest: basic-llseek-size
[136.017708] Subtest basic-llseek-size: SUCCESS (0.004s)
[136.090359] [132/161] (869s left) prime_self_import (basic-with_fd_dup)
[136.147566] Starting subtest: basic-with_fd_dup
[136.151012] Subtest basic-with_fd_dup: SUCCESS (0.004s)
[136.227493] [133/161] (869s left) prime_self_import (basic-with_one_bo)
[136.283276] Starting subtest: basic-with_one_bo
[136.286899] Subtest basic-with_one_bo: SUCCESS (0.003s)
[136.349023] [134/161] (869s left) prime_self_import (basic-with_one_bo_two_files)
[136.406646] Starting subtest: basic-with_one_bo_two_files
[136.408998] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s)
[136.490990] [135/161] (869s left) prime_self_import (basic-with_two_bos)
[136.547028] Starting subtest: basic-with_two_bos
[136.551657] Subtest basic-with_two_bos: SUCCESS (0.004s)
[136.639683] [136/161] (869s left) prime_vgem (basic-fence-flip)
[136.708904] Starting subtest: basic-fence-flip
[136.910460] Subtest basic-fence-flip: SKIP (0.197s)
[136.988326] [137/161] (868s left) prime_vgem (basic-fence-mmap)
[137.056596] Starting subtest: basic-fence-mmap
[137.086611] Subtest basic-fence-mmap: SUCCESS (0.030s)
[137.175905] [138/161] (868s left) prime_vgem (basic-fence-read)
[137.243678] Starting subtest: basic-fence-read
[137.312588] Subtest basic-fence-read: SUCCESS (0.069s)
[137.395445] [139/161] (868s left) prime_vgem (basic-gtt)
[137.479851] Starting subtest: basic-gtt
[137.493063] Subtest basic-gtt: SUCCESS (0.013s)
[137.571775] [140/161] (868s left) prime_vgem (basic-read)
[137.641549] Starting subtest: basic-read
[137.674963] Subtest basic-read: SUCCESS (0.033s)
[137.754465] [141/161] (868s left) prime_vgem (basic-write)
[137.822540] Starting subtest: basic-write
[137.858469] Subtest basic-write: SUCCESS (0.036s)
[137.921694] [142/161] (868s left) vgem_basic (setversion)
[137.982341] Starting subtest: setversion
[137.984276] Subtest setversion: SUCCESS (0.000s)
[138.042557] [143/161] (868s left) vgem_basic (create)
[138.104173] Starting subtest: create
[138.105161] Subtest create: SUCCESS (0.000s)
[138.159614] [144/161] (868s left) vgem_basic (debugfs)
[138.220118] Starting subtest: debugfs
[138.221061] Subtest debugfs: SUCCESS (0.001s)
[138.279447] [145/161] (867s left) vgem_basic (dmabuf-export)
[138.339956] Starting subtest: dmabuf-export
[138.341887] Subtest dmabuf-export: SUCCESS (0.002s)
[138.422480] [146/161] (867s left) vgem_basic (dmabuf-fence)
[138.482130] Starting subtest: dmabuf-fence
[138.483144] Subtest dmabuf-fence: SUCCESS (0.001s)
[138.541016] [147/161] (867s left) vgem_basic (dmabuf-fence-before)
[138.601956] Starting subtest: dmabuf-fence-before
[138.603055] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[138.656923] [148/161] (867s left) vgem_basic (dmabuf-mmap)
[138.717671] Starting subtest: dmabuf-mmap
[138.729477] Subtest dmabuf-mmap: SUCCESS (0.013s)
[138.789872] [149/161] (867s left) vgem_basic (mmap)
[138.849591] Starting subtest: mmap
[138.858355] Subtest mmap: SUCCESS (0.009s)
[138.915462] [150/161] (867s left) vgem_basic (second-client)
[138.977362] Starting subtest: second-client
[138.980620] Subtest second-client: SUCCESS (0.003s)
[139.037590] [151/161] (867s left) vgem_basic (sysfs)
[139.096133] Starting subtest: sysfs
[139.097145] Subtest sysfs: SUCCESS (0.001s)
[139.155997] [152/161] (867s left) core_hotunplug (unbind-rebind)
[139.268176] Starting subtest: unbind-rebind
[143.558696] Subtest unbind-rebind: SUCCESS (4.280s)
[143.609913] [153/161] (863s left) vgem_basic (unload)
[143.675020] Starting subtest: unload
[172.775674] Subtest unload: SUCCESS (29.045s)
[172.832551] [154/161] (833s left) i915_module_load (reload)
[172.895278] Starting subtest: reload
[176.216726] Subtest reload: SUCCESS (3.318s)
[176.285138] [155/161] (830s left) gem_lmem_swapping (basic)
[176.433058] Subtest basic: SKIP (0.000s)
[176.486049] [156/161] (830s left) gem_lmem_swapping (parallel-random-engines)
[176.552785] Subtest parallel-random-engines: SKIP (0.000s)
[176.606072] [157/161] (830s left) gem_lmem_swapping (random-engines)
[176.671451] Subtest random-engines: SKIP (0.000s)
[176.724578] [158/161] (830s left) gem_lmem_swapping (verify-random)
[176.790657] Subtest verify-random: SKIP (0.000s)
[176.842636] [159/161] (830s left) i915_pm_rpm (module-reload)
[180.120863] Starting subtest: module-reload
[193.914497] Subtest module-reload: SUCCESS (13.742s)
[193.982516] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[193.984251] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[193.986861] [160/161] (813s left) i915_selftest (live)
[194.054749] Starting subtest: live
[194.055990] Starting dynamic subtest: sanitycheck
[196.607466] Dynamic subtest sanitycheck: SUCCESS (2.496s)
[196.619009] Starting dynamic subtest: uncore
[199.173318] Dynamic subtest uncore: SUCCESS (2.565s)
[199.182440] Starting dynamic subtest: workarounds
[202.040086] Dynamic subtest workarounds: SUCCESS (2.866s)
[202.048946] Starting dynamic subtest: gt_engines
[205.123662] Dynamic subtest gt_engines: SUCCESS (3.082s)
[205.134769] Starting dynamic subtest: gt_timelines
[220.359690] Dynamic subtest gt_timelines: SUCCESS (15.234s)
[220.368588] Starting dynamic subtest: gt_contexts
[223.087361] Dynamic subtest gt_contexts: SUCCESS (2.727s)
[223.096178] Starting dynamic subtest: gt_lrc
[228.767187] Dynamic subtest gt_lrc: SUCCESS (5.678s)
[228.778648] Starting dynamic subtest: gt_mocs
[231.392897] Dynamic subtest gt_mocs: SUCCESS (2.625s)
[231.401723] Starting dynamic subtest: gt_pm
[242.589180] Dynamic subtest gt_pm: SUCCESS (11.194s)
[242.600718] Starting dynamic subtest: gt_heartbeat
[245.219873] Dynamic subtest gt_heartbeat: SUCCESS (2.630s)
[245.231373] Starting dynamic subtest: gt_tlb
[248.782090] Dynamic subtest gt_tlb: SUCCESS (3.561s)
[248.792858] Starting dynamic subtest: requests
[258.894464] Dynamic subtest requests: SUCCESS (10.111s)
[258.905307] Starting dynamic subtest: migrate
[264.393207] Dynamic subtest migrate: SUCCESS (5.497s)
[264.402092] Starting dynamic subtest: active
[266.941179] Dynamic subtest active: SUCCESS (2.546s)
[266.951596] Starting dynamic subtest: objects
[270.341117] Dynamic subtest objects: SUCCESS (3.398s)
[270.352432] Starting dynamic subtest: mman
[276.545546] Dynamic subtest mman: SUCCESS (6.258s)
[276.556642] Starting dynamic subtest: dmabuf
[279.184413] Dynamic subtest dmabuf: SUCCESS (2.636s)
[279.197137] Starting dynamic subtest: vma
[281.808788] Dynamic subtest vma: SUCCESS (2.568s)
[281.817733] Starting dynamic subtest: coherency
[286.697812] Dynamic subtest coherency: SUCCESS (4.887s)
[286.706693] Starting dynamic subtest: gtt
[296.521898] Dynamic subtest gtt: SUCCESS (9.824s)
[296.533208] Starting dynamic subtest: gem
[299.628482] Dynamic subtest gem: SUCCESS (3.104s)
[299.637483] Starting dynamic subtest: evict
[304.419857] Dynamic subtest evict: SUCCESS (4.789s)
[304.430143] Starting dynamic subtest: hugepages
[312.861234] Dynamic subtest hugepages: SUCCESS (8.440s)
[312.870173] Starting dynamic subtest: gem_contexts
[332.391307] Dynamic subtest gem_contexts: SUCCESS (19.528s)
[332.400643] Starting dynamic subtest: client
[334.972190] Dynamic subtest client: SUCCESS (2.578s)
[334.983725] Starting dynamic subtest: gem_migrate
[337.544500] Dynamic subtest gem_migrate: SUCCESS (2.570s)
[337.553413] Starting dynamic subtest: reset
[340.471030] Dynamic subtest reset: SUCCESS (2.925s)
[340.482562] Starting dynamic subtest: memory_region
[343.015907] Dynamic subtest memory_region: SUCCESS (2.543s)
[343.024915] Starting dynamic subtest: hangcheck
[374.297861] Dynamic subtest hangcheck: SUCCESS (31.280s)
[374.309019] Starting dynamic subtest: execlists
[389.772526] Dynamic subtest execlists: SUCCESS (15.472s)
[389.783308] Starting dynamic subtest: ring_submission
[392.334779] Dynamic subtest ring_submission: SUCCESS (2.557s)
[392.346334] Starting dynamic subtest: perf
[395.043038] Dynamic subtest perf: SUCCESS (2.706s)
[395.052055] Starting dynamic subtest: slpc
[397.542964] Dynamic subtest slpc: SUCCESS (2.497s)
[397.554554] Starting dynamic subtest: guc
[400.081467] Dynamic subtest guc: SUCCESS (2.536s)
[400.091880] Starting dynamic subtest: guc_multi_lrc
[402.620061] Dynamic subtest guc_multi_lrc: SUCCESS (2.536s)
[402.629031] Starting dynamic subtest: guc_hang
[405.161124] Dynamic subtest guc_hang: SUCCESS (2.539s)
[405.170073] Starting dynamic subtest: late_gt_pm
[407.742541] Dynamic subtest late_gt_pm: SUCCESS (2.578s)
[407.745128] Subtest live: SUCCESS (213.631s)
[407.809136] [161/161] (599s left) dmabuf (all-tests)
[407.878739] Starting subtest: all-tests
[407.880104] Starting dynamic subtest: sanitycheck
[407.949304] Dynamic subtest sanitycheck: SUCCESS (0.069s)
[407.979628] Starting dynamic subtest: dma_fence
[408.246841] Dynamic subtest dma_fence: SUCCESS (0.232s)
[408.262267] Starting dynamic subtest: dma_fence_chain
[420.808216] Dynamic subtest dma_fence_chain: SUCCESS (12.561s)
[420.829690] Starting dynamic subtest: dma_fence_unwrap
[420.866621] Dynamic subtest dma_fence_unwrap: SUCCESS (0.110s)
[420.896864] Starting dynamic subtest: dma_resv
[420.947093] Dynamic subtest dma_resv: SUCCESS (0.075s)
[420.952692] Subtest all-tests: SUCCESS (13.069s)
[421.020269] Closing watchdogs
Done.