[60.139136] Initializing watchdogs
[60.139184]   /dev/watchdog0
[60.153949] [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]
[60.158545] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.160741] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.164508] [001/133] (960s left) kms_psr (fbc-pr-cursor-plane-onoff)
[60.293296] Starting subtest: fbc-pr-cursor-plane-onoff
[60.297750] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[60.361807] [002/133] (960s left) gem_exec_schedule (preempt-self)
[60.438662] Starting subtest: preempt-self
[60.440952] Starting dynamic subtest: rcs0
[60.456894] Dynamic subtest rcs0: SUCCESS (0.022s)
[60.464211] Starting dynamic subtest: bcs0
[60.471929] Dynamic subtest bcs0: SUCCESS (0.015s)
[60.479657] Starting dynamic subtest: vcs0
[60.487661] Dynamic subtest vcs0: SUCCESS (0.016s)
[60.494625] Starting dynamic subtest: vcs1
[60.511496] Dynamic subtest vcs1: SUCCESS (0.024s)
[60.518675] Starting dynamic subtest: vecs0
[60.527745] Dynamic subtest vecs0: SUCCESS (0.016s)
[60.534464] Starting dynamic subtest: ccs0
[60.545578] Dynamic subtest ccs0: SUCCESS (0.018s)
[60.547820] Subtest preempt-self: SUCCESS (0.111s)
[61.986497] [003/133] (958s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[62.090455] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[62.094534] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[62.182251] [004/133] (958s left) kms_color_pipeline (plane-ctm3x4)
[62.279563] Starting subtest: plane-ctm3x4
[62.444608] Starting dynamic subtest: pipe-A-plane-0
[62.754810] Dynamic subtest pipe-A-plane-0: FAIL (0.149s)
[62.761896] Starting dynamic subtest: pipe-A-plane-1
[62.964161] Dynamic subtest pipe-A-plane-1: FAIL (0.139s)
[62.971476] Starting dynamic subtest: pipe-A-plane-2
[63.171786] Dynamic subtest pipe-A-plane-2: FAIL (0.153s)
[64.081528] Starting dynamic subtest: pipe-B-plane-0
[64.485896] Dynamic subtest pipe-B-plane-0: FAIL (0.142s)
[64.495263] Starting dynamic subtest: pipe-B-plane-1
[64.800338] Dynamic subtest pipe-B-plane-1: FAIL (0.143s)
[64.809105] Starting dynamic subtest: pipe-B-plane-2
[65.109022] Dynamic subtest pipe-B-plane-2: FAIL (0.615s)
[66.178576] Starting dynamic subtest: pipe-C-plane-0
[66.653268] Dynamic subtest pipe-C-plane-0: FAIL (0.130s)
[66.660918] Starting dynamic subtest: pipe-C-plane-1
[67.060877] Dynamic subtest pipe-C-plane-1: FAIL (0.133s)
[67.069912] Starting dynamic subtest: pipe-C-plane-2
[67.431873] Dynamic subtest pipe-C-plane-2: FAIL (0.621s)
[68.216304] Starting dynamic subtest: pipe-D-plane-0
[68.761195] Dynamic subtest pipe-D-plane-0: FAIL (0.108s)
[68.770144] Starting dynamic subtest: pipe-D-plane-1
[69.234244] Dynamic subtest pipe-D-plane-1: FAIL (0.608s)
[69.242840] Starting dynamic subtest: pipe-D-plane-2
[69.665536] Dynamic subtest pipe-D-plane-2: FAIL (0.540s)
[69.772769] Subtest plane-ctm3x4: FAIL (7.513s)
[70.591935] [005/133] (950s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[70.694750] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[77.850064] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.163s)
[77.986600] [006/133] (942s left) perf_pmu (busy-idle-check-all)
[78.034540] Starting subtest: busy-idle-check-all
[78.036696] Starting dynamic subtest: rcs0
[78.685359] Dynamic subtest rcs0: SUCCESS (0.652s)
[78.694814] Starting dynamic subtest: bcs0
[79.336657] Dynamic subtest bcs0: SUCCESS (0.651s)
[79.347283] Starting dynamic subtest: vcs0
[80.853612] Dynamic subtest vcs0: SUCCESS (1.514s)
[80.862735] Starting dynamic subtest: vcs1
[82.902060] Dynamic subtest vcs1: SUCCESS (2.047s)
[82.912988] Starting dynamic subtest: vecs0
[84.884437] Dynamic subtest vecs0: SUCCESS (1.982s)
[84.894311] Starting dynamic subtest: ccs0
[85.539743] Dynamic subtest ccs0: SUCCESS (0.655s)
[85.542368] Subtest busy-idle-check-all: SUCCESS (7.507s)
[85.636564] [007/133] (935s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[85.740230] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[85.742517] Starting dynamic subtest: pipe-A
[85.803903] Dynamic subtest pipe-A: SUCCESS (0.066s)
[85.811506] Starting dynamic subtest: pipe-B
[86.962667] Dynamic subtest pipe-B: SUCCESS (1.158s)
[86.973748] Starting dynamic subtest: pipe-C
[88.074890] Dynamic subtest pipe-C: SUCCESS (1.111s)
[88.087202] Starting dynamic subtest: pipe-D
[89.201727] Dynamic subtest pipe-D: SUCCESS (1.126s)
[89.204129] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.463s)
[90.374248] [008/133] (930s left) gem_basic (bad-close)
[90.447261] Starting subtest: bad-close
[90.451860] Subtest bad-close: SUCCESS (0.000s)
[90.544827] [009/133] (930s left) syncobj_basic (test-valid-cycle)
[90.607081] Starting subtest: test-valid-cycle
[90.609382] Subtest test-valid-cycle: SUCCESS (0.000s)
[90.721937] [010/133] (930s left) gen9_exec_parse (unaligned-jump)
[90.787249] Subtest unaligned-jump: SKIP (0.000s)
[90.844264] [011/133] (930s left) drm_buddy (drm_buddy)
[90.882493] Starting subtest: drm_buddy
[90.887649] Subtest drm_buddy: SKIP (0.001s)
[90.933952] [012/133] (930s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[91.039820] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[92.163618] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.126s)
[92.286546] [013/133] (928s left) gen9_exec_parse (bb-chained)
[92.341563] Subtest bb-chained: SKIP (0.000s)
[92.405522] [014/133] (928s left) gem_gtt_cpu_tlb
[92.526773] [015/133] (928s left) syncobj_timeline (transfer-timeline-point)
[92.582932] Starting subtest: transfer-timeline-point
[92.584927] Subtest transfer-timeline-point: SUCCESS (0.001s)
[92.692758] [016/133] (928s left) gem_ctx_shared (exec-single-timeline)
[92.757340] Starting subtest: exec-single-timeline
[92.759411] Starting dynamic subtest: rcs0
[93.810749] Dynamic subtest rcs0: SUCCESS (1.051s)
[93.822523] Starting dynamic subtest: bcs0
[94.898065] Dynamic subtest bcs0: SUCCESS (1.086s)
[94.909539] Starting dynamic subtest: vcs0
[95.987226] Dynamic subtest vcs0: SUCCESS (1.087s)
[95.999043] Starting dynamic subtest: vcs1
[97.075603] Dynamic subtest vcs1: SUCCESS (1.086s)
[97.086047] Starting dynamic subtest: vecs0
[98.163063] Dynamic subtest vecs0: SUCCESS (1.085s)
[98.173858] Starting dynamic subtest: ccs0
[99.252236] Dynamic subtest ccs0: SUCCESS (1.084s)
[99.254663] Subtest exec-single-timeline: SUCCESS (6.493s)
[99.487175] [017/133] (921s left) kms_chamelium_color (ctm-0-75)
[99.591423] Subtest ctm-0-75: SKIP (0.000s)
[99.634743] [018/133] (921s left) gem_pxp (create-regular-buffer)
[99.779866] Starting subtest: create-regular-buffer
[99.782202] Subtest create-regular-buffer: SUCCESS (0.000s)
[99.881570] [019/133] (921s left) kms_force_connector_basic (prune-stale-modes)
[99.953978] Starting subtest: prune-stale-modes
[100.395682] Subtest prune-stale-modes: SUCCESS (0.442s)
[100.540154] [020/133] (920s left) kms_chamelium_hpd (dp-hpd)
[100.937669] Subtest dp-hpd: SKIP (0.000s)
[101.778307] [021/133] (919s left) gem_render_copy (yf-tiled-to-vebox-linear)
[101.843775] Starting subtest: yf-tiled-to-vebox-linear
[101.848200] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[102.038299] [022/133] (919s left) kms_psr (psr-sprite-blt)
[102.131421] Starting subtest: psr-sprite-blt
[102.133658] Starting dynamic subtest: eDP-1
[103.897066] Dynamic subtest eDP-1: SUCCESS (1.766s)
[103.899394] Subtest psr-sprite-blt: SUCCESS (1.767s)
[104.692800] [023/133] (916s left) perf (non-system-wide-paranoid)
[104.830065] Starting subtest: non-system-wide-paranoid
[104.858070] Subtest non-system-wide-paranoid: SUCCESS (0.030s)
[104.905668] [024/133] (916s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[105.006924] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[105.009223] Starting dynamic subtest: pipe-A-eDP-1
[105.031947] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[105.042144] Starting dynamic subtest: pipe-B-eDP-1
[105.063165] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[105.070373] Starting dynamic subtest: pipe-C-eDP-1
[105.091298] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[105.098482] Starting dynamic subtest: pipe-D-eDP-1
[105.119919] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[105.124460] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[107.290262] [025/133] (914s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[107.361588] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[107.466243] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.105s)
[107.539748] [026/133] (914s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k)
[107.932202] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s)
[108.776490] [027/133] (912s left) kms_panel_fitting (legacy)
[108.864349] Starting subtest: legacy
[108.867090] Starting dynamic subtest: pipe-A-eDP-1
[109.452448] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.590s)
[109.478181] Starting dynamic subtest: pipe-B-eDP-1
[111.061229] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.589s)
[111.086899] Starting dynamic subtest: pipe-C-eDP-1
[112.590686] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.509s)
[112.617565] Starting dynamic subtest: pipe-D-eDP-1
[114.226864] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.616s)
[114.229943] Subtest legacy: SUCCESS (5.365s)
[115.395751] [028/133] (906s left) api_intel_allocator (reserve-simple)
[115.457131] Starting subtest: reserve-simple
[115.459669] Subtest reserve-simple: SUCCESS (0.003s)
[115.589735] [029/133] (906s left) gem_exec_balancer (hog)
[115.648059] Starting subtest: hog
[115.652415] Subtest hog: SKIP (0.000s)
[115.958943] [030/133] (905s left) kms_flip (2x-dpms-vs-vblank-race)
[116.061513] Starting subtest: 2x-dpms-vs-vblank-race
[116.070459] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s)
[116.146554] [031/133] (905s left) gem_exec_schedule (pi-userfault)
[116.322653] Starting subtest: pi-userfault
[116.325075] Starting dynamic subtest: rcs0
[116.331722] Dynamic subtest rcs0: SUCCESS (0.012s)
[116.342271] Starting dynamic subtest: bcs0
[116.344534] Dynamic subtest bcs0: SUCCESS (0.010s)
[116.352396] Starting dynamic subtest: vcs0
[116.354277] Dynamic subtest vcs0: SUCCESS (0.008s)
[116.362084] Starting dynamic subtest: vcs1
[116.364213] Dynamic subtest vcs1: SUCCESS (0.009s)
[116.372265] Starting dynamic subtest: vecs0
[116.374114] Dynamic subtest vecs0: SUCCESS (0.008s)
[116.381920] Starting dynamic subtest: ccs0
[116.384149] Dynamic subtest ccs0: SUCCESS (0.008s)
[116.386268] Subtest pi-userfault: SUCCESS (0.058s)
[116.563889] [032/133] (905s left) kms_frontbuffer_tracking (fbc-tiling-y)
[116.662310] Starting subtest: fbc-tiling-y
[116.666439] Subtest fbc-tiling-y: SKIP (0.000s)
[116.752402] [033/133] (905s left) kms_vblank (wait-busy-hang)
[116.839941] Starting subtest: wait-busy-hang
[116.841992] Starting dynamic subtest: pipe-A-eDP-1
[143.636134] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.797s)
[143.648931] Starting dynamic subtest: pipe-D-eDP-1
[168.676355] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.039s)
[168.678558] Subtest wait-busy-hang: SUCCESS (51.839s)
[169.486983] [034/133] (852s left) gem_lmem_swapping (heavy-verify-random-ccs)
[169.538694] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[169.584741] [035/133] (852s left) gem_create (create-ext-cpu-access-big)
[169.762522] Starting subtest: create-ext-cpu-access-big
[169.766837] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[169.831404] [036/133] (852s left) kms_async_flips (invalid-async-flip)
[169.931092] Starting subtest: invalid-async-flip
[170.304749] Starting dynamic subtest: pipe-A-eDP-1
[171.090736] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.786s)
[171.464578] Starting dynamic subtest: pipe-B-eDP-1
[172.277659] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.821s)
[172.630933] Starting dynamic subtest: pipe-C-eDP-1
[173.470244] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.846s)
[173.826066] Starting dynamic subtest: pipe-D-eDP-1
[174.665233] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.849s)
[174.667844] Subtest invalid-async-flip: SUCCESS (4.737s)
[175.886624] [037/133] (846s left) gem_userptr_blits (huge-split)
[175.960686] Starting subtest: huge-split
[175.969533] Subtest huge-split: SUCCESS (0.009s)
[176.101441] [038/133] (845s left) kms_pm_dc (dc5-psr)
[177.195187] Starting subtest: dc5-psr
[180.081646] Subtest dc5-psr: SUCCESS (2.888s)
[180.888859] [039/133] (841s left) prime_mmap (test_forked_cpu_write)
[180.958752] Starting subtest: test_forked_cpu_write
[180.960775] Starting dynamic subtest: test_forked_cpu_write-smem
[180.968392] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.012s)
[180.970759] Subtest test_forked_cpu_write: SUCCESS (0.013s)
[181.086690] [040/133] (841s left) kms_invalid_mode (zero-vdisplay)
[181.195733] Starting subtest: zero-vdisplay
[181.198044] Starting dynamic subtest: pipe-A-eDP-1
[181.479310] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[181.490662] Starting dynamic subtest: pipe-B-eDP-1
[181.492630] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[181.500783] Starting dynamic subtest: pipe-C-eDP-1
[181.503029] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[181.510723] Starting dynamic subtest: pipe-D-eDP-1
[181.513063] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[181.515399] Subtest zero-vdisplay: SUCCESS (0.290s)
[182.288659] [041/133] (839s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[182.409586] Starting subtest: basic-busy-flip-before-cursor-legacy
[182.414253] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[182.551382] [042/133] (839s left) gem_eio (in-flight-contexts-1us)
[182.752522] Starting subtest: in-flight-contexts-1us
[192.929058] Subtest in-flight-contexts-1us: SUCCESS (10.177s)
[193.103529] [043/133] (829s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[193.203904] Starting subtest: 4-tiled-32bpp-rotate-270
[193.224070] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.020s)
[193.324585] [044/133] (829s left) perf (invalid-oa-format-id)
[193.416775] Starting subtest: invalid-oa-format-id
[193.426949] Subtest invalid-oa-format-id: SUCCESS (0.008s)
[193.468888] [045/133] (828s left) tools_test (tools_test)
[193.519845] Starting subtest: tools_test
[193.568482] Subtest tools_test: SUCCESS (0.067s)
[193.650505] [046/133] (828s left) prime_mmap (test_refcounting)
[193.709223] Starting subtest: test_refcounting
[193.711135] Starting dynamic subtest: test_refcounting-smem
[193.739616] Dynamic subtest test_refcounting-smem: SUCCESS (0.033s)
[193.741992] Subtest test_refcounting: SUCCESS (0.033s)
[193.846655] [047/133] (828s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[193.955674] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[198.013756] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.062s)
[199.192155] [048/133] (823s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[199.283654] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[199.287955] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[199.362226] [049/133] (823s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[199.432443] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[199.503621] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.005s)
[199.539538] [050/133] (823s left) kms_sequence (get-forked)
[199.626319] Starting subtest: get-forked
[199.628488] Starting dynamic subtest: pipe-A-eDP-1
[201.505763] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.878s)
[201.515809] Starting dynamic subtest: pipe-B-eDP-1
[204.127456] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.619s)
[204.136839] Starting dynamic subtest: pipe-C-eDP-1
[206.717663] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.588s)
[206.727860] Starting dynamic subtest: pipe-D-eDP-1
[209.286651] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.569s)
[209.288955] Subtest get-forked: SUCCESS (9.659s)
[210.083571] [051/133] (812s left) kms_flip (2x-flip-vs-suspend)
[210.186230] Starting subtest: 2x-flip-vs-suspend
[210.199870] Subtest 2x-flip-vs-suspend: SKIP (0.013s)
[210.283204] [052/133] (812s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[210.380610] Starting subtest: fbcpsr-rgb565-draw-blt
[217.382454] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.005s)
[217.506718] [053/133] (805s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[217.607892] Starting subtest: yf-tiled-64bpp-rotate-90
[217.612149] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[217.727433] [054/133] (804s left) gem_mmap_gtt (hang-user)
[217.792521] Subtest hang-user: SKIP (0.000s)
[217.854734] [055/133] (804s left) vgem_basic (busy-fence)
[217.947189] Starting subtest: busy-fence
[217.949452] Subtest busy-fence: SUCCESS (0.000s)
[218.014966] [FACT vgem_basic (busy-fence)] new: kernel.kmod_is_loaded.vgem: true
[218.018008] [056/133] (804s left) kms_psr (psr2-cursor-render)
[218.112173] Starting subtest: psr2-cursor-render
[218.114352] Starting dynamic subtest: eDP-1
[219.817447] Dynamic subtest eDP-1: SUCCESS (1.706s)
[219.819874] Subtest psr2-cursor-render: SUCCESS (1.708s)
[220.699099] [057/133] (802s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[220.795081] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[220.797354] Starting dynamic subtest: pipe-A-default-mode
[221.927611] Dynamic subtest pipe-A-default-mode: SKIP (1.129s)
[221.931689] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.131s)
[222.060196] [058/133] (800s left) kms_flip (2x-flip-vs-panning-vs-hang)
[222.156015] Starting subtest: 2x-flip-vs-panning-vs-hang
[222.166262] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.010s)
[222.248871] [059/133] (800s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[222.345018] Starting subtest: pr-cursor-plane-move-continuous-sf
[222.349317] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[222.412679] [060/133] (800s left) api_intel_bb (delta-check)
[222.458338] Starting subtest: delta-check
[222.460722] Subtest delta-check: SUCCESS (0.005s)
[222.583413] [061/133] (800s left) gem_exec_parallel (contexts)
[222.641756] Starting subtest: contexts
[222.644247] Starting dynamic subtest: rcs0
[226.330047] Dynamic subtest rcs0: SUCCESS (3.686s)
[226.341279] Starting dynamic subtest: bcs0
[230.392674] Dynamic subtest bcs0: SUCCESS (4.060s)
[230.404108] Starting dynamic subtest: vcs0
[236.272225] Dynamic subtest vcs0: SUCCESS (5.879s)
[236.281435] Starting dynamic subtest: vcs1
[240.427185] Dynamic subtest vcs1: SUCCESS (4.151s)
[240.439111] Starting dynamic subtest: vecs0
[246.359936] Dynamic subtest vecs0: SUCCESS (5.932s)
[246.368887] Starting dynamic subtest: ccs0
[250.583346] Dynamic subtest ccs0: SUCCESS (4.221s)
[250.585883] Subtest contexts: SUCCESS (27.942s)
[250.768848] [062/133] (772s left) i915_pm_rpm (debugfs-read)
[253.005511] Starting subtest: debugfs-read
[254.163367] Subtest debugfs-read: SUCCESS (1.155s)
[254.535336] [063/133] (768s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[254.638644] Starting subtest: fbc-rgb101010-draw-pwrite
[259.983829] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.349s)
[261.177659] [064/133] (761s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[261.229960] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[261.337313] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.106s)
[261.413116] [065/133] (761s left) kms_prop_blob (blob-multiple)
[261.470784] Starting subtest: blob-multiple
[261.473170] Subtest blob-multiple: SUCCESS (0.002s)
[261.576736] [066/133] (761s left) kms_draw_crc (draw-method-mmap-gtt)
[261.660042] Starting subtest: draw-method-mmap-gtt
[261.664635] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[261.767460] [067/133] (761s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[261.871505] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[262.995934] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.124s)
[263.163203] [068/133] (760s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[263.261808] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[263.265306] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.000s)
[263.335364] [069/133] (760s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[263.441326] Starting subtest: y-tiled-8bpp-rotate-180
[263.445020] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[263.538220] [070/133] (759s left) gem_softpin (noreloc)
[263.600136] Starting subtest: noreloc
[269.017304] Subtest noreloc: SUCCESS (5.415s)
[269.171342] [071/133] (754s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[269.272415] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[269.276811] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[269.371744] [072/133] (754s left) gem_ctx_persistence (heartbeat-hang)
[269.429052] Starting subtest: heartbeat-hang
[269.433679] Subtest heartbeat-hang: SKIP (0.000s)
[269.527820] [073/133] (754s left) gem_exec_whisper (basic-normal-all)
[269.583126] Starting subtest: basic-normal-all
[272.036660] Subtest basic-normal-all: SUCCESS (2.451s)
[272.226771] [074/133] (751s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[272.338201] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[272.342554] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[272.450629] [075/133] (751s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[272.541735] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[272.546055] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[272.636889] [076/133] (751s left) kms_plane_lowres (tiling-none)
[272.733331] Starting subtest: tiling-none
[272.735664] Starting dynamic subtest: pipe-A-eDP-1
[272.740337] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[273.026764] Starting dynamic subtest: pipe-B-eDP-1
[273.031402] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[273.043342] Starting dynamic subtest: pipe-C-eDP-1
[273.048251] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[273.056887] Starting dynamic subtest: pipe-D-eDP-1
[273.061092] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[273.065237] Subtest tiling-none: SKIP (0.293s)
[273.872594] [077/133] (749s left) gem_tiled_fence_blits (basic)
[273.928573] Subtest basic: SKIP (0.000s)
[274.006532] [078/133] (749s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[274.059786] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[274.160458] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.102s)
[274.238690] [079/133] (749s left) perf (per-context-mode-unprivileged)
[274.323318] Starting subtest: per-context-mode-unprivileged
[274.327528] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[274.369442] [080/133] (749s left) kms_psr (pr-dpms)
[274.461848] Starting subtest: pr-dpms
[274.466103] Subtest pr-dpms: SKIP (0.000s)
[274.533900] [081/133] (749s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[274.640319] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[274.644437] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[274.721814] [082/133] (749s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[274.807278] Starting subtest: basic-modeset-with-all-modifiers-formats
[275.181470] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[275.914816] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.735s)
[275.924241] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[275.936493] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[275.945078] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[275.958785] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.022s)
[275.969561] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[276.103303] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.144s)
[276.114806] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[276.125384] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[276.134038] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[276.147643] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.021s)
[276.156135] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[276.169981] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.021s)
[276.178396] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[276.192188] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.021s)
[276.200600] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[276.214377] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s)
[276.223064] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[276.236577] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.021s)
[276.245079] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[276.258989] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.021s)
[276.267388] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[276.281109] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.021s)
[276.289768] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[276.436635] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.155s)
[276.446136] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[276.459058] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.022s)
[276.467351] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[276.480985] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.021s)
[276.489581] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[276.503203] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.021s)
[276.511530] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[276.525422] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s)
[276.533530] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[276.547663] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.022s)
[276.555724] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[276.569877] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.021s)
[276.577861] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[276.592119] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.021s)
[276.600224] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[276.614245] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.021s)
[276.622350] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[276.781362] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.166s)
[276.790691] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[276.803880] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s)
[276.813058] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[276.825846] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.021s)
[276.834844] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[276.847503] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s)
[276.855511] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[276.869615] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.021s)
[276.877864] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[276.892020] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s)
[276.899602] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[276.914483] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[276.922238] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[276.936529] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.021s)
[276.944229] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[276.958727] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.021s)
[277.344289] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.539s)
[278.176397] [083/133] (745s left) syncobj_timeline (signal)
[278.226165] Starting subtest: signal
[278.228330] Subtest signal: SUCCESS (0.000s)
[278.325688] [084/133] (745s left) kms_hdr (invalid-metadata-sizes)
[278.412045] Starting subtest: invalid-metadata-sizes
[278.418394] Subtest invalid-metadata-sizes: SKIP (0.000s)
[278.483407] [085/133] (745s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[278.583261] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[282.546963] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (3.967s)
[283.680525] [086/133] (740s left) gem_softpin (allocator-nopin)
[283.743086] Starting subtest: allocator-nopin
[283.837333] Subtest allocator-nopin: SUCCESS (0.096s)
[283.975138] [087/133] (740s left) kms_cursor_crc (cursor-onscreen-128x42)
[284.201630] Starting subtest: cursor-onscreen-128x42
[284.252055] Subtest cursor-onscreen-128x42: SKIP (0.044s)
[284.474328] [088/133] (739s left) syncobj_timeline (invalid-wait-illegal-handle)
[284.539460] Starting subtest: invalid-wait-illegal-handle
[284.541709] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[284.639556] [089/133] (739s left) perf_pmu (busy-accuracy-2)
[284.681740] Starting subtest: busy-accuracy-2
[284.683550] Starting dynamic subtest: rcs0
[287.726615] Dynamic subtest rcs0: SUCCESS (3.042s)
[287.737962] Starting dynamic subtest: bcs0
[290.789041] Dynamic subtest bcs0: SUCCESS (3.060s)
[290.797918] Starting dynamic subtest: vcs0
[293.837674] Dynamic subtest vcs0: SUCCESS (3.046s)
[293.847103] Starting dynamic subtest: vcs1
[296.882777] Dynamic subtest vcs1: SUCCESS (3.043s)
[296.892115] Starting dynamic subtest: vecs0
[299.928035] Dynamic subtest vecs0: SUCCESS (3.043s)
[299.938600] Starting dynamic subtest: ccs0
[302.989518] Dynamic subtest ccs0: SUCCESS (3.059s)
[302.992019] Subtest busy-accuracy-2: SUCCESS (18.307s)
[303.105437] [090/133] (721s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[303.218934] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[303.221215] Starting dynamic subtest: pipe-A-eDP-1
[303.243639] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[303.254434] Starting dynamic subtest: pipe-B-eDP-1
[303.275900] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[303.284392] Starting dynamic subtest: pipe-C-eDP-1
[303.305873] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[303.314587] Starting dynamic subtest: pipe-D-eDP-1
[303.336165] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[303.340188] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.005s)
[305.472161] [091/133] (718s left) gem_pipe_control_store_loop (fresh-buffer)
[305.532550] Starting subtest: fresh-buffer
[307.686796] Subtest fresh-buffer: SUCCESS (2.152s)
[307.809223] [092/133] (716s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[307.897891] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[315.124867] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.230s)
[315.237215] [093/133] (709s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[315.343636] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[315.347602] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[315.441392] [094/133] (708s left) perf (invalid-oa-metric-set-id)
[315.538215] Starting subtest: invalid-oa-metric-set-id
[315.550965] Subtest invalid-oa-metric-set-id: SUCCESS (0.012s)
[315.602152] [095/133] (708s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[315.704830] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[316.687768] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.982s)
[316.825688] [096/133] (707s left) gem_softpin (evict-snoop-interruptible)
[316.892762] Starting subtest: evict-snoop-interruptible
[316.897353] Subtest evict-snoop-interruptible: SKIP (0.000s)
[317.012756] [097/133] (707s left) kms_flip (modeset-vs-vblank-race)
[317.106819] Starting subtest: modeset-vs-vblank-race
[317.108765] Starting dynamic subtest: A-eDP1
[321.747929] Dynamic subtest A-eDP1: SUCCESS (4.639s)
[321.759299] Starting dynamic subtest: B-eDP1
[326.454232] Dynamic subtest B-eDP1: SUCCESS (4.704s)
[326.470493] Starting dynamic subtest: C-eDP1
[331.141054] Dynamic subtest C-eDP1: SUCCESS (4.685s)
[331.152682] Starting dynamic subtest: D-eDP1
[335.832997] Dynamic subtest D-eDP1: SUCCESS (4.689s)
[335.835213] Subtest modeset-vs-vblank-race: SUCCESS (18.729s)
[337.072268] [098/133] (687s left) gem_eio (banned)
[337.299444] Starting subtest: banned
[337.925963] Subtest banned: SUCCESS (0.625s)
[338.074969] [099/133] (686s left) kms_cursor_crc (cursor-random-128x42)
[338.310167] Starting subtest: cursor-random-128x42
[338.355216] Subtest cursor-random-128x42: SKIP (0.043s)
[338.572321] [100/133] (686s left) kms_lease (lease-revoke)
[338.664288] Starting subtest: lease-revoke
[338.666139] Starting dynamic subtest: pipe-A-eDP-1
[338.693561] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.030s)
[338.702475] Starting dynamic subtest: pipe-B-eDP-1
[338.724174] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.027s)
[338.732752] Starting dynamic subtest: pipe-C-eDP-1
[338.749295] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.026s)
[338.757924] Starting dynamic subtest: pipe-D-eDP-1
[338.776189] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.026s)
[338.778078] Subtest lease-revoke: SUCCESS (0.114s)
[338.905957] [101/133] (685s left) gem_exec_reloc (basic-gtt-noreloc)
[338.962138] Subtest basic-gtt-noreloc: SKIP (0.000s)
[339.027125] [102/133] (685s left) kms_pipe_stress (stress-xrgb8888-untiled)
[339.120337] Starting subtest: stress-xrgb8888-untiled
[344.977754] Subtest stress-xrgb8888-untiled: SUCCESS (5.859s)
[345.025836] [103/133] (679s left) kms_content_protection (mei-interface)
[345.174778] Starting subtest: mei-interface
[345.178805] Subtest mei-interface: SKIP (0.001s)
[345.307392] [104/133] (679s left) gem_mmap_gtt (cpuset-big-copy-odd)
[345.365294] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[345.428832] [105/133] (679s left) prime_self_import (basic-with_fd_dup)
[345.461613] Starting subtest: basic-with_fd_dup
[345.486089] Subtest basic-with_fd_dup: SUCCESS (0.027s)
[345.592682] [106/133] (679s left) fbdev (nullptr)
[345.631094] Starting subtest: nullptr
[345.633069] Subtest nullptr: SUCCESS (0.000s)
[345.692289] [107/133] (679s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[345.804927] Starting subtest: psr-rgb101010-draw-mmap-cpu
[352.938340] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (7.137s)
[353.069245] [108/133] (671s left) i915_hangman (error-state-basic)
[353.135367] Starting subtest: error-state-basic
[353.294625] Subtest error-state-basic: SUCCESS (0.162s)
[353.373669] [109/133] (671s left) kms_rotation_crc (bad-tiling)
[353.478305] Starting subtest: bad-tiling
[353.482259] Subtest bad-tiling: SKIP (0.001s)
[353.591657] [110/133] (671s left) gem_userptr_blits (sync-unmap-after-close)
[353.662709] Starting subtest: sync-unmap-after-close
[353.673600] Subtest sync-unmap-after-close: SUCCESS (0.011s)
[353.796466] [111/133] (671s left) kms_flip (flip-vs-expired-vblank-interruptible)
[353.890252] Starting subtest: flip-vs-expired-vblank-interruptible
[353.894440] Starting dynamic subtest: A-eDP1
[362.528425] Dynamic subtest A-eDP1: SUCCESS (8.635s)
[362.542353] Starting dynamic subtest: B-eDP1
[371.132622] Dynamic subtest B-eDP1: SUCCESS (8.601s)
[371.143585] Starting dynamic subtest: C-eDP1
[379.822676] Dynamic subtest C-eDP1: SUCCESS (8.688s)
[379.831790] Starting dynamic subtest: D-eDP1
[388.518536] Dynamic subtest D-eDP1: SUCCESS (8.694s)
[388.520979] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.630s)
[389.763536] [112/133] (635s left) gem_exec_fence (syncobj-timeline-chain-engines)
[390.373222] Starting subtest: syncobj-timeline-chain-engines
[390.499661] Subtest syncobj-timeline-chain-engines: SUCCESS (0.126s)
[391.985284] [113/133] (633s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[392.085979] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[392.089868] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[392.161451] [114/133] (633s left) kms_cursor_edge_walk (64x64-left-edge)
[392.255165] Starting subtest: 64x64-left-edge
[392.257445] Starting dynamic subtest: pipe-A-eDP-1
[395.687084] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.433s)
[395.697604] Starting dynamic subtest: pipe-D-eDP-1
[398.903056] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.213s)
[398.905482] Subtest 64x64-left-edge: SUCCESS (6.649s)
[399.760443] [115/133] (625s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[399.850847] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[399.853152] Starting dynamic subtest: pipe-A-eDP-1
[399.875597] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[399.887880] Starting dynamic subtest: pipe-B-eDP-1
[399.909645] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[399.918071] Starting dynamic subtest: pipe-C-eDP-1
[399.939608] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[399.947647] Starting dynamic subtest: pipe-D-eDP-1
[399.969455] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[399.973843] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[402.056979] [116/133] (623s left) gem_exec_schedule (fifo)
[402.132926] Starting subtest: fifo
[402.135222] Starting dynamic subtest: rcs0
[402.229044] Dynamic subtest rcs0: SUCCESS (0.101s)
[402.243185] Starting dynamic subtest: vcs0
[402.312393] Dynamic subtest vcs0: SUCCESS (0.083s)
[402.322498] Starting dynamic subtest: vcs1
[402.399895] Dynamic subtest vcs1: SUCCESS (0.085s)
[402.412286] Starting dynamic subtest: vecs0
[402.487123] Dynamic subtest vecs0: SUCCESS (0.085s)
[402.498379] Starting dynamic subtest: ccs0
[402.579772] Dynamic subtest ccs0: SUCCESS (0.090s)
[402.582469] Subtest fifo: SUCCESS (0.452s)
[404.017249] [117/133] (621s left) kms_psr (fbc-psr2-basic)
[404.105031] Starting subtest: fbc-psr2-basic
[404.107355] Starting dynamic subtest: eDP-1
[404.111702] Dynamic subtest eDP-1: SKIP (0.000s)
[404.116096] Subtest fbc-psr2-basic: SKIP (0.001s)
[404.194442] [118/133] (621s left) prime_mmap (test_forked)
[404.253971] Starting subtest: test_forked
[404.256283] Starting dynamic subtest: test_forked-smem
[404.297077] Dynamic subtest test_forked-smem: SUCCESS (0.043s)
[404.299705] Subtest test_forked: SUCCESS (0.044s)
[404.403365] [119/133] (621s left) i915_query (query-regions-garbage-items)
[404.457563] Starting subtest: query-regions-garbage-items
[404.459743] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[404.561920] [120/133] (620s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[404.665400] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[404.669644] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[404.748738] [121/133] (620s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[404.871396] Starting subtest: cursorA-vs-flipB-varying-size
[404.876109] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[405.019749] [122/133] (620s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[405.108879] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[405.112156] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[405.220328] [123/133] (620s left) gem_render_copy (linear-to-vebox-yf-tiled)
[405.288539] Starting subtest: linear-to-vebox-yf-tiled
[405.292044] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[405.472972] [124/133] (620s left) gem_ctx_isolation (nonpriv)
[405.542217] Starting subtest: nonpriv
[405.544561] Starting dynamic subtest: rcs0
[405.764066] Dynamic subtest rcs0: SUCCESS (0.221s)
[405.773750] Starting dynamic subtest: bcs0
[406.002674] Dynamic subtest bcs0: SUCCESS (0.237s)
[406.014116] Starting dynamic subtest: vcs0
[406.246127] Dynamic subtest vcs0: SUCCESS (0.243s)
[406.257433] Starting dynamic subtest: vcs1
[408.155874] Dynamic subtest vcs1: SUCCESS (1.909s)
[408.167159] Starting dynamic subtest: vecs0
[410.186043] Dynamic subtest vecs0: SUCCESS (2.029s)
[410.197434] Starting dynamic subtest: ccs0
[412.182579] Dynamic subtest ccs0: SUCCESS (1.995s)
[412.185274] Subtest nonpriv: SUCCESS (6.640s)
[412.412487] [125/133] (613s left) kms_psr (fbc-psr-primary-mmap-gtt)
[412.508050] Starting subtest: fbc-psr-primary-mmap-gtt
[412.510304] Starting dynamic subtest: eDP-1
[412.514398] Dynamic subtest eDP-1: SKIP (0.000s)
[412.518545] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[412.584238] [126/133] (613s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[412.681072] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[412.684959] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[412.782144] [127/133] (613s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[413.040777] Starting subtest: parallel-dmabuf-import-out-fence
[414.279039] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.239s)
[414.374758] [128/133] (611s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[414.476863] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[414.478781] Starting dynamic subtest: A-eDP1
[423.367268] Dynamic subtest A-eDP1: SUCCESS (8.889s)
[423.381366] Starting dynamic subtest: B-eDP1
[432.263794] Dynamic subtest B-eDP1: SUCCESS (8.894s)
[432.275681] Starting dynamic subtest: C-eDP1
[441.146011] Dynamic subtest C-eDP1: SUCCESS (8.879s)
[441.160041] Starting dynamic subtest: D-eDP1
[450.055325] Dynamic subtest D-eDP1: SUCCESS (8.906s)
[450.057195] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.582s)
[451.243933] [129/133] (574s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[451.350538] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[451.354653] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[451.436198] [130/133] (574s left) kms_plane (plane-position-covered)
[451.540101] Starting subtest: plane-position-covered
[452.075110] Starting dynamic subtest: pipe-A-plane-1
[453.407160] Dynamic subtest pipe-A-plane-1: SUCCESS (1.334s)
[453.416516] Starting dynamic subtest: pipe-A-plane-2
[454.679508] Dynamic subtest pipe-A-plane-2: SUCCESS (1.272s)
[454.689659] Starting dynamic subtest: pipe-A-plane-3
[456.006585] Dynamic subtest pipe-A-plane-3: SUCCESS (1.325s)
[456.016252] Starting dynamic subtest: pipe-A-plane-4
[457.348741] Dynamic subtest pipe-A-plane-4: SUCCESS (1.340s)
[457.360640] Starting dynamic subtest: pipe-A-plane-5
[457.373388] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[458.523817] Starting dynamic subtest: pipe-B-plane-1
[459.800106] Dynamic subtest pipe-B-plane-1: SUCCESS (1.284s)
[459.809860] Starting dynamic subtest: pipe-B-plane-2
[461.113093] Dynamic subtest pipe-B-plane-2: SUCCESS (1.311s)
[461.123782] Starting dynamic subtest: pipe-B-plane-3
[462.366873] Dynamic subtest pipe-B-plane-3: SUCCESS (1.255s)
[462.376374] Starting dynamic subtest: pipe-B-plane-4
[463.692579] Dynamic subtest pipe-B-plane-4: SUCCESS (1.325s)
[463.703035] Starting dynamic subtest: pipe-B-plane-5
[463.720529] Dynamic subtest pipe-B-plane-5: SUCCESS (0.026s)
[463.722808] Subtest plane-position-covered: SUCCESS (12.181s)
[464.549547] [131/133] (561s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[464.669547] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[464.673880] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[464.816553] [132/133] (561s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[464.910201] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[464.912488] Starting dynamic subtest: pipe-A-eDP-1
[464.935439] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[464.947085] Starting dynamic subtest: pipe-B-eDP-1
[464.968539] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[464.977222] Starting dynamic subtest: pipe-C-eDP-1
[464.998896] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[465.007698] Starting dynamic subtest: pipe-D-eDP-1
[465.030256] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[465.034635] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[467.141657] [133/133] (558s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[467.233589] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[467.237609] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[467.330950] 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.