[62.322609] Initializing watchdogs
[62.322657]   /dev/watchdog0
[62.338274] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[62.342923] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.345185] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.348688] [001/133] (960s left) kms_psr (fbc-pr-cursor-plane-onoff)
[62.462923] Starting subtest: fbc-pr-cursor-plane-onoff
[62.467076] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[62.543809] [002/133] (960s left) gem_exec_schedule (preempt-self)
[62.619032] Starting subtest: preempt-self
[62.621320] Starting dynamic subtest: rcs0
[62.638584] Dynamic subtest rcs0: SUCCESS (0.022s)
[62.646204] Starting dynamic subtest: bcs0
[62.654849] Dynamic subtest bcs0: SUCCESS (0.016s)
[62.661914] Starting dynamic subtest: vcs0
[62.677080] Dynamic subtest vcs0: SUCCESS (0.022s)
[62.683736] Starting dynamic subtest: vcs1
[62.691950] Dynamic subtest vcs1: SUCCESS (0.015s)
[62.698809] Starting dynamic subtest: vecs0
[62.710068] Dynamic subtest vecs0: SUCCESS (0.018s)
[62.717061] Starting dynamic subtest: ccs0
[62.733650] Dynamic subtest ccs0: SUCCESS (0.023s)
[62.736479] Subtest preempt-self: SUCCESS (0.117s)
[63.968582] [003/133] (958s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[64.075407] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[64.079816] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[64.164934] [004/133] (958s left) kms_color_pipeline (plane-ctm3x4)
[64.272492] Starting subtest: plane-ctm3x4
[64.440104] Starting dynamic subtest: pipe-A-plane-0
[64.774052] Dynamic subtest pipe-A-plane-0: FAIL (0.161s)
[64.782391] Starting dynamic subtest: pipe-A-plane-1
[64.982921] Dynamic subtest pipe-A-plane-1: FAIL (0.147s)
[64.991935] Starting dynamic subtest: pipe-A-plane-2
[65.203303] Dynamic subtest pipe-A-plane-2: FAIL (0.155s)
[66.162195] Starting dynamic subtest: pipe-B-plane-0
[66.566802] Dynamic subtest pipe-B-plane-0: FAIL (0.141s)
[66.576104] Starting dynamic subtest: pipe-B-plane-1
[66.877228] Dynamic subtest pipe-B-plane-1: FAIL (0.147s)
[66.885060] Starting dynamic subtest: pipe-B-plane-2
[67.190854] Dynamic subtest pipe-B-plane-2: FAIL (0.155s)
[67.798723] Starting dynamic subtest: pipe-C-plane-0
[68.264279] Dynamic subtest pipe-C-plane-0: FAIL (0.108s)
[68.273069] Starting dynamic subtest: pipe-C-plane-1
[68.664430] Dynamic subtest pipe-C-plane-1: FAIL (0.146s)
[68.673799] Starting dynamic subtest: pipe-C-plane-2
[69.022301] Dynamic subtest pipe-C-plane-2: FAIL (0.604s)
[69.807344] Starting dynamic subtest: pipe-D-plane-0
[70.352223] Dynamic subtest pipe-D-plane-0: FAIL (0.108s)
[70.360176] Starting dynamic subtest: pipe-D-plane-1
[70.822696] Dynamic subtest pipe-D-plane-1: FAIL (0.596s)
[70.831594] Starting dynamic subtest: pipe-D-plane-2
[71.239609] Dynamic subtest pipe-D-plane-2: FAIL (0.548s)
[71.352068] Subtest plane-ctm3x4: FAIL (7.079s)
[72.186875] [005/133] (950s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[72.286478] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[79.407918] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.124s)
[79.516314] [006/133] (943s left) perf_pmu (busy-idle-check-all)
[79.556452] Starting subtest: busy-idle-check-all
[79.558803] Starting dynamic subtest: rcs0
[80.218866] Dynamic subtest rcs0: SUCCESS (0.662s)
[80.228323] Starting dynamic subtest: bcs0
[80.871151] Dynamic subtest bcs0: SUCCESS (0.651s)
[80.879719] Starting dynamic subtest: vcs0
[82.902086] Dynamic subtest vcs0: SUCCESS (2.028s)
[82.912659] Starting dynamic subtest: vcs1
[84.886046] Dynamic subtest vcs1: SUCCESS (1.982s)
[84.901025] Starting dynamic subtest: vecs0
[86.934024] Dynamic subtest vecs0: SUCCESS (2.047s)
[86.944660] Starting dynamic subtest: ccs0
[87.589249] Dynamic subtest ccs0: SUCCESS (0.655s)
[87.591709] Subtest busy-idle-check-all: SUCCESS (8.033s)
[87.701929] [007/133] (935s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[87.802747] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[87.804953] Starting dynamic subtest: pipe-A
[87.866398] Dynamic subtest pipe-A: SUCCESS (0.065s)
[87.875583] Starting dynamic subtest: pipe-B
[89.022093] Dynamic subtest pipe-B: SUCCESS (1.155s)
[89.032227] Starting dynamic subtest: pipe-C
[90.130941] Dynamic subtest pipe-C: SUCCESS (1.108s)
[90.139867] Starting dynamic subtest: pipe-D
[91.266411] Dynamic subtest pipe-D: SUCCESS (1.135s)
[91.268828] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.466s)
[92.428462] [008/133] (930s left) gem_basic (bad-close)
[92.477861] Starting subtest: bad-close
[92.482466] Subtest bad-close: SUCCESS (0.000s)
[92.564023] [009/133] (930s left) syncobj_basic (test-valid-cycle)
[92.612066] Starting subtest: test-valid-cycle
[92.614087] Subtest test-valid-cycle: SUCCESS (0.000s)
[92.692586] [010/133] (930s left) gen9_exec_parse (unaligned-jump)
[92.763540] Subtest unaligned-jump: SKIP (0.000s)
[92.815546] [011/133] (930s left) drm_buddy (drm_buddy)
[92.851099] Starting subtest: drm_buddy
[92.855639] Subtest drm_buddy: SKIP (0.001s)
[92.905515] [012/133] (930s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[92.997638] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[94.198628] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.201s)
[94.354754] [013/133] (928s left) gen9_exec_parse (bb-chained)
[94.421468] Subtest bb-chained: SKIP (0.000s)
[94.481237] [014/133] (928s left) gem_gtt_cpu_tlb
[94.595714] [015/133] (928s left) syncobj_timeline (transfer-timeline-point)
[94.660246] Starting subtest: transfer-timeline-point
[94.662299] Subtest transfer-timeline-point: SUCCESS (0.001s)
[94.758337] [016/133] (928s left) gem_ctx_shared (exec-single-timeline)
[94.822285] Starting subtest: exec-single-timeline
[94.824164] Starting dynamic subtest: rcs0
[95.858060] Dynamic subtest rcs0: SUCCESS (1.033s)
[95.868753] Starting dynamic subtest: bcs0
[96.881280] Dynamic subtest bcs0: SUCCESS (1.023s)
[96.891903] Starting dynamic subtest: vcs0
[97.972700] Dynamic subtest vcs0: SUCCESS (1.089s)
[97.983771] Starting dynamic subtest: vcs1
[99.060476] Dynamic subtest vcs1: SUCCESS (1.084s)
[99.071399] Starting dynamic subtest: vecs0
[100.147077] Dynamic subtest vecs0: SUCCESS (1.086s)
[100.158266] Starting dynamic subtest: ccs0
[101.235235] Dynamic subtest ccs0: SUCCESS (1.086s)
[101.238082] Subtest exec-single-timeline: SUCCESS (6.411s)
[101.910143] [017/133] (921s left) kms_chamelium_color (ctm-0-75)
[102.018336] Subtest ctm-0-75: SKIP (0.000s)
[102.060991] [018/133] (921s left) gem_pxp (create-regular-buffer)
[102.190286] Starting subtest: create-regular-buffer
[102.192834] Subtest create-regular-buffer: SUCCESS (0.000s)
[102.295386] [019/133] (921s left) kms_force_connector_basic (prune-stale-modes)
[102.373121] Starting subtest: prune-stale-modes
[102.815358] Subtest prune-stale-modes: SUCCESS (0.442s)
[102.949127] [020/133] (920s left) kms_chamelium_hpd (dp-hpd)
[103.339896] Subtest dp-hpd: SKIP (0.000s)
[104.140591] [021/133] (919s left) gem_render_copy (yf-tiled-to-vebox-linear)
[104.204144] Starting subtest: yf-tiled-to-vebox-linear
[104.208780] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[104.387543] [022/133] (919s left) kms_psr (psr-sprite-blt)
[104.500148] Starting subtest: psr-sprite-blt
[104.502554] Starting dynamic subtest: eDP-1
[106.284393] Dynamic subtest eDP-1: SUCCESS (1.785s)
[106.286685] Subtest psr-sprite-blt: SUCCESS (1.786s)
[107.122684] [023/133] (916s left) perf (non-system-wide-paranoid)
[107.257236] Starting subtest: non-system-wide-paranoid
[107.282857] Subtest non-system-wide-paranoid: SUCCESS (0.026s)
[107.331573] [024/133] (916s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[107.431919] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[107.434453] Starting dynamic subtest: pipe-A-eDP-1
[107.457107] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[107.467269] Starting dynamic subtest: pipe-B-eDP-1
[107.487403] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[107.494734] Starting dynamic subtest: pipe-C-eDP-1
[107.514920] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[107.522218] Starting dynamic subtest: pipe-D-eDP-1
[107.542669] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[107.546742] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[109.676559] [025/133] (914s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[109.725571] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[109.833788] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.106s)
[109.907456] [026/133] (913s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k)
[110.294240] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s)
[111.089113] [027/133] (912s left) kms_panel_fitting (legacy)
[111.176560] Starting subtest: legacy
[111.178942] Starting dynamic subtest: pipe-A-eDP-1
[111.717488] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.543s)
[111.744716] Starting dynamic subtest: pipe-B-eDP-1
[113.282825] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.545s)
[113.308345] Starting dynamic subtest: pipe-C-eDP-1
[114.807071] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.505s)
[114.833428] Starting dynamic subtest: pipe-D-eDP-1
[116.323593] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.497s)
[116.325921] Subtest legacy: SUCCESS (5.149s)
[117.555149] [028/133] (906s left) api_intel_allocator (reserve-simple)
[117.609779] Starting subtest: reserve-simple
[117.612089] Subtest reserve-simple: SUCCESS (0.003s)
[117.727127] [029/133] (906s left) gem_exec_balancer (hog)
[117.787889] Starting subtest: hog
[117.792599] Subtest hog: SKIP (0.000s)
[118.092340] [030/133] (905s left) kms_flip (2x-dpms-vs-vblank-race)
[118.188584] Starting subtest: 2x-dpms-vs-vblank-race
[118.199814] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s)
[118.289738] [031/133] (905s left) gem_exec_schedule (pi-userfault)
[118.482598] Starting subtest: pi-userfault
[118.484655] Starting dynamic subtest: rcs0
[118.494044] Dynamic subtest rcs0: SUCCESS (0.013s)
[118.508806] Starting dynamic subtest: bcs0
[118.511015] Dynamic subtest bcs0: SUCCESS (0.012s)
[118.519185] Starting dynamic subtest: vcs0
[118.521055] Dynamic subtest vcs0: SUCCESS (0.008s)
[118.529366] Starting dynamic subtest: vcs1
[118.531618] Dynamic subtest vcs1: SUCCESS (0.008s)
[118.539920] Starting dynamic subtest: vecs0
[118.542341] Dynamic subtest vecs0: SUCCESS (0.007s)
[118.550141] Starting dynamic subtest: ccs0
[118.552275] Dynamic subtest ccs0: SUCCESS (0.008s)
[118.554446] Subtest pi-userfault: SUCCESS (0.060s)
[118.721310] [032/133] (905s left) kms_frontbuffer_tracking (fbc-tiling-y)
[118.832702] Starting subtest: fbc-tiling-y
[118.836890] Subtest fbc-tiling-y: SKIP (0.000s)
[118.918080] [033/133] (905s left) kms_vblank (wait-busy-hang)
[119.018326] Starting subtest: wait-busy-hang
[119.020259] Starting dynamic subtest: pipe-A-eDP-1
[145.686761] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.667s)
[145.701688] Starting dynamic subtest: pipe-D-eDP-1
[160.712811] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.022s)
[160.715160] Subtest wait-busy-hang: SUCCESS (41.692s)
[161.503815] [034/133] (862s left) gem_lmem_swapping (heavy-verify-random-ccs)
[161.548871] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[161.592530] [035/133] (862s left) gem_create (create-ext-cpu-access-big)
[161.754325] Starting subtest: create-ext-cpu-access-big
[161.759515] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[161.837858] [036/133] (862s left) kms_async_flips (invalid-async-flip)
[161.933213] Starting subtest: invalid-async-flip
[162.317792] Starting dynamic subtest: pipe-A-eDP-1
[163.136616] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.819s)
[163.503350] Starting dynamic subtest: pipe-B-eDP-1
[164.273552] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.784s)
[164.629365] Starting dynamic subtest: pipe-C-eDP-1
[165.398188] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.775s)
[165.750568] Starting dynamic subtest: pipe-D-eDP-1
[166.522315] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.779s)
[166.524729] Subtest invalid-async-flip: SUCCESS (4.591s)
[167.668176] [037/133] (856s left) gem_userptr_blits (huge-split)
[167.729683] Starting subtest: huge-split
[167.737225] Subtest huge-split: SUCCESS (0.007s)
[167.850912] [038/133] (856s left) kms_pm_dc (dc5-psr)
[168.949655] Starting subtest: dc5-psr
[171.830971] Subtest dc5-psr: SUCCESS (2.880s)
[172.708821] [039/133] (851s left) prime_mmap (test_forked_cpu_write)
[172.758337] Starting subtest: test_forked_cpu_write
[172.760352] Starting dynamic subtest: test_forked_cpu_write-smem
[172.765081] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.008s)
[172.767482] Subtest test_forked_cpu_write: SUCCESS (0.009s)
[172.860410] [040/133] (851s left) kms_invalid_mode (zero-vdisplay)
[172.950153] Starting subtest: zero-vdisplay
[172.952337] Starting dynamic subtest: pipe-A-eDP-1
[173.249727] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.297s)
[173.258822] Starting dynamic subtest: pipe-B-eDP-1
[173.260891] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[173.268219] Starting dynamic subtest: pipe-C-eDP-1
[173.270641] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[173.278390] Starting dynamic subtest: pipe-D-eDP-1
[173.281070] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[173.283759] Subtest zero-vdisplay: SUCCESS (0.302s)
[174.059316] [041/133] (850s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[174.178368] Starting subtest: basic-busy-flip-before-cursor-legacy
[174.182915] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[174.320304] [042/133] (850s left) gem_eio (in-flight-contexts-1us)
[174.525926] Starting subtest: in-flight-contexts-1us
[184.943624] Subtest in-flight-contexts-1us: SUCCESS (10.416s)
[185.107219] [043/133] (839s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[185.208693] Starting subtest: 4-tiled-32bpp-rotate-270
[185.229564] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.020s)
[185.328829] [044/133] (839s left) perf (invalid-oa-format-id)
[185.410212] Starting subtest: invalid-oa-format-id
[185.419411] Subtest invalid-oa-format-id: SUCCESS (0.007s)
[185.462529] [045/133] (839s left) tools_test (tools_test)
[185.515304] Starting subtest: tools_test
[185.569989] Subtest tools_test: SUCCESS (0.071s)
[185.641086] [046/133] (838s left) prime_mmap (test_refcounting)
[185.694056] Starting subtest: test_refcounting
[185.696382] Starting dynamic subtest: test_refcounting-smem
[185.726787] Dynamic subtest test_refcounting-smem: SUCCESS (0.034s)
[185.729100] Subtest test_refcounting: SUCCESS (0.035s)
[185.830939] [047/133] (838s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[185.928038] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[190.024453] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.097s)
[191.180622] [048/133] (833s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[191.269643] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[191.273926] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[191.365167] [049/133] (833s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[191.411282] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[191.482164] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.005s)
[191.520806] [050/133] (833s left) kms_sequence (get-forked)
[191.613474] Starting subtest: get-forked
[191.615647] Starting dynamic subtest: pipe-A-eDP-1
[193.533325] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.916s)
[193.543098] Starting dynamic subtest: pipe-B-eDP-1
[196.127037] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.594s)
[196.136269] Starting dynamic subtest: pipe-C-eDP-1
[198.646958] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.519s)
[198.657793] Starting dynamic subtest: pipe-D-eDP-1
[201.168869] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.523s)
[201.171258] Subtest get-forked: SUCCESS (9.557s)
[202.001011] [051/133] (822s left) kms_flip (2x-flip-vs-suspend)
[202.098232] Starting subtest: 2x-flip-vs-suspend
[202.107902] Subtest 2x-flip-vs-suspend: SKIP (0.011s)
[202.186372] [052/133] (822s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[202.279711] Starting subtest: fbcpsr-rgb565-draw-blt
[209.434109] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.157s)
[209.591286] [053/133] (815s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[209.688383] Starting subtest: yf-tiled-64bpp-rotate-90
[209.692468] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[209.791576] [054/133] (815s left) gem_mmap_gtt (hang-user)
[209.843639] Subtest hang-user: SKIP (0.000s)
[209.907429] [055/133] (815s left) vgem_basic (busy-fence)
[210.006097] Starting subtest: busy-fence
[210.008439] Subtest busy-fence: SUCCESS (0.001s)
[210.063223] [FACT vgem_basic (busy-fence)] new: kernel.kmod_is_loaded.vgem: true
[210.066392] [056/133] (814s left) kms_psr (psr2-cursor-render)
[210.161379] Starting subtest: psr2-cursor-render
[210.163702] Starting dynamic subtest: eDP-1
[211.926760] Dynamic subtest eDP-1: SUCCESS (1.764s)
[211.928954] Subtest psr2-cursor-render: SUCCESS (1.765s)
[212.737039] [057/133] (812s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[212.821911] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[212.824157] Starting dynamic subtest: pipe-A-default-mode
[213.987546] Dynamic subtest pipe-A-default-mode: SKIP (1.164s)
[213.992200] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.166s)
[214.129632] [058/133] (810s left) kms_flip (2x-flip-vs-panning-vs-hang)
[214.226510] Starting subtest: 2x-flip-vs-panning-vs-hang
[214.238190] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.011s)
[214.346427] [059/133] (810s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[214.434500] Starting subtest: pr-cursor-plane-move-continuous-sf
[214.438589] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[214.504350] [060/133] (810s left) api_intel_bb (delta-check)
[214.561156] Starting subtest: delta-check
[214.564724] Subtest delta-check: SUCCESS (0.006s)
[214.696641] [061/133] (810s left) gem_exec_parallel (contexts)
[214.752238] Starting subtest: contexts
[214.754464] Starting dynamic subtest: rcs0
[218.151632] Dynamic subtest rcs0: SUCCESS (3.398s)
[218.160666] Starting dynamic subtest: bcs0
[222.442344] Dynamic subtest bcs0: SUCCESS (4.288s)
[222.451541] Starting dynamic subtest: vcs0
[228.358484] Dynamic subtest vcs0: SUCCESS (5.913s)
[228.367031] Starting dynamic subtest: vcs1
[234.248227] Dynamic subtest vcs1: SUCCESS (5.888s)
[234.257118] Starting dynamic subtest: vecs0
[238.447695] Dynamic subtest vecs0: SUCCESS (4.198s)
[238.457921] Starting dynamic subtest: ccs0
[242.524530] Dynamic subtest ccs0: SUCCESS (4.074s)
[242.526722] Subtest contexts: SUCCESS (27.771s)
[242.709108] [062/133] (782s left) i915_pm_rpm (debugfs-read)
[244.244497] Starting subtest: debugfs-read
[245.414675] Subtest debugfs-read: SUCCESS (1.169s)
[245.798696] [063/133] (779s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[245.899443] Starting subtest: fbc-rgb101010-draw-pwrite
[251.272749] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.376s)
[252.392389] [064/133] (772s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[252.446807] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[252.553708] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.106s)
[252.629589] [065/133] (772s left) kms_prop_blob (blob-multiple)
[252.689563] Starting subtest: blob-multiple
[252.691866] Subtest blob-multiple: SUCCESS (0.002s)
[252.790136] [066/133] (772s left) kms_draw_crc (draw-method-mmap-gtt)
[252.877187] Starting subtest: draw-method-mmap-gtt
[252.881685] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[252.975404] [067/133] (772s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[253.084190] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[254.119424] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.035s)
[254.230713] [068/133] (771s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[254.326166] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[254.330438] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.000s)
[254.394702] [069/133] (771s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[254.488726] Starting subtest: y-tiled-8bpp-rotate-180
[254.492421] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[254.612290] [070/133] (770s left) gem_softpin (noreloc)
[254.669031] Starting subtest: noreloc
[260.079786] Subtest noreloc: SUCCESS (5.409s)
[260.196631] [071/133] (765s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[260.297563] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[260.301843] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[260.393867] [072/133] (765s left) gem_ctx_persistence (heartbeat-hang)
[260.448318] Starting subtest: heartbeat-hang
[260.453056] Subtest heartbeat-hang: SKIP (0.000s)
[260.543537] [073/133] (765s left) gem_exec_whisper (basic-normal-all)
[260.598275] Starting subtest: basic-normal-all
[262.980474] Subtest basic-normal-all: SUCCESS (2.380s)
[263.166425] [074/133] (762s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[263.281663] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[263.286227] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[263.378456] [075/133] (762s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[263.483999] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[263.488476] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[263.589834] [076/133] (762s left) kms_plane_lowres (tiling-none)
[263.677588] Starting subtest: tiling-none
[263.679820] Starting dynamic subtest: pipe-A-eDP-1
[263.684140] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[263.977778] Starting dynamic subtest: pipe-B-eDP-1
[263.982173] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[263.990868] Starting dynamic subtest: pipe-C-eDP-1
[263.995271] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[264.003630] Starting dynamic subtest: pipe-D-eDP-1
[264.008168] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[264.012265] Subtest tiling-none: SKIP (0.299s)
[264.802292] [077/133] (761s left) gem_tiled_fence_blits (basic)
[264.861463] Subtest basic: SKIP (0.000s)
[264.928579] [078/133] (761s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[264.984197] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[265.090049] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.104s)
[265.166989] [079/133] (760s left) perf (per-context-mode-unprivileged)
[265.253542] Starting subtest: per-context-mode-unprivileged
[265.257798] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[265.308382] [080/133] (760s left) kms_psr (pr-dpms)
[265.395795] Starting subtest: pr-dpms
[265.400096] Subtest pr-dpms: SKIP (0.000s)
[265.470237] [081/133] (760s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[265.576482] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[265.580778] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[265.687246] [082/133] (760s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[265.776053] Starting subtest: basic-modeset-with-all-modifiers-formats
[266.152606] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[266.907635] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.755s)
[266.916054] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[266.928768] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.019s)
[266.936985] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[266.951265] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.021s)
[266.960584] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[267.095788] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.144s)
[267.104961] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[267.118491] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.022s)
[267.126708] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[267.139872] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.021s)
[267.148109] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[267.162286] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.021s)
[267.170292] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[267.184562] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.022s)
[267.192631] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[267.206878] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s)
[267.215187] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[267.229081] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.021s)
[267.237432] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[267.250991] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.021s)
[267.259345] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[267.273400] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.021s)
[267.281646] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[267.440271] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.166s)
[267.449177] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[267.462399] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.021s)
[267.470786] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[267.484635] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.021s)
[267.492975] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[267.507015] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s)
[267.515341] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[267.529218] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.020s)
[267.537535] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[267.551416] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.021s)
[267.559998] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[267.573580] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.021s)
[267.582175] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[267.595797] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.021s)
[267.604309] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[267.618220] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[267.626634] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[267.785823] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.166s)
[267.795633] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[267.807441] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.020s)
[267.816807] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[267.829330] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.021s)
[267.840190] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[267.851439] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.021s)
[267.861283] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[267.873564] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.021s)
[267.881564] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[267.895631] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.021s)
[267.904042] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[267.917860] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.021s)
[267.925850] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[267.940329] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s)
[267.948279] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[267.962544] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.021s)
[268.347524] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.572s)
[269.196989] [083/133] (756s left) syncobj_timeline (signal)
[269.258242] Starting subtest: signal
[269.260067] Subtest signal: SUCCESS (0.000s)
[269.350773] [084/133] (756s left) kms_hdr (invalid-metadata-sizes)
[269.441146] Starting subtest: invalid-metadata-sizes
[269.447505] Subtest invalid-metadata-sizes: SKIP (0.000s)
[269.514966] [085/133] (756s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[269.608861] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[273.585982] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (3.979s)
[274.781289] [086/133] (751s left) gem_softpin (allocator-nopin)
[274.838793] Starting subtest: allocator-nopin
[274.929978] Subtest allocator-nopin: SUCCESS (0.091s)
[275.048464] [087/133] (751s left) kms_cursor_crc (cursor-onscreen-128x42)
[275.283993] Starting subtest: cursor-onscreen-128x42
[275.328872] Subtest cursor-onscreen-128x42: SKIP (0.043s)
[275.551933] [088/133] (750s left) syncobj_timeline (invalid-wait-illegal-handle)
[275.610581] Starting subtest: invalid-wait-illegal-handle
[275.612967] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[275.721614] [089/133] (750s left) perf_pmu (busy-accuracy-2)
[275.787280] Starting subtest: busy-accuracy-2
[275.796201] Starting dynamic subtest: rcs0
[278.840942] Dynamic subtest rcs0: SUCCESS (3.045s)
[278.859834] Starting dynamic subtest: bcs0
[281.880049] Dynamic subtest bcs0: SUCCESS (3.057s)
[281.890686] Starting dynamic subtest: vcs0
[284.927057] Dynamic subtest vcs0: SUCCESS (3.044s)
[284.937720] Starting dynamic subtest: vcs1
[287.976657] Dynamic subtest vcs1: SUCCESS (3.048s)
[287.987506] Starting dynamic subtest: vecs0
[291.029482] Dynamic subtest vecs0: SUCCESS (3.050s)
[291.040963] Starting dynamic subtest: ccs0
[294.089961] Dynamic subtest ccs0: SUCCESS (3.057s)
[294.092477] Subtest busy-accuracy-2: SUCCESS (18.314s)
[294.212163] [090/133] (732s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[294.309983] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[294.312248] Starting dynamic subtest: pipe-A-eDP-1
[294.335223] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[294.345295] Starting dynamic subtest: pipe-B-eDP-1
[294.366977] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[294.375450] Starting dynamic subtest: pipe-C-eDP-1
[294.397226] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[294.405575] Starting dynamic subtest: pipe-D-eDP-1
[294.428064] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[294.432233] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.005s)
[296.640731] [091/133] (729s left) gem_pipe_control_store_loop (fresh-buffer)
[296.700671] Starting subtest: fresh-buffer
[298.854457] Subtest fresh-buffer: SUCCESS (2.152s)
[298.954912] [092/133] (727s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[299.053708] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[306.156189] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.105s)
[306.287859] [093/133] (720s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[306.378406] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[306.382736] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[306.473530] [094/133] (720s left) perf (invalid-oa-metric-set-id)
[306.564765] Starting subtest: invalid-oa-metric-set-id
[306.573729] Subtest invalid-oa-metric-set-id: SUCCESS (0.008s)
[306.613345] [095/133] (720s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[306.726282] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[307.816764] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.090s)
[307.939823] [096/133] (718s left) gem_softpin (evict-snoop-interruptible)
[308.005337] Starting subtest: evict-snoop-interruptible
[308.008908] Subtest evict-snoop-interruptible: SKIP (0.000s)
[308.123963] [097/133] (718s left) kms_flip (modeset-vs-vblank-race)
[308.225192] Starting subtest: modeset-vs-vblank-race
[308.227179] Starting dynamic subtest: A-eDP1
[312.904605] Dynamic subtest A-eDP1: SUCCESS (4.677s)
[312.915746] Starting dynamic subtest: B-eDP1
[317.634405] Dynamic subtest B-eDP1: SUCCESS (4.727s)
[317.645972] Starting dynamic subtest: C-eDP1
[322.267653] Dynamic subtest C-eDP1: SUCCESS (4.631s)
[322.280710] Starting dynamic subtest: D-eDP1
[326.818911] Dynamic subtest D-eDP1: SUCCESS (4.549s)
[326.823647] Subtest modeset-vs-vblank-race: SUCCESS (18.598s)
[327.976122] [098/133] (698s left) gem_eio (banned)
[328.219769] Starting subtest: banned
[328.855938] Subtest banned: SUCCESS (0.634s)
[329.015888] [099/133] (697s left) kms_cursor_crc (cursor-random-128x42)
[329.242705] Starting subtest: cursor-random-128x42
[329.292387] Subtest cursor-random-128x42: SKIP (0.045s)
[329.501205] [100/133] (697s left) kms_lease (lease-revoke)
[329.602321] Starting subtest: lease-revoke
[329.604230] Starting dynamic subtest: pipe-A-eDP-1
[329.634559] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.032s)
[329.649332] Starting dynamic subtest: pipe-B-eDP-1
[329.664062] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.027s)
[329.672610] Starting dynamic subtest: pipe-C-eDP-1
[329.692656] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.027s)
[329.701107] Starting dynamic subtest: pipe-D-eDP-1
[329.722372] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.028s)
[329.724248] Subtest lease-revoke: SUCCESS (0.120s)
[329.833393] [101/133] (697s left) gem_exec_reloc (basic-gtt-noreloc)
[329.903096] Subtest basic-gtt-noreloc: SKIP (0.000s)
[329.976483] [102/133] (696s left) kms_pipe_stress (stress-xrgb8888-untiled)
[330.061944] Starting subtest: stress-xrgb8888-untiled
[335.971624] Subtest stress-xrgb8888-untiled: SUCCESS (5.910s)
[336.035023] [103/133] (690s left) kms_content_protection (mei-interface)
[336.177395] Starting subtest: mei-interface
[336.181276] Subtest mei-interface: SKIP (0.001s)
[336.282607] [104/133] (690s left) gem_mmap_gtt (cpuset-big-copy-odd)
[336.333053] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[336.404493] [105/133] (690s left) prime_self_import (basic-with_fd_dup)
[336.442572] Starting subtest: basic-with_fd_dup
[336.462956] Subtest basic-with_fd_dup: SUCCESS (0.021s)
[336.574601] [106/133] (690s left) fbdev (nullptr)
[336.613413] Starting subtest: nullptr
[336.615460] Subtest nullptr: SUCCESS (0.000s)
[336.671784] [107/133] (690s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[336.762232] Starting subtest: psr-rgb101010-draw-mmap-cpu
[343.875263] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (7.116s)
[343.978350] [108/133] (683s left) i915_hangman (error-state-basic)
[344.051633] Starting subtest: error-state-basic
[344.210313] Subtest error-state-basic: SUCCESS (0.157s)
[344.283637] [109/133] (682s left) kms_rotation_crc (bad-tiling)
[344.368836] Starting subtest: bad-tiling
[344.373215] Subtest bad-tiling: SKIP (0.001s)
[344.442078] [110/133] (682s left) gem_userptr_blits (sync-unmap-after-close)
[344.508837] Starting subtest: sync-unmap-after-close
[344.520305] Subtest sync-unmap-after-close: SUCCESS (0.013s)
[344.650341] [111/133] (682s left) kms_flip (flip-vs-expired-vblank-interruptible)
[344.740094] Starting subtest: flip-vs-expired-vblank-interruptible
[344.742380] Starting dynamic subtest: A-eDP1
[353.409646] Dynamic subtest A-eDP1: SUCCESS (8.668s)
[353.425145] Starting dynamic subtest: B-eDP1
[362.041732] Dynamic subtest B-eDP1: SUCCESS (8.629s)
[362.060533] Starting dynamic subtest: C-eDP1
[370.661471] Dynamic subtest C-eDP1: SUCCESS (8.616s)
[370.671569] Starting dynamic subtest: D-eDP1
[379.282955] Dynamic subtest D-eDP1: SUCCESS (8.619s)
[379.287734] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.547s)
[380.458375] [112/133] (646s left) gem_exec_fence (syncobj-timeline-chain-engines)
[381.058744] Starting subtest: syncobj-timeline-chain-engines
[381.181611] Subtest syncobj-timeline-chain-engines: SUCCESS (0.123s)
[382.011933] [113/133] (645s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[382.107832] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[382.111792] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[382.187627] [114/133] (645s left) kms_cursor_edge_walk (64x64-left-edge)
[382.276057] Starting subtest: 64x64-left-edge
[382.278129] Starting dynamic subtest: pipe-A-eDP-1
[385.731645] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.454s)
[385.745630] Starting dynamic subtest: pipe-D-eDP-1
[388.850704] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.117s)
[388.852988] Subtest 64x64-left-edge: SUCCESS (6.576s)
[389.648906] [115/133] (637s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[389.760336] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[389.762615] Starting dynamic subtest: pipe-A-eDP-1
[389.785321] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[389.794726] Starting dynamic subtest: pipe-B-eDP-1
[389.816219] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[389.825335] Starting dynamic subtest: pipe-C-eDP-1
[389.847059] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[389.856753] Starting dynamic subtest: pipe-D-eDP-1
[389.880226] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[389.884474] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[392.013835] [116/133] (635s left) gem_exec_schedule (fifo)
[392.085991] Starting subtest: fifo
[392.087926] Starting dynamic subtest: rcs0
[392.187310] Dynamic subtest rcs0: SUCCESS (0.110s)
[392.199111] Starting dynamic subtest: vcs0
[392.274061] Dynamic subtest vcs0: SUCCESS (0.085s)
[392.284531] Starting dynamic subtest: vcs1
[392.357206] Dynamic subtest vcs1: SUCCESS (0.080s)
[392.368973] Starting dynamic subtest: vecs0
[392.433155] Dynamic subtest vecs0: SUCCESS (0.075s)
[392.447913] Starting dynamic subtest: ccs0
[392.525794] Dynamic subtest ccs0: SUCCESS (0.092s)
[392.528235] Subtest fifo: SUCCESS (0.449s)
[394.038570] [117/133] (633s left) kms_psr (fbc-psr2-basic)
[394.148238] Starting subtest: fbc-psr2-basic
[394.150368] Starting dynamic subtest: eDP-1
[394.154573] Dynamic subtest eDP-1: SKIP (0.000s)
[394.158747] Subtest fbc-psr2-basic: SKIP (0.001s)
[394.235777] [118/133] (633s left) prime_mmap (test_forked)
[394.293289] Starting subtest: test_forked
[394.295434] Starting dynamic subtest: test_forked-smem
[394.332807] Dynamic subtest test_forked-smem: SUCCESS (0.041s)
[394.335600] Subtest test_forked: SUCCESS (0.043s)
[394.445815] [119/133] (633s left) i915_query (query-regions-garbage-items)
[394.500592] Starting subtest: query-regions-garbage-items
[394.502521] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[394.590859] [120/133] (633s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[394.691569] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[394.695990] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[394.790528] [121/133] (632s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[394.905238] Starting subtest: cursorA-vs-flipB-varying-size
[394.909431] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[395.062428] [122/133] (632s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[395.160801] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[395.164135] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[395.262505] [123/133] (632s left) gem_render_copy (linear-to-vebox-yf-tiled)
[395.322625] Starting subtest: linear-to-vebox-yf-tiled
[395.326375] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[395.507032] [124/133] (632s left) gem_ctx_isolation (nonpriv)
[395.572987] Starting subtest: nonpriv
[395.575356] Starting dynamic subtest: rcs0
[395.837084] Dynamic subtest rcs0: SUCCESS (0.264s)
[395.846896] Starting dynamic subtest: bcs0
[396.088382] Dynamic subtest bcs0: SUCCESS (0.250s)
[396.100041] Starting dynamic subtest: vcs0
[396.336049] Dynamic subtest vcs0: SUCCESS (0.247s)
[396.347561] Starting dynamic subtest: vcs1
[398.148733] Dynamic subtest vcs1: SUCCESS (1.812s)
[398.160267] Starting dynamic subtest: vecs0
[400.135347] Dynamic subtest vecs0: SUCCESS (1.986s)
[400.147178] Starting dynamic subtest: ccs0
[402.142750] Dynamic subtest ccs0: SUCCESS (2.006s)
[402.144991] Subtest nonpriv: SUCCESS (6.570s)
[402.377655] [125/133] (625s left) kms_psr (fbc-psr-primary-mmap-gtt)
[402.476041] Starting subtest: fbc-psr-primary-mmap-gtt
[402.478318] Starting dynamic subtest: eDP-1
[402.482314] Dynamic subtest eDP-1: SKIP (0.000s)
[402.486435] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[402.550110] [126/133] (625s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[402.652595] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[402.656571] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[402.752346] [127/133] (625s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[403.026785] Starting subtest: parallel-dmabuf-import-out-fence
[404.277970] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.255s)
[404.385525] [128/133] (623s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[404.484916] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[404.487213] Starting dynamic subtest: A-eDP1
[413.365120] Dynamic subtest A-eDP1: SUCCESS (8.878s)
[413.377085] Starting dynamic subtest: B-eDP1
[422.286723] Dynamic subtest B-eDP1: SUCCESS (8.919s)
[422.295401] Starting dynamic subtest: C-eDP1
[431.211143] Dynamic subtest C-eDP1: SUCCESS (8.923s)
[431.222606] Starting dynamic subtest: D-eDP1
[440.056720] Dynamic subtest D-eDP1: SUCCESS (8.842s)
[440.062594] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.574s)
[441.291155] [129/133] (586s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[441.403037] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[441.407370] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[441.496946] [130/133] (586s left) kms_plane (plane-position-covered)
[441.605938] Starting subtest: plane-position-covered
[442.139392] Starting dynamic subtest: pipe-A-plane-1
[443.411689] Dynamic subtest pipe-A-plane-1: SUCCESS (1.275s)
[443.423861] Starting dynamic subtest: pipe-A-plane-2
[444.709232] Dynamic subtest pipe-A-plane-2: SUCCESS (1.294s)
[444.719027] Starting dynamic subtest: pipe-A-plane-3
[445.962071] Dynamic subtest pipe-A-plane-3: SUCCESS (1.254s)
[445.971991] Starting dynamic subtest: pipe-A-plane-4
[447.302235] Dynamic subtest pipe-A-plane-4: SUCCESS (1.338s)
[447.311756] Starting dynamic subtest: pipe-A-plane-5
[447.331064] Dynamic subtest pipe-A-plane-5: SUCCESS (0.029s)
[448.544068] Starting dynamic subtest: pipe-B-plane-1
[449.878640] Dynamic subtest pipe-B-plane-1: SUCCESS (1.339s)
[449.887959] Starting dynamic subtest: pipe-B-plane-2
[451.167790] Dynamic subtest pipe-B-plane-2: SUCCESS (1.291s)
[451.178283] Starting dynamic subtest: pipe-B-plane-3
[452.416156] Dynamic subtest pipe-B-plane-3: SUCCESS (1.245s)
[452.430363] Starting dynamic subtest: pipe-B-plane-4
[453.766377] Dynamic subtest pipe-B-plane-4: SUCCESS (1.349s)
[453.776854] Starting dynamic subtest: pipe-B-plane-5
[453.791603] Dynamic subtest pipe-B-plane-5: SUCCESS (0.026s)
[453.794117] Subtest plane-position-covered: SUCCESS (12.186s)
[454.628969] [131/133] (573s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[454.758304] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[454.762795] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[454.910916] [132/133] (573s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[454.997152] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[454.999336] Starting dynamic subtest: pipe-A-eDP-1
[455.021773] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[455.033363] Starting dynamic subtest: pipe-B-eDP-1
[455.054663] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[455.063636] Starting dynamic subtest: pipe-C-eDP-1
[455.085051] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[455.093531] Starting dynamic subtest: pipe-D-eDP-1
[455.115392] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[455.119441] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[457.309321] [133/133] (570s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[457.402322] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[457.406332] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[457.504658] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: gem_exec_schedule
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_color_pipeline
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: perf_pmu
results: parsing output: 6/ for test: kms_plane_scaling
results: parsing output: 7/ for test: gem_basic
results: parsing output: 8/ for test: syncobj_basic
results: parsing output: 9/ for test: gen9_exec_parse
results: parsing output: 10/ for test: drm_buddy
results: parsing output: 11/ for test: kms_big_fb
results: parsing output: 12/ for test: gen9_exec_parse
results: parsing output: 13/ for test: gem_gtt_cpu_tlb
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: gem_ctx_shared
results: parsing output: 16/ for test: kms_chamelium_color
results: parsing output: 17/ for test: gem_pxp
results: parsing output: 18/ for test: kms_force_connector_basic
results: parsing output: 19/ for test: kms_chamelium_hpd
results: parsing output: 20/ for test: gem_render_copy
results: parsing output: 21/ for test: kms_psr
results: parsing output: 22/ for test: perf
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: kms_chamelium_edid
results: parsing output: 26/ for test: kms_panel_fitting
results: parsing output: 27/ for test: api_intel_allocator
results: parsing output: 28/ for test: gem_exec_balancer
results: parsing output: 29/ for test: kms_flip
results: parsing output: 30/ for test: gem_exec_schedule
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_vblank
results: parsing output: 33/ for test: gem_lmem_swapping
results: parsing output: 34/ for test: gem_create
results: parsing output: 35/ for test: kms_async_flips
results: parsing output: 36/ for test: gem_userptr_blits
results: parsing output: 37/ for test: kms_pm_dc
results: parsing output: 38/ for test: prime_mmap
results: parsing output: 39/ for test: kms_invalid_mode
results: parsing output: 40/ for test: kms_cursor_legacy
results: parsing output: 41/ for test: gem_eio
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: perf
results: parsing output: 44/ for test: tools_test
results: parsing output: 45/ for test: prime_mmap
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: sriov_basic
results: parsing output: 49/ for test: kms_sequence
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: gem_mmap_gtt
results: parsing output: 54/ for test: vgem_basic
results: parsing output: 55/ for test: kms_psr
results: parsing output: 56/ for test: kms_flip_scaled_crc
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: kms_psr2_sf
results: parsing output: 59/ for test: api_intel_bb
results: parsing output: 60/ for test: gem_exec_parallel
results: parsing output: 61/ for test: i915_pm_rpm
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: syncobj_wait
results: parsing output: 64/ for test: kms_prop_blob
results: parsing output: 65/ for test: kms_draw_crc
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: kms_plane
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: gem_softpin
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_ctx_persistence
results: parsing output: 72/ for test: gem_exec_whisper
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_plane_lowres
results: parsing output: 76/ for test: gem_tiled_fence_blits
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: perf
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_async_flips
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: kms_hdr
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_softpin
results: parsing output: 86/ for test: kms_cursor_crc
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: perf_pmu
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: gem_pipe_control_store_loop
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: perf
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: gem_softpin
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: gem_eio
results: parsing output: 98/ for test: kms_cursor_crc
results: parsing output: 99/ for test: kms_lease
results: parsing output: 100/ for test: gem_exec_reloc
results: parsing output: 101/ for test: kms_pipe_stress
results: parsing output: 102/ for test: kms_content_protection
results: parsing output: 103/ for test: gem_mmap_gtt
results: parsing output: 104/ for test: prime_self_import
results: parsing output: 105/ for test: fbdev
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: i915_hangman
results: parsing output: 108/ for test: kms_rotation_crc
results: parsing output: 109/ for test: gem_userptr_blits
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: gem_exec_fence
results: parsing output: 112/ for test: kms_psr2_sf
results: parsing output: 113/ for test: kms_cursor_edge_walk
results: parsing output: 114/ for test: kms_ccs
results: parsing output: 115/ for test: gem_exec_schedule
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: prime_mmap
results: parsing output: 118/ for test: i915_query
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: kms_cursor_legacy
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gem_render_copy
results: parsing output: 123/ for test: gem_ctx_isolation
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_exec_balancer
results: parsing output: 127/ for test: kms_flip
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_plane
results: parsing output: 130/ for test: kms_cursor_legacy
results: parsing output: 131/ for test: kms_ccs
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.