[66.875446] Initializing watchdogs
[66.875509]   /dev/watchdog0
[66.908624] [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]
[66.920276] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[66.924950] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[66.927451] [001/132] (960s left) syncobj_timeline (wait-for-submit-snapshot)
[66.993802] Starting subtest: wait-for-submit-snapshot
[67.074509] Subtest wait-for-submit-snapshot: SUCCESS (0.083s)
[67.162113] [002/132] (960s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[67.481817] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[67.483690] Starting dynamic subtest: pipe-A-HDMI-A-1
[67.504398] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.005s)
[67.511410] Starting dynamic subtest: pipe-B-HDMI-A-1
[67.533168] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.005s)
[67.540058] Starting dynamic subtest: pipe-C-HDMI-A-1
[67.561235] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.005s)
[67.569156] Starting dynamic subtest: pipe-D-HDMI-A-1
[67.591146] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.006s)
[67.592957] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SKIP (0.028s)
[67.798084] [003/132] (959s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[67.958905] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[69.071206] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (1.114s)
[69.233612] [004/132] (958s left) kms_big_fb (linear-8bpp-rotate-270)
[69.334719] Starting subtest: linear-8bpp-rotate-270
[69.407746] Subtest linear-8bpp-rotate-270: SKIP (0.076s)
[69.538474] [005/132] (958s left) kms_busy (extended-modeset-hang-newfb)
[69.629689] Starting subtest: extended-modeset-hang-newfb
[69.631112] Starting dynamic subtest: pipe-A
[93.889150] Dynamic subtest pipe-A: SUCCESS (24.263s)
[93.899951] Starting dynamic subtest: pipe-D
[117.953204] Dynamic subtest pipe-D: SUCCESS (24.058s)
[117.954632] Subtest extended-modeset-hang-newfb: SUCCESS (48.327s)
[118.100879] [006/132] (909s left) perf (oa-exponents)
[118.196955] Starting subtest: oa-exponents
[118.197650] Starting dynamic subtest: 0-rcs0
[121.620713] Dynamic subtest 0-rcs0: SUCCESS (3.415s)
[121.621473] Subtest oa-exponents: SUCCESS (3.416s)
[121.653105] [007/132] (906s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[121.768173] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[122.447386] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (0.679s)
[122.606611] [008/132] (905s left) kms_pipe_crc_basic (suspend-read-crc)
[122.690618] Starting subtest: suspend-read-crc
[122.692101] Starting dynamic subtest: pipe-A-HDMI-A-1
[139.563970] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.243s)
[139.570876] Starting dynamic subtest: pipe-B-HDMI-A-1
[156.535636] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.714s)
[156.542561] Starting dynamic subtest: pipe-C-HDMI-A-1
[173.504947] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.682s)
[173.513516] Starting dynamic subtest: pipe-D-HDMI-A-1
[190.499346] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.672s)
[190.500063] Subtest suspend-read-crc: SUCCESS (7.317s)
[199.678024] [009/132] (837s left) perf_pmu (interrupts-sync)
[199.718766] Starting subtest: interrupts-sync
[200.843032] Subtest interrupts-sync: SUCCESS (1.128s)
[200.938813] [FACT perf_pmu (interrupts-sync)] new: kernel.kmod_is_loaded.vgem: true
[200.941969] [010/132] (835s left) gem_exec_reloc (basic-gtt-active)
[200.975722] Starting subtest: basic-gtt-active
[201.109379] Subtest basic-gtt-active: SUCCESS (0.129s)
[201.248695] [011/132] (835s left) kms_flip (modeset-vs-vblank-race)
[201.329598] Starting subtest: modeset-vs-vblank-race
[201.331451] Starting dynamic subtest: A-HDMI-A1
[204.151143] Dynamic subtest A-HDMI-A1: SUCCESS (2.891s)
[204.158187] Starting dynamic subtest: B-HDMI-A1
[206.948623] Dynamic subtest B-HDMI-A1: SUCCESS (2.846s)
[206.958535] Starting dynamic subtest: C-HDMI-A1
[209.812767] Dynamic subtest C-HDMI-A1: SUCCESS (2.897s)
[209.821783] Starting dynamic subtest: D-HDMI-A1
[212.652607] Dynamic subtest D-HDMI-A1: SUCCESS (2.862s)
[212.654873] Subtest modeset-vs-vblank-race: SUCCESS (11.504s)
[212.836636] [012/132] (824s left) gem_sync (basic-each)
[212.887527] Starting subtest: basic-each
[215.097272] Subtest basic-each: SUCCESS (2.222s)
[215.305257] [013/132] (821s left) gem_ctx_persistence (legacy-engines-mixed)
[215.340490] Starting subtest: legacy-engines-mixed
[215.341212] Starting dynamic subtest: render
[215.384927] Dynamic subtest render: SUCCESS (0.043s)
[215.401223] Starting dynamic subtest: bsd1
[215.433935] Dynamic subtest bsd1: SUCCESS (0.047s)
[215.450770] Starting dynamic subtest: bsd2
[215.486912] Dynamic subtest bsd2: SUCCESS (0.050s)
[215.505129] Starting dynamic subtest: blt
[215.544996] Dynamic subtest blt: SUCCESS (0.055s)
[215.562222] Starting dynamic subtest: vebox
[215.604650] Dynamic subtest vebox: SUCCESS (0.057s)
[215.608236] Subtest legacy-engines-mixed: SUCCESS (0.267s)
[215.693002] [014/132] (821s left) kms_plane (plane-panning-bottom-right)
[215.777546] Starting subtest: plane-panning-bottom-right
[215.779685] Starting dynamic subtest: pipe-A
[216.143691] Dynamic subtest pipe-A: SUCCESS (0.366s)
[216.154340] Starting dynamic subtest: pipe-B
[216.487848] Dynamic subtest pipe-B: SUCCESS (0.343s)
[216.488543] Subtest plane-panning-bottom-right: SUCCESS (0.714s)
[216.659350] [015/132] (820s left) prime_vgem (wait)
[216.716483] Starting subtest: wait
[216.717212] Starting dynamic subtest: rcs0
[216.759945] Dynamic subtest rcs0: SUCCESS (0.043s)
[216.768404] Starting dynamic subtest: bcs0
[216.777823] Dynamic subtest bcs0: SUCCESS (0.017s)
[216.785460] Starting dynamic subtest: vcs0
[216.810268] Dynamic subtest vcs0: SUCCESS (0.031s)
[216.821903] Starting dynamic subtest: vcs1
[216.832484] Dynamic subtest vcs1: SUCCESS (0.020s)
[216.843958] Starting dynamic subtest: vecs0
[216.864319] Dynamic subtest vecs0: SUCCESS (0.030s)
[216.867451] Subtest wait: SUCCESS (0.150s)
[217.006990] [016/132] (820s left) i915_query (query-topology-matches-eu-total)
[217.038094] Starting subtest: query-topology-matches-eu-total
[217.038773] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[217.127675] [017/132] (819s left) syncobj_timeline (reset-signaled)
[217.161987] Starting subtest: reset-signaled
[217.162667] Subtest reset-signaled: SUCCESS (0.001s)
[217.279681] [018/132] (819s left) syncobj_timeline (multi-wait-all-available-signaled)
[217.312912] Starting subtest: multi-wait-all-available-signaled
[217.313623] Subtest multi-wait-all-available-signaled: SUCCESS (0.001s)
[217.401640] [019/132] (819s left) kms_cursor_crc (cursor-random-256x256)
[217.490431] Starting subtest: cursor-random-256x256
[217.495077] Starting dynamic subtest: pipe-A-HDMI-A-1
[219.404445] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.915s)
[219.441802] Starting dynamic subtest: pipe-D-HDMI-A-1
[221.300501] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.873s)
[221.301256] Subtest cursor-random-256x256: SUCCESS (3.822s)
[221.454227] [020/132] (815s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[221.496699] Starting subtest: mixed-tiled-to-y-tiled-ccs
[221.497381] Starting dynamic subtest: smem
[221.609352] Dynamic subtest smem: SUCCESS (0.112s)
[221.610061] Subtest mixed-tiled-to-y-tiled-ccs: SUCCESS (0.113s)
[221.806554] [021/132] (815s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[221.894518] Starting subtest: primary-y-tiled-reflect-x-180
[226.829734] Subtest primary-y-tiled-reflect-x-180: SUCCESS (4.945s)
[227.045903] [022/132] (810s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[227.084540] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[227.085266] Starting dynamic subtest: smem
[227.164633] Dynamic subtest smem: SUCCESS (0.080s)
[227.165365] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SUCCESS (0.081s)
[227.369725] [023/132] (809s left) gem_exec_schedule (reorder-wide)
[227.537292] Starting subtest: reorder-wide
[227.538151] Starting dynamic subtest: rcs0
[227.607000] Dynamic subtest rcs0: SUCCESS (0.070s)
[227.618314] Starting dynamic subtest: bcs0
[227.681947] Dynamic subtest bcs0: SUCCESS (0.073s)
[227.693400] Starting dynamic subtest: vcs0
[227.757479] Dynamic subtest vcs0: SUCCESS (0.073s)
[227.770865] Starting dynamic subtest: vcs1
[227.828688] Dynamic subtest vcs1: SUCCESS (0.069s)
[227.840261] Starting dynamic subtest: vecs0
[227.899921] Dynamic subtest vecs0: SUCCESS (0.069s)
[227.900873] Subtest reorder-wide: SUCCESS (0.366s)
[228.101058] [024/132] (809s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[228.192961] Starting subtest: fbc-indfb-scaledprimary
[231.024100] Subtest fbc-indfb-scaledprimary: SUCCESS (2.834s)
[231.176334] [025/132] (806s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[231.268005] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[231.269349] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[231.390162] [026/132] (806s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[231.475209] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[231.475906] Starting dynamic subtest: pipe-A-HDMI-A-1
[231.478563] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[231.485572] Starting dynamic subtest: pipe-B-HDMI-A-1
[231.488236] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[231.495199] Starting dynamic subtest: pipe-C-HDMI-A-1
[231.497914] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[231.504709] Starting dynamic subtest: pipe-D-HDMI-A-1
[231.507437] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[231.508803] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.007s)
[231.716785] [027/132] (805s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[231.806839] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[231.852289] [028/132] (805s left) kms_cursor_crc (cursor-random-64x21)
[231.939518] Starting subtest: cursor-random-64x21
[231.944556] Starting dynamic subtest: pipe-A-HDMI-A-1
[233.858063] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.913s)
[233.896957] Starting dynamic subtest: pipe-D-HDMI-A-1
[235.776467] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.887s)
[235.777212] Subtest cursor-random-64x21: SUCCESS (3.836s)
[235.934944] [029/132] (801s left) prime_mmap (test_dup)
[235.970428] Starting subtest: test_dup
[235.971110] Starting dynamic subtest: test_dup-smem
[235.971763] Dynamic subtest test_dup-smem: SUCCESS (0.002s)
[235.972438] Subtest test_dup: SUCCESS (0.003s)
[236.088636] [030/132] (801s left) gem_exec_schedule (u-submit-late-slice)
[236.133160] Starting subtest: u-submit-late-slice
[236.133862] Starting dynamic subtest: rcs0
[236.159348] Dynamic subtest rcs0: SUCCESS (0.026s)
[236.168898] Starting dynamic subtest: bcs0
[236.190657] Dynamic subtest bcs0: SUCCESS (0.030s)
[236.199530] Starting dynamic subtest: vcs0
[236.219481] Dynamic subtest vcs0: SUCCESS (0.028s)
[236.227975] Starting dynamic subtest: vcs1
[236.246411] Dynamic subtest vcs1: SUCCESS (0.026s)
[236.253823] Starting dynamic subtest: vecs0
[236.273380] Dynamic subtest vecs0: SUCCESS (0.026s)
[236.274187] Subtest u-submit-late-slice: SUCCESS (0.141s)
[236.595985] [031/132] (801s left) syncobj_timeline (etime-multi-wait-all-submitted)
[236.629583] Starting subtest: etime-multi-wait-all-submitted
[236.738048] Subtest etime-multi-wait-all-submitted: SUCCESS (0.108s)
[236.830739] [032/132] (800s left) fbdev (write)
[236.865547] Starting subtest: write
[237.321531] Subtest write: SUCCESS (0.447s)
[237.391890] [033/132] (800s left) syncobj_wait (invalid-signal-zero-handles)
[237.423894] Starting subtest: invalid-signal-zero-handles
[237.424575] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[237.512541] [034/132] (800s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[237.603103] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[237.604511] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[237.714670] [035/132] (800s left) gem_exec_balancer (sliced)
[237.757132] Starting subtest: sliced
[239.173418] Subtest sliced: SUCCESS (1.408s)
[239.366160] [036/132] (798s left) gem_ccs (large-ctrl-surf-copy)
[239.403089] Starting subtest: large-ctrl-surf-copy
[239.404443] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[239.486419] [037/132] (798s left) gem_fenced_exec_thrash (2-spare-fences)
[239.521434] Starting subtest: 2-spare-fences
[241.676267] Subtest 2-spare-fences: SUCCESS (2.154s)
[241.814919] [038/132] (796s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[241.903237] Starting subtest: basic-busy-flip-before-cursor-varying-size
[241.904683] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[241.982738] [039/132] (796s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[242.076862] Starting subtest: 4-tiled-8bpp-rotate-0
[242.078229] Subtest 4-tiled-8bpp-rotate-0: SKIP (0.000s)
[242.203839] [040/132] (795s left) gem_mmap_wc (copy)
[242.236825] Starting subtest: copy
[242.340824] Subtest copy: SUCCESS (0.105s)
[242.430743] [041/132] (795s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[242.515387] Starting subtest: cursor-vs-flip-toggle
[274.264287] Subtest cursor-vs-flip-toggle: SUCCESS (31.756s)
[274.421106] [042/132] (763s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[274.524271] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[274.525664] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[274.622593] [043/132] (763s left) kms_addfb_basic (unused-handle)
[274.655449] Starting subtest: unused-handle
[274.656145] Subtest unused-handle: SUCCESS (0.000s)
[274.835101] [044/132] (763s left) gem_ctx_shared (q-smoketest-all)
[274.876897] Starting subtest: Q-smoketest-all
[307.153994] Subtest Q-smoketest-all: SUCCESS (32.266s)
[307.344988] [045/132] (730s left) kms_flip (2x-flip-vs-expired-vblank)
[307.435800] Starting subtest: 2x-flip-vs-expired-vblank
[307.444839] Subtest 2x-flip-vs-expired-vblank: SKIP (0.009s)
[307.542730] [046/132] (730s left) kms_force_connector_basic (force-edid)
[307.679920] Starting subtest: force-edid
[307.814836] Subtest force-edid: SUCCESS (0.149s)
[307.987794] [047/132] (730s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[308.086075] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[308.745298] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.659s)
[308.912580] [048/132] (729s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[308.997375] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[308.998056] Starting dynamic subtest: pipe-A
[309.120510] Dynamic subtest pipe-A: SUCCESS (0.123s)
[309.129179] Starting dynamic subtest: pipe-B
[309.253479] Dynamic subtest pipe-B: SUCCESS (0.132s)
[309.261751] Starting dynamic subtest: pipe-C
[309.378184] Dynamic subtest pipe-C: SUCCESS (0.124s)
[309.386474] Starting dynamic subtest: pipe-D
[309.513511] Dynamic subtest pipe-D: SUCCESS (0.134s)
[309.514275] Subtest planes-unity-scaling-downscale-factor-0-5: SUCCESS (0.517s)
[309.717427] [049/132] (728s left) kms_chamelium_audio (hdmi-audio)
[309.869446] Subtest hdmi-audio: SKIP (0.000s)
[309.944469] [050/132] (728s left) gem_set_tiling_vs_gtt
[310.417970] [051/132] (728s left) gem_lmem_swapping (massive)
[310.453536] Subtest massive: SKIP (0.000s)
[310.496910] [052/132] (728s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[310.585624] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[310.586974] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[310.720931] [053/132] (727s left) prime_busy (after)
[310.757665] Starting subtest: after
[310.762570] Starting dynamic subtest: rcs0
[310.792937] Dynamic subtest rcs0: SUCCESS (0.030s)
[310.803408] Starting dynamic subtest: bcs0
[310.807482] Dynamic subtest bcs0: SUCCESS (0.013s)
[310.815618] Starting dynamic subtest: vcs0
[310.827587] Dynamic subtest vcs0: SUCCESS (0.019s)
[310.837351] Starting dynamic subtest: vcs1
[310.841194] Dynamic subtest vcs1: SUCCESS (0.012s)
[310.849174] Starting dynamic subtest: vecs0
[310.859376] Dynamic subtest vecs0: SUCCESS (0.017s)
[310.966594] Subtest after: SUCCESS (0.209s)
[311.057200] [054/132] (727s left) syncobj_wait (invalid-signal-illegal-handle)
[311.090139] Starting subtest: invalid-signal-illegal-handle
[311.090861] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[311.172675] [055/132] (727s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[311.258340] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[311.259020] Starting dynamic subtest: pipe-A-valid-mode
[311.310996] Dynamic subtest pipe-A-valid-mode: SKIP (0.051s)
[311.312341] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.053s)
[311.441521] [056/132] (727s left) gem_gtt_cpu_tlb
[311.589369] [057/132] (727s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[311.680010] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[311.681362] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[311.807879] [058/132] (727s left) gen9_exec_parse (batch-zero-length)
[311.843393] Subtest batch-zero-length: SKIP (0.000s)
[311.887608] [059/132] (726s left) gem_softpin (evict-snoop-interruptible)
[311.925772] Starting subtest: evict-snoop-interruptible
[311.927138] Subtest evict-snoop-interruptible: SKIP (0.000s)
[312.012247] [060/132] (726s left) dmabuf_sync_file (export-basic)
[312.050325] Starting subtest: export-basic
[312.051031] Subtest export-basic: SUCCESS (0.001s)
[312.129268] [061/132] (726s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[312.214461] Starting subtest: fb-8bpc-vs-panel-6bpc
[312.216249] Starting dynamic subtest: pipe-A-HDMI-A-1
[312.275973] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.060s)
[312.277377] Subtest fb-8bpc-vs-panel-6bpc: SKIP (0.062s)
[312.443657] [062/132] (726s left) syncobj_timeline (host-signal-ordered)
[312.478139] Starting subtest: host-signal-ordered
[312.478836] Subtest host-signal-ordered: SUCCESS (0.000s)
[312.571411] [063/132] (726s left) kms_chamelium_hpd (common-hpd-after-suspend)
[312.707534] Subtest common-hpd-after-suspend: SKIP (0.000s)
[312.797502] [064/132] (726s left) kms_flip (2x-flip-vs-fences)
[312.889936] Starting subtest: 2x-flip-vs-fences
[312.905629] Subtest 2x-flip-vs-fences: SKIP (0.016s)
[313.002820] [065/132] (726s left) perf (mi-rpc)
[313.091659] Starting subtest: mi-rpc
[313.093014] Subtest mi-rpc: SKIP (0.000s)
[313.135051] [066/132] (726s left) sw_sync (sync_random_merge)
[313.165305] Starting subtest: sync_random_merge
[313.223910] Subtest sync_random_merge: SUCCESS (0.058s)
[313.301731] [067/132] (725s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[313.390121] Starting subtest: psr-rgb101010-draw-pwrite
[313.391484] Subtest psr-rgb101010-draw-pwrite: SKIP (0.000s)
[313.526142] [068/132] (725s left) kms_getfb (getfb2-handle-closed)
[313.612388] Starting subtest: getfb2-handle-closed
[313.613083] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[313.733911] [069/132] (725s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[313.822224] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[313.823569] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[313.943393] [070/132] (725s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[313.975354] Starting subtest: invalid-smem-bo-on-discrete
[313.976686] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[314.151271] [071/132] (725s left) perf (gen12-invalid-class-instance)
[314.241538] Starting subtest: gen12-invalid-class-instance
[314.249680] Subtest gen12-invalid-class-instance: SUCCESS (0.008s)
[314.293898] [072/132] (725s left) gem_exec_schedule (implicit-read-write)
[314.335328] Starting subtest: implicit-read-write
[314.336103] Starting dynamic subtest: rcs0
[314.395388] Dynamic subtest rcs0: SUCCESS (0.059s)
[314.406858] Starting dynamic subtest: bcs0
[314.458520] Dynamic subtest bcs0: SUCCESS (0.060s)
[314.472653] Starting dynamic subtest: vcs0
[314.524907] Dynamic subtest vcs0: SUCCESS (0.064s)
[314.536950] Starting dynamic subtest: vcs1
[314.589653] Dynamic subtest vcs1: SUCCESS (0.063s)
[314.601131] Starting dynamic subtest: vecs0
[314.657081] Dynamic subtest vecs0: SUCCESS (0.064s)
[314.658810] Subtest implicit-read-write: SUCCESS (0.323s)
[314.977113] [073/132] (724s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[315.064341] Starting subtest: addfb25-framebuffer-vs-set-tiling
[315.065050] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[315.177024] [074/132] (724s left) kms_atomic (plane-cursor-legacy)
[315.261272] Starting subtest: plane-cursor-legacy
[315.263157] Starting dynamic subtest: pipe-A-HDMI-A-1
[315.394232] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.131s)
[315.396051] Subtest plane-cursor-legacy: SUCCESS (0.134s)
[315.549278] [075/132] (723s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[315.635458] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[315.637299] Starting dynamic subtest: pipe-A-HDMI-A-1
[315.643380] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[315.650568] Starting dynamic subtest: pipe-B-HDMI-A-1
[315.656726] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[315.663970] Starting dynamic subtest: pipe-C-HDMI-A-1
[315.670054] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[315.677096] Starting dynamic subtest: pipe-D-HDMI-A-1
[315.682853] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[315.683526] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SUCCESS (0.010s)
[315.881791] [076/132] (723s left) gem_exec_balancer (bonded-pair)
[315.925201] Starting subtest: bonded-pair
[348.465835] Subtest bonded-pair: SUCCESS (32.533s)
[348.670063] [077/132] (690s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[348.761129] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[348.762575] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[348.883410] [078/132] (690s left) gem_ctx_exec (basic-invalid-context)
[348.916683] Starting subtest: basic-invalid-context
[348.918444] Subtest basic-invalid-context: SUCCESS (0.002s)
[349.041597] [079/132] (690s left) kms_content_protection (lic-type-0-hdcp14)
[349.131311] Starting subtest: lic-type-0-hdcp14
[349.145737] Subtest lic-type-0-hdcp14: SKIP (0.012s)
[349.258064] [080/132] (690s left) gem_eio (wait-immediate)
[349.299250] Starting subtest: wait-immediate
[349.443921] Subtest wait-immediate: SUCCESS (0.144s)
[349.588793] [081/132] (690s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[349.678457] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[349.686546] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.009s)
[349.776964] [082/132] (690s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[349.862242] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[349.864039] Starting dynamic subtest: pipe-A-valid-mode
[351.064024] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.201s)
[351.064726] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SUCCESS (1.202s)
[351.210952] [083/132] (688s left) kms_psr (psr2-basic)
[351.303060] Subtest psr2-basic: SKIP (0.000s)
[351.348240] [084/132] (688s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[351.432617] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[351.434771] Starting dynamic subtest: pipe-A-HDMI-A-1
[351.441585] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[351.451211] Starting dynamic subtest: pipe-B-HDMI-A-1
[351.458058] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[351.467351] Starting dynamic subtest: pipe-C-HDMI-A-1
[351.474030] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[351.483184] Starting dynamic subtest: pipe-D-HDMI-A-1
[351.490047] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[351.491411] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.009s)
[351.689556] [085/132] (688s left) kms_vblank (query-forked-busy)
[351.775251] Starting subtest: query-forked-busy
[351.775950] Starting dynamic subtest: pipe-A-HDMI-A-1
[353.069333] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.293s)
[353.084906] Starting dynamic subtest: pipe-D-HDMI-A-1
[354.350964] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.273s)
[354.351696] Subtest query-forked-busy: SUCCESS (2.577s)
[354.510961] [086/132] (685s left) kms_pm_dc (dc9-dpms)
[355.606083] Starting subtest: dc9-dpms
[358.906498] Subtest dc9-dpms: SKIP (3.292s)
[359.012922] [087/132] (680s left) gem_userptr_blits (set-cache-level)
[359.053914] Starting subtest: set-cache-level
[359.054607] Subtest set-cache-level: SUCCESS (0.000s)
[359.192425] [088/132] (680s left) gem_exec_fence (keep-in-fence)
[359.355418] Starting subtest: keep-in-fence
[359.358249] Starting dynamic subtest: rcs0
[359.388798] Dynamic subtest rcs0: SUCCESS (0.032s)
[359.403039] Starting dynamic subtest: bcs0
[359.418658] Dynamic subtest bcs0: SUCCESS (0.028s)
[359.431824] Starting dynamic subtest: vcs0
[359.454006] Dynamic subtest vcs0: SUCCESS (0.033s)
[359.470904] Starting dynamic subtest: vcs1
[359.491891] Dynamic subtest vcs1: SUCCESS (0.036s)
[359.507963] Starting dynamic subtest: vecs0
[359.527783] Dynamic subtest vecs0: SUCCESS (0.033s)
[359.529093] Subtest keep-in-fence: SUCCESS (0.174s)
[360.021299] [089/132] (680s left) kms_pm_rpm (modeset-pc8-residency-stress)
[361.421695] Starting subtest: modeset-pc8-residency-stress
[361.423453] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[361.617908] [090/132] (678s left) kms_psr (fbc-psr2-sprite-plane-move)
[361.704862] Subtest fbc-psr2-sprite-plane-move: SKIP (0.000s)
[361.746741] [091/132] (678s left) gem_exec_create (forked)
[361.787477] Starting subtest: forked
[361.788216] Starting dynamic subtest: smem
[381.874578] Dynamic subtest smem: SUCCESS (20.091s)
[381.875270] Subtest forked: SUCCESS (20.092s)
[382.072708] [092/132] (658s left) kms_psr (pr-cursor-mmap-cpu)
[382.165827] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[382.211142] [093/132] (657s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[382.301216] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[382.302619] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[382.430357] [094/132] (657s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[382.520656] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[382.562317] [095/132] (657s left) gem_exec_reloc (basic-wc-read)
[382.600080] Starting subtest: basic-wc-read
[382.604548] Subtest basic-wc-read: SUCCESS (0.005s)
[382.737065] [096/132] (657s left) kms_psr (psr-cursor-plane-move)
[382.822330] Subtest psr-cursor-plane-move: SKIP (0.000s)
[382.862059] [097/132] (657s left) kms_flip (basic-plain-flip)
[382.946970] Starting subtest: basic-plain-flip
[382.949501] Starting dynamic subtest: A-HDMI-A1
[383.622425] Dynamic subtest A-HDMI-A1: SUCCESS (0.673s)
[383.640887] Starting dynamic subtest: B-HDMI-A1
[384.293246] Dynamic subtest B-HDMI-A1: SUCCESS (0.665s)
[384.306475] Starting dynamic subtest: C-HDMI-A1
[384.950288] Dynamic subtest C-HDMI-A1: SUCCESS (0.654s)
[384.960713] Starting dynamic subtest: D-HDMI-A1
[385.619201] Dynamic subtest D-HDMI-A1: SUCCESS (0.664s)
[385.620129] Subtest basic-plain-flip: SUCCESS (2.674s)
[385.787384] [098/132] (654s left) kms_flip (plain-flip-fb-recreate)
[385.877837] Starting subtest: plain-flip-fb-recreate
[385.879895] Starting dynamic subtest: A-HDMI-A1
[393.695029] Dynamic subtest A-HDMI-A1: SUCCESS (7.817s)
[393.712068] Starting dynamic subtest: B-HDMI-A1
[401.498693] Dynamic subtest B-HDMI-A1: SUCCESS (7.803s)
[401.515467] Starting dynamic subtest: C-HDMI-A1
[409.305824] Dynamic subtest C-HDMI-A1: SUCCESS (7.806s)
[409.324454] Starting dynamic subtest: D-HDMI-A1
[417.121434] Dynamic subtest D-HDMI-A1: SUCCESS (7.814s)
[417.126689] Subtest plain-flip-fb-recreate: SUCCESS (31.258s)
[417.291355] [099/132] (623s left) i915_suspend (debugfs-reader)
[417.324028] Starting subtest: debugfs-reader
[436.298053] Subtest debugfs-reader: SUCCESS (3.209s)
[444.375641] [100/132] (604s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[444.469121] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[444.470534] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[444.586442] [101/132] (603s left) gem_exec_nop (basic-sequential)
[444.627056] Starting subtest: basic-sequential
[447.985864] Subtest basic-sequential: SUCCESS (3.359s)
[448.227653] [102/132] (600s left) gem_pxp (create-regular-buffer)
[448.328372] Starting subtest: create-regular-buffer
[448.329368] Subtest create-regular-buffer: SUCCESS (0.000s)
[448.443106] [103/132] (600s left) syncobj_basic (test-valid-cycle)
[448.475405] Starting subtest: test-valid-cycle
[448.476141] Subtest test-valid-cycle: SUCCESS (0.000s)
[448.562802] [104/132] (600s left) gem_exec_suspend (basic-s3-devices)
[448.600524] Starting subtest: basic-S3-devices
[448.601206] Starting dynamic subtest: smem
[455.428173] Dynamic subtest smem: SUCCESS (6.974s)
[455.428863] Subtest basic-S3-devices: SUCCESS (6.975s)
[464.649357] [105/132] (593s left) template (a)
[464.683673] Starting subtest: A
[464.684374] Subtest A: SUCCESS (0.000s)
[464.762008] [106/132] (593s left) gem_mmap_gtt (bad-object)
[464.793567] Starting subtest: bad-object
[464.794260] Subtest bad-object: SUCCESS (0.000s)
[464.920935] [107/132] (592s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[465.011794] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[465.013138] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[465.128164] [108/132] (592s left) api_intel_bb (intel-bb-blit-y)
[465.161214] Starting subtest: intel-bb-blit-y
[468.371586] Subtest intel-bb-blit-y: SUCCESS (3.181s)
[468.486591] [109/132] (589s left) kms_selftest (drm_format_helper)
[468.522320] Starting subtest: drm_format_helper
[468.539540] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[468.633181] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.091s)
[468.644767] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[468.720665] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.087s)
[468.739846] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[468.818023] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.093s)
[468.836313] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[468.901112] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.081s)
[468.918536] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[469.003879] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.100s)
[469.019501] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[469.099681] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.092s)
[469.115546] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[469.191643] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.089s)
[469.206163] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[469.277697] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.083s)
[469.295410] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[469.367406] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.088s)
[469.386016] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[469.457776] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.087s)
[469.475258] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[469.549080] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.088s)
[469.566031] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[469.632466] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.081s)
[469.650722] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[469.737943] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.101s)
[469.755511] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[469.844549] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.103s)
[469.861733] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[469.942265] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.096s)
[469.962181] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[470.027669] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.080s)
[470.038953] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[470.123519] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.095s)
[470.126490] Subtest drm_format_helper: SUCCESS (1.604s)
[470.306148] [110/132] (587s left) gem_mmap_offset (oob-read)
[470.337022] Starting subtest: oob-read
[470.337712] Subtest oob-read: SUCCESS (0.001s)
[470.438526] [111/132] (587s left) gem_spin_batch (resubmit-all)
[470.479825] Starting subtest: resubmit-all
[470.480532] Starting dynamic subtest: rcs0
[470.484390] Dynamic subtest rcs0: SUCCESS (0.004s)
[470.494329] Starting dynamic subtest: bcs0
[470.495080] Dynamic subtest bcs0: SUCCESS (0.002s)
[470.502803] Starting dynamic subtest: vcs0
[470.503488] Dynamic subtest vcs0: SUCCESS (0.002s)
[470.510549] Starting dynamic subtest: vcs1
[470.511221] Dynamic subtest vcs1: SUCCESS (0.002s)
[470.518516] Starting dynamic subtest: vecs0
[470.519186] Dynamic subtest vecs0: SUCCESS (0.002s)
[470.519844] Subtest resubmit-all: SUCCESS (0.016s)
[470.697928] [112/132] (587s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[470.783166] Starting subtest: cursorB-vs-flipA-toggle
[470.785728] Subtest cursorB-vs-flipA-toggle: SKIP (0.002s)
[470.865056] [113/132] (587s left) gen9_exec_parse (valid-registers)
[470.900532] Subtest valid-registers: SKIP (0.000s)
[470.944076] [114/132] (587s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[471.027227] Starting subtest: disable-crc-after-crtc
[471.028979] Starting dynamic subtest: pipe-A-HDMI-A-1
[471.385412] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.356s)
[471.394660] Starting dynamic subtest: pipe-B-HDMI-A-1
[471.684029] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.297s)
[471.693279] Starting dynamic subtest: pipe-C-HDMI-A-1
[472.001025] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.316s)
[472.010978] Starting dynamic subtest: pipe-D-HDMI-A-1
[472.335191] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.331s)
[472.335993] Subtest disable-crc-after-crtc: SUCCESS (1.309s)
[472.483191] [115/132] (585s left) gem_exec_fence (syncobj-unused-fence)
[472.810853] Starting subtest: syncobj-unused-fence
[472.813551] Subtest syncobj-unused-fence: SUCCESS (0.003s)
[473.128166] [116/132] (585s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[473.217251] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[473.218668] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[473.350161] [117/132] (584s left) gem_set_tiling_vs_pwrite
[473.507600] [118/132] (584s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[473.595989] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[473.597314] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[473.724955] [119/132] (584s left) vgem_basic (busy-fence)
[473.757780] Starting subtest: busy-fence
[473.758500] Subtest busy-fence: SUCCESS (0.000s)
[473.837639] [120/132] (584s left) i915_pm_rpm (debugfs-read)
[475.226707] Starting subtest: debugfs-read
[476.428026] Subtest debugfs-read: SUCCESS (1.202s)
[476.610008] [121/132] (581s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[476.699036] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[478.154161] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (1.456s)
[478.311940] [122/132] (580s left) perf_pmu (busy-start)
[478.349080] Starting subtest: busy-start
[478.349779] Starting dynamic subtest: rcs0
[480.892018] Dynamic subtest rcs0: SUCCESS (2.522s)
[480.902706] Starting dynamic subtest: bcs0
[483.413863] Dynamic subtest bcs0: SUCCESS (2.525s)
[483.424416] Starting dynamic subtest: vcs0
[485.939139] Dynamic subtest vcs0: SUCCESS (2.519s)
[485.949604] Starting dynamic subtest: vcs1
[488.458054] Dynamic subtest vcs1: SUCCESS (2.525s)
[488.468897] Starting dynamic subtest: vecs0
[490.983580] Dynamic subtest vecs0: SUCCESS (2.521s)
[490.984496] Subtest busy-start: SUCCESS (12.622s)
[491.049044] [123/132] (567s left) kms_addfb_basic (size-max)
[491.137833] Starting subtest: size-max
[491.138595] Subtest size-max: SUCCESS (0.000s)
[491.272042] [124/132] (567s left) kms_psr (fbc-pr-primary-blt)
[491.356080] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[491.402603] [125/132] (567s left) kms_color_pipeline (plane-ctm3x4)
[491.488267] Starting subtest: plane-ctm3x4
[491.505273] Starting dynamic subtest: pipe-A-HDMI-A-1
[491.645631] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.141s)
[491.811102] Starting dynamic subtest: pipe-B-HDMI-A-1
[491.950615] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.147s)
[492.071970] Starting dynamic subtest: pipe-C-HDMI-A-1
[492.196445] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.131s)
[492.356133] Starting dynamic subtest: pipe-D-HDMI-A-1
[492.480483] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.131s)
[492.545083] Subtest plane-ctm3x4: SUCCESS (1.057s)
[492.666589] [126/132] (565s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[492.807354] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[492.894617] [127/132] (565s left) api_intel_allocator (standalone)
[492.930678] Starting subtest: standalone
[492.948552] Subtest standalone: SUCCESS (0.018s)
[493.060799] [128/132] (565s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[493.148200] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[493.149617] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[493.251690] [129/132] (565s left) kms_big_fb (y-tiled-addfb)
[493.344242] Starting subtest: y-tiled-addfb
[493.344938] Subtest y-tiled-addfb: SUCCESS (0.000s)
[493.468456] [130/132] (565s left) kms_prime (basic-crc-vgem)
[493.564527] Starting subtest: basic-crc-vgem
[493.565202] Starting dynamic subtest: second-to-first
[494.217944] Dynamic subtest second-to-first: SUCCESS (0.654s)
[494.219149] Subtest basic-crc-vgem: SUCCESS (0.655s)
[494.337153] [131/132] (564s left) i915_hangman (engine-error-state-capture)
[494.379812] Starting subtest: engine-error-state-capture
[494.380541] Starting dynamic subtest: rcs0
[498.666413] Dynamic subtest rcs0: SUCCESS (4.287s)
[498.679112] Starting dynamic subtest: bcs0
[502.686890] Dynamic subtest bcs0: SUCCESS (4.019s)
[502.699668] Starting dynamic subtest: vcs0
[506.680234] Dynamic subtest vcs0: SUCCESS (3.992s)
[506.701254] Starting dynamic subtest: vcs1
[510.705314] Dynamic subtest vcs1: SUCCESS (4.023s)
[510.719253] Starting dynamic subtest: vecs0
[514.672160] Dynamic subtest vecs0: SUCCESS (3.965s)
[514.673318] Subtest engine-error-state-capture: SUCCESS (20.298s)
[514.813496] [132/132] (544s left) kms_invalid_mode (bad-vsync-end)
[514.900270] Starting subtest: bad-vsync-end
[514.901081] Starting dynamic subtest: pipe-A-HDMI-A-1
[514.948597] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.047s)
[514.960543] Starting dynamic subtest: pipe-B-HDMI-A-1
[514.961273] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[514.971139] Starting dynamic subtest: pipe-C-HDMI-A-1
[514.971810] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[514.979512] Starting dynamic subtest: pipe-D-HDMI-A-1
[514.980276] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[514.980958] Subtest bad-vsync-end: SUCCESS (0.057s)
[515.116329] 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.