[46.143836] Initializing watchdogs
[46.144107]   /dev/watchdog0
[46.186409] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:4e51 Intel Jasperlake (Gen11) 
[46.196064] [001/161] (960s left) i915_module_load (load)
[46.535257] Starting subtest: load
[51.124817] Subtest load: SUCCESS (4.585s)
[51.229455] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[51.232879] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[51.238864] [002/161] (955s left) core_auth (basic-auth)
[51.377389] Starting subtest: basic-auth
[51.380287] Subtest basic-auth: SUCCESS (0.002s)
[51.523743] [003/161] (955s left) debugfs_test (read_all_entries)
[51.648243] Starting subtest: read_all_entries
[51.785822] Subtest read_all_entries: SUCCESS (0.137s)
[52.070685] [004/161] (954s left) debugfs_test (basic-hwmon)
[52.248831] Starting subtest: basic-hwmon
[52.254604] Subtest basic-hwmon: SKIP (0.000s)
[52.483447] [005/161] (954s left) debugfs_test (sysfs)
[52.604500] Starting subtest: sysfs
[52.768479] Subtest sysfs: SUCCESS (0.163s)
[52.996447] [006/161] (954s left) fbdev (eof)
[53.119117] Starting subtest: eof
[53.121614] Subtest eof: SUCCESS (0.001s)
[53.255981] [007/161] (954s left) fbdev (info)
[53.366314] Starting subtest: info
[53.368650] Subtest info: SUCCESS (0.000s)
[53.504358] [008/161] (953s left) fbdev (nullptr)
[53.616795] Starting subtest: nullptr
[53.619319] Subtest nullptr: SUCCESS (0.000s)
[53.740620] [009/161] (953s left) fbdev (read)
[53.849686] Starting subtest: read
[62.378723] Subtest read: SUCCESS (8.528s)
[62.509972] [010/161] (945s left) fbdev (write)
[62.637967] Starting subtest: write
[67.134174] Subtest write: SUCCESS (4.473s)
[67.266713] [011/161] (940s left) gem_basic (bad-close)
[67.379131] Starting subtest: bad-close
[67.384192] Subtest bad-close: SUCCESS (0.000s)
[67.525743] [012/161] (940s left) gem_basic (create-close)
[67.636499] Starting subtest: create-close
[67.641812] Subtest create-close: SUCCESS (0.000s)
[67.793322] [013/161] (940s left) gem_basic (create-fd-close)
[67.908843] Starting subtest: create-fd-close
[67.913458] Subtest create-fd-close: SUCCESS (0.000s)
[68.083088] [014/161] (939s left) gem_busy (busy@all-engines)
[68.222462] Starting subtest: busy
[68.225208] Starting dynamic subtest: all-engines
[68.331359] Dynamic subtest all-engines: SUCCESS (0.107s)
[68.333988] Subtest busy: SUCCESS (0.108s)
[68.854173] [015/161] (939s left) gem_close_race (basic-process)
[68.999168] Starting subtest: basic-process
[69.091050] Subtest basic-process: SUCCESS (0.091s)
[69.363412] [016/161] (938s left) gem_close_race (basic-threads)
[69.509254] Starting subtest: basic-threads
[70.802350] Subtest basic-threads: SUCCESS (1.283s)
[71.098593] [017/161] (937s left) gem_ctx_create (basic)
[71.234324] Starting subtest: basic
[71.237187] Subtest basic: SUCCESS (0.000s)
[71.490367] [018/161] (936s left) gem_ctx_create (basic-files)
[71.626564] Starting subtest: basic-files
[73.664737] Subtest basic-files: SUCCESS (2.028s)
[74.001397] [019/161] (934s left) gem_ctx_exec (basic)
[74.117334] Starting subtest: basic
[74.125557] Subtest basic: SUCCESS (0.009s)
[74.289646] [020/161] (934s left) gem_exec_basic (basic)
[74.419863] Starting subtest: basic
[74.423156] Starting dynamic subtest: rcs0-smem
[74.426246] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[74.450018] Starting dynamic subtest: bcs0-smem
[74.452198] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[74.470633] Starting dynamic subtest: vcs0-smem
[74.472715] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[74.490617] Starting dynamic subtest: vecs0-smem
[74.492653] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[74.494628] Subtest basic: SUCCESS (0.010s)
[74.693592] [021/161] (934s left) gem_exec_create (basic)
[74.834830] Starting subtest: basic
[74.838323] Starting dynamic subtest: smem
[77.082515] Dynamic subtest smem: SUCCESS (2.236s)
[77.085415] Subtest basic: SUCCESS (2.236s)
[77.389163] [022/161] (931s left) gem_exec_fence (basic-busy)
[77.879279] Starting subtest: basic-busy
[77.882486] Starting dynamic subtest: rcs0
[77.941051] Dynamic subtest rcs0: SUCCESS (0.059s)
[77.975338] Starting dynamic subtest: bcs0
[78.208727] Dynamic subtest bcs0: SUCCESS (0.273s)
[78.235687] Starting dynamic subtest: vcs0
[78.508285] Dynamic subtest vcs0: SUCCESS (0.297s)
[78.532340] Starting dynamic subtest: vecs0
[78.729856] Dynamic subtest vecs0: SUCCESS (0.223s)
[78.732866] Subtest basic-busy: SUCCESS (0.855s)
[79.635162] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[79.641962] [023/161] (929s left) gem_exec_fence (basic-wait)
[79.950494] Starting subtest: basic-wait
[79.953689] Starting dynamic subtest: rcs0
[80.014162] Dynamic subtest rcs0: SUCCESS (0.063s)
[80.056463] Starting dynamic subtest: bcs0
[80.059467] Dynamic subtest bcs0: SUCCESS (0.034s)
[80.088555] Starting dynamic subtest: vcs0
[80.091275] Dynamic subtest vcs0: SUCCESS (0.030s)
[80.114522] Starting dynamic subtest: vecs0
[80.116799] Dynamic subtest vecs0: SUCCESS (0.030s)
[80.118977] Subtest basic-wait: SUCCESS (0.160s)
[80.768908] [024/161] (928s left) gem_exec_fence (basic-await)
[81.044384] Starting subtest: basic-await
[81.047582] Starting dynamic subtest: rcs0
[81.218280] Dynamic subtest rcs0: SUCCESS (0.171s)
[81.250506] Starting dynamic subtest: bcs0
[81.385970] Dynamic subtest bcs0: SUCCESS (0.167s)
[81.419103] Starting dynamic subtest: vcs0
[81.552953] Dynamic subtest vcs0: SUCCESS (0.164s)
[81.582602] Starting dynamic subtest: vecs0
[81.719511] Dynamic subtest vecs0: SUCCESS (0.165s)
[81.722643] Subtest basic-await: SUCCESS (0.674s)
[82.368164] [025/161] (926s left) gem_exec_fence (nb-await)
[82.651079] Starting subtest: nb-await
[82.653978] Starting dynamic subtest: rcs0
[82.728071] Dynamic subtest rcs0: SUCCESS (0.076s)
[82.758581] Starting dynamic subtest: bcs0
[82.803574] Dynamic subtest bcs0: SUCCESS (0.074s)
[82.841905] Starting dynamic subtest: vcs0
[82.881783] Dynamic subtest vcs0: SUCCESS (0.077s)
[82.924781] Starting dynamic subtest: vecs0
[82.959976] Dynamic subtest vecs0: SUCCESS (0.077s)
[82.963599] Subtest nb-await: SUCCESS (0.308s)
[83.604334] [026/161] (925s left) gem_exec_gttfill (basic)
[83.742691] Starting subtest: basic
[98.749113] Subtest basic: SUCCESS (14.997s)
[99.045255] [027/161] (910s left) gem_exec_parallel (engines)
[99.283783] Starting subtest: engines
[99.286768] Starting dynamic subtest: basic
[104.040409] Dynamic subtest basic: SUCCESS (4.755s)
[104.069694] Starting dynamic subtest: contexts
[113.737522] Dynamic subtest contexts: SUCCESS (9.694s)
[113.777692] Starting dynamic subtest: fds
[124.673710] Dynamic subtest fds: SUCCESS (10.935s)
[124.702228] Starting dynamic subtest: userptr
[129.245204] Dynamic subtest userptr: SUCCESS (4.571s)
[129.247921] Subtest engines: SUCCESS (29.958s)
[129.529784] [028/161] (880s left) gem_exec_store (basic)
[129.671459] Starting subtest: basic
[129.730438] Subtest basic: SUCCESS (0.059s)
[130.010408] [029/161] (879s left) gem_flink_basic (bad-flink)
[130.118913] Starting subtest: bad-flink
[130.121823] Subtest bad-flink: SUCCESS (0.000s)
[130.265926] [030/161] (879s left) gem_flink_basic (bad-open)
[130.375439] Starting subtest: bad-open
[130.378264] Subtest bad-open: SUCCESS (0.000s)
[130.517993] [031/161] (879s left) gem_flink_basic (basic)
[130.624107] Starting subtest: basic
[130.626836] Subtest basic: SUCCESS (0.000s)
[130.782687] [032/161] (879s left) gem_flink_basic (double-flink)
[130.893592] Starting subtest: double-flink
[130.895908] Subtest double-flink: SUCCESS (0.000s)
[131.070202] [033/161] (879s left) gem_flink_basic (flink-lifetime)
[131.180294] Starting subtest: flink-lifetime
[131.182971] Subtest flink-lifetime: SUCCESS (0.004s)
[131.349785] [034/161] (878s left) gem_huc_copy (huc-copy)
[131.468149] Starting subtest: huc-copy
[131.473094] Subtest huc-copy: SKIP (0.000s)
[131.671110] [035/161] (878s left) gem_linear_blits (basic)
[131.936997] Starting subtest: basic
[131.958223] Subtest basic: SUCCESS (0.021s)
[132.174615] [036/161] (878s left) gem_mmap (basic)
[132.357203] Starting subtest: basic
[132.369099] Subtest basic: SUCCESS (0.001s)
[132.533288] [037/161] (877s left) gem_mmap_gtt (basic)
[132.644776] Starting subtest: basic
[132.647591] Subtest basic: SUCCESS (0.002s)
[132.801248] [038/161] (877s left) gem_render_linear_blits (basic)
[132.920928] Starting subtest: basic
[133.001341] Subtest basic: SUCCESS (0.080s)
[133.132621] [039/161] (877s left) gem_render_tiled_blits (basic)
[133.247827] Starting subtest: basic
[133.343044] Subtest basic: SUCCESS (0.092s)
[133.503739] [040/161] (877s left) gem_ringfill (basic-all)
[133.846235] Starting subtest: basic-all
[135.146332] Subtest basic-all: SUCCESS (1.299s)
[135.304996] [041/161] (875s left) gem_softpin (allocator-basic)
[135.424339] Starting subtest: allocator-basic
[135.622557] Subtest allocator-basic: SUCCESS (0.197s)
[135.804894] [042/161] (875s left) gem_softpin (allocator-basic-reserve)
[135.924853] Starting subtest: allocator-basic-reserve
[136.122153] Subtest allocator-basic-reserve: SUCCESS (0.199s)
[136.327668] [043/161] (874s left) gem_softpin (safe-alignment)
[136.453880] Starting subtest: safe-alignment
[136.478740] Subtest safe-alignment: SUCCESS (0.027s)
[136.674545] [044/161] (874s left) gem_sync (basic-all)
[136.818113] Starting subtest: basic-all
[138.928378] Subtest basic-all: SUCCESS (2.110s)
[139.205959] [045/161] (872s left) gem_sync (basic-each)
[139.347287] Starting subtest: basic-each
[141.825137] Subtest basic-each: SUCCESS (2.474s)
[142.136452] [046/161] (869s left) gem_tiled_blits (basic)
[142.357667] Starting subtest: basic
[142.407216] Subtest basic: SUCCESS (0.049s)
[142.591614] [047/161] (868s left) gem_tiled_fence_blits (basic)
[142.904564] Starting subtest: basic
[142.952401] Subtest basic: SUCCESS (0.048s)
[143.174668] [048/161] (868s left) gem_tiled_pread_basic
[143.800623] [049/161] (867s left) gem_wait (busy@all-engines)
[143.949534] Starting subtest: busy
[143.952334] Starting dynamic subtest: all-engines
[144.485905] Dynamic subtest all-engines: SUCCESS (0.536s)
[144.488816] Subtest busy: SUCCESS (0.537s)
[144.801583] [050/161] (867s left) gem_wait (wait@all-engines)
[144.952278] Starting subtest: wait
[144.955264] Starting dynamic subtest: all-engines
[145.992647] Dynamic subtest all-engines: SUCCESS (1.040s)
[145.995918] Subtest wait: SUCCESS (1.041s)
[146.318992] [051/161] (865s left) i915_getparams_basic (basic-eu-total)
[146.428125] Starting subtest: basic-eu-total
[146.433268] Subtest basic-eu-total: SUCCESS (0.000s)
[146.584422] [052/161] (865s left) i915_getparams_basic (basic-subslice-total)
[146.694950] Starting subtest: basic-subslice-total
[146.700686] Subtest basic-subslice-total: SUCCESS (0.000s)
[146.853564] [053/161] (865s left) i915_hangman (error-state-basic)
[146.989022] Starting subtest: error-state-basic
[147.012311] Subtest error-state-basic: SUCCESS (0.019s)
[147.185121] [054/161] (865s left) i915_pciid
[147.485512] [055/161] (864s left) kms_addfb_basic (addfb25-4-tiled)
[147.665290] Starting subtest: addfb25-4-tiled
[147.667728] Subtest addfb25-4-tiled: SUCCESS (0.001s)
[147.850255] [056/161] (864s left) kms_addfb_basic (addfb25-bad-modifier)
[148.013561] Starting subtest: addfb25-bad-modifier
[148.016401] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[148.183296] [057/161] (864s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[148.354192] Starting subtest: addfb25-framebuffer-vs-set-tiling
[148.356584] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[148.518871] [058/161] (864s left) kms_addfb_basic (addfb25-modifier-no-flag)
[148.688122] Starting subtest: addfb25-modifier-no-flag
[148.690512] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[148.881397] [059/161] (863s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[149.047361] Starting subtest: addfb25-x-tiled-legacy
[149.049748] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[149.220595] [060/161] (863s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[149.392417] Starting subtest: addfb25-x-tiled-mismatch-legacy
[149.394923] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[149.558515] [061/161] (863s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[149.729538] Starting subtest: addfb25-yf-tiled-legacy
[149.732023] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[149.905800] [062/161] (863s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[150.076280] Starting subtest: addfb25-y-tiled-legacy
[150.078693] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[150.253783] [063/161] (862s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[150.421303] Starting subtest: addfb25-y-tiled-small-legacy
[150.423765] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s)
[150.609049] [064/161] (862s left) kms_addfb_basic (bad-pitch-0)
[150.718683] Starting subtest: bad-pitch-0
[150.721214] Subtest bad-pitch-0: SUCCESS (0.000s)
[150.964749] [065/161] (862s left) kms_addfb_basic (bad-pitch-1024)
[151.077390] Starting subtest: bad-pitch-1024
[151.079819] Subtest bad-pitch-1024: SUCCESS (0.000s)
[151.305744] [066/161] (862s left) kms_addfb_basic (bad-pitch-128)
[151.415061] Starting subtest: bad-pitch-128
[151.417438] Subtest bad-pitch-128: SUCCESS (0.000s)
[151.666095] [067/161] (861s left) kms_addfb_basic (bad-pitch-256)
[151.774017] Starting subtest: bad-pitch-256
[151.776393] Subtest bad-pitch-256: SUCCESS (0.000s)
[152.019973] [068/161] (861s left) kms_addfb_basic (bad-pitch-32)
[152.127871] Starting subtest: bad-pitch-32
[152.130363] Subtest bad-pitch-32: SUCCESS (0.000s)
[152.356759] [069/161] (861s left) kms_addfb_basic (bad-pitch-63)
[152.465776] Starting subtest: bad-pitch-63
[152.468303] Subtest bad-pitch-63: SUCCESS (0.000s)
[152.726360] [070/161] (861s left) kms_addfb_basic (bad-pitch-65536)
[152.885522] Starting subtest: bad-pitch-65536
[152.889251] Subtest bad-pitch-65536: SUCCESS (0.001s)
[153.154459] [071/161] (860s left) kms_addfb_basic (bad-pitch-999)
[153.264803] Starting subtest: bad-pitch-999
[153.267809] Subtest bad-pitch-999: SUCCESS (0.000s)
[153.487860] [072/161] (860s left) kms_addfb_basic (basic)
[153.596628] Starting subtest: basic
[153.599362] Subtest basic: SUCCESS (0.000s)
[153.846680] [073/161] (860s left) kms_addfb_basic (basic-x-tiled-legacy)
[153.958540] Starting subtest: basic-x-tiled-legacy
[153.961065] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[154.206968] [074/161] (860s left) kms_addfb_basic (basic-y-tiled-legacy)
[154.316191] Starting subtest: basic-y-tiled-legacy
[154.318599] Subtest basic-y-tiled-legacy: SUCCESS (0.001s)
[154.554774] [075/161] (859s left) kms_addfb_basic (bo-too-small)
[154.720388] Starting subtest: bo-too-small
[154.722991] Subtest bo-too-small: SUCCESS (0.001s)
[154.921684] [076/161] (859s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[155.092529] Starting subtest: bo-too-small-due-to-tiling
[155.095176] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[155.280926] [077/161] (859s left) kms_addfb_basic (clobberred-modifier)
[155.392414] Starting subtest: clobberred-modifier
[155.394893] Subtest clobberred-modifier: SUCCESS (0.000s)
[155.623413] [078/161] (859s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[155.733419] Starting subtest: framebuffer-vs-set-tiling
[155.735896] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[155.969462] [079/161] (858s left) kms_addfb_basic (invalid-get-prop)
[156.078270] Starting subtest: invalid-get-prop
[156.080752] Subtest invalid-get-prop: SUCCESS (0.000s)
[156.330290] [080/161] (858s left) kms_addfb_basic (invalid-get-prop-any)
[156.441366] Starting subtest: invalid-get-prop-any
[156.443750] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[156.674680] [081/161] (858s left) kms_addfb_basic (invalid-set-prop)
[156.782422] Starting subtest: invalid-set-prop
[156.784488] Subtest invalid-set-prop: SUCCESS (0.000s)
[157.015995] [082/161] (858s left) kms_addfb_basic (invalid-set-prop-any)
[157.125947] Starting subtest: invalid-set-prop-any
[157.128539] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[157.374591] [083/161] (857s left) kms_addfb_basic (no-handle)
[157.477606] Starting subtest: no-handle
[157.480190] Subtest no-handle: SUCCESS (0.000s)
[157.725622] [084/161] (857s left) kms_addfb_basic (size-max)
[157.893443] Starting subtest: size-max
[157.895980] Subtest size-max: SUCCESS (0.000s)
[158.075884] [085/161] (857s left) kms_addfb_basic (small-bo)
[158.244395] Starting subtest: small-bo
[158.246966] Subtest small-bo: SUCCESS (0.000s)
[158.441197] [086/161] (857s left) kms_addfb_basic (tile-pitch-mismatch)
[158.547817] Starting subtest: tile-pitch-mismatch
[158.550522] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[158.798057] [087/161] (856s left) kms_addfb_basic (too-high)
[158.965587] Starting subtest: too-high
[158.968204] Subtest too-high: SUCCESS (0.002s)
[159.147357] [088/161] (856s left) kms_addfb_basic (too-wide)
[159.314542] Starting subtest: too-wide
[159.317207] Subtest too-wide: SUCCESS (0.000s)
[159.502101] [089/161] (856s left) kms_addfb_basic (unused-handle)
[159.610423] Starting subtest: unused-handle
[159.612952] Subtest unused-handle: SUCCESS (0.000s)
[159.855093] [090/161] (856s left) kms_addfb_basic (unused-modifier)
[159.962828] Starting subtest: unused-modifier
[159.965145] Subtest unused-modifier: SUCCESS (0.000s)
[160.204343] [091/161] (855s left) kms_addfb_basic (unused-offsets)
[160.313127] Starting subtest: unused-offsets
[160.315518] Subtest unused-offsets: SUCCESS (0.000s)
[160.564726] [092/161] (855s left) kms_addfb_basic (unused-pitches)
[160.672994] Starting subtest: unused-pitches
[160.675831] Subtest unused-pitches: SUCCESS (0.000s)
[160.933833] [093/161] (855s left) kms_busy (basic)
[161.106977] Starting subtest: basic
[161.112182] Starting dynamic subtest: flip
[162.162088] Dynamic subtest flip: SUCCESS (1.049s)
[162.198795] Starting dynamic subtest: modeset
[166.127417] Dynamic subtest modeset: SUCCESS (3.965s)
[166.130833] Subtest basic: SUCCESS (5.018s)
[167.103938] [094/161] (849s left) kms_prop_blob (basic)
[167.213708] Starting subtest: basic
[167.216431] Subtest basic: SUCCESS (0.000s)
[167.367993] [095/161] (849s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[167.537656] Starting subtest: basic-busy-flip-before-cursor-atomic
[167.542706] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[167.707195] [096/161] (848s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[167.941851] Starting subtest: basic-busy-flip-before-cursor-legacy
[167.947090] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[168.099369] [097/161] (848s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[168.266697] Starting subtest: basic-flip-after-cursor-atomic
[169.539830] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.273s)
[170.495952] [098/161] (846s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[170.663616] Starting subtest: basic-flip-after-cursor-legacy
[171.932663] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.270s)
[172.948104] [099/161] (843s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[173.118636] Starting subtest: basic-flip-after-cursor-varying-size
[174.385257] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.267s)
[175.405613] [100/161] (841s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[175.575576] Starting subtest: basic-flip-before-cursor-atomic
[176.845047] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.268s)
[177.849251] [101/161] (839s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[178.019724] Starting subtest: basic-flip-before-cursor-legacy
[179.302851] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.283s)
[180.292234] [102/161] (836s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[180.459790] Starting subtest: basic-flip-before-cursor-varying-size
[181.732325] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.271s)
[182.645512] [103/161] (834s left) kms_dsc (dsc-basic)
[182.830047] Starting subtest: dsc-basic
[182.851206] Subtest dsc-basic: SKIP (0.001s)
[182.978717] [104/161] (834s left) kms_flip (basic-flip-vs-dpms)
[183.147491] Starting subtest: basic-flip-vs-dpms
[183.153252] Starting dynamic subtest: A-eDP1
[186.088714] Dynamic subtest A-eDP1: SUCCESS (2.934s)
[186.134555] Starting dynamic subtest: B-eDP1
[188.453536] Dynamic subtest B-eDP1: SUCCESS (2.364s)
[188.497230] Starting dynamic subtest: C-eDP1
[190.853419] Dynamic subtest C-eDP1: SUCCESS (2.398s)
[190.860735] Subtest basic-flip-vs-dpms: SUCCESS (7.710s)
[191.808847] [105/161] (825s left) kms_flip (basic-flip-vs-modeset)
[191.977848] Starting subtest: basic-flip-vs-modeset
[191.983340] Starting dynamic subtest: A-eDP1
[194.913526] Dynamic subtest A-eDP1: SUCCESS (2.931s)
[194.957444] Starting dynamic subtest: B-eDP1
[197.283766] Dynamic subtest B-eDP1: SUCCESS (2.367s)
[197.326275] Starting dynamic subtest: C-eDP1
[199.672518] Dynamic subtest C-eDP1: SUCCESS (2.384s)
[199.675783] Subtest basic-flip-vs-modeset: SUCCESS (7.698s)
[200.658168] [106/161] (816s left) kms_flip (basic-flip-vs-wf_vblank)
[200.826928] Starting subtest: basic-flip-vs-wf_vblank
[200.833873] Starting dynamic subtest: A-eDP1
[203.122955] Dynamic subtest A-eDP1: SUCCESS (2.291s)
[203.156061] Starting dynamic subtest: B-eDP1
[205.449812] Dynamic subtest B-eDP1: SUCCESS (2.324s)
[205.480693] Starting dynamic subtest: C-eDP1
[207.789842] Dynamic subtest C-eDP1: SUCCESS (2.338s)
[207.796604] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.967s)
[209.198541] [107/161] (808s left) kms_flip (basic-plain-flip)
[209.366438] Starting subtest: basic-plain-flip
[209.373249] Starting dynamic subtest: A-eDP1
[211.388070] Dynamic subtest A-eDP1: SUCCESS (2.016s)
[211.429547] Starting dynamic subtest: B-eDP1
[213.395790] Dynamic subtest B-eDP1: SUCCESS (2.005s)
[213.428020] Starting dynamic subtest: C-eDP1
[215.430036] Dynamic subtest C-eDP1: SUCCESS (2.032s)
[215.436659] Subtest basic-plain-flip: SUCCESS (6.067s)
[216.800344] [108/161] (801s left) kms_force_connector_basic (force-connector-state)
[216.942837] Starting subtest: force-connector-state
[217.871122] Subtest force-connector-state: SUCCESS (0.931s)
[218.847101] [109/161] (799s left) kms_force_connector_basic (force-edid)
[218.988348] Starting subtest: force-edid
[219.263837] Subtest force-edid: SUCCESS (0.278s)
[219.542183] [110/161] (798s left) kms_force_connector_basic (force-load-detect)
[219.680480] Starting subtest: force-load-detect
[219.685529] Subtest force-load-detect: SKIP (0.000s)
[219.913508] [111/161] (798s left) kms_force_connector_basic (prune-stale-modes)
[220.049825] Starting subtest: prune-stale-modes
[220.382613] Subtest prune-stale-modes: SUCCESS (0.335s)
[220.672977] [112/161] (797s left) kms_frontbuffer_tracking (basic)
[220.853102] Starting subtest: basic
[224.946517] Subtest basic: SUCCESS (4.094s)
[225.199729] [113/161] (793s left) kms_hdmi_inject (inject-audio)
[225.677845] Starting subtest: inject-audio
[226.034822] Subtest inject-audio: SUCCESS (0.358s)
[226.694232] [114/161] (791s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[226.867560] Starting subtest: compare-crc-sanitycheck-xr24
[226.870376] Starting dynamic subtest: pipe-A-eDP-1
[227.688221] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.816s)
[227.732204] Starting dynamic subtest: pipe-B-eDP-1
[229.053225] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.356s)
[229.098798] Starting dynamic subtest: pipe-C-eDP-1
[230.404792] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.346s)
[230.408279] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.538s)
[231.349586] [115/161] (787s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[231.519879] Starting subtest: compare-crc-sanitycheck-nv12
[231.522728] Starting dynamic subtest: pipe-A-eDP-1
[232.701862] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.178s)
[232.745535] Starting dynamic subtest: pipe-B-eDP-1
[234.118198] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.408s)
[234.166871] Starting dynamic subtest: pipe-C-eDP-1
[235.483408] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.360s)
[235.486837] Subtest compare-crc-sanitycheck-nv12: SUCCESS (3.966s)
[236.403592] [116/161] (782s left) kms_pipe_crc_basic (hang-read-crc)
[236.577945] Starting subtest: hang-read-crc
[236.580766] Starting dynamic subtest: pipe-A-eDP-1
[239.139583] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.558s)
[239.184692] Starting dynamic subtest: pipe-B-eDP-1
[242.146495] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.996s)
[242.185485] Starting dynamic subtest: pipe-C-eDP-1
[245.299700] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.147s)
[245.302947] Subtest hang-read-crc: SUCCESS (8.723s)
[246.292970] [117/161] (772s left) kms_pipe_crc_basic (nonblocking-crc)
[246.462826] Starting subtest: nonblocking-crc
[246.465620] Starting dynamic subtest: pipe-A-eDP-1
[247.456327] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.991s)
[247.507235] Starting dynamic subtest: pipe-B-eDP-1
[249.052475] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.583s)
[249.095535] Starting dynamic subtest: pipe-C-eDP-1
[250.605431] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.549s)
[250.609038] Subtest nonblocking-crc: SUCCESS (4.146s)
[251.551406] [118/161] (767s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[251.721359] Starting subtest: nonblocking-crc-frame-sequence
[251.724174] Starting dynamic subtest: pipe-A-eDP-1
[252.732507] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.009s)
[252.785099] Starting dynamic subtest: pipe-B-eDP-1
[254.291232] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.545s)
[254.334444] Starting dynamic subtest: pipe-C-eDP-1
[255.872332] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.577s)
[255.875706] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.155s)
[256.813236] [119/161] (762s left) kms_pipe_crc_basic (read-crc)
[256.984176] Starting subtest: read-crc
[256.986865] Starting dynamic subtest: pipe-A-eDP-1
[257.938725] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.952s)
[257.971149] Starting dynamic subtest: pipe-B-eDP-1
[259.517931] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.570s)
[259.567747] Starting dynamic subtest: pipe-C-eDP-1
[261.079526] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.554s)
[261.083042] Subtest read-crc: SUCCESS (4.096s)
[262.073463] [120/161] (757s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[262.246755] Starting subtest: read-crc-frame-sequence
[262.249648] Starting dynamic subtest: pipe-A-eDP-1
[263.190488] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.939s)
[263.234989] Starting dynamic subtest: pipe-B-eDP-1
[264.764821] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.567s)
[264.811549] Starting dynamic subtest: pipe-C-eDP-1
[266.324764] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.549s)
[266.328125] Subtest read-crc-frame-sequence: SUCCESS (4.078s)
[267.239245] [121/161] (752s left) kms_pm_backlight (basic-brightness)
[267.410691] Starting subtest: basic-brightness
[267.526327] Starting dynamic subtest: eDP-1
[268.098379] Dynamic subtest eDP-1: SUCCESS (0.570s)
[268.102370] Subtest basic-brightness: SUCCESS (0.688s)
[269.016962] [122/161] (750s left) kms_pm_rpm (basic-pci-d3-state)
[270.838174] Starting subtest: basic-pci-d3-state
[271.480377] Subtest basic-pci-d3-state: SUCCESS (0.637s)
[271.750399] [123/161] (747s left) kms_pm_rpm (basic-rte)
[271.860524] Starting subtest: basic-rte
[274.248150] Subtest basic-rte: SUCCESS (2.386s)
[275.564365] [124/161] (744s left) kms_psr (psr-primary-page-flip)
[275.735453] Starting subtest: psr-primary-page-flip
[275.738271] Starting dynamic subtest: eDP-1
[279.757725] Dynamic subtest eDP-1: SUCCESS (4.019s)
[279.760998] Subtest psr-primary-page-flip: SUCCESS (4.024s)
[280.693866] [125/161] (739s left) kms_psr (psr-cursor-plane-move)
[280.865212] Starting subtest: psr-cursor-plane-move
[280.867899] Starting dynamic subtest: eDP-1
[284.799226] Dynamic subtest eDP-1: SUCCESS (3.931s)
[284.802167] Subtest psr-cursor-plane-move: SUCCESS (3.935s)
[285.744845] [126/161] (734s left) kms_psr (psr-sprite-plane-onoff)
[285.915709] Starting subtest: psr-sprite-plane-onoff
[285.918449] Starting dynamic subtest: eDP-1
[289.952710] Dynamic subtest eDP-1: SUCCESS (4.032s)
[289.955906] Subtest psr-sprite-plane-onoff: SUCCESS (4.036s)
[290.902742] [127/161] (729s left) kms_psr (psr-primary-mmap-gtt)
[291.075310] Starting subtest: psr-primary-mmap-gtt
[291.078106] Starting dynamic subtest: eDP-1
[295.111799] Dynamic subtest eDP-1: SUCCESS (4.032s)
[295.114685] Subtest psr-primary-mmap-gtt: SUCCESS (4.037s)
[296.059712] [128/161] (723s left) kms_setmode (basic-clone-single-crtc)
[296.176497] Starting subtest: basic-clone-single-crtc
[296.184031] Subtest basic-clone-single-crtc: SKIP (0.000s)
[296.321968] [129/161] (723s left) i915_pm_rps (basic-api)
[296.445942] Starting subtest: basic-api
[296.452669] Subtest basic-api: SUCCESS (0.006s)
[296.624825] [130/161] (723s left) prime_self_import (basic-llseek-bad)
[296.735886] Starting subtest: basic-llseek-bad
[296.741512] Subtest basic-llseek-bad: SUCCESS (0.005s)
[296.906800] [131/161] (723s left) prime_self_import (basic-llseek-size)
[297.014712] Starting subtest: basic-llseek-size
[297.019584] Subtest basic-llseek-size: SUCCESS (0.008s)
[297.186705] [132/161] (723s left) prime_self_import (basic-with_fd_dup)
[297.292882] Starting subtest: basic-with_fd_dup
[297.298275] Subtest basic-with_fd_dup: SUCCESS (0.008s)
[297.473286] [133/161] (723s left) prime_self_import (basic-with_one_bo)
[297.576283] Starting subtest: basic-with_one_bo
[297.585984] Subtest basic-with_one_bo: SUCCESS (0.008s)
[297.743241] [134/161] (722s left) prime_self_import (basic-with_one_bo_two_files)
[297.847455] Starting subtest: basic-with_one_bo_two_files
[297.856854] Subtest basic-with_one_bo_two_files: SUCCESS (0.007s)
[298.024117] [135/161] (722s left) prime_self_import (basic-with_two_bos)
[298.129582] Starting subtest: basic-with_two_bos
[298.139190] Subtest basic-with_two_bos: SUCCESS (0.008s)
[298.310317] [136/161] (722s left) prime_vgem (basic-fence-flip)
[298.460227] Starting subtest: basic-fence-flip
[299.049878] Subtest basic-fence-flip: SUCCESS (0.593s)
[299.227577] [137/161] (721s left) prime_vgem (basic-fence-mmap)
[299.376140] Starting subtest: basic-fence-mmap
[299.437562] Subtest basic-fence-mmap: SUCCESS (0.061s)
[299.590345] [138/161] (721s left) prime_vgem (basic-fence-read)
[299.747291] Starting subtest: basic-fence-read
[299.854875] Subtest basic-fence-read: SUCCESS (0.110s)
[300.008299] [139/161] (721s left) prime_vgem (basic-gtt)
[300.149904] Starting subtest: basic-gtt
[300.178901] Subtest basic-gtt: SUCCESS (0.029s)
[300.341372] [140/161] (720s left) prime_vgem (basic-read)
[300.487445] Starting subtest: basic-read
[300.536677] Subtest basic-read: SUCCESS (0.053s)
[300.690627] [141/161] (720s left) prime_vgem (basic-write)
[300.817288] Starting subtest: basic-write
[300.887103] Subtest basic-write: SUCCESS (0.070s)
[301.039888] [142/161] (720s left) vgem_basic (setversion)
[301.153988] Starting subtest: setversion
[301.158783] Subtest setversion: SUCCESS (0.000s)
[301.294870] [143/161] (720s left) vgem_basic (create)
[301.419191] Starting subtest: create
[301.421757] Subtest create: SUCCESS (0.001s)
[301.558202] [144/161] (720s left) vgem_basic (debugfs)
[301.684946] Starting subtest: debugfs
[301.687740] Subtest debugfs: SUCCESS (0.001s)
[301.823114] [145/161] (719s left) vgem_basic (dmabuf-export)
[301.935826] Starting subtest: dmabuf-export
[301.941283] Subtest dmabuf-export: SUCCESS (0.005s)
[302.108784] [146/161] (719s left) vgem_basic (dmabuf-fence)
[302.219188] Starting subtest: dmabuf-fence
[302.221679] Subtest dmabuf-fence: SUCCESS (0.002s)
[302.357240] [147/161] (719s left) vgem_basic (dmabuf-fence-before)
[302.485843] Starting subtest: dmabuf-fence-before
[302.488389] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[302.624820] [148/161] (719s left) vgem_basic (dmabuf-mmap)
[302.754858] Starting subtest: dmabuf-mmap
[302.787145] Subtest dmabuf-mmap: SUCCESS (0.035s)
[302.944263] [149/161] (719s left) vgem_basic (mmap)
[303.072781] Starting subtest: mmap
[303.089501] Subtest mmap: SUCCESS (0.022s)
[303.247347] [150/161] (719s left) vgem_basic (second-client)
[303.368986] Starting subtest: second-client
[303.403255] Subtest second-client: SUCCESS (0.033s)
[303.542953] [151/161] (718s left) vgem_basic (sysfs)
[303.672817] Starting subtest: sysfs
[303.675257] Subtest sysfs: SUCCESS (0.001s)
[303.807680] [152/161] (718s left) core_hotunplug (unbind-rebind)
[304.020361] Starting subtest: unbind-rebind
[309.414257] Subtest unbind-rebind: SUCCESS (5.395s)
[309.523113] [153/161] (713s left) vgem_basic (unload)
[309.634405] Starting subtest: unload
[338.858157] Subtest unload: SUCCESS (29.222s)
[339.104711] [154/161] (683s left) i915_module_load (reload)
[339.215347] Starting subtest: reload
[344.436123] Subtest reload: SUCCESS (5.223s)
[344.587157] [155/161] (678s left) gem_lmem_swapping (basic)
[344.730102] Subtest basic: SKIP (0.000s)
[344.875138] [156/161] (678s left) gem_lmem_swapping (parallel-random-engines)
[345.003222] Subtest parallel-random-engines: SKIP (0.000s)
[345.122922] [157/161] (678s left) gem_lmem_swapping (random-engines)
[345.250590] Subtest random-engines: SKIP (0.000s)
[345.372836] [158/161] (677s left) gem_lmem_swapping (verify-random)
[345.502549] Subtest verify-random: SKIP (0.000s)
[345.622727] [159/161] (677s left) i915_pm_rpm (module-reload)
[358.211300] Starting subtest: module-reload
[392.406979] Subtest module-reload: SUCCESS (34.194s)
[392.480716] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[392.483955] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[392.491493] [160/161] (630s left) i915_selftest (live)
[392.612538] Starting subtest: live
[392.615622] Starting dynamic subtest: sanitycheck
[396.368875] Dynamic subtest sanitycheck: SUCCESS (3.751s)
[396.403335] Starting dynamic subtest: uncore
[399.937420] Dynamic subtest uncore: SUCCESS (3.566s)
[399.971863] Starting dynamic subtest: workarounds
[403.952606] Dynamic subtest workarounds: SUCCESS (4.010s)
[404.000243] Starting dynamic subtest: gt_engines
[408.014607] Dynamic subtest gt_engines: SUCCESS (4.057s)
[408.051473] Starting dynamic subtest: gt_timelines
[424.557297] Dynamic subtest gt_timelines: SUCCESS (16.539s)
[424.586570] Starting dynamic subtest: gt_contexts
[428.266477] Dynamic subtest gt_contexts: SUCCESS (3.704s)
[428.297247] Starting dynamic subtest: gt_lrc
[434.207238] Dynamic subtest gt_lrc: SUCCESS (5.935s)
[434.236870] Starting dynamic subtest: gt_mocs
[438.028680] Dynamic subtest gt_mocs: SUCCESS (3.817s)
[438.066606] Starting dynamic subtest: gt_pm
[448.250590] Dynamic subtest gt_pm: SUCCESS (10.217s)
[448.278178] Starting dynamic subtest: gt_heartbeat
[451.919545] Dynamic subtest gt_heartbeat: SUCCESS (3.664s)
[451.949544] Starting dynamic subtest: gt_tlb
[456.897749] Dynamic subtest gt_tlb: SUCCESS (4.973s)
[456.938811] Starting dynamic subtest: requests
[466.503544] Dynamic subtest requests: SUCCESS (9.600s)
[466.537373] Starting dynamic subtest: migrate
[472.995504] Dynamic subtest migrate: SUCCESS (6.486s)
[473.025674] Starting dynamic subtest: active
[476.675597] Dynamic subtest active: SUCCESS (3.675s)
[476.705679] Starting dynamic subtest: objects
[481.507520] Dynamic subtest objects: SUCCESS (4.827s)
[481.535853] Starting dynamic subtest: mman
[490.020592] Dynamic subtest mman: SUCCESS (8.508s)
[490.051500] Starting dynamic subtest: dmabuf
[493.757549] Dynamic subtest dmabuf: SUCCESS (3.732s)
[493.787837] Starting dynamic subtest: vma
[497.381562] Dynamic subtest vma: SUCCESS (3.619s)
[497.411550] Starting dynamic subtest: coherency
[503.304848] Dynamic subtest coherency: SUCCESS (5.918s)
[503.335893] Starting dynamic subtest: gtt
[515.084438] Dynamic subtest gtt: SUCCESS (11.774s)
[515.113600] Starting dynamic subtest: gem
[519.195500] Dynamic subtest gem: SUCCESS (4.106s)
[519.225494] Starting dynamic subtest: evict
[524.954621] Dynamic subtest evict: SUCCESS (5.754s)
[524.988734] Starting dynamic subtest: hugepages
[535.011776] Dynamic subtest hugepages: SUCCESS (10.052s)
[535.047129] Starting dynamic subtest: gem_contexts
[553.206626] Dynamic subtest gem_contexts: SUCCESS (18.189s)
[553.234994] Starting dynamic subtest: client
[556.895885] Dynamic subtest client: SUCCESS (3.685s)
[556.930823] Starting dynamic subtest: gem_migrate
[560.607443] Dynamic subtest gem_migrate: SUCCESS (3.706s)
[560.636929] Starting dynamic subtest: reset
[571.301362] Dynamic subtest reset: SUCCESS (10.689s)
[571.331605] Starting dynamic subtest: memory_region
[574.975748] Dynamic subtest memory_region: SUCCESS (3.669s)
[575.005987] Starting dynamic subtest: hangcheck
[601.666061] Dynamic subtest hangcheck: SUCCESS (26.684s)
[601.695571] Starting dynamic subtest: execlists
[615.041962] Dynamic subtest execlists: SUCCESS (13.370s)
[615.076417] Starting dynamic subtest: ring_submission
[618.695571] Dynamic subtest ring_submission: SUCCESS (3.648s)
[618.727521] Starting dynamic subtest: perf
[622.585536] Dynamic subtest perf: SUCCESS (3.885s)
[622.615493] Starting dynamic subtest: slpc
[626.219461] Dynamic subtest slpc: SUCCESS (3.629s)
[626.253911] Starting dynamic subtest: guc
[629.826480] Dynamic subtest guc: SUCCESS (3.602s)
[629.856048] Starting dynamic subtest: guc_multi_lrc
[633.436051] Dynamic subtest guc_multi_lrc: SUCCESS (3.604s)
[633.465093] Starting dynamic subtest: guc_hang
[637.045829] Dynamic subtest guc_hang: SUCCESS (3.605s)
[637.075930] Starting dynamic subtest: late_gt_pm
[640.749728] Dynamic subtest late_gt_pm: SUCCESS (3.699s)
[640.753193] Subtest live: SUCCESS (248.130s)
[640.840237] [161/161] (382s left) dmabuf (all-tests)
[640.963802] Starting subtest: all-tests
[640.968155] Starting dynamic subtest: sanitycheck
[641.066967] Dynamic subtest sanitycheck: SUCCESS (0.106s)
[641.106975] Starting dynamic subtest: dma_fence
[641.309177] Dynamic subtest dma_fence: SUCCESS (0.236s)
[641.344130] Starting dynamic subtest: dma_fence_chain
[656.602042] Dynamic subtest dma_fence_chain: SUCCESS (15.287s)
[656.633416] Starting dynamic subtest: dma_fence_unwrap
[656.709668] Dynamic subtest dma_fence_unwrap: SUCCESS (0.103s)
[656.742761] Starting dynamic subtest: dma_resv
[656.810626] Dynamic subtest dma_resv: SUCCESS (0.096s)
[656.814144] Subtest all-tests: SUCCESS (15.853s)
[656.895075] Closing watchdogs
Done.