[50.596217] Initializing watchdogs
[50.596463]   /dev/watchdog0
[50.632247] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[50.643622] [001/161] (960s left) i915_module_load (load)
[51.061327] Starting subtest: load
[53.664164] Subtest load: SUCCESS (2.602s)
[53.827284] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[53.832801] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[53.843443] [002/161] (957s left) core_auth (basic-auth)
[54.054330] Starting subtest: basic-auth
[54.055872] Subtest basic-auth: SUCCESS (0.001s)
[54.195697] [003/161] (957s left) debugfs_test (read_all_entries)
[54.324060] Starting subtest: read_all_entries
[54.468221] Subtest read_all_entries: SUCCESS (0.145s)
[54.651385] [004/161] (956s left) debugfs_test (basic-hwmon)
[54.775630] Starting subtest: basic-hwmon
[54.777828] Subtest basic-hwmon: SKIP (0.000s)
[54.950462] [005/161] (956s left) debugfs_test (sysfs)
[55.083296] Starting subtest: sysfs
[55.173885] Subtest sysfs: SUCCESS (0.092s)
[55.349375] [006/161] (956s left) fbdev (eof)
[55.480985] Starting subtest: eof
[55.484086] Subtest eof: SUCCESS (0.002s)
[55.590725] [007/161] (956s left) fbdev (info)
[55.703369] Starting subtest: info
[55.704963] Subtest info: SUCCESS (0.000s)
[55.826889] [008/161] (955s left) fbdev (nullptr)
[55.945216] Starting subtest: nullptr
[55.946358] Subtest nullptr: SUCCESS (0.000s)
[56.053223] [009/161] (955s left) fbdev (read)
[56.180892] Starting subtest: read
[57.782439] Subtest read: SUCCESS (1.576s)
[57.900575] [010/161] (954s left) fbdev (write)
[58.026512] Starting subtest: write
[58.830587] Subtest write: SUCCESS (0.792s)
[58.948529] [011/161] (953s left) gem_basic (bad-close)
[59.062449] Starting subtest: bad-close
[59.065117] Subtest bad-close: SUCCESS (0.000s)
[59.204335] [012/161] (952s left) gem_basic (create-close)
[59.319470] Starting subtest: create-close
[59.323405] Subtest create-close: SUCCESS (0.000s)
[59.456964] [013/161] (952s left) gem_basic (create-fd-close)
[59.572576] Starting subtest: create-fd-close
[59.575364] Subtest create-fd-close: SUCCESS (0.001s)
[59.709508] [014/161] (952s left) gem_busy (busy@all-engines)
[59.856430] Starting subtest: busy
[59.857502] Starting dynamic subtest: all-engines
[59.947444] Dynamic subtest all-engines: SUCCESS (0.090s)
[59.949111] Subtest busy: SUCCESS (0.090s)
[60.353501] [015/161] (952s left) gem_close_race (basic-process)
[60.498848] Starting subtest: basic-process
[60.590484] Subtest basic-process: SUCCESS (0.089s)
[60.843122] [016/161] (951s left) gem_close_race (basic-threads)
[60.990502] Starting subtest: basic-threads
[62.235961] Subtest basic-threads: SUCCESS (1.232s)
[62.473054] [017/161] (950s left) gem_ctx_create (basic)
[62.610539] Starting subtest: basic
[62.611601] Subtest basic: SUCCESS (0.000s)
[62.859920] [018/161] (949s left) gem_ctx_create (basic-files)
[63.003117] Starting subtest: basic-files
[65.035909] Subtest basic-files: SUCCESS (2.019s)
[65.289248] [019/161] (947s left) gem_ctx_exec (basic)
[65.411965] Starting subtest: basic
[65.420282] Subtest basic: SUCCESS (0.007s)
[65.561414] [020/161] (947s left) gem_exec_basic (basic)
[65.692625] Starting subtest: basic
[65.694073] Starting dynamic subtest: rcs0-smem
[65.698115] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[65.712411] Starting dynamic subtest: bcs0-smem
[65.713487] Dynamic subtest bcs0-smem: SUCCESS (0.005s)
[65.727889] Starting dynamic subtest: vcs0-smem
[65.729691] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[65.744157] Starting dynamic subtest: vecs0-smem
[65.745767] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[65.747253] Subtest basic: SUCCESS (0.017s)
[65.965483] [021/161] (946s left) gem_exec_create (basic)
[66.107919] Starting subtest: basic
[66.110427] Starting dynamic subtest: smem
[68.194352] Dynamic subtest smem: SUCCESS (2.075s)
[68.196473] Subtest basic: SUCCESS (2.077s)
[68.501084] [022/161] (944s left) gem_exec_fence (basic-busy)
[68.885899] Starting subtest: basic-busy
[68.887046] Starting dynamic subtest: rcs0
[68.910354] Dynamic subtest rcs0: SUCCESS (0.027s)
[68.926478] Starting dynamic subtest: bcs0
[68.949180] Dynamic subtest bcs0: SUCCESS (0.034s)
[68.970219] Starting dynamic subtest: vcs0
[68.978453] Dynamic subtest vcs0: SUCCESS (0.029s)
[68.999927] Starting dynamic subtest: vecs0
[69.005325] Dynamic subtest vecs0: SUCCESS (0.028s)
[69.007173] Subtest basic-busy: SUCCESS (0.121s)
[69.906626] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[69.911383] [023/161] (943s left) gem_exec_fence (basic-wait)
[70.191968] Starting subtest: basic-wait
[70.193333] Starting dynamic subtest: rcs0
[70.216188] Dynamic subtest rcs0: SUCCESS (0.023s)
[70.235357] Starting dynamic subtest: bcs0
[70.239591] Dynamic subtest bcs0: SUCCESS (0.023s)
[70.256810] Starting dynamic subtest: vcs0
[70.258181] Dynamic subtest vcs0: SUCCESS (0.017s)
[70.276060] Starting dynamic subtest: vecs0
[70.277503] Dynamic subtest vecs0: SUCCESS (0.018s)
[70.278790] Subtest basic-wait: SUCCESS (0.084s)
[70.943937] [024/161] (942s left) gem_exec_fence (basic-await)
[71.219965] Starting subtest: basic-await
[71.222076] Starting dynamic subtest: rcs0
[71.346417] Dynamic subtest rcs0: SUCCESS (0.124s)
[71.363246] Starting dynamic subtest: bcs0
[71.469722] Dynamic subtest bcs0: SUCCESS (0.122s)
[71.484659] Starting dynamic subtest: vcs0
[71.606402] Dynamic subtest vcs0: SUCCESS (0.131s)
[71.620993] Starting dynamic subtest: vecs0
[71.735685] Dynamic subtest vecs0: SUCCESS (0.130s)
[71.736896] Subtest basic-await: SUCCESS (0.516s)
[72.412906] [025/161] (940s left) gem_exec_fence (nb-await)
[72.687835] Starting subtest: nb-await
[72.690281] Starting dynamic subtest: rcs0
[72.763269] Dynamic subtest rcs0: SUCCESS (0.071s)
[72.778251] Starting dynamic subtest: bcs0
[72.831121] Dynamic subtest bcs0: SUCCESS (0.068s)
[72.846421] Starting dynamic subtest: vcs0
[72.900871] Dynamic subtest vcs0: SUCCESS (0.069s)
[72.916753] Starting dynamic subtest: vecs0
[72.969239] Dynamic subtest vecs0: SUCCESS (0.067s)
[72.970443] Subtest nb-await: SUCCESS (0.281s)
[73.647703] [026/161] (939s left) gem_exec_gttfill (basic)
[73.790301] Starting subtest: basic
[90.425285] Subtest basic: SUCCESS (16.616s)
[90.925649] [027/161] (922s left) gem_exec_parallel (engines)
[91.755638] Starting subtest: engines
[91.757041] Starting dynamic subtest: basic
[95.527483] Dynamic subtest basic: SUCCESS (3.768s)
[95.545237] Starting dynamic subtest: contexts
[103.299186] Dynamic subtest contexts: SUCCESS (7.771s)
[103.317871] Starting dynamic subtest: fds
[107.741694] Dynamic subtest fds: SUCCESS (4.439s)
[107.759868] Starting dynamic subtest: userptr
[110.915656] Dynamic subtest userptr: SUCCESS (3.175s)
[110.916966] Subtest engines: SUCCESS (19.157s)
[111.179948] [028/161] (902s left) gem_exec_store (basic)
[111.323322] Starting subtest: basic
[111.373987] Subtest basic: SUCCESS (0.050s)
[111.628921] [029/161] (902s left) gem_flink_basic (bad-flink)
[111.749255] Starting subtest: bad-flink
[111.750484] Subtest bad-flink: SUCCESS (0.000s)
[111.890513] [030/161] (902s left) gem_flink_basic (bad-open)
[112.004852] Starting subtest: bad-open
[112.006727] Subtest bad-open: SUCCESS (0.000s)
[112.158038] [031/161] (902s left) gem_flink_basic (basic)
[112.268830] Starting subtest: basic
[112.270993] Subtest basic: SUCCESS (0.000s)
[112.416263] [032/161] (901s left) gem_flink_basic (double-flink)
[112.529399] Starting subtest: double-flink
[112.532117] Subtest double-flink: SUCCESS (0.000s)
[112.687791] [033/161] (901s left) gem_flink_basic (flink-lifetime)
[112.798479] Starting subtest: flink-lifetime
[112.799696] Subtest flink-lifetime: SUCCESS (0.002s)
[112.951981] [034/161] (901s left) gem_huc_copy (huc-copy)
[113.079448] Starting subtest: huc-copy
[113.081756] Subtest huc-copy: SKIP (0.000s)
[113.236888] [035/161] (901s left) gem_linear_blits (basic)
[113.497987] Starting subtest: basic
[113.520469] Subtest basic: SUCCESS (0.024s)
[113.724872] [036/161] (900s left) gem_mmap (basic)
[114.004844] Starting subtest: basic
[114.010672] Subtest basic: SUCCESS (0.001s)
[114.146884] [037/161] (900s left) gem_mmap_gtt (basic)
[114.259365] Starting subtest: basic
[114.260489] Subtest basic: SUCCESS (0.001s)
[114.398038] [038/161] (900s left) gem_render_linear_blits (basic)
[114.516246] Starting subtest: basic
[114.589274] Subtest basic: SUCCESS (0.069s)
[114.697934] [039/161] (900s left) gem_render_tiled_blits (basic)
[114.818167] Starting subtest: basic
[114.919223] Subtest basic: SUCCESS (0.098s)
[115.030399] [040/161] (900s left) gem_ringfill (basic-all)
[115.406192] Starting subtest: basic-all
[116.614484] Subtest basic-all: SUCCESS (1.203s)
[116.779076] [041/161] (898s left) gem_softpin (allocator-basic)
[116.903194] Starting subtest: allocator-basic
[117.103852] Subtest allocator-basic: SUCCESS (0.198s)
[117.269191] [042/161] (897s left) gem_softpin (allocator-basic-reserve)
[117.400693] Starting subtest: allocator-basic-reserve
[117.603647] Subtest allocator-basic-reserve: SUCCESS (0.198s)
[117.769449] [043/161] (897s left) gem_softpin (safe-alignment)
[117.899167] Starting subtest: safe-alignment
[117.923356] Subtest safe-alignment: SUCCESS (0.023s)
[118.067107] [044/161] (897s left) gem_sync (basic-all)
[118.216071] Starting subtest: basic-all
[120.294823] Subtest basic-all: SUCCESS (2.079s)
[120.568715] [045/161] (894s left) gem_sync (basic-each)
[120.715355] Starting subtest: basic-each
[123.101311] Subtest basic-each: SUCCESS (2.386s)
[123.354938] [046/161] (892s left) gem_tiled_blits (basic)
[123.577693] Starting subtest: basic
[123.619898] Subtest basic: SUCCESS (0.042s)
[123.818693] [047/161] (891s left) gem_tiled_fence_blits (basic)
[124.213594] Starting subtest: basic
[124.248887] Subtest basic: SUCCESS (0.035s)
[124.453592] [048/161] (891s left) gem_tiled_pread_basic
[125.126896] [049/161] (890s left) gem_wait (busy@all-engines)
[125.278128] Starting subtest: busy
[125.282105] Starting dynamic subtest: all-engines
[125.800282] Dynamic subtest all-engines: SUCCESS (0.520s)
[125.801400] Subtest busy: SUCCESS (0.521s)
[126.115227] [050/161] (889s left) gem_wait (wait@all-engines)
[126.264153] Starting subtest: wait
[126.265229] Starting dynamic subtest: all-engines
[127.308218] Dynamic subtest all-engines: SUCCESS (1.043s)
[127.311568] Subtest wait: SUCCESS (1.044s)
[127.604915] [051/161] (888s left) i915_getparams_basic (basic-eu-total)
[127.719128] Starting subtest: basic-eu-total
[127.721472] Subtest basic-eu-total: SUCCESS (0.000s)
[127.850348] [052/161] (888s left) i915_getparams_basic (basic-subslice-total)
[127.965325] Starting subtest: basic-subslice-total
[127.968535] Subtest basic-subslice-total: SUCCESS (0.000s)
[128.098902] [053/161] (888s left) i915_hangman (error-state-basic)
[128.234067] Starting subtest: error-state-basic
[128.251144] Subtest error-state-basic: SUCCESS (0.013s)
[128.396150] [054/161] (888s left) i915_pciid
[128.658542] [055/161] (887s left) kms_addfb_basic (addfb25-4-tiled)
[128.843931] Starting subtest: addfb25-4-tiled
[128.846976] Subtest addfb25-4-tiled: SUCCESS (0.001s)
[128.977566] [056/161] (887s left) kms_addfb_basic (addfb25-bad-modifier)
[129.162717] Starting subtest: addfb25-bad-modifier
[129.163900] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[129.309858] [057/161] (887s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[129.493500] Starting subtest: addfb25-framebuffer-vs-set-tiling
[129.495772] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[129.629725] [058/161] (887s left) kms_addfb_basic (addfb25-modifier-no-flag)
[129.797634] Starting subtest: addfb25-modifier-no-flag
[129.800194] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[129.929672] [059/161] (886s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[130.108930] Starting subtest: addfb25-x-tiled-legacy
[130.110931] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[130.246127] [060/161] (886s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[130.435581] Starting subtest: addfb25-x-tiled-mismatch-legacy
[130.436949] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[130.576634] [061/161] (886s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[130.751882] Starting subtest: addfb25-yf-tiled-legacy
[130.755909] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[130.894748] [062/161] (886s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[131.066725] Starting subtest: addfb25-y-tiled-legacy
[131.068628] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[131.210675] [063/161] (886s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[131.384052] Starting subtest: addfb25-y-tiled-small-legacy
[131.385994] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s)
[131.528577] [064/161] (885s left) kms_addfb_basic (bad-pitch-0)
[131.644655] Starting subtest: bad-pitch-0
[131.645850] Subtest bad-pitch-0: SUCCESS (0.000s)
[131.844595] [065/161] (885s left) kms_addfb_basic (bad-pitch-1024)
[131.956408] Starting subtest: bad-pitch-1024
[131.957682] Subtest bad-pitch-1024: SUCCESS (0.000s)
[132.161417] [066/161] (885s left) kms_addfb_basic (bad-pitch-128)
[132.272823] Starting subtest: bad-pitch-128
[132.274039] Subtest bad-pitch-128: SUCCESS (0.000s)
[132.461074] [067/161] (885s left) kms_addfb_basic (bad-pitch-256)
[132.572412] Starting subtest: bad-pitch-256
[132.573453] Subtest bad-pitch-256: SUCCESS (0.000s)
[132.776908] [068/161] (884s left) kms_addfb_basic (bad-pitch-32)
[132.889196] Starting subtest: bad-pitch-32
[132.890280] Subtest bad-pitch-32: SUCCESS (0.000s)
[133.095502] [069/161] (884s left) kms_addfb_basic (bad-pitch-63)
[133.207045] Starting subtest: bad-pitch-63
[133.208119] Subtest bad-pitch-63: SUCCESS (0.000s)
[133.395759] [070/161] (884s left) kms_addfb_basic (bad-pitch-65536)
[133.513668] Starting subtest: bad-pitch-65536
[133.515617] Subtest bad-pitch-65536: SUCCESS (0.001s)
[133.727730] [071/161] (884s left) kms_addfb_basic (bad-pitch-999)
[133.842869] Starting subtest: bad-pitch-999
[133.844957] Subtest bad-pitch-999: SUCCESS (0.000s)
[134.043568] [072/161] (883s left) kms_addfb_basic (basic)
[134.159459] Starting subtest: basic
[134.161855] Subtest basic: SUCCESS (0.000s)
[134.359907] [073/161] (883s left) kms_addfb_basic (basic-x-tiled-legacy)
[134.476062] Starting subtest: basic-x-tiled-legacy
[134.477127] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[134.678535] [074/161] (883s left) kms_addfb_basic (basic-y-tiled-legacy)
[134.792599] Starting subtest: basic-y-tiled-legacy
[134.794075] Subtest basic-y-tiled-legacy: SUCCESS (0.001s)
[134.996369] [075/161] (883s left) kms_addfb_basic (bo-too-small)
[135.170846] Starting subtest: bo-too-small
[135.172270] Subtest bo-too-small: SUCCESS (0.001s)
[135.311991] [076/161] (883s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[135.489303] Starting subtest: bo-too-small-due-to-tiling
[135.490396] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[135.640524] [077/161] (882s left) kms_addfb_basic (clobberred-modifier)
[135.760303] Starting subtest: clobberred-modifier
[135.761819] Subtest clobberred-modifier: SUCCESS (0.001s)
[136.005409] [078/161] (882s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[136.125905] Starting subtest: framebuffer-vs-set-tiling
[136.126958] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[136.367322] [079/161] (882s left) kms_addfb_basic (invalid-get-prop)
[136.484180] Starting subtest: invalid-get-prop
[136.485210] Subtest invalid-get-prop: SUCCESS (0.000s)
[136.754969] [080/161] (882s left) kms_addfb_basic (invalid-get-prop-any)
[136.887972] Starting subtest: invalid-get-prop-any
[136.890042] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[137.149343] [081/161] (881s left) kms_addfb_basic (invalid-set-prop)
[137.315176] Starting subtest: invalid-set-prop
[137.316341] Subtest invalid-set-prop: SUCCESS (0.003s)
[137.665161] [082/161] (881s left) kms_addfb_basic (invalid-set-prop-any)
[137.797211] Starting subtest: invalid-set-prop-any
[137.798929] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[138.003830] [083/161] (881s left) kms_addfb_basic (no-handle)
[138.149320] Starting subtest: no-handle
[138.153076] Subtest no-handle: SUCCESS (0.000s)
[138.373532] [084/161] (880s left) kms_addfb_basic (size-max)
[138.619223] Starting subtest: size-max
[138.628298] Subtest size-max: SUCCESS (0.006s)
[138.794668] [085/161] (880s left) kms_addfb_basic (small-bo)
[139.015157] Starting subtest: small-bo
[139.016966] Subtest small-bo: SUCCESS (0.000s)
[139.218908] [086/161] (880s left) kms_addfb_basic (tile-pitch-mismatch)
[139.375971] Starting subtest: tile-pitch-mismatch
[139.377150] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[139.669207] [087/161] (880s left) kms_addfb_basic (too-high)
[139.876653] Starting subtest: too-high
[139.877841] Subtest too-high: SUCCESS (0.002s)
[140.102583] [088/161] (879s left) kms_addfb_basic (too-wide)
[140.333293] Starting subtest: too-wide
[140.334643] Subtest too-wide: SUCCESS (0.000s)
[140.555253] [089/161] (879s left) kms_addfb_basic (unused-handle)
[140.687120] Starting subtest: unused-handle
[140.689035] Subtest unused-handle: SUCCESS (0.000s)
[140.927613] [090/161] (879s left) kms_addfb_basic (unused-modifier)
[141.041172] Starting subtest: unused-modifier
[141.042665] Subtest unused-modifier: SUCCESS (0.000s)
[141.259691] [091/161] (878s left) kms_addfb_basic (unused-offsets)
[141.378317] Starting subtest: unused-offsets
[141.380116] Subtest unused-offsets: SUCCESS (0.000s)
[141.595320] [092/161] (878s left) kms_addfb_basic (unused-pitches)
[141.709373] Starting subtest: unused-pitches
[141.710519] Subtest unused-pitches: SUCCESS (0.000s)
[141.927532] [093/161] (878s left) kms_busy (basic)
[142.111870] Starting subtest: basic
[142.115970] Starting dynamic subtest: flip
[142.882328] Dynamic subtest flip: SUCCESS (0.759s)
[142.921529] Starting dynamic subtest: modeset
[144.207185] Dynamic subtest modeset: SUCCESS (1.327s)
[144.211230] Subtest basic: SUCCESS (2.092s)
[144.485852] [094/161] (876s left) kms_prop_blob (basic)
[144.601236] Starting subtest: basic
[144.602456] Subtest basic: SUCCESS (0.000s)
[144.732144] [095/161] (875s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[144.906833] Starting subtest: basic-busy-flip-before-cursor-atomic
[144.910233] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[145.044177] [096/161] (875s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[145.226377] Starting subtest: basic-busy-flip-before-cursor-legacy
[145.228821] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[145.360875] [097/161] (875s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[145.542968] Starting subtest: basic-flip-after-cursor-atomic
[146.655714] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.109s)
[146.868063] [098/161] (873s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[147.050762] Starting subtest: basic-flip-after-cursor-legacy
[148.142721] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.091s)
[148.349114] [099/161] (872s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[148.521794] Starting subtest: basic-flip-after-cursor-varying-size
[149.621397] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.100s)
[149.837733] [100/161] (871s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[150.015585] Starting subtest: basic-flip-before-cursor-atomic
[151.127365] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.108s)
[151.404135] [101/161] (869s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[151.584037] Starting subtest: basic-flip-before-cursor-legacy
[152.686134] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.097s)
[152.916137] [102/161] (868s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[153.092342] Starting subtest: basic-flip-before-cursor-varying-size
[154.188595] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.093s)
[154.413338] [103/161] (866s left) kms_dsc (dsc-basic)
[154.594210] Subtest dsc-basic: SKIP (0.000s)
[154.698204] [104/161] (866s left) kms_flip (basic-flip-vs-dpms)
[154.878177] Starting subtest: basic-flip-vs-dpms
[154.882847] Starting dynamic subtest: A-HDMI-A2
[156.076165] Dynamic subtest A-HDMI-A2: SUCCESS (1.188s)
[156.094052] Starting dynamic subtest: B-HDMI-A2
[157.049922] Dynamic subtest B-HDMI-A2: SUCCESS (0.976s)
[157.071789] Starting dynamic subtest: C-HDMI-A2
[158.042234] Dynamic subtest C-HDMI-A2: SUCCESS (0.982s)
[158.043301] Subtest basic-flip-vs-dpms: SUCCESS (3.163s)
[158.307709] [105/161] (863s left) kms_flip (basic-flip-vs-modeset)
[158.498511] Starting subtest: basic-flip-vs-modeset
[158.503423] Starting dynamic subtest: A-HDMI-A2
[159.763061] Dynamic subtest A-HDMI-A2: SUCCESS (1.249s)
[159.789900] Starting dynamic subtest: B-HDMI-A2
[160.770415] Dynamic subtest B-HDMI-A2: SUCCESS (0.992s)
[160.797239] Starting dynamic subtest: C-HDMI-A2
[161.728105] Dynamic subtest C-HDMI-A2: SUCCESS (0.959s)
[161.729347] Subtest basic-flip-vs-modeset: SUCCESS (3.230s)
[161.976607] [106/161] (859s left) kms_flip (basic-flip-vs-wf_vblank)
[162.166584] Starting subtest: basic-flip-vs-wf_vblank
[162.170911] Starting dynamic subtest: A-HDMI-A2
[163.578285] Dynamic subtest A-HDMI-A2: SUCCESS (1.402s)
[163.596441] Starting dynamic subtest: B-HDMI-A2
[164.924879] Dynamic subtest B-HDMI-A2: SUCCESS (1.346s)
[164.943462] Starting dynamic subtest: C-HDMI-A2
[166.289069] Dynamic subtest C-HDMI-A2: SUCCESS (1.360s)
[166.296925] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.124s)
[166.715674] [107/161] (854s left) kms_flip (basic-plain-flip)
[166.897819] Starting subtest: basic-plain-flip
[166.900579] Starting dynamic subtest: A-HDMI-A2
[168.031133] Dynamic subtest A-HDMI-A2: SUCCESS (1.126s)
[168.049908] Starting dynamic subtest: B-HDMI-A2
[169.077726] Dynamic subtest B-HDMI-A2: SUCCESS (1.043s)
[169.104112] Starting dynamic subtest: C-HDMI-A2
[170.134734] Dynamic subtest C-HDMI-A2: SUCCESS (1.054s)
[170.137295] Subtest basic-plain-flip: SUCCESS (3.240s)
[170.575477] [108/161] (851s left) kms_force_connector_basic (force-connector-state)
[170.782820] Starting subtest: force-connector-state
[171.236319] Subtest force-connector-state: SUCCESS (0.454s)
[171.681171] [109/161] (850s left) kms_force_connector_basic (force-edid)
[171.901152] Starting subtest: force-edid
[171.974620] Subtest force-edid: SUCCESS (0.077s)
[172.297328] [110/161] (849s left) kms_force_connector_basic (force-load-detect)
[172.517233] Starting subtest: force-load-detect
[172.521502] Subtest force-load-detect: SKIP (0.000s)
[172.798618] [111/161] (849s left) kms_force_connector_basic (prune-stale-modes)
[173.024573] Starting subtest: prune-stale-modes
[173.102351] Subtest prune-stale-modes: SUCCESS (0.078s)
[173.432298] [112/161] (848s left) kms_frontbuffer_tracking (basic)
[173.642861] Starting subtest: basic
[176.827192] Subtest basic: SUCCESS (3.181s)
[176.982049] [113/161] (845s left) kms_hdmi_inject (inject-audio)
[177.310811] Starting subtest: inject-audio
[177.529614] Subtest inject-audio: SUCCESS (0.217s)
[177.948670] [114/161] (844s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[178.125317] Starting subtest: compare-crc-sanitycheck-xr24
[178.135124] Starting dynamic subtest: pipe-A-HDMI-A-2
[178.759149] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.585s)
[178.805888] Starting dynamic subtest: pipe-B-HDMI-A-2
[179.304909] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.578s)
[179.323493] Starting dynamic subtest: pipe-C-HDMI-A-2
[179.883618] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.575s)
[179.884776] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.756s)
[180.109085] [115/161] (842s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[180.288825] Starting subtest: compare-crc-sanitycheck-nv12
[180.294409] Starting dynamic subtest: pipe-A-HDMI-A-2
[180.974126] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.675s)
[181.002967] Starting dynamic subtest: pipe-B-HDMI-A-2
[181.692136] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.698s)
[181.721279] Starting dynamic subtest: pipe-C-HDMI-A-2
[182.347946] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.666s)
[182.356471] Subtest compare-crc-sanitycheck-nv12: SUCCESS (2.061s)
[182.586542] [116/161] (839s left) kms_pipe_crc_basic (hang-read-crc)
[182.776290] Starting subtest: hang-read-crc
[182.777395] Starting dynamic subtest: pipe-A-HDMI-A-2
[184.169904] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.390s)
[184.195326] Starting dynamic subtest: pipe-B-HDMI-A-2
[185.532331] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.356s)
[185.563029] Starting dynamic subtest: pipe-C-HDMI-A-2
[186.875935] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.337s)
[186.877150] Subtest hang-read-crc: SUCCESS (4.101s)
[187.094131] [117/161] (835s left) kms_pipe_crc_basic (nonblocking-crc)
[187.286704] Starting subtest: nonblocking-crc
[187.287879] Starting dynamic subtest: pipe-A-HDMI-A-2
[188.051872] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.763s)
[188.079069] Starting dynamic subtest: pipe-B-HDMI-A-2
[188.821486] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.757s)
[188.842346] Starting dynamic subtest: pipe-C-HDMI-A-2
[189.564125] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.737s)
[189.566180] Subtest nonblocking-crc: SUCCESS (2.282s)
[189.786914] [118/161] (832s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[189.968669] Starting subtest: nonblocking-crc-frame-sequence
[189.973915] Starting dynamic subtest: pipe-A-HDMI-A-2
[190.732057] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.755s)
[190.753367] Starting dynamic subtest: pipe-B-HDMI-A-2
[191.484793] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.749s)
[191.520892] Starting dynamic subtest: pipe-C-HDMI-A-2
[192.213166] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.720s)
[192.214274] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.243s)
[192.429682] [119/161] (830s left) kms_pipe_crc_basic (read-crc)
[192.601433] Starting subtest: read-crc
[192.610447] Starting dynamic subtest: pipe-A-HDMI-A-2
[193.322293] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.711s)
[193.347957] Starting dynamic subtest: pipe-B-HDMI-A-2
[194.002854] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.665s)
[194.030697] Starting dynamic subtest: pipe-C-HDMI-A-2
[194.669392] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.658s)
[194.670945] Subtest read-crc: SUCCESS (2.066s)
[194.893897] [120/161] (828s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[195.081422] Starting subtest: read-crc-frame-sequence
[195.083828] Starting dynamic subtest: pipe-A-HDMI-A-2
[195.796435] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.708s)
[195.818456] Starting dynamic subtest: pipe-B-HDMI-A-2
[196.494672] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.694s)
[196.526504] Starting dynamic subtest: pipe-C-HDMI-A-2
[197.171596] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.667s)
[197.173634] Subtest read-crc-frame-sequence: SUCCESS (2.094s)
[197.387265] [121/161] (825s left) kms_pm_backlight (basic-brightness)
[197.575834] Subtest basic-brightness: SKIP (0.000s)
[197.673644] [122/161] (825s left) kms_pm_rpm (basic-pci-d3-state)
[199.380419] Starting subtest: basic-pci-d3-state
[199.708949] Subtest basic-pci-d3-state: SUCCESS (0.328s)
[199.898994] [123/161] (823s left) kms_pm_rpm (basic-rte)
[200.009586] Starting subtest: basic-rte
[201.914290] Subtest basic-rte: SUCCESS (1.902s)
[202.629137] [124/161] (820s left) kms_psr (psr-primary-page-flip)
[202.808946] Subtest psr-primary-page-flip: SKIP (0.000s)
[202.915543] [125/161] (820s left) kms_psr (psr-cursor-plane-move)
[203.096575] Subtest psr-cursor-plane-move: SKIP (0.000s)
[203.216220] [126/161] (820s left) kms_psr (psr-sprite-plane-onoff)
[203.404774] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[203.516070] [127/161] (820s left) kms_psr (psr-primary-mmap-gtt)
[203.702378] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[203.814835] [128/161] (819s left) kms_setmode (basic-clone-single-crtc)
[203.933247] Starting subtest: basic-clone-single-crtc
[203.938158] Subtest basic-clone-single-crtc: SKIP (0.000s)
[204.084940] [129/161] (819s left) i915_pm_rps (basic-api)
[204.212608] Starting subtest: basic-api
[204.222845] Subtest basic-api: SUCCESS (0.010s)
[204.370205] [130/161] (819s left) prime_self_import (basic-llseek-bad)
[204.485143] Starting subtest: basic-llseek-bad
[204.493152] Subtest basic-llseek-bad: SUCCESS (0.007s)
[204.642570] [131/161] (819s left) prime_self_import (basic-llseek-size)
[204.754471] Starting subtest: basic-llseek-size
[204.762290] Subtest basic-llseek-size: SUCCESS (0.007s)
[204.898452] [132/161] (819s left) prime_self_import (basic-with_fd_dup)
[205.010138] Starting subtest: basic-with_fd_dup
[205.017344] Subtest basic-with_fd_dup: SUCCESS (0.006s)
[205.168970] [133/161] (818s left) prime_self_import (basic-with_one_bo)
[205.280970] Starting subtest: basic-with_one_bo
[205.291551] Subtest basic-with_one_bo: SUCCESS (0.009s)
[205.435374] [134/161] (818s left) prime_self_import (basic-with_one_bo_two_files)
[205.540900] Starting subtest: basic-with_one_bo_two_files
[205.554273] Subtest basic-with_one_bo_two_files: SUCCESS (0.011s)
[205.701538] [135/161] (818s left) prime_self_import (basic-with_two_bos)
[205.815290] Starting subtest: basic-with_two_bos
[205.821380] Subtest basic-with_two_bos: SUCCESS (0.009s)
[205.970791] [136/161] (818s left) prime_vgem (basic-fence-flip)
[206.113163] Starting subtest: basic-fence-flip
[206.625363] Subtest basic-fence-flip: SUCCESS (0.512s)
[206.801299] [137/161] (817s left) prime_vgem (basic-fence-mmap)
[206.937987] Starting subtest: basic-fence-mmap
[207.006218] Subtest basic-fence-mmap: SUCCESS (0.065s)
[207.151989] [138/161] (817s left) prime_vgem (basic-fence-read)
[207.293198] Starting subtest: basic-fence-read
[207.417746] Subtest basic-fence-read: SUCCESS (0.124s)
[207.568852] [139/161] (817s left) prime_vgem (basic-gtt)
[207.707517] Starting subtest: basic-gtt
[207.735201] Subtest basic-gtt: SUCCESS (0.029s)
[207.909043] [140/161] (816s left) prime_vgem (basic-read)
[208.043128] Starting subtest: basic-read
[208.101947] Subtest basic-read: SUCCESS (0.059s)
[208.259483] [141/161] (816s left) prime_vgem (basic-write)
[208.406722] Starting subtest: basic-write
[208.485848] Subtest basic-write: SUCCESS (0.078s)
[208.640136] [142/161] (816s left) vgem_basic (setversion)
[208.760083] Starting subtest: setversion
[208.762255] Subtest setversion: SUCCESS (0.000s)
[208.889870] [143/161] (816s left) vgem_basic (create)
[209.011966] Starting subtest: create
[209.013881] Subtest create: SUCCESS (0.001s)
[209.137124] [144/161] (816s left) vgem_basic (debugfs)
[209.264877] Starting subtest: debugfs
[209.266241] Subtest debugfs: SUCCESS (0.002s)
[209.383925] [145/161] (815s left) vgem_basic (dmabuf-export)
[209.515073] Starting subtest: dmabuf-export
[209.517422] Subtest dmabuf-export: SUCCESS (0.006s)
[209.681812] [146/161] (815s left) vgem_basic (dmabuf-fence)
[209.810157] Starting subtest: dmabuf-fence
[209.818565] Subtest dmabuf-fence: SUCCESS (0.002s)
[209.935153] [147/161] (815s left) vgem_basic (dmabuf-fence-before)
[210.064103] Starting subtest: dmabuf-fence-before
[210.065897] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[210.184208] [148/161] (815s left) vgem_basic (dmabuf-mmap)
[210.310427] Starting subtest: dmabuf-mmap
[210.338635] Subtest dmabuf-mmap: SUCCESS (0.030s)
[210.471385] [149/161] (815s left) vgem_basic (mmap)
[210.592226] Starting subtest: mmap
[210.610243] Subtest mmap: SUCCESS (0.019s)
[210.732574] [150/161] (815s left) vgem_basic (second-client)
[210.860888] Starting subtest: second-client
[210.892333] Subtest second-client: SUCCESS (0.031s)
[211.016334] [151/161] (814s left) vgem_basic (sysfs)
[211.145061] Starting subtest: sysfs
[211.146333] Subtest sysfs: SUCCESS (0.001s)
[211.272568] [152/161] (814s left) core_hotunplug (unbind-rebind)
[211.511284] Starting subtest: unbind-rebind
[215.307726] Subtest unbind-rebind: SUCCESS (3.793s)
[215.401850] [153/161] (810s left) vgem_basic (unload)
[215.517712] Starting subtest: unload
[244.492428] Subtest unload: SUCCESS (28.971s)
[244.685960] [154/161] (781s left) i915_module_load (reload)
[244.797197] Starting subtest: reload
[248.814871] Subtest reload: SUCCESS (4.001s)
[249.038088] [155/161] (777s left) gem_lmem_swapping (basic)
[249.382996] Subtest basic: SKIP (0.000s)
[249.519048] [156/161] (777s left) gem_lmem_swapping (parallel-random-engines)
[249.642431] Subtest parallel-random-engines: SKIP (0.000s)
[249.745236] [157/161] (776s left) gem_lmem_swapping (random-engines)
[249.866100] Subtest random-engines: SKIP (0.000s)
[249.981598] [158/161] (776s left) gem_lmem_swapping (verify-random)
[250.106446] Subtest verify-random: SKIP (0.000s)
[250.208612] [159/161] (776s left) i915_pm_rpm (module-reload)
[252.057897] Starting subtest: module-reload
[262.779482] Subtest module-reload: SUCCESS (10.721s)
[262.844609] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[262.847554] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[262.852950] [160/161] (764s left) i915_selftest (live)
[262.977352] Starting subtest: live
[262.978640] Starting dynamic subtest: sanitycheck
[267.347300] Dynamic subtest sanitycheck: SUCCESS (4.367s)
[267.363833] Starting dynamic subtest: uncore
[269.573202] Dynamic subtest uncore: SUCCESS (2.220s)
[269.612222] Starting dynamic subtest: workarounds
[272.068874] Dynamic subtest workarounds: SUCCESS (2.494s)
[272.085479] Starting dynamic subtest: gt_engines
[274.692136] Dynamic subtest gt_engines: SUCCESS (2.618s)
[274.710894] Starting dynamic subtest: gt_timelines
[288.167054] Dynamic subtest gt_timelines: SUCCESS (13.471s)
[288.187960] Starting dynamic subtest: gt_contexts
[290.362144] Dynamic subtest gt_contexts: SUCCESS (2.190s)
[290.382893] Starting dynamic subtest: gt_lrc
[295.041283] Dynamic subtest gt_lrc: SUCCESS (4.678s)
[295.089025] Starting dynamic subtest: gt_mocs
[297.329170] Dynamic subtest gt_mocs: SUCCESS (2.281s)
[297.356050] Starting dynamic subtest: gt_pm
[308.970276] Dynamic subtest gt_pm: SUCCESS (11.639s)
[308.986505] Starting dynamic subtest: gt_heartbeat
[311.210064] Dynamic subtest gt_heartbeat: SUCCESS (2.237s)
[311.236835] Starting dynamic subtest: gt_tlb
[314.116612] Dynamic subtest gt_tlb: SUCCESS (2.903s)
[314.132978] Starting dynamic subtest: requests
[322.685798] Dynamic subtest requests: SUCCESS (8.566s)
[322.704319] Starting dynamic subtest: migrate
[327.841963] Dynamic subtest migrate: SUCCESS (5.151s)
[327.858698] Starting dynamic subtest: active
[330.003649] Dynamic subtest active: SUCCESS (2.154s)
[330.031144] Starting dynamic subtest: objects
[334.055637] Dynamic subtest objects: SUCCESS (4.051s)
[334.081042] Starting dynamic subtest: mman
[341.782522] Dynamic subtest mman: SUCCESS (7.725s)
[341.798393] Starting dynamic subtest: dmabuf
[344.096863] Dynamic subtest dmabuf: SUCCESS (2.310s)
[344.113385] Starting dynamic subtest: vma
[346.247600] Dynamic subtest vma: SUCCESS (2.147s)
[346.263872] Starting dynamic subtest: coherency
[354.761129] Dynamic subtest coherency: SUCCESS (8.508s)
[354.792131] Starting dynamic subtest: gtt
[364.930585] Dynamic subtest gtt: SUCCESS (10.167s)
[364.947160] Starting dynamic subtest: gem
[367.804784] Dynamic subtest gem: SUCCESS (2.870s)
[367.824071] Starting dynamic subtest: evict
[372.412721] Dynamic subtest evict: SUCCESS (4.603s)
[372.428578] Starting dynamic subtest: hugepages
[381.136094] Dynamic subtest hugepages: SUCCESS (8.721s)
[381.155377] Starting dynamic subtest: gem_contexts
[399.868912] Dynamic subtest gem_contexts: SUCCESS (18.727s)
[399.885118] Starting dynamic subtest: client
[404.356191] Dynamic subtest client: SUCCESS (4.485s)
[404.373525] Starting dynamic subtest: gem_migrate
[406.506282] Dynamic subtest gem_migrate: SUCCESS (2.146s)
[406.524096] Starting dynamic subtest: reset
[412.466075] Dynamic subtest reset: SUCCESS (5.955s)
[412.496128] Starting dynamic subtest: memory_region
[414.583645] Dynamic subtest memory_region: SUCCESS (2.114s)
[414.605186] Starting dynamic subtest: hangcheck
[439.879864] Dynamic subtest hangcheck: SUCCESS (25.294s)
[439.896401] Starting dynamic subtest: execlists
[451.226214] Dynamic subtest execlists: SUCCESS (11.342s)
[451.255085] Starting dynamic subtest: ring_submission
[453.681332] Dynamic subtest ring_submission: SUCCESS (2.452s)
[453.698391] Starting dynamic subtest: perf
[456.039777] Dynamic subtest perf: SUCCESS (2.354s)
[456.056311] Starting dynamic subtest: slpc
[458.184717] Dynamic subtest slpc: SUCCESS (2.138s)
[458.210181] Starting dynamic subtest: guc
[460.395045] Dynamic subtest guc: SUCCESS (2.211s)
[460.411835] Starting dynamic subtest: guc_multi_lrc
[462.527251] Dynamic subtest guc_multi_lrc: SUCCESS (2.128s)
[462.543547] Starting dynamic subtest: guc_hang
[464.825837] Dynamic subtest guc_hang: SUCCESS (2.296s)
[464.843063] Starting dynamic subtest: late_gt_pm
[467.061720] Dynamic subtest late_gt_pm: SUCCESS (2.231s)
[467.062818] Subtest live: SUCCESS (204.079s)
[467.144330] [161/161] (559s left) dmabuf (all-tests)
[467.267053] Starting subtest: all-tests
[467.268867] Starting dynamic subtest: sanitycheck
[467.330100] Dynamic subtest sanitycheck: SUCCESS (0.063s)
[467.347225] Starting dynamic subtest: dma_fence
[467.531926] Dynamic subtest dma_fence: SUCCESS (0.198s)
[467.550863] Starting dynamic subtest: dma_fence_chain
[481.788644] Dynamic subtest dma_fence_chain: SUCCESS (14.252s)
[481.803811] Starting dynamic subtest: dma_fence_unwrap
[481.859234] Dynamic subtest dma_fence_unwrap: SUCCESS (0.068s)
[481.877888] Starting dynamic subtest: dma_resv
[481.936612] Dynamic subtest dma_resv: SUCCESS (0.073s)
[481.941927] Subtest all-tests: SUCCESS (14.675s)
[482.007714] Closing watchdogs
Done.