[52.328304] Initializing watchdogs
[52.328515]   /dev/watchdog0
[52.369711] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:4e51 Intel Jasperlake (Gen11) 
[52.379767] [001/161] (960s left) i915_module_load (load)
[52.721085] Starting subtest: load
[56.901331] Subtest load: SUCCESS (4.183s)
[57.023334] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.027153] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[57.034330] [002/161] (955s left) core_auth (basic-auth)
[57.152065] Starting subtest: basic-auth
[57.154917] Subtest basic-auth: SUCCESS (0.002s)
[57.309718] [003/161] (955s left) debugfs_test (read_all_entries)
[57.446368] Starting subtest: read_all_entries
[57.583583] Subtest read_all_entries: SUCCESS (0.140s)
[57.920755] [004/161] (955s left) debugfs_test (basic-hwmon)
[58.091153] Starting subtest: basic-hwmon
[58.096364] Subtest basic-hwmon: SKIP (0.000s)
[58.305625] [005/161] (955s left) debugfs_test (sysfs)
[58.426239] Starting subtest: sysfs
[58.593869] Subtest sysfs: SUCCESS (0.166s)
[58.864316] [006/161] (954s left) fbdev (eof)
[58.999174] Starting subtest: eof
[59.001989] Subtest eof: SUCCESS (0.002s)
[59.151828] [007/161] (954s left) fbdev (info)
[59.261609] Starting subtest: info
[59.263980] Subtest info: SUCCESS (0.000s)
[59.386717] [008/161] (954s left) fbdev (nullptr)
[59.515637] Starting subtest: nullptr
[59.518060] Subtest nullptr: SUCCESS (0.000s)
[59.641788] [009/161] (954s left) fbdev (read)
[59.764248] Starting subtest: read
[68.328805] Subtest read: SUCCESS (8.564s)
[68.479242] [010/161] (945s left) fbdev (write)
[68.598129] Starting subtest: write
[73.043682] Subtest write: SUCCESS (4.445s)
[73.171789] [011/161] (940s left) gem_basic (bad-close)
[73.282781] Starting subtest: bad-close
[73.288337] Subtest bad-close: SUCCESS (0.000s)
[73.425697] [012/161] (940s left) gem_basic (create-close)
[73.534858] Starting subtest: create-close
[73.540211] Subtest create-close: SUCCESS (0.000s)
[73.690610] [013/161] (940s left) gem_basic (create-fd-close)
[73.801454] Starting subtest: create-fd-close
[73.806582] Subtest create-fd-close: SUCCESS (0.001s)
[73.959730] [014/161] (940s left) gem_busy (busy@all-engines)
[74.102627] Starting subtest: busy
[74.105196] Starting dynamic subtest: all-engines
[74.203628] Dynamic subtest all-engines: SUCCESS (0.100s)
[74.205933] Subtest busy: SUCCESS (0.101s)
[74.661590] [015/161] (939s left) gem_close_race (basic-process)
[74.810203] Starting subtest: basic-process
[74.901184] Subtest basic-process: SUCCESS (0.093s)
[75.160292] [016/161] (939s left) gem_close_race (basic-threads)
[75.325238] Starting subtest: basic-threads
[76.685391] Subtest basic-threads: SUCCESS (1.356s)
[77.331147] [017/161] (937s left) gem_ctx_create (basic)
[77.583552] Starting subtest: basic
[77.588207] Subtest basic: SUCCESS (0.001s)
[78.354607] [018/161] (936s left) gem_ctx_create (basic-files)
[78.677865] Starting subtest: basic-files
[80.718547] Subtest basic-files: SUCCESS (2.041s)
[81.031941] [019/161] (933s left) gem_ctx_exec (basic)
[81.150674] Starting subtest: basic
[81.155736] Subtest basic: SUCCESS (0.009s)
[81.308999] [020/161] (933s left) gem_exec_basic (basic)
[81.435622] Starting subtest: basic
[81.439129] Starting dynamic subtest: rcs0-smem
[81.442299] Dynamic subtest rcs0-smem: SUCCESS (0.005s)
[81.464342] Starting dynamic subtest: bcs0-smem
[81.466904] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[81.485724] Starting dynamic subtest: vcs0-smem
[81.488242] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[81.506665] Starting dynamic subtest: vecs0-smem
[81.509089] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[81.511415] Subtest basic: SUCCESS (0.012s)
[81.709933] [021/161] (933s left) gem_exec_create (basic)
[81.848961] Starting subtest: basic
[81.852351] Starting dynamic subtest: smem
[83.905206] Dynamic subtest smem: SUCCESS (2.056s)
[83.907431] Subtest basic: SUCCESS (2.057s)
[84.205249] [022/161] (930s left) gem_exec_fence (basic-busy)
[84.483724] Starting subtest: basic-busy
[84.486169] Starting dynamic subtest: rcs0
[84.534624] Dynamic subtest rcs0: SUCCESS (0.050s)
[84.560720] Starting dynamic subtest: bcs0
[84.569381] Dynamic subtest bcs0: SUCCESS (0.034s)
[84.594866] Starting dynamic subtest: vcs0
[84.600755] Dynamic subtest vcs0: SUCCESS (0.027s)
[84.624818] Starting dynamic subtest: vecs0
[84.629796] Dynamic subtest vecs0: SUCCESS (0.029s)
[84.632297] Subtest basic-busy: SUCCESS (0.142s)
[85.361721] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[85.366532] [023/161] (929s left) gem_exec_fence (basic-wait)
[85.647211] Starting subtest: basic-wait
[85.650263] Starting dynamic subtest: rcs0
[85.681908] Dynamic subtest rcs0: SUCCESS (0.035s)
[85.707521] Starting dynamic subtest: bcs0
[85.710276] Dynamic subtest bcs0: SUCCESS (0.028s)
[85.737169] Starting dynamic subtest: vcs0
[85.742835] Dynamic subtest vcs0: SUCCESS (0.030s)
[85.765764] Starting dynamic subtest: vecs0
[85.780235] Dynamic subtest vecs0: SUCCESS (0.039s)
[85.782824] Subtest basic-wait: SUCCESS (0.133s)
[86.419506] [024/161] (928s left) gem_exec_fence (basic-await)
[86.697400] Starting subtest: basic-await
[86.700501] Starting dynamic subtest: rcs0
[86.851403] Dynamic subtest rcs0: SUCCESS (0.151s)
[86.889340] Starting dynamic subtest: bcs0
[87.019584] Dynamic subtest bcs0: SUCCESS (0.167s)
[87.061407] Starting dynamic subtest: vcs0
[87.191062] Dynamic subtest vcs0: SUCCESS (0.170s)
[87.232379] Starting dynamic subtest: vecs0
[87.360603] Dynamic subtest vecs0: SUCCESS (0.168s)
[87.363736] Subtest basic-await: SUCCESS (0.662s)
[88.014903] [025/161] (927s left) gem_exec_fence (nb-await)
[88.294123] Starting subtest: nb-await
[88.297084] Starting dynamic subtest: rcs0
[88.372475] Dynamic subtest rcs0: SUCCESS (0.076s)
[88.402833] Starting dynamic subtest: bcs0
[88.445991] Dynamic subtest bcs0: SUCCESS (0.073s)
[88.483375] Starting dynamic subtest: vcs0
[88.524300] Dynamic subtest vcs0: SUCCESS (0.077s)
[88.564521] Starting dynamic subtest: vecs0
[88.602093] Dynamic subtest vecs0: SUCCESS (0.076s)
[88.605736] Subtest nb-await: SUCCESS (0.307s)
[89.252811] [026/161] (926s left) gem_exec_gttfill (basic)
[89.391540] Starting subtest: basic
[104.174424] Subtest basic: SUCCESS (14.785s)
[104.452276] [027/161] (911s left) gem_exec_parallel (engines)
[104.681421] Starting subtest: engines
[104.684453] Starting dynamic subtest: basic
[109.384286] Dynamic subtest basic: SUCCESS (4.703s)
[109.425734] Starting dynamic subtest: contexts
[115.685724] Dynamic subtest contexts: SUCCESS (6.300s)
[115.711217] Starting dynamic subtest: fds
[123.271662] Dynamic subtest fds: SUCCESS (7.586s)
[123.307506] Starting dynamic subtest: userptr
[126.758133] Dynamic subtest userptr: SUCCESS (3.486s)
[126.761312] Subtest engines: SUCCESS (22.077s)
[127.056376] [028/161] (888s left) gem_exec_store (basic)
[127.197103] Starting subtest: basic
[127.282530] Subtest basic: SUCCESS (0.086s)
[127.556039] [029/161] (888s left) gem_flink_basic (bad-flink)
[127.669635] Starting subtest: bad-flink
[127.672333] Subtest bad-flink: SUCCESS (0.000s)
[127.819214] [030/161] (888s left) gem_flink_basic (bad-open)
[127.934284] Starting subtest: bad-open
[127.937062] Subtest bad-open: SUCCESS (0.000s)
[128.088175] [031/161] (888s left) gem_flink_basic (basic)
[128.201557] Starting subtest: basic
[128.203663] Subtest basic: SUCCESS (0.000s)
[128.369178] [032/161] (887s left) gem_flink_basic (double-flink)
[128.478066] Starting subtest: double-flink
[128.480410] Subtest double-flink: SUCCESS (0.000s)
[128.657672] [033/161] (887s left) gem_flink_basic (flink-lifetime)
[128.769886] Starting subtest: flink-lifetime
[128.775634] Subtest flink-lifetime: SUCCESS (0.004s)
[128.955836] [034/161] (887s left) gem_huc_copy (huc-copy)
[129.078481] Starting subtest: huc-copy
[129.083227] Subtest huc-copy: SKIP (0.000s)
[129.270539] [035/161] (887s left) gem_linear_blits (basic)
[129.538229] Starting subtest: basic
[129.561972] Subtest basic: SUCCESS (0.024s)
[129.785804] [036/161] (886s left) gem_mmap (basic)
[129.968157] Starting subtest: basic
[129.980457] Subtest basic: SUCCESS (0.001s)
[130.154432] [037/161] (886s left) gem_mmap_gtt (basic)
[130.266805] Starting subtest: basic
[130.269604] Subtest basic: SUCCESS (0.002s)
[130.416960] [038/161] (886s left) gem_render_linear_blits (basic)
[130.537898] Starting subtest: basic
[130.622119] Subtest basic: SUCCESS (0.083s)
[130.756218] [039/161] (886s left) gem_render_tiled_blits (basic)
[130.875653] Starting subtest: basic
[130.972872] Subtest basic: SUCCESS (0.095s)
[131.138482] [040/161] (885s left) gem_ringfill (basic-all)
[131.462475] Starting subtest: basic-all
[132.796434] Subtest basic-all: SUCCESS (1.333s)
[132.960743] [041/161] (884s left) gem_softpin (allocator-basic)
[133.085830] Starting subtest: allocator-basic
[133.279273] Subtest allocator-basic: SUCCESS (0.192s)
[133.510192] [042/161] (883s left) gem_softpin (allocator-basic-reserve)
[133.629144] Starting subtest: allocator-basic-reserve
[133.825900] Subtest allocator-basic-reserve: SUCCESS (0.196s)
[134.031846] [043/161] (883s left) gem_softpin (safe-alignment)
[134.153174] Starting subtest: safe-alignment
[134.179677] Subtest safe-alignment: SUCCESS (0.026s)
[134.357398] [044/161] (883s left) gem_sync (basic-all)
[134.506103] Starting subtest: basic-all
[136.563743] Subtest basic-all: SUCCESS (2.060s)
[136.838956] [045/161] (880s left) gem_sync (basic-each)
[136.981068] Starting subtest: basic-each
[139.304925] Subtest basic-each: SUCCESS (2.325s)
[139.625661] [046/161] (878s left) gem_tiled_blits (basic)
[139.853985] Starting subtest: basic
[139.899517] Subtest basic: SUCCESS (0.046s)
[140.140566] [047/161] (877s left) gem_tiled_fence_blits (basic)
[140.458068] Starting subtest: basic
[140.506125] Subtest basic: SUCCESS (0.048s)
[140.722257] [048/161] (877s left) gem_tiled_pread_basic
[141.320055] [049/161] (876s left) gem_wait (busy@all-engines)
[141.470063] Starting subtest: busy
[141.472993] Starting dynamic subtest: all-engines
[141.997378] Dynamic subtest all-engines: SUCCESS (0.527s)
[142.000270] Subtest busy: SUCCESS (0.528s)
[142.326051] [050/161] (875s left) gem_wait (wait@all-engines)
[142.479287] Starting subtest: wait
[142.481716] Starting dynamic subtest: all-engines
[143.520445] Dynamic subtest all-engines: SUCCESS (1.044s)
[143.523481] Subtest wait: SUCCESS (1.045s)
[143.840215] [051/161] (874s left) i915_getparams_basic (basic-eu-total)
[143.951461] Starting subtest: basic-eu-total
[143.956288] Subtest basic-eu-total: SUCCESS (0.000s)
[144.103723] [052/161] (874s left) i915_getparams_basic (basic-subslice-total)
[144.214147] Starting subtest: basic-subslice-total
[144.219441] Subtest basic-subslice-total: SUCCESS (0.000s)
[144.371398] [053/161] (874s left) i915_hangman (error-state-basic)
[144.520928] Starting subtest: error-state-basic
[144.544165] Subtest error-state-basic: SUCCESS (0.020s)
[144.709457] [054/161] (873s left) i915_pciid
[144.970365] [055/161] (873s left) kms_addfb_basic (addfb25-4-tiled)
[145.151768] Starting subtest: addfb25-4-tiled
[145.154162] Subtest addfb25-4-tiled: SUCCESS (0.001s)
[145.347862] [056/161] (873s left) kms_addfb_basic (addfb25-bad-modifier)
[145.515587] Starting subtest: addfb25-bad-modifier
[145.518172] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[145.688808] [057/161] (873s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[145.861146] Starting subtest: addfb25-framebuffer-vs-set-tiling
[145.863503] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[146.065669] [058/161] (872s left) kms_addfb_basic (addfb25-modifier-no-flag)
[146.239400] Starting subtest: addfb25-modifier-no-flag
[146.241650] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[146.437142] [059/161] (872s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[146.610194] Starting subtest: addfb25-x-tiled-legacy
[146.612643] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[146.786060] [060/161] (872s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[146.957331] Starting subtest: addfb25-x-tiled-mismatch-legacy
[146.959739] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[147.170155] [061/161] (872s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[147.348377] Starting subtest: addfb25-yf-tiled-legacy
[147.350838] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[147.530126] [062/161] (871s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[147.700191] Starting subtest: addfb25-y-tiled-legacy
[147.702567] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[147.893707] [063/161] (871s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[148.063960] Starting subtest: addfb25-y-tiled-small-legacy
[148.066526] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s)
[148.242735] [064/161] (871s left) kms_addfb_basic (bad-pitch-0)
[148.352435] Starting subtest: bad-pitch-0
[148.354847] Subtest bad-pitch-0: SUCCESS (0.000s)
[148.614081] [065/161] (871s left) kms_addfb_basic (bad-pitch-1024)
[148.726736] Starting subtest: bad-pitch-1024
[148.729274] Subtest bad-pitch-1024: SUCCESS (0.000s)
[148.979743] [066/161] (870s left) kms_addfb_basic (bad-pitch-128)
[149.088624] Starting subtest: bad-pitch-128
[149.091197] Subtest bad-pitch-128: SUCCESS (0.000s)
[149.332398] [067/161] (870s left) kms_addfb_basic (bad-pitch-256)
[149.445983] Starting subtest: bad-pitch-256
[149.448166] Subtest bad-pitch-256: SUCCESS (0.000s)
[149.681774] [068/161] (870s left) kms_addfb_basic (bad-pitch-32)
[149.796604] Starting subtest: bad-pitch-32
[149.798595] Subtest bad-pitch-32: SUCCESS (0.000s)
[150.059720] [069/161] (870s left) kms_addfb_basic (bad-pitch-63)
[150.168398] Starting subtest: bad-pitch-63
[150.170896] Subtest bad-pitch-63: SUCCESS (0.000s)
[150.403879] [070/161] (869s left) kms_addfb_basic (bad-pitch-65536)
[150.515555] Starting subtest: bad-pitch-65536
[150.517913] Subtest bad-pitch-65536: SUCCESS (0.001s)
[150.740245] [071/161] (869s left) kms_addfb_basic (bad-pitch-999)
[150.851096] Starting subtest: bad-pitch-999
[150.853105] Subtest bad-pitch-999: SUCCESS (0.000s)
[151.102799] [072/161] (869s left) kms_addfb_basic (basic)
[151.211643] Starting subtest: basic
[151.214233] Subtest basic: SUCCESS (0.000s)
[151.472100] [073/161] (869s left) kms_addfb_basic (basic-x-tiled-legacy)
[151.585303] Starting subtest: basic-x-tiled-legacy
[151.587735] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[151.819938] [074/161] (868s left) kms_addfb_basic (basic-y-tiled-legacy)
[151.935865] Starting subtest: basic-y-tiled-legacy
[151.938221] Subtest basic-y-tiled-legacy: SUCCESS (0.001s)
[152.193456] [075/161] (868s left) kms_addfb_basic (bo-too-small)
[152.363412] Starting subtest: bo-too-small
[152.366333] Subtest bo-too-small: SUCCESS (0.001s)
[152.536770] [076/161] (868s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[152.702461] Starting subtest: bo-too-small-due-to-tiling
[152.704934] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[152.884052] [077/161] (868s left) kms_addfb_basic (clobberred-modifier)
[152.993932] Starting subtest: clobberred-modifier
[152.996442] Subtest clobberred-modifier: SUCCESS (0.000s)
[153.229567] [078/161] (867s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[153.383813] Starting subtest: framebuffer-vs-set-tiling
[153.387828] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[153.654826] [079/161] (867s left) kms_addfb_basic (invalid-get-prop)
[153.767618] Starting subtest: invalid-get-prop
[153.769906] Subtest invalid-get-prop: SUCCESS (0.000s)
[154.027033] [080/161] (867s left) kms_addfb_basic (invalid-get-prop-any)
[154.140060] Starting subtest: invalid-get-prop-any
[154.142669] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[154.390742] [081/161] (867s left) kms_addfb_basic (invalid-set-prop)
[154.497500] Starting subtest: invalid-set-prop
[154.500305] Subtest invalid-set-prop: SUCCESS (0.000s)
[154.742320] [082/161] (866s left) kms_addfb_basic (invalid-set-prop-any)
[154.856619] Starting subtest: invalid-set-prop-any
[154.858946] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[155.125578] [083/161] (866s left) kms_addfb_basic (no-handle)
[155.237205] Starting subtest: no-handle
[155.239533] Subtest no-handle: SUCCESS (0.000s)
[155.471499] [084/161] (866s left) kms_addfb_basic (size-max)
[155.644863] Starting subtest: size-max
[155.647763] Subtest size-max: SUCCESS (0.000s)
[155.859282] [085/161] (866s left) kms_addfb_basic (small-bo)
[156.039880] Starting subtest: small-bo
[156.042714] Subtest small-bo: SUCCESS (0.000s)
[156.239045] [086/161] (865s left) kms_addfb_basic (tile-pitch-mismatch)
[156.350934] Starting subtest: tile-pitch-mismatch
[156.353671] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[156.597312] [087/161] (865s left) kms_addfb_basic (too-high)
[156.766354] Starting subtest: too-high
[156.769430] Subtest too-high: SUCCESS (0.002s)
[156.950092] [088/161] (865s left) kms_addfb_basic (too-wide)
[157.125298] Starting subtest: too-wide
[157.127674] Subtest too-wide: SUCCESS (0.000s)
[157.308346] [089/161] (865s left) kms_addfb_basic (unused-handle)
[157.421309] Starting subtest: unused-handle
[157.423363] Subtest unused-handle: SUCCESS (0.000s)
[157.674981] [090/161] (864s left) kms_addfb_basic (unused-modifier)
[157.787882] Starting subtest: unused-modifier
[157.790205] Subtest unused-modifier: SUCCESS (0.000s)
[158.041941] [091/161] (864s left) kms_addfb_basic (unused-offsets)
[158.151215] Starting subtest: unused-offsets
[158.153213] Subtest unused-offsets: SUCCESS (0.000s)
[158.396787] [092/161] (864s left) kms_addfb_basic (unused-pitches)
[158.509439] Starting subtest: unused-pitches
[158.511480] Subtest unused-pitches: SUCCESS (0.000s)
[158.747216] [093/161] (864s left) kms_busy (basic)
[158.922554] Starting subtest: basic
[158.927570] Starting dynamic subtest: flip
[159.979209] Dynamic subtest flip: SUCCESS (1.050s)
[160.020077] Starting dynamic subtest: modeset
[163.827654] Dynamic subtest modeset: SUCCESS (3.849s)
[163.831308] Subtest basic: SUCCESS (4.904s)
[164.806463] [094/161] (858s left) kms_prop_blob (basic)
[164.916751] Starting subtest: basic
[164.919532] Subtest basic: SUCCESS (0.000s)
[165.069937] [095/161] (857s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[165.239733] Starting subtest: basic-busy-flip-before-cursor-atomic
[165.245013] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[165.389690] [096/161] (857s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[165.559627] Starting subtest: basic-busy-flip-before-cursor-legacy
[165.564860] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[165.709751] [097/161] (857s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[165.877058] Starting subtest: basic-flip-after-cursor-atomic
[167.161586] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.282s)
[168.100524] [098/161] (855s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[168.272099] Starting subtest: basic-flip-after-cursor-legacy
[169.585545] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.312s)
[170.558878] [099/161] (852s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[170.726585] Starting subtest: basic-flip-after-cursor-varying-size
[171.994370] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.266s)
[173.002444] [100/161] (850s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[173.170470] Starting subtest: basic-flip-before-cursor-atomic
[174.438695] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.269s)
[175.455235] [101/161] (848s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[175.624606] Starting subtest: basic-flip-before-cursor-legacy
[176.890932] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.267s)
[177.904199] [102/161] (845s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[178.076588] Starting subtest: basic-flip-before-cursor-varying-size
[179.347367] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.269s)
[180.263648] [103/161] (843s left) kms_dsc (dsc-basic)
[180.433841] Starting subtest: dsc-basic
[180.446541] Subtest dsc-basic: SKIP (0.001s)
[180.582238] [104/161] (843s left) kms_flip (basic-flip-vs-dpms)
[180.752389] Starting subtest: basic-flip-vs-dpms
[180.758078] Starting dynamic subtest: A-eDP1
[183.636884] Dynamic subtest A-eDP1: SUCCESS (2.877s)
[183.683899] Starting dynamic subtest: B-eDP1
[185.984476] Dynamic subtest B-eDP1: SUCCESS (2.344s)
[186.024452] Starting dynamic subtest: C-eDP1
[188.377319] Dynamic subtest C-eDP1: SUCCESS (2.388s)
[188.380439] Subtest basic-flip-vs-dpms: SUCCESS (7.625s)
[189.337866] [105/161] (834s left) kms_flip (basic-flip-vs-modeset)
[189.506581] Starting subtest: basic-flip-vs-modeset
[189.512672] Starting dynamic subtest: A-eDP1
[192.364875] Dynamic subtest A-eDP1: SUCCESS (2.849s)
[192.408494] Starting dynamic subtest: B-eDP1
[194.726498] Dynamic subtest B-eDP1: SUCCESS (2.360s)
[194.768784] Starting dynamic subtest: C-eDP1
[197.105313] Dynamic subtest C-eDP1: SUCCESS (2.375s)
[197.108664] Subtest basic-flip-vs-modeset: SUCCESS (7.601s)
[198.090425] [106/161] (825s left) kms_flip (basic-flip-vs-wf_vblank)
[198.263470] Starting subtest: basic-flip-vs-wf_vblank
[198.269472] Starting dynamic subtest: A-eDP1
[200.673404] Dynamic subtest A-eDP1: SUCCESS (2.404s)
[200.706503] Starting dynamic subtest: B-eDP1
[202.992749] Dynamic subtest B-eDP1: SUCCESS (2.317s)
[203.024358] Starting dynamic subtest: C-eDP1
[205.330934] Dynamic subtest C-eDP1: SUCCESS (2.335s)
[205.337482] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.071s)
[206.734858] [107/161] (817s left) kms_flip (basic-plain-flip)
[206.904550] Starting subtest: basic-plain-flip
[206.910641] Starting dynamic subtest: A-eDP1
[209.027731] Dynamic subtest A-eDP1: SUCCESS (2.117s)
[209.061628] Starting dynamic subtest: B-eDP1
[211.046450] Dynamic subtest B-eDP1: SUCCESS (2.016s)
[211.078053] Starting dynamic subtest: C-eDP1
[213.085534] Dynamic subtest C-eDP1: SUCCESS (2.037s)
[213.092090] Subtest basic-plain-flip: SUCCESS (6.185s)
[214.449808] [108/161] (809s left) kms_force_connector_basic (force-connector-state)
[214.593462] Starting subtest: force-connector-state
[215.520384] Subtest force-connector-state: SUCCESS (0.929s)
[216.505159] [109/161] (807s left) kms_force_connector_basic (force-edid)
[216.648360] Starting subtest: force-edid
[216.927255] Subtest force-edid: SUCCESS (0.277s)
[217.216114] [110/161] (807s left) kms_force_connector_basic (force-load-detect)
[217.356707] Starting subtest: force-load-detect
[217.362169] Subtest force-load-detect: SKIP (0.000s)
[217.593921] [111/161] (807s left) kms_force_connector_basic (prune-stale-modes)
[217.736316] Starting subtest: prune-stale-modes
[218.071888] Subtest prune-stale-modes: SUCCESS (0.336s)
[218.361849] [112/161] (806s left) kms_frontbuffer_tracking (basic)
[218.545116] Starting subtest: basic
[222.655149] Subtest basic: SUCCESS (4.110s)
[222.896875] [113/161] (801s left) kms_hdmi_inject (inject-audio)
[223.369719] Starting subtest: inject-audio
[223.729912] Subtest inject-audio: SUCCESS (0.361s)
[224.334201] [114/161] (800s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[224.510666] Starting subtest: compare-crc-sanitycheck-xr24
[224.513698] Starting dynamic subtest: pipe-A-eDP-1
[225.325307] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.811s)
[225.358530] Starting dynamic subtest: pipe-B-eDP-1
[226.722545] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.393s)
[226.772422] Starting dynamic subtest: pipe-C-eDP-1
[228.062804] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.331s)
[228.065965] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.553s)
[229.010647] [115/161] (796s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[229.180402] Starting subtest: compare-crc-sanitycheck-nv12
[229.183203] Starting dynamic subtest: pipe-A-eDP-1
[230.347136] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.163s)
[230.395502] Starting dynamic subtest: pipe-B-eDP-1
[231.773731] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.419s)
[231.827291] Starting dynamic subtest: pipe-C-eDP-1
[233.152814] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.366s)
[233.155997] Subtest compare-crc-sanitycheck-nv12: SUCCESS (3.968s)
[234.061729] [116/161] (791s left) kms_pipe_crc_basic (hang-read-crc)
[234.235182] Starting subtest: hang-read-crc
[234.237876] Starting dynamic subtest: pipe-A-eDP-1
[236.801352] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.563s)
[236.852664] Starting dynamic subtest: pipe-B-eDP-1
[239.907669] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.098s)
[239.950738] Starting dynamic subtest: pipe-C-eDP-1
[242.930989] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.014s)
[242.934103] Subtest hang-read-crc: SUCCESS (8.696s)
[243.850315] [117/161] (781s left) kms_pipe_crc_basic (nonblocking-crc)
[244.026455] Starting subtest: nonblocking-crc
[244.029280] Starting dynamic subtest: pipe-A-eDP-1
[245.024770] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.996s)
[245.076384] Starting dynamic subtest: pipe-B-eDP-1
[246.599203] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.564s)
[246.650573] Starting dynamic subtest: pipe-C-eDP-1
[248.161235] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.555s)
[248.164574] Subtest nonblocking-crc: SUCCESS (4.137s)
[249.106520] [118/161] (776s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[249.280542] Starting subtest: nonblocking-crc-frame-sequence
[249.283278] Starting dynamic subtest: pipe-A-eDP-1
[250.291742] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.005s)
[250.339844] Starting dynamic subtest: pipe-B-eDP-1
[251.859707] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.560s)
[251.911207] Starting dynamic subtest: pipe-C-eDP-1
[253.423211] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.558s)
[253.426212] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.146s)
[254.360620] [119/161] (771s left) kms_pipe_crc_basic (read-crc)
[254.533496] Starting subtest: read-crc
[254.536200] Starting dynamic subtest: pipe-A-eDP-1
[255.485692] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.947s)
[255.534847] Starting dynamic subtest: pipe-B-eDP-1
[257.054567] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.560s)
[257.102241] Starting dynamic subtest: pipe-C-eDP-1
[258.616697] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.554s)
[258.620166] Subtest read-crc: SUCCESS (4.084s)
[259.520794] [120/161] (766s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[259.694589] Starting subtest: read-crc-frame-sequence
[259.697216] Starting dynamic subtest: pipe-A-eDP-1
[260.620675] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.921s)
[260.671443] Starting dynamic subtest: pipe-B-eDP-1
[262.225537] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.598s)
[262.267451] Starting dynamic subtest: pipe-C-eDP-1
[263.773511] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.536s)
[263.776827] Subtest read-crc-frame-sequence: SUCCESS (4.079s)
[264.676842] [121/161] (761s left) kms_pm_backlight (basic-brightness)
[264.851711] Starting subtest: basic-brightness
[264.958421] Starting dynamic subtest: eDP-1
[265.530146] Dynamic subtest eDP-1: SUCCESS (0.567s)
[265.533894] Subtest basic-brightness: SUCCESS (0.677s)
[266.465200] [122/161] (759s left) kms_pm_rpm (basic-pci-d3-state)
[268.318420] Starting subtest: basic-pci-d3-state
[268.961450] Subtest basic-pci-d3-state: SUCCESS (0.640s)
[269.192460] [123/161] (756s left) kms_pm_rpm (basic-rte)
[269.300382] Starting subtest: basic-rte
[271.613224] Subtest basic-rte: SUCCESS (2.310s)
[272.912425] [124/161] (753s left) kms_psr (psr-primary-page-flip)
[273.089870] Starting subtest: psr-primary-page-flip
[273.092677] Starting dynamic subtest: eDP-1
[277.095123] Dynamic subtest eDP-1: SUCCESS (4.000s)
[277.098045] Subtest psr-primary-page-flip: SUCCESS (4.005s)
[278.039733] [125/161] (748s left) kms_psr (psr-cursor-plane-move)
[278.212067] Starting subtest: psr-cursor-plane-move
[278.214782] Starting dynamic subtest: eDP-1
[282.146828] Dynamic subtest eDP-1: SUCCESS (3.929s)
[282.150682] Subtest psr-cursor-plane-move: SUCCESS (3.934s)
[283.086342] [126/161] (743s left) kms_psr (psr-sprite-plane-onoff)
[283.261685] Starting subtest: psr-sprite-plane-onoff
[283.264366] Starting dynamic subtest: eDP-1
[287.271557] Dynamic subtest eDP-1: SUCCESS (4.007s)
[287.275509] Subtest psr-sprite-plane-onoff: SUCCESS (4.012s)
[288.240749] [127/161] (738s left) kms_psr (psr-primary-mmap-gtt)
[288.482977] Starting subtest: psr-primary-mmap-gtt
[288.485796] Starting dynamic subtest: eDP-1
[292.459807] Dynamic subtest eDP-1: SUCCESS (3.969s)
[292.463287] Subtest psr-primary-mmap-gtt: SUCCESS (3.975s)
[293.399768] [128/161] (733s left) kms_setmode (basic-clone-single-crtc)
[293.520219] Starting subtest: basic-clone-single-crtc
[293.528144] Subtest basic-clone-single-crtc: SKIP (0.000s)
[293.681248] [129/161] (732s left) i915_pm_rps (basic-api)
[293.809116] Starting subtest: basic-api
[293.816823] Subtest basic-api: SUCCESS (0.008s)
[293.979038] [130/161] (732s left) prime_self_import (basic-llseek-bad)
[294.086909] Starting subtest: basic-llseek-bad
[294.092587] Subtest basic-llseek-bad: SUCCESS (0.007s)
[294.280991] [131/161] (732s left) prime_self_import (basic-llseek-size)
[294.389513] Starting subtest: basic-llseek-size
[294.398942] Subtest basic-llseek-size: SUCCESS (0.008s)
[294.582940] [132/161] (732s left) prime_self_import (basic-with_fd_dup)
[294.687787] Starting subtest: basic-with_fd_dup
[294.697378] Subtest basic-with_fd_dup: SUCCESS (0.008s)
[294.867848] [133/161] (732s left) prime_self_import (basic-with_one_bo)
[294.975469] Starting subtest: basic-with_one_bo
[294.984582] Subtest basic-with_one_bo: SUCCESS (0.010s)
[295.150918] [134/161] (731s left) prime_self_import (basic-with_one_bo_two_files)
[295.259810] Starting subtest: basic-with_one_bo_two_files
[295.264753] Subtest basic-with_one_bo_two_files: SUCCESS (0.006s)
[295.436936] [135/161] (731s left) prime_self_import (basic-with_two_bos)
[295.552955] Starting subtest: basic-with_two_bos
[295.562995] Subtest basic-with_two_bos: SUCCESS (0.008s)
[295.733600] [136/161] (731s left) prime_vgem (basic-fence-flip)
[295.878721] Starting subtest: basic-fence-flip
[296.473933] Subtest basic-fence-flip: SUCCESS (0.598s)
[296.667897] [137/161] (730s left) prime_vgem (basic-fence-mmap)
[296.807389] Starting subtest: basic-fence-mmap
[296.869482] Subtest basic-fence-mmap: SUCCESS (0.062s)
[297.034776] [138/161] (730s left) prime_vgem (basic-fence-read)
[297.174683] Starting subtest: basic-fence-read
[297.283466] Subtest basic-fence-read: SUCCESS (0.108s)
[297.449272] [139/161] (730s left) prime_vgem (basic-gtt)
[297.590648] Starting subtest: basic-gtt
[297.620924] Subtest basic-gtt: SUCCESS (0.030s)
[297.800797] [140/161] (729s left) prime_vgem (basic-read)
[297.950264] Starting subtest: basic-read
[298.002824] Subtest basic-read: SUCCESS (0.052s)
[298.164923] [141/161] (729s left) prime_vgem (basic-write)
[298.321596] Starting subtest: basic-write
[298.385404] Subtest basic-write: SUCCESS (0.067s)
[298.551828] [142/161] (729s left) vgem_basic (setversion)
[298.679611] Starting subtest: setversion
[298.684268] Subtest setversion: SUCCESS (0.000s)
[298.813537] [143/161] (729s left) vgem_basic (create)
[298.927239] Starting subtest: create
[298.929672] Subtest create: SUCCESS (0.001s)
[299.065751] [144/161] (729s left) vgem_basic (debugfs)
[299.192662] Starting subtest: debugfs
[299.195391] Subtest debugfs: SUCCESS (0.001s)
[299.334566] [145/161] (728s left) vgem_basic (dmabuf-export)
[299.459204] Starting subtest: dmabuf-export
[299.463747] Subtest dmabuf-export: SUCCESS (0.005s)
[299.658623] [146/161] (728s left) vgem_basic (dmabuf-fence)
[299.778365] Starting subtest: dmabuf-fence
[299.780868] Subtest dmabuf-fence: SUCCESS (0.001s)
[299.916749] [147/161] (728s left) vgem_basic (dmabuf-fence-before)
[300.042691] Starting subtest: dmabuf-fence-before
[300.045355] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[300.183431] [148/161] (728s left) vgem_basic (dmabuf-mmap)
[300.309779] Starting subtest: dmabuf-mmap
[300.340911] Subtest dmabuf-mmap: SUCCESS (0.032s)
[300.481140] [149/161] (728s left) vgem_basic (mmap)
[300.609425] Starting subtest: mmap
[300.631637] Subtest mmap: SUCCESS (0.023s)
[300.783596] [150/161] (727s left) vgem_basic (second-client)
[300.909932] Starting subtest: second-client
[300.947533] Subtest second-client: SUCCESS (0.032s)
[301.084694] [151/161] (727s left) vgem_basic (sysfs)
[301.209215] Starting subtest: sysfs
[301.211659] Subtest sysfs: SUCCESS (0.001s)
[301.348893] [152/161] (727s left) core_hotunplug (unbind-rebind)
[301.561341] Starting subtest: unbind-rebind
[307.012336] Subtest unbind-rebind: SUCCESS (5.452s)
[307.124797] [153/161] (721s left) vgem_basic (unload)
[307.236185] Starting subtest: unload
[336.424558] Subtest unload: SUCCESS (29.186s)
[336.662662] [154/161] (692s left) i915_module_load (reload)
[336.775574] Starting subtest: reload
[341.997264] Subtest reload: SUCCESS (5.218s)
[342.151249] [155/161] (687s left) gem_lmem_swapping (basic)
[342.303356] Subtest basic: SKIP (0.000s)
[342.446889] [156/161] (687s left) gem_lmem_swapping (parallel-random-engines)
[342.571558] Subtest parallel-random-engines: SKIP (0.000s)
[342.696242] [157/161] (686s left) gem_lmem_swapping (random-engines)
[342.823567] Subtest random-engines: SKIP (0.000s)
[342.949536] [158/161] (686s left) gem_lmem_swapping (verify-random)
[343.080608] Subtest verify-random: SKIP (0.000s)
[343.195804] [159/161] (686s left) i915_pm_rpm (module-reload)
[355.764155] Starting subtest: module-reload
[390.011042] Subtest module-reload: SUCCESS (34.244s)
[390.084934] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[390.087788] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[390.093456] [160/161] (639s left) i915_selftest (live)
[390.212333] Starting subtest: live
[390.215329] Starting dynamic subtest: sanitycheck
[393.845616] Dynamic subtest sanitycheck: SUCCESS (3.631s)
[393.876826] Starting dynamic subtest: uncore
[397.400415] Dynamic subtest uncore: SUCCESS (3.551s)
[397.434428] Starting dynamic subtest: workarounds
[401.359406] Dynamic subtest workarounds: SUCCESS (3.954s)
[401.392720] Starting dynamic subtest: gt_engines
[405.410384] Dynamic subtest gt_engines: SUCCESS (4.045s)
[405.444148] Starting dynamic subtest: gt_timelines
[421.551066] Dynamic subtest gt_timelines: SUCCESS (16.135s)
[421.587641] Starting dynamic subtest: gt_contexts
[425.295522] Dynamic subtest gt_contexts: SUCCESS (3.739s)
[425.328994] Starting dynamic subtest: gt_lrc
[431.178854] Dynamic subtest gt_lrc: SUCCESS (5.878s)
[431.212778] Starting dynamic subtest: gt_mocs
[434.911358] Dynamic subtest gt_mocs: SUCCESS (3.727s)
[434.943970] Starting dynamic subtest: gt_pm
[445.473513] Dynamic subtest gt_pm: SUCCESS (10.557s)
[445.501252] Starting dynamic subtest: gt_heartbeat
[449.166429] Dynamic subtest gt_heartbeat: SUCCESS (3.688s)
[449.201573] Starting dynamic subtest: gt_tlb
[454.027762] Dynamic subtest gt_tlb: SUCCESS (4.856s)
[454.056925] Starting dynamic subtest: requests
[463.717505] Dynamic subtest requests: SUCCESS (9.684s)
[463.744781] Starting dynamic subtest: migrate
[470.117928] Dynamic subtest migrate: SUCCESS (6.395s)
[470.151607] Starting dynamic subtest: active
[473.743590] Dynamic subtest active: SUCCESS (3.621s)
[473.772516] Starting dynamic subtest: objects
[478.664413] Dynamic subtest objects: SUCCESS (4.916s)
[478.698849] Starting dynamic subtest: mman
[487.120447] Dynamic subtest mman: SUCCESS (8.451s)
[487.153147] Starting dynamic subtest: dmabuf
[490.865570] Dynamic subtest dmabuf: SUCCESS (3.740s)
[490.895090] Starting dynamic subtest: vma
[494.511632] Dynamic subtest vma: SUCCESS (3.641s)
[494.540499] Starting dynamic subtest: coherency
[501.143914] Dynamic subtest coherency: SUCCESS (6.627s)
[501.173944] Starting dynamic subtest: gtt
[512.951574] Dynamic subtest gtt: SUCCESS (11.802s)
[512.981529] Starting dynamic subtest: gem
[517.044464] Dynamic subtest gem: SUCCESS (4.088s)
[517.071935] Starting dynamic subtest: evict
[522.809603] Dynamic subtest evict: SUCCESS (5.760s)
[522.838599] Starting dynamic subtest: hugepages
[532.734800] Dynamic subtest hugepages: SUCCESS (9.920s)
[532.768340] Starting dynamic subtest: gem_contexts
[551.018977] Dynamic subtest gem_contexts: SUCCESS (18.278s)
[551.047273] Starting dynamic subtest: client
[554.717844] Dynamic subtest client: SUCCESS (3.694s)
[554.746378] Starting dynamic subtest: gem_migrate
[558.306461] Dynamic subtest gem_migrate: SUCCESS (3.584s)
[558.344266] Starting dynamic subtest: reset
[568.970415] Dynamic subtest reset: SUCCESS (10.660s)
[568.999615] Starting dynamic subtest: memory_region
[572.578662] Dynamic subtest memory_region: SUCCESS (3.603s)
[572.608049] Starting dynamic subtest: hangcheck
[599.248871] Dynamic subtest hangcheck: SUCCESS (26.664s)
[599.277597] Starting dynamic subtest: execlists
[612.711943] Dynamic subtest execlists: SUCCESS (13.458s)
[612.739297] Starting dynamic subtest: ring_submission
[616.303043] Dynamic subtest ring_submission: SUCCESS (3.587s)
[616.335754] Starting dynamic subtest: perf
[620.275988] Dynamic subtest perf: SUCCESS (3.967s)
[620.309453] Starting dynamic subtest: slpc
[623.924521] Dynamic subtest slpc: SUCCESS (3.643s)
[623.954292] Starting dynamic subtest: guc
[627.518370] Dynamic subtest guc: SUCCESS (3.589s)
[627.547141] Starting dynamic subtest: guc_multi_lrc
[631.137650] Dynamic subtest guc_multi_lrc: SUCCESS (3.614s)
[631.175784] Starting dynamic subtest: guc_hang
[634.837591] Dynamic subtest guc_hang: SUCCESS (3.695s)
[634.866843] Starting dynamic subtest: late_gt_pm
[638.617495] Dynamic subtest late_gt_pm: SUCCESS (3.775s)
[638.620929] Subtest live: SUCCESS (248.399s)
[638.706485] [161/161] (391s left) dmabuf (all-tests)
[638.824785] Starting subtest: all-tests
[638.827794] Starting dynamic subtest: sanitycheck
[638.952659] Dynamic subtest sanitycheck: SUCCESS (0.125s)
[638.985554] Starting dynamic subtest: dma_fence
[639.210425] Dynamic subtest dma_fence: SUCCESS (0.253s)
[639.238925] Starting dynamic subtest: dma_fence_chain
[654.387584] Dynamic subtest dma_fence_chain: SUCCESS (15.171s)
[654.416370] Starting dynamic subtest: dma_fence_unwrap
[654.510428] Dynamic subtest dma_fence_unwrap: SUCCESS (0.119s)
[654.543705] Starting dynamic subtest: dma_resv
[654.600405] Dynamic subtest dma_resv: SUCCESS (0.085s)
[654.603853] Subtest all-tests: SUCCESS (15.777s)
[654.699565] Closing watchdogs
Done.