[42.978220] Initializing watchdogs
[42.978297]   /dev/watchdog0
[42.997288] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:46d3 Intel Alderlake_n (Gen12) 
[43.002154] [001/162] (960s left) i915_module_load (load)
[43.044596] Starting subtest: load
[45.590230] Subtest load: SUCCESS (2.545s)
[45.627090] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[45.628896] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[45.631444] [002/162] (957s left) core_auth (basic-auth)
[45.709542] Starting subtest: basic-auth
[45.711998] Subtest basic-auth: SUCCESS (0.001s)
[45.840186] [003/162] (957s left) core_debugfs (read-all-entries)
[45.878199] Starting subtest: read-all-entries
[46.009228] Subtest read-all-entries: SUCCESS (0.131s)
[46.140769] [004/162] (957s left) core_sysfs (read-all-entries)
[46.177609] Starting subtest: read-all-entries
[46.181637] Subtest read-all-entries: SUCCESS (0.004s)
[46.308490] [005/162] (957s left) fbdev (eof)
[46.357394] Starting subtest: eof
[46.358226] Subtest eof: SUCCESS (0.001s)
[46.489600] [006/162] (957s left) fbdev (info)
[46.522828] Starting subtest: info
[46.523569] Subtest info: SUCCESS (0.000s)
[46.655125] [007/162] (957s left) fbdev (nullptr)
[46.706230] Starting subtest: nullptr
[46.707651] Subtest nullptr: SUCCESS (0.000s)
[46.824913] [008/162] (956s left) fbdev (read)
[46.873499] Starting subtest: read
[53.676164] Subtest read: SUCCESS (6.769s)
[53.775226] [009/162] (950s left) fbdev (write)
[53.822918] Starting subtest: write
[57.257290] Subtest write: SUCCESS (3.425s)
[57.380564] [010/162] (946s left) gem_basic (bad-close)
[57.418280] Starting subtest: bad-close
[57.419905] Subtest bad-close: SUCCESS (0.000s)
[57.545807] [011/162] (946s left) gem_basic (create-close)
[57.583485] Starting subtest: create-close
[57.584871] Subtest create-close: SUCCESS (0.000s)
[57.733817] [012/162] (946s left) gem_basic (create-fd-close)
[57.772823] Starting subtest: create-fd-close
[57.774322] Subtest create-fd-close: SUCCESS (0.000s)
[57.925637] [013/162] (946s left) gem_busy (busy@all-engines)
[57.979583] Starting subtest: busy
[57.980392] Starting dynamic subtest: all-engines
[58.022827] Dynamic subtest all-engines: SUCCESS (0.041s)
[58.023649] Subtest busy: SUCCESS (0.042s)
[58.467098] [014/162] (945s left) gem_close_race (basic-process)
[58.517302] Starting subtest: basic-process
[58.562002] Subtest basic-process: SUCCESS (0.042s)
[58.816136] [015/162] (945s left) gem_close_race (basic-threads)
[58.866495] Starting subtest: basic-threads
[60.054800] Subtest basic-threads: SUCCESS (1.146s)
[60.325356] [016/162] (943s left) gem_ctx_create (basic)
[60.420109] Starting subtest: basic
[60.421127] Subtest basic: SUCCESS (0.000s)
[60.685079] [017/162] (943s left) gem_ctx_create (basic-files)
[60.752105] Starting subtest: basic-files
[62.769568] Subtest basic-files: SUCCESS (1.965s)
[63.177116] [018/162] (941s left) gem_ctx_exec (basic)
[63.229900] Starting subtest: basic
[63.234487] Subtest basic: SUCCESS (0.005s)
[63.404896] [019/162] (940s left) gem_exec_basic (basic)
[63.461962] Starting subtest: basic
[63.462850] Starting dynamic subtest: rcs0-smem
[63.463636] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[63.474305] Starting dynamic subtest: bcs0-smem
[63.475076] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[63.484917] Starting dynamic subtest: vcs0-smem
[63.485708] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[63.495699] Starting dynamic subtest: vecs0-smem
[63.496498] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[63.497255] Subtest basic: SUCCESS (0.005s)
[63.728384] [020/162] (940s left) gem_exec_create (basic)
[63.785910] Starting subtest: basic
[63.786803] Starting dynamic subtest: smem
[65.887639] Dynamic subtest smem: SUCCESS (2.064s)
[65.889184] Subtest basic: SUCCESS (2.065s)
[66.148600] [021/162] (938s left) gem_exec_fence (basic-busy)
[66.321399] Starting subtest: basic-busy
[66.322404] Starting dynamic subtest: rcs0
[66.374943] Dynamic subtest rcs0: SUCCESS (0.054s)
[66.390273] Starting dynamic subtest: bcs0
[66.426374] Dynamic subtest bcs0: SUCCESS (0.050s)
[66.436821] Starting dynamic subtest: vcs0
[66.473951] Dynamic subtest vcs0: SUCCESS (0.046s)
[66.491739] Starting dynamic subtest: vecs0
[66.526611] Dynamic subtest vecs0: SUCCESS (0.050s)
[66.527851] Subtest basic-busy: SUCCESS (0.204s)
[67.511307] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[67.517533] [022/162] (937s left) gem_exec_fence (basic-wait)
[67.775933] Starting subtest: basic-wait
[67.777325] Starting dynamic subtest: rcs0
[67.871379] Dynamic subtest rcs0: SUCCESS (0.094s)
[67.883662] Starting dynamic subtest: bcs0
[68.074308] Dynamic subtest bcs0: SUCCESS (0.200s)
[68.086174] Starting dynamic subtest: vcs0
[68.125176] Dynamic subtest vcs0: SUCCESS (0.050s)
[68.137462] Starting dynamic subtest: vecs0
[68.206598] Dynamic subtest vecs0: SUCCESS (0.080s)
[68.207692] Subtest basic-wait: SUCCESS (0.426s)
[68.796542] [023/162] (935s left) gem_exec_fence (basic-await)
[68.968488] Starting subtest: basic-await
[68.969532] Starting dynamic subtest: rcs0
[69.053315] Dynamic subtest rcs0: SUCCESS (0.086s)
[69.068902] Starting dynamic subtest: bcs0
[69.138992] Dynamic subtest bcs0: SUCCESS (0.084s)
[69.158642] Starting dynamic subtest: vcs0
[69.228506] Dynamic subtest vcs0: SUCCESS (0.088s)
[69.251272] Starting dynamic subtest: vecs0
[69.322194] Dynamic subtest vecs0: SUCCESS (0.090s)
[69.323830] Subtest basic-await: SUCCESS (0.352s)
[69.907995] [024/162] (934s left) gem_exec_fence (nb-await)
[70.073613] Starting subtest: nb-await
[70.074768] Starting dynamic subtest: rcs0
[70.137608] Dynamic subtest rcs0: SUCCESS (0.066s)
[70.156314] Starting dynamic subtest: bcs0
[70.201429] Dynamic subtest bcs0: SUCCESS (0.062s)
[70.222550] Starting dynamic subtest: vcs0
[70.268852] Dynamic subtest vcs0: SUCCESS (0.066s)
[70.292260] Starting dynamic subtest: vecs0
[70.339840] Dynamic subtest vecs0: SUCCESS (0.069s)
[70.341478] Subtest nb-await: SUCCESS (0.267s)
[70.920496] [025/162] (933s left) gem_exec_gttfill (basic)
[70.967388] Starting subtest: basic
[74.721956] Subtest basic: SUCCESS (3.722s)
[74.986952] [026/162] (929s left) gem_exec_parallel (engines)
[75.107704] Starting subtest: engines
[75.108609] Starting dynamic subtest: basic
[77.275798] Dynamic subtest basic: SUCCESS (2.159s)
[77.294436] Starting dynamic subtest: contexts
[81.672844] Dynamic subtest contexts: SUCCESS (4.375s)
[81.690517] Starting dynamic subtest: fds
[85.712098] Dynamic subtest fds: SUCCESS (4.034s)
[85.728590] Starting dynamic subtest: userptr
[87.758845] Dynamic subtest userptr: SUCCESS (2.052s)
[87.760374] Subtest engines: SUCCESS (12.624s)
[88.033469] [027/162] (916s left) gem_exec_store (basic)
[88.094538] Starting subtest: basic
[88.187421] Subtest basic: SUCCESS (0.092s)
[88.446069] [028/162] (916s left) gem_flink_basic (bad-flink)
[88.488486] Starting subtest: bad-flink
[88.489254] Subtest bad-flink: SUCCESS (0.000s)
[88.630440] [029/162] (916s left) gem_flink_basic (bad-open)
[88.671473] Starting subtest: bad-open
[88.672322] Subtest bad-open: SUCCESS (0.000s)
[88.809276] [030/162] (916s left) gem_flink_basic (basic)
[88.849993] Starting subtest: basic
[88.850765] Subtest basic: SUCCESS (0.000s)
[89.010914] [031/162] (915s left) gem_flink_basic (double-flink)
[89.050321] Starting subtest: double-flink
[89.051105] Subtest double-flink: SUCCESS (0.000s)
[89.210842] [032/162] (915s left) gem_flink_basic (flink-lifetime)
[89.250011] Starting subtest: flink-lifetime
[89.251704] Subtest flink-lifetime: SUCCESS (0.001s)
[89.410886] [033/162] (915s left) gem_huc_copy (huc-copy)
[89.457779] Starting subtest: huc-copy
[89.461247] Subtest huc-copy: SUCCESS (0.004s)
[89.653368] [034/162] (915s left) gem_linear_blits (basic)
[89.787462] Starting subtest: basic
[89.795819] Subtest basic: SUCCESS (0.007s)
[89.970133] [035/162] (915s left) gem_mmap (basic)
[90.057848] Starting subtest: basic
[90.061300] Subtest basic: SUCCESS (0.001s)
[90.209893] [036/162] (915s left) gem_mmap_gtt (basic)
[90.250034] Starting subtest: basic
[90.250821] Subtest basic: SUCCESS (0.001s)
[90.400208] [037/162] (914s left) gem_render_linear_blits (basic)
[90.444703] Starting subtest: basic
[90.487386] Subtest basic: SUCCESS (0.043s)
[90.624601] [038/162] (914s left) gem_render_tiled_blits (basic)
[90.671558] Starting subtest: basic
[90.727716] Subtest basic: SUCCESS (0.056s)
[90.889650] [039/162] (914s left) gem_ringfill (basic-all)
[91.188694] Starting subtest: basic-all
[92.337875] Subtest basic-all: SUCCESS (1.140s)
[92.534717] [040/162] (912s left) gem_softpin (allocator-basic)
[92.594038] Starting subtest: allocator-basic
[92.734728] Subtest allocator-basic: SUCCESS (0.132s)
[92.914736] [041/162] (912s left) gem_softpin (allocator-basic-reserve)
[92.968664] Starting subtest: allocator-basic-reserve
[93.101614] Subtest allocator-basic-reserve: SUCCESS (0.125s)
[93.303055] [042/162] (912s left) gem_softpin (safe-alignment)
[93.356649] Starting subtest: safe-alignment
[93.375160] Subtest safe-alignment: SUCCESS (0.018s)
[93.565561] [043/162] (912s left) gem_sync (basic-all)
[93.622193] Starting subtest: basic-all
[96.075222] Subtest basic-all: SUCCESS (2.451s)
[96.333499] [044/162] (909s left) gem_sync (basic-each)
[96.382364] Starting subtest: basic-each
[99.191136] Subtest basic-each: SUCCESS (2.807s)
[99.451490] [045/162] (906s left) gem_tiled_blits (basic)
[99.573960] Starting subtest: basic
[99.593706] Subtest basic: SUCCESS (0.020s)
[99.792356] [046/162] (906s left) gem_tiled_fence_blits (basic)
[99.967381] Starting subtest: basic
[99.987156] Subtest basic: SUCCESS (0.020s)
[100.171429] [047/162] (905s left) gem_tiled_pread_basic
[100.329530] [048/162] (905s left) gem_wait (busy@all-engines)
[100.387872] Starting subtest: busy
[100.388647] Starting dynamic subtest: all-engines
[100.950942] Dynamic subtest all-engines: SUCCESS (0.563s)
[100.952304] Subtest busy: SUCCESS (0.564s)
[101.222623] [049/162] (904s left) gem_wait (wait@all-engines)
[101.277986] Starting subtest: wait
[101.278853] Starting dynamic subtest: all-engines
[102.344092] Dynamic subtest all-engines: SUCCESS (1.065s)
[102.345573] Subtest wait: SUCCESS (1.066s)
[102.611922] [050/162] (903s left) i915_getparams_basic (basic-eu-total)
[102.647865] Starting subtest: basic-eu-total
[102.649337] Subtest basic-eu-total: SUCCESS (0.000s)
[102.781610] [051/162] (903s left) i915_getparams_basic (basic-subslice-total)
[102.818998] Starting subtest: basic-subslice-total
[102.820526] Subtest basic-subslice-total: SUCCESS (0.000s)
[102.948888] [052/162] (903s left) i915_hangman (error-state-basic)
[102.995917] Starting subtest: error-state-basic
[103.110241] Subtest error-state-basic: SUCCESS (0.113s)
[103.260656] [053/162] (902s left) i915_pciid
[103.426076] [054/162] (902s left) intel_hwmon (hwmon-read)
[103.463292] Subtest hwmon-read: SKIP (0.000s)
[103.535179] [055/162] (902s left) intel_hwmon (hwmon-write)
[103.571958] Subtest hwmon-write: SKIP (0.000s)
[103.624938] [056/162] (902s left) kms_addfb_basic (addfb25-4-tiled)
[103.696899] Starting subtest: addfb25-4-tiled
[103.697749] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[103.863291] [057/162] (902s left) kms_addfb_basic (addfb25-bad-modifier)
[103.921685] Starting subtest: addfb25-bad-modifier
[103.922497] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[104.067170] [058/162] (902s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[104.130107] Starting subtest: addfb25-framebuffer-vs-set-tiling
[104.131035] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.001s)
[104.297954] [059/162] (902s left) kms_addfb_basic (addfb25-modifier-no-flag)
[104.356601] Starting subtest: addfb25-modifier-no-flag
[104.357346] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[104.518361] [060/162] (901s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[104.582110] Starting subtest: addfb25-x-tiled-legacy
[104.583026] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[104.747354] [061/162] (901s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[104.807433] Starting subtest: addfb25-x-tiled-mismatch-legacy
[104.808197] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[104.968339] [062/162] (901s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[105.031690] Starting subtest: addfb25-yf-tiled-legacy
[105.032488] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[105.188416] [063/162] (901s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[105.249412] Starting subtest: addfb25-y-tiled-legacy
[105.250403] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[105.418058] [064/162] (901s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[105.481882] Starting subtest: addfb25-y-tiled-small-legacy
[105.483079] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[105.670926] [065/162] (901s left) kms_addfb_basic (bad-pitch-0)
[105.712825] Starting subtest: bad-pitch-0
[105.713615] Subtest bad-pitch-0: SUCCESS (0.000s)
[105.899706] [066/162] (900s left) kms_addfb_basic (bad-pitch-1024)
[105.939816] Starting subtest: bad-pitch-1024
[105.940662] Subtest bad-pitch-1024: SUCCESS (0.000s)
[106.135295] [067/162] (900s left) kms_addfb_basic (bad-pitch-128)
[106.175076] Starting subtest: bad-pitch-128
[106.175809] Subtest bad-pitch-128: SUCCESS (0.000s)
[106.359597] [068/162] (900s left) kms_addfb_basic (bad-pitch-256)
[106.400893] Starting subtest: bad-pitch-256
[106.401649] Subtest bad-pitch-256: SUCCESS (0.000s)
[106.599496] [069/162] (900s left) kms_addfb_basic (bad-pitch-32)
[106.640068] Starting subtest: bad-pitch-32
[106.640842] Subtest bad-pitch-32: SUCCESS (0.000s)
[106.829733] [070/162] (900s left) kms_addfb_basic (bad-pitch-63)
[106.869121] Starting subtest: bad-pitch-63
[106.869871] Subtest bad-pitch-63: SUCCESS (0.000s)
[107.055669] [071/162] (900s left) kms_addfb_basic (bad-pitch-65536)
[107.098573] Starting subtest: bad-pitch-65536
[107.099294] Subtest bad-pitch-65536: SUCCESS (0.000s)
[107.283874] [072/162] (899s left) kms_addfb_basic (bad-pitch-999)
[107.324933] Starting subtest: bad-pitch-999
[107.325753] Subtest bad-pitch-999: SUCCESS (0.000s)
[107.515517] [073/162] (899s left) kms_addfb_basic (basic)
[107.555859] Starting subtest: basic
[107.556662] Subtest basic: SUCCESS (0.000s)
[107.742515] [074/162] (899s left) kms_addfb_basic (basic-x-tiled-legacy)
[107.782849] Starting subtest: basic-x-tiled-legacy
[107.783600] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[107.964429] [075/162] (899s left) kms_addfb_basic (basic-y-tiled-legacy)
[108.004983] Starting subtest: basic-y-tiled-legacy
[108.005768] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[108.189704] [076/162] (899s left) kms_addfb_basic (bo-too-small)
[108.251664] Starting subtest: bo-too-small
[108.252462] Subtest bo-too-small: SUCCESS (0.000s)
[108.426568] [077/162] (898s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[108.487690] Starting subtest: bo-too-small-due-to-tiling
[108.488475] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[108.662372] [078/162] (898s left) kms_addfb_basic (clobberred-modifier)
[108.703272] Starting subtest: clobberred-modifier
[108.704097] Subtest clobberred-modifier: SUCCESS (0.000s)
[108.865886] [079/162] (898s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[108.907047] Starting subtest: framebuffer-vs-set-tiling
[108.907799] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[109.103963] [080/162] (898s left) kms_addfb_basic (invalid-get-prop)
[109.144879] Starting subtest: invalid-get-prop
[109.145782] Subtest invalid-get-prop: SUCCESS (0.000s)
[109.330296] [081/162] (898s left) kms_addfb_basic (invalid-get-prop-any)
[109.372651] Starting subtest: invalid-get-prop-any
[109.373376] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[109.556817] [082/162] (898s left) kms_addfb_basic (invalid-set-prop)
[109.596844] Starting subtest: invalid-set-prop
[109.597665] Subtest invalid-set-prop: SUCCESS (0.000s)
[109.784090] [083/162] (897s left) kms_addfb_basic (invalid-set-prop-any)
[109.824241] Starting subtest: invalid-set-prop-any
[109.825056] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[110.020884] [084/162] (897s left) kms_addfb_basic (no-handle)
[110.061276] Starting subtest: no-handle
[110.062496] Subtest no-handle: SUCCESS (0.000s)
[110.259516] [085/162] (897s left) kms_addfb_basic (size-max)
[110.324282] Starting subtest: size-max
[110.325263] Subtest size-max: SUCCESS (0.000s)
[110.489790] [086/162] (897s left) kms_addfb_basic (small-bo)
[110.550841] Starting subtest: small-bo
[110.551617] Subtest small-bo: SUCCESS (0.000s)
[110.712170] [087/162] (897s left) kms_addfb_basic (tile-pitch-mismatch)
[110.753018] Starting subtest: tile-pitch-mismatch
[110.753746] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[110.938101] [088/162] (896s left) kms_addfb_basic (too-high)
[111.004304] Starting subtest: too-high
[111.005183] Subtest too-high: SUCCESS (0.001s)
[111.170718] [089/162] (896s left) kms_addfb_basic (too-wide)
[111.234579] Starting subtest: too-wide
[111.235351] Subtest too-wide: SUCCESS (0.000s)
[111.401621] [090/162] (896s left) kms_addfb_basic (unused-handle)
[111.441957] Starting subtest: unused-handle
[111.442801] Subtest unused-handle: SUCCESS (0.000s)
[111.626242] [091/162] (896s left) kms_addfb_basic (unused-modifier)
[111.666214] Starting subtest: unused-modifier
[111.666964] Subtest unused-modifier: SUCCESS (0.000s)
[111.856558] [092/162] (896s left) kms_addfb_basic (unused-offsets)
[111.897841] Starting subtest: unused-offsets
[111.898613] Subtest unused-offsets: SUCCESS (0.000s)
[112.082608] [093/162] (896s left) kms_addfb_basic (unused-pitches)
[112.122598] Starting subtest: unused-pitches
[112.123857] Subtest unused-pitches: SUCCESS (0.000s)
[112.298323] [094/162] (895s left) kms_busy (basic)
[112.365823] Starting subtest: basic
[112.366616] Starting dynamic subtest: flip
[113.153874] Dynamic subtest flip: SUCCESS (0.787s)
[113.165266] Starting dynamic subtest: modeset
[116.828215] Dynamic subtest modeset: SUCCESS (3.673s)
[116.828964] Subtest basic: SUCCESS (4.462s)
[117.785182] [095/162] (890s left) kms_prop_blob (basic)
[117.826387] Starting subtest: basic
[117.827152] Subtest basic: SUCCESS (0.000s)
[117.970945] [096/162] (890s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[118.072244] Starting subtest: basic-busy-flip-before-cursor-atomic
[118.073741] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[118.275353] [097/162] (890s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[118.373840] Starting subtest: basic-busy-flip-before-cursor-legacy
[118.375510] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[118.571062] [098/162] (889s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[118.675582] Starting subtest: basic-flip-after-cursor-atomic
[119.915374] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.239s)
[120.880947] [099/162] (887s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[120.982136] Starting subtest: basic-flip-after-cursor-legacy
[122.227276] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.241s)
[123.125760] [100/162] (885s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[123.224773] Starting subtest: basic-flip-after-cursor-varying-size
[124.420979] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.196s)
[125.365669] [101/162] (883s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[125.464616] Starting subtest: basic-flip-before-cursor-atomic
[126.694050] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.228s)
[127.612333] [102/162] (880s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[127.709454] Starting subtest: basic-flip-before-cursor-legacy
[128.912280] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.202s)
[129.842530] [103/162] (878s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[129.948221] Starting subtest: basic-flip-before-cursor-varying-size
[131.178241] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.229s)
[132.082253] [104/162] (876s left) kms_dsc (dsc-basic)
[132.147126] Starting subtest: dsc-basic
[132.150865] Subtest dsc-basic: SKIP (0.001s)
[132.291587] [105/162] (876s left) kms_flip (basic-flip-vs-dpms)
[132.348622] Starting subtest: basic-flip-vs-dpms
[132.350214] Starting dynamic subtest: A-eDP1
[135.123425] Dynamic subtest A-eDP1: SUCCESS (2.773s)
[135.135714] Starting dynamic subtest: B-eDP1
[137.519811] Dynamic subtest B-eDP1: SUCCESS (2.395s)
[137.540740] Starting dynamic subtest: C-eDP1
[139.893008] Dynamic subtest C-eDP1: SUCCESS (2.371s)
[139.894791] Subtest basic-flip-vs-dpms: SUCCESS (7.545s)
[140.880701] [106/162] (867s left) kms_flip (basic-flip-vs-modeset)
[140.944470] Starting subtest: basic-flip-vs-modeset
[140.946257] Starting dynamic subtest: A-eDP1
[143.703778] Dynamic subtest A-eDP1: SUCCESS (2.757s)
[143.717037] Starting dynamic subtest: B-eDP1
[146.093008] Dynamic subtest B-eDP1: SUCCESS (2.389s)
[146.105946] Starting dynamic subtest: C-eDP1
[148.448335] Dynamic subtest C-eDP1: SUCCESS (2.354s)
[148.452490] Subtest basic-flip-vs-modeset: SUCCESS (7.506s)
[149.334608] [107/162] (859s left) kms_flip (basic-flip-vs-wf_vblank)
[149.402330] Starting subtest: basic-flip-vs-wf_vblank
[149.403995] Starting dynamic subtest: A-eDP1
[151.616476] Dynamic subtest A-eDP1: SUCCESS (2.211s)
[151.638907] Starting dynamic subtest: B-eDP1
[153.872165] Dynamic subtest B-eDP1: SUCCESS (2.252s)
[153.896121] Starting dynamic subtest: C-eDP1
[156.093695] Dynamic subtest C-eDP1: SUCCESS (2.218s)
[156.097206] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.695s)
[157.356066] [108/162] (851s left) kms_flip (basic-plain-flip)
[157.424231] Starting subtest: basic-plain-flip
[157.427437] Starting dynamic subtest: A-eDP1
[159.349515] Dynamic subtest A-eDP1: SUCCESS (1.922s)
[159.371278] Starting dynamic subtest: B-eDP1
[161.268454] Dynamic subtest B-eDP1: SUCCESS (1.916s)
[161.290707] Starting dynamic subtest: C-eDP1
[163.177365] Dynamic subtest C-eDP1: SUCCESS (1.907s)
[163.180125] Subtest basic-plain-flip: SUCCESS (5.756s)
[164.657417] [109/162] (844s left) kms_force_connector_basic (force-connector-state)
[164.715298] Starting subtest: force-connector-state
[165.207198] Subtest force-connector-state: SUCCESS (0.493s)
[166.385331] [110/162] (842s left) kms_force_connector_basic (force-edid)
[166.439852] Starting subtest: force-edid
[166.478557] Subtest force-edid: SUCCESS (0.039s)
[166.665315] [111/162] (842s left) kms_force_connector_basic (force-load-detect)
[166.715375] Starting subtest: force-load-detect
[166.717406] Subtest force-load-detect: SKIP (0.000s)
[166.892777] [112/162] (842s left) kms_force_connector_basic (prune-stale-modes)
[166.942381] Starting subtest: prune-stale-modes
[166.979468] Subtest prune-stale-modes: SUCCESS (0.037s)
[167.164805] [113/162] (841s left) kms_frontbuffer_tracking (basic)
[167.229996] Starting subtest: basic
[172.702708] Subtest basic: SUCCESS (5.472s)
[172.872151] [114/162] (836s left) kms_hdmi_inject (inject-audio)
[173.232156] Starting subtest: inject-audio
[173.384461] Subtest inject-audio: SUCCESS (0.154s)
[174.215284] [115/162] (834s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[174.276120] Starting subtest: compare-crc-sanitycheck-xr24
[174.276875] Starting dynamic subtest: pipe-A-eDP-1
[175.126353] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.848s)
[175.146775] Starting dynamic subtest: pipe-B-eDP-1
[176.680049] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.551s)
[176.694190] Starting dynamic subtest: pipe-C-eDP-1
[178.095374] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.413s)
[178.096168] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.820s)
[179.035360] [116/162] (830s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[179.099185] Starting subtest: compare-crc-sanitycheck-nv12
[179.100328] Starting dynamic subtest: pipe-A-eDP-1
[180.138731] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.038s)
[180.154672] Starting dynamic subtest: pipe-B-eDP-1
[181.614723] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.473s)
[181.634162] Starting dynamic subtest: pipe-C-eDP-1
[183.042159] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.425s)
[183.042899] Subtest compare-crc-sanitycheck-nv12: SUCCESS (3.944s)
[183.979163] [117/162] (825s left) kms_pipe_crc_basic (hang-read-crc)
[184.038524] Starting subtest: hang-read-crc
[184.040918] Starting dynamic subtest: pipe-A-eDP-1
[186.449502] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.409s)
[186.470019] Starting dynamic subtest: pipe-B-eDP-1
[189.557635] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.103s)
[189.571848] Starting dynamic subtest: pipe-C-eDP-1
[192.532545] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.972s)
[192.533511] Subtest hang-read-crc: SUCCESS (8.492s)
[193.454089] [118/162] (815s left) kms_pipe_crc_basic (nonblocking-crc)
[193.523772] Starting subtest: nonblocking-crc
[193.525098] Starting dynamic subtest: pipe-A-eDP-1
[194.494044] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.968s)
[194.507324] Starting dynamic subtest: pipe-B-eDP-1
[196.176860] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.680s)
[196.196884] Starting dynamic subtest: pipe-C-eDP-1
[197.764027] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.582s)
[197.765155] Subtest nonblocking-crc: SUCCESS (4.240s)
[198.721276] [119/162] (810s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[198.789170] Starting subtest: nonblocking-crc-frame-sequence
[198.789995] Starting dynamic subtest: pipe-A-eDP-1
[199.754732] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.964s)
[199.767468] Starting dynamic subtest: pipe-B-eDP-1
[201.468311] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.711s)
[201.489915] Starting dynamic subtest: pipe-C-eDP-1
[203.031318] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.558s)
[203.032088] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.243s)
[204.008378] [120/162] (805s left) kms_pipe_crc_basic (read-crc)
[204.076146] Starting subtest: read-crc
[204.079085] Starting dynamic subtest: pipe-A-eDP-1
[204.962242] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.883s)
[204.975366] Starting dynamic subtest: pipe-B-eDP-1
[206.565945] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.602s)
[206.581447] Starting dynamic subtest: pipe-C-eDP-1
[208.059934] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.491s)
[208.060737] Subtest read-crc: SUCCESS (3.984s)
[208.994428] [121/162] (800s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[209.063241] Starting subtest: read-crc-frame-sequence
[209.066240] Starting dynamic subtest: pipe-A-eDP-1
[209.929795] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.863s)
[209.943293] Starting dynamic subtest: pipe-B-eDP-1
[211.546593] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.614s)
[211.567560] Starting dynamic subtest: pipe-C-eDP-1
[213.104968] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.554s)
[213.105834] Subtest read-crc-frame-sequence: SUCCESS (4.042s)
[214.031879] [122/162] (795s left) kms_pm_backlight (basic-brightness)
[214.096981] Starting subtest: basic-brightness
[214.152429] Starting dynamic subtest: eDP-1
[214.509520] Dynamic subtest eDP-1: SUCCESS (0.356s)
[214.510535] Subtest basic-brightness: SUCCESS (0.412s)
[215.428213] [123/162] (794s left) kms_pm_rpm (basic-pci-d3-state)
[216.956501] Starting subtest: basic-pci-d3-state
[218.446796] Subtest basic-pci-d3-state: SUCCESS (1.488s)
[218.613929] [124/162] (790s left) kms_pm_rpm (basic-rte)
[218.654568] Starting subtest: basic-rte
[221.615500] Subtest basic-rte: SUCCESS (2.962s)
[223.551965] [125/162] (786s left) kms_psr (psr-primary-page-flip)
[223.616696] Starting subtest: psr-primary-page-flip
[223.617626] Starting dynamic subtest: eDP-1
[225.614880] Dynamic subtest eDP-1: SUCCESS (1.996s)
[225.616198] Subtest psr-primary-page-flip: SUCCESS (1.999s)
[226.573740] [126/162] (783s left) kms_psr (psr-cursor-plane-move)
[226.651081] Starting subtest: psr-cursor-plane-move
[226.653595] Starting dynamic subtest: eDP-1
[228.590981] Dynamic subtest eDP-1: SUCCESS (1.937s)
[228.592096] Subtest psr-cursor-plane-move: SUCCESS (1.940s)
[229.479647] [127/162] (780s left) kms_psr (psr-sprite-plane-onoff)
[229.549249] Starting subtest: psr-sprite-plane-onoff
[229.552208] Starting dynamic subtest: eDP-1
[231.598949] Dynamic subtest eDP-1: SUCCESS (2.046s)
[231.600013] Subtest psr-sprite-plane-onoff: SUCCESS (2.050s)
[232.489394] [128/162] (777s left) kms_psr (psr-primary-mmap-gtt)
[232.555309] Starting subtest: psr-primary-mmap-gtt
[232.556105] Starting dynamic subtest: eDP-1
[234.535379] Dynamic subtest eDP-1: SUCCESS (1.978s)
[234.536406] Subtest psr-primary-mmap-gtt: SUCCESS (1.981s)
[235.517535] [129/162] (774s left) kms_setmode (basic-clone-single-crtc)
[235.560926] Starting subtest: basic-clone-single-crtc
[235.563276] Subtest basic-clone-single-crtc: SKIP (0.000s)
[235.697864] [130/162] (774s left) i915_pm_rps (basic-api)
[235.742121] Starting subtest: basic-api
[235.743748] Subtest basic-api: SKIP (0.001s)
[235.875581] [131/162] (774s left) prime_self_import (basic-llseek-bad)
[235.911394] Starting subtest: basic-llseek-bad
[235.914804] Subtest basic-llseek-bad: SUCCESS (0.002s)
[236.059487] [132/162] (773s left) prime_self_import (basic-llseek-size)
[236.095451] Starting subtest: basic-llseek-size
[236.098761] Subtest basic-llseek-size: SUCCESS (0.004s)
[236.260481] [133/162] (773s left) prime_self_import (basic-with_fd_dup)
[236.296286] Starting subtest: basic-with_fd_dup
[236.299596] Subtest basic-with_fd_dup: SUCCESS (0.004s)
[236.457121] [134/162] (773s left) prime_self_import (basic-with_one_bo)
[236.494770] Starting subtest: basic-with_one_bo
[236.496350] Subtest basic-with_one_bo: SUCCESS (0.003s)
[236.633599] [135/162] (773s left) prime_self_import (basic-with_one_bo_two_files)
[236.669487] Starting subtest: basic-with_one_bo_two_files
[236.673154] Subtest basic-with_one_bo_two_files: SUCCESS (0.004s)
[236.821783] [136/162] (773s left) prime_self_import (basic-with_two_bos)
[236.856233] Starting subtest: basic-with_two_bos
[236.860106] Subtest basic-with_two_bos: SUCCESS (0.004s)
[237.009369] [137/162] (773s left) prime_vgem (basic-fence-flip)
[237.058394] Starting subtest: basic-fence-flip
[237.495350] Subtest basic-fence-flip: SUCCESS (0.437s)
[237.666610] [138/162] (772s left) prime_vgem (basic-fence-mmap)
[237.731703] Starting subtest: basic-fence-mmap
[237.753949] Subtest basic-fence-mmap: SUCCESS (0.022s)
[237.916261] [139/162] (772s left) prime_vgem (basic-fence-read)
[237.983704] Starting subtest: basic-fence-read
[237.992271] Subtest basic-fence-read: SKIP (0.008s)
[238.154251] [140/162] (772s left) prime_vgem (basic-gtt)
[238.210182] Starting subtest: basic-gtt
[238.223475] Subtest basic-gtt: SUCCESS (0.013s)
[238.365935] [141/162] (772s left) prime_vgem (basic-read)
[238.420204] Starting subtest: basic-read
[238.428094] Subtest basic-read: SKIP (0.007s)
[238.589899] [142/162] (771s left) prime_vgem (basic-write)
[238.636385] Starting subtest: basic-write
[238.645116] Subtest basic-write: SKIP (0.008s)
[238.803088] [143/162] (771s left) vgem_basic (setversion)
[238.845840] Starting subtest: setversion
[238.847426] Subtest setversion: SUCCESS (0.000s)
[238.966414] [144/162] (771s left) vgem_basic (create)
[239.012825] Starting subtest: create
[239.013680] Subtest create: SUCCESS (0.000s)
[239.136469] [145/162] (771s left) vgem_basic (debugfs)
[239.179309] Starting subtest: debugfs
[239.180274] Subtest debugfs: SUCCESS (0.001s)
[239.302917] [146/162] (771s left) vgem_basic (dmabuf-export)
[239.345881] Starting subtest: dmabuf-export
[239.363569] Subtest dmabuf-export: SUCCESS (0.016s)
[239.516978] [147/162] (771s left) vgem_basic (dmabuf-fence)
[239.563562] Starting subtest: dmabuf-fence
[239.564350] Subtest dmabuf-fence: SUCCESS (0.001s)
[239.682803] [148/162] (771s left) vgem_basic (dmabuf-fence-before)
[239.731872] Starting subtest: dmabuf-fence-before
[239.732794] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[239.853799] [149/162] (770s left) vgem_basic (dmabuf-mmap)
[239.895972] Starting subtest: dmabuf-mmap
[239.909100] Subtest dmabuf-mmap: SUCCESS (0.013s)
[240.037605] [150/162] (770s left) vgem_basic (mmap)
[240.079232] Starting subtest: mmap
[240.088609] Subtest mmap: SUCCESS (0.009s)
[240.204365] [151/162] (770s left) vgem_basic (second-client)
[240.248533] Starting subtest: second-client
[240.280713] Subtest second-client: SUCCESS (0.033s)
[240.404877] [152/162] (770s left) vgem_basic (sysfs)
[240.445932] Starting subtest: sysfs
[240.446807] Subtest sysfs: SUCCESS (0.001s)
[240.570930] [153/162] (770s left) core_hotunplug (unbind-rebind)
[240.705486] Starting subtest: unbind-rebind
[245.304406] Subtest unbind-rebind: SUCCESS (4.601s)
[245.351073] [154/162] (765s left) vgem_basic (unload)
[245.396492] Starting subtest: unload
[274.445187] Subtest unload: SUCCESS (29.038s)
[274.639411] [155/162] (736s left) i915_module_load (reload)
[274.679310] Starting subtest: reload
[278.328942] Subtest reload: SUCCESS (3.648s)
[278.388502] [156/162] (732s left) gem_lmem_swapping (basic)
[278.438111] Subtest basic: SKIP (0.000s)
[278.496414] [157/162] (732s left) gem_lmem_swapping (parallel-random-engines)
[278.537116] Subtest parallel-random-engines: SKIP (0.000s)
[278.598975] [158/162] (732s left) gem_lmem_swapping (random-engines)
[278.639370] Subtest random-engines: SKIP (0.000s)
[278.713183] [159/162] (732s left) gem_lmem_swapping (verify-random)
[278.754015] Subtest verify-random: SKIP (0.000s)
[278.816049] [160/162] (732s left) i915_pm_rpm (module-reload)
[281.060902] Starting subtest: module-reload
[292.880394] Subtest module-reload: SUCCESS (11.810s)
[292.918179] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[292.919365] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[292.924020] [161/162] (718s left) i915_selftest (live)
[292.967457] Starting subtest: live
[292.968409] Starting dynamic subtest: sanitycheck
[295.193537] Dynamic subtest sanitycheck: SUCCESS (2.217s)
[295.207915] Starting dynamic subtest: uncore
[297.482710] Dynamic subtest uncore: SUCCESS (2.286s)
[297.491843] Starting dynamic subtest: workarounds
[300.576765] Dynamic subtest workarounds: SUCCESS (3.090s)
[300.587091] Starting dynamic subtest: gt_engines
[303.357849] Dynamic subtest gt_engines: SUCCESS (2.777s)
[303.369791] Starting dynamic subtest: gt_timelines
[315.290499] Dynamic subtest gt_timelines: SUCCESS (11.928s)
[315.306611] Starting dynamic subtest: gt_contexts
[317.957662] Dynamic subtest gt_contexts: SUCCESS (2.663s)
[317.966847] Starting dynamic subtest: gt_lrc
[322.763171] Dynamic subtest gt_lrc: SUCCESS (4.801s)
[322.772600] Starting dynamic subtest: gt_mocs
[325.725919] Dynamic subtest gt_mocs: SUCCESS (2.959s)
[325.735174] Starting dynamic subtest: gt_pm
[330.413864] Dynamic subtest gt_pm: SUCCESS (4.684s)
[330.422998] Starting dynamic subtest: gt_heartbeat
[332.727902] Dynamic subtest gt_heartbeat: SUCCESS (2.310s)
[332.737092] Starting dynamic subtest: gt_tlb
[337.007686] Dynamic subtest gt_tlb: SUCCESS (4.276s)
[337.016892] Starting dynamic subtest: requests
[345.678131] Dynamic subtest requests: SUCCESS (8.666s)
[345.690875] Starting dynamic subtest: migrate
[350.791072] Dynamic subtest migrate: SUCCESS (5.110s)
[350.805200] Starting dynamic subtest: active
[353.098828] Dynamic subtest active: SUCCESS (2.304s)
[353.107987] Starting dynamic subtest: objects
[356.428877] Dynamic subtest objects: SUCCESS (3.326s)
[356.438026] Starting dynamic subtest: mman