[41.068473] Initializing watchdogs
[41.068533]   /dev/watchdog0
[41.086438] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d51 Intel Meteorlake (Gen12) 
[41.098969] [001/162] (960s left) i915_module_load (load)
[41.171219] Starting subtest: load
[44.531056] Subtest load: SUCCESS (3.382s)
[44.588846] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[44.591812] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[44.600934] [002/162] (957s left) core_auth (basic-auth)
[45.827143] Starting subtest: basic-auth
[45.833991] Subtest basic-auth: SUCCESS (0.001s)
[45.959447] [003/162] (955s left) core_debugfs (read-all-entries)
[46.068596] Starting subtest: read-all-entries
[46.208852] Subtest read-all-entries: SUCCESS (0.162s)
[46.381486] [004/162] (955s left) core_sysfs (read-all-entries)
[46.514161] Starting subtest: read-all-entries
[46.520860] Subtest read-all-entries: SUCCESS (0.011s)
[46.654292] [005/162] (955s left) fbdev (eof)
[46.748130] Starting subtest: eof
[46.761256] Subtest eof: SUCCESS (0.000s)
[46.907881] [006/162] (955s left) fbdev (info)
[47.000163] Starting subtest: info
[47.013440] Subtest info: SUCCESS (0.000s)
[47.142284] [007/162] (955s left) fbdev (nullptr)
[47.254187] Starting subtest: nullptr
[47.267314] Subtest nullptr: SUCCESS (0.000s)
[47.485062] [008/162] (954s left) fbdev (read)
[47.596923] Starting subtest: read
[49.268152] Subtest read: SUCCESS (1.639s)
[49.413463] [009/162] (953s left) fbdev (write)
[49.520460] Starting subtest: write
[50.577015] Subtest write: SUCCESS (1.039s)
[50.721789] [010/162] (951s left) gem_basic (bad-close)
[50.824182] Starting subtest: bad-close
[50.837892] Subtest bad-close: SUCCESS (0.000s)
[51.036890] [011/162] (951s left) gem_basic (create-close)
[51.135658] Starting subtest: create-close
[51.149025] Subtest create-close: SUCCESS (0.000s)
[51.310837] [012/162] (951s left) gem_basic (create-fd-close)
[51.403845] Starting subtest: create-fd-close
[51.417251] Subtest create-fd-close: SUCCESS (0.000s)
[51.579128] [013/162] (951s left) gem_busy (busy@all-engines)
[51.676560] Starting subtest: busy
[51.683177] Starting dynamic subtest: all-engines
[51.744870] Dynamic subtest all-engines: SUCCESS (0.067s)
[51.751439] Subtest busy: SUCCESS (0.068s)
[52.969630] [014/162] (949s left) gem_close_race (basic-process)
[53.063993] Starting subtest: basic-process
[53.137912] Subtest basic-process: SUCCESS (0.082s)
[53.368265] [015/162] (949s left) gem_close_race (basic-threads)
[53.438307] Starting subtest: basic-threads
[54.678242] Subtest basic-threads: SUCCESS (1.231s)
[54.926274] [016/162] (948s left) gem_ctx_create (basic)
[55.017579] Starting subtest: basic
[55.034126] Subtest basic: SUCCESS (0.000s)
[55.256900] [017/162] (947s left) gem_ctx_create (basic-files)
[55.321743] Starting subtest: basic-files
[57.391770] Subtest basic-files: SUCCESS (2.047s)
[57.907757] [018/162] (945s left) gem_ctx_exec (basic)
[57.963968] Starting subtest: basic
[57.970190] Subtest basic: SUCCESS (0.012s)
[58.131881] [019/162] (945s left) gem_exec_basic (basic)
[58.184901] Starting subtest: basic
[58.191145] Starting dynamic subtest: rcs0-smem
[58.197403] Dynamic subtest rcs0-smem: SUCCESS (0.006s)
[58.208558] Starting dynamic subtest: bcs0-smem
[58.214808] Dynamic subtest bcs0-smem: SUCCESS (0.003s)
[58.225744] Starting dynamic subtest: vcs0-smem
[58.231983] Dynamic subtest vcs0-smem: SUCCESS (0.003s)
[58.242891] Starting dynamic subtest: vcs1-smem
[58.249120] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[58.259873] Starting dynamic subtest: vecs0-smem
[58.266010] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[58.276753] Starting dynamic subtest: ccs0-smem
[58.282942] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[58.289175] Subtest basic: SUCCESS (0.020s)
[59.868248] [020/162] (943s left) gem_exec_create (basic)
[59.920467] Starting subtest: basic
[59.929553] Starting dynamic subtest: smem
[63.847024] Dynamic subtest smem: SUCCESS (3.900s)
[63.855735] Subtest basic: SUCCESS (3.900s)
[64.067567] [021/162] (939s left) gem_exec_fence (basic-busy)
[64.248419] Starting subtest: basic-busy
[64.264959] Starting dynamic subtest: rcs0
[64.348214] Dynamic subtest rcs0: SUCCESS (0.101s)
[64.366095] Starting dynamic subtest: bcs0
[64.398124] Dynamic subtest bcs0: SUCCESS (0.059s)
[64.416482] Starting dynamic subtest: vcs0
[64.461475] Dynamic subtest vcs0: SUCCESS (0.055s)
[64.481548] Starting dynamic subtest: vcs1
[64.515956] Dynamic subtest vcs1: SUCCESS (0.059s)
[64.530581] Starting dynamic subtest: vecs0
[64.576025] Dynamic subtest vecs0: SUCCESS (0.060s)
[64.595362] Starting dynamic subtest: ccs0
[64.643020] Dynamic subtest ccs0: SUCCESS (0.067s)
[64.649194] Subtest basic-busy: SUCCESS (0.403s)
[67.076748] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[67.094763] [022/162] (936s left) gem_exec_fence (basic-wait)
[67.329101] Starting subtest: basic-wait
[67.336072] Starting dynamic subtest: rcs0
[67.624974] Dynamic subtest rcs0: SUCCESS (0.300s)
[67.642052] Starting dynamic subtest: bcs0
[67.760236] Dynamic subtest bcs0: SUCCESS (0.134s)
[67.776992] Starting dynamic subtest: vcs0
[67.873268] Dynamic subtest vcs0: SUCCESS (0.112s)
[67.890779] Starting dynamic subtest: vcs1
[68.018696] Dynamic subtest vcs1: SUCCESS (0.144s)
[68.037332] Starting dynamic subtest: vecs0
[68.149659] Dynamic subtest vecs0: SUCCESS (0.131s)
[68.166799] Starting dynamic subtest: ccs0
[68.210976] Dynamic subtest ccs0: SUCCESS (0.060s)
[68.217989] Subtest basic-wait: SUCCESS (0.884s)
[69.994727] [023/162] (933s left) gem_exec_fence (basic-await)
[70.162410] Starting subtest: basic-await
[70.169071] Starting dynamic subtest: rcs0
[70.254189] Dynamic subtest rcs0: SUCCESS (0.096s)
[70.266500] Starting dynamic subtest: bcs0
[70.340292] Dynamic subtest bcs0: SUCCESS (0.085s)
[70.352421] Starting dynamic subtest: vcs0
[70.421925] Dynamic subtest vcs0: SUCCESS (0.081s)
[70.434426] Starting dynamic subtest: vcs1
[70.499724] Dynamic subtest vcs1: SUCCESS (0.077s)
[70.511835] Starting dynamic subtest: vecs0
[70.577158] Dynamic subtest vecs0: SUCCESS (0.077s)
[70.589815] Starting dynamic subtest: ccs0
[70.659559] Dynamic subtest ccs0: SUCCESS (0.082s)
[70.666534] Subtest basic-await: SUCCESS (0.500s)
[72.951185] [024/162] (930s left) gem_exec_fence (nb-await)
[73.120774] Starting subtest: nb-await
[73.127245] Starting dynamic subtest: rcs0
[73.197548] Dynamic subtest rcs0: SUCCESS (0.080s)
[73.209555] Starting dynamic subtest: bcs0
[73.256967] Dynamic subtest bcs0: SUCCESS (0.059s)
[73.270332] Starting dynamic subtest: vcs0
[73.320608] Dynamic subtest vcs0: SUCCESS (0.062s)
[73.332666] Starting dynamic subtest: vcs1
[73.385681] Dynamic subtest vcs1: SUCCESS (0.065s)
[73.397576] Starting dynamic subtest: vecs0
[73.445613] Dynamic subtest vecs0: SUCCESS (0.061s)
[73.459758] Starting dynamic subtest: ccs0
[73.505354] Dynamic subtest ccs0: SUCCESS (0.060s)
[73.512995] Subtest nb-await: SUCCESS (0.389s)
[75.044393] [025/162] (928s left) gem_exec_gttfill (basic)
[75.129095] Starting subtest: basic
[78.694751] Subtest basic: SUCCESS (3.581s)
[78.979487] [026/162] (924s left) gem_exec_parallel (engines)
[79.085570] Starting subtest: engines
[79.098799] Starting dynamic subtest: basic
[80.900581] Dynamic subtest basic: SUCCESS (1.818s)
[80.920294] Starting dynamic subtest: contexts
[85.409444] Dynamic subtest contexts: SUCCESS (4.514s)
[85.429003] Starting dynamic subtest: fds
[90.892613] Dynamic subtest fds: SUCCESS (5.486s)
[90.916018] Starting dynamic subtest: userptr
[92.849819] Dynamic subtest userptr: SUCCESS (1.960s)
[92.863310] Subtest engines: SUCCESS (13.781s)
[93.109879] [027/162] (910s left) gem_exec_store (basic)
[93.225977] Starting subtest: basic
[93.314297] Subtest basic: SUCCESS (0.134s)
[93.647750] [028/162] (910s left) gem_flink_basic (bad-flink)
[93.734407] Starting subtest: bad-flink
[93.740928] Subtest bad-flink: SUCCESS (0.000s)
[93.868163] [029/162] (910s left) gem_flink_basic (bad-open)
[93.955791] Starting subtest: bad-open
[93.965545] Subtest bad-open: SUCCESS (0.000s)
[94.089762] [030/162] (910s left) gem_flink_basic (basic)
[94.176981] Starting subtest: basic
[94.186893] Subtest basic: SUCCESS (0.000s)
[94.331379] [031/162] (909s left) gem_flink_basic (double-flink)
[94.397675] Starting subtest: double-flink
[94.411166] Subtest double-flink: SUCCESS (0.000s)
[94.641550] [032/162] (909s left) gem_flink_basic (flink-lifetime)
[94.707336] Starting subtest: flink-lifetime
[94.720498] Subtest flink-lifetime: SUCCESS (0.001s)
[94.911821] [033/162] (909s left) gem_huc_copy (huc-copy)
[94.984196] Starting subtest: huc-copy
[95.000845] Subtest huc-copy: SUCCESS (0.004s)
[95.194232] [034/162] (909s left) gem_linear_blits (basic)
[95.369342] Starting subtest: basic
[95.392912] Subtest basic: SUCCESS (0.021s)
[95.598790] [035/162] (909s left) gem_mmap (basic)
[95.719099] Subtest basic: SKIP (0.000s)
[95.888070] [036/162] (909s left) gem_mmap_gtt (basic)
[95.978267] Subtest basic: SKIP (0.000s)
[96.045586] [037/162] (909s left) gem_render_linear_blits (basic)
[96.118218] Starting subtest: basic
[96.180180] Subtest basic: SUCCESS (0.053s)
[96.302021] [038/162] (908s left) gem_render_tiled_blits (basic)
[96.376814] Subtest basic: SKIP (0.000s)
[96.475854] [039/162] (908s left) gem_ringfill (basic-all)
[101.872006] Starting subtest: basic-all
[103.037972] Subtest basic-all: SUCCESS (1.178s)
[103.254528] [040/162] (902s left) gem_softpin (allocator-basic)
[103.344455] Starting subtest: allocator-basic
[103.417696] Subtest allocator-basic: SUCCESS (0.096s)
[103.603137] [041/162] (901s left) gem_softpin (allocator-basic-reserve)
[103.693662] Starting subtest: allocator-basic-reserve
[103.763377] Subtest allocator-basic-reserve: SUCCESS (0.092s)
[103.967584] [042/162] (901s left) gem_softpin (safe-alignment)
[104.057294] Starting subtest: safe-alignment
[104.079344] Subtest safe-alignment: SUCCESS (0.049s)
[105.908182] [043/162] (899s left) gem_sync (basic-all)
[106.043977] Starting subtest: basic-all
[109.193064] Subtest basic-all: SUCCESS (3.228s)
[109.404167] [044/162] (896s left) gem_sync (basic-each)
[109.561246] Starting subtest: basic-each
[111.923476] Subtest basic-each: SUCCESS (2.457s)
[112.167732] [045/162] (893s left) gem_tiled_blits (basic)
[112.253995] Subtest basic: SKIP (0.000s)
[112.328438] [046/162] (893s left) gem_tiled_fence_blits (basic)
[112.415597] Subtest basic: SKIP (0.000s)
[112.499114] [047/162] (893s left) gem_tiled_pread_basic
[112.652998] [048/162] (893s left) gem_wait (busy@all-engines)
[112.737586] Starting subtest: busy
[112.746663] Starting dynamic subtest: all-engines
[113.894608] Dynamic subtest all-engines: SUCCESS (1.164s)
[113.908090] Subtest busy: SUCCESS (1.164s)
[114.177651] [049/162] (891s left) gem_wait (wait@all-engines)
[114.260931] Starting subtest: wait
[114.277610] Starting dynamic subtest: all-engines
[115.811166] Dynamic subtest all-engines: SUCCESS (1.557s)
[115.824153] Subtest wait: SUCCESS (1.557s)
[116.045921] [050/162] (889s left) i915_getparams_basic (basic-eu-total)
[116.117471] Starting subtest: basic-eu-total
[116.140072] Subtest basic-eu-total: SUCCESS (0.000s)
[116.227999] [051/162] (889s left) i915_getparams_basic (basic-subslice-total)
[116.306050] Starting subtest: basic-subslice-total
[116.328121] Subtest basic-subslice-total: SUCCESS (0.000s)
[116.406077] [052/162] (889s left) i915_hangman (error-state-basic)
[116.489966] Starting subtest: error-state-basic
[116.613525] Subtest error-state-basic: SUCCESS (0.133s)
[116.732098] [053/162] (889s left) i915_pciid
[116.907400] [054/162] (889s left) intel_hwmon (hwmon-read)
[116.995551] Subtest hwmon-read: SKIP (0.000s)
[117.064854] [055/162] (889s left) intel_hwmon (hwmon-write)
[117.137485] Subtest hwmon-write: SKIP (0.000s)
[117.215882] [056/162] (889s left) kms_addfb_basic (addfb25-4-tiled)
[117.329465] Starting subtest: addfb25-4-tiled
[117.339216] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[117.514052] [057/162] (888s left) kms_addfb_basic (addfb25-bad-modifier)
[117.611066] Starting subtest: addfb25-bad-modifier
[117.624439] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[117.896073] [058/162] (888s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[118.005087] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[118.266429] [059/162] (888s left) kms_addfb_basic (addfb25-modifier-no-flag)
[118.363844] Starting subtest: addfb25-modifier-no-flag
[118.377368] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[118.600020] [060/162] (888s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[118.700288] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[118.835625] [061/162] (888s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[118.947084] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[119.079522] [062/162] (887s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[119.170552] Starting subtest: addfb25-yf-tiled-legacy
[119.179381] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[119.323862] [063/162] (887s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[119.434984] Starting subtest: addfb25-y-tiled-legacy
[119.441167] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[119.580373] [064/162] (887s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[119.686607] Starting subtest: addfb25-y-tiled-small-legacy
[119.708646] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[119.855820] [065/162] (887s left) kms_addfb_basic (bad-pitch-0)
[119.932625] Starting subtest: bad-pitch-0
[119.941562] Subtest bad-pitch-0: SUCCESS (0.000s)
[120.135050] [066/162] (887s left) kms_addfb_basic (bad-pitch-1024)
[120.200462] Starting subtest: bad-pitch-1024
[120.207920] Subtest bad-pitch-1024: SUCCESS (0.000s)
[120.375900] [067/162] (886s left) kms_addfb_basic (bad-pitch-128)
[120.437959] Starting subtest: bad-pitch-128
[120.446732] Subtest bad-pitch-128: SUCCESS (0.000s)
[120.618952] [068/162] (886s left) kms_addfb_basic (bad-pitch-256)
[120.682081] Starting subtest: bad-pitch-256
[120.690700] Subtest bad-pitch-256: SUCCESS (0.000s)
[120.845400] [069/162] (886s left) kms_addfb_basic (bad-pitch-32)
[120.917080] Starting subtest: bad-pitch-32
[120.924469] Subtest bad-pitch-32: SUCCESS (0.000s)
[121.086239] [070/162] (886s left) kms_addfb_basic (bad-pitch-63)
[121.151377] Starting subtest: bad-pitch-63
[121.164272] Subtest bad-pitch-63: SUCCESS (0.000s)
[121.334853] [071/162] (886s left) kms_addfb_basic (bad-pitch-65536)
[121.407094] Starting subtest: bad-pitch-65536
[121.423620] Subtest bad-pitch-65536: SUCCESS (0.000s)
[121.593170] [072/162] (886s left) kms_addfb_basic (bad-pitch-999)
[121.663809] Starting subtest: bad-pitch-999
[121.680286] Subtest bad-pitch-999: SUCCESS (0.000s)
[121.825902] [073/162] (885s left) kms_addfb_basic (basic)
[121.897143] Starting subtest: basic
[121.904236] Subtest basic: SUCCESS (0.000s)
[122.067999] [074/162] (885s left) kms_addfb_basic (basic-x-tiled-legacy)
[122.156045] Starting subtest: basic-x-tiled-legacy
[122.173931] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[122.324471] [075/162] (885s left) kms_addfb_basic (basic-y-tiled-legacy)
[122.394680] Starting subtest: basic-y-tiled-legacy
[122.416580] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[122.573145] [076/162] (885s left) kms_addfb_basic (bo-too-small)
[122.667287] Starting subtest: bo-too-small
[122.683793] Subtest bo-too-small: SUCCESS (0.000s)
[122.810543] [077/162] (885s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[122.907411] Starting subtest: bo-too-small-due-to-tiling
[122.929532] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[123.040691] [078/162] (884s left) kms_addfb_basic (clobberred-modifier)
[123.128789] Starting subtest: clobberred-modifier
[123.151445] Subtest clobberred-modifier: SKIP (0.000s)
[123.284412] [079/162] (884s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[123.355792] Starting subtest: framebuffer-vs-set-tiling
[123.378397] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[123.556390] [080/162] (884s left) kms_addfb_basic (invalid-get-prop)
[123.628392] Starting subtest: invalid-get-prop
[123.639404] Subtest invalid-get-prop: SUCCESS (0.000s)
[123.819913] [081/162] (884s left) kms_addfb_basic (invalid-get-prop-any)
[123.890245] Starting subtest: invalid-get-prop-any
[123.900543] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[124.070366] [082/162] (884s left) kms_addfb_basic (invalid-set-prop)
[124.149880] Starting subtest: invalid-set-prop
[124.156123] Subtest invalid-set-prop: SUCCESS (0.000s)
[124.324541] [083/162] (883s left) kms_addfb_basic (invalid-set-prop-any)
[124.382056] Starting subtest: invalid-set-prop-any
[124.388956] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[124.660865] [084/162] (883s left) kms_addfb_basic (no-handle)
[124.740123] Starting subtest: no-handle
[124.748802] Subtest no-handle: SUCCESS (0.000s)
[124.897423] [085/162] (883s left) kms_addfb_basic (size-max)
[124.992857] Starting subtest: size-max
[125.009468] Subtest size-max: SUCCESS (0.000s)
[125.164456] [086/162] (883s left) kms_addfb_basic (small-bo)
[125.259147] Starting subtest: small-bo
[125.275768] Subtest small-bo: SUCCESS (0.000s)
[125.434547] [087/162] (883s left) kms_addfb_basic (tile-pitch-mismatch)
[125.507836] Starting subtest: tile-pitch-mismatch
[125.530817] Subtest tile-pitch-mismatch: SKIP (0.000s)
[125.696843] [088/162] (882s left) kms_addfb_basic (too-high)
[125.789460] Starting subtest: too-high
[125.802718] Subtest too-high: SUCCESS (0.000s)
[125.959433] [089/162] (882s left) kms_addfb_basic (too-wide)
[126.052160] Starting subtest: too-wide
[126.062170] Subtest too-wide: SUCCESS (0.000s)
[126.209493] [090/162] (882s left) kms_addfb_basic (unused-handle)
[126.296885] Starting subtest: unused-handle
[126.306662] Subtest unused-handle: SUCCESS (0.000s)
[126.503368] [091/162] (882s left) kms_addfb_basic (unused-modifier)
[126.596605] Starting subtest: unused-modifier
[126.613093] Subtest unused-modifier: SUCCESS (0.000s)
[126.768569] [092/162] (882s left) kms_addfb_basic (unused-offsets)
[126.857326] Starting subtest: unused-offsets
[126.863947] Subtest unused-offsets: SUCCESS (0.000s)
[127.055085] [093/162] (881s left) kms_addfb_basic (unused-pitches)
[127.137197] Starting subtest: unused-pitches
[127.146084] Subtest unused-pitches: SUCCESS (0.000s)
[127.319691] [094/162] (881s left) kms_busy (basic)
[127.413090] Starting subtest: basic
[127.426360] Starting dynamic subtest: flip
[128.283952] Dynamic subtest flip: SUCCESS (0.873s)
[128.303509] Starting dynamic subtest: modeset
[131.821767] Dynamic subtest modeset: SUCCESS (3.539s)
[131.835241] Subtest basic: SUCCESS (4.413s)
[132.774919] [095/162] (876s left) kms_prop_blob (basic)
[132.857699] Starting subtest: basic
[132.866546] Subtest basic: SUCCESS (0.000s)
[132.935746] [096/162] (876s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[133.059612] Starting subtest: basic-busy-flip-before-cursor-atomic
[133.082606] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[133.249480] [097/162] (876s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[133.364040] Starting subtest: basic-busy-flip-before-cursor-legacy
[133.386034] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[133.547936] [098/162] (875s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[133.667138] Starting subtest: basic-flip-after-cursor-atomic
[134.876705] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.214s)
[135.785787] [099/162] (873s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[135.909718] Starting subtest: basic-flip-after-cursor-legacy
[137.114659] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.213s)
[138.038354] [100/162] (871s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[138.171004] Starting subtest: basic-flip-after-cursor-varying-size
[139.372139] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.213s)
[140.272032] [101/162] (869s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[140.398863] Starting subtest: basic-flip-before-cursor-atomic
[141.601097] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.212s)
[142.530826] [102/162] (867s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[142.661878] Starting subtest: basic-flip-before-cursor-legacy
[143.865836] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.205s)
[144.764072] [103/162] (864s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[144.880942] Starting subtest: basic-flip-before-cursor-varying-size
[146.094533] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.213s)
[146.980510] [104/162] (862s left) kms_dsc (dsc-basic)
[147.069265] Starting subtest: dsc-basic
[147.123386] Subtest dsc-basic: SKIP (0.001s)
[147.197837] [105/162] (862s left) kms_flip (basic-flip-vs-dpms)
[147.294687] Starting subtest: basic-flip-vs-dpms
[147.302601] Starting dynamic subtest: A-eDP1
[149.826746] Dynamic subtest A-eDP1: SUCCESS (2.546s)
[149.844599] Starting dynamic subtest: B-eDP1
[151.989840] Dynamic subtest B-eDP1: SUCCESS (2.150s)
[152.007572] Starting dynamic subtest: C-eDP1
[154.163726] Dynamic subtest C-eDP1: SUCCESS (2.170s)
[154.181440] Starting dynamic subtest: D-eDP1
[156.330717] Dynamic subtest D-eDP1: SUCCESS (2.171s)
[156.347094] Subtest basic-flip-vs-dpms: SUCCESS (9.045s)
[157.181855] [106/162] (852s left) kms_flip (basic-flip-vs-modeset)
[157.293572] Starting subtest: basic-flip-vs-modeset
[157.299688] Starting dynamic subtest: A-eDP1
[159.816958] Dynamic subtest A-eDP1: SUCCESS (2.543s)
[159.830147] Starting dynamic subtest: B-eDP1
[161.994405] Dynamic subtest B-eDP1: SUCCESS (2.169s)
[162.014697] Starting dynamic subtest: C-eDP1
[164.160241] Dynamic subtest C-eDP1: SUCCESS (2.163s)
[164.180647] Starting dynamic subtest: D-eDP1
[166.322546] Dynamic subtest D-eDP1: SUCCESS (2.170s)
[166.328922] Subtest basic-flip-vs-modeset: SUCCESS (9.053s)
[167.202398] [107/162] (842s left) kms_flip (basic-flip-vs-wf_vblank)
[167.284094] Starting subtest: basic-flip-vs-wf_vblank
[167.290306] Starting dynamic subtest: A-eDP1
[169.336612] Dynamic subtest A-eDP1: SUCCESS (2.053s)
[169.358244] Starting dynamic subtest: B-eDP1
[171.384935] Dynamic subtest B-eDP1: SUCCESS (2.034s)
[171.414482] Starting dynamic subtest: C-eDP1
[173.403570] Dynamic subtest C-eDP1: SUCCESS (2.013s)
[173.429066] Starting dynamic subtest: D-eDP1
[175.451531] Dynamic subtest D-eDP1: SUCCESS (2.044s)
[175.464799] Subtest basic-flip-vs-wf_vblank: SUCCESS (8.156s)
[176.792372] [108/162] (833s left) kms_flip (basic-plain-flip)
[176.901768] Starting subtest: basic-plain-flip
[176.908091] Starting dynamic subtest: A-eDP1
[178.635795] Dynamic subtest A-eDP1: SUCCESS (1.755s)
[178.649241] Starting dynamic subtest: B-eDP1
[180.377798] Dynamic subtest B-eDP1: SUCCESS (1.736s)
[180.421461] Starting dynamic subtest: C-eDP1
[182.098827] Dynamic subtest C-eDP1: SUCCESS (1.714s)
[182.128705] Starting dynamic subtest: D-eDP1
[183.734340] Dynamic subtest D-eDP1: SUCCESS (1.629s)
[183.747819] Subtest basic-plain-flip: SUCCESS (6.842s)
[184.946851] [109/162] (825s left) kms_force_connector_basic (force-connector-state)
[185.033538] Starting subtest: force-connector-state
[185.658679] Subtest force-connector-state: SUCCESS (0.636s)
[186.726788] [110/162] (823s left) kms_force_connector_basic (force-edid)
[186.792505] Starting subtest: force-edid
[187.077135] Subtest force-edid: SUCCESS (0.288s)
[187.261965] [111/162] (823s left) kms_force_connector_basic (force-load-detect)
[187.322665] Starting subtest: force-load-detect
[187.335280] Subtest force-load-detect: SKIP (0.000s)
[187.466172] [112/162] (822s left) kms_force_connector_basic (prune-stale-modes)
[187.530196] Starting subtest: prune-stale-modes
[187.888536] Subtest prune-stale-modes: SUCCESS (0.358s)
[188.155052] [113/162] (822s left) kms_frontbuffer_tracking (basic)
[188.252642] Starting subtest: basic
[193.588018] Subtest basic: SUCCESS (5.335s)
[193.771687] [114/162] (816s left) kms_hdmi_inject (inject-audio)
[194.142371] Starting subtest: inject-audio
[194.394184] Subtest inject-audio: SUCCESS (0.252s)
[195.018900] [115/162] (815s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[195.101185] Starting subtest: compare-crc-sanitycheck-xr24
[195.117706] Starting dynamic subtest: pipe-A-eDP-1
[195.844466] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.741s)
[195.858029] Starting dynamic subtest: pipe-B-eDP-1
[197.231683] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.387s)
[197.244594] Starting dynamic subtest: pipe-C-eDP-1
[198.570747] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.333s)
[198.588581] Starting dynamic subtest: pipe-D-eDP-1
[199.870922] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.297s)
[199.887665] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.766s)
[200.775668] [116/162] (809s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[200.873975] Starting subtest: compare-crc-sanitycheck-nv12
[200.890559] Starting dynamic subtest: pipe-A-eDP-1
[201.786395] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.923s)
[201.804107] Starting dynamic subtest: pipe-B-eDP-1
[203.228424] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.439s)
[203.246089] Starting dynamic subtest: pipe-C-eDP-1
[204.553037] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.323s)
[204.566331] Starting dynamic subtest: pipe-D-eDP-1
[205.942379] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.384s)
[205.958970] Subtest compare-crc-sanitycheck-nv12: SUCCESS (5.081s)
[206.869500] [117/162] (803s left) kms_pipe_crc_basic (hang-read-crc)
[206.960033] Starting subtest: hang-read-crc
[206.966579] Starting dynamic subtest: pipe-A-eDP-1
[209.334152] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.368s)
[209.356085] Starting dynamic subtest: pipe-B-eDP-1
[212.430820] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.104s)
[212.448582] Starting dynamic subtest: pipe-C-eDP-1
[215.361164] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.926s)
[215.378935] Starting dynamic subtest: pipe-D-eDP-1
[218.352280] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.989s)
[218.368789] Subtest hang-read-crc: SUCCESS (11.397s)
[219.289429] [118/162] (791s left) kms_pipe_crc_basic (nonblocking-crc)
[219.377192] Starting subtest: nonblocking-crc
[219.390660] Starting dynamic subtest: pipe-A-eDP-1
[220.253704] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.879s)
[220.266952] Starting dynamic subtest: pipe-B-eDP-1
[221.789259] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.528s)
[221.802645] Starting dynamic subtest: pipe-C-eDP-1
[223.241853] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.451s)
[223.255110] Starting dynamic subtest: pipe-D-eDP-1
[224.731540] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.489s)
[224.738726] Subtest nonblocking-crc: SUCCESS (5.354s)
[225.674095] [119/162] (785s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[225.751753] Starting subtest: nonblocking-crc-frame-sequence
[225.760657] Starting dynamic subtest: pipe-A-eDP-1
[226.634482] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.876s)
[226.652625] Starting dynamic subtest: pipe-B-eDP-1
[228.189629] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.550s)
[228.208420] Starting dynamic subtest: pipe-C-eDP-1
[229.754352] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.557s)
[229.776563] Starting dynamic subtest: pipe-D-eDP-1
[231.334795] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.591s)
[231.351376] Subtest nonblocking-crc-frame-sequence: SUCCESS (5.581s)
[232.272920] [120/162] (778s left) kms_pipe_crc_basic (read-crc)
[232.349266] Starting subtest: read-crc
[232.355568] Starting dynamic subtest: pipe-A-eDP-1
[233.163973] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.812s)
[233.181661] Starting dynamic subtest: pipe-B-eDP-1
[234.633797] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.457s)
[234.651528] Starting dynamic subtest: pipe-C-eDP-1
[235.967952] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.346s)
[235.981220] Starting dynamic subtest: pipe-D-eDP-1
[237.359319] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.386s)
[237.365390] Subtest read-crc: SUCCESS (5.008s)
[238.286401] [121/162] (772s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[238.378766] Starting subtest: read-crc-frame-sequence
[238.391021] Starting dynamic subtest: pipe-A-eDP-1
[239.186007] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.811s)
[239.203696] Starting dynamic subtest: pipe-B-eDP-1
[240.638800] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.453s)
[240.656374] Starting dynamic subtest: pipe-C-eDP-1
[242.068263] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.427s)
[242.085981] Starting dynamic subtest: pipe-D-eDP-1
[243.512878] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.444s)
[243.520245] Subtest read-crc-frame-sequence: SUCCESS (5.141s)
[244.371798] [122/162] (766s left) kms_pm_backlight (basic-brightness)
[244.470075] Starting subtest: basic-brightness
[244.530695] Starting dynamic subtest: eDP-1
[244.856809] Dynamic subtest eDP-1: SUCCESS (0.333s)
[244.873394] Subtest basic-brightness: SUCCESS (0.398s)
[245.773019] [123/162] (765s left) kms_pm_rpm (basic-pci-d3-state)
[248.014332] Starting subtest: basic-pci-d3-state
[249.484206] Subtest basic-pci-d3-state: SUCCESS (1.476s)
[249.635356] [124/162] (761s left) kms_pm_rpm (basic-rte)
[249.688678] Starting subtest: basic-rte
[252.613106] Subtest basic-rte: SUCCESS (2.930s)
[254.429956] [125/162] (756s left) kms_psr (psr-primary-page-flip)
[254.527645] Starting subtest: psr-primary-page-flip
[254.544118] Starting dynamic subtest: eDP-1
[256.432366] Dynamic subtest eDP-1: SUCCESS (1.911s)
[256.441308] Subtest psr-primary-page-flip: SUCCESS (1.912s)
[257.258834] [126/162] (753s left) kms_psr (psr-cursor-plane-move)
[257.338402] Starting subtest: psr-cursor-plane-move
[257.346911] Starting dynamic subtest: eDP-1
[259.214817] Dynamic subtest eDP-1: SUCCESS (1.873s)
[259.231158] Subtest psr-cursor-plane-move: SUCCESS (1.875s)
[260.062411] [127/162] (751s left) kms_psr (psr-sprite-plane-onoff)
[260.149360] Starting subtest: psr-sprite-plane-onoff
[260.166013] Starting dynamic subtest: eDP-1
[262.067398] Dynamic subtest eDP-1: SUCCESS (1.928s)
[262.073509] Subtest psr-sprite-plane-onoff: SUCCESS (1.930s)
[262.950829] [128/162] (748s left) kms_psr (psr-primary-mmap-gtt)
[263.030503] Starting subtest: psr-primary-mmap-gtt
[263.036766] Starting dynamic subtest: eDP-1
[264.732243] Dynamic subtest eDP-1: SKIP (1.676s)
[264.754314] Subtest psr-primary-mmap-gtt: SKIP (1.679s)
[264.983088] [129/162] (746s left) kms_setmode (basic-clone-single-crtc)
[265.062316] Starting subtest: basic-clone-single-crtc
[265.092948] Subtest basic-clone-single-crtc: SKIP (0.000s)
[265.162167] [130/162] (746s left) i915_pm_rps (basic-api)
[265.236918] Starting subtest: basic-api
[265.259455] Subtest basic-api: SKIP (0.001s)
[265.340523] [131/162] (746s left) prime_self_import (basic-llseek-bad)
[265.411725] Starting subtest: basic-llseek-bad
[265.434454] Subtest basic-llseek-bad: SUCCESS (0.002s)
[265.559290] [132/162] (746s left) prime_self_import (basic-llseek-size)
[265.618621] Starting subtest: basic-llseek-size
[265.637306] Subtest basic-llseek-size: SUCCESS (0.002s)
[265.776423] [133/162] (745s left) prime_self_import (basic-with_fd_dup)
[265.834124] Starting subtest: basic-with_fd_dup
[265.852127] Subtest basic-with_fd_dup: SUCCESS (0.003s)
[265.998067] [134/162] (745s left) prime_self_import (basic-with_one_bo)
[266.065233] Starting subtest: basic-with_one_bo
[266.084413] Subtest basic-with_one_bo: SUCCESS (0.002s)
[266.194159] [135/162] (745s left) prime_self_import (basic-with_one_bo_two_files)
[266.251206] Starting subtest: basic-with_one_bo_two_files
[266.269225] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s)
[266.420037] [136/162] (745s left) prime_self_import (basic-with_two_bos)
[266.487419] Starting subtest: basic-with_two_bos
[266.506626] Subtest basic-with_two_bos: SUCCESS (0.002s)
[266.653962] [137/162] (745s left) prime_vgem (basic-fence-flip)
[266.731584] Starting subtest: basic-fence-flip
[267.155447] Subtest basic-fence-flip: SUCCESS (0.444s)
[267.319251] [138/162] (744s left) prime_vgem (basic-fence-mmap)
[267.394707] Starting subtest: basic-fence-mmap
[267.414286] Subtest basic-fence-mmap: SKIP (0.000s)
[267.541498] [139/162] (744s left) prime_vgem (basic-fence-read)
[267.632463] Starting subtest: basic-fence-read
[267.654428] Subtest basic-fence-read: SKIP (0.013s)
[267.786512] [140/162] (744s left) prime_vgem (basic-gtt)
[267.880840] Starting subtest: basic-gtt
[267.903526] Subtest basic-gtt: SKIP (0.000s)
[268.018888] [141/162] (744s left) prime_vgem (basic-read)
[268.113159] Starting subtest: basic-read
[268.135873] Subtest basic-read: SKIP (0.011s)
[268.263327] [142/162] (743s left) prime_vgem (basic-write)
[268.358966] Starting subtest: basic-write
[268.381836] Subtest basic-write: SKIP (0.011s)
[268.507409] [143/162] (743s left) vgem_basic (setversion)
[268.593431] Starting subtest: setversion
[268.616010] Subtest setversion: SUCCESS (0.000s)
[268.687550] [144/162] (743s left) vgem_basic (create)
[268.770279] Starting subtest: create
[268.779117] Subtest create: SUCCESS (0.000s)
[268.873321] [145/162] (743s left) vgem_basic (debugfs)
[268.961624] Starting subtest: debugfs
[268.967844] Subtest debugfs: SUCCESS (0.000s)
[269.052411] [146/162] (743s left) vgem_basic (dmabuf-export)
[269.140939] Starting subtest: dmabuf-export
[269.163905] Subtest dmabuf-export: SUCCESS (0.019s)
[269.301804] [147/162] (743s left) vgem_basic (dmabuf-fence)
[269.390388] Starting subtest: dmabuf-fence
[269.396625] Subtest dmabuf-fence: SUCCESS (0.000s)
[269.485935] [148/162] (743s left) vgem_basic (dmabuf-fence-before)
[269.574389] Starting subtest: dmabuf-fence-before
[269.580626] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[269.652763] [149/162] (742s left) vgem_basic (dmabuf-mmap)
[269.741295] Starting subtest: dmabuf-mmap
[269.751900] Subtest dmabuf-mmap: SUCCESS (0.020s)
[269.850999] [150/162] (742s left) vgem_basic (mmap)
[269.939608] Starting subtest: mmap
[269.945789] Subtest mmap: SUCCESS (0.012s)
[270.045867] [151/162] (742s left) vgem_basic (second-client)
[270.119201] Starting subtest: second-client
[270.158600] Subtest second-client: SUCCESS (0.033s)
[270.263966] [152/162] (742s left) vgem_basic (sysfs)
[270.337064] Starting subtest: sysfs
[270.353757] Subtest sysfs: SUCCESS (0.000s)
[270.440606] [153/162] (742s left) core_hotunplug (unbind-rebind)
[270.547295] Starting subtest: unbind-rebind
[276.944939] Subtest unbind-rebind: SUCCESS (6.408s)
[277.133335] [154/162] (735s left) vgem_basic (unload)
[277.251155] Starting subtest: unload
[306.406453] Subtest unload: SUCCESS (29.166s)
[306.932424] [155/162] (706s left) i915_module_load (reload)
[307.139417] Starting subtest: reload
[314.359627] Subtest reload: SUCCESS (7.225s)
[314.496647] [156/162] (698s left) gem_lmem_swapping (basic)
[314.610841] Subtest basic: SKIP (0.000s)
[314.732838] [157/162] (698s left) gem_lmem_swapping (parallel-random-engines)
[314.873597] Subtest parallel-random-engines: SKIP (0.000s)
[314.992262] [158/162] (698s left) gem_lmem_swapping (random-engines)
[315.134211] Subtest random-engines: SKIP (0.000s)
[315.265040] [159/162] (698s left) gem_lmem_swapping (verify-random)
[315.401340] Subtest verify-random: SKIP (0.000s)
[315.534666] [160/162] (698s left) i915_pm_rpm (module-reload)