[78.751694] Initializing watchdogs
[78.751772]   /dev/watchdog0
[78.769692] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:46d3 Intel Alderlake_n (Gen12) 
[78.773564] [001/161] (960s left) i915_module_load (load)
[78.924466] Starting subtest: load
[81.301607] Subtest load: SUCCESS (2.441s)
[81.339400] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[81.340864] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[81.343307] [002/161] (957s left) core_auth (basic-auth)
[81.441228] Starting subtest: basic-auth
[81.442419] Subtest basic-auth: SUCCESS (0.002s)
[81.566907] [003/161] (957s left) debugfs_test (read_all_entries)
[81.631392] Starting subtest: read_all_entries
[81.860352] Subtest read_all_entries: SUCCESS (0.234s)
[81.983654] [004/161] (957s left) debugfs_test (basic-hwmon)
[82.029860] Starting subtest: basic-hwmon
[82.031355] Subtest basic-hwmon: SKIP (0.000s)
[82.160777] [005/161] (957s left) debugfs_test (sysfs)
[82.205159] Starting subtest: sysfs
[82.259874] Subtest sysfs: SUCCESS (0.055s)
[82.379325] [006/161] (957s left) fbdev (eof)
[82.431320] Starting subtest: eof
[82.432625] Subtest eof: SUCCESS (0.001s)
[82.511317] [007/161] (956s left) fbdev (info)
[82.553072] Starting subtest: info
[82.553965] Subtest info: SUCCESS (0.000s)
[82.641137] [008/161] (956s left) fbdev (nullptr)
[82.692507] Starting subtest: nullptr
[82.693468] Subtest nullptr: SUCCESS (0.000s)
[82.778924] [009/161] (956s left) fbdev (read)
[82.822861] Starting subtest: read
[89.590298] Subtest read: SUCCESS (6.818s)
[89.647264] [010/161] (949s left) fbdev (write)
[89.701963] Starting subtest: write
[93.217963] Subtest write: SUCCESS (3.504s)
[93.277069] [011/161] (946s left) gem_basic (bad-close)
[93.319908] Starting subtest: bad-close
[93.321461] Subtest bad-close: SUCCESS (0.000s)
[93.412556] [012/161] (946s left) gem_basic (create-close)
[93.455908] Starting subtest: create-close
[93.457404] Subtest create-close: SUCCESS (0.000s)
[93.564219] [013/161] (945s left) gem_basic (create-fd-close)
[93.607646] Starting subtest: create-fd-close
[93.609074] Subtest create-fd-close: SUCCESS (0.000s)
[93.715101] [014/161] (945s left) gem_busy (busy@all-engines)
[93.771516] Starting subtest: busy
[93.772488] Starting dynamic subtest: all-engines
[93.812083] Dynamic subtest all-engines: SUCCESS (0.041s)
[93.812904] Subtest busy: SUCCESS (0.041s)
[94.195609] [015/161] (945s left) gem_close_race (basic-process)
[94.251687] Starting subtest: basic-process
[94.304546] Subtest basic-process: SUCCESS (0.052s)
[94.515369] [016/161] (945s left) gem_close_race (basic-threads)
[94.572343] Starting subtest: basic-threads
[95.757612] Subtest basic-threads: SUCCESS (1.189s)
[95.996663] [017/161] (943s left) gem_ctx_create (basic)
[96.087306] Starting subtest: basic
[96.088372] Subtest basic: SUCCESS (0.000s)
[96.318762] [018/161] (943s left) gem_ctx_create (basic-files)
[96.397314] Starting subtest: basic-files
[98.419332] Subtest basic-files: SUCCESS (2.027s)
[98.672802] [019/161] (941s left) gem_ctx_exec (basic)
[98.741445] Starting subtest: basic
[98.751196] Subtest basic: SUCCESS (0.009s)
[98.909131] [020/161] (940s left) gem_exec_basic (basic)
[98.980512] Starting subtest: basic
[98.981519] Starting dynamic subtest: rcs0-smem
[98.984076] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[98.997667] Starting dynamic subtest: bcs0-smem
[98.998531] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[99.008778] Starting dynamic subtest: vcs0-smem
[99.009682] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[99.019309] Starting dynamic subtest: vecs0-smem
[99.020218] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[99.021061] Subtest basic: SUCCESS (0.009s)
[99.214968] [021/161] (940s left) gem_exec_create (basic)
[99.288088] Starting subtest: basic
[99.288920] Starting dynamic subtest: smem
[101.394732] Dynamic subtest smem: SUCCESS (2.110s)
[101.396245] Subtest basic: SUCCESS (2.111s)
[101.620668] [022/161] (938s left) gem_exec_fence (basic-busy)
[101.804140] Starting subtest: basic-busy
[101.805281] Starting dynamic subtest: rcs0
[101.894200] Dynamic subtest rcs0: SUCCESS (0.090s)
[101.907839] Starting dynamic subtest: bcs0
[101.945788] Dynamic subtest bcs0: SUCCESS (0.051s)
[101.960611] Starting dynamic subtest: vcs0
[101.998699] Dynamic subtest vcs0: SUCCESS (0.052s)
[102.015470] Starting dynamic subtest: vecs0
[102.048649] Dynamic subtest vecs0: SUCCESS (0.049s)
[102.049933] Subtest basic-busy: SUCCESS (0.245s)
[102.628838] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[102.632464] [023/161] (937s left) gem_exec_fence (basic-wait)
[102.805387] Starting subtest: basic-wait
[102.806471] Starting dynamic subtest: rcs0
[102.904589] Dynamic subtest rcs0: SUCCESS (0.099s)
[102.919677] Starting dynamic subtest: bcs0
[102.957636] Dynamic subtest bcs0: SUCCESS (0.052s)
[102.973674] Starting dynamic subtest: vcs0
[103.005049] Dynamic subtest vcs0: SUCCESS (0.047s)
[103.020306] Starting dynamic subtest: vecs0
[103.058838] Dynamic subtest vecs0: SUCCESS (0.051s)
[103.060283] Subtest basic-wait: SUCCESS (0.253s)
[103.604896] [024/161] (936s left) gem_exec_fence (basic-await)
[103.779577] Starting subtest: basic-await
[103.780695] Starting dynamic subtest: rcs0
[103.866195] Dynamic subtest rcs0: SUCCESS (0.088s)
[103.884576] Starting dynamic subtest: bcs0
[103.961512] Dynamic subtest bcs0: SUCCESS (0.095s)
[103.973099] Starting dynamic subtest: vcs0
[104.051061] Dynamic subtest vcs0: SUCCESS (0.088s)
[104.068974] Starting dynamic subtest: vecs0
[104.144416] Dynamic subtest vecs0: SUCCESS (0.093s)
[104.146508] Subtest basic-await: SUCCESS (0.367s)
[104.710358] [025/161] (935s left) gem_exec_fence (nb-await)
[104.882185] Starting subtest: nb-await
[104.884617] Starting dynamic subtest: rcs0
[104.947644] Dynamic subtest rcs0: SUCCESS (0.064s)
[104.965169] Starting dynamic subtest: bcs0
[105.011192] Dynamic subtest bcs0: SUCCESS (0.063s)
[105.032587] Starting dynamic subtest: vcs0
[105.075574] Dynamic subtest vcs0: SUCCESS (0.064s)
[105.097928] Starting dynamic subtest: vecs0
[105.142587] Dynamic subtest vecs0: SUCCESS (0.066s)
[105.144103] Subtest nb-await: SUCCESS (0.260s)
[105.674727] [026/161] (934s left) gem_exec_gttfill (basic)
[105.728869] Starting subtest: basic
[112.999047] Subtest basic: SUCCESS (7.264s)
[113.237674] [027/161] (927s left) gem_exec_parallel (engines)
[113.372984] Starting subtest: engines
[113.374107] Starting dynamic subtest: basic
[116.651378] Dynamic subtest basic: SUCCESS (3.279s)
[116.669263] Starting dynamic subtest: contexts
[121.072789] Dynamic subtest contexts: SUCCESS (4.411s)
[121.086414] Starting dynamic subtest: fds
[125.791884] Dynamic subtest fds: SUCCESS (4.718s)
[125.812958] Starting dynamic subtest: userptr
[128.663548] Dynamic subtest userptr: SUCCESS (2.880s)
[128.664832] Subtest engines: SUCCESS (15.291s)
[128.906165] [028/161] (911s left) gem_exec_store (basic)
[128.983947] Starting subtest: basic
[129.060516] Subtest basic: SUCCESS (0.076s)
[129.287726] [029/161] (911s left) gem_flink_basic (bad-flink)
[129.340428] Starting subtest: bad-flink
[129.341231] Subtest bad-flink: SUCCESS (0.000s)
[129.454791] [030/161] (910s left) gem_flink_basic (bad-open)
[129.505661] Starting subtest: bad-open
[129.506511] Subtest bad-open: SUCCESS (0.000s)
[129.604925] [031/161] (910s left) gem_flink_basic (basic)
[129.656757] Starting subtest: basic
[129.657570] Subtest basic: SUCCESS (0.000s)
[129.785540] [032/161] (910s left) gem_flink_basic (double-flink)
[129.838170] Starting subtest: double-flink
[129.838991] Subtest double-flink: SUCCESS (0.000s)
[129.971089] [033/161] (910s left) gem_flink_basic (flink-lifetime)
[130.022331] Starting subtest: flink-lifetime
[130.023629] Subtest flink-lifetime: SUCCESS (0.001s)
[130.152328] [034/161] (910s left) gem_huc_copy (huc-copy)
[130.209184] Starting subtest: huc-copy
[130.213806] Subtest huc-copy: SUCCESS (0.005s)
[130.377456] [035/161] (910s left) gem_linear_blits (basic)
[130.535361] Starting subtest: basic
[130.542899] Subtest basic: SUCCESS (0.011s)
[130.717490] [036/161] (910s left) gem_mmap (basic)
[130.813708] Starting subtest: basic
[130.817597] Subtest basic: SUCCESS (0.000s)
[130.954652] [037/161] (909s left) gem_mmap_gtt (basic)
[131.005358] Starting subtest: basic
[131.006157] Subtest basic: SUCCESS (0.001s)
[131.122334] [038/161] (909s left) gem_render_linear_blits (basic)
[131.175449] Starting subtest: basic
[131.223544] Subtest basic: SUCCESS (0.048s)
[131.337090] [039/161] (909s left) gem_render_tiled_blits (basic)
[131.392700] Starting subtest: basic
[131.444440] Subtest basic: SUCCESS (0.052s)
[131.565226] [040/161] (909s left) gem_ringfill (basic-all)
[131.873762] Starting subtest: basic-all
[133.031523] Subtest basic-all: SUCCESS (1.149s)
[133.186293] [041/161] (907s left) gem_softpin (allocator-basic)
[133.258320] Starting subtest: allocator-basic
[133.385305] Subtest allocator-basic: SUCCESS (0.118s)
[133.552333] [042/161] (907s left) gem_softpin (allocator-basic-reserve)
[133.617419] Starting subtest: allocator-basic-reserve
[133.735537] Subtest allocator-basic-reserve: SUCCESS (0.109s)
[133.884835] [043/161] (907s left) gem_softpin (safe-alignment)
[133.963437] Starting subtest: safe-alignment
[133.982993] Subtest safe-alignment: SUCCESS (0.020s)
[134.149065] [044/161] (907s left) gem_sync (basic-all)
[134.224077] Starting subtest: basic-all
[136.616295] Subtest basic-all: SUCCESS (2.391s)
[136.842120] [045/161] (904s left) gem_sync (basic-each)
[136.899563] Starting subtest: basic-each
[139.734312] Subtest basic-each: SUCCESS (2.834s)
[139.962287] [046/161] (901s left) gem_tiled_blits (basic)
[140.099532] Starting subtest: basic
[140.121479] Subtest basic: SUCCESS (0.022s)
[140.298801] [047/161] (901s left) gem_tiled_fence_blits (basic)
[140.480613] Starting subtest: basic
[140.499796] Subtest basic: SUCCESS (0.021s)
[140.676649] [048/161] (900s left) gem_tiled_pread_basic
[140.867357] [049/161] (900s left) gem_wait (busy@all-engines)
[140.938070] Starting subtest: busy
[140.938974] Starting dynamic subtest: all-engines
[141.510539] Dynamic subtest all-engines: SUCCESS (0.571s)
[141.511876] Subtest busy: SUCCESS (0.571s)
[141.755096] [050/161] (899s left) gem_wait (wait@all-engines)
[141.822671] Starting subtest: wait
[141.823491] Starting dynamic subtest: all-engines
[142.888850] Dynamic subtest all-engines: SUCCESS (1.065s)
[142.890443] Subtest wait: SUCCESS (1.066s)
[143.129551] [051/161] (898s left) i915_getparams_basic (basic-eu-total)
[143.172013] Starting subtest: basic-eu-total
[143.173524] Subtest basic-eu-total: SUCCESS (0.000s)
[143.265272] [052/161] (898s left) i915_getparams_basic (basic-subslice-total)
[143.308747] Starting subtest: basic-subslice-total
[143.310899] Subtest basic-subslice-total: SUCCESS (0.000s)
[143.398838] [053/161] (898s left) i915_hangman (error-state-basic)
[143.450803] Starting subtest: error-state-basic
[143.564484] Subtest error-state-basic: SUCCESS (0.114s)
[143.674996] [054/161] (897s left) i915_pciid
[143.809780] [055/161] (897s left) kms_addfb_basic (addfb25-4-tiled)
[143.886862] Starting subtest: addfb25-4-tiled
[143.887615] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[144.017417] [056/161] (897s left) kms_addfb_basic (addfb25-bad-modifier)
[144.088031] Starting subtest: addfb25-bad-modifier
[144.088828] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[144.217459] [057/161] (897s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[144.289927] Starting subtest: addfb25-framebuffer-vs-set-tiling
[144.290864] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[144.437813] [058/161] (897s left) kms_addfb_basic (addfb25-modifier-no-flag)
[144.513124] Starting subtest: addfb25-modifier-no-flag
[144.514040] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[144.648212] [059/161] (897s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[144.723872] Starting subtest: addfb25-x-tiled-legacy
[144.724838] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[144.857853] [060/161] (897s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[144.934045] Starting subtest: addfb25-x-tiled-mismatch-legacy
[144.935056] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[145.059504] [061/161] (896s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[145.138116] Starting subtest: addfb25-yf-tiled-legacy
[145.138936] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[145.269470] [062/161] (896s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[145.344132] Starting subtest: addfb25-y-tiled-legacy
[145.344978] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[145.485509] [063/161] (896s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[145.560977] Starting subtest: addfb25-y-tiled-small-legacy
[145.561840] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[145.687977] [064/161] (896s left) kms_addfb_basic (bad-pitch-0)
[145.739433] Starting subtest: bad-pitch-0
[145.740254] Subtest bad-pitch-0: SUCCESS (0.000s)
[145.893551] [065/161] (896s left) kms_addfb_basic (bad-pitch-1024)
[145.946586] Starting subtest: bad-pitch-1024
[145.947394] Subtest bad-pitch-1024: SUCCESS (0.000s)
[146.113912] [066/161] (896s left) kms_addfb_basic (bad-pitch-128)
[146.165737] Starting subtest: bad-pitch-128
[146.166624] Subtest bad-pitch-128: SUCCESS (0.000s)
[146.315137] [067/161] (895s left) kms_addfb_basic (bad-pitch-256)
[146.366696] Starting subtest: bad-pitch-256
[146.367523] Subtest bad-pitch-256: SUCCESS (0.000s)
[146.518804] [068/161] (895s left) kms_addfb_basic (bad-pitch-32)
[146.571829] Starting subtest: bad-pitch-32
[146.572613] Subtest bad-pitch-32: SUCCESS (0.000s)
[146.727757] [069/161] (895s left) kms_addfb_basic (bad-pitch-63)
[146.778609] Starting subtest: bad-pitch-63
[146.779767] Subtest bad-pitch-63: SUCCESS (0.000s)
[146.936126] [070/161] (895s left) kms_addfb_basic (bad-pitch-65536)
[146.988360] Starting subtest: bad-pitch-65536
[146.989207] Subtest bad-pitch-65536: SUCCESS (0.000s)
[147.151780] [071/161] (895s left) kms_addfb_basic (bad-pitch-999)
[147.203240] Starting subtest: bad-pitch-999
[147.204194] Subtest bad-pitch-999: SUCCESS (0.000s)
[147.357084] [072/161] (895s left) kms_addfb_basic (basic)
[147.409465] Starting subtest: basic
[147.410239] Subtest basic: SUCCESS (0.000s)
[147.567843] [073/161] (895s left) kms_addfb_basic (basic-x-tiled-legacy)
[147.621283] Starting subtest: basic-x-tiled-legacy
[147.622120] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[147.782122] [074/161] (894s left) kms_addfb_basic (basic-y-tiled-legacy)
[147.836243] Starting subtest: basic-y-tiled-legacy
[147.837058] Subtest basic-y-tiled-legacy: SUCCESS (0.001s)
[147.994664] [075/161] (894s left) kms_addfb_basic (bo-too-small)
[148.076469] Starting subtest: bo-too-small
[148.077524] Subtest bo-too-small: SUCCESS (0.000s)
[148.219390] [076/161] (894s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[148.295797] Starting subtest: bo-too-small-due-to-tiling
[148.296605] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[148.428959] [077/161] (894s left) kms_addfb_basic (clobberred-modifier)
[148.482876] Starting subtest: clobberred-modifier
[148.483789] Subtest clobberred-modifier: SUCCESS (0.000s)
[148.640147] [078/161] (894s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[148.692266] Starting subtest: framebuffer-vs-set-tiling
[148.693045] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[148.850560] [079/161] (894s left) kms_addfb_basic (invalid-get-prop)
[148.908856] Starting subtest: invalid-get-prop
[148.909681] Subtest invalid-get-prop: SUCCESS (0.000s)
[149.070305] [080/161] (893s left) kms_addfb_basic (invalid-get-prop-any)
[149.126992] Starting subtest: invalid-get-prop-any
[149.127932] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[149.290939] [081/161] (893s left) kms_addfb_basic (invalid-set-prop)
[149.346793] Starting subtest: invalid-set-prop
[149.347794] Subtest invalid-set-prop: SUCCESS (0.000s)
[149.506429] [082/161] (893s left) kms_addfb_basic (invalid-set-prop-any)
[149.560756] Starting subtest: invalid-set-prop-any
[149.562034] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[149.730910] [083/161] (893s left) kms_addfb_basic (no-handle)
[149.784869] Starting subtest: no-handle
[149.785754] Subtest no-handle: SUCCESS (0.000s)
[149.955415] [084/161] (893s left) kms_addfb_basic (size-max)
[150.037348] Starting subtest: size-max
[150.038282] Subtest size-max: SUCCESS (0.000s)
[150.174643] [085/161] (893s left) kms_addfb_basic (small-bo)
[150.253498] Starting subtest: small-bo
[150.254449] Subtest small-bo: SUCCESS (0.000s)
[150.388813] [086/161] (892s left) kms_addfb_basic (tile-pitch-mismatch)
[150.441099] Starting subtest: tile-pitch-mismatch
[150.441871] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[150.598308] [087/161] (892s left) kms_addfb_basic (too-high)
[150.676206] Starting subtest: too-high
[150.677233] Subtest too-high: SUCCESS (0.001s)
[150.840745] [088/161] (892s left) kms_addfb_basic (too-wide)
[150.914169] Starting subtest: too-wide
[150.915074] Subtest too-wide: SUCCESS (0.000s)
[151.045968] [089/161] (892s left) kms_addfb_basic (unused-handle)
[151.096428] Starting subtest: unused-handle
[151.097245] Subtest unused-handle: SUCCESS (0.000s)
[151.253687] [090/161] (892s left) kms_addfb_basic (unused-modifier)
[151.303661] Starting subtest: unused-modifier
[151.304538] Subtest unused-modifier: SUCCESS (0.000s)
[151.466407] [091/161] (892s left) kms_addfb_basic (unused-offsets)
[151.516604] Starting subtest: unused-offsets
[151.517410] Subtest unused-offsets: SUCCESS (0.000s)
[151.677833] [092/161] (891s left) kms_addfb_basic (unused-pitches)
[151.729220] Starting subtest: unused-pitches
[151.729986] Subtest unused-pitches: SUCCESS (0.000s)
[151.892967] [093/161] (891s left) kms_busy (basic)
[151.975376] Starting subtest: basic
[151.976243] Starting dynamic subtest: flip
[152.834496] Dynamic subtest flip: SUCCESS (0.857s)
[152.857845] Starting dynamic subtest: modeset
[156.494578] Dynamic subtest modeset: SUCCESS (3.660s)
[156.495717] Subtest basic: SUCCESS (4.519s)
[157.430650] [094/161] (886s left) kms_prop_blob (basic)
[157.480147] Starting subtest: basic
[157.480946] Subtest basic: SUCCESS (0.000s)
[157.572848] [095/161] (886s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[157.671984] Starting subtest: basic-busy-flip-before-cursor-atomic
[157.673578] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[157.822684] [096/161] (885s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[157.928935] Starting subtest: basic-busy-flip-before-cursor-legacy
[157.930574] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[158.079863] [097/161] (885s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[158.184705] Starting subtest: basic-flip-after-cursor-atomic
[159.370530] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.185s)
[160.300503] [098/161] (883s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[160.402532] Starting subtest: basic-flip-after-cursor-legacy
[161.595146] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.191s)
[162.546668] [099/161] (881s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[162.651229] Starting subtest: basic-flip-after-cursor-varying-size
[163.842880] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.189s)
[164.792435] [100/161] (879s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[164.890805] Starting subtest: basic-flip-before-cursor-atomic
[166.081645] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.191s)
[167.038135] [101/161] (876s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[167.150777] Starting subtest: basic-flip-before-cursor-legacy
[168.344448] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.193s)
[169.279805] [102/161] (874s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[169.386810] Starting subtest: basic-flip-before-cursor-varying-size
[170.576946] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.188s)
[171.521708] [103/161] (872s left) kms_dsc (dsc-basic)
[171.592134] Starting subtest: dsc-basic
[171.596047] Subtest dsc-basic: SKIP (0.001s)
[171.704582] [104/161] (872s left) kms_flip (basic-flip-vs-dpms)
[171.774812] Starting subtest: basic-flip-vs-dpms
[171.776981] Starting dynamic subtest: A-eDP1
[174.587332] Dynamic subtest A-eDP1: SUCCESS (2.810s)
[174.598605] Starting dynamic subtest: B-eDP1
[176.965087] Dynamic subtest B-eDP1: SUCCESS (2.377s)
[176.988265] Starting dynamic subtest: C-eDP1
[179.310904] Dynamic subtest C-eDP1: SUCCESS (2.345s)
[179.311718] Subtest basic-flip-vs-dpms: SUCCESS (7.536s)
[180.265465] [105/161] (863s left) kms_flip (basic-flip-vs-modeset)
[180.338835] Starting subtest: basic-flip-vs-modeset
[180.341326] Starting dynamic subtest: A-eDP1
[183.116784] Dynamic subtest A-eDP1: SUCCESS (2.775s)
[183.142283] Starting dynamic subtest: B-eDP1
[185.493736] Dynamic subtest B-eDP1: SUCCESS (2.376s)
[185.515927] Starting dynamic subtest: C-eDP1
[187.832245] Dynamic subtest C-eDP1: SUCCESS (2.338s)
[187.834042] Subtest basic-flip-vs-modeset: SUCCESS (7.494s)
[188.701651] [106/161] (855s left) kms_flip (basic-flip-vs-wf_vblank)
[188.777493] Starting subtest: basic-flip-vs-wf_vblank
[188.778285] Starting dynamic subtest: A-eDP1
[191.009531] Dynamic subtest A-eDP1: SUCCESS (2.231s)
[191.034957] Starting dynamic subtest: B-eDP1
[193.254100] Dynamic subtest B-eDP1: SUCCESS (2.242s)
[193.267681] Starting dynamic subtest: C-eDP1
[195.473711] Dynamic subtest C-eDP1: SUCCESS (2.217s)
[195.476942] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.701s)
[196.727897] [107/161] (847s left) kms_flip (basic-plain-flip)
[196.798665] Starting subtest: basic-plain-flip
[196.800547] Starting dynamic subtest: A-eDP1
[198.750735] Dynamic subtest A-eDP1: SUCCESS (1.949s)
[198.779052] Starting dynamic subtest: B-eDP1
[200.684919] Dynamic subtest B-eDP1: SUCCESS (1.931s)
[200.698676] Starting dynamic subtest: C-eDP1
[202.600877] Dynamic subtest C-eDP1: SUCCESS (1.914s)
[202.604282] Subtest basic-plain-flip: SUCCESS (5.805s)
[203.825521] [108/161] (840s left) kms_force_connector_basic (force-connector-state)
[203.887195] Starting subtest: force-connector-state
[204.373052] Subtest force-connector-state: SUCCESS (0.486s)
[205.556164] [109/161] (838s left) kms_force_connector_basic (force-edid)
[205.616217] Starting subtest: force-edid
[205.649924] Subtest force-edid: SUCCESS (0.034s)
[205.807963] [110/161] (838s left) kms_force_connector_basic (force-load-detect)
[205.865395] Starting subtest: force-load-detect
[205.867330] Subtest force-load-detect: SKIP (0.000s)
[206.014877] [111/161] (838s left) kms_force_connector_basic (prune-stale-modes)
[206.073399] Starting subtest: prune-stale-modes
[206.113946] Subtest prune-stale-modes: SUCCESS (0.041s)
[206.294595] [112/161] (838s left) kms_frontbuffer_tracking (basic)
[206.367187] Starting subtest: basic
[211.973477] Subtest basic: SUCCESS (5.606s)
[212.117247] [113/161] (832s left) kms_hdmi_inject (inject-audio)
[212.463582] Starting subtest: inject-audio
[212.630080] Subtest inject-audio: SUCCESS (0.167s)
[213.369423] [114/161] (831s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[213.442528] Starting subtest: compare-crc-sanitycheck-xr24
[213.443555] Starting dynamic subtest: pipe-A-eDP-1
[214.287208] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.841s)
[214.311486] Starting dynamic subtest: pipe-B-eDP-1
[215.780691] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.492s)
[215.804770] Starting dynamic subtest: pipe-C-eDP-1
[217.179573] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.398s)
[217.180368] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.738s)
[218.083376] [115/161] (826s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[218.160602] Starting subtest: compare-crc-sanitycheck-nv12
[218.161493] Starting dynamic subtest: pipe-A-eDP-1
[219.220319] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.056s)
[219.243956] Starting dynamic subtest: pipe-B-eDP-1
[220.711052] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.489s)
[220.737237] Starting dynamic subtest: pipe-C-eDP-1
[222.124969] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.411s)
[222.126199] Subtest compare-crc-sanitycheck-nv12: SUCCESS (3.965s)
[223.023958] [116/161] (821s left) kms_pipe_crc_basic (hang-read-crc)
[223.095061] Starting subtest: hang-read-crc
[223.095872] Starting dynamic subtest: pipe-A-eDP-1
[225.488730] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.392s)
[225.502820] Starting dynamic subtest: pipe-B-eDP-1
[228.583487] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.093s)
[228.601395] Starting dynamic subtest: pipe-C-eDP-1
[231.559950] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.972s)
[231.560792] Subtest hang-read-crc: SUCCESS (8.466s)
[232.484212] [117/161] (812s left) kms_pipe_crc_basic (nonblocking-crc)
[232.561951] Starting subtest: nonblocking-crc
[232.562879] Starting dynamic subtest: pipe-A-eDP-1
[233.559753] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.996s)
[233.587626] Starting dynamic subtest: pipe-B-eDP-1
[235.281468] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.720s)
[235.297091] Starting dynamic subtest: pipe-C-eDP-1
[236.930123] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.645s)
[236.931332] Subtest nonblocking-crc: SUCCESS (4.369s)
[237.857252] [118/161] (806s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[237.935676] Starting subtest: nonblocking-crc-frame-sequence
[237.936574] Starting dynamic subtest: pipe-A-eDP-1
[238.949229] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.009s)
[238.961298] Starting dynamic subtest: pipe-B-eDP-1
[240.663183] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.714s)
[240.679666] Starting dynamic subtest: pipe-C-eDP-1
[242.303120] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.639s)
[242.303930] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.369s)
[243.214096] [119/161] (801s left) kms_pipe_crc_basic (read-crc)
[243.286250] Starting subtest: read-crc
[243.287070] Starting dynamic subtest: pipe-A-eDP-1
[244.183925] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.894s)
[244.194607] Starting dynamic subtest: pipe-B-eDP-1
[245.774635] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.591s)
[245.786877] Starting dynamic subtest: pipe-C-eDP-1
[247.282810] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.506s)
[247.283667] Subtest read-crc: SUCCESS (3.998s)
[248.142931] [120/161] (796s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[248.214303] Starting subtest: read-crc-frame-sequence
[248.215094] Starting dynamic subtest: pipe-A-eDP-1
[249.112368] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.896s)
[249.128664] Starting dynamic subtest: pipe-B-eDP-1
[250.592259] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.478s)
[250.608967] Starting dynamic subtest: pipe-C-eDP-1
[252.095101] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.499s)
[252.095915] Subtest read-crc-frame-sequence: SUCCESS (3.882s)
[252.982348] [121/161] (791s left) kms_pm_backlight (basic-brightness)
[253.059202] Starting subtest: basic-brightness
[253.130619] Starting dynamic subtest: eDP-1
[253.460803] Dynamic subtest eDP-1: SUCCESS (0.331s)
[253.461809] Subtest basic-brightness: SUCCESS (0.402s)
[254.383906] [122/161] (790s left) kms_pm_rpm (basic-pci-d3-state)
[255.925073] Starting subtest: basic-pci-d3-state
[257.399299] Subtest basic-pci-d3-state: SUCCESS (1.475s)
[257.528526] [123/161] (787s left) kms_pm_rpm (basic-rte)
[257.572837] Starting subtest: basic-rte
[260.538535] Subtest basic-rte: SUCCESS (2.965s)
[262.118507] [124/161] (782s left) kms_psr (psr-primary-page-flip)
[262.192290] Starting subtest: psr-primary-page-flip
[262.193061] Starting dynamic subtest: eDP-1
[264.180532] Dynamic subtest eDP-1: SUCCESS (1.986s)
[264.181924] Subtest psr-primary-page-flip: SUCCESS (1.987s)
[265.114852] [125/161] (780s left) kms_psr (psr-cursor-plane-move)
[265.188929] Starting subtest: psr-cursor-plane-move
[265.189735] Starting dynamic subtest: eDP-1
[267.061858] Dynamic subtest eDP-1: SUCCESS (1.872s)
[267.063451] Subtest psr-cursor-plane-move: SUCCESS (1.875s)
[268.015631] [126/161] (777s left) kms_psr (psr-sprite-plane-onoff)
[268.095364] Starting subtest: psr-sprite-plane-onoff
[268.096472] Starting dynamic subtest: eDP-1
[270.149865] Dynamic subtest eDP-1: SUCCESS (2.054s)
[270.151325] Subtest psr-sprite-plane-onoff: SUCCESS (2.056s)
[271.021921] [127/161] (774s left) kms_psr (psr-primary-mmap-gtt)
[271.097471] Starting subtest: psr-primary-mmap-gtt
[271.098264] Starting dynamic subtest: eDP-1
[273.082516] Dynamic subtest eDP-1: SUCCESS (1.984s)
[273.083822] Subtest psr-primary-mmap-gtt: SUCCESS (1.986s)
[274.026666] [128/161] (771s left) kms_setmode (basic-clone-single-crtc)
[274.076621] Starting subtest: basic-clone-single-crtc
[274.079034] Subtest basic-clone-single-crtc: SKIP (0.000s)
[274.190271] [129/161] (771s left) i915_pm_rps (basic-api)
[274.240408] Starting subtest: basic-api
[274.242747] Subtest basic-api: SKIP (0.001s)
[274.374099] [130/161] (771s left) prime_self_import (basic-llseek-bad)
[274.417733] Starting subtest: basic-llseek-bad
[274.419312] Subtest basic-llseek-bad: SUCCESS (0.002s)
[274.559223] [131/161] (770s left) prime_self_import (basic-llseek-size)
[274.601410] Starting subtest: basic-llseek-size
[274.604475] Subtest basic-llseek-size: SUCCESS (0.003s)
[274.727452] [132/161] (770s left) prime_self_import (basic-with_fd_dup)
[274.769992] Starting subtest: basic-with_fd_dup
[274.773303] Subtest basic-with_fd_dup: SUCCESS (0.003s)
[274.894769] [133/161] (770s left) prime_self_import (basic-with_one_bo)
[274.936497] Starting subtest: basic-with_one_bo
[274.938984] Subtest basic-with_one_bo: SUCCESS (0.003s)
[275.049420] [134/161] (770s left) prime_self_import (basic-with_one_bo_two_files)
[275.093684] Starting subtest: basic-with_one_bo_two_files
[275.096060] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s)
[275.239390] [135/161] (770s left) prime_self_import (basic-with_two_bos)
[275.281894] Starting subtest: basic-with_two_bos
[275.283602] Subtest basic-with_two_bos: SUCCESS (0.003s)
[275.412511] [136/161] (770s left) prime_vgem (basic-fence-flip)
[275.488548] Starting subtest: basic-fence-flip
[275.938221] Subtest basic-fence-flip: SUCCESS (0.449s)
[276.059112] [137/161] (769s left) prime_vgem (basic-fence-mmap)
[276.112858] Starting subtest: basic-fence-mmap
[276.138670] Subtest basic-fence-mmap: SUCCESS (0.028s)
[276.260792] [138/161] (769s left) prime_vgem (basic-fence-read)
[276.315809] Starting subtest: basic-fence-read
[276.323170] Subtest basic-fence-read: SKIP (0.008s)
[276.443945] [139/161] (769s left) prime_vgem (basic-gtt)
[276.525266] Starting subtest: basic-gtt
[276.539880] Subtest basic-gtt: SUCCESS (0.015s)
[276.659497] [140/161] (769s left) prime_vgem (basic-read)
[276.711158] Starting subtest: basic-read
[276.719681] Subtest basic-read: SKIP (0.008s)
[276.843857] [141/161] (769s left) prime_vgem (basic-write)
[276.894086] Starting subtest: basic-write
[276.902573] Subtest basic-write: SKIP (0.008s)
[277.025923] [142/161] (768s left) vgem_basic (setversion)
[277.071718] Starting subtest: setversion
[277.073361] Subtest setversion: SUCCESS (0.000s)
[277.154346] [143/161] (768s left) vgem_basic (create)
[277.205418] Starting subtest: create
[277.206320] Subtest create: SUCCESS (0.000s)
[277.298881] [144/161] (768s left) vgem_basic (debugfs)
[277.355568] Starting subtest: debugfs
[277.356727] Subtest debugfs: SUCCESS (0.001s)
[277.439858] [145/161] (768s left) vgem_basic (dmabuf-export)
[277.488654] Starting subtest: dmabuf-export
[277.501377] Subtest dmabuf-export: SUCCESS (0.010s)
[277.631870] [146/161] (768s left) vgem_basic (dmabuf-fence)
[277.688693] Starting subtest: dmabuf-fence
[277.689911] Subtest dmabuf-fence: SUCCESS (0.001s)
[277.776117] [147/161] (768s left) vgem_basic (dmabuf-fence-before)
[277.821930] Starting subtest: dmabuf-fence-before
[277.823479] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[277.909253] [148/161] (768s left) vgem_basic (dmabuf-mmap)
[277.955059] Starting subtest: dmabuf-mmap
[277.968917] Subtest dmabuf-mmap: SUCCESS (0.014s)
[278.057184] [149/161] (768s left) vgem_basic (mmap)
[278.105829] Starting subtest: mmap
[278.119069] Subtest mmap: SUCCESS (0.014s)
[278.209191] [150/161] (768s left) vgem_basic (second-client)
[278.255216] Starting subtest: second-client
[278.290254] Subtest second-client: SUCCESS (0.033s)
[278.376299] [151/161] (767s left) vgem_basic (sysfs)
[278.423744] Starting subtest: sysfs
[278.424641] Subtest sysfs: SUCCESS (0.000s)
[278.510837] [152/161] (767s left) core_hotunplug (unbind-rebind)
[278.632203] Starting subtest: unbind-rebind
[283.247201] Subtest unbind-rebind: SUCCESS (4.616s)
[283.293564] [153/161] (763s left) vgem_basic (unload)
[283.335659] Starting subtest: unload
[312.462406] Subtest unload: SUCCESS (29.092s)
[312.583158] [154/161] (733s left) i915_module_load (reload)
[312.630756] Starting subtest: reload
[316.206585] Subtest reload: SUCCESS (3.576s)
[316.248479] [155/161] (730s left) gem_lmem_swapping (basic)
[316.300631] Subtest basic: SKIP (0.000s)
[316.358683] [156/161] (730s left) gem_lmem_swapping (parallel-random-engines)
[316.413226] Subtest parallel-random-engines: SKIP (0.000s)
[316.492456] [157/161] (730s left) gem_lmem_swapping (random-engines)
[316.550394] Subtest random-engines: SKIP (0.000s)
[316.607050] [158/161] (730s left) gem_lmem_swapping (verify-random)
[316.656184] Subtest verify-random: SKIP (0.000s)
[316.708173] [159/161] (730s left) i915_pm_rpm (module-reload)
[319.010591] Starting subtest: module-reload
[332.160579] Subtest module-reload: SUCCESS (13.140s)
[332.195657] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[332.197255] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[332.202873] [160/161] (714s left) i915_selftest (live)
[332.250476] Starting subtest: live
[332.251466] Starting dynamic subtest: sanitycheck
[334.507939] Dynamic subtest sanitycheck: SUCCESS (2.247s)
[334.519523] Starting dynamic subtest: uncore
[336.732863] Dynamic subtest uncore: SUCCESS (2.222s)
[336.743674] Starting dynamic subtest: workarounds
[339.780636] Dynamic subtest workarounds: SUCCESS (3.045s)
[339.792042] Starting dynamic subtest: gt_engines
[342.475700] Dynamic subtest gt_engines: SUCCESS (2.692s)
[342.486434] Starting dynamic subtest: gt_timelines
[352.895489] Dynamic subtest gt_timelines: SUCCESS (10.417s)
[352.908134] Starting dynamic subtest: gt_contexts
[355.534032] Dynamic subtest gt_contexts: SUCCESS (2.635s)
[355.545267] Starting dynamic subtest: gt_lrc
[360.232934] Dynamic subtest gt_lrc: SUCCESS (4.696s)
[360.243912] Starting dynamic subtest: gt_mocs
[363.089986] Dynamic subtest gt_mocs: SUCCESS (2.854s)
[363.102357] Starting dynamic subtest: gt_pm
[367.740095] Dynamic subtest gt_pm: SUCCESS (4.646s)
[367.751596] Starting dynamic subtest: gt_heartbeat
[370.027414] Dynamic subtest gt_heartbeat: SUCCESS (2.284s)
[370.035926] Starting dynamic subtest: gt_tlb
[373.321623] Dynamic subtest gt_tlb: SUCCESS (3.291s)
[373.331938] Starting dynamic subtest: requests
[381.988109] Dynamic subtest requests: SUCCESS (8.663s)
[382.000228] Starting dynamic subtest: migrate
[386.911358] Dynamic subtest migrate: SUCCESS (4.921s)
[386.919857] Starting dynamic subtest: active
[389.149886] Dynamic subtest active: SUCCESS (2.244s)
[389.169995] Starting dynamic subtest: objects
[392.285891] Dynamic subtest objects: SUCCESS (3.124s)
[392.296354] Starting dynamic subtest: mman
[398.041445] Dynamic subtest mman: SUCCESS (5.753s)
[398.050504] Starting dynamic subtest: dmabuf
[400.491775] Dynamic subtest dmabuf: SUCCESS (2.446s)
[400.502493] Starting dynamic subtest: vma
[402.947046] Dynamic subtest vma: SUCCESS (2.452s)
[402.959812] Starting dynamic subtest: coherency
[407.652033] Dynamic subtest coherency: SUCCESS (4.702s)
[407.664511] Starting dynamic subtest: gtt
[416.875412] Dynamic subtest gtt: SUCCESS (9.220s)
[416.883964] Starting dynamic subtest: gem
[419.607358] Dynamic subtest gem: SUCCESS (2.729s)
[419.615983] Starting dynamic subtest: evict
[423.551436] Dynamic subtest evict: SUCCESS (3.940s)
[423.561967] Starting dynamic subtest: hugepages
[432.045907] Dynamic subtest hugepages: SUCCESS (8.491s)
[432.056816] Starting dynamic subtest: gem_contexts
[447.131819] Dynamic subtest gem_contexts: SUCCESS (15.083s)
[447.144036] Starting dynamic subtest: client
[449.666652] Dynamic subtest client: SUCCESS (2.531s)
[449.680242] Starting dynamic subtest: gem_migrate
[452.172964] Dynamic subtest gem_migrate: SUCCESS (2.503s)
[452.184222] Starting dynamic subtest: reset
[457.360447] Dynamic subtest reset: SUCCESS (5.184s)
[457.370994] Starting dynamic subtest: memory_region
[459.783564] Dynamic subtest memory_region: SUCCESS (2.420s)
[459.794150] Starting dynamic subtest: hangcheck
[477.127335] Dynamic subtest hangcheck: SUCCESS (17.340s)
[477.140556] Starting dynamic subtest: execlists
[479.593368] Dynamic subtest execlists: SUCCESS (2.463s)
[479.601842] Starting dynamic subtest: ring_submission
[482.002172] Dynamic subtest ring_submission: SUCCESS (2.414s)
[482.020541] Starting dynamic subtest: perf
[484.506918] Dynamic subtest perf: SUCCESS (2.493s)
[484.518235] Starting dynamic subtest: slpc
[491.877747] Dynamic subtest slpc: SUCCESS (7.368s)
[491.885911] Starting dynamic subtest: guc
[495.027898] Dynamic subtest guc: SUCCESS (3.147s)
[495.041272] Starting dynamic subtest: guc_multi_lrc
[497.323493] Dynamic subtest guc_multi_lrc: SUCCESS (2.293s)
[497.332100] Starting dynamic subtest: guc_hang
[500.239046] Dynamic subtest guc_hang: SUCCESS (2.911s)
[500.249950] Starting dynamic subtest: late_gt_pm
[502.596789] Dynamic subtest late_gt_pm: SUCCESS (2.354s)
[502.598338] Subtest live: SUCCESS (170.339s)
[502.639132] [161/161] (544s left) dmabuf (all-tests)
[502.690793] Starting subtest: all-tests
[502.691738] Starting dynamic subtest: sanitycheck
[502.794321] Dynamic subtest sanitycheck: SUCCESS (0.102s)
[502.809572] Starting dynamic subtest: dma_fence
[503.051120] Dynamic subtest dma_fence: SUCCESS (0.245s)
[503.062230] Starting dynamic subtest: dma_fence_chain
[514.084343] Dynamic subtest dma_fence_chain: SUCCESS (11.029s)
[514.097602] Starting dynamic subtest: dma_fence_unwrap
[514.168396] Dynamic subtest dma_fence_unwrap: SUCCESS (0.090s)
[514.194421] Starting dynamic subtest: dma_resv
[514.264363] Dynamic subtest dma_resv: SUCCESS (0.092s)
[514.265961] Subtest all-tests: SUCCESS (11.574s)
[514.316130] Closing watchdogs
Done.