[92.081761] Initializing watchdogs
[92.081870]   /dev/watchdog0
[92.114676] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:46d3 Intel Alderlake_n (Gen12) 
[92.121064] [001/161] (960s left) i915_module_load (load)
[92.340702] Starting subtest: load
[94.804513] Subtest load: SUCCESS (2.467s)
[94.837134] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[94.838591] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[94.841180] [002/161] (957s left) core_auth (basic-auth)
[94.900638] Starting subtest: basic-auth
[94.901600] Subtest basic-auth: SUCCESS (0.001s)
[95.000018] [003/161] (957s left) debugfs_test (read_all_entries)
[95.077367] Starting subtest: read_all_entries
[95.317310] Subtest read_all_entries: SUCCESS (0.240s)
[95.450964] [004/161] (957s left) debugfs_test (basic-hwmon)
[95.498447] Starting subtest: basic-hwmon
[95.500323] Subtest basic-hwmon: SKIP (0.000s)
[95.632408] [005/161] (957s left) debugfs_test (sysfs)
[95.679404] Starting subtest: sysfs
[95.744636] Subtest sysfs: SUCCESS (0.065s)
[95.874991] [006/161] (956s left) fbdev (eof)
[95.920293] Starting subtest: eof
[95.921346] Subtest eof: SUCCESS (0.000s)
[95.997875] [007/161] (956s left) fbdev (info)
[96.039174] Starting subtest: info
[96.039953] Subtest info: SUCCESS (0.000s)
[96.128700] [008/161] (956s left) fbdev (nullptr)
[96.186400] Starting subtest: nullptr
[96.187685] Subtest nullptr: SUCCESS (0.000s)
[96.265438] [009/161] (956s left) fbdev (read)
[96.319308] Starting subtest: read
[103.145463] Subtest read: SUCCESS (6.797s)
[103.212823] [010/161] (949s left) fbdev (write)
[103.259929] Starting subtest: write
[106.735750] Subtest write: SUCCESS (3.443s)
[106.795499] [011/161] (946s left) gem_basic (bad-close)
[106.837573] Starting subtest: bad-close
[106.839609] Subtest bad-close: SUCCESS (0.000s)
[106.933488] [012/161] (946s left) gem_basic (create-close)
[106.978085] Starting subtest: create-close
[106.979587] Subtest create-close: SUCCESS (0.000s)
[107.105143] [013/161] (945s left) gem_basic (create-fd-close)
[107.148765] Starting subtest: create-fd-close
[107.150174] Subtest create-fd-close: SUCCESS (0.000s)
[107.254493] [014/161] (945s left) gem_busy (busy@all-engines)
[107.309967] Starting subtest: busy
[107.311605] Starting dynamic subtest: all-engines
[107.365916] Dynamic subtest all-engines: SUCCESS (0.056s)
[107.366691] Subtest busy: SUCCESS (0.056s)
[107.756170] [015/161] (945s left) gem_close_race (basic-process)
[107.811890] Starting subtest: basic-process
[107.865447] Subtest basic-process: SUCCESS (0.053s)
[108.085301] [016/161] (945s left) gem_close_race (basic-threads)
[108.139849] Starting subtest: basic-threads
[109.430651] Subtest basic-threads: SUCCESS (1.290s)
[109.668891] [017/161] (943s left) gem_ctx_create (basic)
[109.757187] Starting subtest: basic
[109.758156] Subtest basic: SUCCESS (0.000s)
[109.989935] [018/161] (943s left) gem_ctx_create (basic-files)
[110.066475] Starting subtest: basic-files
[112.089968] Subtest basic-files: SUCCESS (2.024s)
[112.367554] [019/161] (941s left) gem_ctx_exec (basic)
[112.440307] Starting subtest: basic
[112.445608] Subtest basic: SUCCESS (0.005s)
[112.603710] [020/161] (940s left) gem_exec_basic (basic)
[112.678760] Starting subtest: basic
[112.680160] Starting dynamic subtest: rcs0-smem
[112.681090] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[112.693129] Starting dynamic subtest: bcs0-smem
[112.694112] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[112.704605] Starting dynamic subtest: vcs0-smem
[112.705513] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[112.716350] Starting dynamic subtest: vecs0-smem
[112.717289] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[112.718183] Subtest basic: SUCCESS (0.007s)
[112.915832] [021/161] (940s left) gem_exec_create (basic)
[112.990257] Starting subtest: basic
[112.991268] Starting dynamic subtest: smem
[115.096663] Dynamic subtest smem: SUCCESS (2.106s)
[115.098107] Subtest basic: SUCCESS (2.106s)
[115.317473] [022/161] (938s left) gem_exec_fence (basic-busy)
[115.502414] Starting subtest: basic-busy
[115.503587] Starting dynamic subtest: rcs0
[115.595587] Dynamic subtest rcs0: SUCCESS (0.092s)
[115.610757] Starting dynamic subtest: bcs0
[115.649825] Dynamic subtest bcs0: SUCCESS (0.053s)
[115.664529] Starting dynamic subtest: vcs0
[115.702873] Dynamic subtest vcs0: SUCCESS (0.052s)
[115.717992] Starting dynamic subtest: vecs0
[115.750676] Dynamic subtest vecs0: SUCCESS (0.047s)
[115.751992] Subtest basic-busy: SUCCESS (0.248s)
[116.324710] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[116.326678] [023/161] (937s left) gem_exec_fence (basic-wait)
[116.502234] Starting subtest: basic-wait
[116.503391] Starting dynamic subtest: rcs0
[116.555222] Dynamic subtest rcs0: SUCCESS (0.054s)
[116.571159] Starting dynamic subtest: bcs0
[116.607160] Dynamic subtest bcs0: SUCCESS (0.051s)
[116.621469] Starting dynamic subtest: vcs0
[116.658896] Dynamic subtest vcs0: SUCCESS (0.051s)
[116.674759] Starting dynamic subtest: vecs0
[116.706257] Dynamic subtest vecs0: SUCCESS (0.047s)
[116.707695] Subtest basic-wait: SUCCESS (0.205s)
[117.243119] [024/161] (936s left) gem_exec_fence (basic-await)
[117.424330] Starting subtest: basic-await
[117.425459] Starting dynamic subtest: rcs0
[117.513997] Dynamic subtest rcs0: SUCCESS (0.090s)
[117.525789] Starting dynamic subtest: bcs0
[117.603229] Dynamic subtest bcs0: SUCCESS (0.088s)
[117.624972] Starting dynamic subtest: vcs0
[117.700225] Dynamic subtest vcs0: SUCCESS (0.097s)
[117.717888] Starting dynamic subtest: vecs0
[117.792581] Dynamic subtest vecs0: SUCCESS (0.091s)
[117.794195] Subtest basic-await: SUCCESS (0.368s)
[118.321690] [025/161] (935s left) gem_exec_fence (nb-await)
[118.497801] Starting subtest: nb-await
[118.499165] Starting dynamic subtest: rcs0
[118.560693] Dynamic subtest rcs0: SUCCESS (0.063s)
[118.579665] Starting dynamic subtest: bcs0
[118.624533] Dynamic subtest bcs0: SUCCESS (0.063s)
[118.646353] Starting dynamic subtest: vcs0
[118.688640] Dynamic subtest vcs0: SUCCESS (0.064s)
[118.709745] Starting dynamic subtest: vecs0
[118.753620] Dynamic subtest vecs0: SUCCESS (0.064s)
[118.755460] Subtest nb-await: SUCCESS (0.256s)
[119.300378] [026/161] (934s left) gem_exec_gttfill (basic)
[119.355207] Starting subtest: basic
[126.553857] Subtest basic: SUCCESS (7.189s)
[126.791161] [027/161] (927s left) gem_exec_parallel (engines)
[126.937609] Starting subtest: engines
[126.938636] Starting dynamic subtest: basic
[129.708876] Dynamic subtest basic: SUCCESS (2.771s)
[129.725924] Starting dynamic subtest: contexts
[134.019885] Dynamic subtest contexts: SUCCESS (4.302s)
[134.037661] Starting dynamic subtest: fds
[138.771584] Dynamic subtest fds: SUCCESS (4.760s)
[138.789454] Starting dynamic subtest: userptr
[141.248782] Dynamic subtest userptr: SUCCESS (2.477s)
[141.250213] Subtest engines: SUCCESS (14.311s)
[141.494507] [028/161] (912s left) gem_exec_store (basic)
[141.568884] Starting subtest: basic
[141.690720] Subtest basic: SUCCESS (0.121s)
[141.920829] [029/161] (911s left) gem_flink_basic (bad-flink)
[141.970220] Starting subtest: bad-flink
[141.971064] Subtest bad-flink: SUCCESS (0.000s)
[142.084045] [030/161] (911s left) gem_flink_basic (bad-open)
[142.142765] Starting subtest: bad-open
[142.143938] Subtest bad-open: SUCCESS (0.000s)
[142.255747] [031/161] (911s left) gem_flink_basic (basic)
[142.306632] Starting subtest: basic
[142.307479] Subtest basic: SUCCESS (0.000s)
[142.432940] [032/161] (911s left) gem_flink_basic (double-flink)
[142.482098] Starting subtest: double-flink
[142.482909] Subtest double-flink: SUCCESS (0.000s)
[142.612656] [033/161] (911s left) gem_flink_basic (flink-lifetime)
[142.663226] Starting subtest: flink-lifetime
[142.664071] Subtest flink-lifetime: SUCCESS (0.001s)
[142.795336] [034/161] (911s left) gem_huc_copy (huc-copy)
[142.851859] Starting subtest: huc-copy
[142.856967] Subtest huc-copy: SUCCESS (0.005s)
[143.013471] [035/161] (911s left) gem_linear_blits (basic)
[143.160629] Starting subtest: basic
[143.169441] Subtest basic: SUCCESS (0.010s)
[143.365566] [036/161] (910s left) gem_mmap (basic)
[143.469501] Starting subtest: basic
[143.473406] Subtest basic: SUCCESS (0.001s)
[143.593721] [037/161] (910s left) gem_mmap_gtt (basic)
[143.641977] Starting subtest: basic
[143.642854] Subtest basic: SUCCESS (0.001s)
[143.749196] [038/161] (910s left) gem_render_linear_blits (basic)
[143.802165] Starting subtest: basic
[143.844675] Subtest basic: SUCCESS (0.043s)
[143.961826] [039/161] (910s left) gem_render_tiled_blits (basic)
[144.017448] Starting subtest: basic
[144.070044] Subtest basic: SUCCESS (0.052s)
[144.194026] [040/161] (910s left) gem_ringfill (basic-all)
[144.494653] Starting subtest: basic-all
[145.645693] Subtest basic-all: SUCCESS (1.143s)
[145.824238] [041/161] (908s left) gem_softpin (allocator-basic)
[145.891481] Starting subtest: allocator-basic
[146.014834] Subtest allocator-basic: SUCCESS (0.115s)
[146.174885] [042/161] (908s left) gem_softpin (allocator-basic-reserve)
[146.239236] Starting subtest: allocator-basic-reserve
[146.358063] Subtest allocator-basic-reserve: SUCCESS (0.110s)
[146.531800] [043/161] (908s left) gem_softpin (safe-alignment)
[146.594556] Starting subtest: safe-alignment
[146.613275] Subtest safe-alignment: SUCCESS (0.019s)
[146.789569] [044/161] (907s left) gem_sync (basic-all)
[146.859062] Starting subtest: basic-all
[149.181511] Subtest basic-all: SUCCESS (2.321s)
[149.409761] [045/161] (905s left) gem_sync (basic-each)
[149.466739] Starting subtest: basic-each
[152.335592] Subtest basic-each: SUCCESS (2.868s)
[152.564746] [046/161] (902s left) gem_tiled_blits (basic)
[152.694735] Starting subtest: basic
[152.718447] Subtest basic: SUCCESS (0.024s)
[152.901651] [047/161] (901s left) gem_tiled_fence_blits (basic)
[153.080285] Starting subtest: basic
[153.101083] Subtest basic: SUCCESS (0.022s)
[153.269956] [048/161] (901s left) gem_tiled_pread_basic
[153.457908] [049/161] (901s left) gem_wait (busy@all-engines)
[153.531165] Starting subtest: busy
[153.532027] Starting dynamic subtest: all-engines
[154.086857] Dynamic subtest all-engines: SUCCESS (0.554s)
[154.088348] Subtest busy: SUCCESS (0.555s)
[154.342324] [050/161] (900s left) gem_wait (wait@all-engines)
[154.419759] Starting subtest: wait
[154.420650] Starting dynamic subtest: all-engines
[155.504166] Dynamic subtest all-engines: SUCCESS (1.084s)
[155.505749] Subtest wait: SUCCESS (1.084s)
[155.747684] [051/161] (899s left) i915_getparams_basic (basic-eu-total)
[155.793940] Starting subtest: basic-eu-total
[155.795486] Subtest basic-eu-total: SUCCESS (0.000s)
[155.894841] [052/161] (899s left) i915_getparams_basic (basic-subslice-total)
[155.936896] Starting subtest: basic-subslice-total
[155.938890] Subtest basic-subslice-total: SUCCESS (0.000s)
[156.030360] [053/161] (899s left) i915_hangman (error-state-basic)
[156.081602] Starting subtest: error-state-basic
[156.195834] Subtest error-state-basic: SUCCESS (0.114s)
[156.312988] [054/161] (898s left) i915_pciid
[156.464808] [055/161] (898s left) kms_addfb_basic (addfb25-4-tiled)
[156.545095] Starting subtest: addfb25-4-tiled
[156.545946] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[156.685288] [056/161] (898s left) kms_addfb_basic (addfb25-bad-modifier)
[156.757111] Starting subtest: addfb25-bad-modifier
[156.758088] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[156.894134] [057/161] (898s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[156.971712] Starting subtest: addfb25-framebuffer-vs-set-tiling
[156.972800] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.001s)
[157.101884] [058/161] (898s left) kms_addfb_basic (addfb25-modifier-no-flag)
[157.177368] Starting subtest: addfb25-modifier-no-flag
[157.178132] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[157.312303] [059/161] (898s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[157.386438] Starting subtest: addfb25-x-tiled-legacy
[157.387416] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[157.525438] [060/161] (897s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[157.599356] Starting subtest: addfb25-x-tiled-mismatch-legacy
[157.600347] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[157.736086] [061/161] (897s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[157.813437] Starting subtest: addfb25-yf-tiled-legacy
[157.814334] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[157.949746] [062/161] (897s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[158.026311] Starting subtest: addfb25-y-tiled-legacy
[158.027286] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[158.162754] [063/161] (897s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[158.241265] Starting subtest: addfb25-y-tiled-small-legacy
[158.242289] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[158.373547] [064/161] (897s left) kms_addfb_basic (bad-pitch-0)
[158.426680] Starting subtest: bad-pitch-0
[158.427490] Subtest bad-pitch-0: SUCCESS (0.000s)
[158.589879] [065/161] (897s left) kms_addfb_basic (bad-pitch-1024)
[158.640054] Starting subtest: bad-pitch-1024
[158.640872] Subtest bad-pitch-1024: SUCCESS (0.000s)
[158.795731] [066/161] (897s left) kms_addfb_basic (bad-pitch-128)
[158.845378] Starting subtest: bad-pitch-128
[158.846172] Subtest bad-pitch-128: SUCCESS (0.000s)
[159.003343] [067/161] (896s left) kms_addfb_basic (bad-pitch-256)
[159.053459] Starting subtest: bad-pitch-256
[159.054326] Subtest bad-pitch-256: SUCCESS (0.000s)
[159.212538] [068/161] (896s left) kms_addfb_basic (bad-pitch-32)
[159.263588] Starting subtest: bad-pitch-32
[159.264417] Subtest bad-pitch-32: SUCCESS (0.000s)
[159.428229] [069/161] (896s left) kms_addfb_basic (bad-pitch-63)
[159.480119] Starting subtest: bad-pitch-63
[159.480943] Subtest bad-pitch-63: SUCCESS (0.000s)
[159.644812] [070/161] (896s left) kms_addfb_basic (bad-pitch-65536)
[159.696905] Starting subtest: bad-pitch-65536
[159.697967] Subtest bad-pitch-65536: SUCCESS (0.000s)
[159.859045] [071/161] (896s left) kms_addfb_basic (bad-pitch-999)
[159.908844] Starting subtest: bad-pitch-999
[159.909610] Subtest bad-pitch-999: SUCCESS (0.000s)
[160.078407] [072/161] (896s left) kms_addfb_basic (basic)
[160.130695] Starting subtest: basic
[160.131513] Subtest basic: SUCCESS (0.000s)
[160.283460] [073/161] (895s left) kms_addfb_basic (basic-x-tiled-legacy)
[160.336862] Starting subtest: basic-x-tiled-legacy
[160.338159] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[160.494950] [074/161] (895s left) kms_addfb_basic (basic-y-tiled-legacy)
[160.549404] Starting subtest: basic-y-tiled-legacy
[160.550866] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[160.709879] [075/161] (895s left) kms_addfb_basic (bo-too-small)
[160.790327] Starting subtest: bo-too-small
[160.791352] Subtest bo-too-small: SUCCESS (0.000s)
[160.923772] [076/161] (895s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[161.004319] Starting subtest: bo-too-small-due-to-tiling
[161.012464] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[161.150035] [077/161] (895s left) kms_addfb_basic (clobberred-modifier)
[161.201216] Starting subtest: clobberred-modifier
[161.202052] Subtest clobberred-modifier: SUCCESS (0.000s)
[161.366685] [078/161] (895s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[161.419022] Starting subtest: framebuffer-vs-set-tiling
[161.419834] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[161.584160] [079/161] (894s left) kms_addfb_basic (invalid-get-prop)
[161.633926] Starting subtest: invalid-get-prop
[161.634927] Subtest invalid-get-prop: SUCCESS (0.000s)
[161.789302] [080/161] (894s left) kms_addfb_basic (invalid-get-prop-any)
[161.839313] Starting subtest: invalid-get-prop-any
[161.840138] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[162.000695] [081/161] (894s left) kms_addfb_basic (invalid-set-prop)
[162.055994] Starting subtest: invalid-set-prop
[162.057094] Subtest invalid-set-prop: SUCCESS (0.000s)
[162.222773] [082/161] (894s left) kms_addfb_basic (invalid-set-prop-any)
[162.273532] Starting subtest: invalid-set-prop-any
[162.274288] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[162.431977] [083/161] (894s left) kms_addfb_basic (no-handle)
[162.484333] Starting subtest: no-handle
[162.485802] Subtest no-handle: SUCCESS (0.000s)
[162.644312] [084/161] (894s left) kms_addfb_basic (size-max)
[162.723086] Starting subtest: size-max
[162.724114] Subtest size-max: SUCCESS (0.000s)
[162.863119] [085/161] (893s left) kms_addfb_basic (small-bo)
[162.937990] Starting subtest: small-bo
[162.938863] Subtest small-bo: SUCCESS (0.000s)
[163.073414] [086/161] (893s left) kms_addfb_basic (tile-pitch-mismatch)
[163.126166] Starting subtest: tile-pitch-mismatch
[163.126932] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[163.288474] [087/161] (893s left) kms_addfb_basic (too-high)
[163.366959] Starting subtest: too-high
[163.367915] Subtest too-high: SUCCESS (0.001s)
[163.505760] [088/161] (893s left) kms_addfb_basic (too-wide)
[163.587249] Starting subtest: too-wide
[163.588176] Subtest too-wide: SUCCESS (0.000s)
[163.723812] [089/161] (893s left) kms_addfb_basic (unused-handle)
[163.776509] Starting subtest: unused-handle
[163.777294] Subtest unused-handle: SUCCESS (0.000s)
[163.936049] [090/161] (893s left) kms_addfb_basic (unused-modifier)
[163.989429] Starting subtest: unused-modifier
[163.990308] Subtest unused-modifier: SUCCESS (0.000s)
[164.155226] [091/161] (892s left) kms_addfb_basic (unused-offsets)
[164.206854] Starting subtest: unused-offsets
[164.207962] Subtest unused-offsets: SUCCESS (0.000s)
[164.372354] [092/161] (892s left) kms_addfb_basic (unused-pitches)
[164.422972] Starting subtest: unused-pitches
[164.423932] Subtest unused-pitches: SUCCESS (0.000s)
[164.584485] [093/161] (892s left) kms_busy (basic)
[164.669750] Starting subtest: basic
[164.670605] Starting dynamic subtest: flip
[165.527862] Dynamic subtest flip: SUCCESS (0.857s)
[165.551460] Starting dynamic subtest: modeset
[169.392121] Dynamic subtest modeset: SUCCESS (3.862s)
[169.392994] Subtest basic: SUCCESS (4.721s)
[170.332919] [094/161] (886s left) kms_prop_blob (basic)
[170.381147] Starting subtest: basic
[170.381969] Subtest basic: SUCCESS (0.000s)
[170.481644] [095/161] (886s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[170.590918] Starting subtest: basic-busy-flip-before-cursor-atomic
[170.592646] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[170.747814] [096/161] (886s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[170.855215] Starting subtest: basic-busy-flip-before-cursor-legacy
[170.857146] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[171.009023] [097/161] (886s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[171.114870] Starting subtest: basic-flip-after-cursor-atomic
[172.307859] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.191s)
[173.215506] [098/161] (884s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[173.324928] Starting subtest: basic-flip-after-cursor-legacy
[174.515386] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.188s)
[175.455814] [099/161] (882s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[175.569786] Starting subtest: basic-flip-after-cursor-varying-size
[176.758758] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.189s)
[177.696792] [100/161] (879s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[177.807871] Starting subtest: basic-flip-before-cursor-atomic
[179.001287] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.191s)
[179.937891] [101/161] (877s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[180.046309] Starting subtest: basic-flip-before-cursor-legacy
[181.236529] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.187s)
[182.172158] [102/161] (875s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[182.276445] Starting subtest: basic-flip-before-cursor-varying-size
[183.468326] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.190s)
[184.416276] [103/161] (873s left) kms_dsc (dsc-basic)
[184.490714] Starting subtest: dsc-basic
[184.494283] Subtest dsc-basic: SKIP (0.000s)
[184.594957] [104/161] (873s left) kms_flip (basic-flip-vs-dpms)
[184.663361] Starting subtest: basic-flip-vs-dpms
[184.665112] Starting dynamic subtest: A-eDP1
[187.474294] Dynamic subtest A-eDP1: SUCCESS (2.809s)
[187.484823] Starting dynamic subtest: B-eDP1
[189.861497] Dynamic subtest B-eDP1: SUCCESS (2.384s)
[189.884582] Starting dynamic subtest: C-eDP1
[192.215070] Dynamic subtest C-eDP1: SUCCESS (2.355s)
[192.216849] Subtest basic-flip-vs-dpms: SUCCESS (7.552s)
[193.180778] [105/161] (864s left) kms_flip (basic-flip-vs-modeset)
[193.263880] Starting subtest: basic-flip-vs-modeset
[193.266011] Starting dynamic subtest: A-eDP1
[196.024245] Dynamic subtest A-eDP1: SUCCESS (2.757s)
[196.045824] Starting dynamic subtest: B-eDP1
[198.404493] Dynamic subtest B-eDP1: SUCCESS (2.380s)
[198.426163] Starting dynamic subtest: C-eDP1
[200.768333] Dynamic subtest C-eDP1: SUCCESS (2.362s)
[200.769195] Subtest basic-flip-vs-modeset: SUCCESS (7.504s)
[201.727594] [106/161] (856s left) kms_flip (basic-flip-vs-wf_vblank)
[201.804612] Starting subtest: basic-flip-vs-wf_vblank
[201.806632] Starting dynamic subtest: A-eDP1
[204.036433] Dynamic subtest A-eDP1: SUCCESS (2.229s)
[204.063563] Starting dynamic subtest: B-eDP1
[206.274883] Dynamic subtest B-eDP1: SUCCESS (2.236s)
[206.301573] Starting dynamic subtest: C-eDP1
[208.499503] Dynamic subtest C-eDP1: SUCCESS (2.219s)
[208.500384] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.695s)
[209.755873] [107/161] (848s left) kms_flip (basic-plain-flip)
[209.835527] Starting subtest: basic-plain-flip
[209.836867] Starting dynamic subtest: A-eDP1
[211.774506] Dynamic subtest A-eDP1: SUCCESS (1.937s)
[211.789232] Starting dynamic subtest: B-eDP1
[213.708507] Dynamic subtest B-eDP1: SUCCESS (1.931s)
[213.733604] Starting dynamic subtest: C-eDP1
[215.615945] Dynamic subtest C-eDP1: SUCCESS (1.905s)
[215.619469] Subtest basic-plain-flip: SUCCESS (5.784s)
[216.940222] [108/161] (840s left) kms_force_connector_basic (force-connector-state)
[217.008300] Starting subtest: force-connector-state
[217.493012] Subtest force-connector-state: SUCCESS (0.485s)
[218.662008] [109/161] (839s left) kms_force_connector_basic (force-edid)
[218.727983] Starting subtest: force-edid
[218.769960] Subtest force-edid: SUCCESS (0.043s)
[218.950696] [110/161] (839s left) kms_force_connector_basic (force-load-detect)
[219.007296] Starting subtest: force-load-detect
[219.009201] Subtest force-load-detect: SKIP (0.000s)
[219.151143] [111/161] (838s left) kms_force_connector_basic (prune-stale-modes)
[219.209224] Starting subtest: prune-stale-modes
[219.242083] Subtest prune-stale-modes: SUCCESS (0.033s)
[219.404222] [112/161] (838s left) kms_frontbuffer_tracking (basic)
[219.478123] Starting subtest: basic
[225.051529] Subtest basic: SUCCESS (5.573s)
[225.204918] [113/161] (832s left) kms_hdmi_inject (inject-audio)
[225.562849] Starting subtest: inject-audio
[225.723950] Subtest inject-audio: SUCCESS (0.162s)
[226.467959] [114/161] (831s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[226.547633] Starting subtest: compare-crc-sanitycheck-xr24
[226.548531] Starting dynamic subtest: pipe-A-eDP-1
[227.421704] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.873s)
[227.433902] Starting dynamic subtest: pipe-B-eDP-1
[228.982071] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.557s)
[229.009275] Starting dynamic subtest: pipe-C-eDP-1
[230.386236] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.398s)
[230.387356] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.837s)
[231.270237] [115/161] (826s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[231.348637] Starting subtest: compare-crc-sanitycheck-nv12
[231.349434] Starting dynamic subtest: pipe-A-eDP-1
[232.349125] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.999s)
[232.376658] Starting dynamic subtest: pipe-B-eDP-1
[233.734231] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.384s)
[233.759939] Starting dynamic subtest: pipe-C-eDP-1
[235.120950] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.384s)
[235.121721] Subtest compare-crc-sanitycheck-nv12: SUCCESS (3.773s)
[236.019875] [116/161] (822s left) kms_pipe_crc_basic (hang-read-crc)
[236.096915] Starting subtest: hang-read-crc
[236.097914] Starting dynamic subtest: pipe-A-eDP-1
[238.607226] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.509s)
[238.625128] Starting dynamic subtest: pipe-B-eDP-1
[241.694891] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.084s)
[241.708922] Starting dynamic subtest: pipe-C-eDP-1
[244.662371] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.964s)
[244.663469] Subtest hang-read-crc: SUCCESS (8.566s)
[245.546167] [117/161] (812s left) kms_pipe_crc_basic (nonblocking-crc)
[245.620565] Starting subtest: nonblocking-crc
[245.621785] Starting dynamic subtest: pipe-A-eDP-1
[246.588137] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.966s)
[246.603412] Starting dynamic subtest: pipe-B-eDP-1
[248.235074] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.645s)
[248.250805] Starting dynamic subtest: pipe-C-eDP-1
[249.785102] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.548s)
[249.785892] Subtest nonblocking-crc: SUCCESS (4.166s)
[250.712291] [118/161] (807s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[250.790014] Starting subtest: nonblocking-crc-frame-sequence
[250.791143] Starting dynamic subtest: pipe-A-eDP-1
[251.773558] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.982s)
[251.788981] Starting dynamic subtest: pipe-B-eDP-1
[253.399614] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.624s)
[253.416295] Starting dynamic subtest: pipe-C-eDP-1
[255.027777] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.625s)
[255.028641] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.239s)
[255.963898] [119/161] (802s left) kms_pipe_crc_basic (read-crc)
[256.044143] Starting subtest: read-crc
[256.045113] Starting dynamic subtest: pipe-A-eDP-1
[256.905883] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.860s)
[256.919496] Starting dynamic subtest: pipe-B-eDP-1
[258.452430] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.544s)
[258.468921] Starting dynamic subtest: pipe-C-eDP-1
[259.983755] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.529s)
[259.984554] Subtest read-crc: SUCCESS (3.940s)
[260.896871] [120/161] (797s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[260.974137] Starting subtest: read-crc-frame-sequence
[260.974954] Starting dynamic subtest: pipe-A-eDP-1
[261.889353] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.914s)
[261.904891] Starting dynamic subtest: pipe-B-eDP-1
[263.487839] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.596s)
[263.502600] Starting dynamic subtest: pipe-C-eDP-1
[265.026684] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.537s)
[265.027502] Subtest read-crc-frame-sequence: SUCCESS (4.055s)
[265.939056] [121/161] (792s left) kms_pm_backlight (basic-brightness)
[266.019330] Starting subtest: basic-brightness
[266.093244] Starting dynamic subtest: eDP-1
[266.420259] Dynamic subtest eDP-1: SUCCESS (0.330s)
[266.421089] Subtest basic-brightness: SUCCESS (0.401s)
[267.344843] [122/161] (791s left) kms_pm_rpm (basic-pci-d3-state)
[268.903142] Starting subtest: basic-pci-d3-state
[270.394751] Subtest basic-pci-d3-state: SUCCESS (1.491s)
[270.535283] [123/161] (788s left) kms_pm_rpm (basic-rte)
[270.583745] Starting subtest: basic-rte
[273.559384] Subtest basic-rte: SUCCESS (2.974s)
[275.133283] [124/161] (783s left) kms_psr (psr-primary-page-flip)
[275.214334] Starting subtest: psr-primary-page-flip
[275.215314] Starting dynamic subtest: eDP-1
[277.184764] Dynamic subtest eDP-1: SUCCESS (1.968s)
[277.186061] Subtest psr-primary-page-flip: SUCCESS (1.970s)
[278.128598] [125/161] (780s left) kms_psr (psr-cursor-plane-move)
[278.211336] Starting subtest: psr-cursor-plane-move
[278.212447] Starting dynamic subtest: eDP-1
[280.076414] Dynamic subtest eDP-1: SUCCESS (1.864s)
[280.077608] Subtest psr-cursor-plane-move: SUCCESS (1.867s)
[280.936664] [126/161] (777s left) kms_psr (psr-sprite-plane-onoff)
[281.018232] Starting subtest: psr-sprite-plane-onoff
[281.019089] Starting dynamic subtest: eDP-1
[283.071941] Dynamic subtest eDP-1: SUCCESS (2.052s)
[283.073335] Subtest psr-sprite-plane-onoff: SUCCESS (2.054s)
[283.947740] [127/161] (774s left) kms_psr (psr-primary-mmap-gtt)
[284.028204] Starting subtest: psr-primary-mmap-gtt
[284.029122] Starting dynamic subtest: eDP-1
[286.005147] Dynamic subtest eDP-1: SUCCESS (1.977s)
[286.006587] Subtest psr-primary-mmap-gtt: SUCCESS (1.979s)
[286.954628] [128/161] (771s left) kms_setmode (basic-clone-single-crtc)
[287.009207] Starting subtest: basic-clone-single-crtc
[287.011393] Subtest basic-clone-single-crtc: SKIP (0.000s)
[287.119721] [129/161] (771s left) i915_pm_rps (basic-api)
[287.169906] Starting subtest: basic-api
[287.171497] Subtest basic-api: SKIP (0.001s)
[287.300081] [130/161] (771s left) prime_self_import (basic-llseek-bad)
[287.345158] Starting subtest: basic-llseek-bad
[287.346860] Subtest basic-llseek-bad: SUCCESS (0.002s)
[287.448299] [131/161] (771s left) prime_self_import (basic-llseek-size)
[287.492204] Starting subtest: basic-llseek-size
[287.494176] Subtest basic-llseek-size: SUCCESS (0.003s)
[287.631136] [132/161] (771s left) prime_self_import (basic-with_fd_dup)
[287.672898] Starting subtest: basic-with_fd_dup
[287.677124] Subtest basic-with_fd_dup: SUCCESS (0.003s)
[287.814447] [133/161] (771s left) prime_self_import (basic-with_one_bo)
[287.857733] Starting subtest: basic-with_one_bo
[287.860846] Subtest basic-with_one_bo: SUCCESS (0.003s)
[287.948318] [134/161] (771s left) prime_self_import (basic-with_one_bo_two_files)
[287.991570] Starting subtest: basic-with_one_bo_two_files
[287.994543] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s)
[288.114176] [135/161] (771s left) prime_self_import (basic-with_two_bos)
[288.157477] Starting subtest: basic-with_two_bos
[288.159138] Subtest basic-with_two_bos: SUCCESS (0.003s)
[288.264788] [136/161] (770s left) prime_vgem (basic-fence-flip)
[288.334466] Starting subtest: basic-fence-flip
[288.777768] Subtest basic-fence-flip: SUCCESS (0.443s)
[288.917370] [137/161] (770s left) prime_vgem (basic-fence-mmap)
[288.967715] Starting subtest: basic-fence-mmap
[288.994584] Subtest basic-fence-mmap: SUCCESS (0.027s)
[289.125339] [138/161] (770s left) prime_vgem (basic-fence-read)
[289.186338] Starting subtest: basic-fence-read
[289.192907] Subtest basic-fence-read: SKIP (0.008s)
[289.316440] [139/161] (770s left) prime_vgem (basic-gtt)
[289.367922] Starting subtest: basic-gtt
[289.382491] Subtest basic-gtt: SUCCESS (0.015s)
[289.523431] [140/161] (769s left) prime_vgem (basic-read)
[289.595671] Starting subtest: basic-read
[289.605230] Subtest basic-read: SKIP (0.009s)
[289.733992] [141/161] (769s left) prime_vgem (basic-write)
[289.783757] Starting subtest: basic-write
[289.792525] Subtest basic-write: SKIP (0.008s)
[289.916894] [142/161] (769s left) vgem_basic (setversion)
[289.961561] Starting subtest: setversion
[289.963126] Subtest setversion: SUCCESS (0.000s)
[290.055864] [143/161] (769s left) vgem_basic (create)
[290.115987] Starting subtest: create
[290.117170] Subtest create: SUCCESS (0.001s)
[290.199845] [144/161] (769s left) vgem_basic (debugfs)
[290.245620] Starting subtest: debugfs
[290.247181] Subtest debugfs: SUCCESS (0.001s)
[290.338133] [145/161] (769s left) vgem_basic (dmabuf-export)
[290.395418] Starting subtest: dmabuf-export
[290.409573] Subtest dmabuf-export: SUCCESS (0.012s)
[290.533115] [146/161] (769s left) vgem_basic (dmabuf-fence)
[290.581146] Starting subtest: dmabuf-fence
[290.581874] Subtest dmabuf-fence: SUCCESS (0.001s)
[290.664808] [147/161] (769s left) vgem_basic (dmabuf-fence-before)
[290.712893] Starting subtest: dmabuf-fence-before
[290.713716] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[290.795123] [148/161] (769s left) vgem_basic (dmabuf-mmap)
[290.845605] Starting subtest: dmabuf-mmap
[290.860291] Subtest dmabuf-mmap: SUCCESS (0.015s)
[290.944985] [149/161] (768s left) vgem_basic (mmap)
[290.995073] Starting subtest: mmap
[291.004477] Subtest mmap: SUCCESS (0.010s)
[291.077898] [150/161] (768s left) vgem_basic (second-client)
[291.128434] Starting subtest: second-client
[291.163275] Subtest second-client: SUCCESS (0.033s)
[291.248954] [151/161] (768s left) vgem_basic (sysfs)
[291.295035] Starting subtest: sysfs
[291.295819] Subtest sysfs: SUCCESS (0.001s)
[291.384381] [152/161] (768s left) core_hotunplug (unbind-rebind)
[291.505571] Starting subtest: unbind-rebind
[296.143123] Subtest unbind-rebind: SUCCESS (4.639s)
[296.190253] [153/161] (763s left) vgem_basic (unload)
[296.237700] Starting subtest: unload
[325.398983] Subtest unload: SUCCESS (29.127s)
[325.539210] [154/161] (734s left) i915_module_load (reload)
[325.585957] Starting subtest: reload
[329.176077] Subtest reload: SUCCESS (3.590s)
[329.219566] [155/161] (730s left) gem_lmem_swapping (basic)
[329.277197] Subtest basic: SKIP (0.000s)
[329.354980] [156/161] (730s left) gem_lmem_swapping (parallel-random-engines)
[329.443234] Subtest parallel-random-engines: SKIP (0.000s)
[329.524407] [157/161] (730s left) gem_lmem_swapping (random-engines)
[329.582350] Subtest random-engines: SKIP (0.000s)
[329.651327] [158/161] (730s left) gem_lmem_swapping (verify-random)
[329.706807] Subtest verify-random: SKIP (0.000s)
[329.763072] [159/161] (730s left) i915_pm_rpm (module-reload)
[332.101303] Starting subtest: module-reload
[344.260789] Subtest module-reload: SUCCESS (12.149s)
[344.295880] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[344.297186] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[344.301967] [160/161] (716s left) i915_selftest (live)
[344.352870] Starting subtest: live
[344.353757] Starting dynamic subtest: sanitycheck
[346.579878] Dynamic subtest sanitycheck: SUCCESS (2.217s)
[346.590910] Starting dynamic subtest: uncore
[348.834868] Dynamic subtest uncore: SUCCESS (2.252s)
[348.845906] Starting dynamic subtest: workarounds
[351.866984] Dynamic subtest workarounds: SUCCESS (3.029s)
[351.877384] Starting dynamic subtest: gt_engines
[354.597728] Dynamic subtest gt_engines: SUCCESS (2.727s)
[354.608486] Starting dynamic subtest: gt_timelines
[365.004704] Dynamic subtest gt_timelines: SUCCESS (10.403s)
[365.017656] Starting dynamic subtest: gt_contexts
[367.559087] Dynamic subtest gt_contexts: SUCCESS (2.551s)
[367.570100] Starting dynamic subtest: gt_lrc
[372.302982] Dynamic subtest gt_lrc: SUCCESS (4.741s)
[372.314350] Starting dynamic subtest: gt_mocs
[375.102351] Dynamic subtest gt_mocs: SUCCESS (2.796s)
[375.110722] Starting dynamic subtest: gt_pm
[379.782858] Dynamic subtest gt_pm: SUCCESS (4.677s)
[379.793221] Starting dynamic subtest: gt_heartbeat
[382.053953] Dynamic subtest gt_heartbeat: SUCCESS (2.268s)
[382.066527] Starting dynamic subtest: gt_tlb
[385.522751] Dynamic subtest gt_tlb: SUCCESS (3.466s)
[385.534048] Starting dynamic subtest: requests
[394.245204] Dynamic subtest requests: SUCCESS (8.727s)
[394.278060] Starting dynamic subtest: migrate
[399.208739] Dynamic subtest migrate: SUCCESS (4.952s)
[399.221923] Starting dynamic subtest: active
[401.438873] Dynamic subtest active: SUCCESS (2.227s)
[401.449538] Starting dynamic subtest: objects
[404.593967] Dynamic subtest objects: SUCCESS (3.151s)
[404.605015] Starting dynamic subtest: mman
[410.421826] Dynamic subtest mman: SUCCESS (5.825s)
[410.432959] Starting dynamic subtest: dmabuf
[412.974965] Dynamic subtest dmabuf: SUCCESS (2.550s)
[412.986204] Starting dynamic subtest: vma
[415.383893] Dynamic subtest vma: SUCCESS (2.405s)
[415.394872] Starting dynamic subtest: coherency
[420.797301] Dynamic subtest coherency: SUCCESS (5.410s)
[420.808867] Starting dynamic subtest: gtt
[429.996915] Dynamic subtest gtt: SUCCESS (9.196s)
[430.008109] Starting dynamic subtest: gem
[432.670769] Dynamic subtest gem: SUCCESS (2.671s)
[432.681961] Starting dynamic subtest: evict
[436.559630] Dynamic subtest evict: SUCCESS (3.885s)
[436.570918] Starting dynamic subtest: hugepages
[445.124154] Dynamic subtest hugepages: SUCCESS (8.561s)
[445.138810] Starting dynamic subtest: gem_contexts
[459.959427] Dynamic subtest gem_contexts: SUCCESS (14.832s)
[459.970256] Starting dynamic subtest: client
[462.447071] Dynamic subtest client: SUCCESS (2.484s)
[462.455926] Starting dynamic subtest: gem_migrate
[464.833759] Dynamic subtest gem_migrate: SUCCESS (2.383s)
[464.843752] Starting dynamic subtest: reset
[469.729619] Dynamic subtest reset: SUCCESS (4.892s)
[469.740918] Starting dynamic subtest: memory_region
[472.169953] Dynamic subtest memory_region: SUCCESS (2.437s)
[472.180807] Starting dynamic subtest: hangcheck
[489.675299] Dynamic subtest hangcheck: SUCCESS (17.501s)
[489.687110] Starting dynamic subtest: execlists
[492.105063] Dynamic subtest execlists: SUCCESS (2.426s)
[492.116235] Starting dynamic subtest: ring_submission
[494.490951] Dynamic subtest ring_submission: SUCCESS (2.382s)
[494.504372] Starting dynamic subtest: perf
[497.003032] Dynamic subtest perf: SUCCESS (2.509s)
[497.013912] Starting dynamic subtest: slpc
[503.502680] Dynamic subtest slpc: SUCCESS (6.503s)
[503.514216] Starting dynamic subtest: guc
[506.602765] Dynamic subtest guc: SUCCESS (3.090s)
[506.613418] Starting dynamic subtest: guc_multi_lrc
[508.824621] Dynamic subtest guc_multi_lrc: SUCCESS (2.219s)
[508.833997] Starting dynamic subtest: guc_hang
[511.848913] Dynamic subtest guc_hang: SUCCESS (3.021s)
[511.859913] Starting dynamic subtest: late_gt_pm
[514.262247] Dynamic subtest late_gt_pm: SUCCESS (2.414s)
[514.263128] Subtest live: SUCCESS (169.902s)
[514.298839] [161/161] (546s left) dmabuf (all-tests)
[514.355149] Starting subtest: all-tests
[514.355976] Starting dynamic subtest: sanitycheck
[514.447360] Dynamic subtest sanitycheck: SUCCESS (0.093s)
[514.477838] Starting dynamic subtest: dma_fence
[514.692891] Dynamic subtest dma_fence: SUCCESS (0.234s)
[514.703202] Starting dynamic subtest: dma_fence_chain
[525.278199] Dynamic subtest dma_fence_chain: SUCCESS (10.581s)
[525.298606] Starting dynamic subtest: dma_fence_unwrap
[525.369334] Dynamic subtest dma_fence_unwrap: SUCCESS (0.096s)
[525.395796] Starting dynamic subtest: dma_resv
[525.487268] Dynamic subtest dma_resv: SUCCESS (0.115s)
[525.489043] Subtest all-tests: SUCCESS (11.135s)
[525.538972] Closing watchdogs
Done.