[61.219499] Initializing watchdogs
[61.219565]   /dev/watchdog0
[61.234489] [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]
[61.238874] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.241068] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.244336] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[61.372098] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[61.376211] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[61.460969] [002/133] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[61.550050] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[61.554211] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[61.645920] [003/133] (960s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[61.748735] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[62.438822] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.692s)
[62.590828] [004/133] (959s left) gen7_exec_parse (basic-offset)
[62.647505] Subtest basic-offset: SKIP (0.000s)
[62.703436] [005/133] (959s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[62.794448] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[67.266200] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.476s)
[68.453492] [006/133] (953s left) tools_test (tools_test)
[68.503776] Starting subtest: tools_test
[68.570439] Subtest tools_test: SUCCESS (0.078s)
[68.642820] [007/133] (953s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[68.730990] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[68.735622] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[69.892327] [008/133] (952s left) kms_flip (modeset-vs-vblank-race)
[70.006666] Starting subtest: modeset-vs-vblank-race
[70.009157] Starting dynamic subtest: A-eDP1
[74.722185] Dynamic subtest A-eDP1: SUCCESS (4.719s)
[74.732079] Starting dynamic subtest: B-eDP1
[79.431398] Dynamic subtest B-eDP1: SUCCESS (4.708s)
[79.445309] Starting dynamic subtest: C-eDP1
[84.043823] Dynamic subtest C-eDP1: SUCCESS (4.611s)
[84.053416] Starting dynamic subtest: D-eDP1
[88.609353] Dynamic subtest D-eDP1: SUCCESS (4.564s)
[88.611798] Subtest modeset-vs-vblank-race: SUCCESS (18.610s)
[89.780962] [009/133] (932s left) i915_pm_rpm (reg-read-ioctl)
[92.124336] Starting subtest: reg-read-ioctl
[94.515201] Subtest reg-read-ioctl: SUCCESS (2.393s)
[94.971518] [010/133] (927s left) gem_exec_balancer (hang)
[95.237259] Starting subtest: hang
[96.917981] Subtest hang: SUCCESS (1.682s)
[97.037216] [011/133] (925s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[97.128863] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[97.133365] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[97.214369] [012/133] (925s left) perf_pmu (faulting-read)
[97.261810] Starting subtest: faulting-read
[97.264229] Starting dynamic subtest: wb
[97.266224] Dynamic subtest wb: SUCCESS (0.001s)
[97.275252] Starting dynamic subtest: wc
[97.277486] Dynamic subtest wc: SUCCESS (0.000s)
[97.284980] Starting dynamic subtest: uc
[97.287173] Dynamic subtest uc: SUCCESS (0.000s)
[97.289311] Subtest faulting-read: SUCCESS (0.002s)
[97.380244] [013/133] (924s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[97.479431] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[97.483664] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[97.576011] [014/133] (924s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[97.951356] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[98.806526] [015/133] (923s left) gem_exec_schedule (pi-distinct-iova)
[98.992650] Starting subtest: pi-distinct-iova
[98.994762] Starting dynamic subtest: rcs0
[99.064186] Dynamic subtest rcs0: SUCCESS (0.074s)
[99.073286] Starting dynamic subtest: vcs0
[99.124354] Dynamic subtest vcs0: SUCCESS (0.060s)
[99.132927] Starting dynamic subtest: vcs1
[99.189828] Dynamic subtest vcs1: SUCCESS (0.064s)
[99.200515] Starting dynamic subtest: vecs0
[99.245528] Dynamic subtest vecs0: SUCCESS (0.056s)
[99.256757] Starting dynamic subtest: ccs0
[99.310312] Dynamic subtest ccs0: SUCCESS (0.064s)
[99.312442] Subtest pi-distinct-iova: SUCCESS (0.321s)
[100.976234] [016/133] (921s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[101.073870] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[101.077999] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[101.158225] [017/133] (921s left) drm_read (short-buffer-block)
[101.309351] Starting subtest: short-buffer-block
[101.311762] Subtest short-buffer-block: SUCCESS (0.000s)
[101.436773] [018/133] (921s left) perf (oa-formats)
[101.545721] Starting subtest: oa-formats
[101.547906] Starting dynamic subtest: 0-rcs0
[101.558472] Dynamic subtest 0-rcs0: SUCCESS (0.014s)
[101.567417] Starting dynamic subtest: 1-vcs1
[101.579755] Dynamic subtest 1-vcs1: SUCCESS (0.021s)
[101.581920] Subtest oa-formats: SUCCESS (0.036s)
[101.628108] [019/133] (920s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[101.715237] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[101.719323] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[101.811494] [020/133] (920s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[101.904975] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[101.908885] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[102.017678] [021/133] (920s left) kms_psr (pr-basic)
[102.113897] Starting subtest: pr-basic
[102.117525] Subtest pr-basic: SKIP (0.000s)
[102.194460] [022/133] (920s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[102.293109] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[102.295058] Starting dynamic subtest: pipe-A-eDP-1
[102.313438] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[102.321916] Starting dynamic subtest: pipe-B-eDP-1
[102.338953] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[102.346591] Starting dynamic subtest: pipe-C-eDP-1
[102.363609] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[102.370707] Starting dynamic subtest: pipe-D-eDP-1
[102.388199] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[102.391724] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[104.571029] [023/133] (918s left) kms_chamelium_edid (hdmi-mode-timings)
[104.976387] Subtest hdmi-mode-timings: SKIP (0.000s)
[105.782220] [024/133] (916s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[105.924449] Starting subtest: dp-mst-lic-type-0-hdcp14
[105.929206] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[106.038385] [025/133] (916s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[106.138617] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[106.142966] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[106.222852] [026/133] (916s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[106.308986] Starting subtest: primary-4-tiled-reflect-x-180
[113.339429] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.033s)
[114.486318] [027/133] (908s left) kms_flip (2x-flip-vs-panning-interruptible)
[114.584111] Starting subtest: 2x-flip-vs-panning-interruptible
[114.596131] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[114.670257] [028/133] (908s left) kms_flip (plain-flip-fb-recreate)
[114.762519] Starting subtest: plain-flip-fb-recreate
[114.764834] Starting dynamic subtest: A-eDP1
[123.684721] Dynamic subtest A-eDP1: SUCCESS (8.922s)
[123.693089] Starting dynamic subtest: B-eDP1
[132.518268] Dynamic subtest B-eDP1: SUCCESS (8.832s)
[132.528303] Starting dynamic subtest: C-eDP1
[141.334881] Dynamic subtest C-eDP1: SUCCESS (8.816s)
[141.344177] Starting dynamic subtest: D-eDP1
[150.168420] Dynamic subtest D-eDP1: SUCCESS (8.831s)
[150.173212] Subtest plain-flip-fb-recreate: SUCCESS (35.412s)
[151.344532] [029/133] (871s left) gem_tiled_partial_pwrite_pread (writes)
[151.416258] Subtest writes: SKIP (0.000s)
[151.475542] [030/133] (871s left) gem_lmem_swapping (heavy-verify-random)
[151.517519] Subtest heavy-verify-random: SKIP (0.000s)
[151.560174] [031/133] (871s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[151.645977] Starting subtest: x-tiled-64bpp-rotate-90
[151.667945] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[151.777949] [032/133] (871s left) vgem_basic (debugfs)
[151.876151] Starting subtest: debugfs
[151.878559] Subtest debugfs: SUCCESS (0.001s)
[151.930729] [FACT vgem_basic (debugfs)] new: kernel.kmod_is_loaded.vgem: true
[151.933764] [033/133] (871s left) kms_atomic_interruptible (legacy-setmode)
[152.023736] Starting subtest: legacy-setmode
[152.025896] Starting dynamic subtest: pipe-A-eDP-1
[158.938435] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.912s)
[158.940639] Subtest legacy-setmode: SUCCESS (6.913s)
[159.799669] [034/133] (863s left) gem_pxp (reject-modify-context-protection-off-2)
[159.927276] Starting subtest: reject-modify-context-protection-off-2
[159.929772] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[160.047359] [035/133] (863s left) gem_exec_basic (basic)
[160.105707] Starting subtest: basic
[160.107614] Starting dynamic subtest: rcs0-smem
[160.109954] Dynamic subtest rcs0-smem: SUCCESS (0.004s)
[160.121956] Starting dynamic subtest: bcs0-smem
[160.124045] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[160.133704] Starting dynamic subtest: vcs0-smem
[160.135542] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[160.142967] Starting dynamic subtest: vcs1-smem
[160.144760] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[160.152337] Starting dynamic subtest: vecs0-smem
[160.154198] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[160.161850] Starting dynamic subtest: ccs0-smem
[160.163709] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[160.165562] Subtest basic: SUCCESS (0.016s)
[161.980242] [036/133] (861s left) api_intel_bb (offset-control)
[162.038873] Starting subtest: offset-control
[162.043762] Subtest offset-control: SUCCESS (0.007s)
[162.162338] [037/133] (861s left) kms_joiner (basic-max-non-joiner)
[162.260994] Starting subtest: basic-max-non-joiner
[162.265374] Subtest basic-max-non-joiner: SKIP (0.000s)
[162.339512] [038/133] (860s left) kms_addfb_basic (small-bo)
[162.429161] Starting subtest: small-bo
[162.431306] Subtest small-bo: SUCCESS (0.000s)
[162.518290] [039/133] (860s left) i915_query (query-topology-garbage-items)
[162.566651] Starting subtest: query-topology-garbage-items
[162.568529] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[162.658992] [040/133] (860s left) perf (gen12-group-exclusive-stream-ctx-handle)
[162.751099] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[162.780694] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.028s)
[162.824820] [041/133] (860s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[163.873197] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[163.877492] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[163.979743] [042/133] (859s left) gem_exec_params (cliprects-invalid)
[164.040082] Starting subtest: cliprects-invalid
[164.042403] Subtest cliprects-invalid: SUCCESS (0.000s)
[164.156188] [043/133] (859s left) kms_cursor_crc (cursor-random-64x64)
[164.324806] Starting subtest: cursor-random-64x64
[164.330053] Starting dynamic subtest: pipe-A-eDP-1
[167.682958] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.355s)
[167.710874] Starting dynamic subtest: pipe-D-eDP-1
[171.717314] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.011s)
[171.719894] Subtest cursor-random-64x64: SUCCESS (7.391s)
[172.582908] [044/133] (850s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[172.680396] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[172.684901] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[172.796365] [045/133] (850s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[172.895397] Starting subtest: 4-tiled-16bpp-rotate-180
[174.252460] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.358s)
[174.363461] [046/133] (849s left) dumb_buffer (create-valid-dumb)
[174.416590] Starting subtest: create-valid-dumb
[174.418308] Subtest create-valid-dumb: SUCCESS (0.000s)
[174.511788] [047/133] (849s left) gem_softpin (zero)
[174.568563] Starting subtest: zero
[174.574042] Subtest zero: SUCCESS (0.004s)
[174.712358] [048/133] (849s left) gem_blits (basic)
[174.795905] Starting subtest: basic
[176.271855] Subtest basic: SUCCESS (1.475s)
[176.385968] [049/133] (847s left) gem_busy (close-race)
[176.443647] Starting subtest: close-race
[201.877747] Subtest close-race: SUCCESS (25.431s)
[202.242110] [050/133] (821s left) gem_exec_alignment (forked)
[202.349983] Starting subtest: forked
[242.766997] Subtest forked: SUCCESS (40.418s)
[242.846489] [051/133] (781s left) syncobj_eventfd (binary-wait-before-signal)
[242.950869] Starting subtest: binary-wait-before-signal
[242.981965] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[243.074087] [052/133] (780s left) prime_mmap (test_errors)
[243.125428] Starting subtest: test_errors
[243.127381] Starting dynamic subtest: test_errors-smem
[243.273751] Dynamic subtest test_errors-smem: SUCCESS (0.149s)
[243.276779] Subtest test_errors: SUCCESS (0.150s)
[243.380088] [053/133] (780s left) gem_ctx_persistence (heartbeat-stop)
[243.445887] Starting subtest: heartbeat-stop
[243.450728] Subtest heartbeat-stop: SKIP (0.000s)
[243.549080] [054/133] (780s left) gem_ctx_param (invalid-get-ringsize)
[243.608535] Starting subtest: invalid-get-ringsize
[243.610822] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[243.727379] [055/133] (780s left) i915_query (query-topology-matches-eu-total)
[243.784281] Starting subtest: query-topology-matches-eu-total
[243.786423] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[243.890370] [056/133] (780s left) kms_cursor_edge_walk (64x64-right-edge)
[243.993101] Starting subtest: 64x64-right-edge
[243.995374] Starting dynamic subtest: pipe-A-eDP-1
[247.446483] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.452s)
[247.455306] Starting dynamic subtest: pipe-D-eDP-1
[250.554727] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.107s)
[250.556998] Subtest 64x64-right-edge: SUCCESS (6.563s)
[251.390675] [057/133] (772s left) kms_plane (plane-position-covered)
[251.481081] Starting subtest: plane-position-covered
[252.017644] Starting dynamic subtest: pipe-A-plane-1
[253.264885] Dynamic subtest pipe-A-plane-1: SUCCESS (1.246s)
[253.274864] Starting dynamic subtest: pipe-A-plane-2
[254.508731] Dynamic subtest pipe-A-plane-2: SUCCESS (1.245s)
[254.519135] Starting dynamic subtest: pipe-A-plane-3
[255.817662] Dynamic subtest pipe-A-plane-3: SUCCESS (1.308s)
[255.828056] Starting dynamic subtest: pipe-A-plane-4
[257.068614] Dynamic subtest pipe-A-plane-4: SUCCESS (1.249s)
[257.078842] Starting dynamic subtest: pipe-A-plane-5
[257.094198] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[258.240594] Starting dynamic subtest: pipe-B-plane-1
[259.575461] Dynamic subtest pipe-B-plane-1: SUCCESS (1.340s)
[259.585161] Starting dynamic subtest: pipe-B-plane-2
[260.894144] Dynamic subtest pipe-B-plane-2: SUCCESS (1.319s)
[260.903560] Starting dynamic subtest: pipe-B-plane-3
[262.144076] Dynamic subtest pipe-B-plane-3: SUCCESS (1.247s)
[262.153822] Starting dynamic subtest: pipe-B-plane-4
[263.467861] Dynamic subtest pipe-B-plane-4: SUCCESS (1.325s)
[263.478597] Starting dynamic subtest: pipe-B-plane-5
[263.494472] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[263.496862] Subtest plane-position-covered: SUCCESS (12.013s)
[264.347982] [058/133] (759s left) kms_frontbuffer_tracking (psr-suspend)
[264.445657] Starting subtest: psr-suspend
[302.983534] Subtest psr-suspend: SUCCESS (8.928s)
[309.101750] [059/133] (721s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[309.213447] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[309.217390] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[309.328266] [060/133] (720s left) gem_exec_schedule (fairslice)
[309.411148] Starting subtest: fairslice
[309.413138] Starting dynamic subtest: rcs0
[311.423570] Dynamic subtest rcs0: SUCCESS (2.016s)
[311.435198] Starting dynamic subtest: bcs0
[313.443317] Dynamic subtest bcs0: SUCCESS (2.016s)
[313.454841] Starting dynamic subtest: vcs0
[315.460103] Dynamic subtest vcs0: SUCCESS (2.015s)
[315.472056] Starting dynamic subtest: vcs1
[317.474934] Dynamic subtest vcs1: SUCCESS (2.013s)
[317.486822] Starting dynamic subtest: vecs0
[319.495520] Dynamic subtest vecs0: SUCCESS (2.017s)
[319.507048] Starting dynamic subtest: ccs0
[321.514046] Dynamic subtest ccs0: SUCCESS (2.017s)
[321.516158] Subtest fairslice: SUCCESS (12.099s)
[321.811399] [061/133] (708s left) sw_sync (alloc_fence_invalid_timeline)
[321.865850] Starting subtest: alloc_fence_invalid_timeline
[321.868015] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[321.943015] [062/133] (708s left) gem_exec_whisper (basic-fds-forked)
[322.019934] Starting subtest: basic-fds-forked
[346.235258] Subtest basic-fds-forked: SUCCESS (24.211s)
[346.420020] [063/133] (683s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[346.516709] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[346.521160] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[346.630959] [064/133] (683s left) gem_vm_create (execbuf)
[346.692890] Starting subtest: execbuf
[346.700478] Subtest execbuf: SUCCESS (0.008s)
[346.840010] [065/133] (683s left) kms_cursor_crc (cursor-onscreen-256x85)
[347.095020] Starting subtest: cursor-onscreen-256x85
[347.140920] Subtest cursor-onscreen-256x85: SKIP (0.041s)
[347.316607] [066/133] (683s left) kms_plane_alpha_blend (coverage-7efc)
[347.409455] Starting subtest: coverage-7efc
[347.721744] Starting dynamic subtest: pipe-A-eDP-1
[348.320098] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.598s)
[348.350988] Starting dynamic subtest: pipe-D-eDP-1
[349.625115] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.284s)
[349.627417] Subtest coverage-7efc: SUCCESS (2.217s)
[350.471183] [067/133] (680s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[350.576449] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[350.578661] Starting dynamic subtest: pipe-A
[350.596325] Dynamic subtest pipe-A: SKIP (0.018s)
[350.608309] Starting dynamic subtest: pipe-B
[350.631667] Dynamic subtest pipe-B: SKIP (0.033s)
[350.641431] Starting dynamic subtest: pipe-C
[350.661667] Dynamic subtest pipe-C: SKIP (0.031s)
[350.671283] Starting dynamic subtest: pipe-D
[350.691692] Dynamic subtest pipe-D: SKIP (0.030s)
[350.695302] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.114s)
[350.804366] [068/133] (679s left) vgem_basic (busy-fence)
[350.851035] Starting subtest: busy-fence
[350.853145] Subtest busy-fence: SUCCESS (0.000s)
[350.911851] [069/133] (679s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[351.005345] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[351.034182] Starting dynamic subtest: pipe-A-plane-0
[351.456149] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[351.470208] Starting dynamic subtest: pipe-A-plane-3
[351.711392] Dynamic subtest pipe-A-plane-3: SUCCESS (0.253s)
[351.722886] Starting dynamic subtest: pipe-A-plane-5
[351.726544] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[352.854984] Starting dynamic subtest: pipe-B-plane-0
[353.279888] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[353.290004] Starting dynamic subtest: pipe-B-plane-3
[353.538089] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[353.548013] Starting dynamic subtest: pipe-B-plane-5
[353.552554] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[353.851255] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.845s)
[354.662574] [070/133] (676s left) kms_addfb_basic (invalid-set-prop-any)
[354.715741] Starting subtest: invalid-set-prop-any
[354.717910] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[354.847335] [071/133] (675s left) kms_addfb_basic (size-max)
[354.947677] Starting subtest: size-max
[354.949840] Subtest size-max: SUCCESS (0.000s)
[355.050715] [072/133] (675s left) kms_addfb_basic (bad-pitch-128)
[355.099177] Starting subtest: bad-pitch-128
[355.101070] Subtest bad-pitch-128: SUCCESS (0.000s)
[355.249064] [073/133] (675s left) syncobj_timeline (single-wait-available-submitted)
[355.305353] Starting subtest: single-wait-available-submitted
[355.307521] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[355.396530] [074/133] (675s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[355.491576] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[356.549882] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.059s)
[356.682217] [075/133] (674s left) gem_pread (exhaustion)
[356.741484] Subtest exhaustion: SKIP (0.000s)
[356.800759] [076/133] (674s left) kms_frontbuffer_tracking (psr-1p-rte)
[356.888164] Starting subtest: psr-1p-rte
[362.284049] Subtest psr-1p-rte: SUCCESS (5.398s)
[362.446116] [077/133] (668s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[362.576286] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[380.214332] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.634s)
[381.098919] [078/133] (649s left) api_intel_allocator (fork-simple-once)
[381.164176] Starting subtest: fork-simple-once
[381.180002] Subtest fork-simple-once: SUCCESS (0.018s)
[381.316342] [079/133] (649s left) gem_set_tiling_vs_pwrite
[381.444356] [080/133] (649s left) kms_pm_backlight (brightness-with-dpms)
[381.544421] Starting subtest: brightness-with-dpms
[381.596831] Starting dynamic subtest: eDP-1
[384.325509] Dynamic subtest eDP-1: SUCCESS (2.729s)
[384.327869] Subtest brightness-with-dpms: SUCCESS (2.781s)
[385.200718] [081/133] (645s left) kms_lease (lease-invalid-crtc)
[385.301401] Starting subtest: lease-invalid-crtc
[385.303586] Starting dynamic subtest: pipe-A-eDP-1
[385.305923] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[385.316674] Starting dynamic subtest: pipe-B-eDP-1
[385.318562] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[385.328385] Starting dynamic subtest: pipe-C-eDP-1
[385.330575] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[385.340260] Starting dynamic subtest: pipe-D-eDP-1
[385.342089] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[385.343931] Subtest lease-invalid-crtc: SUCCESS (0.007s)
[385.382388] [082/133] (645s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[385.476089] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[385.480462] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[385.579006] [083/133] (645s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[385.666052] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[392.605617] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.941s)
[392.745145] [084/133] (638s left) kms_dp_linktrain_fallback (dp-fallback)
[392.847800] Starting subtest: dp-fallback
[392.854466] Subtest dp-fallback: SKIP (0.000s)
[392.935040] [085/133] (638s left) kms_vblank (ts-continuation-idle)
[393.025633] Starting subtest: ts-continuation-idle
[393.027837] Starting dynamic subtest: pipe-A-eDP-1
[393.439780] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.415s)
[393.456800] Starting dynamic subtest: pipe-D-eDP-1
[394.493616] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.052s)
[394.495917] Subtest ts-continuation-idle: SUCCESS (1.471s)
[395.380965] [086/133] (635s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[395.485393] Starting subtest: fbc-psr-cursor-mmap-gtt
[395.487655] Starting dynamic subtest: eDP-1
[395.491686] Dynamic subtest eDP-1: SKIP (0.000s)
[395.495777] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[395.572004] [087/133] (635s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[395.683060] Starting subtest: cursor-vs-flip-varying-size
[426.996355] Subtest cursor-vs-flip-varying-size: SUCCESS (31.313s)
[427.820848] [088/133] (603s left) i915_drm_fdinfo (busy-check-all)
[427.864720] Starting subtest: busy-check-all
[427.867100] Starting dynamic subtest: rcs0
[427.871769] Dynamic subtest rcs0: SKIP (0.004s)
[427.883832] Starting dynamic subtest: bcs0
[427.888491] Dynamic subtest bcs0: SKIP (0.000s)
[427.898097] Starting dynamic subtest: vcs0
[427.902422] Dynamic subtest vcs0: SKIP (0.000s)
[427.912296] Starting dynamic subtest: vcs1
[427.916475] Dynamic subtest vcs1: SKIP (0.000s)
[427.926005] Starting dynamic subtest: vecs0
[427.930330] Dynamic subtest vecs0: SKIP (0.000s)
[427.940753] Starting dynamic subtest: ccs0
[427.945093] Dynamic subtest ccs0: SKIP (0.000s)
[427.949432] Subtest busy-check-all: SKIP (0.009s)
[427.988390] [089/133] (603s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[428.109344] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[428.111755] Starting dynamic subtest: pipe-A-eDP-1
[428.132474] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[428.144565] Starting dynamic subtest: pipe-B-eDP-1
[428.163507] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[428.172781] Starting dynamic subtest: pipe-C-eDP-1
[428.192009] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[428.203759] Starting dynamic subtest: pipe-D-eDP-1
[428.222846] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[428.224774] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[430.277049] [090/133] (601s left) prime_busy (before-wait)
[430.341081] Starting subtest: before-wait
[430.347105] Starting dynamic subtest: rcs0
[430.368540] Dynamic subtest rcs0: SUCCESS (0.024s)
[430.379919] Starting dynamic subtest: bcs0
[430.417793] Dynamic subtest bcs0: SUCCESS (0.048s)
[430.428470] Starting dynamic subtest: vcs0
[430.460260] Dynamic subtest vcs0: SUCCESS (0.042s)
[430.470721] Starting dynamic subtest: vcs1
[430.502531] Dynamic subtest vcs1: SUCCESS (0.041s)
[430.512569] Starting dynamic subtest: vecs0
[430.545290] Dynamic subtest vecs0: SUCCESS (0.042s)
[430.555706] Starting dynamic subtest: ccs0
[430.586639] Dynamic subtest ccs0: SUCCESS (0.041s)
[430.694838] Subtest before-wait: SUCCESS (0.352s)
[430.775572] [091/133] (600s left) gem_ppgtt (blt-vs-render-ctx0)
[430.839152] Starting subtest: blt-vs-render-ctx0
[463.587304] Subtest blt-vs-render-ctx0: SUCCESS (32.743s)
[463.702887] [092/133] (567s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[463.870733] Starting subtest: cursorB-vs-flipB-atomic
[463.875315] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[464.017774] [093/133] (567s left) gem_exec_reloc (basic-wc-read-active)
[464.075255] Subtest basic-wc-read-active: SKIP (0.000s)
[464.145852] [094/133] (567s left) gem_exec_fence (syncobj-import)
[464.604131] Starting subtest: syncobj-import
[464.609345] Subtest syncobj-import: SUCCESS (0.005s)
[466.600950] [095/133] (565s left) kms_psr (fbc-psr2-sprite-blt)
[466.699178] Starting subtest: fbc-psr2-sprite-blt
[466.701389] Starting dynamic subtest: eDP-1
[466.705459] Dynamic subtest eDP-1: SKIP (0.000s)
[466.709470] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[466.774151] [096/133] (565s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[466.870347] Starting subtest: plane-lut1d-post-ctm3x4
[467.005136] Starting dynamic subtest: pipe-A-plane-0
[467.182779] Dynamic subtest pipe-A-plane-0: SUCCESS (0.178s)
[467.193351] Starting dynamic subtest: pipe-A-plane-1
[467.349021] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[467.359753] Starting dynamic subtest: pipe-A-plane-2
[467.504792] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s)
[468.663025] Starting dynamic subtest: pipe-B-plane-0
[468.832084] Dynamic subtest pipe-B-plane-0: SUCCESS (0.177s)
[468.842591] Starting dynamic subtest: pipe-B-plane-1
[468.966252] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s)
[468.976832] Starting dynamic subtest: pipe-B-plane-2
[469.132744] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[470.294474] Starting dynamic subtest: pipe-C-plane-0
[470.419210] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[470.429340] Starting dynamic subtest: pipe-C-plane-1
[470.563837] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[470.582803] Starting dynamic subtest: pipe-C-plane-2
[470.708254] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[471.924900] Starting dynamic subtest: pipe-D-plane-0
[472.060700] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[472.071466] Starting dynamic subtest: pipe-D-plane-1
[472.205252] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[472.215689] Starting dynamic subtest: pipe-D-plane-2
[472.361985] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[472.648167] Subtest plane-lut1d-post-ctm3x4: SUCCESS (5.777s)
[473.507093] [097/133] (558s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[473.567432] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[473.571881] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[473.754586] [098/133] (558s left) kms_big_fb (linear-8bpp-rotate-180)
[473.868403] Starting subtest: linear-8bpp-rotate-180
[475.171113] Subtest linear-8bpp-rotate-180: SUCCESS (1.302s)
[475.283216] [099/133] (556s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[475.390805] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[475.394434] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[475.493342] [100/133] (556s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[475.588263] Starting subtest: extended-modeset-hang-oldfb-with-reset
[475.590339] Starting dynamic subtest: pipe-A
[487.288824] Dynamic subtest pipe-A: SUCCESS (11.699s)
[487.300715] Starting dynamic subtest: pipe-D
[499.553686] Dynamic subtest pipe-D: SUCCESS (12.259s)
[499.556062] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.962s)
[500.350107] [101/133] (531s left) gem_exec_schedule (timeslicing)
[500.422775] Starting subtest: timeslicing
[500.424731] Starting dynamic subtest: rcs0
[500.433777] Dynamic subtest rcs0: SUCCESS (0.021s)
[500.446647] Starting dynamic subtest: bcs0
[500.454668] Dynamic subtest bcs0: SUCCESS (0.020s)
[500.465701] Starting dynamic subtest: vcs0
[500.475125] Dynamic subtest vcs0: SUCCESS (0.020s)
[500.485512] Starting dynamic subtest: vcs1
[500.494894] Dynamic subtest vcs1: SUCCESS (0.019s)
[500.505454] Starting dynamic subtest: vecs0
[500.515327] Dynamic subtest vecs0: SUCCESS (0.020s)
[500.525855] Starting dynamic subtest: ccs0
[500.535245] Dynamic subtest ccs0: SUCCESS (0.019s)
[500.537539] Subtest timeslicing: SUCCESS (0.124s)
[502.574471] [102/133] (529s left) kms_chamelium_color (ctm-0-25)
[502.682322] Subtest ctm-0-25: SKIP (0.000s)
[502.733696] [103/133] (529s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[502.818015] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[502.820251] Starting dynamic subtest: pipe-A-eDP-1
[502.905021] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s)
[502.918007] Starting dynamic subtest: pipe-B-eDP-1
[504.018117] Dynamic subtest pipe-B-eDP-1: SKIP (1.113s)
[504.022690] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.205s)
[505.243852] [104/133] (526s left) gem_mmap (short-mmap)
[505.307012] Subtest short-mmap: SKIP (0.000s)
[505.364815] [105/133] (526s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[505.425911] Starting subtest: multi-wait-available-unsubmitted-submitted
[505.428226] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[505.540137] [106/133] (526s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[505.634881] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[505.638905] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[505.777183] [107/133] (526s left) kms_getfb (getfb2-accept-nv12)
[505.880966] Starting subtest: getfb2-accept-nv12
[505.883144] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[505.991529] [108/133] (526s left) syncobj_timeline (invalid-signal-zero-handles)
[506.050852] Starting subtest: invalid-signal-zero-handles
[506.053150] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[506.152333] [109/133] (526s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[506.242375] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[506.246103] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[506.318709] [110/133] (526s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[506.425928] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[506.427869] Starting dynamic subtest: pipe-A-eDP-1
[506.478194] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[506.488422] Starting dynamic subtest: pipe-B-eDP-1
[506.535130] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[506.545272] Starting dynamic subtest: pipe-C-eDP-1
[506.593808] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[506.604436] Starting dynamic subtest: pipe-D-eDP-1
[506.650919] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[506.654543] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[508.580351] [111/133] (523s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[508.681376] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[508.689588] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.011s)
[508.783417] [112/133] (523s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[508.878296] Starting subtest: async-flip-with-page-flip-events-tiled
[509.259467] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[512.061532] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.802s)
[512.072540] Starting dynamic subtest: pipe-A-eDP-1-4
[514.235042] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.172s)
[514.245571] Starting dynamic subtest: pipe-A-eDP-1-4
[516.245463] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[516.255901] Starting dynamic subtest: pipe-A-eDP-1-x
[518.424331] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.177s)
[518.803931] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[521.606956] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.810s)
[521.617529] Starting dynamic subtest: pipe-B-eDP-1-4
[523.792354] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.184s)
[523.803774] Starting dynamic subtest: pipe-B-eDP-1-4
[525.802134] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.008s)
[525.812892] Starting dynamic subtest: pipe-B-eDP-1-x
[527.993584] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[528.357501] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[531.133386] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.784s)
[531.144499] Starting dynamic subtest: pipe-C-eDP-1-4
[533.330369] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.195s)
[533.342673] Starting dynamic subtest: pipe-C-eDP-1-4
[535.340164] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[535.351349] Starting dynamic subtest: pipe-C-eDP-1-x
[537.518482] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[537.883491] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[540.665623] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.791s)
[540.676493] Starting dynamic subtest: pipe-D-eDP-1-4
[542.840158] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.173s)
[542.850436] Starting dynamic subtest: pipe-D-eDP-1-4
[544.850818] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[544.861803] Starting dynamic subtest: pipe-D-eDP-1-x
[547.029662] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.177s)
[547.032096] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.151s)
[548.256966] [113/133] (484s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[548.365952] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[548.370572] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[548.472330] [114/133] (484s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[548.520557] Starting subtest: etime-multi-wait-for-submit-submitted
[548.622644] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.102s)
[548.701454] [115/133] (483s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[550.736324] Starting subtest: modeset-non-lpsp-stress-no-wait
[550.801189] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.065s)
[551.132067] [116/133] (481s left) gem_exec_params (sol-reset-invalid)
[551.201703] Starting subtest: sol-reset-invalid
[551.203980] Subtest sol-reset-invalid: SUCCESS (0.003s)
[552.572416] [117/133] (480s left) gem_mmap_gtt (cpuset-big-copy)
[552.633649] Subtest cpuset-big-copy: SKIP (0.000s)
[552.690028] [118/133] (480s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[552.782567] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[560.538086] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.758s)
[560.653310] [119/133] (472s left) kms_psr (psr2-sprite-plane-onoff)
[560.738582] Starting subtest: psr2-sprite-plane-onoff
[560.740869] Starting dynamic subtest: eDP-1
[562.505652] Dynamic subtest eDP-1: SUCCESS (1.765s)
[562.507981] Subtest psr2-sprite-plane-onoff: SUCCESS (1.766s)
[563.367772] [120/133] (469s left) kms_dsc (dsc-with-output-formats)
[563.485767] Starting subtest: dsc-with-output-formats
[563.507803] Subtest dsc-with-output-formats: SKIP (0.001s)
[563.571748] [121/133] (469s left) gen3_mixed_blits
[563.720251] [122/133] (469s left) gem_mmap_offset (clear-via-pagefault)
[563.775978] Starting subtest: clear-via-pagefault
[563.778006] Starting dynamic subtest: smem0
[744.114464] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[780.139370] Closing watchdogs
[780.140716] Initializing watchdogs
[780.140748]   /dev/watchdog0
[780.158716] [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]
[780.165192] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[780.166453] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[780.166902] [FACT before any test] new: kernel.kmod_is_loaded.vgem: true
[780.170651] [123/133] (252s left) gem_eio (reset-stress)
[780.418783] Starting subtest: reset-stress
[780.420944] Starting dynamic subtest: render
[785.468799] Dynamic subtest render: SUCCESS (5.048s)
[785.486926] Starting dynamic subtest: bsd1
[804.047839] Dynamic subtest bsd1: SUCCESS (18.578s)
[804.065079] Starting dynamic subtest: bsd2
[822.039529] Dynamic subtest bsd2: SUCCESS (17.991s)
[822.055318] Starting dynamic subtest: blt
[822.059470] Dynamic subtest blt: SKIP (0.000s)
[822.070239] Starting dynamic subtest: vebox
[840.058197] Dynamic subtest vebox: SUCCESS (18.013s)
[840.060500] Subtest reset-stress: SUCCESS (59.638s)
[841.579796] [124/133] (191s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[841.636707] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[841.639085] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[841.736158] [125/133] (191s left) kms_vblank (query-busy-hang)
[841.833394] Starting subtest: query-busy-hang
[841.835394] Starting dynamic subtest: pipe-A-eDP-1
[843.708904] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.877s)
[843.725171] Starting dynamic subtest: pipe-D-eDP-1
[846.311257] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.600s)
[846.313840] Subtest query-busy-hang: SUCCESS (4.482s)
[847.117557] [126/133] (186s left) kms_psr (fbc-pr-cursor-plane-onoff)
[847.204440] Starting subtest: fbc-pr-cursor-plane-onoff
[847.208888] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[847.295548] [127/133] (185s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[847.385223] Starting subtest: psr-1p-primscrn-cur-indfb-move
[854.825568] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.443s)
[854.951545] [128/133] (178s left) tools_test (sysfs_l3_parity)
[854.999467] Starting subtest: sysfs_l3_parity
[855.069893] Subtest sysfs_l3_parity: SKIP (0.080s)
[855.124131] [129/133] (178s left) kms_vblank (crtc-id)
[855.212336] Starting subtest: crtc-id
[855.214521] Starting dynamic subtest: pipe-A-eDP-1
[855.667137] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.455s)
[855.681983] Starting dynamic subtest: pipe-D-eDP-1
[856.793865] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.122s)
[856.796107] Subtest crtc-id: SUCCESS (1.581s)
[857.630673] [130/133] (175s left) gem_ctx_engines (independent)
[857.687707] Starting subtest: independent
[857.689939] Starting dynamic subtest: rcs0
[857.838625] Dynamic subtest rcs0: SUCCESS (0.148s)
[857.854093] Starting dynamic subtest: bcs0
[858.013163] Dynamic subtest bcs0: SUCCESS (0.174s)
[858.025735] Starting dynamic subtest: vcs0
[858.166507] Dynamic subtest vcs0: SUCCESS (0.150s)
[858.185018] Starting dynamic subtest: vcs1
[858.349333] Dynamic subtest vcs1: SUCCESS (0.182s)
[858.362084] Starting dynamic subtest: vecs0
[858.508756] Dynamic subtest vecs0: SUCCESS (0.157s)
[858.522317] Starting dynamic subtest: ccs0
[858.656505] Dynamic subtest ccs0: SUCCESS (0.147s)
[858.668696] Starting dynamic subtest: all-engines
[859.329221] Dynamic subtest all-engines: SUCCESS (0.671s)
[859.331925] Subtest independent: SUCCESS (1.641s)
[859.690476] [131/133] (173s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[859.788464] Starting subtest: flip-vs-dpms-on-nop-interruptible
[859.790660] Starting dynamic subtest: A-eDP1
[861.616969] Dynamic subtest A-eDP1: SUCCESS (1.827s)
[861.630183] Starting dynamic subtest: B-eDP1
[863.457750] Dynamic subtest B-eDP1: SUCCESS (1.839s)
[863.468578] Starting dynamic subtest: C-eDP1
[865.287569] Dynamic subtest C-eDP1: SUCCESS (1.828s)
[865.298502] Starting dynamic subtest: D-eDP1
[867.119118] Dynamic subtest D-eDP1: SUCCESS (1.829s)
[867.121539] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.333s)
[868.298200] [132/133] (165s left) kms_plane_lowres (tiling-x)
[868.402304] Starting subtest: tiling-x
[868.404548] Starting dynamic subtest: pipe-A-eDP-1
[868.408875] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[868.703188] Starting dynamic subtest: pipe-B-eDP-1
[868.707805] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[868.718330] Starting dynamic subtest: pipe-C-eDP-1
[868.722942] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[868.733335] Starting dynamic subtest: pipe-D-eDP-1
[868.738080] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[868.742477] Subtest tiling-x: SKIP (0.298s)
[869.517293] [133/133] (163s left) i915_pm_freq_api (freq-reset)
[869.569121] Starting subtest: freq-reset
[869.571463] Starting dynamic subtest: gt0
[869.761330] Dynamic subtest gt0: SUCCESS (0.191s)
[869.771766] Starting dynamic subtest: gt1
[869.937091] Dynamic subtest gt1: SUCCESS (0.174s)
[869.939849] Subtest freq-reset: SUCCESS (0.367s)
[870.008967] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: gen7_exec_parse
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: tools_test
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: i915_pm_rpm
results: parsing output: 9/ for test: gem_exec_balancer
results: parsing output: 10/ for test: kms_flip_scaled_crc
results: parsing output: 11/ for test: perf_pmu
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_chamelium_hpd
results: parsing output: 14/ for test: gem_exec_schedule
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: drm_read
results: parsing output: 17/ for test: perf
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: kms_chamelium_edid
results: parsing output: 23/ for test: kms_content_protection
results: parsing output: 24/ for test: kms_psr2_sf
results: parsing output: 25/ for test: kms_rotation_crc
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: kms_flip
results: parsing output: 28/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 29/ for test: gem_lmem_swapping
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: vgem_basic
results: parsing output: 32/ for test: kms_atomic_interruptible
results: parsing output: 33/ for test: gem_pxp
results: parsing output: 34/ for test: gem_exec_basic
results: parsing output: 35/ for test: api_intel_bb
results: parsing output: 36/ for test: kms_joiner
results: parsing output: 37/ for test: kms_addfb_basic
results: parsing output: 38/ for test: i915_query
results: parsing output: 39/ for test: perf
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_exec_params
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: dumb_buffer
results: parsing output: 46/ for test: gem_softpin
results: parsing output: 47/ for test: gem_blits
results: parsing output: 48/ for test: gem_busy
results: parsing output: 49/ for test: gem_exec_alignment
results: parsing output: 50/ for test: syncobj_eventfd
results: parsing output: 51/ for test: prime_mmap
results: parsing output: 52/ for test: gem_ctx_persistence
results: parsing output: 53/ for test: gem_ctx_param
results: parsing output: 54/ for test: i915_query
results: parsing output: 55/ for test: kms_cursor_edge_walk
results: parsing output: 56/ for test: kms_plane
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_exec_schedule
results: parsing output: 60/ for test: sw_sync
results: parsing output: 61/ for test: gem_exec_whisper
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_vm_create
results: parsing output: 64/ for test: kms_cursor_crc
results: parsing output: 65/ for test: kms_plane_alpha_blend
results: parsing output: 66/ for test: kms_plane_scaling
results: parsing output: 67/ for test: vgem_basic
results: parsing output: 68/ for test: kms_plane
results: parsing output: 69/ for test: kms_addfb_basic
results: parsing output: 70/ for test: kms_addfb_basic
results: parsing output: 71/ for test: kms_addfb_basic
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: gem_pread
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: api_intel_allocator
results: parsing output: 78/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 79/ for test: kms_pm_backlight
results: parsing output: 80/ for test: kms_lease
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_dp_linktrain_fallback
results: parsing output: 84/ for test: kms_vblank
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: kms_cursor_legacy
results: parsing output: 87/ for test: i915_drm_fdinfo
results: parsing output: 88/ for test: kms_ccs
results: parsing output: 89/ for test: prime_busy
results: parsing output: 90/ for test: gem_ppgtt
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: gem_exec_reloc
results: parsing output: 93/ for test: gem_exec_fence
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: kms_color_pipeline
results: parsing output: 96/ for test: gem_render_copy
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_busy
results: parsing output: 100/ for test: gem_exec_schedule
results: parsing output: 101/ for test: kms_chamelium_color
results: parsing output: 102/ for test: kms_psr2_sf
results: parsing output: 103/ for test: gem_mmap
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_getfb
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: kms_flip_scaled_crc
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: kms_async_flips
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: kms_pm_rpm
results: parsing output: 115/ for test: gem_exec_params
results: parsing output: 116/ for test: gem_mmap_gtt
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: kms_dsc
results: parsing output: 120/ for test: gen3_mixed_blits
results: parsing output: 121/ for test: gem_mmap_offset
results: parsing output: 122/ for test: gem_eio
results: parsing output: 123/ for test: syncobj_wait
results: parsing output: 124/ for test: kms_vblank
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: tools_test
results: parsing output: 128/ for test: kms_vblank
results: parsing output: 129/ for test: gem_ctx_engines
results: parsing output: 130/ for test: kms_flip
results: parsing output: 131/ for test: kms_plane_lowres
results: parsing output: 132/ for test: i915_pm_freq_api
Done.