[45.144075] Initializing watchdogs
[45.144146]   /dev/watchdog0
[45.160439] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[45.165860] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[45.168865] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[45.170719] [001/132] (960s left) syncobj_timeline (wait-for-submit-snapshot)
[45.209155] Starting subtest: wait-for-submit-snapshot
[45.292560] Subtest wait-for-submit-snapshot: SUCCESS (0.083s)
[45.387833] [002/132] (960s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[45.474382] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[45.475101] Starting dynamic subtest: pipe-A-HDMI-A-1
[45.492384] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s)
[45.497344] Starting dynamic subtest: pipe-B-HDMI-A-1
[45.521971] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s)
[45.528355] Starting dynamic subtest: pipe-C-HDMI-A-1
[45.546462] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[45.551725] Starting dynamic subtest: pipe-D-HDMI-A-1
[45.569377] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.002s)
[45.570694] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SKIP (0.011s)
[45.732829] [003/132] (960s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[45.824029] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[46.934238] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (1.130s)
[47.079189] [004/132] (958s left) kms_big_fb (linear-8bpp-rotate-270)
[47.173670] Starting subtest: linear-8bpp-rotate-270
[47.248253] Subtest linear-8bpp-rotate-270: SKIP (0.077s)
[47.376170] [005/132] (958s left) kms_busy (extended-modeset-hang-newfb)
[47.463259] Starting subtest: extended-modeset-hang-newfb
[47.464661] Starting dynamic subtest: pipe-A
[71.870259] Dynamic subtest pipe-A: SUCCESS (24.670s)
[71.878520] Starting dynamic subtest: pipe-D
[95.925503] Dynamic subtest pipe-D: SUCCESS (24.056s)
[95.926991] Subtest extended-modeset-hang-newfb: SUCCESS (48.732s)
[96.055131] [006/132] (909s left) perf (oa-exponents)
[96.154356] Starting subtest: oa-exponents
[96.155062] Starting dynamic subtest: 0-rcs0
[99.613682] Dynamic subtest 0-rcs0: SUCCESS (3.450s)
[99.614413] Subtest oa-exponents: SUCCESS (3.451s)
[99.641370] [007/132] (906s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[99.761317] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[100.450652] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (0.689s)
[100.600289] [008/132] (905s left) kms_pipe_crc_basic (suspend-read-crc)
[100.683455] Starting subtest: suspend-read-crc
[100.684138] Starting dynamic subtest: pipe-A-HDMI-A-1
[117.488628] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.301s)
[117.497339] Starting dynamic subtest: pipe-B-HDMI-A-1
[134.455981] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.664s)
[134.462955] Starting dynamic subtest: pipe-C-HDMI-A-1
[151.479885] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.697s)
[151.487825] Starting dynamic subtest: pipe-D-HDMI-A-1
[168.466637] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.693s)
[168.467351] Subtest suspend-read-crc: SUCCESS (7.363s)
[177.644805] [009/132] (837s left) perf_pmu (interrupts-sync)
[177.680674] Starting subtest: interrupts-sync
[178.789765] Subtest interrupts-sync: SUCCESS (1.141s)
[178.890101] [FACT perf_pmu (interrupts-sync)] new: kernel.kmod_is_loaded.vgem: true
[178.893611] [010/132] (836s left) gem_exec_reloc (basic-gtt-active)
[178.929257] Starting subtest: basic-gtt-active
[179.060176] Subtest basic-gtt-active: SUCCESS (0.126s)
[179.187547] [011/132] (835s left) kms_flip (modeset-vs-vblank-race)
[179.269754] Starting subtest: modeset-vs-vblank-race
[179.271803] Starting dynamic subtest: A-HDMI-A1
[179.606418] Dynamic subtest A-HDMI-A1: FAIL (0.320s)
[179.612634] Starting dynamic subtest: B-HDMI-A1
[182.442348] Dynamic subtest B-HDMI-A1: SUCCESS (2.932s)
[182.449727] Starting dynamic subtest: C-HDMI-A1
[185.310967] Dynamic subtest C-HDMI-A1: SUCCESS (2.916s)
[185.318637] Starting dynamic subtest: D-HDMI-A1
[188.170851] Dynamic subtest D-HDMI-A1: SUCCESS (2.892s)
[188.172969] Subtest modeset-vs-vblank-race: FAIL (9.069s)
[188.356065] [012/132] (826s left) gem_sync (basic-each)
[188.403397] Starting subtest: basic-each
[190.492762] Subtest basic-each: SUCCESS (2.106s)
[190.705420] [013/132] (824s left) gem_ctx_persistence (legacy-engines-mixed)
[190.741338] Starting subtest: legacy-engines-mixed
[190.742058] Starting dynamic subtest: render
[190.811059] Dynamic subtest render: SUCCESS (0.069s)
[190.829422] Starting dynamic subtest: bsd1
[190.871968] Dynamic subtest bsd1: SUCCESS (0.058s)
[190.889941] Starting dynamic subtest: bsd2
[190.921904] Dynamic subtest bsd2: SUCCESS (0.047s)
[190.938979] Starting dynamic subtest: blt
[190.983925] Dynamic subtest blt: SUCCESS (0.060s)
[191.003739] Starting dynamic subtest: vebox
[191.060917] Dynamic subtest vebox: SUCCESS (0.073s)
[191.065329] Subtest legacy-engines-mixed: SUCCESS (0.323s)
[191.156206] [014/132] (824s left) kms_plane (plane-panning-bottom-right)
[191.240065] Starting subtest: plane-panning-bottom-right
[191.241755] Starting dynamic subtest: pipe-A
[191.605758] Dynamic subtest pipe-A: SUCCESS (0.366s)
[191.613718] Starting dynamic subtest: pipe-B
[191.964683] Dynamic subtest pipe-B: SUCCESS (0.360s)
[191.965372] Subtest plane-panning-bottom-right: SUCCESS (0.730s)
[192.124976] [015/132] (823s left) prime_vgem (wait)
[192.182308] Starting subtest: wait
[192.183042] Starting dynamic subtest: rcs0
[192.239522] Dynamic subtest rcs0: SUCCESS (0.057s)
[192.248894] Starting dynamic subtest: bcs0
[192.258243] Dynamic subtest bcs0: SUCCESS (0.018s)
[192.266503] Starting dynamic subtest: vcs0
[192.279698] Dynamic subtest vcs0: SUCCESS (0.020s)
[192.288935] Starting dynamic subtest: vcs1
[192.303085] Dynamic subtest vcs1: SUCCESS (0.022s)
[192.314108] Starting dynamic subtest: vecs0
[192.321669] Dynamic subtest vecs0: SUCCESS (0.017s)
[192.322423] Subtest wait: SUCCESS (0.141s)
[192.473257] [016/132] (822s left) i915_query (query-topology-matches-eu-total)
[192.505165] Starting subtest: query-topology-matches-eu-total
[192.505862] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[192.594904] [017/132] (822s left) syncobj_timeline (reset-signaled)
[192.627463] Starting subtest: reset-signaled
[192.628173] Subtest reset-signaled: SUCCESS (0.000s)
[192.720418] [018/132] (822s left) syncobj_timeline (multi-wait-all-available-signaled)
[192.751981] Starting subtest: multi-wait-all-available-signaled
[192.752654] Subtest multi-wait-all-available-signaled: SUCCESS (0.001s)
[192.843478] [019/132] (822s left) kms_cursor_crc (cursor-random-256x256)
[192.935721] Starting subtest: cursor-random-256x256
[192.942511] Starting dynamic subtest: pipe-A-HDMI-A-1
[194.844399] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.911s)
[194.886958] Starting dynamic subtest: pipe-D-HDMI-A-1
[196.749720] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.876s)
[196.750486] Subtest cursor-random-256x256: SUCCESS (3.831s)
[196.918178] [020/132] (818s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[196.958588] Starting subtest: mixed-tiled-to-y-tiled-ccs
[196.959287] Starting dynamic subtest: smem
[197.069699] Dynamic subtest smem: SUCCESS (0.110s)
[197.070433] Subtest mixed-tiled-to-y-tiled-ccs: SUCCESS (0.111s)
[197.273874] [021/132] (818s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[197.359072] Starting subtest: primary-y-tiled-reflect-x-180
[202.265745] Subtest primary-y-tiled-reflect-x-180: SUCCESS (4.919s)
[202.489981] [022/132] (813s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[202.527606] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[202.528319] Starting dynamic subtest: smem
[202.609301] Dynamic subtest smem: SUCCESS (0.081s)
[202.610057] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SUCCESS (0.082s)
[202.814000] [023/132] (812s left) gem_exec_schedule (reorder-wide)
[202.978173] Starting subtest: reorder-wide
[202.979058] Starting dynamic subtest: rcs0
[203.048735] Dynamic subtest rcs0: SUCCESS (0.071s)
[203.061227] Starting dynamic subtest: bcs0
[203.125155] Dynamic subtest bcs0: SUCCESS (0.075s)
[203.136246] Starting dynamic subtest: vcs0
[203.200221] Dynamic subtest vcs0: SUCCESS (0.073s)
[203.211744] Starting dynamic subtest: vcs1
[203.270620] Dynamic subtest vcs1: SUCCESS (0.068s)
[203.281418] Starting dynamic subtest: vecs0
[203.344755] Dynamic subtest vecs0: SUCCESS (0.072s)
[203.347503] Subtest reorder-wide: SUCCESS (0.371s)
[203.545011] [024/132] (812s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[203.635157] Starting subtest: fbc-indfb-scaledprimary
[206.466019] Subtest fbc-indfb-scaledprimary: SUCCESS (2.834s)
[206.633786] [025/132] (809s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[206.724145] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[206.725523] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[206.839354] [026/132] (808s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[206.923296] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[206.925119] Starting dynamic subtest: pipe-A-HDMI-A-1
[206.927859] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[206.934836] Starting dynamic subtest: pipe-B-HDMI-A-1
[206.937562] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[206.944628] Starting dynamic subtest: pipe-C-HDMI-A-1
[206.947358] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[206.954155] Starting dynamic subtest: pipe-D-HDMI-A-1
[206.956826] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[206.958175] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.008s)
[207.170017] [027/132] (808s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[207.258445] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[207.300187] [028/132] (808s left) kms_cursor_crc (cursor-random-64x21)
[207.386251] Starting subtest: cursor-random-64x21
[207.391133] Starting dynamic subtest: pipe-A-HDMI-A-1
[209.303012] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.910s)
[209.336746] Starting dynamic subtest: pipe-D-HDMI-A-1
[211.218909] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.888s)
[211.219901] Subtest cursor-random-64x21: SUCCESS (3.831s)
[211.374257] [029/132] (804s left) prime_mmap (test_dup)
[211.410147] Starting subtest: test_dup
[211.410832] Starting dynamic subtest: test_dup-smem
[211.411509] Dynamic subtest test_dup-smem: SUCCESS (0.002s)
[211.412191] Subtest test_dup: SUCCESS (0.003s)
[211.537173] [030/132] (804s left) gem_exec_schedule (u-submit-late-slice)
[211.580422] Starting subtest: u-submit-late-slice
[211.581129] Starting dynamic subtest: rcs0
[211.608500] Dynamic subtest rcs0: SUCCESS (0.027s)
[211.616462] Starting dynamic subtest: bcs0
[211.635473] Dynamic subtest bcs0: SUCCESS (0.026s)
[211.644573] Starting dynamic subtest: vcs0
[211.667635] Dynamic subtest vcs0: SUCCESS (0.030s)
[211.677307] Starting dynamic subtest: vcs1
[211.696401] Dynamic subtest vcs1: SUCCESS (0.027s)
[211.705298] Starting dynamic subtest: vecs0
[211.730642] Dynamic subtest vecs0: SUCCESS (0.033s)
[211.731384] Subtest u-submit-late-slice: SUCCESS (0.151s)
[212.056821] [031/132] (803s left) syncobj_timeline (etime-multi-wait-all-submitted)
[212.090437] Starting subtest: etime-multi-wait-all-submitted
[212.196114] Subtest etime-multi-wait-all-submitted: SUCCESS (0.105s)
[212.288014] [032/132] (803s left) fbdev (write)
[212.329954] Starting subtest: write
[212.787434] Subtest write: SUCCESS (0.449s)
[212.854108] [033/132] (803s left) syncobj_wait (invalid-signal-zero-handles)
[212.887058] Starting subtest: invalid-signal-zero-handles
[212.887725] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[212.976619] [034/132] (803s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[213.064580] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[213.065938] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[213.188028] [035/132] (802s left) gem_exec_balancer (sliced)
[213.229390] Starting subtest: sliced
[214.642051] Subtest sliced: SUCCESS (1.404s)
[214.842062] [036/132] (801s left) gem_ccs (large-ctrl-surf-copy)
[214.879103] Starting subtest: large-ctrl-surf-copy
[214.880504] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[214.969389] [037/132] (801s left) gem_fenced_exec_thrash (2-spare-fences)
[215.004760] Starting subtest: 2-spare-fences
[217.158702] Subtest 2-spare-fences: SUCCESS (2.153s)
[217.297441] [038/132] (798s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[217.385273] Starting subtest: basic-busy-flip-before-cursor-varying-size
[217.386687] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[217.467434] [039/132] (798s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[217.561585] Starting subtest: 4-tiled-8bpp-rotate-0
[217.563006] Subtest 4-tiled-8bpp-rotate-0: SKIP (0.000s)
[217.690611] [040/132] (798s left) gem_mmap_wc (copy)
[217.723090] Starting subtest: copy
[217.839813] Subtest copy: SUCCESS (0.111s)
[217.917534] [041/132] (798s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[218.002896] Starting subtest: cursor-vs-flip-toggle
[249.790381] Subtest cursor-vs-flip-toggle: SUCCESS (31.792s)
[249.949079] [042/132] (766s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[250.045025] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[250.046447] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[250.169757] [043/132] (766s left) kms_addfb_basic (unused-handle)
[250.204449] Starting subtest: unused-handle
[250.205146] Subtest unused-handle: SUCCESS (0.000s)
[250.362903] [044/132] (766s left) gem_ctx_shared (q-smoketest-all)
[250.404486] Starting subtest: Q-smoketest-all
[282.673255] Subtest Q-smoketest-all: SUCCESS (32.258s)
[282.862791] [045/132] (733s left) kms_flip (2x-flip-vs-expired-vblank)
[282.948747] Starting subtest: 2x-flip-vs-expired-vblank
[282.957932] Subtest 2x-flip-vs-expired-vblank: SKIP (0.009s)
[283.051624] [046/132] (733s left) kms_force_connector_basic (force-edid)
[283.173818] Starting subtest: force-edid
[283.323864] Subtest force-edid: SUCCESS (0.150s)
[283.497613] [047/132] (733s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[283.593558] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[284.246281] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.653s)
[284.404936] [048/132] (732s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[284.496402] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[284.497396] Starting dynamic subtest: pipe-A
[284.614661] Dynamic subtest pipe-A: SUCCESS (0.125s)
[284.626751] Starting dynamic subtest: pipe-B
[284.740323] Dynamic subtest pipe-B: SUCCESS (0.124s)
[284.749441] Starting dynamic subtest: pipe-C
[284.866149] Dynamic subtest pipe-C: SUCCESS (0.125s)
[284.882701] Starting dynamic subtest: pipe-D
[285.007919] Dynamic subtest pipe-D: SUCCESS (0.141s)
[285.008657] Subtest planes-unity-scaling-downscale-factor-0-5: SUCCESS (0.520s)
[285.211220] [049/132] (731s left) kms_chamelium_audio (hdmi-audio)
[285.351949] Subtest hdmi-audio: SKIP (0.000s)
[285.446976] [050/132] (731s left) gem_set_tiling_vs_gtt
[285.932600] [051/132] (730s left) gem_lmem_swapping (massive)
[285.967544] Subtest massive: SKIP (0.000s)
[286.008606] [052/132] (730s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[286.100014] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[286.101451] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[286.211799] [053/132] (730s left) prime_busy (after)
[286.248054] Starting subtest: after
[286.252157] Starting dynamic subtest: rcs0
[286.291809] Dynamic subtest rcs0: SUCCESS (0.039s)
[286.308735] Starting dynamic subtest: bcs0
[286.313036] Dynamic subtest bcs0: SUCCESS (0.019s)
[286.328148] Starting dynamic subtest: vcs0
[286.337129] Dynamic subtest vcs0: SUCCESS (0.023s)
[286.350980] Starting dynamic subtest: vcs1
[286.353290] Dynamic subtest vcs1: SUCCESS (0.014s)
[286.361454] Starting dynamic subtest: vecs0
[286.379151] Dynamic subtest vecs0: SUCCESS (0.024s)
[286.489002] Subtest after: SUCCESS (0.240s)
[286.579465] [054/132] (730s left) syncobj_wait (invalid-signal-illegal-handle)
[286.612194] Starting subtest: invalid-signal-illegal-handle
[286.612952] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[286.701782] [055/132] (730s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[286.786228] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[286.788172] Starting dynamic subtest: pipe-A-valid-mode
[286.837984] Dynamic subtest pipe-A-valid-mode: SKIP (0.050s)
[286.839327] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.052s)
[286.961008] [056/132] (729s left) gem_gtt_cpu_tlb
[287.118889] [057/132] (729s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[287.206987] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[287.208382] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[287.326996] [058/132] (729s left) gen9_exec_parse (batch-zero-length)
[287.362899] Subtest batch-zero-length: SKIP (0.000s)
[287.407444] [059/132] (729s left) gem_softpin (evict-snoop-interruptible)
[287.445716] Starting subtest: evict-snoop-interruptible
[287.447127] Subtest evict-snoop-interruptible: SKIP (0.000s)
[287.536374] [060/132] (729s left) dmabuf_sync_file (export-basic)
[287.577701] Starting subtest: export-basic
[287.579567] Subtest export-basic: SUCCESS (0.001s)
[287.656989] [061/132] (729s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[287.742323] Starting subtest: fb-8bpc-vs-panel-6bpc
[287.743027] Starting dynamic subtest: pipe-A-HDMI-A-1
[287.794664] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.051s)
[287.796018] Subtest fb-8bpc-vs-panel-6bpc: SKIP (0.053s)
[287.944119] [062/132] (729s left) syncobj_timeline (host-signal-ordered)
[287.979697] Starting subtest: host-signal-ordered
[287.980412] Subtest host-signal-ordered: SUCCESS (0.000s)
[288.072646] [063/132] (729s left) kms_chamelium_hpd (common-hpd-after-suspend)
[288.210852] Subtest common-hpd-after-suspend: SKIP (0.000s)
[288.305591] [064/132] (728s left) kms_flip (2x-flip-vs-fences)
[288.408213] Starting subtest: 2x-flip-vs-fences
[288.417266] Subtest 2x-flip-vs-fences: SKIP (0.009s)
[288.529558] [065/132] (728s left) perf (mi-rpc)
[288.618751] Starting subtest: mi-rpc
[288.620115] Subtest mi-rpc: SKIP (0.000s)
[288.662164] [066/132] (728s left) sw_sync (sync_random_merge)
[288.695118] Starting subtest: sync_random_merge
[288.751479] Subtest sync_random_merge: SUCCESS (0.057s)
[288.831147] [067/132] (728s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[288.920280] Starting subtest: psr-rgb101010-draw-pwrite
[288.921635] Subtest psr-rgb101010-draw-pwrite: SKIP (0.000s)
[289.036491] [068/132] (728s left) kms_getfb (getfb2-handle-closed)
[289.123387] Starting subtest: getfb2-handle-closed
[289.124095] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[289.246002] [069/132] (728s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[289.335443] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[289.336777] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[289.436174] [070/132] (728s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[289.468908] Starting subtest: invalid-smem-bo-on-discrete
[289.470316] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[289.628160] [071/132] (727s left) perf (gen12-invalid-class-instance)
[289.719778] Starting subtest: gen12-invalid-class-instance
[289.727415] Subtest gen12-invalid-class-instance: SUCCESS (0.008s)
[289.770552] [072/132] (727s left) gem_exec_schedule (implicit-read-write)
[289.812682] Starting subtest: implicit-read-write
[289.813416] Starting dynamic subtest: rcs0
[289.872311] Dynamic subtest rcs0: SUCCESS (0.059s)
[289.884315] Starting dynamic subtest: bcs0
[289.935950] Dynamic subtest bcs0: SUCCESS (0.061s)
[289.948913] Starting dynamic subtest: vcs0
[290.000553] Dynamic subtest vcs0: SUCCESS (0.062s)
[290.013389] Starting dynamic subtest: vcs1
[290.064186] Dynamic subtest vcs1: SUCCESS (0.061s)
[290.076495] Starting dynamic subtest: vecs0
[290.127185] Dynamic subtest vecs0: SUCCESS (0.061s)
[290.128453] Subtest implicit-read-write: SUCCESS (0.315s)
[290.454265] [073/132] (727s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[290.541197] Starting subtest: addfb25-framebuffer-vs-set-tiling
[290.541880] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[290.662930] [074/132] (727s left) kms_atomic (plane-cursor-legacy)
[290.747680] Starting subtest: plane-cursor-legacy
[290.749812] Starting dynamic subtest: pipe-A-HDMI-A-1
[290.887475] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.138s)
[290.888207] Subtest plane-cursor-legacy: SUCCESS (0.140s)
[291.029243] [075/132] (726s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[291.115643] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[291.117435] Starting dynamic subtest: pipe-A-HDMI-A-1
[291.123292] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[291.130491] Starting dynamic subtest: pipe-B-HDMI-A-1
[291.136580] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[291.143698] Starting dynamic subtest: pipe-C-HDMI-A-1
[291.149690] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[291.156739] Starting dynamic subtest: pipe-D-HDMI-A-1
[291.162544] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[291.163204] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SUCCESS (0.009s)
[291.362139] [076/132] (726s left) gem_exec_balancer (bonded-pair)
[291.404273] Starting subtest: bonded-pair
[323.937104] Subtest bonded-pair: SUCCESS (32.525s)
[324.132184] [077/132] (693s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[324.223036] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[324.224393] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[324.330562] [078/132] (693s left) gem_ctx_exec (basic-invalid-context)
[324.363606] Starting subtest: basic-invalid-context
[324.365399] Subtest basic-invalid-context: SUCCESS (0.002s)
[324.490153] [079/132] (693s left) kms_content_protection (lic-type-0-hdcp14)
[324.582423] Starting subtest: lic-type-0-hdcp14
[324.596940] Subtest lic-type-0-hdcp14: SKIP (0.013s)
[324.704951] [080/132] (693s left) gem_eio (wait-immediate)
[324.749446] Starting subtest: wait-immediate
[324.894139] Subtest wait-immediate: SUCCESS (0.145s)
[325.035821] [081/132] (692s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[325.124447] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[325.133978] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.009s)
[325.228842] [082/132] (692s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[325.314358] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[325.315046] Starting dynamic subtest: pipe-A-valid-mode
[326.498887] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.184s)
[326.500627] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SUCCESS (1.186s)
[326.666319] [083/132] (691s left) kms_psr (psr2-basic)
[326.757363] Subtest psr2-basic: SKIP (0.000s)
[326.810036] [084/132] (691s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[326.895106] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[326.896912] Starting dynamic subtest: pipe-A-HDMI-A-1
[326.903398] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[326.910732] Starting dynamic subtest: pipe-B-HDMI-A-1
[326.917202] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[326.924514] Starting dynamic subtest: pipe-C-HDMI-A-1
[326.930942] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[326.938098] Starting dynamic subtest: pipe-D-HDMI-A-1
[326.944697] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[326.946078] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.009s)
[327.139830] [085/132] (690s left) kms_vblank (query-forked-busy)
[327.230236] Starting subtest: query-forked-busy
[327.232503] Starting dynamic subtest: pipe-A-HDMI-A-1
[328.513545] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.281s)
[328.527862] Starting dynamic subtest: pipe-D-HDMI-A-1
[329.809394] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.289s)
[329.810095] Subtest query-forked-busy: SUCCESS (2.580s)
[329.978061] [086/132] (688s left) kms_pm_dc (dc9-dpms)
[331.071679] Starting subtest: dc9-dpms
[334.399929] Subtest dc9-dpms: SKIP (3.294s)
[334.489698] [087/132] (683s left) gem_userptr_blits (set-cache-level)
[334.528219] Starting subtest: set-cache-level
[334.528906] Subtest set-cache-level: SUCCESS (0.000s)
[334.685977] [088/132] (683s left) gem_exec_fence (keep-in-fence)
[334.849369] Starting subtest: keep-in-fence
[334.850393] Starting dynamic subtest: rcs0
[334.880818] Dynamic subtest rcs0: SUCCESS (0.030s)
[334.894771] Starting dynamic subtest: bcs0
[334.911677] Dynamic subtest bcs0: SUCCESS (0.029s)
[334.925478] Starting dynamic subtest: vcs0
[334.942905] Dynamic subtest vcs0: SUCCESS (0.029s)
[334.956417] Starting dynamic subtest: vcs1
[334.972666] Dynamic subtest vcs1: SUCCESS (0.028s)
[334.986189] Starting dynamic subtest: vecs0
[335.004778] Dynamic subtest vecs0: SUCCESS (0.030s)
[335.005943] Subtest keep-in-fence: SUCCESS (0.157s)
[335.506221] [089/132] (682s left) kms_pm_rpm (modeset-pc8-residency-stress)
[336.901587] Starting subtest: modeset-pc8-residency-stress
[336.903711] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[337.097926] [090/132] (681s left) kms_psr (fbc-psr2-sprite-plane-move)
[337.194943] Subtest fbc-psr2-sprite-plane-move: SKIP (0.000s)
[337.236555] [091/132] (681s left) gem_exec_create (forked)
[337.275953] Starting subtest: forked
[337.276652] Starting dynamic subtest: smem
[357.370341] Dynamic subtest smem: SUCCESS (20.098s)
[357.371042] Subtest forked: SUCCESS (20.099s)
[357.572793] [092/132] (660s left) kms_psr (pr-cursor-mmap-cpu)
[357.665832] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[357.711677] [093/132] (660s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[357.800416] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[357.801767] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[357.912669] [094/132] (660s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[358.001354] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[358.043964] [095/132] (660s left) gem_exec_reloc (basic-wc-read)
[358.080239] Starting subtest: basic-wc-read
[358.085777] Subtest basic-wc-read: SUCCESS (0.005s)
[358.220691] [096/132] (660s left) kms_psr (psr-cursor-plane-move)
[358.305945] Subtest psr-cursor-plane-move: SKIP (0.000s)
[358.351070] [097/132] (660s left) kms_flip (basic-plain-flip)
[358.435902] Starting subtest: basic-plain-flip
[358.438162] Starting dynamic subtest: A-HDMI-A1
[359.113660] Dynamic subtest A-HDMI-A1: SUCCESS (0.675s)
[359.126783] Starting dynamic subtest: B-HDMI-A1
[359.781246] Dynamic subtest B-HDMI-A1: SUCCESS (0.662s)
[359.790041] Starting dynamic subtest: C-HDMI-A1
[360.437646] Dynamic subtest C-HDMI-A1: SUCCESS (0.653s)
[360.448525] Starting dynamic subtest: D-HDMI-A1
[361.096342] Dynamic subtest D-HDMI-A1: SUCCESS (0.655s)
[361.097200] Subtest basic-plain-flip: SUCCESS (2.658s)
[361.255001] [098/132] (657s left) kms_flip (plain-flip-fb-recreate)
[361.343772] Starting subtest: plain-flip-fb-recreate
[361.346306] Starting dynamic subtest: A-HDMI-A1
[369.160663] Dynamic subtest A-HDMI-A1: SUCCESS (7.816s)
[369.178499] Starting dynamic subtest: B-HDMI-A1
[376.971594] Dynamic subtest B-HDMI-A1: SUCCESS (7.810s)
[376.982832] Starting dynamic subtest: C-HDMI-A1
[384.780941] Dynamic subtest C-HDMI-A1: SUCCESS (7.808s)
[384.795581] Starting dynamic subtest: D-HDMI-A1
[392.588906] Dynamic subtest D-HDMI-A1: SUCCESS (7.807s)
[392.594173] Subtest plain-flip-fb-recreate: SUCCESS (31.258s)
[392.757164] [099/132] (625s left) i915_suspend (debugfs-reader)
[392.789013] Starting subtest: debugfs-reader
[411.240418] Subtest debugfs-reader: SUCCESS (3.201s)
[419.312945] [100/132] (607s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[419.406234] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[419.407666] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[419.511159] [101/132] (607s left) gem_exec_nop (basic-sequential)
[419.550659] Starting subtest: basic-sequential
[422.903158] Subtest basic-sequential: SUCCESS (3.457s)
[423.141315] [102/132] (603s left) gem_pxp (create-regular-buffer)
[423.239548] Starting subtest: create-regular-buffer
[423.240631] Subtest create-regular-buffer: SUCCESS (0.000s)
[423.359166] [103/132] (603s left) syncobj_basic (test-valid-cycle)
[423.389631] Starting subtest: test-valid-cycle
[423.390318] Subtest test-valid-cycle: SUCCESS (0.000s)
[423.478341] [104/132] (603s left) gem_exec_suspend (basic-s3-devices)
[423.516732] Starting subtest: basic-S3-devices
[423.517802] Starting dynamic subtest: smem
[430.397172] Dynamic subtest smem: SUCCESS (6.985s)
[430.397951] Subtest basic-S3-devices: SUCCESS (6.986s)
[438.628672] [105/132] (596s left) template (a)
[438.663514] Starting subtest: A
[438.664205] Subtest A: SUCCESS (0.000s)
[438.748184] [106/132] (596s left) gem_mmap_gtt (bad-object)
[438.779587] Starting subtest: bad-object
[438.780289] Subtest bad-object: SUCCESS (0.000s)
[438.902360] [107/132] (596s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[438.992845] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[438.994195] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[439.111011] [108/132] (595s left) api_intel_bb (intel-bb-blit-y)
[439.142617] Starting subtest: intel-bb-blit-y
[442.343081] Subtest intel-bb-blit-y: SUCCESS (3.169s)
[442.449309] [109/132] (592s left) kms_selftest (drm_format_helper)
[442.482661] Starting subtest: drm_format_helper
[442.500970] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[442.603369] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.104s)
[442.622232] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[442.701320] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.092s)
[442.716714] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[442.790031] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.086s)
[442.805258] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[442.878881] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.088s)
[442.894696] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[442.963262] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.081s)
[442.978385] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[443.041589] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.075s)
[443.056525] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[443.136186] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.092s)
[443.154627] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[443.242038] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.102s)
[443.258144] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[443.326049] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.084s)
[443.346427] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[443.416575] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.083s)
[443.431847] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[443.500863] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.082s)
[443.516584] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[443.585231] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.081s)
[443.601092] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[443.709278] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.121s)
[443.725422] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[443.793335] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.081s)
[443.810285] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[443.885021] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.087s)
[443.900364] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[443.974515] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.088s)
[443.989887] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[444.064383] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.089s)
[444.067402] Subtest drm_format_helper: SUCCESS (1.584s)
[444.247712] [110/132] (590s left) gem_mmap_offset (oob-read)
[444.280373] Starting subtest: oob-read
[444.281071] Subtest oob-read: SUCCESS (0.000s)
[444.388409] [111/132] (590s left) gem_spin_batch (resubmit-all)
[444.430074] Starting subtest: resubmit-all
[444.430776] Starting dynamic subtest: rcs0
[444.433234] Dynamic subtest rcs0: SUCCESS (0.004s)
[444.443324] Starting dynamic subtest: bcs0
[444.444071] Dynamic subtest bcs0: SUCCESS (0.002s)
[444.451824] Starting dynamic subtest: vcs0
[444.452507] Dynamic subtest vcs0: SUCCESS (0.002s)
[444.459653] Starting dynamic subtest: vcs1
[444.460329] Dynamic subtest vcs1: SUCCESS (0.002s)
[444.467360] Starting dynamic subtest: vecs0
[444.468044] Dynamic subtest vecs0: SUCCESS (0.002s)
[444.468722] Subtest resubmit-all: SUCCESS (0.017s)
[444.647435] [112/132] (590s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[444.733984] Starting subtest: cursorB-vs-flipA-toggle
[444.735940] Subtest cursorB-vs-flipA-toggle: SKIP (0.002s)
[444.823540] [113/132] (590s left) gen9_exec_parse (valid-registers)
[444.860042] Subtest valid-registers: SKIP (0.000s)
[444.903611] [114/132] (590s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[444.986991] Starting subtest: disable-crc-after-crtc
[444.987676] Starting dynamic subtest: pipe-A-HDMI-A-1
[445.329294] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.341s)
[445.338237] Starting dynamic subtest: pipe-B-HDMI-A-1
[445.639205] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.308s)
[445.647914] Starting dynamic subtest: pipe-C-HDMI-A-1
[445.962841] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.323s)
[445.972863] Starting dynamic subtest: pipe-D-HDMI-A-1
[446.264265] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.299s)
[446.264955] Subtest disable-crc-after-crtc: SUCCESS (1.279s)
[446.453317] [115/132] (588s left) gem_exec_fence (syncobj-unused-fence)
[446.782270] Starting subtest: syncobj-unused-fence
[446.784142] Subtest syncobj-unused-fence: SUCCESS (0.002s)
[447.101027] [116/132] (588s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[447.190574] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[447.191921] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[447.325111] [117/132] (588s left) gem_set_tiling_vs_pwrite
[447.474903] [118/132] (588s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[447.563402] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[447.564833] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[447.688991] [119/132] (587s left) vgem_basic (busy-fence)
[447.723949] Starting subtest: busy-fence
[447.724640] Subtest busy-fence: SUCCESS (0.000s)
[447.806895] [120/132] (587s left) i915_pm_rpm (debugfs-read)
[449.211915] Starting subtest: debugfs-read
[450.414253] Subtest debugfs-read: SUCCESS (1.202s)
[450.598578] [121/132] (585s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[450.689810] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[452.146537] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (1.457s)
[452.313084] [122/132] (583s left) perf_pmu (busy-start)
[452.349264] Starting subtest: busy-start
[452.349995] Starting dynamic subtest: rcs0
[454.892907] Dynamic subtest rcs0: SUCCESS (2.520s)
[454.903792] Starting dynamic subtest: bcs0
[457.415156] Dynamic subtest bcs0: SUCCESS (2.522s)
[457.425762] Starting dynamic subtest: vcs0
[459.938594] Dynamic subtest vcs0: SUCCESS (2.522s)
[459.948916] Starting dynamic subtest: vcs1
[462.461808] Dynamic subtest vcs1: SUCCESS (2.521s)
[462.472642] Starting dynamic subtest: vecs0
[464.981909] Dynamic subtest vecs0: SUCCESS (2.518s)
[464.982847] Subtest busy-start: SUCCESS (12.615s)
[465.043159] [123/132] (570s left) kms_addfb_basic (size-max)
[465.130040] Starting subtest: size-max
[465.130782] Subtest size-max: SUCCESS (0.000s)
[465.241168] [124/132] (570s left) kms_psr (fbc-pr-primary-blt)
[465.325550] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[465.370948] [125/132] (570s left) kms_color_pipeline (plane-ctm3x4)
[465.457008] Starting subtest: plane-ctm3x4
[465.473988] Starting dynamic subtest: pipe-A-HDMI-A-1
[465.614599] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.141s)
[465.763174] Starting dynamic subtest: pipe-B-HDMI-A-1
[465.887459] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.131s)
[466.027343] Starting dynamic subtest: pipe-C-HDMI-A-1
[466.159251] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.139s)
[466.303599] Starting dynamic subtest: pipe-D-HDMI-A-1
[466.425773] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.132s)
[466.484818] Subtest plane-ctm3x4: SUCCESS (1.028s)
[466.616373] [126/132] (569s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[466.753497] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[466.845782] [127/132] (569s left) api_intel_allocator (standalone)
[466.882301] Starting subtest: standalone
[466.899543] Subtest standalone: SUCCESS (0.018s)
[467.008946] [128/132] (568s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[467.095312] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[467.096723] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[467.218499] [129/132] (568s left) kms_big_fb (y-tiled-addfb)
[467.312163] Starting subtest: y-tiled-addfb
[467.312892] Subtest y-tiled-addfb: SUCCESS (0.000s)
[467.433272] [130/132] (568s left) kms_prime (basic-crc-vgem)
[467.529613] Starting subtest: basic-crc-vgem
[467.530308] Starting dynamic subtest: second-to-first
[468.175014] Dynamic subtest second-to-first: SUCCESS (0.646s)
[468.178194] Subtest basic-crc-vgem: SUCCESS (0.648s)
[468.285005] [131/132] (567s left) i915_hangman (engine-error-state-capture)
[468.328833] Starting subtest: engine-error-state-capture
[468.329563] Starting dynamic subtest: rcs0
[472.105139] Dynamic subtest rcs0: SUCCESS (3.776s)
[472.124817] Starting dynamic subtest: bcs0
[476.063281] Dynamic subtest bcs0: SUCCESS (3.956s)
[476.076484] Starting dynamic subtest: vcs0
[480.108913] Dynamic subtest vcs0: SUCCESS (4.044s)
[480.128244] Starting dynamic subtest: vcs1
[484.062063] Dynamic subtest vcs1: SUCCESS (3.950s)
[484.080860] Starting dynamic subtest: vecs0
[487.082177] Dynamic subtest vecs0: SUCCESS (3.017s)
[487.083507] Subtest engine-error-state-capture: SUCCESS (18.757s)
[487.187567] [132/132] (548s left) kms_invalid_mode (bad-vsync-end)
[487.272710] Starting subtest: bad-vsync-end
[487.273402] Starting dynamic subtest: pipe-A-HDMI-A-1
[487.325329] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.051s)
[487.334881] Starting dynamic subtest: pipe-B-HDMI-A-1
[487.335581] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[487.343244] Starting dynamic subtest: pipe-C-HDMI-A-1
[487.343942] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[487.351456] Starting dynamic subtest: pipe-D-HDMI-A-1
[487.352143] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[487.352819] Subtest bad-vsync-end: SUCCESS (0.063s)
[487.496344] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: kms_busy
results: parsing output: 5/ for test: perf
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: kms_pipe_crc_basic
results: parsing output: 8/ for test: perf_pmu
results: parsing output: 9/ for test: gem_exec_reloc
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: gem_sync
results: parsing output: 12/ for test: gem_ctx_persistence
results: parsing output: 13/ for test: kms_plane
results: parsing output: 14/ for test: prime_vgem
results: parsing output: 15/ for test: i915_query
results: parsing output: 16/ for test: syncobj_timeline
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: kms_cursor_crc
results: parsing output: 19/ for test: gem_render_copy
results: parsing output: 20/ for test: kms_rotation_crc
results: parsing output: 21/ for test: gem_render_copy
results: parsing output: 22/ for test: gem_exec_schedule
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: kms_psr2_sf
results: parsing output: 27/ for test: kms_cursor_crc
results: parsing output: 28/ for test: prime_mmap
results: parsing output: 29/ for test: gem_exec_schedule
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: fbdev
results: parsing output: 32/ for test: syncobj_wait
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_exec_balancer
results: parsing output: 35/ for test: gem_ccs
results: parsing output: 36/ for test: gem_fenced_exec_thrash
results: parsing output: 37/ for test: kms_cursor_legacy
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: gem_mmap_wc
results: parsing output: 40/ for test: kms_cursor_legacy
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_addfb_basic
results: parsing output: 43/ for test: gem_ctx_shared
results: parsing output: 44/ for test: kms_flip
results: parsing output: 45/ for test: kms_force_connector_basic
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: kms_plane_scaling
results: parsing output: 48/ for test: kms_chamelium_audio
results: parsing output: 49/ for test: gem_set_tiling_vs_gtt
results: parsing output: 50/ for test: gem_lmem_swapping
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: prime_busy
results: parsing output: 53/ for test: syncobj_wait
results: parsing output: 54/ for test: kms_flip_scaled_crc
results: parsing output: 55/ for test: gem_gtt_cpu_tlb
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gen9_exec_parse
results: parsing output: 58/ for test: gem_softpin
results: parsing output: 59/ for test: dmabuf_sync_file
results: parsing output: 60/ for test: kms_dither
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: kms_chamelium_hpd
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: perf
results: parsing output: 65/ for test: sw_sync
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_getfb
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_addfb_basic
results: parsing output: 70/ for test: perf
results: parsing output: 71/ for test: gem_exec_schedule
results: parsing output: 72/ for test: kms_addfb_basic
results: parsing output: 73/ for test: kms_atomic
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: gem_exec_balancer
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_ctx_exec
results: parsing output: 78/ for test: kms_content_protection
results: parsing output: 79/ for test: gem_eio
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: kms_flip_scaled_crc
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: kms_ccs
results: parsing output: 84/ for test: kms_vblank
results: parsing output: 85/ for test: kms_pm_dc
results: parsing output: 86/ for test: gem_userptr_blits
results: parsing output: 87/ for test: gem_exec_fence
results: parsing output: 88/ for test: kms_pm_rpm
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: gem_exec_create
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_psr2_sf
results: parsing output: 94/ for test: gem_exec_reloc
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: kms_flip
results: parsing output: 98/ for test: i915_suspend
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_exec_nop
results: parsing output: 101/ for test: gem_pxp
results: parsing output: 102/ for test: syncobj_basic
results: parsing output: 103/ for test: gem_exec_suspend
results: parsing output: 104/ for test: template
results: parsing output: 105/ for test: gem_mmap_gtt
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: api_intel_bb
results: parsing output: 108/ for test: kms_selftest
results: parsing output: 109/ for test: gem_mmap_offset
results: parsing output: 110/ for test: gem_spin_batch
results: parsing output: 111/ for test: kms_cursor_legacy
results: parsing output: 112/ for test: gen9_exec_parse
results: parsing output: 113/ for test: kms_pipe_crc_basic
results: parsing output: 114/ for test: gem_exec_fence
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: vgem_basic
results: parsing output: 119/ for test: i915_pm_rpm
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: perf_pmu
results: parsing output: 122/ for test: kms_addfb_basic
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: kms_color_pipeline
results: parsing output: 125/ for test: kms_chamelium_hpd
results: parsing output: 126/ for test: api_intel_allocator
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: kms_prime
results: parsing output: 130/ for test: i915_hangman
results: parsing output: 131/ for test: kms_invalid_mode
Done.