[46.655703] Initializing watchdogs
[46.655913]   /dev/watchdog0
[46.690031] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[46.702460] [001/161] (960s left) i915_module_load (load)
[47.156995] Starting subtest: load
[109.156161] Subtest load: SUCCESS (62.396s)
[109.266451] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[109.272429] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[109.296745] [002/161] (897s left) core_auth (basic-auth)
[109.609204] Starting subtest: basic-auth
[109.610209] Subtest basic-auth: SUCCESS (0.001s)
[109.760565] [003/161] (897s left) debugfs_test (read_all_entries)
[109.891301] Starting subtest: read_all_entries
[110.044187] Subtest read_all_entries: SUCCESS (0.152s)
[110.230725] [004/161] (896s left) debugfs_test (basic-hwmon)
[110.358172] Starting subtest: basic-hwmon
[110.360284] Subtest basic-hwmon: SKIP (0.000s)
[110.555463] [005/161] (896s left) debugfs_test (sysfs)
[110.684640] Starting subtest: sysfs
[110.787079] Subtest sysfs: SUCCESS (0.098s)
[110.962367] [006/161] (896s left) fbdev (eof)
[111.097630] Starting subtest: eof
[111.098788] Subtest eof: SUCCESS (0.001s)
[111.207446] [007/161] (896s left) fbdev (info)
[111.318260] Starting subtest: info
[111.319270] Subtest info: SUCCESS (0.000s)
[111.436923] [008/161] (896s left) fbdev (nullptr)
[111.558416] Starting subtest: nullptr
[111.559537] Subtest nullptr: SUCCESS (0.000s)
[111.669102] [009/161] (895s left) fbdev (read)
[111.793228] Starting subtest: read
[113.364393] Subtest read: SUCCESS (1.569s)
[113.474932] [010/161] (894s left) fbdev (write)
[113.594131] Starting subtest: write
[114.390656] Subtest write: SUCCESS (0.795s)
[114.508135] [011/161] (893s left) gem_basic (bad-close)
[114.621531] Starting subtest: bad-close
[114.624091] Subtest bad-close: SUCCESS (0.000s)
[114.740311] [012/161] (893s left) gem_basic (create-close)
[114.855283] Starting subtest: create-close
[114.857644] Subtest create-close: SUCCESS (0.000s)
[114.990513] [013/161] (892s left) gem_basic (create-fd-close)
[115.103793] Starting subtest: create-fd-close
[115.106240] Subtest create-fd-close: SUCCESS (0.000s)
[115.241305] [014/161] (892s left) gem_busy (busy@all-engines)
[115.384181] Starting subtest: busy
[115.385387] Starting dynamic subtest: all-engines
[115.479770] Dynamic subtest all-engines: SUCCESS (0.095s)
[115.481291] Subtest busy: SUCCESS (0.095s)
[115.889252] [015/161] (892s left) gem_close_race (basic-process)
[116.039236] Starting subtest: basic-process
[116.121161] Subtest basic-process: SUCCESS (0.084s)
[116.358897] [016/161] (891s left) gem_close_race (basic-threads)
[116.501333] Starting subtest: basic-threads
[117.655084] Subtest basic-threads: SUCCESS (1.152s)
[117.895825] [017/161] (890s left) gem_ctx_create (basic)
[118.033428] Starting subtest: basic
[118.034561] Subtest basic: SUCCESS (0.001s)
[118.280908] [018/161] (890s left) gem_ctx_create (basic-files)
[118.422555] Starting subtest: basic-files
[120.458776] Subtest basic-files: SUCCESS (2.034s)
[120.716947] [019/161] (887s left) gem_ctx_exec (basic)
[120.838264] Starting subtest: basic
[120.845555] Subtest basic: SUCCESS (0.007s)
[120.989344] [020/161] (887s left) gem_exec_basic (basic)
[121.120785] Starting subtest: basic
[121.124040] Starting dynamic subtest: rcs0-smem
[121.125132] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[121.141349] Starting dynamic subtest: bcs0-smem
[121.142545] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[121.157619] Starting dynamic subtest: vcs0-smem
[121.159389] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[121.183472] Starting dynamic subtest: vecs0-smem
[121.184889] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[121.186403] Subtest basic: SUCCESS (0.009s)
[121.402413] [021/161] (887s left) gem_exec_create (basic)
[121.539452] Starting subtest: basic
[121.540871] Starting dynamic subtest: smem
[123.603844] Dynamic subtest smem: SUCCESS (2.063s)
[123.606036] Subtest basic: SUCCESS (2.064s)
[123.851744] [022/161] (884s left) gem_exec_fence (basic-busy)
[124.124564] Starting subtest: basic-busy
[124.126269] Starting dynamic subtest: rcs0
[124.143369] Dynamic subtest rcs0: SUCCESS (0.022s)
[124.158637] Starting dynamic subtest: bcs0
[124.168306] Dynamic subtest bcs0: SUCCESS (0.025s)
[124.184596] Starting dynamic subtest: vcs0
[124.197368] Dynamic subtest vcs0: SUCCESS (0.029s)
[124.215239] Starting dynamic subtest: vecs0
[124.223387] Dynamic subtest vecs0: SUCCESS (0.025s)
[124.224600] Subtest basic-busy: SUCCESS (0.103s)
[124.958802] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[124.964121] [023/161] (883s left) gem_exec_fence (basic-wait)
[125.235053] Starting subtest: basic-wait
[125.236554] Starting dynamic subtest: rcs0
[125.250284] Dynamic subtest rcs0: SUCCESS (0.016s)
[125.266437] Starting dynamic subtest: bcs0
[125.271966] Dynamic subtest bcs0: SUCCESS (0.022s)
[125.291236] Starting dynamic subtest: vcs0
[125.292411] Dynamic subtest vcs0: SUCCESS (0.017s)
[125.308621] Starting dynamic subtest: vecs0
[125.309882] Dynamic subtest vecs0: SUCCESS (0.018s)
[125.311117] Subtest basic-wait: SUCCESS (0.076s)
[125.968173] [024/161] (882s left) gem_exec_fence (basic-await)
[126.242159] Starting subtest: basic-await
[126.243274] Starting dynamic subtest: rcs0
[126.367496] Dynamic subtest rcs0: SUCCESS (0.124s)
[126.384590] Starting dynamic subtest: bcs0
[126.495186] Dynamic subtest bcs0: SUCCESS (0.127s)
[126.514036] Starting dynamic subtest: vcs0
[126.628362] Dynamic subtest vcs0: SUCCESS (0.128s)
[126.644790] Starting dynamic subtest: vecs0
[126.751933] Dynamic subtest vecs0: SUCCESS (0.127s)
[126.753151] Subtest basic-await: SUCCESS (0.510s)
[127.424755] [025/161] (881s left) gem_exec_fence (nb-await)
[127.718143] Starting subtest: nb-await
[127.720731] Starting dynamic subtest: rcs0
[127.784070] Dynamic subtest rcs0: SUCCESS (0.069s)
[127.800668] Starting dynamic subtest: bcs0
[127.852919] Dynamic subtest bcs0: SUCCESS (0.066s)
[127.868813] Starting dynamic subtest: vcs0
[127.922259] Dynamic subtest vcs0: SUCCESS (0.067s)
[127.937933] Starting dynamic subtest: vecs0
[127.985747] Dynamic subtest vecs0: SUCCESS (0.065s)
[127.987681] Subtest nb-await: SUCCESS (0.273s)
[128.657153] [026/161] (880s left) gem_exec_gttfill (basic)
[128.798168] Starting subtest: basic
[145.422176] Subtest basic: SUCCESS (16.621s)
[145.676100] [027/161] (863s left) gem_exec_parallel (engines)
[145.925268] Starting subtest: engines
[145.926621] Starting dynamic subtest: basic
[149.942322] Dynamic subtest basic: SUCCESS (4.018s)
[149.960515] Starting dynamic subtest: contexts
[160.114579] Dynamic subtest contexts: SUCCESS (10.169s)
[160.132673] Starting dynamic subtest: fds
[169.878355] Dynamic subtest fds: SUCCESS (9.761s)
[169.896709] Starting dynamic subtest: userptr
[173.037586] Dynamic subtest userptr: SUCCESS (3.161s)
[173.038837] Subtest engines: SUCCESS (27.112s)
[173.300794] [028/161] (835s left) gem_exec_store (basic)
[173.445637] Starting subtest: basic
[173.498952] Subtest basic: SUCCESS (0.053s)
[173.755812] [029/161] (835s left) gem_flink_basic (bad-flink)
[173.866615] Starting subtest: bad-flink
[173.867860] Subtest bad-flink: SUCCESS (0.000s)
[174.010627] [030/161] (835s left) gem_flink_basic (bad-open)
[174.123352] Starting subtest: bad-open
[174.124914] Subtest bad-open: SUCCESS (0.000s)
[174.269813] [031/161] (835s left) gem_flink_basic (basic)
[174.380483] Starting subtest: basic
[174.381859] Subtest basic: SUCCESS (0.000s)
[174.532239] [032/161] (835s left) gem_flink_basic (double-flink)
[174.641458] Starting subtest: double-flink
[174.642938] Subtest double-flink: SUCCESS (0.000s)
[174.784800] [033/161] (834s left) gem_flink_basic (flink-lifetime)
[174.895154] Starting subtest: flink-lifetime
[174.896338] Subtest flink-lifetime: SUCCESS (0.002s)
[175.040700] [034/161] (834s left) gem_huc_copy (huc-copy)
[175.164418] Starting subtest: huc-copy
[175.167529] Subtest huc-copy: SKIP (0.000s)
[175.333166] [035/161] (834s left) gem_linear_blits (basic)
[175.593864] Starting subtest: basic
[175.614146] Subtest basic: SUCCESS (0.020s)
[175.828837] [036/161] (834s left) gem_mmap (basic)
[176.098612] Starting subtest: basic
[176.105691] Subtest basic: SUCCESS (0.001s)
[176.232561] [037/161] (833s left) gem_mmap_gtt (basic)
[176.346823] Starting subtest: basic
[176.350436] Subtest basic: SUCCESS (0.001s)
[176.461662] [038/161] (833s left) gem_render_linear_blits (basic)
[176.587204] Starting subtest: basic
[176.660617] Subtest basic: SUCCESS (0.073s)
[176.769224] [039/161] (833s left) gem_render_tiled_blits (basic)
[176.887644] Starting subtest: basic
[176.990047] Subtest basic: SUCCESS (0.098s)
[177.098885] [040/161] (833s left) gem_ringfill (basic-all)
[177.454312] Starting subtest: basic-all
[178.662998] Subtest basic-all: SUCCESS (1.208s)
[178.830989] [041/161] (831s left) gem_softpin (allocator-basic)
[178.951798] Starting subtest: allocator-basic
[179.165402] Subtest allocator-basic: SUCCESS (0.201s)
[179.329749] [042/161] (831s left) gem_softpin (allocator-basic-reserve)
[179.449970] Starting subtest: allocator-basic-reserve
[179.660969] Subtest allocator-basic-reserve: SUCCESS (0.194s)
[179.817225] [043/161] (830s left) gem_softpin (safe-alignment)
[179.943790] Starting subtest: safe-alignment
[179.967233] Subtest safe-alignment: SUCCESS (0.023s)
[180.116206] [044/161] (830s left) gem_sync (basic-all)
[180.254641] Starting subtest: basic-all
[182.399018] Subtest basic-all: SUCCESS (2.143s)
[182.651915] [045/161] (828s left) gem_sync (basic-each)
[182.792900] Starting subtest: basic-each
[185.190120] Subtest basic-each: SUCCESS (2.397s)
[185.448470] [046/161] (825s left) gem_tiled_blits (basic)
[185.668958] Starting subtest: basic
[185.711788] Subtest basic: SUCCESS (0.043s)
[185.932115] [047/161] (825s left) gem_tiled_fence_blits (basic)
[186.327245] Starting subtest: basic
[186.365766] Subtest basic: SUCCESS (0.037s)
[186.566914] [048/161] (824s left) gem_tiled_pread_basic
[187.220305] [049/161] (824s left) gem_wait (busy@all-engines)
[187.374108] Starting subtest: busy
[187.376057] Starting dynamic subtest: all-engines
[187.894253] Dynamic subtest all-engines: SUCCESS (0.519s)
[187.895297] Subtest busy: SUCCESS (0.520s)
[188.183866] [050/161] (823s left) gem_wait (wait@all-engines)
[188.337041] Starting subtest: wait
[188.338415] Starting dynamic subtest: all-engines
[189.373666] Dynamic subtest all-engines: SUCCESS (1.034s)
[189.374912] Subtest wait: SUCCESS (1.035s)
[189.666956] [051/161] (821s left) i915_getparams_basic (basic-eu-total)
[189.777772] Starting subtest: basic-eu-total
[189.780222] Subtest basic-eu-total: SUCCESS (0.000s)
[189.912059] [052/161] (821s left) i915_getparams_basic (basic-subslice-total)
[190.021745] Starting subtest: basic-subslice-total
[190.025500] Subtest basic-subslice-total: SUCCESS (0.000s)
[190.166624] [053/161] (821s left) i915_hangman (error-state-basic)
[190.301223] Starting subtest: error-state-basic
[190.321268] Subtest error-state-basic: SUCCESS (0.020s)
[190.478212] [054/161] (821s left) i915_pciid
[190.737483] [055/161] (821s left) kms_addfb_basic (addfb25-4-tiled)
[190.924964] Starting subtest: addfb25-4-tiled
[190.927698] Subtest addfb25-4-tiled: SUCCESS (0.001s)
[191.056703] [056/161] (820s left) kms_addfb_basic (addfb25-bad-modifier)
[191.234507] Starting subtest: addfb25-bad-modifier
[191.235572] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[191.373869] [057/161] (820s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[191.549952] Starting subtest: addfb25-framebuffer-vs-set-tiling
[191.551338] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[191.690910] [058/161] (820s left) kms_addfb_basic (addfb25-modifier-no-flag)
[191.871134] Starting subtest: addfb25-modifier-no-flag
[191.872946] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[192.022938] [059/161] (820s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[192.202634] Starting subtest: addfb25-x-tiled-legacy
[192.204164] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[192.339332] [060/161] (819s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[192.518027] Starting subtest: addfb25-x-tiled-mismatch-legacy
[192.520141] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[192.656376] [061/161] (819s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[192.829373] Starting subtest: addfb25-yf-tiled-legacy
[192.830562] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.001s)
[192.972525] [062/161] (819s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[193.145560] Starting subtest: addfb25-y-tiled-legacy
[193.146773] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[193.290966] [063/161] (819s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[193.469614] Starting subtest: addfb25-y-tiled-small-legacy
[193.470827] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s)
[193.607900] [064/161] (819s left) kms_addfb_basic (bad-pitch-0)
[193.720411] Starting subtest: bad-pitch-0
[193.721432] Subtest bad-pitch-0: SUCCESS (0.000s)
[193.924090] [065/161] (818s left) kms_addfb_basic (bad-pitch-1024)
[194.039825] Starting subtest: bad-pitch-1024
[194.041168] Subtest bad-pitch-1024: SUCCESS (0.000s)
[194.238504] [066/161] (818s left) kms_addfb_basic (bad-pitch-128)
[194.355302] Starting subtest: bad-pitch-128
[194.356363] Subtest bad-pitch-128: SUCCESS (0.000s)
[194.555235] [067/161] (818s left) kms_addfb_basic (bad-pitch-256)
[194.668797] Starting subtest: bad-pitch-256
[194.669993] Subtest bad-pitch-256: SUCCESS (0.000s)
[194.889266] [068/161] (818s left) kms_addfb_basic (bad-pitch-32)
[195.002573] Starting subtest: bad-pitch-32
[195.003652] Subtest bad-pitch-32: SUCCESS (0.000s)
[195.207410] [069/161] (817s left) kms_addfb_basic (bad-pitch-63)
[195.323623] Starting subtest: bad-pitch-63
[195.325867] Subtest bad-pitch-63: SUCCESS (0.000s)
[195.540975] [070/161] (817s left) kms_addfb_basic (bad-pitch-65536)
[195.653534] Starting subtest: bad-pitch-65536
[195.654717] Subtest bad-pitch-65536: SUCCESS (0.000s)
[195.856886] [071/161] (817s left) kms_addfb_basic (bad-pitch-999)
[195.971190] Starting subtest: bad-pitch-999
[195.972310] Subtest bad-pitch-999: SUCCESS (0.000s)
[196.172728] [072/161] (817s left) kms_addfb_basic (basic)
[196.283462] Starting subtest: basic
[196.284458] Subtest basic: SUCCESS (0.000s)
[196.489268] [073/161] (816s left) kms_addfb_basic (basic-x-tiled-legacy)
[196.607140] Starting subtest: basic-x-tiled-legacy
[196.608281] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[196.806792] [074/161] (816s left) kms_addfb_basic (basic-y-tiled-legacy)
[196.919373] Starting subtest: basic-y-tiled-legacy
[196.920696] Subtest basic-y-tiled-legacy: SUCCESS (0.001s)
[197.124448] [075/161] (816s left) kms_addfb_basic (bo-too-small)
[197.303797] Starting subtest: bo-too-small
[197.306520] Subtest bo-too-small: SUCCESS (0.002s)
[197.439188] [076/161] (816s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[197.624906] Starting subtest: bo-too-small-due-to-tiling
[197.627386] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[197.755964] [077/161] (816s left) kms_addfb_basic (clobberred-modifier)
[197.866257] Starting subtest: clobberred-modifier
[197.869152] Subtest clobberred-modifier: SUCCESS (0.000s)
[198.072160] [078/161] (815s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[198.186405] Starting subtest: framebuffer-vs-set-tiling
[198.188056] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[198.406091] [079/161] (815s left) kms_addfb_basic (invalid-get-prop)
[198.521555] Starting subtest: invalid-get-prop
[198.522646] Subtest invalid-get-prop: SUCCESS (0.000s)
[198.722652] [080/161] (815s left) kms_addfb_basic (invalid-get-prop-any)
[198.836692] Starting subtest: invalid-get-prop-any
[198.838822] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[199.040744] [081/161] (815s left) kms_addfb_basic (invalid-set-prop)
[199.153102] Starting subtest: invalid-set-prop
[199.154263] Subtest invalid-set-prop: SUCCESS (0.000s)
[199.355883] [082/161] (814s left) kms_addfb_basic (invalid-set-prop-any)
[199.472551] Starting subtest: invalid-set-prop-any
[199.474220] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[199.689395] [083/161] (814s left) kms_addfb_basic (no-handle)
[199.802973] Starting subtest: no-handle
[199.804211] Subtest no-handle: SUCCESS (0.000s)
[200.024043] [084/161] (814s left) kms_addfb_basic (size-max)
[200.205131] Starting subtest: size-max
[200.207471] Subtest size-max: SUCCESS (0.000s)
[200.339876] [085/161] (814s left) kms_addfb_basic (small-bo)
[200.518954] Starting subtest: small-bo
[200.520284] Subtest small-bo: SUCCESS (0.000s)
[200.656760] [086/161] (813s left) kms_addfb_basic (tile-pitch-mismatch)
[200.769432] Starting subtest: tile-pitch-mismatch
[200.771134] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[200.975273] [087/161] (813s left) kms_addfb_basic (too-high)
[201.153954] Starting subtest: too-high
[201.155182] Subtest too-high: SUCCESS (0.002s)
[201.288759] [088/161] (813s left) kms_addfb_basic (too-wide)
[201.463233] Starting subtest: too-wide
[201.465367] Subtest too-wide: SUCCESS (0.000s)
[201.606144] [089/161] (813s left) kms_addfb_basic (unused-handle)
[201.716420] Starting subtest: unused-handle
[201.718419] Subtest unused-handle: SUCCESS (0.000s)
[201.923209] [090/161] (813s left) kms_addfb_basic (unused-modifier)
[202.040761] Starting subtest: unused-modifier
[202.041893] Subtest unused-modifier: SUCCESS (0.000s)
[202.239776] [091/161] (812s left) kms_addfb_basic (unused-offsets)
[202.353278] Starting subtest: unused-offsets
[202.355071] Subtest unused-offsets: SUCCESS (0.000s)
[202.556722] [092/161] (812s left) kms_addfb_basic (unused-pitches)
[202.677299] Starting subtest: unused-pitches
[202.681542] Subtest unused-pitches: SUCCESS (0.000s)
[202.907859] [093/161] (812s left) kms_busy (basic)
[203.092913] Starting subtest: basic
[203.094022] Starting dynamic subtest: flip
[203.883503] Dynamic subtest flip: SUCCESS (0.781s)
[203.912230] Starting dynamic subtest: modeset
[205.150110] Dynamic subtest modeset: SUCCESS (1.262s)
[205.154854] Subtest basic: SUCCESS (2.047s)
[205.437750] [094/161] (809s left) kms_prop_blob (basic)
[205.556824] Starting subtest: basic
[205.558955] Subtest basic: SUCCESS (0.000s)
[205.709107] [095/161] (809s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[205.891063] Starting subtest: basic-busy-flip-before-cursor-atomic
[205.894265] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[206.033840] [096/161] (809s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[206.210574] Starting subtest: basic-busy-flip-before-cursor-legacy
[206.213269] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[206.345408] [097/161] (809s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[206.518617] Starting subtest: basic-flip-after-cursor-atomic
[207.621776] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.099s)
[207.837789] [098/161] (807s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[208.012740] Starting subtest: basic-flip-after-cursor-legacy
[209.109363] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.098s)
[209.327889] [099/161] (806s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[209.503819] Starting subtest: basic-flip-after-cursor-varying-size
[210.606069] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.101s)
[210.815912] [100/161] (805s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[210.992907] Starting subtest: basic-flip-before-cursor-atomic
[212.085706] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.088s)
[212.320138] [101/161] (803s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[212.500382] Starting subtest: basic-flip-before-cursor-legacy
[213.602367] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.102s)
[213.842109] [102/161] (802s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[214.018034] Starting subtest: basic-flip-before-cursor-varying-size
[215.110243] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.091s)
[215.339127] [103/161] (800s left) kms_dsc (dsc-basic)
[215.509873] Subtest dsc-basic: SKIP (0.000s)
[215.608798] [104/161] (800s left) kms_flip (basic-flip-vs-dpms)
[215.787718] Starting subtest: basic-flip-vs-dpms
[215.790718] Starting dynamic subtest: A-HDMI-A2
[216.995065] Dynamic subtest A-HDMI-A2: SUCCESS (1.191s)
[217.026436] Starting dynamic subtest: B-HDMI-A2
[217.971236] Dynamic subtest B-HDMI-A2: SUCCESS (0.986s)
[217.995862] Starting dynamic subtest: C-HDMI-A2
[218.959190] Dynamic subtest C-HDMI-A2: SUCCESS (0.982s)
[218.962129] Subtest basic-flip-vs-dpms: SUCCESS (3.170s)
[219.223802] [105/161] (797s left) kms_flip (basic-flip-vs-modeset)
[219.413770] Starting subtest: basic-flip-vs-modeset
[219.418152] Starting dynamic subtest: A-HDMI-A2
[220.664770] Dynamic subtest A-HDMI-A2: SUCCESS (1.244s)
[220.704358] Starting dynamic subtest: B-HDMI-A2
[221.650196] Dynamic subtest B-HDMI-A2: SUCCESS (0.973s)
[221.699363] Starting dynamic subtest: C-HDMI-A2
[222.661072] Dynamic subtest C-HDMI-A2: SUCCESS (0.995s)
[222.664934] Subtest basic-flip-vs-modeset: SUCCESS (3.239s)
[222.912022] [106/161] (793s left) kms_flip (basic-flip-vs-wf_vblank)
[223.094336] Starting subtest: basic-flip-vs-wf_vblank
[223.095431] Starting dynamic subtest: A-HDMI-A2
[224.489573] Dynamic subtest A-HDMI-A2: SUCCESS (1.394s)
[224.512451] Starting dynamic subtest: B-HDMI-A2
[225.852511] Dynamic subtest B-HDMI-A2: SUCCESS (1.356s)
[225.871199] Starting dynamic subtest: C-HDMI-A2
[227.208925] Dynamic subtest C-HDMI-A2: SUCCESS (1.356s)
[227.210122] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.119s)
[227.636643] [107/161] (788s left) kms_flip (basic-plain-flip)
[227.812070] Starting subtest: basic-plain-flip
[227.815865] Starting dynamic subtest: A-HDMI-A2
[228.924350] Dynamic subtest A-HDMI-A2: SUCCESS (1.104s)
[228.944683] Starting dynamic subtest: B-HDMI-A2
[229.990835] Dynamic subtest B-HDMI-A2: SUCCESS (1.063s)
[230.012384] Starting dynamic subtest: C-HDMI-A2
[231.067032] Dynamic subtest C-HDMI-A2: SUCCESS (1.069s)
[231.070241] Subtest basic-plain-flip: SUCCESS (3.253s)
[231.500738] [108/161] (785s left) kms_force_connector_basic (force-connector-state)
[231.720960] Starting subtest: force-connector-state
[232.167950] Subtest force-connector-state: SUCCESS (0.447s)
[232.646853] [109/161] (784s left) kms_force_connector_basic (force-edid)
[232.892437] Starting subtest: force-edid
[232.955446] Subtest force-edid: SUCCESS (0.060s)
[233.277668] [110/161] (783s left) kms_force_connector_basic (force-load-detect)
[233.497985] Starting subtest: force-load-detect
[233.503791] Subtest force-load-detect: SKIP (0.000s)
[233.778141] [111/161] (783s left) kms_force_connector_basic (prune-stale-modes)
[233.995421] Starting subtest: prune-stale-modes
[234.076970] Subtest prune-stale-modes: SUCCESS (0.081s)
[234.411846] [112/161] (782s left) kms_frontbuffer_tracking (basic)
[234.613881] Starting subtest: basic
[237.773178] Subtest basic: SUCCESS (3.157s)
[237.935506] [113/161] (779s left) kms_hdmi_inject (inject-audio)
[238.258308] Starting subtest: inject-audio
[238.464418] Subtest inject-audio: SUCCESS (0.207s)
[238.878862] [114/161] (778s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[239.066194] Starting subtest: compare-crc-sanitycheck-xr24
[239.069237] Starting dynamic subtest: pipe-A-HDMI-A-2
[239.647754] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.573s)
[239.669331] Starting dynamic subtest: pipe-B-HDMI-A-2
[240.229045] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.568s)
[240.252990] Starting dynamic subtest: pipe-C-HDMI-A-2
[240.821595] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.576s)
[240.822719] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.754s)
[241.048773] [115/161] (776s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[241.230422] Starting subtest: compare-crc-sanitycheck-nv12
[241.236091] Starting dynamic subtest: pipe-A-HDMI-A-2
[241.949660] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.712s)
[241.982923] Starting dynamic subtest: pipe-B-HDMI-A-2
[242.629240] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.667s)
[242.657778] Starting dynamic subtest: pipe-C-HDMI-A-2
[243.295185] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.664s)
[243.296720] Subtest compare-crc-sanitycheck-nv12: SUCCESS (2.064s)
[243.521894] [116/161] (773s left) kms_pipe_crc_basic (hang-read-crc)
[243.708840] Starting subtest: hang-read-crc
[243.719115] Starting dynamic subtest: pipe-A-HDMI-A-2
[245.175889] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.456s)
[245.198945] Starting dynamic subtest: pipe-B-HDMI-A-2
[246.513934] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.333s)
[246.539959] Starting dynamic subtest: pipe-C-HDMI-A-2
[247.902253] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.380s)
[247.904623] Subtest hang-read-crc: SUCCESS (4.194s)
[248.139974] [117/161] (769s left) kms_pipe_crc_basic (nonblocking-crc)
[248.328593] Starting subtest: nonblocking-crc
[248.334624] Starting dynamic subtest: pipe-A-HDMI-A-2
[249.121081] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.780s)
[249.149522] Starting dynamic subtest: pipe-B-HDMI-A-2
[249.851091] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.726s)
[249.875196] Starting dynamic subtest: pipe-C-HDMI-A-2
[250.587333] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.728s)
[250.588456] Subtest nonblocking-crc: SUCCESS (2.257s)
[250.814291] [118/161] (766s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[251.006215] Starting subtest: nonblocking-crc-frame-sequence
[251.007364] Starting dynamic subtest: pipe-A-HDMI-A-2
[251.778273] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.772s)
[251.811182] Starting dynamic subtest: pipe-B-HDMI-A-2
[252.535280] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.741s)
[252.554271] Starting dynamic subtest: pipe-C-HDMI-A-2
[253.293835] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.754s)
[253.296409] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.292s)
[253.508764] [119/161] (764s left) kms_pipe_crc_basic (read-crc)
[253.688560] Starting subtest: read-crc
[253.689643] Starting dynamic subtest: pipe-A-HDMI-A-2
[254.406849] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.715s)
[254.437939] Starting dynamic subtest: pipe-B-HDMI-A-2
[255.126562] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.711s)
[255.155051] Starting dynamic subtest: pipe-C-HDMI-A-2
[255.813623] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.681s)
[255.814737] Subtest read-crc: SUCCESS (2.129s)
[256.041753] [120/161] (761s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[256.234131] Starting subtest: read-crc-frame-sequence
[256.241570] Starting dynamic subtest: pipe-A-HDMI-A-2
[256.944136] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.705s)
[256.968564] Starting dynamic subtest: pipe-B-HDMI-A-2
[257.607106] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.654s)
[257.646413] Starting dynamic subtest: pipe-C-HDMI-A-2
[258.327310] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.708s)
[258.328403] Subtest read-crc-frame-sequence: SUCCESS (2.092s)
[258.555185] [121/161] (759s left) kms_pm_backlight (basic-brightness)
[258.734807] Subtest basic-brightness: SKIP (0.000s)
[258.832674] [122/161] (759s left) kms_pm_rpm (basic-pci-d3-state)
[260.530357] Starting subtest: basic-pci-d3-state
[260.824653] Subtest basic-pci-d3-state: SUCCESS (0.292s)
[261.013530] [123/161] (757s left) kms_pm_rpm (basic-rte)
[261.129508] Starting subtest: basic-rte
[263.000446] Subtest basic-rte: SUCCESS (1.873s)
[263.717974] [124/161] (754s left) kms_psr (psr-primary-page-flip)
[263.910819] Subtest psr-primary-page-flip: SKIP (0.000s)
[264.011304] [125/161] (754s left) kms_psr (psr-cursor-plane-move)
[264.196887] Subtest psr-cursor-plane-move: SKIP (0.000s)
[264.307570] [126/161] (754s left) kms_psr (psr-sprite-plane-onoff)
[264.475438] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[264.590577] [127/161] (753s left) kms_psr (psr-primary-mmap-gtt)
[264.771431] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[264.875754] [128/161] (753s left) kms_setmode (basic-clone-single-crtc)
[264.994423] Starting subtest: basic-clone-single-crtc
[264.998747] Subtest basic-clone-single-crtc: SKIP (0.000s)
[265.156244] [129/161] (753s left) i915_pm_rps (basic-api)
[265.288140] Starting subtest: basic-api
[265.296436] Subtest basic-api: SUCCESS (0.010s)
[265.456327] [130/161] (753s left) prime_self_import (basic-llseek-bad)
[265.573428] Starting subtest: basic-llseek-bad
[265.577454] Subtest basic-llseek-bad: SUCCESS (0.004s)
[265.737280] [131/161] (753s left) prime_self_import (basic-llseek-size)
[265.848619] Starting subtest: basic-llseek-size
[265.855362] Subtest basic-llseek-size: SUCCESS (0.007s)
[266.011307] [132/161] (753s left) prime_self_import (basic-with_fd_dup)
[266.120981] Starting subtest: basic-with_fd_dup
[266.131099] Subtest basic-with_fd_dup: SUCCESS (0.008s)
[266.275057] [133/161] (752s left) prime_self_import (basic-with_one_bo)
[266.387054] Starting subtest: basic-with_one_bo
[266.390625] Subtest basic-with_one_bo: SUCCESS (0.006s)
[266.546110] [134/161] (752s left) prime_self_import (basic-with_one_bo_two_files)
[266.654255] Starting subtest: basic-with_one_bo_two_files
[266.661346] Subtest basic-with_one_bo_two_files: SUCCESS (0.010s)
[266.811934] [135/161] (752s left) prime_self_import (basic-with_two_bos)
[266.929301] Starting subtest: basic-with_two_bos
[266.931531] Subtest basic-with_two_bos: SUCCESS (0.006s)
[267.074885] [136/161] (752s left) prime_vgem (basic-fence-flip)
[267.223461] Starting subtest: basic-fence-flip
[267.716825] Subtest basic-fence-flip: SUCCESS (0.493s)
[267.875215] [137/161] (751s left) prime_vgem (basic-fence-mmap)
[268.020699] Starting subtest: basic-fence-mmap
[268.085250] Subtest basic-fence-mmap: SUCCESS (0.064s)
[268.232237] [138/161] (751s left) prime_vgem (basic-fence-read)
[268.370421] Starting subtest: basic-fence-read
[268.495042] Subtest basic-fence-read: SUCCESS (0.123s)
[268.647186] [139/161] (751s left) prime_vgem (basic-gtt)
[268.787483] Starting subtest: basic-gtt
[268.815513] Subtest basic-gtt: SUCCESS (0.029s)
[268.957729] [140/161] (750s left) prime_vgem (basic-read)
[269.094034] Starting subtest: basic-read
[269.154288] Subtest basic-read: SUCCESS (0.058s)
[269.318732] [141/161] (750s left) prime_vgem (basic-write)
[269.450219] Starting subtest: basic-write
[269.526455] Subtest basic-write: SUCCESS (0.076s)
[269.673255] [142/161] (750s left) vgem_basic (setversion)
[269.804795] Starting subtest: setversion
[269.807289] Subtest setversion: SUCCESS (0.000s)
[269.929909] [143/161] (750s left) vgem_basic (create)
[270.051474] Starting subtest: create
[270.052644] Subtest create: SUCCESS (0.001s)
[270.178743] [144/161] (750s left) vgem_basic (debugfs)
[270.304108] Starting subtest: debugfs
[270.305406] Subtest debugfs: SUCCESS (0.002s)
[270.424425] [145/161] (749s left) vgem_basic (dmabuf-export)
[270.554673] Starting subtest: dmabuf-export
[270.558150] Subtest dmabuf-export: SUCCESS (0.004s)
[270.708795] [146/161] (749s left) vgem_basic (dmabuf-fence)
[270.840065] Starting subtest: dmabuf-fence
[270.841378] Subtest dmabuf-fence: SUCCESS (0.001s)
[270.957178] [147/161] (749s left) vgem_basic (dmabuf-fence-before)
[271.088766] Starting subtest: dmabuf-fence-before
[271.090114] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[271.206961] [148/161] (749s left) vgem_basic (dmabuf-mmap)
[271.335725] Starting subtest: dmabuf-mmap
[271.359914] Subtest dmabuf-mmap: SUCCESS (0.027s)
[271.489906] [149/161] (749s left) vgem_basic (mmap)
[271.619378] Starting subtest: mmap
[271.634799] Subtest mmap: SUCCESS (0.019s)
[271.761970] [150/161] (749s left) vgem_basic (second-client)
[271.883627] Starting subtest: second-client
[271.919202] Subtest second-client: SUCCESS (0.032s)
[272.042450] [151/161] (748s left) vgem_basic (sysfs)
[272.167634] Starting subtest: sysfs
[272.169244] Subtest sysfs: SUCCESS (0.001s)
[272.307261] [152/161] (748s left) core_hotunplug (unbind-rebind)
[272.536159] Starting subtest: unbind-rebind
[276.293836] Subtest unbind-rebind: SUCCESS (3.759s)
[276.396934] [153/161] (744s left) vgem_basic (unload)
[276.512670] Starting subtest: unload
[305.512203] Subtest unload: SUCCESS (28.997s)
[305.728304] [154/161] (715s left) i915_module_load (reload)
[305.842902] Starting subtest: reload
[309.168439] Subtest reload: SUCCESS (3.327s)
[309.423855] [155/161] (712s left) gem_lmem_swapping (basic)
[309.758074] Subtest basic: SKIP (0.000s)
[309.892930] [156/161] (711s left) gem_lmem_swapping (parallel-random-engines)
[310.022804] Subtest parallel-random-engines: SKIP (0.000s)
[310.131949] [157/161] (711s left) gem_lmem_swapping (random-engines)
[310.254057] Subtest random-engines: SKIP (0.000s)
[310.362184] [158/161] (711s left) gem_lmem_swapping (verify-random)
[310.484134] Subtest verify-random: SKIP (0.000s)
[310.594867] [159/161] (711s left) i915_pm_rpm (module-reload)
[312.448466] Starting subtest: module-reload
[323.325304] Subtest module-reload: SUCCESS (10.877s)
[323.394314] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[323.397394] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[323.402675] [160/161] (698s left) i915_selftest (live)
[323.528043] Starting subtest: live
[323.529339] Starting dynamic subtest: sanitycheck
[325.865850] Dynamic subtest sanitycheck: SUCCESS (2.337s)
[325.885252] Starting dynamic subtest: uncore
[328.014986] Dynamic subtest uncore: SUCCESS (2.144s)
[328.033265] Starting dynamic subtest: workarounds
[330.341801] Dynamic subtest workarounds: SUCCESS (2.322s)
[330.370089] Starting dynamic subtest: gt_engines
[332.999452] Dynamic subtest gt_engines: SUCCESS (2.656s)
[333.027667] Starting dynamic subtest: gt_timelines
[346.668064] Dynamic subtest gt_timelines: SUCCESS (13.660s)
[346.699055] Starting dynamic subtest: gt_contexts
[348.875943] Dynamic subtest gt_contexts: SUCCESS (2.208s)
[348.904081] Starting dynamic subtest: gt_lrc
[353.572175] Dynamic subtest gt_lrc: SUCCESS (4.691s)
[353.587810] Starting dynamic subtest: gt_mocs
[355.874996] Dynamic subtest gt_mocs: SUCCESS (2.300s)
[355.891675] Starting dynamic subtest: gt_pm
[365.635096] Dynamic subtest gt_pm: SUCCESS (9.754s)
[365.662436] Starting dynamic subtest: gt_heartbeat
[367.771967] Dynamic subtest gt_heartbeat: SUCCESS (2.134s)
[367.802059] Starting dynamic subtest: gt_tlb
[370.758312] Dynamic subtest gt_tlb: SUCCESS (2.984s)
[370.775151] Starting dynamic subtest: requests
[379.342806] Dynamic subtest requests: SUCCESS (8.580s)
[379.359087] Starting dynamic subtest: migrate
[384.501860] Dynamic subtest migrate: SUCCESS (5.155s)
[384.518084] Starting dynamic subtest: active
[386.726423] Dynamic subtest active: SUCCESS (2.222s)
[386.743306] Starting dynamic subtest: objects
[390.809810] Dynamic subtest objects: SUCCESS (4.080s)
[390.838828] Starting dynamic subtest: mman
[399.451265] Dynamic subtest mman: SUCCESS (8.633s)
[399.467909] Starting dynamic subtest: dmabuf
[401.808608] Dynamic subtest dmabuf: SUCCESS (2.355s)
[401.825067] Starting dynamic subtest: vma
[404.042292] Dynamic subtest vma: SUCCESS (2.229s)
[404.058536] Starting dynamic subtest: coherency
[412.448833] Dynamic subtest coherency: SUCCESS (8.400s)
[412.475154] Starting dynamic subtest: gtt
[422.379226] Dynamic subtest gtt: SUCCESS (9.931s)
[422.398397] Starting dynamic subtest: gem
[425.111230] Dynamic subtest gem: SUCCESS (2.728s)
[425.128651] Starting dynamic subtest: evict
[429.666037] Dynamic subtest evict: SUCCESS (4.548s)
[429.681681] Starting dynamic subtest: hugepages
[438.465670] Dynamic subtest hugepages: SUCCESS (8.798s)
[438.485743] Starting dynamic subtest: gem_contexts
[457.190039] Dynamic subtest gem_contexts: SUCCESS (18.721s)
[457.208672] Starting dynamic subtest: client
[459.429831] Dynamic subtest client: SUCCESS (2.232s)
[459.451354] Starting dynamic subtest: gem_migrate
[461.630067] Dynamic subtest gem_migrate: SUCCESS (2.196s)
[461.647059] Starting dynamic subtest: reset
[467.651480] Dynamic subtest reset: SUCCESS (6.017s)
[467.671584] Starting dynamic subtest: memory_region
[469.988941] Dynamic subtest memory_region: SUCCESS (2.336s)
[470.005937] Starting dynamic subtest: hangcheck
[495.281974] Dynamic subtest hangcheck: SUCCESS (25.290s)
[495.301795] Starting dynamic subtest: execlists
[506.617223] Dynamic subtest execlists: SUCCESS (11.329s)
[506.634121] Starting dynamic subtest: ring_submission
[508.744471] Dynamic subtest ring_submission: SUCCESS (2.125s)
[508.768695] Starting dynamic subtest: perf
[511.162479] Dynamic subtest perf: SUCCESS (2.411s)
[511.185669] Starting dynamic subtest: slpc
[513.558898] Dynamic subtest slpc: SUCCESS (2.394s)
[513.575234] Starting dynamic subtest: guc
[515.705855] Dynamic subtest guc: SUCCESS (2.142s)
[515.729582] Starting dynamic subtest: guc_multi_lrc
[517.878851] Dynamic subtest guc_multi_lrc: SUCCESS (2.170s)
[517.903082] Starting dynamic subtest: guc_hang
[520.029225] Dynamic subtest guc_hang: SUCCESS (2.146s)
[520.049659] Starting dynamic subtest: late_gt_pm
[522.243405] Dynamic subtest late_gt_pm: SUCCESS (2.211s)
[522.245827] Subtest live: SUCCESS (198.714s)
[522.327095] [161/161] (499s left) dmabuf (all-tests)
[522.451179] Starting subtest: all-tests
[522.452453] Starting dynamic subtest: sanitycheck
[522.490224] Dynamic subtest sanitycheck: SUCCESS (0.041s)
[522.515142] Starting dynamic subtest: dma_fence
[522.720219] Dynamic subtest dma_fence: SUCCESS (0.224s)
[522.738914] Starting dynamic subtest: dma_fence_chain
[537.431177] Dynamic subtest dma_fence_chain: SUCCESS (14.705s)
[537.448427] Starting dynamic subtest: dma_fence_unwrap
[537.494509] Dynamic subtest dma_fence_unwrap: SUCCESS (0.062s)
[537.514832] Starting dynamic subtest: dma_resv
[537.569467] Dynamic subtest dma_resv: SUCCESS (0.068s)
[537.571626] Subtest all-tests: SUCCESS (15.121s)
[537.640120] Closing watchdogs
Done.