[65.926451] Initializing watchdogs
[65.926684]   /dev/watchdog0
[65.963206] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[65.982087] [001/162] (960s left) i915_module_load (load)
[66.093129] Starting subtest: load
[69.006021] Subtest load: SUCCESS (2.912s)
[69.092813] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[69.097573] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[69.108720] [002/162] (957s left) core_auth (basic-auth)
[69.314280] Starting subtest: basic-auth
[69.316454] Subtest basic-auth: SUCCESS (0.005s)
[69.497923] [003/162] (957s left) core_debugfs (read-all-entries)
[69.659693] Starting subtest: read-all-entries
[69.739991] Subtest read-all-entries: SUCCESS (0.081s)
[69.970095] [004/162] (956s left) core_sysfs (read-all-entries)
[70.141731] Starting subtest: read-all-entries
[70.148365] Subtest read-all-entries: SUCCESS (0.007s)
[70.339562] [005/162] (956s left) fbdev (eof)
[70.494322] Starting subtest: eof
[70.498585] Subtest eof: SUCCESS (0.001s)
[70.668178] [006/162] (956s left) fbdev (info)
[70.809361] Starting subtest: info
[70.810525] Subtest info: SUCCESS (0.000s)
[70.957652] [007/162] (956s left) fbdev (nullptr)
[71.089614] Starting subtest: nullptr
[71.090746] Subtest nullptr: SUCCESS (0.000s)
[71.233172] [008/162] (956s left) fbdev (read)
[71.339279] Starting subtest: read
[72.865047] Subtest read: SUCCESS (1.522s)
[72.983412] [009/162] (954s left) fbdev (write)
[73.090237] Starting subtest: write
[73.882521] Subtest write: SUCCESS (0.791s)
[74.040819] [010/162] (953s left) gem_basic (bad-close)
[74.138325] Starting subtest: bad-close
[74.140916] Subtest bad-close: SUCCESS (0.000s)
[74.307196] [011/162] (953s left) gem_basic (create-close)
[74.406176] Starting subtest: create-close
[74.408392] Subtest create-close: SUCCESS (0.000s)
[74.566468] [012/162] (953s left) gem_basic (create-fd-close)
[74.665103] Starting subtest: create-fd-close
[74.668774] Subtest create-fd-close: SUCCESS (0.000s)
[74.818966] [013/162] (952s left) gem_busy (busy@all-engines)
[74.950444] Starting subtest: busy
[74.952922] Starting dynamic subtest: all-engines
[75.028692] Dynamic subtest all-engines: SUCCESS (0.075s)
[75.029964] Subtest busy: SUCCESS (0.076s)
[75.449927] [014/162] (952s left) gem_close_race (basic-process)
[75.578176] Starting subtest: basic-process
[75.645783] Subtest basic-process: SUCCESS (0.068s)
[75.918918] [015/162] (951s left) gem_close_race (basic-threads)
[76.043422] Starting subtest: basic-threads
[77.256504] Subtest basic-threads: SUCCESS (1.213s)
[77.540454] [016/162] (950s left) gem_ctx_create (basic)
[77.661180] Starting subtest: basic
[77.662376] Subtest basic: SUCCESS (0.000s)
[77.939876] [017/162] (950s left) gem_ctx_create (basic-files)
[78.106313] Starting subtest: basic-files
[80.139775] Subtest basic-files: SUCCESS (2.035s)
[80.404273] [018/162] (947s left) gem_ctx_exec (basic)
[80.507078] Starting subtest: basic
[80.512122] Subtest basic: SUCCESS (0.006s)
[80.703292] [019/162] (947s left) gem_exec_basic (basic)
[80.811272] Starting subtest: basic
[80.812376] Starting dynamic subtest: rcs0-smem
[80.818267] Dynamic subtest rcs0-smem: SUCCESS (0.004s)
[80.834164] Starting dynamic subtest: bcs0-smem
[80.835329] Dynamic subtest bcs0-smem: SUCCESS (0.004s)
[80.851313] Starting dynamic subtest: vcs0-smem
[80.852627] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[80.868724] Starting dynamic subtest: vecs0-smem
[80.870285] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[80.871696] Subtest basic: SUCCESS (0.017s)
[81.126397] [020/162] (947s left) gem_exec_create (basic)
[81.243226] Starting subtest: basic
[81.244287] Starting dynamic subtest: smem
[83.294074] Dynamic subtest smem: SUCCESS (2.049s)
[83.295275] Subtest basic: SUCCESS (2.050s)
[83.569533] [021/162] (944s left) gem_exec_fence (basic-busy)
[83.817928] Starting subtest: basic-busy
[83.819094] Starting dynamic subtest: rcs0
[83.842990] Dynamic subtest rcs0: SUCCESS (0.025s)
[83.861112] Starting dynamic subtest: bcs0
[83.877023] Dynamic subtest bcs0: SUCCESS (0.028s)
[83.892950] Starting dynamic subtest: vcs0
[83.906275] Dynamic subtest vcs0: SUCCESS (0.029s)
[83.924912] Starting dynamic subtest: vecs0
[83.928189] Dynamic subtest vecs0: SUCCESS (0.018s)
[83.929348] Subtest basic-busy: SUCCESS (0.108s)
[84.680021] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[84.685455] [022/162] (943s left) gem_exec_fence (basic-wait)
[84.935129] Starting subtest: basic-wait
[84.936297] Starting dynamic subtest: rcs0
[84.953788] Dynamic subtest rcs0: SUCCESS (0.016s)
[84.970385] Starting dynamic subtest: bcs0
[84.971570] Dynamic subtest bcs0: SUCCESS (0.021s)
[84.987568] Starting dynamic subtest: vcs0
[85.001032] Dynamic subtest vcs0: SUCCESS (0.025s)
[85.017399] Starting dynamic subtest: vecs0
[85.022378] Dynamic subtest vecs0: SUCCESS (0.020s)
[85.023431] Subtest basic-wait: SUCCESS (0.086s)
[85.714973] [023/162] (942s left) gem_exec_fence (basic-await)
[85.964819] Starting subtest: basic-await
[85.966639] Starting dynamic subtest: rcs0
[86.083237] Dynamic subtest rcs0: SUCCESS (0.116s)
[86.102044] Starting dynamic subtest: bcs0
[86.200423] Dynamic subtest bcs0: SUCCESS (0.115s)
[86.217795] Starting dynamic subtest: vcs0
[86.308938] Dynamic subtest vcs0: SUCCESS (0.109s)
[86.328147] Starting dynamic subtest: vecs0
[86.421434] Dynamic subtest vecs0: SUCCESS (0.111s)
[86.422553] Subtest basic-await: SUCCESS (0.458s)
[87.136924] [024/162] (941s left) gem_exec_fence (nb-await)
[87.386187] Starting subtest: nb-await
[87.387354] Starting dynamic subtest: rcs0
[87.459495] Dynamic subtest rcs0: SUCCESS (0.072s)
[87.475930] Starting dynamic subtest: bcs0
[87.532567] Dynamic subtest bcs0: SUCCESS (0.071s)
[87.548882] Starting dynamic subtest: vcs0
[87.600835] Dynamic subtest vcs0: SUCCESS (0.066s)
[87.617189] Starting dynamic subtest: vecs0
[87.673290] Dynamic subtest vecs0: SUCCESS (0.071s)
[87.674404] Subtest nb-await: SUCCESS (0.289s)
[88.398975] [025/162] (940s left) gem_exec_gttfill (basic)
[88.526290] Starting subtest: basic
[98.717875] Subtest basic: SUCCESS (10.193s)
[99.032533] [026/162] (929s left) gem_exec_parallel (engines)
[99.308492] Starting subtest: engines
[99.310873] Starting dynamic subtest: basic
[102.647536] Dynamic subtest basic: SUCCESS (3.336s)
[102.665291] Starting dynamic subtest: contexts
[113.895997] Dynamic subtest contexts: SUCCESS (11.249s)
[113.914329] Starting dynamic subtest: fds
[118.908445] Dynamic subtest fds: SUCCESS (5.013s)
[118.928893] Starting dynamic subtest: userptr
[122.445049] Dynamic subtest userptr: SUCCESS (3.535s)
[122.446934] Subtest engines: SUCCESS (23.137s)
[122.754273] [027/162] (906s left) gem_exec_store (basic)
[122.895638] Starting subtest: basic
[122.950869] Subtest basic: SUCCESS (0.057s)
[123.228463] [028/162] (905s left) gem_flink_basic (bad-flink)
[123.329353] Starting subtest: bad-flink
[123.331244] Subtest bad-flink: SUCCESS (0.000s)
[123.498481] [029/162] (905s left) gem_flink_basic (bad-open)
[123.595225] Starting subtest: bad-open
[123.596323] Subtest bad-open: SUCCESS (0.000s)
[123.760630] [030/162] (905s left) gem_flink_basic (basic)
[123.857278] Starting subtest: basic
[123.858376] Subtest basic: SUCCESS (0.001s)
[124.028113] [031/162] (905s left) gem_flink_basic (double-flink)
[124.125755] Starting subtest: double-flink
[124.127423] Subtest double-flink: SUCCESS (0.000s)
[124.277334] [032/162] (905s left) gem_flink_basic (flink-lifetime)
[124.375236] Starting subtest: flink-lifetime
[124.376982] Subtest flink-lifetime: SUCCESS (0.003s)
[124.546436] [033/162] (904s left) gem_huc_copy (huc-copy)
[124.658694] Starting subtest: huc-copy
[124.662197] Subtest huc-copy: SKIP (0.000s)
[124.844992] [034/162] (904s left) gem_linear_blits (basic)
[125.076243] Starting subtest: basic
[125.088337] Subtest basic: SUCCESS (0.017s)
[125.299290] [035/162] (904s left) gem_mmap (basic)
[125.560371] Starting subtest: basic
[125.566577] Subtest basic: SUCCESS (0.003s)
[125.759887] [036/162] (904s left) gem_mmap_gtt (basic)
[125.858377] Starting subtest: basic
[125.859888] Subtest basic: SUCCESS (0.002s)
[126.019932] [037/162] (903s left) gem_render_linear_blits (basic)
[126.125180] Starting subtest: basic
[126.193371] Subtest basic: SUCCESS (0.067s)
[126.301477] [038/162] (903s left) gem_render_tiled_blits (basic)
[126.404088] Starting subtest: basic
[126.499294] Subtest basic: SUCCESS (0.094s)
[126.608098] [039/162] (903s left) gem_ringfill (basic-all)
[126.964821] Starting subtest: basic-all
[128.172494] Subtest basic-all: SUCCESS (1.205s)
[128.349762] [040/162] (901s left) gem_softpin (allocator-basic)
[128.454460] Starting subtest: allocator-basic
[128.681094] Subtest allocator-basic: SUCCESS (0.220s)
[128.864518] [041/162] (901s left) gem_softpin (allocator-basic-reserve)
[128.969088] Starting subtest: allocator-basic-reserve
[129.199648] Subtest allocator-basic-reserve: SUCCESS (0.220s)
[129.395361] [042/162] (900s left) gem_softpin (safe-alignment)
[129.507063] Starting subtest: safe-alignment
[129.533694] Subtest safe-alignment: SUCCESS (0.024s)
[129.713587] [043/162] (900s left) gem_sync (basic-all)
[129.832389] Starting subtest: basic-all
[132.104655] Subtest basic-all: SUCCESS (2.272s)
[132.405756] [044/162] (898s left) gem_sync (basic-each)
[132.526453] Starting subtest: basic-each
[135.056117] Subtest basic-each: SUCCESS (2.530s)
[135.349641] [045/162] (895s left) gem_tiled_blits (basic)
[135.543168] Starting subtest: basic
[135.583494] Subtest basic: SUCCESS (0.040s)
[135.785796] [046/162] (894s left) gem_tiled_fence_blits (basic)
[136.153458] Starting subtest: basic
[136.187435] Subtest basic: SUCCESS (0.034s)
[136.401193] [047/162] (894s left) gem_tiled_pread_basic
[137.029692] [048/162] (893s left) gem_wait (busy@all-engines)
[137.167874] Starting subtest: busy
[137.169890] Starting dynamic subtest: all-engines
[137.694976] Dynamic subtest all-engines: SUCCESS (0.526s)
[137.696138] Subtest busy: SUCCESS (0.528s)
[137.996586] [049/162] (893s left) gem_wait (wait@all-engines)
[138.123557] Starting subtest: wait
[138.124790] Starting dynamic subtest: all-engines
[139.159076] Dynamic subtest all-engines: SUCCESS (1.036s)
[139.161140] Subtest wait: SUCCESS (1.037s)
[139.469720] [050/162] (891s left) i915_getparams_basic (basic-eu-total)
[139.565421] Starting subtest: basic-eu-total
[139.567793] Subtest basic-eu-total: SUCCESS (0.000s)
[139.708989] [051/162] (891s left) i915_getparams_basic (basic-subslice-total)
[139.807902] Starting subtest: basic-subslice-total
[139.810195] Subtest basic-subslice-total: SUCCESS (0.000s)
[139.981390] [052/162] (891s left) i915_hangman (error-state-basic)
[140.107359] Starting subtest: error-state-basic
[140.118997] Subtest error-state-basic: SUCCESS (0.013s)
[140.301925] [053/162] (891s left) i915_pciid
[140.551033] [054/162] (890s left) intel_hwmon (hwmon-read)
[140.649910] Subtest hwmon-read: SKIP (0.000s)
[140.752514] [055/162] (890s left) intel_hwmon (hwmon-write)
[140.850112] Subtest hwmon-write: SKIP (0.000s)
[140.951326] [056/162] (890s left) kms_addfb_basic (addfb25-4-tiled)
[141.128522] Starting subtest: addfb25-4-tiled
[141.130762] Subtest addfb25-4-tiled: SUCCESS (0.001s)
[141.312177] [057/162] (890s left) kms_addfb_basic (addfb25-bad-modifier)
[141.470875] Starting subtest: addfb25-bad-modifier
[141.473247] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[141.645253] [058/162] (890s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[141.802329] Starting subtest: addfb25-framebuffer-vs-set-tiling
[141.803470] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[141.959052] [059/162] (890s left) kms_addfb_basic (addfb25-modifier-no-flag)
[142.125370] Starting subtest: addfb25-modifier-no-flag
[142.126448] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[142.312454] [060/162] (889s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[142.473269] Starting subtest: addfb25-x-tiled-legacy
[142.474420] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[142.664345] [061/162] (889s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[142.826128] Starting subtest: addfb25-x-tiled-mismatch-legacy
[142.827324] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[143.013796] [062/162] (889s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[143.179837] Starting subtest: addfb25-yf-tiled-legacy
[143.181346] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.001s)
[143.363994] [063/162] (888s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[143.528278] Starting subtest: addfb25-y-tiled-legacy
[143.529452] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[143.712966] [064/162] (888s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[143.879952] Starting subtest: addfb25-y-tiled-small-legacy
[143.881224] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s)
[144.044873] [065/162] (888s left) kms_addfb_basic (bad-pitch-0)
[144.142165] Starting subtest: bad-pitch-0
[144.143324] Subtest bad-pitch-0: SUCCESS (0.000s)
[144.378248] [066/162] (888s left) kms_addfb_basic (bad-pitch-1024)
[144.473601] Starting subtest: bad-pitch-1024
[144.474820] Subtest bad-pitch-1024: SUCCESS (0.000s)
[144.729023] [067/162] (887s left) kms_addfb_basic (bad-pitch-128)
[144.829394] Starting subtest: bad-pitch-128
[144.830539] Subtest bad-pitch-128: SUCCESS (0.000s)
[145.059814] [068/162] (887s left) kms_addfb_basic (bad-pitch-256)
[145.160954] Starting subtest: bad-pitch-256
[145.162190] Subtest bad-pitch-256: SUCCESS (0.000s)
[145.393403] [069/162] (887s left) kms_addfb_basic (bad-pitch-32)
[145.489823] Starting subtest: bad-pitch-32
[145.492083] Subtest bad-pitch-32: SUCCESS (0.000s)
[145.710224] [070/162] (887s left) kms_addfb_basic (bad-pitch-63)
[145.811209] Starting subtest: bad-pitch-63
[145.812207] Subtest bad-pitch-63: SUCCESS (0.000s)
[146.045567] [071/162] (887s left) kms_addfb_basic (bad-pitch-65536)
[146.143206] Starting subtest: bad-pitch-65536
[146.144391] Subtest bad-pitch-65536: SUCCESS (0.001s)
[146.397331] [072/162] (886s left) kms_addfb_basic (bad-pitch-999)
[146.493304] Starting subtest: bad-pitch-999
[146.494432] Subtest bad-pitch-999: SUCCESS (0.000s)
[146.710933] [073/162] (886s left) kms_addfb_basic (basic)
[146.807284] Starting subtest: basic
[146.808363] Subtest basic: SUCCESS (0.000s)
[147.043657] [074/162] (886s left) kms_addfb_basic (basic-x-tiled-legacy)
[147.146869] Starting subtest: basic-x-tiled-legacy
[147.148816] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[147.360508] [075/162] (886s left) kms_addfb_basic (basic-y-tiled-legacy)
[147.459974] Starting subtest: basic-y-tiled-legacy
[147.461092] Subtest basic-y-tiled-legacy: SUCCESS (0.001s)
[147.694968] [076/162] (885s left) kms_addfb_basic (bo-too-small)
[147.878649] Starting subtest: bo-too-small
[147.881053] Subtest bo-too-small: SUCCESS (0.001s)
[148.095524] [077/162] (885s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[148.255518] Starting subtest: bo-too-small-due-to-tiling
[148.256746] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[148.462547] [078/162] (885s left) kms_addfb_basic (clobberred-modifier)
[148.558098] Starting subtest: clobberred-modifier
[148.559870] Subtest clobberred-modifier: SUCCESS (0.000s)
[148.775902] [079/162] (885s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[148.873450] Starting subtest: framebuffer-vs-set-tiling
[148.874600] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[149.113943] [080/162] (884s left) kms_addfb_basic (invalid-get-prop)
[149.211142] Starting subtest: invalid-get-prop
[149.212331] Subtest invalid-get-prop: SUCCESS (0.000s)
[149.426494] [081/162] (884s left) kms_addfb_basic (invalid-get-prop-any)
[149.523901] Starting subtest: invalid-get-prop-any
[149.524956] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[149.763077] [082/162] (884s left) kms_addfb_basic (invalid-set-prop)
[149.860068] Starting subtest: invalid-set-prop
[149.861985] Subtest invalid-set-prop: SUCCESS (0.000s)
[150.093992] [083/162] (884s left) kms_addfb_basic (invalid-set-prop-any)
[150.193398] Starting subtest: invalid-set-prop-any
[150.194516] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[150.411952] [084/162] (883s left) kms_addfb_basic (no-handle)
[150.509315] Starting subtest: no-handle
[150.510378] Subtest no-handle: SUCCESS (0.000s)
[150.744521] [085/162] (883s left) kms_addfb_basic (size-max)
[150.908435] Starting subtest: size-max
[150.909577] Subtest size-max: SUCCESS (0.001s)
[151.093921] [086/162] (883s left) kms_addfb_basic (small-bo)
[151.251575] Starting subtest: small-bo
[151.252665] Subtest small-bo: SUCCESS (0.000s)
[151.411375] [087/162] (883s left) kms_addfb_basic (tile-pitch-mismatch)
[151.509477] Starting subtest: tile-pitch-mismatch
[151.510714] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[151.726984] [088/162] (882s left) kms_addfb_basic (too-high)
[151.889442] Starting subtest: too-high
[151.890555] Subtest too-high: SUCCESS (0.002s)
[152.064884] [089/162] (882s left) kms_addfb_basic (too-wide)
[152.225179] Starting subtest: too-wide
[152.226224] Subtest too-wide: SUCCESS (0.000s)
[152.394414] [090/162] (882s left) kms_addfb_basic (unused-handle)
[152.490278] Starting subtest: unused-handle
[152.491845] Subtest unused-handle: SUCCESS (0.000s)
[152.728118] [091/162] (882s left) kms_addfb_basic (unused-modifier)
[152.825448] Starting subtest: unused-modifier
[152.826718] Subtest unused-modifier: SUCCESS (0.000s)
[153.083651] [092/162] (881s left) kms_addfb_basic (unused-offsets)
[153.181408] Starting subtest: unused-offsets
[153.182471] Subtest unused-offsets: SUCCESS (0.000s)
[153.392868] [093/162] (881s left) kms_addfb_basic (unused-pitches)
[153.486651] Starting subtest: unused-pitches
[153.487926] Subtest unused-pitches: SUCCESS (0.000s)
[153.734815] [094/162] (881s left) kms_busy (basic)
[153.897910] Starting subtest: basic
[153.906017] Starting dynamic subtest: flip
[154.677909] Dynamic subtest flip: SUCCESS (0.772s)
[154.721930] Starting dynamic subtest: modeset
[155.899408] Dynamic subtest modeset: SUCCESS (1.219s)
[155.900440] Subtest basic: SUCCESS (1.998s)
[156.206366] [095/162] (879s left) kms_prop_blob (basic)
[156.307235] Starting subtest: basic
[156.309911] Subtest basic: SUCCESS (0.000s)
[156.479130] [096/162] (878s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[156.645281] Starting subtest: basic-busy-flip-before-cursor-atomic
[156.648069] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[156.805044] [097/162] (878s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[156.968963] Starting subtest: basic-busy-flip-before-cursor-legacy
[156.971529] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[157.140845] [098/162] (878s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[157.299769] Starting subtest: basic-flip-after-cursor-atomic
[158.471302] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.172s)
[158.709993] [099/162] (877s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[158.868755] Starting subtest: basic-flip-after-cursor-legacy
[160.001685] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.135s)
[160.247961] [100/162] (875s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[160.405370] Starting subtest: basic-flip-after-cursor-varying-size
[161.545479] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.137s)
[161.807431] [101/162] (874s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[161.969860] Starting subtest: basic-flip-before-cursor-atomic
[163.130379] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.156s)
[163.370759] [102/162] (872s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[163.531110] Starting subtest: basic-flip-before-cursor-legacy
[164.661288] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.132s)
[164.919706] [103/162] (871s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[165.076178] Starting subtest: basic-flip-before-cursor-varying-size
[166.247348] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.171s)
[166.540967] [104/162] (869s left) kms_dsc (dsc-basic)
[166.702366] Subtest dsc-basic: SKIP (0.000s)
[166.813322] [105/162] (869s left) kms_flip (basic-flip-vs-dpms)
[166.975108] Starting subtest: basic-flip-vs-dpms
[166.980011] Starting dynamic subtest: A-HDMI-A2
[168.197560] Dynamic subtest A-HDMI-A2: SUCCESS (1.214s)
[168.231913] Starting dynamic subtest: B-HDMI-A2
[169.148255] Dynamic subtest B-HDMI-A2: SUCCESS (0.949s)
[169.168750] Starting dynamic subtest: C-HDMI-A2
[170.093993] Dynamic subtest C-HDMI-A2: SUCCESS (0.944s)
[170.095177] Subtest basic-flip-vs-dpms: SUCCESS (3.118s)
[170.385846] [106/162] (866s left) kms_flip (basic-flip-vs-modeset)
[170.548596] Starting subtest: basic-flip-vs-modeset
[170.549801] Starting dynamic subtest: A-HDMI-A2
[171.803812] Dynamic subtest A-HDMI-A2: SUCCESS (1.257s)
[171.827072] Starting dynamic subtest: B-HDMI-A2
[172.795216] Dynamic subtest B-HDMI-A2: SUCCESS (0.982s)
[172.821886] Starting dynamic subtest: C-HDMI-A2
[173.777946] Dynamic subtest C-HDMI-A2: SUCCESS (0.978s)
[173.779914] Subtest basic-flip-vs-modeset: SUCCESS (3.234s)
[174.040488] [107/162] (862s left) kms_flip (basic-flip-vs-wf_vblank)
[174.194940] Starting subtest: basic-flip-vs-wf_vblank
[174.203779] Starting dynamic subtest: A-HDMI-A2
[175.599919] Dynamic subtest A-HDMI-A2: SUCCESS (1.398s)
[175.621660] Starting dynamic subtest: B-HDMI-A2
[176.932087] Dynamic subtest B-HDMI-A2: SUCCESS (1.328s)
[176.952014] Starting dynamic subtest: C-HDMI-A2
[178.267608] Dynamic subtest C-HDMI-A2: SUCCESS (1.333s)
[178.268967] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.074s)
[178.707272] [108/162] (857s left) kms_flip (basic-plain-flip)
[178.871352] Starting subtest: basic-plain-flip
[178.876246] Starting dynamic subtest: A-HDMI-A2
[179.991090] Dynamic subtest A-HDMI-A2: SUCCESS (1.112s)
[180.012434] Starting dynamic subtest: B-HDMI-A2
[181.040782] Dynamic subtest B-HDMI-A2: SUCCESS (1.046s)
[181.061095] Starting dynamic subtest: C-HDMI-A2
[182.076480] Dynamic subtest C-HDMI-A2: SUCCESS (1.032s)
[182.078887] Subtest basic-plain-flip: SUCCESS (3.207s)
[182.512975] [109/162] (854s left) kms_force_connector_basic (force-connector-state)
[182.707200] Starting subtest: force-connector-state
[183.148773] Subtest force-connector-state: SUCCESS (0.440s)
[183.636561] [110/162] (853s left) kms_force_connector_basic (force-edid)
[183.827078] Starting subtest: force-edid
[183.885984] Subtest force-edid: SUCCESS (0.060s)
[184.217318] [111/162] (852s left) kms_force_connector_basic (force-load-detect)
[184.405661] Starting subtest: force-load-detect
[184.410947] Subtest force-load-detect: SKIP (0.000s)
[184.681750] [112/162] (852s left) kms_force_connector_basic (prune-stale-modes)
[184.873890] Starting subtest: prune-stale-modes
[184.945790] Subtest prune-stale-modes: SUCCESS (0.070s)
[185.315656] [113/162] (851s left) kms_frontbuffer_tracking (basic)
[185.511743] Starting subtest: basic
[188.693577] Subtest basic: SUCCESS (3.179s)
[188.883061] [114/162] (848s left) kms_hdmi_inject (inject-audio)
[189.192073] Starting subtest: inject-audio
[189.387175] Subtest inject-audio: SUCCESS (0.195s)
[189.826772] [115/162] (847s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[190.003264] Starting subtest: compare-crc-sanitycheck-xr24
[190.004308] Starting dynamic subtest: pipe-A-HDMI-A-2
[190.594703] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.589s)
[190.617490] Starting dynamic subtest: pipe-B-HDMI-A-2
[191.169235] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.567s)
[191.211332] Starting dynamic subtest: pipe-C-HDMI-A-2
[191.719577] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.546s)
[191.720867] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.719s)
[191.979747] [116/162] (845s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[192.145812] Starting subtest: compare-crc-sanitycheck-nv12
[192.149133] Starting dynamic subtest: pipe-A-HDMI-A-2
[192.848511] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.696s)
[192.901892] Starting dynamic subtest: pipe-B-HDMI-A-2
[193.577191] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.692s)
[193.602299] Starting dynamic subtest: pipe-C-HDMI-A-2
[194.249213] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.662s)
[194.252732] Subtest compare-crc-sanitycheck-nv12: SUCCESS (2.105s)
[194.502163] [117/162] (842s left) kms_pipe_crc_basic (hang-read-crc)
[194.658303] Starting subtest: hang-read-crc
[194.669062] Starting dynamic subtest: pipe-A-HDMI-A-2
[196.016399] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.353s)
[196.060020] Starting dynamic subtest: pipe-B-HDMI-A-2
[197.330316] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.306s)
[197.354927] Starting dynamic subtest: pipe-C-HDMI-A-2
[198.649999] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.311s)
[198.651834] Subtest hang-read-crc: SUCCESS (3.990s)
[198.898701] [118/162] (838s left) kms_pipe_crc_basic (nonblocking-crc)
[199.059270] Starting subtest: nonblocking-crc
[199.060314] Starting dynamic subtest: pipe-A-HDMI-A-2
[199.789196] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.727s)
[199.817869] Starting dynamic subtest: pipe-B-HDMI-A-2
[200.524287] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.725s)
[200.570920] Starting dynamic subtest: pipe-C-HDMI-A-2
[201.240415] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.708s)
[201.242297] Subtest nonblocking-crc: SUCCESS (2.181s)
[201.491398] [119/162] (836s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[201.663741] Starting subtest: nonblocking-crc-frame-sequence
[201.666613] Starting dynamic subtest: pipe-A-HDMI-A-2
[202.415140] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.751s)
[202.464319] Starting dynamic subtest: pipe-B-HDMI-A-2
[203.127457] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.701s)
[203.152301] Starting dynamic subtest: pipe-C-HDMI-A-2
[203.832254] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.697s)
[203.833928] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.175s)
[204.096563] [120/162] (833s left) kms_pipe_crc_basic (read-crc)
[204.260443] Starting subtest: read-crc
[204.262881] Starting dynamic subtest: pipe-A-HDMI-A-2
[204.943890] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.678s)
[204.990468] Starting dynamic subtest: pipe-B-HDMI-A-2
[205.592465] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.641s)
[205.639204] Starting dynamic subtest: pipe-C-HDMI-A-2
[206.233530] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.635s)
[206.235544] Subtest read-crc: SUCCESS (1.977s)
[206.509493] [121/162] (831s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[206.672289] Starting subtest: read-crc-frame-sequence
[206.680290] Starting dynamic subtest: pipe-A-HDMI-A-2
[207.381871] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.701s)
[207.448219] Starting dynamic subtest: pipe-B-HDMI-A-2
[208.049558] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.656s)
[208.097826] Starting dynamic subtest: pipe-C-HDMI-A-2
[208.696088] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.641s)
[208.697809] Subtest read-crc-frame-sequence: SUCCESS (2.022s)
[208.944809] [122/162] (829s left) kms_pm_backlight (basic-brightness)
[209.110217] Subtest basic-brightness: SKIP (0.000s)
[209.218807] [123/162] (828s left) kms_pm_rpm (basic-pci-d3-state)
[210.887213] Starting subtest: basic-pci-d3-state
[211.257595] Subtest basic-pci-d3-state: SUCCESS (0.353s)
[211.474924] [124/162] (826s left) kms_pm_rpm (basic-rte)
[211.570147] Starting subtest: basic-rte
[213.470813] Subtest basic-rte: SUCCESS (1.887s)
[214.214099] [125/162] (824s left) kms_psr (psr-primary-page-flip)
[214.383466] Subtest psr-primary-page-flip: SKIP (0.000s)
[214.508738] [126/162] (823s left) kms_psr (psr-cursor-plane-move)
[214.682213] Subtest psr-cursor-plane-move: SKIP (0.000s)
[214.791747] [127/162] (823s left) kms_psr (psr-sprite-plane-onoff)
[214.963245] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[215.073630] [128/162] (823s left) kms_psr (psr-primary-mmap-gtt)
[215.249147] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[215.358784] [129/162] (823s left) kms_setmode (basic-clone-single-crtc)
[215.467113] Starting subtest: basic-clone-single-crtc
[215.471737] Subtest basic-clone-single-crtc: SKIP (0.000s)
[215.617111] [130/162] (823s left) i915_pm_rps (basic-api)
[215.733452] Starting subtest: basic-api
[215.742275] Subtest basic-api: SUCCESS (0.010s)
[215.904182] [131/162] (822s left) prime_self_import (basic-llseek-bad)
[216.003152] Starting subtest: basic-llseek-bad
[216.006337] Subtest basic-llseek-bad: SUCCESS (0.005s)
[216.202722] [132/162] (822s left) prime_self_import (basic-llseek-size)
[216.297712] Starting subtest: basic-llseek-size
[216.304553] Subtest basic-llseek-size: SUCCESS (0.009s)
[216.486712] [133/162] (822s left) prime_self_import (basic-with_fd_dup)
[216.579377] Starting subtest: basic-with_fd_dup
[216.593360] Subtest basic-with_fd_dup: SUCCESS (0.012s)
[216.767817] [134/162] (822s left) prime_self_import (basic-with_one_bo)
[216.865834] Starting subtest: basic-with_one_bo
[216.873163] Subtest basic-with_one_bo: SUCCESS (0.007s)
[217.057902] [135/162] (822s left) prime_self_import (basic-with_one_bo_two_files)
[217.152340] Starting subtest: basic-with_one_bo_two_files
[217.154584] Subtest basic-with_one_bo_two_files: SUCCESS (0.005s)
[217.331746] [136/162] (821s left) prime_self_import (basic-with_two_bos)
[217.430485] Starting subtest: basic-with_two_bos
[217.433810] Subtest basic-with_two_bos: SUCCESS (0.007s)
[217.601731] [137/162] (821s left) prime_vgem (basic-fence-flip)
[217.727043] Starting subtest: basic-fence-flip
[218.194524] Subtest basic-fence-flip: SUCCESS (0.463s)
[218.387082] [138/162] (821s left) prime_vgem (basic-fence-mmap)
[218.513319] Starting subtest: basic-fence-mmap
[218.564388] Subtest basic-fence-mmap: SUCCESS (0.054s)
[218.736659] [139/162] (820s left) prime_vgem (basic-fence-read)
[218.862546] Starting subtest: basic-fence-read
[218.986089] Subtest basic-fence-read: SUCCESS (0.122s)
[219.151178] [140/162] (820s left) prime_vgem (basic-gtt)
[219.275846] Starting subtest: basic-gtt
[219.305883] Subtest basic-gtt: SUCCESS (0.029s)
[219.485885] [141/162] (820s left) prime_vgem (basic-read)
[219.609579] Starting subtest: basic-read
[219.676656] Subtest basic-read: SUCCESS (0.063s)
[219.832634] [142/162] (820s left) prime_vgem (basic-write)
[219.963816] Starting subtest: basic-write
[220.049385] Subtest basic-write: SUCCESS (0.084s)
[220.236859] [143/162] (819s left) vgem_basic (setversion)
[220.347864] Starting subtest: setversion
[220.350253] Subtest setversion: SUCCESS (0.000s)
[220.486096] [144/162] (819s left) vgem_basic (create)
[220.594303] Starting subtest: create
[220.595919] Subtest create: SUCCESS (0.001s)
[220.753917] [145/162] (819s left) vgem_basic (debugfs)
[220.860647] Starting subtest: debugfs
[220.861764] Subtest debugfs: SUCCESS (0.001s)
[221.020363] [146/162] (819s left) vgem_basic (dmabuf-export)
[221.132111] Starting subtest: dmabuf-export
[221.136747] Subtest dmabuf-export: SUCCESS (0.006s)
[221.307715] [147/162] (819s left) vgem_basic (dmabuf-fence)
[221.415274] Starting subtest: dmabuf-fence
[221.416454] Subtest dmabuf-fence: SUCCESS (0.001s)
[221.568939] [148/162] (818s left) vgem_basic (dmabuf-fence-before)
[221.683815] Starting subtest: dmabuf-fence-before
[221.684970] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[221.823901] [149/162] (818s left) vgem_basic (dmabuf-mmap)
[221.926943] Starting subtest: dmabuf-mmap
[221.955249] Subtest dmabuf-mmap: SUCCESS (0.029s)
[222.117696] [150/162] (818s left) vgem_basic (mmap)
[222.231454] Starting subtest: mmap
[222.245050] Subtest mmap: SUCCESS (0.018s)
[222.402135] [151/162] (818s left) vgem_basic (second-client)
[222.514272] Starting subtest: second-client
[222.545074] Subtest second-client: SUCCESS (0.031s)
[222.684946] [152/162] (818s left) vgem_basic (sysfs)
[222.796056] Starting subtest: sysfs
[222.797287] Subtest sysfs: SUCCESS (0.002s)
[222.942319] [153/162] (818s left) core_hotunplug (unbind-rebind)
[223.162067] Starting subtest: unbind-rebind
[227.047896] Subtest unbind-rebind: SUCCESS (3.886s)
[227.149308] [154/162] (813s left) vgem_basic (unload)