[38.969014] Initializing watchdogs
[38.969068]   /dev/watchdog0
[38.984323] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d51 Intel Meteorlake (Gen12) 
[39.001981] [001/162] (960s left) i915_module_load (load)
[39.065795] Starting subtest: load
[41.566794] Subtest load: SUCCESS (2.507s)
[41.607887] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[41.609370] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[41.620671] [002/162] (957s left) core_auth (basic-auth)
[42.832615] Starting subtest: basic-auth
[42.846045] Subtest basic-auth: SUCCESS (0.001s)
[42.948252] [003/162] (956s left) core_debugfs (read-all-entries)
[43.018305] Starting subtest: read-all-entries
[43.138334] Subtest read-all-entries: SUCCESS (0.127s)
[43.256059] [004/162] (956s left) core_sysfs (read-all-entries)
[43.321397] Starting subtest: read-all-entries
[43.336884] Subtest read-all-entries: SUCCESS (0.004s)
[43.521303] [005/162] (956s left) fbdev (eof)
[43.587596] Starting subtest: eof
[43.595731] Subtest eof: SUCCESS (0.000s)
[43.717188] [006/162] (956s left) fbdev (info)
[43.765693] Starting subtest: info
[43.779072] Subtest info: SUCCESS (0.000s)
[43.880527] [007/162] (956s left) fbdev (nullptr)
[43.942932] Starting subtest: nullptr
[43.951762] Subtest nullptr: SUCCESS (0.000s)
[44.046419] [008/162] (955s left) fbdev (read)
[44.118453] Starting subtest: read
[45.040193] Subtest read: SUCCESS (0.907s)
[45.141305] [009/162] (954s left) fbdev (write)
[45.225863] Starting subtest: write
[45.924382] Subtest write: SUCCESS (0.696s)
[46.074351] [010/162] (954s left) gem_basic (bad-close)
[46.149279] Starting subtest: bad-close
[46.167246] Subtest bad-close: SUCCESS (0.000s)
[46.267143] [011/162] (953s left) gem_basic (create-close)
[46.350551] Starting subtest: create-close
[46.366654] Subtest create-close: SUCCESS (0.000s)
[46.488060] [012/162] (953s left) gem_basic (create-fd-close)
[46.573731] Starting subtest: create-fd-close
[46.595911] Subtest create-fd-close: SUCCESS (0.000s)
[46.717137] [013/162] (953s left) gem_busy (busy@all-engines)
[46.784600] Starting subtest: busy
[46.791336] Starting dynamic subtest: all-engines
[46.817882] Dynamic subtest all-engines: SUCCESS (0.049s)
[46.831425] Subtest busy: SUCCESS (0.049s)
[48.886427] [014/162] (951s left) gem_close_race (basic-process)
[48.984651] Starting subtest: basic-process
[49.044491] Subtest basic-process: SUCCESS (0.064s)
[49.266306] [015/162] (951s left) gem_close_race (basic-threads)
[49.364688] Starting subtest: basic-threads
[50.732959] Subtest basic-threads: SUCCESS (1.368s)
[50.969903] [016/162] (949s left) gem_ctx_create (basic)
[51.025545] Starting subtest: basic
[51.032011] Subtest basic: SUCCESS (0.000s)
[51.234767] [017/162] (949s left) gem_ctx_create (basic-files)
[51.291048] Starting subtest: basic-files
[53.299463] Subtest basic-files: SUCCESS (1.989s)
[54.928118] [018/162] (945s left) gem_ctx_exec (basic)
[55.006068] Starting subtest: basic
[55.022787] Subtest basic: SUCCESS (0.006s)
[55.177156] [019/162] (945s left) gem_exec_basic (basic)
[55.238975] Starting subtest: basic
[55.252407] Starting dynamic subtest: rcs0-smem
[55.261123] Dynamic subtest rcs0-smem: SUCCESS (0.005s)
[55.280582] Starting dynamic subtest: bcs0-smem
[55.286816] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[55.303540] Starting dynamic subtest: vcs0-smem
[55.309763] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[55.326523] Starting dynamic subtest: vcs1-smem
[55.332669] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[55.349245] Starting dynamic subtest: vecs0-smem
[55.355412] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[55.372125] Starting dynamic subtest: ccs0-smem
[55.378344] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[55.384585] Subtest basic: SUCCESS (0.014s)
[56.956932] [020/162] (943s left) gem_exec_create (basic)
[57.027933] Starting subtest: basic
[57.035070] Starting dynamic subtest: smem
[60.837773] Dynamic subtest smem: SUCCESS (3.794s)
[60.850707] Subtest basic: SUCCESS (3.794s)
[61.064254] [021/162] (939s left) gem_exec_fence (basic-busy)
[61.241371] Starting subtest: basic-busy
[61.253009] Starting dynamic subtest: rcs0
[61.326676] Dynamic subtest rcs0: SUCCESS (0.094s)
[61.343299] Starting dynamic subtest: bcs0
[61.388435] Dynamic subtest bcs0: SUCCESS (0.056s)
[61.408491] Starting dynamic subtest: vcs0
[61.443200] Dynamic subtest vcs0: SUCCESS (0.059s)
[61.458210] Starting dynamic subtest: vcs1
[61.499794] Dynamic subtest vcs1: SUCCESS (0.058s)
[61.510751] Starting dynamic subtest: vecs0
[61.559155] Dynamic subtest vecs0: SUCCESS (0.059s)
[61.569953] Starting dynamic subtest: ccs0
[61.620013] Dynamic subtest ccs0: SUCCESS (0.061s)
[61.626321] Subtest basic-busy: SUCCESS (0.388s)
[63.966849] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[63.974672] [022/162] (936s left) gem_exec_fence (basic-wait)
[64.138921] Starting subtest: basic-wait
[64.145677] Starting dynamic subtest: rcs0
[64.248942] Dynamic subtest rcs0: SUCCESS (0.111s)
[64.280305] Starting dynamic subtest: bcs0
[64.307688] Dynamic subtest bcs0: SUCCESS (0.058s)
[64.338878] Starting dynamic subtest: vcs0
[64.373700] Dynamic subtest vcs0: SUCCESS (0.066s)
[64.404457] Starting dynamic subtest: vcs1
[64.439320] Dynamic subtest vcs1: SUCCESS (0.065s)
[64.469901] Starting dynamic subtest: vecs0
[64.504345] Dynamic subtest vecs0: SUCCESS (0.065s)
[64.534757] Starting dynamic subtest: ccs0
[64.563741] Dynamic subtest ccs0: SUCCESS (0.059s)
[64.570347] Subtest basic-wait: SUCCESS (0.426s)
[65.979809] [023/162] (934s left) gem_exec_fence (basic-await)
[66.143625] Starting subtest: basic-await
[66.149808] Starting dynamic subtest: rcs0
[66.235769] Dynamic subtest rcs0: SUCCESS (0.093s)
[66.247665] Starting dynamic subtest: bcs0
[66.326304] Dynamic subtest bcs0: SUCCESS (0.090s)
[66.338138] Starting dynamic subtest: vcs0
[66.402510] Dynamic subtest vcs0: SUCCESS (0.076s)
[66.414364] Starting dynamic subtest: vcs1
[66.483247] Dynamic subtest vcs1: SUCCESS (0.080s)
[66.494864] Starting dynamic subtest: vecs0
[66.566638] Dynamic subtest vecs0: SUCCESS (0.081s)
[66.578388] Starting dynamic subtest: ccs0
[66.651965] Dynamic subtest ccs0: SUCCESS (0.082s)
[66.658730] Subtest basic-await: SUCCESS (0.504s)
[68.960115] [024/162] (932s left) gem_exec_fence (nb-await)
[69.131062] Starting subtest: nb-await
[69.144616] Starting dynamic subtest: rcs0
[69.214406] Dynamic subtest rcs0: SUCCESS (0.080s)
[69.232166] Starting dynamic subtest: bcs0
[69.268144] Dynamic subtest bcs0: SUCCESS (0.059s)
[69.287418] Starting dynamic subtest: vcs0
[69.333068] Dynamic subtest vcs0: SUCCESS (0.060s)
[69.349338] Starting dynamic subtest: vcs1
[69.391619] Dynamic subtest vcs1: SUCCESS (0.063s)
[69.411137] Starting dynamic subtest: vecs0
[69.456053] Dynamic subtest vecs0: SUCCESS (0.062s)
[69.474033] Starting dynamic subtest: ccs0
[69.517442] Dynamic subtest ccs0: SUCCESS (0.064s)
[69.530869] Subtest nb-await: SUCCESS (0.388s)
[71.039510] [025/162] (930s left) gem_exec_gttfill (basic)
[71.148333] Starting subtest: basic
[74.892360] Subtest basic: SUCCESS (3.754s)
[75.144290] [026/162] (926s left) gem_exec_parallel (engines)
[75.247792] Starting subtest: engines
[75.254014] Starting dynamic subtest: basic
[76.874115] Dynamic subtest basic: SUCCESS (1.640s)
[76.887837] Starting dynamic subtest: contexts
[81.327529] Dynamic subtest contexts: SUCCESS (4.443s)
[81.347685] Starting dynamic subtest: fds
[86.857808] Dynamic subtest fds: SUCCESS (5.527s)
[86.870219] Starting dynamic subtest: userptr
[88.865989] Dynamic subtest userptr: SUCCESS (2.007s)
[88.875532] Subtest engines: SUCCESS (13.619s)
[89.106402] [027/162] (912s left) gem_exec_store (basic)
[89.189718] Starting subtest: basic
[89.307698] Subtest basic: SUCCESS (0.147s)
[89.548928] [028/162] (911s left) gem_flink_basic (bad-flink)
[89.621279] Starting subtest: bad-flink
[89.630043] Subtest bad-flink: SUCCESS (0.000s)
[89.734344] [029/162] (911s left) gem_flink_basic (bad-open)
[89.806516] Starting subtest: bad-open
[89.815240] Subtest bad-open: SUCCESS (0.000s)
[89.919905] [030/162] (911s left) gem_flink_basic (basic)
[89.999147] Starting subtest: basic
[90.007889] Subtest basic: SUCCESS (0.000s)
[90.144544] [031/162] (911s left) gem_flink_basic (double-flink)
[90.222918] Starting subtest: double-flink
[90.231731] Subtest double-flink: SUCCESS (0.000s)
[90.367862] [032/162] (911s left) gem_flink_basic (flink-lifetime)
[90.435567] Starting subtest: flink-lifetime
[90.444467] Subtest flink-lifetime: SUCCESS (0.001s)
[90.604733] [033/162] (911s left) gem_huc_copy (huc-copy)
[90.678619] Starting subtest: huc-copy
[90.695228] Subtest huc-copy: SUCCESS (0.003s)
[90.863120] [034/162] (910s left) gem_linear_blits (basic)
[91.003788] Starting subtest: basic
[91.027018] Subtest basic: SUCCESS (0.013s)
[91.325841] [035/162] (910s left) gem_mmap (basic)
[91.446596] Subtest basic: SKIP (0.000s)
[91.513418] [036/162] (910s left) gem_mmap_gtt (basic)
[91.604343] Subtest basic: SKIP (0.000s)
[91.671567] [037/162] (910s left) gem_render_linear_blits (basic)
[91.742235] Starting subtest: basic
[91.799464] Subtest basic: SUCCESS (0.042s)
[91.892196] [038/162] (910s left) gem_render_tiled_blits (basic)
[91.983290] Subtest basic: SKIP (0.000s)
[92.056340] [039/162] (910s left) gem_ringfill (basic-all)
[97.842483] Starting subtest: basic-all
[99.015221] Subtest basic-all: SUCCESS (1.181s)
[99.193459] [040/162] (903s left) gem_softpin (allocator-basic)
[99.264776] Starting subtest: allocator-basic
[99.350377] Subtest allocator-basic: SUCCESS (0.094s)
[99.573307] [041/162] (902s left) gem_softpin (allocator-basic-reserve)
[99.642882] Starting subtest: allocator-basic-reserve
[99.726563] Subtest allocator-basic-reserve: SUCCESS (0.098s)
[99.945971] [042/162] (902s left) gem_softpin (safe-alignment)
[100.014325] Starting subtest: safe-alignment
[100.060866] Subtest safe-alignment: SUCCESS (0.051s)
[101.940996] [043/162] (900s left) gem_sync (basic-all)
[102.084767] Starting subtest: basic-all
[105.826058] Subtest basic-all: SUCCESS (3.808s)
[106.074970] [044/162] (896s left) gem_sync (basic-each)
[106.237550] Starting subtest: basic-each
[108.667096] Subtest basic-each: SUCCESS (2.507s)
[108.921154] [045/162] (893s left) gem_tiled_blits (basic)
[109.014852] Subtest basic: SKIP (0.000s)
[109.099049] [046/162] (893s left) gem_tiled_fence_blits (basic)
[109.189864] Subtest basic: SKIP (0.000s)
[109.273786] [047/162] (893s left) gem_tiled_pread_basic
[109.428148] [048/162] (893s left) gem_wait (busy@all-engines)
[109.509285] Starting subtest: busy
[109.515873] Starting dynamic subtest: all-engines
[110.816709] Dynamic subtest all-engines: SUCCESS (1.313s)
[110.832597] Subtest busy: SUCCESS (1.313s)
[111.096054] [049/162] (891s left) gem_wait (wait@all-engines)
[111.182749] Starting subtest: wait
[111.189035] Starting dynamic subtest: all-engines
[112.803170] Dynamic subtest all-engines: SUCCESS (1.624s)
[112.816388] Subtest wait: SUCCESS (1.624s)
[113.028891] [050/162] (889s left) i915_getparams_basic (basic-eu-total)
[113.116398] Starting subtest: basic-eu-total
[113.139172] Subtest basic-eu-total: SUCCESS (0.000s)
[113.215611] [051/162] (889s left) i915_getparams_basic (basic-subslice-total)
[113.288554] Starting subtest: basic-subslice-total
[113.311536] Subtest basic-subslice-total: SUCCESS (0.000s)
[113.416058] [052/162] (889s left) i915_hangman (error-state-basic)
[113.503563] Starting subtest: error-state-basic
[113.632015] Subtest error-state-basic: SUCCESS (0.134s)
[113.752884] [053/162] (889s left) i915_pciid
[113.958547] [054/162] (889s left) intel_hwmon (hwmon-read)
[114.043992] Subtest hwmon-read: SKIP (0.000s)
[114.108415] [055/162] (889s left) intel_hwmon (hwmon-write)
[114.203554] Subtest hwmon-write: SKIP (0.000s)
[114.281310] [056/162] (889s left) kms_addfb_basic (addfb25-4-tiled)
[114.395732] Starting subtest: addfb25-4-tiled
[114.401999] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[114.521372] [057/162] (888s left) kms_addfb_basic (addfb25-bad-modifier)
[114.610822] Starting subtest: addfb25-bad-modifier
[114.617426] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[114.803073] [058/162] (888s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[114.902549] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[115.067801] [059/162] (888s left) kms_addfb_basic (addfb25-modifier-no-flag)
[115.161989] Starting subtest: addfb25-modifier-no-flag
[115.178509] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[115.312268] [060/162] (888s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[115.409357] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[115.582610] [061/162] (888s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[115.698567] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[115.834937] [062/162] (887s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[115.935318] Starting subtest: addfb25-yf-tiled-legacy
[115.944049] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[116.062076] [063/162] (887s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[116.164427] Starting subtest: addfb25-y-tiled-legacy
[116.170841] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[116.300871] [064/162] (887s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[116.402247] Starting subtest: addfb25-y-tiled-small-legacy
[116.424201] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[116.571357] [065/162] (887s left) kms_addfb_basic (bad-pitch-0)
[116.658261] Starting subtest: bad-pitch-0
[116.664770] Subtest bad-pitch-0: SUCCESS (0.000s)
[116.815772] [066/162] (887s left) kms_addfb_basic (bad-pitch-1024)
[116.887652] Starting subtest: bad-pitch-1024
[116.904185] Subtest bad-pitch-1024: SUCCESS (0.000s)
[117.072704] [067/162] (887s left) kms_addfb_basic (bad-pitch-128)
[117.151451] Starting subtest: bad-pitch-128
[117.164673] Subtest bad-pitch-128: SUCCESS (0.000s)
[117.365845] [068/162] (886s left) kms_addfb_basic (bad-pitch-256)
[117.452957] Starting subtest: bad-pitch-256
[117.462815] Subtest bad-pitch-256: SUCCESS (0.000s)
[117.647135] [069/162] (886s left) kms_addfb_basic (bad-pitch-32)
[117.734459] Starting subtest: bad-pitch-32
[117.744202] Subtest bad-pitch-32: SUCCESS (0.000s)
[118.002511] [070/162] (886s left) kms_addfb_basic (bad-pitch-63)
[118.061305] Starting subtest: bad-pitch-63
[118.067653] Subtest bad-pitch-63: SUCCESS (0.000s)
[118.222543] [071/162] (886s left) kms_addfb_basic (bad-pitch-65536)
[118.275800] Starting subtest: bad-pitch-65536
[118.282562] Subtest bad-pitch-65536: SUCCESS (0.000s)
[118.450420] [072/162] (886s left) kms_addfb_basic (bad-pitch-999)
[118.504366] Starting subtest: bad-pitch-999
[118.510915] Subtest bad-pitch-999: SUCCESS (0.000s)
[118.651129] [073/162] (885s left) kms_addfb_basic (basic)
[118.707483] Starting subtest: basic
[118.713800] Subtest basic: SUCCESS (0.000s)
[118.891638] [074/162] (885s left) kms_addfb_basic (basic-x-tiled-legacy)
[118.947323] Starting subtest: basic-x-tiled-legacy
[118.961645] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[119.116529] [075/162] (885s left) kms_addfb_basic (basic-y-tiled-legacy)
[119.172349] Starting subtest: basic-y-tiled-legacy
[119.185878] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[119.337608] [076/162] (885s left) kms_addfb_basic (bo-too-small)
[119.419576] Starting subtest: bo-too-small
[119.426115] Subtest bo-too-small: SUCCESS (0.000s)
[119.603192] [077/162] (885s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[119.689088] Starting subtest: bo-too-small-due-to-tiling
[119.707169] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[119.846560] [078/162] (885s left) kms_addfb_basic (clobberred-modifier)
[119.906892] Starting subtest: clobberred-modifier
[119.925565] Subtest clobberred-modifier: SKIP (0.000s)
[120.082320] [079/162] (884s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[120.143544] Starting subtest: framebuffer-vs-set-tiling
[120.162148] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[120.313597] [080/162] (884s left) kms_addfb_basic (invalid-get-prop)
[120.374982] Starting subtest: invalid-get-prop
[120.384401] Subtest invalid-get-prop: SUCCESS (0.000s)
[120.580664] [081/162] (884s left) kms_addfb_basic (invalid-get-prop-any)
[120.644938] Starting subtest: invalid-get-prop-any
[120.651341] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[120.821956] [082/162] (884s left) kms_addfb_basic (invalid-set-prop)
[120.876555] Starting subtest: invalid-set-prop
[120.882865] Subtest invalid-set-prop: SUCCESS (0.000s)
[121.039014] [083/162] (884s left) kms_addfb_basic (invalid-set-prop-any)
[121.103186] Starting subtest: invalid-set-prop-any
[121.110337] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[121.270253] [084/162] (883s left) kms_addfb_basic (no-handle)
[121.331377] Starting subtest: no-handle
[121.337681] Subtest no-handle: SUCCESS (0.000s)
[121.514882] [085/162] (883s left) kms_addfb_basic (size-max)
[121.589477] Starting subtest: size-max
[121.595746] Subtest size-max: SUCCESS (0.000s)
[121.744380] [086/162] (883s left) kms_addfb_basic (small-bo)
[121.816577] Starting subtest: small-bo
[121.823276] Subtest small-bo: SUCCESS (0.000s)
[121.959889] [087/162] (883s left) kms_addfb_basic (tile-pitch-mismatch)
[122.019580] Starting subtest: tile-pitch-mismatch
[122.032355] Subtest tile-pitch-mismatch: SKIP (0.000s)
[122.143455] [088/162] (883s left) kms_addfb_basic (too-high)
[122.220065] Starting subtest: too-high
[122.226665] Subtest too-high: SUCCESS (0.000s)
[122.382690] [089/162] (883s left) kms_addfb_basic (too-wide)
[122.473819] Starting subtest: too-wide
[122.480173] Subtest too-wide: SUCCESS (0.000s)
[122.639299] [090/162] (882s left) kms_addfb_basic (unused-handle)
[122.720748] Starting subtest: unused-handle
[122.733604] Subtest unused-handle: SUCCESS (0.000s)
[122.890908] [091/162] (882s left) kms_addfb_basic (unused-modifier)
[122.955361] Starting subtest: unused-modifier
[122.961853] Subtest unused-modifier: SUCCESS (0.000s)
[123.154194] [092/162] (882s left) kms_addfb_basic (unused-offsets)
[123.222328] Starting subtest: unused-offsets
[123.235883] Subtest unused-offsets: SUCCESS (0.000s)
[123.415500] [093/162] (882s left) kms_addfb_basic (unused-pitches)
[123.495531] Starting subtest: unused-pitches
[123.507441] Subtest unused-pitches: SUCCESS (0.000s)
[123.646589] [094/162] (882s left) kms_busy (basic)
[123.730655] Starting subtest: basic
[123.738006] Starting dynamic subtest: flip
[124.505449] Dynamic subtest flip: SUCCESS (0.772s)
[124.518335] Starting dynamic subtest: modeset
[127.929472] Dynamic subtest modeset: SUCCESS (3.419s)
[127.945808] Subtest basic: SUCCESS (4.193s)
[128.786358] [095/162] (877s left) kms_prop_blob (basic)
[128.847457] Starting subtest: basic
[128.854620] Subtest basic: SUCCESS (0.000s)
[128.960862] [096/162] (876s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[129.084309] Starting subtest: basic-busy-flip-before-cursor-atomic
[129.106383] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[129.256824] [097/162] (876s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[129.376157] Starting subtest: basic-busy-flip-before-cursor-legacy
[129.399202] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[129.552883] [098/162] (876s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[129.675710] Starting subtest: basic-flip-after-cursor-atomic
[130.882763] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.213s)
[131.821612] [099/162] (874s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[131.932862] Starting subtest: basic-flip-after-cursor-legacy
[133.138485] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.206s)
[134.050341] [100/162] (872s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[134.165599] Starting subtest: basic-flip-after-cursor-varying-size
[135.379951] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.213s)
[136.298625] [101/162] (869s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[136.411910] Starting subtest: basic-flip-before-cursor-atomic
[137.623570] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.203s)
[138.524776] [102/162] (867s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[138.648948] Starting subtest: basic-flip-before-cursor-legacy
[139.852238] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.214s)
[140.756803] [103/162] (865s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[140.876928] Starting subtest: basic-flip-before-cursor-varying-size
[142.075146] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.205s)
[143.006933] [104/162] (863s left) kms_dsc (dsc-basic)
[143.099603] Starting subtest: dsc-basic
[143.168375] Subtest dsc-basic: SKIP (0.000s)
[143.225626] [105/162] (863s left) kms_flip (basic-flip-vs-dpms)
[143.331226] Starting subtest: basic-flip-vs-dpms
[143.340014] Starting dynamic subtest: A-eDP1
[145.944174] Dynamic subtest A-eDP1: SUCCESS (2.628s)
[145.962523] Starting dynamic subtest: B-eDP1
[148.111771] Dynamic subtest B-eDP1: SUCCESS (2.167s)
[148.129498] Starting dynamic subtest: C-eDP1
[150.274409] Dynamic subtest C-eDP1: SUCCESS (2.162s)
[150.292089] Starting dynamic subtest: D-eDP1
[152.504274] Dynamic subtest D-eDP1: SUCCESS (2.237s)
[152.516525] Subtest basic-flip-vs-dpms: SUCCESS (9.203s)
[153.405589] [106/162] (853s left) kms_flip (basic-flip-vs-modeset)
[153.509102] Starting subtest: basic-flip-vs-modeset
[153.520453] Starting dynamic subtest: A-eDP1
[156.047807] Dynamic subtest A-eDP1: SUCCESS (2.553s)
[156.065493] Starting dynamic subtest: B-eDP1
[158.214343] Dynamic subtest B-eDP1: SUCCESS (2.170s)
[158.231978] Starting dynamic subtest: C-eDP1
[160.385273] Dynamic subtest C-eDP1: SUCCESS (2.174s)
[160.397846] Starting dynamic subtest: D-eDP1
[162.545534] Dynamic subtest D-eDP1: SUCCESS (2.155s)
[162.558146] Subtest basic-flip-vs-modeset: SUCCESS (9.059s)
[163.390930] [107/162] (843s left) kms_flip (basic-flip-vs-wf_vblank)
[163.502338] Starting subtest: basic-flip-vs-wf_vblank
[163.508522] Starting dynamic subtest: A-eDP1
[165.449639] Dynamic subtest A-eDP1: SUCCESS (1.965s)
[165.471693] Starting dynamic subtest: B-eDP1
[167.372241] Dynamic subtest B-eDP1: SUCCESS (1.931s)
[167.385438] Starting dynamic subtest: C-eDP1
[169.396045] Dynamic subtest C-eDP1: SUCCESS (2.017s)
[169.409234] Starting dynamic subtest: D-eDP1
[171.343268] Dynamic subtest D-eDP1: SUCCESS (1.926s)
[171.349498] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.848s)
[172.546369] [108/162] (834s left) kms_flip (basic-plain-flip)
[172.647920] Starting subtest: basic-plain-flip
[172.656705] Starting dynamic subtest: A-eDP1
[174.309727] Dynamic subtest A-eDP1: SUCCESS (1.674s)
[174.332861] Starting dynamic subtest: B-eDP1
[176.041593] Dynamic subtest B-eDP1: SUCCESS (1.728s)
[176.065044] Starting dynamic subtest: C-eDP1
[177.764276] Dynamic subtest C-eDP1: SUCCESS (1.717s)
[177.793812] Starting dynamic subtest: D-eDP1
[179.394662] Dynamic subtest D-eDP1: SUCCESS (1.636s)
[179.401098] Subtest basic-plain-flip: SUCCESS (6.765s)
[180.732810] [109/162] (826s left) kms_force_connector_basic (force-connector-state)
[180.795249] Starting subtest: force-connector-state
[181.393228] Subtest force-connector-state: SUCCESS (0.597s)
[182.417163] [110/162] (824s left) kms_force_connector_basic (force-edid)
[182.475428] Starting subtest: force-edid
[182.764879] Subtest force-edid: SUCCESS (0.292s)
[182.962414] [111/162] (823s left) kms_force_connector_basic (force-load-detect)
[183.021065] Starting subtest: force-load-detect
[183.033370] Subtest force-load-detect: SKIP (0.000s)
[183.210214] [112/162] (823s left) kms_force_connector_basic (prune-stale-modes)
[183.279531] Starting subtest: prune-stale-modes
[183.633401] Subtest prune-stale-modes: SUCCESS (0.357s)
[183.825726] [113/162] (823s left) kms_frontbuffer_tracking (basic)
[183.909311] Starting subtest: basic
[189.292297] Subtest basic: SUCCESS (5.387s)
[189.483226] [114/162] (817s left) kms_hdmi_inject (inject-audio)
[189.818991] Starting subtest: inject-audio
[190.068769] Subtest inject-audio: SUCCESS (0.250s)
[190.767672] [115/162] (816s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[190.846723] Starting subtest: compare-crc-sanitycheck-xr24
[190.856058] Starting dynamic subtest: pipe-A-eDP-1
[191.576032] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.732s)
[191.588980] Starting dynamic subtest: pipe-B-eDP-1
[192.909594] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.322s)
[192.927219] Starting dynamic subtest: pipe-C-eDP-1
[194.237467] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.331s)
[194.255115] Starting dynamic subtest: pipe-D-eDP-1
[195.512113] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.278s)
[195.518285] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.670s)
[196.415781] [116/162] (810s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[196.489965] Starting subtest: compare-crc-sanitycheck-nv12
[196.496143] Starting dynamic subtest: pipe-A-eDP-1
[197.425159] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.919s)
[197.447082] Starting dynamic subtest: pipe-B-eDP-1
[198.891297] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.475s)
[198.905317] Starting dynamic subtest: pipe-C-eDP-1
[200.214013] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.322s)
[200.231733] Starting dynamic subtest: pipe-D-eDP-1
[201.622709] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.403s)
[201.639124] Subtest compare-crc-sanitycheck-nv12: SUCCESS (5.131s)
[202.554678] [117/162] (804s left) kms_pipe_crc_basic (hang-read-crc)
[202.627964] Starting subtest: hang-read-crc
[202.634251] Starting dynamic subtest: pipe-A-eDP-1
[204.990373] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.362s)
[205.003156] Starting dynamic subtest: pipe-B-eDP-1
[208.000045] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.004s)
[208.018174] Starting dynamic subtest: pipe-C-eDP-1
[210.936716] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.926s)
[210.955772] Starting dynamic subtest: pipe-D-eDP-1
[213.956017] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.024s)
[213.972436] Subtest hang-read-crc: SUCCESS (11.326s)
[214.851728] [118/162] (792s left) kms_pipe_crc_basic (nonblocking-crc)
[214.947752] Starting subtest: nonblocking-crc
[214.964191] Starting dynamic subtest: pipe-A-eDP-1
[215.819805] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.873s)
[215.837493] Starting dynamic subtest: pipe-B-eDP-1
[217.351981] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.531s)
[217.369767] Starting dynamic subtest: pipe-C-eDP-1
[218.826409] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.472s)
[218.844089] Starting dynamic subtest: pipe-D-eDP-1
[220.317598] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.490s)
[220.334145] Subtest nonblocking-crc: SUCCESS (5.373s)
[221.234659] [119/162] (786s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[221.325333] Starting subtest: nonblocking-crc-frame-sequence
[221.331560] Starting dynamic subtest: pipe-A-eDP-1
[222.224676] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.893s)
[222.273453] Starting dynamic subtest: pipe-B-eDP-1
[223.744680] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.525s)
[223.766093] Starting dynamic subtest: pipe-C-eDP-1
[225.206425] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.452s)
[225.228474] Starting dynamic subtest: pipe-D-eDP-1
[226.703084] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.500s)
[226.719527] Subtest nonblocking-crc-frame-sequence: SUCCESS (5.375s)
[227.669587] [120/162] (779s left) kms_pipe_crc_basic (read-crc)
[227.763995] Starting subtest: read-crc
[227.777423] Starting dynamic subtest: pipe-A-eDP-1
[228.578100] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.808s)
[228.600091] Starting dynamic subtest: pipe-B-eDP-1
[230.006312] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.426s)
[230.027201] Starting dynamic subtest: pipe-C-eDP-1
[231.443417] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.435s)
[231.464223] Starting dynamic subtest: pipe-D-eDP-1
[233.810807] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.363s)
[233.817517] Subtest read-crc: SUCCESS (6.039s)
[234.243870] [121/162] (773s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[234.322994] Starting subtest: read-crc-frame-sequence
[234.329619] Starting dynamic subtest: pipe-A-eDP-1
[235.132316] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.806s)
[235.154513] Starting dynamic subtest: pipe-B-eDP-1
[236.603094] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.470s)
[236.625388] Starting dynamic subtest: pipe-C-eDP-1
[238.122057] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.519s)
[238.142309] Starting dynamic subtest: pipe-D-eDP-1
[239.633805] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.506s)
[239.643054] Subtest read-crc-frame-sequence: SUCCESS (5.308s)
[240.565297] [122/162] (767s left) kms_pm_backlight (basic-brightness)
[240.650667] Starting subtest: basic-brightness
[240.714809] Starting dynamic subtest: eDP-1
[241.048034] Dynamic subtest eDP-1: SUCCESS (0.333s)
[241.057654] Subtest basic-brightness: SUCCESS (0.395s)
[241.956647] [123/162] (765s left) kms_pm_rpm (basic-pci-d3-state)
[243.988262] Starting subtest: basic-pci-d3-state
[245.444544] Subtest basic-pci-d3-state: SUCCESS (1.452s)
[245.577768] [124/162] (762s left) kms_pm_rpm (basic-rte)
[245.652611] Starting subtest: basic-rte
[248.565020] Subtest basic-rte: SUCCESS (2.930s)
[250.358071] [125/162] (757s left) kms_psr (psr-primary-page-flip)
[250.433780] Starting subtest: psr-primary-page-flip
[250.440072] Starting dynamic subtest: eDP-1
[252.392705] Dynamic subtest eDP-1: SUCCESS (1.958s)
[252.399141] Subtest psr-primary-page-flip: SUCCESS (1.959s)
[253.236688] [126/162] (754s left) kms_psr (psr-cursor-plane-move)
[253.311949] Starting subtest: psr-cursor-plane-move
[253.318641] Starting dynamic subtest: eDP-1
[255.172787] Dynamic subtest eDP-1: SUCCESS (1.856s)
[255.189171] Subtest psr-cursor-plane-move: SUCCESS (1.858s)
[256.032075] [127/162] (751s left) kms_psr (psr-sprite-plane-onoff)
[256.111216] Starting subtest: psr-sprite-plane-onoff
[256.120612] Starting dynamic subtest: eDP-1
[258.026044] Dynamic subtest eDP-1: SUCCESS (1.907s)
[258.034720] Subtest psr-sprite-plane-onoff: SUCCESS (1.909s)
[258.931489] [128/162] (749s left) kms_psr (psr-primary-mmap-gtt)
[259.020364] Starting subtest: psr-primary-mmap-gtt
[259.033629] Starting dynamic subtest: eDP-1
[260.605756] Dynamic subtest eDP-1: SKIP (1.559s)
[260.627866] Subtest psr-primary-mmap-gtt: SKIP (1.563s)
[260.898822] [129/162] (747s left) kms_setmode (basic-clone-single-crtc)
[260.994678] Starting subtest: basic-clone-single-crtc
[261.024107] Subtest basic-clone-single-crtc: SKIP (0.000s)
[261.134083] [130/162] (746s left) i915_pm_rps (basic-api)
[261.216094] Starting subtest: basic-api
[261.238075] Subtest basic-api: SKIP (0.001s)
[261.371992] [131/162] (746s left) prime_self_import (basic-llseek-bad)
[261.461804] Starting subtest: basic-llseek-bad
[261.484953] Subtest basic-llseek-bad: SUCCESS (0.002s)
[261.622491] [132/162] (746s left) prime_self_import (basic-llseek-size)
[261.694825] Starting subtest: basic-llseek-size
[261.718114] Subtest basic-llseek-size: SUCCESS (0.002s)
[261.868034] [133/162] (746s left) prime_self_import (basic-with_fd_dup)
[261.937989] Starting subtest: basic-with_fd_dup
[261.954103] Subtest basic-with_fd_dup: SUCCESS (0.003s)
[262.062771] [134/162] (746s left) prime_self_import (basic-with_one_bo)
[262.128957] Starting subtest: basic-with_one_bo
[262.151089] Subtest basic-with_one_bo: SUCCESS (0.002s)
[262.303677] [135/162] (746s left) prime_self_import (basic-with_one_bo_two_files)
[262.379779] Starting subtest: basic-with_one_bo_two_files
[262.399879] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s)
[262.543377] [136/162] (746s left) prime_self_import (basic-with_two_bos)
[262.613131] Starting subtest: basic-with_two_bos
[262.635106] Subtest basic-with_two_bos: SUCCESS (0.002s)
[262.765554] [137/162] (745s left) prime_vgem (basic-fence-flip)
[262.856423] Starting subtest: basic-fence-flip
[263.280118] Subtest basic-fence-flip: SUCCESS (0.445s)
[263.482400] [138/162] (745s left) prime_vgem (basic-fence-mmap)
[263.592211] Starting subtest: basic-fence-mmap
[263.615342] Subtest basic-fence-mmap: SKIP (0.000s)
[263.704293] [139/162] (745s left) prime_vgem (basic-fence-read)
[263.805684] Starting subtest: basic-fence-read
[263.827747] Subtest basic-fence-read: SKIP (0.013s)
[263.983781] [140/162] (744s left) prime_vgem (basic-gtt)
[264.097954] Starting subtest: basic-gtt
[264.121046] Subtest basic-gtt: SKIP (0.000s)
[264.238098] [141/162] (744s left) prime_vgem (basic-read)
[264.326027] Starting subtest: basic-read
[264.348079] Subtest basic-read: SKIP (0.012s)
[264.475872] [142/162] (744s left) prime_vgem (basic-write)
[264.577184] Starting subtest: basic-write
[264.599132] Subtest basic-write: SKIP (0.010s)
[264.709283] [143/162] (744s left) vgem_basic (setversion)
[264.762537] Starting subtest: setversion
[264.775324] Subtest setversion: SUCCESS (0.000s)
[264.870690] [144/162] (744s left) vgem_basic (create)
[264.932814] Starting subtest: create
[264.939459] Subtest create: SUCCESS (0.000s)
[265.029372] [145/162] (744s left) vgem_basic (debugfs)
[265.077949] Starting subtest: debugfs
[265.085107] Subtest debugfs: SUCCESS (0.000s)
[265.208106] [146/162] (744s left) vgem_basic (dmabuf-export)
[265.281273] Starting subtest: dmabuf-export
[265.294808] Subtest dmabuf-export: SUCCESS (0.003s)
[265.429090] [147/162] (743s left) vgem_basic (dmabuf-fence)
[265.493682] Starting subtest: dmabuf-fence
[265.500080] Subtest dmabuf-fence: SUCCESS (0.000s)
[265.595354] [148/162] (743s left) vgem_basic (dmabuf-fence-before)
[265.667086] Starting subtest: dmabuf-fence-before
[265.673913] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[265.759934] [149/162] (743s left) vgem_basic (dmabuf-mmap)
[265.842263] Starting subtest: dmabuf-mmap
[265.848603] Subtest dmabuf-mmap: SUCCESS (0.022s)
[265.971096] [150/162] (743s left) vgem_basic (mmap)
[266.057995] Starting subtest: mmap
[266.071272] Subtest mmap: SUCCESS (0.013s)
[266.179256] [151/162] (743s left) vgem_basic (second-client)
[266.267385] Starting subtest: second-client
[266.290359] Subtest second-client: SUCCESS (0.033s)
[266.384334] [152/162] (743s left) vgem_basic (sysfs)
[266.465396] Starting subtest: sysfs
[266.471702] Subtest sysfs: SUCCESS (0.000s)
[266.560324] [153/162] (743s left) core_hotunplug (unbind-rebind)
[266.667868] Starting subtest: unbind-rebind
[271.201036] Subtest unbind-rebind: SUCCESS (4.560s)
[271.276148] [154/162] (738s left) vgem_basic (unload)
[271.325572] Starting subtest: unload
[300.392103] Subtest unload: SUCCESS (29.059s)
[300.764749] [155/162] (709s left) i915_module_load (reload)