[60.000467] Initializing watchdogs
[60.000522]   /dev/watchdog0
[60.015686] [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.020440] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.022776] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.026222] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[60.172466] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[60.176842] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[60.290731] [002/133] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[60.393480] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[60.397778] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[60.487364] [003/133] (960s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[60.585059] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[61.275474] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.691s)
[61.427190] [004/133] (959s left) gen7_exec_parse (basic-offset)
[61.500707] Subtest basic-offset: SKIP (0.000s)
[61.581054] [005/133] (959s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[61.673591] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[66.034570] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.360s)
[67.254188] [006/133] (953s left) tools_test (tools_test)
[67.322850] Starting subtest: tools_test
[67.433411] Subtest tools_test: SUCCESS (0.127s)
[67.523110] [007/133] (953s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[67.684164] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[67.688660] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[68.833183] [008/133] (952s left) kms_flip (modeset-vs-vblank-race)
[68.928456] Starting subtest: modeset-vs-vblank-race
[68.930928] Starting dynamic subtest: A-eDP1
[73.677083] Dynamic subtest A-eDP1: SUCCESS (4.746s)
[73.687381] Starting dynamic subtest: B-eDP1
[78.436863] Dynamic subtest B-eDP1: SUCCESS (4.757s)
[78.446684] Starting dynamic subtest: C-eDP1
[83.145220] Dynamic subtest C-eDP1: SUCCESS (4.706s)
[83.155201] Starting dynamic subtest: D-eDP1
[87.766626] Dynamic subtest D-eDP1: SUCCESS (4.620s)
[87.771829] Subtest modeset-vs-vblank-race: SUCCESS (18.839s)
[88.915904] [009/133] (931s left) i915_pm_rpm (reg-read-ioctl)
[91.063037] Starting subtest: reg-read-ioctl
[93.363797] Subtest reg-read-ioctl: SUCCESS (2.304s)
[93.754659] [010/133] (927s left) gem_exec_balancer (hang)
[94.016720] Starting subtest: hang
[95.897908] Subtest hang: SUCCESS (1.883s)
[96.031350] [011/133] (924s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[96.113390] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[96.118060] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[96.198956] [012/133] (924s left) perf_pmu (faulting-read)
[96.247765] Starting subtest: faulting-read
[96.250073] Starting dynamic subtest: wb
[96.252418] Dynamic subtest wb: SUCCESS (0.001s)
[96.262251] Starting dynamic subtest: wc
[96.264316] Dynamic subtest wc: SUCCESS (0.000s)
[96.272261] Starting dynamic subtest: uc
[96.274442] Dynamic subtest uc: SUCCESS (0.000s)
[96.276589] Subtest faulting-read: SUCCESS (0.002s)
[96.356953] [013/133] (924s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[96.455527] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[96.459470] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[96.554189] [014/133] (924s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[96.958897] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[97.763931] [015/133] (923s left) gem_exec_schedule (pi-distinct-iova)
[97.944496] Starting subtest: pi-distinct-iova
[97.946691] Starting dynamic subtest: rcs0
[98.018303] Dynamic subtest rcs0: SUCCESS (0.075s)
[98.030122] Starting dynamic subtest: vcs0
[98.079848] Dynamic subtest vcs0: SUCCESS (0.062s)
[98.093940] Starting dynamic subtest: vcs1
[98.138726] Dynamic subtest vcs1: SUCCESS (0.059s)
[98.152048] Starting dynamic subtest: vecs0
[98.196534] Dynamic subtest vecs0: SUCCESS (0.057s)
[98.207390] Starting dynamic subtest: ccs0
[98.273933] Dynamic subtest ccs0: SUCCESS (0.077s)
[98.276770] Subtest pi-distinct-iova: SUCCESS (0.331s)
[100.014425] [016/133] (921s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[100.112644] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[100.116743] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[100.209323] [017/133] (920s left) drm_read (short-buffer-block)
[100.350546] Starting subtest: short-buffer-block
[100.352751] Subtest short-buffer-block: SUCCESS (0.000s)
[100.474417] [018/133] (920s left) perf (oa-formats)
[100.611565] Starting subtest: oa-formats
[100.613438] Starting dynamic subtest: 0-rcs0
[100.625371] Dynamic subtest 0-rcs0: SUCCESS (0.015s)
[100.634473] Starting dynamic subtest: 1-vcs1
[100.646269] Dynamic subtest 1-vcs1: SUCCESS (0.020s)
[100.648609] Subtest oa-formats: SUCCESS (0.036s)
[100.693141] [019/133] (920s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[100.804369] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[100.808951] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[100.914629] [020/133] (920s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[101.028632] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[101.032119] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[101.129811] [021/133] (920s left) kms_psr (pr-basic)
[101.225437] Starting subtest: pr-basic
[101.229147] Subtest pr-basic: SKIP (0.000s)
[101.293832] [022/133] (920s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[101.390876] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[101.392912] Starting dynamic subtest: pipe-A-eDP-1
[101.411068] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[101.419902] Starting dynamic subtest: pipe-B-eDP-1
[101.436771] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[101.444522] Starting dynamic subtest: pipe-C-eDP-1
[101.461648] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[101.468939] Starting dynamic subtest: pipe-D-eDP-1
[101.486803] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[101.490439] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[103.565264] [023/133] (917s left) kms_chamelium_edid (hdmi-mode-timings)
[103.959150] Subtest hdmi-mode-timings: SKIP (0.000s)
[104.776950] [024/133] (916s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[104.925074] Starting subtest: dp-mst-lic-type-0-hdcp14
[104.929373] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[105.053229] [025/133] (916s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[105.162926] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[105.167451] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[105.224383] [026/133] (916s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[105.318929] Starting subtest: primary-4-tiled-reflect-x-180
[112.283684] Subtest primary-4-tiled-reflect-x-180: SUCCESS (6.967s)
[113.477700] [027/133] (908s left) kms_flip (2x-flip-vs-panning-interruptible)
[113.575188] Starting subtest: 2x-flip-vs-panning-interruptible
[113.587974] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[113.663585] [028/133] (907s left) kms_flip (plain-flip-fb-recreate)
[113.760174] Starting subtest: plain-flip-fb-recreate
[113.762618] Starting dynamic subtest: A-eDP1
[122.670976] Dynamic subtest A-eDP1: SUCCESS (8.910s)
[122.680856] Starting dynamic subtest: B-eDP1
[131.492677] Dynamic subtest B-eDP1: SUCCESS (8.820s)
[131.502788] Starting dynamic subtest: C-eDP1
[140.313376] Dynamic subtest C-eDP1: SUCCESS (8.819s)
[140.323333] Starting dynamic subtest: D-eDP1
[149.150984] Dynamic subtest D-eDP1: SUCCESS (8.837s)
[149.154991] Subtest plain-flip-fb-recreate: SUCCESS (35.393s)
[150.330593] [029/133] (871s left) gem_tiled_partial_pwrite_pread (writes)
[150.396055] Subtest writes: SKIP (0.000s)
[150.467194] [030/133] (871s left) gem_lmem_swapping (heavy-verify-random)
[150.512947] Subtest heavy-verify-random: SKIP (0.000s)
[150.549334] [031/133] (871s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[150.638680] Starting subtest: x-tiled-64bpp-rotate-90
[150.657823] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[150.780705] [032/133] (870s left) vgem_basic (debugfs)
[150.891682] Starting subtest: debugfs
[150.893600] Subtest debugfs: SUCCESS (0.000s)
[150.945480] [FACT vgem_basic (debugfs)] new: kernel.kmod_is_loaded.vgem: true
[150.948818] [033/133] (870s left) kms_atomic_interruptible (legacy-setmode)
[151.043247] Starting subtest: legacy-setmode
[151.045629] Starting dynamic subtest: pipe-A-eDP-1
[157.939702] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.897s)
[157.942059] Subtest legacy-setmode: SUCCESS (6.898s)
[158.801316] [034/133] (863s left) gem_pxp (reject-modify-context-protection-off-2)
[158.920281] Starting subtest: reject-modify-context-protection-off-2
[158.922824] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[159.024824] [035/133] (862s left) gem_exec_basic (basic)
[159.078471] Starting subtest: basic
[159.080726] Starting dynamic subtest: rcs0-smem
[159.082906] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[159.090979] Starting dynamic subtest: bcs0-smem
[159.093233] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[159.101196] Starting dynamic subtest: vcs0-smem
[159.103315] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[159.110908] Starting dynamic subtest: vcs1-smem
[159.113098] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[159.121061] Starting dynamic subtest: vecs0-smem
[159.123148] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[159.131213] Starting dynamic subtest: ccs0-smem
[159.133307] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[159.135417] Subtest basic: SUCCESS (0.014s)
[160.959786] [036/133] (860s left) api_intel_bb (offset-control)
[161.015931] Starting subtest: offset-control
[161.020856] Subtest offset-control: SUCCESS (0.007s)
[161.145880] [037/133] (860s left) kms_joiner (basic-max-non-joiner)
[161.233442] Starting subtest: basic-max-non-joiner
[161.237541] Subtest basic-max-non-joiner: SKIP (0.000s)
[161.303051] [038/133] (860s left) kms_addfb_basic (small-bo)
[161.393303] Starting subtest: small-bo
[161.395234] Subtest small-bo: SUCCESS (0.000s)
[161.487758] [039/133] (860s left) i915_query (query-topology-garbage-items)
[161.543092] Starting subtest: query-topology-garbage-items
[161.545365] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[161.637322] [040/133] (860s left) perf (gen12-group-exclusive-stream-ctx-handle)
[161.733083] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[161.760229] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.025s)
[161.810100] [041/133] (860s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[162.914608] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[162.919085] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[163.010743] [042/133] (859s left) gem_exec_params (cliprects-invalid)
[163.069245] Starting subtest: cliprects-invalid
[163.071779] Subtest cliprects-invalid: SUCCESS (0.000s)
[163.174498] [043/133] (859s left) kms_cursor_crc (cursor-random-64x64)
[163.359089] Starting subtest: cursor-random-64x64
[163.361361] Starting dynamic subtest: pipe-A-eDP-1
[166.715114] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.353s)
[166.741120] Starting dynamic subtest: pipe-D-eDP-1
[170.766039] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.030s)
[170.768271] Subtest cursor-random-64x64: SUCCESS (7.408s)
[171.565859] [044/133] (850s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[171.659244] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[171.663520] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[171.777816] [045/133] (850s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[171.870422] Starting subtest: 4-tiled-16bpp-rotate-180
[173.226588] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.356s)
[173.349316] [046/133] (849s left) dumb_buffer (create-valid-dumb)
[173.411382] Starting subtest: create-valid-dumb
[173.413292] Subtest create-valid-dumb: SUCCESS (0.000s)
[173.531285] [047/133] (848s left) gem_softpin (zero)
[173.595018] Starting subtest: zero
[173.601086] Subtest zero: SUCCESS (0.004s)
[173.713952] [048/133] (848s left) gem_blits (basic)
[173.777632] Starting subtest: basic
[175.177081] Subtest basic: SUCCESS (1.399s)
[175.287439] [049/133] (847s left) gem_busy (close-race)
[175.351804] Starting subtest: close-race
[198.932064] Subtest close-race: SUCCESS (23.581s)
[199.308997] [050/133] (823s left) gem_exec_alignment (forked)
[199.418824] Starting subtest: forked
[237.394696] Subtest forked: SUCCESS (37.971s)
[237.972356] [051/133] (784s left) syncobj_eventfd (binary-wait-before-signal)
[238.070685] Starting subtest: binary-wait-before-signal
[238.101649] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[238.176113] [052/133] (784s left) prime_mmap (test_errors)
[238.233048] Starting subtest: test_errors
[238.235410] Starting dynamic subtest: test_errors-smem
[238.331073] Dynamic subtest test_errors-smem: SUCCESS (0.099s)
[238.333603] Subtest test_errors: SUCCESS (0.101s)
[238.450053] [053/133] (784s left) gem_ctx_persistence (heartbeat-stop)
[238.520292] Starting subtest: heartbeat-stop
[238.524966] Subtest heartbeat-stop: SKIP (0.000s)
[238.628071] [054/133] (784s left) gem_ctx_param (invalid-get-ringsize)
[238.674759] Starting subtest: invalid-get-ringsize
[238.677211] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[238.782093] [055/133] (783s left) i915_query (query-topology-matches-eu-total)
[238.843161] Starting subtest: query-topology-matches-eu-total
[238.845524] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[238.965164] [056/133] (783s left) kms_cursor_edge_walk (64x64-right-edge)
[239.067203] Starting subtest: 64x64-right-edge
[239.068995] Starting dynamic subtest: pipe-A-eDP-1
[242.577045] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.508s)
[242.586857] Starting dynamic subtest: pipe-D-eDP-1
[245.753203] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.177s)
[245.755534] Subtest 64x64-right-edge: SUCCESS (6.687s)
[246.575691] [057/133] (776s left) kms_plane (plane-position-covered)
[246.671771] Starting subtest: plane-position-covered
[247.211623] Starting dynamic subtest: pipe-A-plane-1
[248.476296] Dynamic subtest pipe-A-plane-1: SUCCESS (1.265s)
[248.485628] Starting dynamic subtest: pipe-A-plane-2
[249.770888] Dynamic subtest pipe-A-plane-2: SUCCESS (1.292s)
[249.780180] Starting dynamic subtest: pipe-A-plane-3
[251.037213] Dynamic subtest pipe-A-plane-3: SUCCESS (1.266s)
[251.046642] Starting dynamic subtest: pipe-A-plane-4
[252.331422] Dynamic subtest pipe-A-plane-4: SUCCESS (1.294s)
[252.341948] Starting dynamic subtest: pipe-A-plane-5
[252.358074] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[253.588632] Starting dynamic subtest: pipe-B-plane-1
[254.905571] Dynamic subtest pipe-B-plane-1: SUCCESS (1.324s)
[254.915679] Starting dynamic subtest: pipe-B-plane-2
[256.144389] Dynamic subtest pipe-B-plane-2: SUCCESS (1.236s)
[256.155346] Starting dynamic subtest: pipe-B-plane-3
[257.402615] Dynamic subtest pipe-B-plane-3: SUCCESS (1.260s)
[257.412863] Starting dynamic subtest: pipe-B-plane-4
[258.703420] Dynamic subtest pipe-B-plane-4: SUCCESS (1.300s)
[258.713650] Starting dynamic subtest: pipe-B-plane-5
[258.729795] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[258.732167] Subtest plane-position-covered: SUCCESS (12.058s)
[259.502551] [058/133] (763s left) kms_frontbuffer_tracking (psr-suspend)
[259.602441] Starting subtest: psr-suspend
[297.621220] Subtest psr-suspend: SUCCESS (8.832s)
[297.727691] [059/133] (725s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[297.837137] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[297.841628] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[297.963868] [060/133] (724s left) gem_exec_schedule (fairslice)
[298.034996] Starting subtest: fairslice
[298.037249] Starting dynamic subtest: rcs0
[300.046317] Dynamic subtest rcs0: SUCCESS (1.996s)
[300.058152] Starting dynamic subtest: bcs0
[302.065158] Dynamic subtest bcs0: SUCCESS (2.000s)
[302.076892] Starting dynamic subtest: vcs0
[304.087256] Dynamic subtest vcs0: SUCCESS (2.007s)
[304.097724] Starting dynamic subtest: vcs1
[306.104714] Dynamic subtest vcs1: SUCCESS (2.006s)
[306.116932] Starting dynamic subtest: vecs0
[308.120890] Dynamic subtest vecs0: SUCCESS (2.010s)
[308.132044] Starting dynamic subtest: ccs0
[310.141807] Dynamic subtest ccs0: SUCCESS (2.012s)
[310.143790] Subtest fairslice: SUCCESS (12.037s)
[310.453872] [061/133] (712s left) sw_sync (alloc_fence_invalid_timeline)
[310.499550] Starting subtest: alloc_fence_invalid_timeline
[310.501859] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[310.563995] [062/133] (712s left) gem_exec_whisper (basic-fds-forked)
[310.616622] Starting subtest: basic-fds-forked
[334.579796] Subtest basic-fds-forked: SUCCESS (23.940s)
[334.764661] [063/133] (688s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[334.865877] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[334.869832] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[334.966380] [064/133] (688s left) gem_vm_create (execbuf)
[335.032775] Starting subtest: execbuf
[335.041424] Subtest execbuf: SUCCESS (0.009s)
[335.153759] [065/133] (688s left) kms_cursor_crc (cursor-onscreen-256x85)
[335.413720] Starting subtest: cursor-onscreen-256x85
[335.458040] Subtest cursor-onscreen-256x85: SKIP (0.042s)
[335.632326] [066/133] (687s left) kms_plane_alpha_blend (coverage-7efc)
[335.718249] Starting subtest: coverage-7efc
[336.026954] Starting dynamic subtest: pipe-A-eDP-1
[336.635959] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.605s)
[336.663260] Starting dynamic subtest: pipe-D-eDP-1
[337.962818] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.306s)
[337.965157] Subtest coverage-7efc: SUCCESS (2.244s)
[338.799299] [067/133] (684s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[338.893732] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[338.895947] Starting dynamic subtest: pipe-A
[338.916047] Dynamic subtest pipe-A: SKIP (0.018s)
[338.926776] Starting dynamic subtest: pipe-B
[338.948095] Dynamic subtest pipe-B: SKIP (0.030s)
[338.958300] Starting dynamic subtest: pipe-C
[338.978218] Dynamic subtest pipe-C: SKIP (0.031s)
[338.988118] Starting dynamic subtest: pipe-D
[339.008850] Dynamic subtest pipe-D: SKIP (0.030s)
[339.013001] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.112s)
[339.117516] [068/133] (684s left) vgem_basic (busy-fence)
[339.167825] Starting subtest: busy-fence
[339.170113] Subtest busy-fence: SUCCESS (0.000s)
[339.224111] [069/133] (684s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[339.315538] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[339.345610] Starting dynamic subtest: pipe-A-plane-0
[339.778372] Dynamic subtest pipe-A-plane-0: SUCCESS (0.433s)
[339.788120] Starting dynamic subtest: pipe-A-plane-3
[340.035556] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[340.045290] Starting dynamic subtest: pipe-A-plane-5
[340.049178] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[341.180704] Starting dynamic subtest: pipe-B-plane-0
[341.614826] Dynamic subtest pipe-B-plane-0: SUCCESS (0.444s)
[341.629923] Starting dynamic subtest: pipe-B-plane-3
[341.870138] Dynamic subtest pipe-B-plane-3: SUCCESS (0.253s)
[341.880605] Starting dynamic subtest: pipe-B-plane-5
[341.884921] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[342.187200] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.871s)
[343.057859] [070/133] (680s left) kms_addfb_basic (invalid-set-prop-any)
[343.111519] Starting subtest: invalid-set-prop-any
[343.113953] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[343.249433] [071/133] (680s left) kms_addfb_basic (size-max)
[343.338050] Starting subtest: size-max
[343.340091] Subtest size-max: SUCCESS (0.000s)
[343.431636] [072/133] (680s left) kms_addfb_basic (bad-pitch-128)
[343.488540] Starting subtest: bad-pitch-128
[343.490905] Subtest bad-pitch-128: SUCCESS (0.000s)
[343.624664] [073/133] (679s left) syncobj_timeline (single-wait-available-submitted)
[343.680453] Starting subtest: single-wait-available-submitted
[343.682732] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[343.781118] [074/133] (679s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[343.879020] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[344.981435] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.102s)
[345.115874] [075/133] (678s left) gem_pread (exhaustion)
[345.177506] Subtest exhaustion: SKIP (0.000s)
[345.236319] [076/133] (678s left) kms_frontbuffer_tracking (psr-1p-rte)
[345.342209] Starting subtest: psr-1p-rte
[350.766305] Subtest psr-1p-rte: SUCCESS (5.428s)
[350.903706] [077/133] (672s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[351.031081] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[368.174396] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.138s)
[369.060136] [078/133] (654s left) api_intel_allocator (fork-simple-once)
[369.117253] Starting subtest: fork-simple-once
[369.130205] Subtest fork-simple-once: SUCCESS (0.015s)
[369.272989] [079/133] (654s left) gem_set_tiling_vs_pwrite
[369.386952] [080/133] (654s left) kms_pm_backlight (brightness-with-dpms)
[369.479465] Starting subtest: brightness-with-dpms
[369.528343] Starting dynamic subtest: eDP-1
[371.948372] Dynamic subtest eDP-1: SUCCESS (2.419s)
[371.950640] Subtest brightness-with-dpms: SUCCESS (2.470s)
[372.822402] [081/133] (651s left) kms_lease (lease-invalid-crtc)
[372.908401] Starting subtest: lease-invalid-crtc
[372.910602] Starting dynamic subtest: pipe-A-eDP-1
[372.912928] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[372.923496] Starting dynamic subtest: pipe-B-eDP-1
[372.925789] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[372.935900] Starting dynamic subtest: pipe-C-eDP-1
[372.938164] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[372.948040] Starting dynamic subtest: pipe-D-eDP-1
[372.950184] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[372.952301] Subtest lease-invalid-crtc: SUCCESS (0.005s)
[372.994007] [082/133] (650s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[373.088353] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[373.092431] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[373.179489] [083/133] (650s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[373.274386] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[380.142601] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.869s)
[380.297162] [084/133] (643s left) kms_dp_linktrain_fallback (dp-fallback)
[380.395822] Starting subtest: dp-fallback
[380.401944] Subtest dp-fallback: SKIP (0.000s)
[380.477146] [085/133] (643s left) kms_vblank (ts-continuation-idle)
[380.572503] Starting subtest: ts-continuation-idle
[380.574696] Starting dynamic subtest: pipe-A-eDP-1
[380.983230] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.409s)
[380.999213] Starting dynamic subtest: pipe-D-eDP-1
[382.052714] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.068s)
[382.055283] Subtest ts-continuation-idle: SUCCESS (1.482s)
[382.924176] [086/133] (641s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[383.010870] Starting subtest: fbc-psr-cursor-mmap-gtt
[383.013030] Starting dynamic subtest: eDP-1
[383.017272] Dynamic subtest eDP-1: SKIP (0.000s)
[383.021427] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[383.098994] [087/133] (641s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[383.220147] Starting subtest: cursor-vs-flip-varying-size
[414.485118] Subtest cursor-vs-flip-varying-size: SUCCESS (31.265s)
[415.373276] [088/133] (608s left) i915_drm_fdinfo (busy-check-all)
[415.415792] Starting subtest: busy-check-all
[415.418121] Starting dynamic subtest: rcs0
[415.422676] Dynamic subtest rcs0: SKIP (0.004s)
[415.433940] Starting dynamic subtest: bcs0
[415.438436] Dynamic subtest bcs0: SKIP (0.000s)
[415.448495] Starting dynamic subtest: vcs0
[415.452577] Dynamic subtest vcs0: SKIP (0.000s)
[415.462008] Starting dynamic subtest: vcs1
[415.465995] Dynamic subtest vcs1: SKIP (0.000s)
[415.475324] Starting dynamic subtest: vecs0
[415.479376] Dynamic subtest vecs0: SKIP (0.000s)
[415.488623] Starting dynamic subtest: ccs0
[415.492703] Dynamic subtest ccs0: SKIP (0.000s)
[415.496821] Subtest busy-check-all: SKIP (0.009s)
[415.535133] [089/133] (608s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[415.647992] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[415.650270] Starting dynamic subtest: pipe-A-eDP-1
[415.670037] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[415.682794] Starting dynamic subtest: pipe-B-eDP-1
[415.702833] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[415.711851] Starting dynamic subtest: pipe-C-eDP-1
[415.731152] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[415.740052] Starting dynamic subtest: pipe-D-eDP-1
[415.759091] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[415.760934] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[417.911097] [090/133] (606s left) prime_busy (before-wait)
[417.981586] Starting subtest: before-wait
[417.983786] Starting dynamic subtest: rcs0
[418.008316] Dynamic subtest rcs0: SUCCESS (0.026s)
[418.019354] Starting dynamic subtest: bcs0
[418.074480] Dynamic subtest bcs0: SUCCESS (0.065s)
[418.085136] Starting dynamic subtest: vcs0
[418.115776] Dynamic subtest vcs0: SUCCESS (0.041s)
[418.125414] Starting dynamic subtest: vcs1
[418.158536] Dynamic subtest vcs1: SUCCESS (0.042s)
[418.168420] Starting dynamic subtest: vecs0
[418.199454] Dynamic subtest vecs0: SUCCESS (0.040s)
[418.209283] Starting dynamic subtest: ccs0
[418.240819] Dynamic subtest ccs0: SUCCESS (0.041s)
[418.349141] Subtest before-wait: SUCCESS (0.369s)
[418.428275] [091/133] (605s left) gem_ppgtt (blt-vs-render-ctx0)
[418.480386] Starting subtest: blt-vs-render-ctx0
[451.256056] Subtest blt-vs-render-ctx0: SUCCESS (32.769s)
[451.384140] [092/133] (572s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[451.537990] Starting subtest: cursorB-vs-flipB-atomic
[451.542547] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[451.684336] [093/133] (572s left) gem_exec_reloc (basic-wc-read-active)
[451.744187] Subtest basic-wc-read-active: SKIP (0.000s)
[451.824662] [094/133] (572s left) gem_exec_fence (syncobj-import)
[452.306107] Starting subtest: syncobj-import
[452.311565] Subtest syncobj-import: SUCCESS (0.005s)
[454.175776] [095/133] (570s left) kms_psr (fbc-psr2-sprite-blt)
[454.269312] Starting subtest: fbc-psr2-sprite-blt
[454.271697] Starting dynamic subtest: eDP-1
[454.276216] Dynamic subtest eDP-1: SKIP (0.000s)
[454.280799] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[454.343406] [096/133] (570s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[454.436788] Starting subtest: plane-lut1d-post-ctm3x4
[454.593370] Starting dynamic subtest: pipe-A-plane-0
[454.770732] Dynamic subtest pipe-A-plane-0: SUCCESS (0.178s)
[454.781768] Starting dynamic subtest: pipe-A-plane-1
[454.926597] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s)
[454.936835] Starting dynamic subtest: pipe-A-plane-2
[455.071344] Dynamic subtest pipe-A-plane-2: SUCCESS (0.143s)
[456.348084] Starting dynamic subtest: pipe-B-plane-0
[456.503856] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[456.515240] Starting dynamic subtest: pipe-B-plane-1
[456.672481] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[456.682907] Starting dynamic subtest: pipe-B-plane-2
[456.838101] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[458.030414] Starting dynamic subtest: pipe-C-plane-0
[458.188898] Dynamic subtest pipe-C-plane-0: SUCCESS (0.166s)
[458.201076] Starting dynamic subtest: pipe-C-plane-1
[458.355808] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[458.366492] Starting dynamic subtest: pipe-C-plane-2
[458.511230] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[459.675693] Starting dynamic subtest: pipe-D-plane-0
[459.844628] Dynamic subtest pipe-D-plane-0: SUCCESS (0.177s)
[459.855844] Starting dynamic subtest: pipe-D-plane-1
[460.000376] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[460.011137] Starting dynamic subtest: pipe-D-plane-2
[460.155845] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[460.446720] Subtest plane-lut1d-post-ctm3x4: SUCCESS (6.011s)
[461.255858] [097/133] (563s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[461.318514] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[461.322867] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[461.515623] [098/133] (563s left) kms_big_fb (linear-8bpp-rotate-180)
[461.608180] Starting subtest: linear-8bpp-rotate-180
[462.878103] Subtest linear-8bpp-rotate-180: SUCCESS (1.270s)
[463.035712] [099/133] (561s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[463.141727] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[463.145389] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[463.243682] [100/133] (561s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[463.357038] Starting subtest: extended-modeset-hang-oldfb-with-reset
[463.358876] Starting dynamic subtest: pipe-A
[475.036921] Dynamic subtest pipe-A: SUCCESS (11.676s)
[475.047870] Starting dynamic subtest: pipe-D
[487.294804] Dynamic subtest pipe-D: SUCCESS (12.254s)
[487.297236] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.934s)
[488.093123] [101/133] (536s left) gem_exec_schedule (timeslicing)
[488.194536] Starting subtest: timeslicing
[488.197042] Starting dynamic subtest: rcs0
[488.207581] Dynamic subtest rcs0: SUCCESS (0.024s)
[488.223172] Starting dynamic subtest: bcs0
[488.231040] Dynamic subtest bcs0: SUCCESS (0.021s)
[488.245869] Starting dynamic subtest: vcs0
[488.252912] Dynamic subtest vcs0: SUCCESS (0.021s)
[488.263205] Starting dynamic subtest: vcs1
[488.273304] Dynamic subtest vcs1: SUCCESS (0.020s)
[488.283708] Starting dynamic subtest: vecs0
[488.293756] Dynamic subtest vecs0: SUCCESS (0.020s)
[488.304770] Starting dynamic subtest: ccs0
[488.314794] Dynamic subtest ccs0: SUCCESS (0.020s)
[488.317101] Subtest timeslicing: SUCCESS (0.133s)
[490.094134] [102/133] (534s left) kms_chamelium_color (ctm-0-25)
[490.186064] Subtest ctm-0-25: SKIP (0.000s)
[490.238432] [103/133] (534s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[490.374129] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[490.376465] Starting dynamic subtest: pipe-A-eDP-1
[490.461144] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s)
[490.472876] Starting dynamic subtest: pipe-B-eDP-1
[491.573022] Dynamic subtest pipe-B-eDP-1: SKIP (1.110s)
[491.577635] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.201s)
[492.757253] [104/133] (532s left) gem_mmap (short-mmap)
[492.819330] Subtest short-mmap: SKIP (0.000s)
[492.882099] [105/133] (532s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[492.941701] Starting subtest: multi-wait-available-unsubmitted-submitted
[492.944031] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.001s)
[493.052781] [106/133] (531s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[493.159891] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[493.164182] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[493.264733] [107/133] (531s left) kms_getfb (getfb2-accept-nv12)
[493.361270] Starting subtest: getfb2-accept-nv12
[493.363377] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[493.468248] [108/133] (531s left) syncobj_timeline (invalid-signal-zero-handles)
[493.523053] Starting subtest: invalid-signal-zero-handles
[493.525360] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[493.627782] [109/133] (531s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[493.706768] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[493.710204] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[493.792396] [110/133] (531s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[493.890455] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[493.894470] Starting dynamic subtest: pipe-A-eDP-1
[493.941222] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[493.951599] Starting dynamic subtest: pipe-B-eDP-1
[493.997432] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[494.007939] Starting dynamic subtest: pipe-C-eDP-1
[494.055584] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[494.069292] Starting dynamic subtest: pipe-D-eDP-1
[494.116461] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[494.120243] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[496.147105] [111/133] (529s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[496.244671] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[496.256780] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.011s)
[496.354627] [112/133] (528s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[496.442413] Starting subtest: async-flip-with-page-flip-events-tiled
[496.820230] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[499.608094] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.786s)
[499.618883] Starting dynamic subtest: pipe-A-eDP-1-4
[501.782935] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s)
[501.793802] Starting dynamic subtest: pipe-A-eDP-1-4
[503.793458] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[503.806807] Starting dynamic subtest: pipe-A-eDP-1-x
[505.973019] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s)
[506.348713] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[509.193212] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.789s)
[509.204707] Starting dynamic subtest: pipe-B-eDP-1-4
[511.317601] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s)
[511.328306] Starting dynamic subtest: pipe-B-eDP-1-4
[513.327618] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.008s)
[513.340017] Starting dynamic subtest: pipe-B-eDP-1-x
[515.519274] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[515.885940] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[518.665634] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.787s)
[518.677073] Starting dynamic subtest: pipe-C-eDP-1-4
[520.841142] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s)
[520.854518] Starting dynamic subtest: pipe-C-eDP-1-4
[522.850843] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.010s)
[522.861917] Starting dynamic subtest: pipe-C-eDP-1-x
[525.081718] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[525.392269] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[528.200748] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.817s)
[528.211992] Starting dynamic subtest: pipe-D-eDP-1-4
[530.394683] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.193s)
[530.405824] Starting dynamic subtest: pipe-D-eDP-1-4
[532.404197] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[532.415794] Starting dynamic subtest: pipe-D-eDP-1-x
[534.582538] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[534.585498] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.137s)
[535.780888] [113/133] (489s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[535.884368] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[535.888831] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[535.984605] [114/133] (489s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[536.039566] Starting subtest: etime-multi-wait-for-submit-submitted
[536.146530] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.106s)
[536.226702] [115/133] (489s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[538.258190] Starting subtest: modeset-non-lpsp-stress-no-wait
[538.307123] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.050s)
[538.637476] [116/133] (486s left) gem_exec_params (sol-reset-invalid)
[538.706403] Starting subtest: sol-reset-invalid
[538.711925] Subtest sol-reset-invalid: SUCCESS (0.002s)
[540.099832] [117/133] (485s left) gem_mmap_gtt (cpuset-big-copy)
[540.159691] Subtest cpuset-big-copy: SKIP (0.000s)
[540.218792] [118/133] (485s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[540.322105] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[548.104763] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.786s)
[548.235190] [119/133] (477s left) kms_psr (psr2-sprite-plane-onoff)
[548.338682] Starting subtest: psr2-sprite-plane-onoff
[548.340932] Starting dynamic subtest: eDP-1
[550.128377] Dynamic subtest eDP-1: SUCCESS (1.788s)
[550.130776] Subtest psr2-sprite-plane-onoff: SUCCESS (1.789s)
[550.972605] [120/133] (474s left) kms_dsc (dsc-with-output-formats)
[551.059035] Starting subtest: dsc-with-output-formats
[551.080793] Subtest dsc-with-output-formats: SKIP (0.001s)
[551.137406] [121/133] (474s left) gen3_mixed_blits
[551.268313] [122/133] (474s left) gem_mmap_offset (clear-via-pagefault)
[551.318876] Starting subtest: clear-via-pagefault
[551.321080] Starting dynamic subtest: smem0
[583.224826] Dynamic subtest smem0: SUCCESS (31.902s)
[583.226907] Subtest clear-via-pagefault: SUCCESS (31.904s)
[583.335564] [123/133] (442s left) gem_eio (reset-stress)
[583.577305] Starting subtest: reset-stress
[583.579420] Starting dynamic subtest: render
[588.692835] Dynamic subtest render: SUCCESS (5.113s)
[588.703442] Starting dynamic subtest: bsd1
[606.623818] Dynamic subtest bsd1: SUCCESS (17.929s)
[606.642090] Starting dynamic subtest: bsd2
[624.644867] Dynamic subtest bsd2: SUCCESS (18.018s)
[624.662487] Starting dynamic subtest: blt
[624.666760] Dynamic subtest blt: SKIP (0.000s)
[624.676722] Starting dynamic subtest: vebox
[642.584836] Dynamic subtest vebox: SUCCESS (17.935s)
[642.586786] Subtest reset-stress: SUCCESS (59.000s)
[644.142521] [124/133] (381s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[644.209467] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[644.211523] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[644.304757] [125/133] (381s left) kms_vblank (query-busy-hang)
[644.397476] Starting subtest: query-busy-hang
[644.399698] Starting dynamic subtest: pipe-A-eDP-1
[646.289492] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.892s)
[646.305637] Starting dynamic subtest: pipe-D-eDP-1
[648.829718] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.536s)
[648.832330] Subtest query-busy-hang: SUCCESS (4.432s)
[649.628520] [126/133] (376s left) kms_psr (fbc-pr-cursor-plane-onoff)
[649.726632] Starting subtest: fbc-pr-cursor-plane-onoff
[649.731054] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[649.800849] [127/133] (376s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[649.898137] Starting subtest: psr-1p-primscrn-cur-indfb-move
[657.281830] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.386s)
[657.407164] [128/133] (368s left) tools_test (sysfs_l3_parity)
[657.463299] Starting subtest: sysfs_l3_parity
[657.539019] Subtest sysfs_l3_parity: SKIP (0.087s)
[657.607967] [129/133] (368s left) kms_vblank (crtc-id)
[657.691614] Starting subtest: crtc-id
[657.693816] Starting dynamic subtest: pipe-A-eDP-1
[658.139826] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.447s)
[658.155666] Starting dynamic subtest: pipe-D-eDP-1
[659.249061] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.107s)
[659.250972] Subtest crtc-id: SUCCESS (1.558s)
[660.087837] [130/133] (365s left) gem_ctx_engines (independent)
[660.160467] Starting subtest: independent
[660.162829] Starting dynamic subtest: rcs0
[660.307824] Dynamic subtest rcs0: SUCCESS (0.149s)
[660.321289] Starting dynamic subtest: bcs0
[660.475475] Dynamic subtest bcs0: SUCCESS (0.167s)
[660.488461] Starting dynamic subtest: vcs0
[660.653383] Dynamic subtest vcs0: SUCCESS (0.177s)
[660.666408] Starting dynamic subtest: vcs1
[660.831881] Dynamic subtest vcs1: SUCCESS (0.178s)
[660.845028] Starting dynamic subtest: vecs0
[661.003673] Dynamic subtest vecs0: SUCCESS (0.171s)
[661.017366] Starting dynamic subtest: ccs0
[661.185833] Dynamic subtest ccs0: SUCCESS (0.181s)
[661.196426] Starting dynamic subtest: all-engines
[661.846758] Dynamic subtest all-engines: SUCCESS (0.659s)
[661.849512] Subtest independent: SUCCESS (1.688s)
[662.345588] [131/133] (363s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[662.448808] Starting subtest: flip-vs-dpms-on-nop-interruptible
[662.451051] Starting dynamic subtest: A-eDP1
[664.274815] Dynamic subtest A-eDP1: SUCCESS (1.824s)
[664.291685] Starting dynamic subtest: B-eDP1
[666.118881] Dynamic subtest B-eDP1: SUCCESS (1.840s)
[666.136829] Starting dynamic subtest: C-eDP1
[667.944294] Dynamic subtest C-eDP1: SUCCESS (1.823s)
[667.955616] Starting dynamic subtest: D-eDP1
[669.773968] Dynamic subtest D-eDP1: SUCCESS (1.827s)
[669.778785] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.328s)
[670.972362] [132/133] (355s left) kms_plane_lowres (tiling-x)
[671.064155] Starting subtest: tiling-x
[671.066575] Starting dynamic subtest: pipe-A-eDP-1
[671.071282] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[671.371007] Starting dynamic subtest: pipe-B-eDP-1
[671.375525] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[671.386129] Starting dynamic subtest: pipe-C-eDP-1
[671.390609] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[671.400887] Starting dynamic subtest: pipe-D-eDP-1
[671.404936] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[671.409034] Subtest tiling-x: SKIP (0.306s)
[672.188441] [133/133] (353s left) i915_pm_freq_api (freq-reset)
[672.258604] Starting subtest: freq-reset
[672.260906] Starting dynamic subtest: gt0
[672.451795] Dynamic subtest gt0: SUCCESS (0.192s)
[672.461982] Starting dynamic subtest: gt1
[672.623494] Dynamic subtest gt1: SUCCESS (0.170s)
[672.625835] Subtest freq-reset: SUCCESS (0.364s)
[672.696205] 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.