[45.001084] Initializing watchdogs
[45.001141]   /dev/watchdog0
[45.017359] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d51 Intel Meteorlake (Gen12) 
[45.026503] [001/162] (960s left) i915_module_load (load)
[45.154575] Starting subtest: load
[48.410408] Subtest load: SUCCESS (3.258s)
[48.449785] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[48.451276] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[48.458659] [002/162] (957s left) core_auth (basic-auth)
[50.216518] Starting subtest: basic-auth
[50.223283] Subtest basic-auth: SUCCESS (0.003s)
[50.433721] [003/162] (955s left) core_debugfs (read-all-entries)
[50.555707] Starting subtest: read-all-entries
[50.717792] Subtest read-all-entries: SUCCESS (0.177s)
[50.863265] [004/162] (954s left) core_sysfs (read-all-entries)
[50.983687] Starting subtest: read-all-entries
[50.996882] Subtest read-all-entries: SUCCESS (0.011s)
[51.072487] [005/162] (954s left) fbdev (eof)
[51.134810] Starting subtest: eof
[51.143531] Subtest eof: SUCCESS (0.000s)
[51.222382] [006/162] (954s left) fbdev (info)
[51.269287] Starting subtest: info
[51.278170] Subtest info: SUCCESS (0.000s)
[51.347948] [007/162] (954s left) fbdev (nullptr)
[51.412694] Starting subtest: nullptr
[51.425172] Subtest nullptr: SUCCESS (0.000s)
[51.490019] [008/162] (954s left) fbdev (read)
[51.540970] Starting subtest: read
[52.459470] Subtest read: SUCCESS (0.900s)
[52.556679] [009/162] (953s left) fbdev (write)
[52.628381] Starting subtest: write
[53.223701] Subtest write: SUCCESS (0.591s)
[53.303661] [010/162] (952s left) gem_basic (bad-close)
[53.368259] Starting subtest: bad-close
[53.381792] Subtest bad-close: SUCCESS (0.000s)
[53.449204] [011/162] (952s left) gem_basic (create-close)
[53.504725] Starting subtest: create-close
[53.517887] Subtest create-close: SUCCESS (0.000s)
[53.611689] [012/162] (952s left) gem_basic (create-fd-close)
[53.667704] Starting subtest: create-fd-close
[53.681040] Subtest create-fd-close: SUCCESS (0.000s)
[53.764891] [013/162] (952s left) gem_busy (busy@all-engines)
[53.827532] Starting subtest: busy
[53.834290] Starting dynamic subtest: all-engines
[53.863891] Dynamic subtest all-engines: SUCCESS (0.042s)
[53.870846] Subtest busy: SUCCESS (0.043s)
[55.449613] [014/162] (951s left) gem_close_race (basic-process)
[55.533661] Starting subtest: basic-process
[55.581695] Subtest basic-process: SUCCESS (0.053s)
[55.775733] [015/162] (950s left) gem_close_race (basic-threads)
[55.836613] Starting subtest: basic-threads
[57.069887] Subtest basic-threads: SUCCESS (1.231s)
[57.281365] [016/162] (949s left) gem_ctx_create (basic)
[57.361027] Starting subtest: basic
[57.376505] Subtest basic: SUCCESS (0.000s)
[57.550580] [017/162] (949s left) gem_ctx_create (basic-files)
[57.622804] Starting subtest: basic-files
[59.637222] Subtest basic-files: SUCCESS (2.086s)
[61.253968] [018/162] (945s left) gem_ctx_exec (basic)
[61.335325] Starting subtest: basic
[61.343916] Subtest basic: SUCCESS (0.006s)
[61.443605] [019/162] (945s left) gem_exec_basic (basic)
[61.496081] Starting subtest: basic
[61.502334] Starting dynamic subtest: rcs0-smem
[61.518916] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[61.531339] Starting dynamic subtest: bcs0-smem
[61.538216] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[61.549649] Starting dynamic subtest: vcs0-smem
[61.555780] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[61.574350] Starting dynamic subtest: vcs1-smem
[61.580734] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[61.596854] Starting dynamic subtest: vecs0-smem
[61.603344] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[61.619510] Starting dynamic subtest: ccs0-smem
[61.625695] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[61.641653] Subtest basic: SUCCESS (0.014s)
[63.300424] [020/162] (943s left) gem_exec_create (basic)
[63.382345] Starting subtest: basic
[63.390914] Starting dynamic subtest: smem
[67.211363] Dynamic subtest smem: SUCCESS (3.907s)
[67.227219] Subtest basic: SUCCESS (3.908s)
[67.442210] [021/162] (939s left) gem_exec_fence (basic-busy)
[67.630433] Starting subtest: basic-busy
[67.641897] Starting dynamic subtest: rcs0
[67.682082] Dynamic subtest rcs0: SUCCESS (0.062s)
[67.701279] Starting dynamic subtest: bcs0
[67.737682] Dynamic subtest bcs0: SUCCESS (0.058s)
[67.755299] Starting dynamic subtest: vcs0
[67.791585] Dynamic subtest vcs0: SUCCESS (0.048s)
[67.803573] Starting dynamic subtest: vcs1
[67.842572] Dynamic subtest vcs1: SUCCESS (0.048s)
[67.864051] Starting dynamic subtest: vecs0
[67.893096] Dynamic subtest vecs0: SUCCESS (0.052s)
[67.909387] Starting dynamic subtest: ccs0
[67.941930] Dynamic subtest ccs0: SUCCESS (0.055s)
[67.955142] Subtest basic-busy: SUCCESS (0.325s)
[69.368633] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[69.383463] [022/162] (937s left) gem_exec_fence (basic-wait)
[69.560931] Starting subtest: basic-wait
[69.569551] Starting dynamic subtest: rcs0
[69.620526] Dynamic subtest rcs0: SUCCESS (0.062s)
[69.642429] Starting dynamic subtest: bcs0
[69.669148] Dynamic subtest bcs0: SUCCESS (0.057s)
[69.682142] Starting dynamic subtest: vcs0
[69.729314] Dynamic subtest vcs0: SUCCESS (0.052s)
[69.751308] Starting dynamic subtest: vcs1
[69.770247] Dynamic subtest vcs1: SUCCESS (0.051s)
[69.789192] Starting dynamic subtest: vecs0
[69.832420] Dynamic subtest vecs0: SUCCESS (0.052s)
[69.844855] Starting dynamic subtest: ccs0
[69.875863] Dynamic subtest ccs0: SUCCESS (0.054s)
[69.882324] Subtest basic-wait: SUCCESS (0.329s)
[71.360095] [023/162] (935s left) gem_exec_fence (basic-await)
[71.528105] Starting subtest: basic-await
[71.534869] Starting dynamic subtest: rcs0
[71.616321] Dynamic subtest rcs0: SUCCESS (0.091s)
[71.629238] Starting dynamic subtest: bcs0
[71.701894] Dynamic subtest bcs0: SUCCESS (0.086s)
[71.715206] Starting dynamic subtest: vcs0
[71.789113] Dynamic subtest vcs0: SUCCESS (0.087s)
[71.802635] Starting dynamic subtest: vcs1
[71.872109] Dynamic subtest vcs1: SUCCESS (0.083s)
[71.885252] Starting dynamic subtest: vecs0
[71.958683] Dynamic subtest vecs0: SUCCESS (0.086s)
[71.972285] Starting dynamic subtest: ccs0
[72.045283] Dynamic subtest ccs0: SUCCESS (0.087s)
[72.052045] Subtest basic-await: SUCCESS (0.523s)
[74.371095] [024/162] (932s left) gem_exec_fence (nb-await)
[74.539822] Starting subtest: nb-await
[74.546347] Starting dynamic subtest: rcs0
[74.627866] Dynamic subtest rcs0: SUCCESS (0.081s)
[74.649662] Starting dynamic subtest: bcs0
[74.690413] Dynamic subtest bcs0: SUCCESS (0.066s)
[74.702896] Starting dynamic subtest: vcs0
[74.747965] Dynamic subtest vcs0: SUCCESS (0.063s)
[74.760441] Starting dynamic subtest: vcs1
[74.810098] Dynamic subtest vcs1: SUCCESS (0.063s)
[74.822191] Starting dynamic subtest: vecs0
[74.872915] Dynamic subtest vecs0: SUCCESS (0.063s)
[74.885067] Starting dynamic subtest: ccs0
[74.936681] Dynamic subtest ccs0: SUCCESS (0.063s)
[74.943132] Subtest nb-await: SUCCESS (0.400s)
[76.336294] [025/162] (930s left) gem_exec_gttfill (basic)
[76.422714] Starting subtest: basic
[80.192208] Subtest basic: SUCCESS (3.796s)
[80.423820] [026/162] (926s left) gem_exec_parallel (engines)
[80.540246] Starting subtest: engines
[80.549990] Starting dynamic subtest: basic
[82.283212] Dynamic subtest basic: SUCCESS (1.746s)
[82.307215] Starting dynamic subtest: contexts
[86.995452] Dynamic subtest contexts: SUCCESS (4.720s)
[87.018220] Starting dynamic subtest: fds
[92.333006] Dynamic subtest fds: SUCCESS (5.347s)
[92.345545] Starting dynamic subtest: userptr
[94.235245] Dynamic subtest userptr: SUCCESS (1.901s)
[94.241845] Subtest engines: SUCCESS (13.716s)
[94.432552] [027/162] (912s left) gem_exec_store (basic)
[94.509946] Starting subtest: basic
[94.611088] Subtest basic: SUCCESS (0.124s)
[94.905060] [028/162] (912s left) gem_flink_basic (bad-flink)
[94.971134] Starting subtest: bad-flink
[94.977654] Subtest bad-flink: SUCCESS (0.000s)
[95.050329] [029/162] (912s left) gem_flink_basic (bad-open)
[95.110082] Starting subtest: bad-open
[95.116595] Subtest bad-open: SUCCESS (0.000s)
[95.182439] [030/162] (912s left) gem_flink_basic (basic)
[95.237714] Starting subtest: basic
[95.244322] Subtest basic: SUCCESS (0.000s)
[95.333116] [031/162] (912s left) gem_flink_basic (double-flink)
[95.398209] Starting subtest: double-flink
[95.405314] Subtest double-flink: SUCCESS (0.000s)
[95.528743] [032/162] (912s left) gem_flink_basic (flink-lifetime)
[95.597833] Starting subtest: flink-lifetime
[95.604353] Subtest flink-lifetime: SUCCESS (0.001s)
[95.716624] [033/162] (912s left) gem_huc_copy (huc-copy)
[95.791719] Starting subtest: huc-copy
[95.808061] Subtest huc-copy: SUCCESS (0.003s)
[95.922887] [034/162] (912s left) gem_linear_blits (basic)
[96.110637] Starting subtest: basic
[96.131907] Subtest basic: SUCCESS (0.020s)
[96.315509] [035/162] (911s left) gem_mmap (basic)
[96.433886] Subtest basic: SKIP (0.000s)
[96.512608] [036/162] (911s left) gem_mmap_gtt (basic)
[96.602191] Subtest basic: SKIP (0.000s)
[96.672125] [037/162] (911s left) gem_render_linear_blits (basic)
[96.746339] Starting subtest: basic
[96.797642] Subtest basic: SUCCESS (0.041s)
[96.870606] [038/162] (911s left) gem_render_tiled_blits (basic)
[96.933429] Subtest basic: SKIP (0.000s)
[96.990844] [039/162] (911s left) gem_ringfill (basic-all)
[102.233066] Starting subtest: basic-all
[103.397060] Subtest basic-all: SUCCESS (1.176s)
[103.534483] [040/162] (904s left) gem_softpin (allocator-basic)
[103.614785] Starting subtest: allocator-basic
[103.689914] Subtest allocator-basic: SUCCESS (0.097s)
[103.868695] [041/162] (904s left) gem_softpin (allocator-basic-reserve)
[103.942209] Starting subtest: allocator-basic-reserve
[104.025337] Subtest allocator-basic-reserve: SUCCESS (0.096s)
[104.196577] [042/162] (904s left) gem_softpin (safe-alignment)
[104.258554] Starting subtest: safe-alignment
[104.278940] Subtest safe-alignment: SUCCESS (0.032s)
[106.361491] [043/162] (902s left) gem_sync (basic-all)
[106.492803] Starting subtest: basic-all
[110.217866] Subtest basic-all: SUCCESS (3.790s)
[110.414871] [044/162] (898s left) gem_sync (basic-each)
[110.572801] Starting subtest: basic-each
[112.801888] Subtest basic-each: SUCCESS (2.317s)
[113.042777] [045/162] (895s left) gem_tiled_blits (basic)
[113.136793] Subtest basic: SKIP (0.000s)
[113.199541] [046/162] (895s left) gem_tiled_fence_blits (basic)
[113.277242] Subtest basic: SKIP (0.000s)
[113.359802] [047/162] (895s left) gem_tiled_pread_basic (basic)
[113.454312] Subtest basic: SKIP (0.000s)
[113.557679] [048/162] (895s left) gem_wait (busy@all-engines)
[113.643780] Starting subtest: busy
[113.650292] Starting dynamic subtest: all-engines
[115.210096] Dynamic subtest all-engines: SUCCESS (1.571s)
[115.223191] Subtest busy: SUCCESS (1.572s)
[115.462704] [049/162] (893s left) gem_wait (wait@all-engines)
[115.531584] Starting subtest: wait
[115.538649] Starting dynamic subtest: all-engines
[117.191546] Dynamic subtest all-engines: SUCCESS (1.656s)
[117.198165] Subtest wait: SUCCESS (1.656s)
[117.396688] [050/162] (891s left) i915_getparams_basic (basic-eu-total)
[117.474760] Starting subtest: basic-eu-total
[117.497967] Subtest basic-eu-total: SUCCESS (0.000s)
[117.567525] [051/162] (891s left) i915_getparams_basic (basic-subslice-total)
[117.624259] Starting subtest: basic-subslice-total
[117.638305] Subtest basic-subslice-total: SUCCESS (0.000s)
[117.707465] [052/162] (891s left) i915_hangman (error-state-basic)
[117.784429] Starting subtest: error-state-basic
[117.923167] Subtest error-state-basic: SUCCESS (0.144s)
[118.030501] [053/162] (891s left) i915_pciid
[118.170598] [054/162] (891s left) intel_hwmon (hwmon-read)
[118.233278] Subtest hwmon-read: SKIP (0.000s)
[118.294413] [055/162] (891s left) intel_hwmon (hwmon-write)
[118.350261] Subtest hwmon-write: SKIP (0.000s)
[118.408778] [056/162] (891s left) kms_addfb_basic (addfb25-4-tiled)
[118.500919] Starting subtest: addfb25-4-tiled
[118.508205] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[118.612177] [057/162] (890s left) kms_addfb_basic (addfb25-bad-modifier)
[118.695331] Starting subtest: addfb25-bad-modifier
[118.701935] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[118.801967] [058/162] (890s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[118.893917] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[119.013106] [059/162] (890s left) kms_addfb_basic (addfb25-modifier-no-flag)
[119.090217] Starting subtest: addfb25-modifier-no-flag
[119.096813] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[119.206954] [060/162] (890s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[119.297765] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[119.426677] [061/162] (890s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[119.509333] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[119.618356] [062/162] (890s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[119.706895] Starting subtest: addfb25-yf-tiled-legacy
[119.713663] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[119.785446] [063/162] (890s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[119.872614] Starting subtest: addfb25-y-tiled-legacy
[119.879148] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[119.970700] [064/162] (889s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[120.059522] Starting subtest: addfb25-y-tiled-small-legacy
[120.072282] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[120.162880] [065/162] (889s left) kms_addfb_basic (bad-pitch-0)
[120.220675] Starting subtest: bad-pitch-0
[120.227343] Subtest bad-pitch-0: SUCCESS (0.000s)
[120.356496] [066/162] (889s left) kms_addfb_basic (bad-pitch-1024)
[120.429730] Starting subtest: bad-pitch-1024
[120.438657] Subtest bad-pitch-1024: SUCCESS (0.000s)
[120.547300] [067/162] (889s left) kms_addfb_basic (bad-pitch-128)
[120.610873] Starting subtest: bad-pitch-128
[120.620244] Subtest bad-pitch-128: SUCCESS (0.000s)
[120.755093] [068/162] (889s left) kms_addfb_basic (bad-pitch-256)
[120.821261] Starting subtest: bad-pitch-256
[120.827740] Subtest bad-pitch-256: SUCCESS (0.000s)
[120.957054] [069/162] (889s left) kms_addfb_basic (bad-pitch-32)
[121.014133] Starting subtest: bad-pitch-32
[121.020656] Subtest bad-pitch-32: SUCCESS (0.000s)
[121.148787] [070/162] (889s left) kms_addfb_basic (bad-pitch-63)
[121.210243] Starting subtest: bad-pitch-63
[121.216852] Subtest bad-pitch-63: SUCCESS (0.000s)
[121.356554] [071/162] (888s left) kms_addfb_basic (bad-pitch-65536)
[121.410866] Starting subtest: bad-pitch-65536
[121.417570] Subtest bad-pitch-65536: SUCCESS (0.000s)
[121.566728] [072/162] (888s left) kms_addfb_basic (bad-pitch-999)
[121.627090] Starting subtest: bad-pitch-999
[121.633669] Subtest bad-pitch-999: SUCCESS (0.000s)
[121.751720] [073/162] (888s left) kms_addfb_basic (basic)
[121.806360] Starting subtest: basic
[121.812902] Subtest basic: SUCCESS (0.000s)
[121.936387] [074/162] (888s left) kms_addfb_basic (basic-x-tiled-legacy)
[121.999283] Starting subtest: basic-x-tiled-legacy
[122.012354] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[122.140198] [075/162] (888s left) kms_addfb_basic (basic-y-tiled-legacy)
[122.195688] Starting subtest: basic-y-tiled-legacy
[122.208667] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[122.330381] [076/162] (888s left) kms_addfb_basic (bo-too-small)
[122.412295] Starting subtest: bo-too-small
[122.418757] Subtest bo-too-small: SUCCESS (0.000s)
[122.517692] [077/162] (888s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[122.600479] Starting subtest: bo-too-small-due-to-tiling
[122.616566] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[122.710368] [078/162] (887s left) kms_addfb_basic (clobberred-modifier)
[122.786280] Starting subtest: clobberred-modifier
[122.808509] Subtest clobberred-modifier: SKIP (0.000s)
[122.930137] [079/162] (887s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[123.005599] Starting subtest: framebuffer-vs-set-tiling
[123.028513] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[123.165525] [080/162] (887s left) kms_addfb_basic (invalid-get-prop)
[123.243905] Starting subtest: invalid-get-prop
[123.257214] Subtest invalid-get-prop: SUCCESS (0.000s)
[123.375217] [081/162] (887s left) kms_addfb_basic (invalid-get-prop-any)
[123.441394] Starting subtest: invalid-get-prop-any
[123.449814] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[123.586624] [082/162] (887s left) kms_addfb_basic (invalid-set-prop)
[123.665455] Starting subtest: invalid-set-prop
[123.678949] Subtest invalid-set-prop: SUCCESS (0.000s)
[123.809929] [083/162] (887s left) kms_addfb_basic (invalid-set-prop-any)
[123.885849] Starting subtest: invalid-set-prop-any
[123.892622] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[124.001467] [084/162] (887s left) kms_addfb_basic (no-handle)
[124.057749] Starting subtest: no-handle
[124.064361] Subtest no-handle: SUCCESS (0.000s)
[124.193755] [085/162] (886s left) kms_addfb_basic (size-max)
[124.269863] Starting subtest: size-max
[124.276578] Subtest size-max: SUCCESS (0.000s)
[124.381807] [086/162] (886s left) kms_addfb_basic (small-bo)
[124.451929] Starting subtest: small-bo
[124.458479] Subtest small-bo: SUCCESS (0.000s)
[124.568779] [087/162] (886s left) kms_addfb_basic (tile-pitch-mismatch)
[124.625241] Starting subtest: tile-pitch-mismatch
[124.639261] Subtest tile-pitch-mismatch: SKIP (0.000s)
[124.855378] [088/162] (886s left) kms_addfb_basic (too-high)
[124.937959] Starting subtest: too-high
[124.944385] Subtest too-high: SUCCESS (0.000s)
[125.057849] [089/162] (886s left) kms_addfb_basic (too-wide)
[125.140340] Starting subtest: too-wide
[125.146780] Subtest too-wide: SUCCESS (0.000s)
[125.223532] [090/162] (886s left) kms_addfb_basic (unused-handle)
[125.285803] Starting subtest: unused-handle
[125.292171] Subtest unused-handle: SUCCESS (0.000s)
[125.414237] [091/162] (886s left) kms_addfb_basic (unused-modifier)
[125.470917] Starting subtest: unused-modifier
[125.477411] Subtest unused-modifier: SUCCESS (0.000s)
[125.630956] [092/162] (885s left) kms_addfb_basic (unused-offsets)
[125.722842] Starting subtest: unused-offsets
[125.729329] Subtest unused-offsets: SUCCESS (0.000s)
[125.841443] [093/162] (885s left) kms_addfb_basic (unused-pitches)
[125.916945] Starting subtest: unused-pitches
[125.933356] Subtest unused-pitches: SUCCESS (0.000s)
[126.052768] [094/162] (885s left) kms_busy (basic)
[126.150295] Starting subtest: basic
[126.166999] Starting dynamic subtest: flip
[126.932516] Dynamic subtest flip: SUCCESS (0.781s)
[126.950428] Starting dynamic subtest: modeset
[130.414897] Dynamic subtest modeset: SUCCESS (3.481s)
[130.431371] Subtest basic: SUCCESS (4.264s)
[131.340534] [095/162] (880s left) kms_prop_blob (basic)
[131.412828] Starting subtest: basic
[131.425999] Subtest basic: SUCCESS (0.000s)
[131.495061] [096/162] (880s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[131.624657] Starting subtest: basic-busy-flip-before-cursor-atomic
[131.646613] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[131.780900] [097/162] (880s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[131.902739] Starting subtest: basic-busy-flip-before-cursor-legacy
[131.925644] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[132.058054] [098/162] (879s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[132.193435] Starting subtest: basic-flip-after-cursor-atomic
[133.449830] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.255s)
[134.315782] [099/162] (877s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[134.436202] Starting subtest: basic-flip-after-cursor-legacy
[135.659345] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.221s)
[136.621860] [100/162] (875s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[136.752527] Starting subtest: basic-flip-after-cursor-varying-size
[137.955931] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.205s)
[138.849923] [101/162] (873s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[138.961823] Starting subtest: basic-flip-before-cursor-atomic
[140.225041] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.253s)
[141.083611] [102/162] (871s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[141.196815] Starting subtest: basic-flip-before-cursor-legacy
[142.409700] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.213s)
[143.299010] [103/162] (868s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[143.413187] Starting subtest: basic-flip-before-cursor-varying-size
[144.677540] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.262s)
[145.555662] [104/162] (866s left) kms_dsc (dsc-basic)
[145.653152] Starting subtest: dsc-basic
[145.721749] Subtest dsc-basic: SKIP (0.000s)
[145.829395] [105/162] (866s left) kms_flip (basic-flip-vs-dpms)
[145.934541] Starting subtest: basic-flip-vs-dpms
[145.943301] Starting dynamic subtest: A-eDP1
[148.526939] Dynamic subtest A-eDP1: SUCCESS (2.605s)
[148.540628] Starting dynamic subtest: B-eDP1
[150.783988] Dynamic subtest B-eDP1: SUCCESS (2.250s)
[150.801782] Starting dynamic subtest: C-eDP1
[153.047833] Dynamic subtest C-eDP1: SUCCESS (2.263s)
[153.066790] Starting dynamic subtest: D-eDP1
[155.312420] Dynamic subtest D-eDP1: SUCCESS (2.267s)
[155.325842] Subtest basic-flip-vs-dpms: SUCCESS (9.393s)
[156.240275] [106/162] (856s left) kms_flip (basic-flip-vs-modeset)
[156.354033] Starting subtest: basic-flip-vs-modeset
[156.360231] Starting dynamic subtest: A-eDP1
[158.909767] Dynamic subtest A-eDP1: SUCCESS (2.578s)
[158.923358] Starting dynamic subtest: B-eDP1
[161.167271] Dynamic subtest B-eDP1: SUCCESS (2.253s)
[161.180891] Starting dynamic subtest: C-eDP1
[163.427742] Dynamic subtest C-eDP1: SUCCESS (2.264s)
[163.441565] Starting dynamic subtest: D-eDP1
[165.703188] Dynamic subtest D-eDP1: SUCCESS (2.271s)
[165.710690] Subtest basic-flip-vs-modeset: SUCCESS (9.375s)
[166.623111] [107/162] (845s left) kms_flip (basic-flip-vs-wf_vblank)
[166.728190] Starting subtest: basic-flip-vs-wf_vblank
[166.734457] Starting dynamic subtest: A-eDP1
[168.703180] Dynamic subtest A-eDP1: SUCCESS (1.985s)
[168.722678] Starting dynamic subtest: B-eDP1
[170.731228] Dynamic subtest B-eDP1: SUCCESS (2.030s)
[170.750821] Starting dynamic subtest: C-eDP1
[172.756731] Dynamic subtest C-eDP1: SUCCESS (2.004s)
[172.775953] Starting dynamic subtest: D-eDP1
[174.792988] Dynamic subtest D-eDP1: SUCCESS (2.034s)
[174.806060] Subtest basic-flip-vs-wf_vblank: SUCCESS (8.062s)
[175.985506] [108/162] (836s left) kms_flip (basic-plain-flip)
[176.093995] Starting subtest: basic-plain-flip
[176.100629] Starting dynamic subtest: A-eDP1
[177.788751] Dynamic subtest A-eDP1: SUCCESS (1.710s)
[177.813865] Starting dynamic subtest: B-eDP1
[179.526355] Dynamic subtest B-eDP1: SUCCESS (1.738s)
[179.547639] Starting dynamic subtest: C-eDP1
[181.246459] Dynamic subtest C-eDP1: SUCCESS (1.713s)
[181.267603] Starting dynamic subtest: D-eDP1
[182.985265] Dynamic subtest D-eDP1: SUCCESS (1.731s)
[183.001831] Subtest basic-plain-flip: SUCCESS (6.907s)
[184.294206] [109/162] (828s left) kms_force_connector_basic (force-connector-state)
[184.383534] Starting subtest: force-connector-state
[184.979740] Subtest force-connector-state: SUCCESS (0.600s)
[186.026901] [110/162] (826s left) kms_force_connector_basic (force-edid)
[186.106008] Starting subtest: force-edid
[186.397037] Subtest force-edid: SUCCESS (0.293s)
[186.545141] [111/162] (826s left) kms_force_connector_basic (force-load-detect)
[186.638068] Starting subtest: force-load-detect
[186.661093] Subtest force-load-detect: SKIP (0.000s)
[186.760539] [112/162] (826s left) kms_force_connector_basic (prune-stale-modes)
[186.836433] Starting subtest: prune-stale-modes
[187.198207] Subtest prune-stale-modes: SUCCESS (0.365s)
[187.346644] [113/162] (825s left) kms_frontbuffer_tracking (basic)
[187.450503] Starting subtest: basic
[192.914075] Subtest basic: SUCCESS (5.471s)
[193.048700] [114/162] (820s left) kms_hdmi_inject (inject-audio)
[193.407149] Starting subtest: inject-audio
[193.682919] Subtest inject-audio: SUCCESS (0.272s)
[194.308436] [115/162] (818s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[194.389523] Starting subtest: compare-crc-sanitycheck-xr24
[194.396521] Starting dynamic subtest: pipe-A-eDP-1
[195.135026] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.740s)
[195.178052] Starting dynamic subtest: pipe-B-eDP-1
[196.476359] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.343s)
[196.524127] Starting dynamic subtest: pipe-C-eDP-1
[197.813035] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.334s)
[197.829040] Starting dynamic subtest: pipe-D-eDP-1
[199.108315] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.297s)
[199.114807] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.720s)
[199.977888] [116/162] (813s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[200.061427] Starting subtest: compare-crc-sanitycheck-nv12
[200.067759] Starting dynamic subtest: pipe-A-eDP-1
[200.949778] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.891s)
[200.967526] Starting dynamic subtest: pipe-B-eDP-1
[202.389122] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.427s)
[202.411033] Starting dynamic subtest: pipe-C-eDP-1
[203.768695] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.382s)
[203.783626] Starting dynamic subtest: pipe-D-eDP-1
[205.203406] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.420s)
[205.213122] Subtest compare-crc-sanitycheck-nv12: SUCCESS (5.131s)
[206.082429] [117/162] (807s left) kms_pipe_crc_basic (hang-read-crc)
[206.160022] Starting subtest: hang-read-crc
[206.166761] Starting dynamic subtest: pipe-A-eDP-1
[208.578352] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.413s)
[208.592125] Starting dynamic subtest: pipe-B-eDP-1
[211.776921] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.198s)
[211.791133] Starting dynamic subtest: pipe-C-eDP-1
[214.802805] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.023s)
[214.820486] Starting dynamic subtest: pipe-D-eDP-1
[217.803047] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.998s)
[217.819516] Subtest hang-read-crc: SUCCESS (11.643s)
[218.691532] [118/162] (794s left) kms_pipe_crc_basic (nonblocking-crc)
[218.794808] Starting subtest: nonblocking-crc
[218.803594] Starting dynamic subtest: pipe-A-eDP-1
[219.856450] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.061s)
[219.872558] Starting dynamic subtest: pipe-B-eDP-1
[221.498335] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.641s)
[221.514410] Starting dynamic subtest: pipe-C-eDP-1
[223.083098] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.588s)
[223.100859] Starting dynamic subtest: pipe-D-eDP-1
[224.696764] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.610s)
[224.713228] Subtest nonblocking-crc: SUCCESS (5.911s)
[225.592178] [119/162] (787s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[225.676265] Starting subtest: nonblocking-crc-frame-sequence
[225.689181] Starting dynamic subtest: pipe-A-eDP-1
[226.568019] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.882s)
[226.587502] Starting dynamic subtest: pipe-B-eDP-1
[228.154064] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.593s)
[228.171798] Starting dynamic subtest: pipe-C-eDP-1
[229.610224] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.450s)
[229.627888] Starting dynamic subtest: pipe-D-eDP-1
[231.098410] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.490s)
[231.114898] Subtest nonblocking-crc-frame-sequence: SUCCESS (5.421s)
[231.974828] [120/162] (781s left) kms_pipe_crc_basic (read-crc)
[232.074930] Starting subtest: read-crc
[232.083662] Starting dynamic subtest: pipe-A-eDP-1
[232.881415] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.811s)
[232.899119] Starting dynamic subtest: pipe-B-eDP-1
[234.398624] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.509s)
[234.413994] Starting dynamic subtest: pipe-C-eDP-1
[235.827472] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.433s)
[235.845181] Starting dynamic subtest: pipe-D-eDP-1
[237.215577] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.392s)
[237.222464] Subtest read-crc: SUCCESS (5.151s)
[238.077899] [121/162] (775s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[238.161615] Starting subtest: read-crc-frame-sequence
[238.168478] Starting dynamic subtest: pipe-A-eDP-1
[238.976625] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.810s)
[239.019168] Starting dynamic subtest: pipe-B-eDP-1
[240.481437] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.507s)
[240.509263] Starting dynamic subtest: pipe-C-eDP-1
[241.917400] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.426s)
[241.945268] Starting dynamic subtest: pipe-D-eDP-1
[243.489046] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.582s)
[243.496241] Subtest read-crc-frame-sequence: SUCCESS (5.331s)
[244.411174] [122/162] (769s left) kms_pm_backlight (basic-brightness)
[244.509224] Starting subtest: basic-brightness
[244.567508] Starting dynamic subtest: eDP-1
[244.886986] Dynamic subtest eDP-1: SUCCESS (0.328s)
[244.898923] Subtest basic-brightness: SUCCESS (0.389s)
[245.813604] [123/162] (767s left) kms_pm_rpm (basic-pci-d3-state)
[247.343492] Starting subtest: basic-pci-d3-state
[248.843497] Subtest basic-pci-d3-state: SUCCESS (1.496s)
[248.967488] [124/162] (764s left) kms_pm_rpm (basic-rte)
[249.033333] Starting subtest: basic-rte
[251.978064] Subtest basic-rte: SUCCESS (2.957s)
[253.776326] [125/162] (759s left) kms_psr (psr-primary-page-flip)
[253.859267] Starting subtest: psr-primary-page-flip
[253.865476] Starting dynamic subtest: eDP-1
[255.779962] Dynamic subtest eDP-1: SUCCESS (1.923s)
[255.786280] Subtest psr-primary-page-flip: SUCCESS (1.925s)
[256.683902] [126/162] (757s left) kms_psr (psr-cursor-plane-move)
[256.775804] Starting subtest: psr-cursor-plane-move
[256.792340] Starting dynamic subtest: eDP-1
[258.668218] Dynamic subtest eDP-1: SUCCESS (1.880s)
[258.687183] Subtest psr-cursor-plane-move: SUCCESS (1.881s)
[259.587631] [127/162] (754s left) kms_psr (psr-sprite-plane-onoff)
[259.660561] Starting subtest: psr-sprite-plane-onoff
[259.673261] Starting dynamic subtest: eDP-1
[261.569601] Dynamic subtest eDP-1: SUCCESS (1.907s)
[261.583963] Subtest psr-sprite-plane-onoff: SUCCESS (1.908s)
[262.580711] [128/162] (751s left) kms_psr (psr-primary-mmap-gtt)
[262.671648] Starting subtest: psr-primary-mmap-gtt
[262.684648] Starting dynamic subtest: eDP-1
[264.364080] Dynamic subtest eDP-1: SKIP (1.677s)
[264.377673] Subtest psr-primary-mmap-gtt: SKIP (1.678s)
[264.556690] [129/162] (749s left) kms_setmode (basic-clone-single-crtc)
[264.625149] Starting subtest: basic-clone-single-crtc
[264.646423] Subtest basic-clone-single-crtc: SKIP (0.000s)
[264.699921] [130/162] (749s left) i915_pm_rps (basic-api)
[264.756977] Starting subtest: basic-api
[264.770265] Subtest basic-api: SKIP (0.001s)
[264.838714] [131/162] (749s left) prime_self_import (basic-llseek-bad)
[264.895820] Starting subtest: basic-llseek-bad
[264.908900] Subtest basic-llseek-bad: SUCCESS (0.002s)
[265.009849] [132/162] (749s left) prime_self_import (basic-llseek-size)
[265.067944] Starting subtest: basic-llseek-size
[265.089946] Subtest basic-llseek-size: SUCCESS (0.003s)
[265.169008] [133/162] (749s left) prime_self_import (basic-with_fd_dup)
[265.225887] Starting subtest: basic-with_fd_dup
[265.239534] Subtest basic-with_fd_dup: SUCCESS (0.003s)
[265.320780] [134/162] (749s left) prime_self_import (basic-with_one_bo)
[265.371277] Starting subtest: basic-with_one_bo
[265.384730] Subtest basic-with_one_bo: SUCCESS (0.003s)
[265.511231] [135/162] (748s left) prime_self_import (basic-with_one_bo_two_files)
[265.586804] Starting subtest: basic-with_one_bo_two_files
[265.609693] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s)
[265.692971] [136/162] (748s left) prime_self_import (basic-with_two_bos)
[265.753512] Starting subtest: basic-with_two_bos
[265.766958] Subtest basic-with_two_bos: SUCCESS (0.003s)
[265.870113] [137/162] (748s left) prime_vgem (basic-fence-flip)
[265.948842] Starting subtest: basic-fence-flip
[266.386557] Subtest basic-fence-flip: SUCCESS (0.455s)
[266.515446] [138/162] (748s left) prime_vgem (basic-fence-mmap)
[266.580277] Starting subtest: basic-fence-mmap
[266.596812] Subtest basic-fence-mmap: SKIP (0.000s)
[266.698266] [139/162] (748s left) prime_vgem (basic-fence-read)
[266.777852] Starting subtest: basic-fence-read
[266.791426] Subtest basic-fence-read: SKIP (0.015s)
[266.894691] [140/162] (747s left) prime_vgem (basic-gtt)
[266.962163] Starting subtest: basic-gtt
[266.974429] Subtest basic-gtt: SKIP (0.000s)
[267.076818] [141/162] (747s left) prime_vgem (basic-read)
[267.151929] Starting subtest: basic-read
[267.171953] Subtest basic-read: SKIP (0.011s)
[267.277515] [142/162] (747s left) prime_vgem (basic-write)
[267.359815] Starting subtest: basic-write
[267.372651] Subtest basic-write: SKIP (0.010s)
[267.476601] [143/162] (747s left) vgem_basic (setversion)
[267.545453] Starting subtest: setversion
[267.558447] Subtest setversion: SUCCESS (0.000s)
[267.611596] [144/162] (747s left) vgem_basic (create)
[267.673680] Starting subtest: create
[267.681918] Subtest create: SUCCESS (0.000s)
[267.749593] [145/162] (747s left) vgem_basic (debugfs)
[267.841585] Starting subtest: debugfs
[267.847981] Subtest debugfs: SUCCESS (0.000s)
[267.929112] [146/162] (747s left) vgem_basic (dmabuf-export)
[268.004150] Starting subtest: dmabuf-export
[268.027110] Subtest dmabuf-export: SUCCESS (0.003s)
[268.108079] [147/162] (747s left) vgem_basic (dmabuf-fence)
[268.189245] Starting subtest: dmabuf-fence
[268.198075] Subtest dmabuf-fence: SUCCESS (0.000s)
[268.269554] [148/162] (746s left) vgem_basic (dmabuf-fence-before)
[268.361676] Starting subtest: dmabuf-fence-before
[268.368153] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[268.444351] [149/162] (746s left) vgem_basic (dmabuf-mmap)
[268.507828] Starting subtest: dmabuf-mmap
[268.516450] Subtest dmabuf-mmap: SUCCESS (0.018s)
[268.587609] [150/162] (746s left) vgem_basic (mmap)
[268.657049] Starting subtest: mmap
[268.663565] Subtest mmap: SUCCESS (0.011s)
[268.743681] [151/162] (746s left) vgem_basic (second-client)
[268.811561] Starting subtest: second-client
[268.834491] Subtest second-client: SUCCESS (0.033s)
[268.908450] [152/162] (746s left) vgem_basic (sysfs)
[268.983748] Starting subtest: sysfs
[269.000270] Subtest sysfs: SUCCESS (0.000s)
[269.066555] [153/162] (746s left) core_hotunplug (unbind-rebind)
[269.189687] Starting subtest: unbind-rebind
[275.507962] Subtest unbind-rebind: SUCCESS (6.321s)
[275.699032] [154/162] (740s left) vgem_basic (unload)
[275.766632] Starting subtest: unload
[304.874665] Subtest unload: SUCCESS (29.109s)
[305.608641] [155/162] (710s left) i915_module_load (reload)
[305.905710] Starting subtest: reload
[314.061149] Subtest reload: SUCCESS (8.158s)
[314.178380] [156/162] (702s left) gem_lmem_swapping (basic)
[314.320029] Subtest basic: SKIP (0.000s)
[314.478911] [157/162] (701s left) gem_lmem_swapping (parallel-random-engines)
[314.608105] Subtest parallel-random-engines: SKIP (0.000s)
[314.820284] [158/162] (701s left) gem_lmem_swapping (random-engines)
[314.964666] Subtest random-engines: SKIP (0.000s)
[315.080463] [159/162] (701s left) gem_lmem_swapping (verify-random)
[315.225564] Subtest verify-random: SKIP (0.000s)
[315.336174] [160/162] (701s left) i915_pm_rpm (module-reload)