[59.657568] Initializing watchdogs
[59.657621]   /dev/watchdog0
[59.673608] [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]
[59.678576] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.681458] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.683184] [001/133] (960s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[59.782077] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[59.783737] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[59.848552] [002/133] (960s left) gem_mmap_gtt (fault-concurrent-y)
[59.898775] Subtest fault-concurrent-Y: SKIP (0.000s)
[59.951520] [003/133] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[60.048432] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[60.050481] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[60.133130] [004/133] (960s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[61.311933] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[61.614597] [005/133] (958s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[61.703466] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[61.704427] Starting dynamic subtest: pipe-A-eDP-1
[62.992595] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.289s)
[63.269028] Starting dynamic subtest: pipe-B-eDP-1
[64.329630] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.061s)
[64.590494] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.888s)
[65.431534] [006/133] (954s left) gem_mmap_wc (read)
[65.477337] Subtest read: SKIP (0.000s)
[65.531412] [007/133] (954s left) kms_dsc (dsc-basic)
[65.626351] Starting subtest: dsc-basic
[65.631832] Subtest dsc-basic: SKIP (0.000s)
[65.703666] [008/133] (954s left) kms_addfb_basic (unused-offsets)
[65.748227] Starting subtest: unused-offsets
[65.749137] Subtest unused-offsets: SUCCESS (0.000s)
[65.871356] [009/133] (954s left) gem_pxp (create-valid-protected-context)
[66.001862] Starting subtest: create-valid-protected-context
[66.004453] Subtest create-valid-protected-context: SUCCESS (0.003s)
[66.113149] [010/133] (954s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[66.196450] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[66.197415] Starting dynamic subtest: pipe-A-eDP-1
[67.127900] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.930s)
[67.135342] Starting dynamic subtest: pipe-B-eDP-1
[68.746665] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.618s)
[68.754237] Starting dynamic subtest: pipe-C-eDP-1
[70.290918] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.544s)
[70.298737] Starting dynamic subtest: pipe-D-eDP-1
[71.793439] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.502s)
[71.794260] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.597s)
[72.992233] [011/133] (947s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[73.230114] Starting subtest: fbcpsr-stridechange
[79.533233] Subtest fbcpsr-stridechange: SUCCESS (6.305s)
[79.652866] [012/133] (940s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[79.755250] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[79.757119] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[79.853464] [013/133] (940s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[79.945949] Starting subtest: psr2-plane-move-sf-dmg-area
[79.946824] Starting dynamic subtest: pipe-A-eDP-1
[84.446875] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.501s)
[84.455159] Starting dynamic subtest: pipe-B-eDP-1
[89.778520] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.330s)
[89.779719] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.833s)
[90.650670] [014/133] (929s left) kms_cursor_edge_walk (64x64-top-edge)
[90.743373] Starting subtest: 64x64-top-edge
[90.744221] Starting dynamic subtest: pipe-A-eDP-1
[94.221169] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.477s)
[94.229278] Starting dynamic subtest: pipe-D-eDP-1
[97.331508] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.109s)
[97.332712] Subtest 64x64-top-edge: SUCCESS (6.588s)
[98.150700] [015/133] (922s left) vgem_basic (dmabuf-mmap)
[98.220602] Starting subtest: dmabuf-mmap
[98.231298] Subtest dmabuf-mmap: SUCCESS (0.011s)
[98.284028] [FACT vgem_basic (dmabuf-mmap)] new: kernel.kmod_is_loaded.vgem: true
[98.285876] [016/133] (922s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[98.381539] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[98.382517] Starting dynamic subtest: pipe-A
[98.445818] Dynamic subtest pipe-A: SUCCESS (0.065s)
[98.454962] Starting dynamic subtest: pipe-B
[99.579054] Dynamic subtest pipe-B: SUCCESS (1.132s)
[99.589979] Starting dynamic subtest: pipe-C
[100.693750] Dynamic subtest pipe-C: SUCCESS (1.114s)
[100.701654] Starting dynamic subtest: pipe-D
[101.835375] Dynamic subtest pipe-D: SUCCESS (1.141s)
[101.836329] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.455s)
[102.989914] [017/133] (917s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[103.086061] Starting subtest: bad-rotation-90-yf-tiled-ccs
[103.086981] Starting dynamic subtest: pipe-A-eDP-1
[103.094936] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[103.101801] Starting dynamic subtest: pipe-B-eDP-1
[103.109163] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[103.116055] Starting dynamic subtest: pipe-C-eDP-1
[103.123713] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[103.130190] Starting dynamic subtest: pipe-D-eDP-1
[103.138282] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[103.139839] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.003s)
[105.357672] [018/133] (915s left) gem_ctx_exec (basic)
[105.421942] Starting subtest: basic
[105.428835] Subtest basic: SUCCESS (0.007s)
[105.565655] [019/133] (915s left) gem_exec_schedule (pi-shared-iova)
[105.744754] Starting subtest: pi-shared-iova
[105.745855] Starting dynamic subtest: rcs0
[105.825424] Dynamic subtest rcs0: SUCCESS (0.082s)
[105.834420] Starting dynamic subtest: vcs0
[105.882416] Dynamic subtest vcs0: SUCCESS (0.056s)
[105.892078] Starting dynamic subtest: vcs1
[105.938627] Dynamic subtest vcs1: SUCCESS (0.056s)
[105.946063] Starting dynamic subtest: vecs0
[105.999067] Dynamic subtest vecs0: SUCCESS (0.060s)
[106.009289] Starting dynamic subtest: ccs0
[106.063075] Dynamic subtest ccs0: SUCCESS (0.063s)
[106.064722] Subtest pi-shared-iova: SUCCESS (0.320s)
[107.380875] [020/133] (913s left) device_reset (unbind-reset-rebind)
[107.428236] Starting subtest: unbind-reset-rebind
[113.621915] Subtest unbind-reset-rebind: SUCCESS (6.182s)
[113.652750] [021/133] (907s left) syncobj_timeline (wait-all-snapshot)
[113.701171] Starting subtest: wait-all-snapshot
[113.783854] Subtest wait-all-snapshot: SUCCESS (0.082s)
[113.856250] [022/133] (907s left) gem_mmap_gtt (medium-copy-xy)
[113.902063] Subtest medium-copy-XY: SKIP (0.000s)
[113.961175] [023/133] (906s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[114.007589] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[114.008484] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[114.091452] [024/133] (906s left) perf_pmu (busy-check-all)
[114.126168] Starting subtest: busy-check-all
[114.127118] Starting dynamic subtest: rcs0
[114.678298] Dynamic subtest rcs0: SUCCESS (0.551s)
[114.689668] Starting dynamic subtest: bcs0
[115.228261] Dynamic subtest bcs0: SUCCESS (0.548s)
[115.239864] Starting dynamic subtest: vcs0
[116.325329] Dynamic subtest vcs0: SUCCESS (1.086s)
[116.336416] Starting dynamic subtest: vcs1
[118.308880] Dynamic subtest vcs1: SUCCESS (1.981s)
[118.317031] Starting dynamic subtest: vecs0
[120.358748] Dynamic subtest vecs0: SUCCESS (2.048s)
[120.367205] Starting dynamic subtest: ccs0
[120.906173] Dynamic subtest ccs0: SUCCESS (0.554s)
[120.907396] Subtest busy-check-all: SUCCESS (6.780s)
[121.000291] [025/133] (900s left) syncobj_timeline (invalid-query-illegal-handle)
[121.048388] Starting subtest: invalid-query-illegal-handle
[121.049364] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[121.163272] [026/133] (899s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[121.286432] Starting subtest: cursorA-vs-flipA-atomic-transitions
[132.484044] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.195s)
[133.282204] [027/133] (887s left) gem_tiled_swapping (non-threaded)
[133.338531] Subtest non-threaded: SKIP (0.000s)
[133.393178] [028/133] (887s left) kms_plane_multiple (tiling-x)
[133.485385] Starting subtest: tiling-x
[133.486324] Starting dynamic subtest: pipe-A-eDP-1
[137.244994] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.757s)
[137.255437] Starting dynamic subtest: pipe-B-eDP-1
[141.742590] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.497s)
[141.751631] Starting dynamic subtest: pipe-C-eDP-1
[146.082040] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.339s)
[146.090606] Starting dynamic subtest: pipe-D-eDP-1
[150.444968] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.362s)
[150.446123] Subtest tiling-x: SUCCESS (16.960s)
[151.243750] [029/133] (869s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[151.343047] Starting subtest: yf-tiled-16bpp-rotate-270
[151.344915] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[151.454746] [030/133] (869s left) kms_psr (pr-cursor-mmap-cpu)
[151.539970] Starting subtest: pr-cursor-mmap-cpu
[151.541752] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[151.607922] [031/133] (869s left) gem_ctx_param (invalid-get-ringsize)
[151.662464] Starting subtest: invalid-get-ringsize
[151.663275] Subtest invalid-get-ringsize: SUCCESS (0.002s)
[151.773355] [032/133] (869s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[151.872716] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[158.519394] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.647s)
[158.640592] [033/133] (862s left) gem_exec_whisper (basic-fds-all)
[158.703153] Starting subtest: basic-fds-all
[169.647752] Subtest basic-fds-all: SUCCESS (10.944s)
[169.827109] [034/133] (851s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[169.924369] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[169.925984] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[170.012917] [035/133] (851s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[170.055431] Starting subtest: invalid-multi-wait-unsubmitted
[170.056372] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[170.147836] [036/133] (851s left) gem_mmap_offset (close-race)
[170.194204] Starting subtest: close-race
[190.312221] Subtest close-race: SUCCESS (20.109s)
[190.440973] [037/133] (830s left) kms_psr (psr-cursor-render)
[190.535122] Starting subtest: psr-cursor-render
[190.536025] Starting dynamic subtest: eDP-1
[192.253943] Dynamic subtest eDP-1: SUCCESS (1.718s)
[192.254966] Subtest psr-cursor-render: SUCCESS (1.719s)
[193.136139] [038/133] (828s left) perf_pmu (interrupts)
[193.171080] Starting subtest: interrupts
[194.273913] Subtest interrupts: SUCCESS (1.092s)
[194.373742] [039/133] (827s left) api_intel_allocator (alloc-simple)
[194.424723] Starting subtest: alloc-simple
[194.427878] Subtest alloc-simple: SUCCESS (0.003s)
[194.554666] [040/133] (826s left) kms_psr (psr-primary-blt)
[194.640433] Starting subtest: psr-primary-blt
[194.641417] Starting dynamic subtest: eDP-1
[196.428542] Dynamic subtest eDP-1: SUCCESS (1.786s)
[196.429517] Subtest psr-primary-blt: SUCCESS (1.787s)
[197.290233] [041/133] (824s left) kms_cursor_crc (cursor-random-512x170)
[197.577408] Starting subtest: cursor-random-512x170
[197.579296] Subtest cursor-random-512x170: SKIP (0.001s)
[197.713497] [042/133] (823s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[197.756820] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[197.864897] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.107s)
[197.944797] [043/133] (823s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[199.466799] Starting subtest: gem-execbuf-stress-pc8
[199.504467] Subtest gem-execbuf-stress-pc8: SKIP (0.040s)
[200.262785] [044/133] (821s left) gem_reg_read (bad-register)
[200.314919] Starting subtest: bad-register
[200.316021] Subtest bad-register: SUCCESS (0.000s)
[200.404835] [045/133] (821s left) gem_mmap_gtt (basic-small-copy-odd)
[200.460216] Subtest basic-small-copy-odd: SKIP (0.000s)
[200.520892] [046/133] (821s left) i915_hangman (gt-engine-hang)
[200.583687] Starting subtest: gt-engine-hang
[200.584775] Starting dynamic subtest: rcs0
[202.308547] Dynamic subtest rcs0: SUCCESS (1.716s)
[202.321668] Starting dynamic subtest: bcs0
[204.227571] Dynamic subtest bcs0: SUCCESS (1.915s)
[204.236988] Starting dynamic subtest: vcs0
[205.315222] Dynamic subtest vcs0: SUCCESS (1.085s)
[205.326397] Starting dynamic subtest: vcs1
[207.300664] Dynamic subtest vcs1: SUCCESS (1.982s)
[207.312355] Starting dynamic subtest: vecs0
[209.283878] Dynamic subtest vecs0: SUCCESS (1.981s)
[209.295097] Starting dynamic subtest: ccs0
[211.331535] Dynamic subtest ccs0: SUCCESS (2.045s)
[211.332930] Subtest gt-engine-hang: SUCCESS (10.741s)
[211.461708] [047/133] (810s left) fbdev (pan)
[211.494663] Starting subtest: pan
[211.524495] Subtest pan: SUCCESS (0.030s)
[211.592521] [048/133] (810s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[211.694558] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[212.421088] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: FAIL (0.520s)
[212.452914] [049/133] (809s left) prime_self_import (basic-with_one_bo)
[212.482574] Starting subtest: basic-with_one_bo
[212.506307] Subtest basic-with_one_bo: SUCCESS (0.024s)
[212.640470] [050/133] (809s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[212.722722] Starting subtest: 2x-flip-vs-modeset-vs-hang
[212.726125] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.002s)
[212.806775] [051/133] (809s left) kms_flip (2x-flip-vs-suspend)
[212.897094] Starting subtest: 2x-flip-vs-suspend
[212.898858] Subtest 2x-flip-vs-suspend: SKIP (0.002s)
[212.973621] [052/133] (809s left) i915_query (query-garbage)
[213.023083] Starting subtest: query-garbage
[213.024434] Subtest query-garbage: SUCCESS (0.000s)
[213.117110] [053/133] (808s left) kms_pm_dc (dc5-retention-flops)
[214.205768] Starting subtest: dc5-retention-flops
[214.208391] Subtest dc5-retention-flops: SKIP (0.000s)
[214.286651] [054/133] (807s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[214.374981] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[214.376661] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[214.477140] [055/133] (807s left) kms_atomic_interruptible (legacy-dpms)
[214.570431] Starting subtest: legacy-dpms
[214.571489] Starting dynamic subtest: pipe-A-eDP-1
[221.970819] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.399s)
[221.971646] Subtest legacy-dpms: SUCCESS (7.401s)
[222.788556] [056/133] (799s left) gem_basic (create-close)
[222.845364] Starting subtest: create-close
[222.847310] Subtest create-close: SUCCESS (0.000s)
[222.933662] [057/133] (799s left) sysfs_timeslice_duration (idempotent)
[222.991046] Starting subtest: idempotent
[222.992175] Starting dynamic subtest: vecs0
[222.993189] Dynamic subtest vecs0: SUCCESS (0.000s)
[223.002944] Starting dynamic subtest: ccs0
[223.003922] Dynamic subtest ccs0: SUCCESS (0.000s)
[223.013200] Starting dynamic subtest: vcs0
[223.014160] Dynamic subtest vcs0: SUCCESS (0.000s)
[223.023080] Starting dynamic subtest: bcs0
[223.024027] Dynamic subtest bcs0: SUCCESS (0.000s)
[223.032939] Starting dynamic subtest: rcs0
[223.034026] Dynamic subtest rcs0: SUCCESS (0.000s)
[223.042418] Starting dynamic subtest: vcs1
[223.043558] Dynamic subtest vcs1: SUCCESS (0.000s)
[223.044978] Subtest idempotent: SUCCESS (0.006s)
[223.102732] [058/133] (799s left) kms_cursor_crc (cursor-offscreen-128x128)
[223.307873] Starting subtest: cursor-offscreen-128x128
[223.311065] Starting dynamic subtest: pipe-A-eDP-1
[225.266741] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.955s)
[225.298466] Starting dynamic subtest: pipe-D-eDP-1
[227.923556] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.633s)
[227.924627] Subtest cursor-offscreen-128x128: SUCCESS (4.615s)
[228.778625] [059/133] (793s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[228.871373] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[228.873220] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[228.971343] [060/133] (793s left) gem_pxp (regular-baseline-src-copy-readible)
[229.077513] Starting subtest: regular-baseline-src-copy-readible
[229.135831] Subtest regular-baseline-src-copy-readible: SUCCESS (0.060s)
[229.255352] [061/133] (793s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[229.346133] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[229.347928] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[229.418284] [062/133] (792s left) gem_exec_schedule (fairslice)
[229.480894] Starting subtest: fairslice
[229.481922] Starting dynamic subtest: rcs0
[231.507520] Dynamic subtest rcs0: SUCCESS (2.023s)
[231.516619] Starting dynamic subtest: bcs0
[233.529477] Dynamic subtest bcs0: SUCCESS (2.017s)
[233.538580] Starting dynamic subtest: vcs0
[235.548532] Dynamic subtest vcs0: SUCCESS (2.019s)
[235.557079] Starting dynamic subtest: vcs1
[237.567990] Dynamic subtest vcs1: SUCCESS (2.021s)
[237.578229] Starting dynamic subtest: vecs0
[239.589720] Dynamic subtest vecs0: SUCCESS (2.019s)
[239.601295] Starting dynamic subtest: ccs0
[241.610288] Dynamic subtest ccs0: SUCCESS (2.023s)
[241.611339] Subtest fairslice: SUCCESS (12.127s)
[241.918951] [063/133] (780s left) kms_frontbuffer_tracking (psr-2p-rte)
[242.016252] Starting subtest: psr-2p-rte
[242.017922] Subtest psr-2p-rte: SKIP (0.000s)
[242.110131] [064/133] (780s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[242.196269] Starting subtest: plane-lut1d-pre-ctm3x4
[242.365856] Starting dynamic subtest: pipe-A-plane-0
[242.565600] Dynamic subtest pipe-A-plane-0: SUCCESS (0.200s)
[242.575745] Starting dynamic subtest: pipe-A-plane-1
[242.732292] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[242.741821] Starting dynamic subtest: pipe-A-plane-2
[242.899064] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[244.088875] Starting dynamic subtest: pipe-B-plane-0
[244.257155] Dynamic subtest pipe-B-plane-0: SUCCESS (0.177s)
[244.266764] Starting dynamic subtest: pipe-B-plane-1
[244.412954] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s)
[244.422842] Starting dynamic subtest: pipe-B-plane-2
[244.579915] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[245.799544] Starting dynamic subtest: pipe-C-plane-0
[245.957169] Dynamic subtest pipe-C-plane-0: SUCCESS (0.167s)
[245.968741] Starting dynamic subtest: pipe-C-plane-1
[246.123847] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[246.134074] Starting dynamic subtest: pipe-C-plane-2
[246.290497] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[247.470063] Starting dynamic subtest: pipe-D-plane-0
[247.627243] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s)
[247.636487] Starting dynamic subtest: pipe-D-plane-1
[247.793931] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[247.803917] Starting dynamic subtest: pipe-D-plane-2
[247.960785] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[248.247376] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (6.051s)
[249.117106] [065/133] (773s left) gem_exec_balancer (semaphore)
[249.179385] Starting subtest: semaphore
[250.338433] Subtest semaphore: SUCCESS (1.150s)
[250.644039] [066/133] (771s left) kms_content_protection (dp-mst-type-0)
[250.787974] Starting subtest: dp-mst-type-0
[250.789966] Subtest dp-mst-type-0: SKIP (0.000s)
[250.923871] [067/133] (771s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[251.024370] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[251.026055] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[251.108904] [068/133] (771s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[251.216363] Starting subtest: 2x-flip-vs-cursor-atomic
[251.219257] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[251.356672] [069/133] (771s left) kms_lease (lease-invalid-crtc)
[251.438620] Starting subtest: lease-invalid-crtc
[251.439557] Starting dynamic subtest: pipe-A-eDP-1
[251.440542] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[251.454289] Starting dynamic subtest: pipe-B-eDP-1
[251.455284] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[251.464262] Starting dynamic subtest: pipe-C-eDP-1
[251.465180] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[251.474066] Starting dynamic subtest: pipe-D-eDP-1
[251.474933] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[251.475806] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[251.509928] [070/133] (771s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[251.630477] Starting subtest: cursor-vs-flip-atomic-transitions
[282.098932] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.465s)
[282.941406] [071/133] (739s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[282.991673] Starting subtest: yf-tiled-to-vebox-y-tiled
[282.993340] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[283.170211] [072/133] (739s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[283.262311] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[283.263368] Starting dynamic subtest: pipe-A-default-mode
[284.407391] Dynamic subtest pipe-A-default-mode: SKIP (1.144s)
[284.409266] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.145s)
[284.548513] [073/133] (738s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[284.605822] Starting subtest: etime-single-wait-available-unsubmitted
[284.713148] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.106s)
[284.788679] [074/133] (737s left) kms_chamelium_color (ctm-0-50)
[284.877571] Subtest ctm-0-50: SKIP (0.000s)
[284.918951] [075/133] (737s left) kms_invalid_mode (overflow-vrefresh)
[285.013983] Starting subtest: overflow-vrefresh
[285.015118] Starting dynamic subtest: pipe-A-eDP-1
[285.299546] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[285.311447] Starting dynamic subtest: pipe-B-eDP-1
[285.312318] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[285.321442] Starting dynamic subtest: pipe-C-eDP-1
[285.322246] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[285.331084] Starting dynamic subtest: pipe-D-eDP-1
[285.331986] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[285.332935] Subtest overflow-vrefresh: SUCCESS (0.291s)
[286.098480] [076/133] (736s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[286.193607] Starting subtest: psr-1p-primscrn-spr-indfb-move
[293.653136] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.459s)
[293.795926] [077/133] (729s left) gem_create (hog-create)
[293.866798] Starting subtest: hog-create
[293.868284] Starting dynamic subtest: smem0
[327.342303] Dynamic subtest smem0: SUCCESS (33.464s)
[327.343722] Subtest hog-create: SUCCESS (33.466s)
[327.532418] [078/133] (695s left) gem_unref_active_buffers
[327.772029] [079/133] (695s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[327.879040] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[327.881084] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[327.985109] [080/133] (694s left) kms_big_fb (y-tiled-addfb-size-overflow)
[328.084355] Starting subtest: y-tiled-addfb-size-overflow
[328.086376] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[328.196213] [081/133] (694s left) gem_exec_reloc (basic-write-cpu-active)
[328.254932] Subtest basic-write-cpu-active: SKIP (0.000s)
[328.326917] [082/133] (694s left) kms_pm_rpm (legacy-planes-dpms)
[330.459524] Starting subtest: legacy-planes-dpms
[330.460928] Starting dynamic subtest: plane-65
[338.768553] Dynamic subtest plane-65: SUCCESS (8.307s)
[338.783310] Starting dynamic subtest: plane-95
[347.086105] Dynamic subtest plane-95: SUCCESS (8.314s)
[347.100657] Starting dynamic subtest: plane-125
[355.403046] Dynamic subtest plane-125: SUCCESS (8.314s)
[355.417474] Starting dynamic subtest: plane-135
[364.039172] Dynamic subtest plane-135: SUCCESS (8.633s)
[364.043165] Subtest legacy-planes-dpms: SUCCESS (33.580s)
[364.419046] [083/133] (658s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[364.510801] Starting subtest: disable-crc-after-crtc
[364.512246] Starting dynamic subtest: pipe-A-eDP-1
[366.175534] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.665s)
[366.185911] Starting dynamic subtest: pipe-B-eDP-1
[368.547247] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.370s)
[368.557506] Starting dynamic subtest: pipe-C-eDP-1
[370.778955] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.228s)
[370.790561] Starting dynamic subtest: pipe-D-eDP-1
[373.069289] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.289s)
[373.070184] Subtest disable-crc-after-crtc: SUCCESS (8.559s)
[373.898126] [084/133] (649s left) prime_udl
[373.970620] [085/133] (649s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[374.060975] Starting subtest: fbcpsr-modesetfrombusy
[380.269618] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.210s)
[380.396490] [086/133] (642s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[380.499520] Starting subtest: x-tiled-8bpp-rotate-270
[380.520156] Subtest x-tiled-8bpp-rotate-270: SKIP (0.020s)
[380.636870] [087/133] (642s left) gem_exec_fence (syncobj-repeat)
[381.093676] Starting subtest: syncobj-repeat
[381.304791] Subtest syncobj-repeat: SUCCESS (0.206s)
[382.390766] [088/133] (640s left) gem_softpin (zero)
[382.450172] Starting subtest: zero
[382.454580] Subtest zero: SUCCESS (0.004s)
[382.564400] [089/133] (640s left) gem_ctx_persistence (heartbeat-hostile)
[382.610818] Starting subtest: heartbeat-hostile
[382.612688] Subtest heartbeat-hostile: SKIP (0.000s)
[382.734060] [090/133] (640s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[382.830885] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[382.832962] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[382.930617] [091/133] (640s left) kms_chamelium_frames (hdmi-crc-multiple)
[383.303357] Subtest hdmi-crc-multiple: SKIP (0.000s)
[384.160081] [092/133] (639s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[384.249205] Starting subtest: async-flip-with-page-flip-events-linear
[384.625277] Starting dynamic subtest: pipe-A-eDP-1
[387.368011] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.733s)
[387.734418] Starting dynamic subtest: pipe-B-eDP-1
[390.501255] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.767s)
[390.857886] Starting dynamic subtest: pipe-C-eDP-1
[393.631029] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.774s)
[393.996880] Starting dynamic subtest: pipe-D-eDP-1
[396.764791] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.768s)
[396.766344] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.508s)
[397.937066] [093/133] (625s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[398.036348] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[398.038198] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[398.112081] [094/133] (625s left) gem_exec_params (secure-non-master)
[398.161193] Starting subtest: secure-non-master
[398.162978] Subtest secure-non-master: SKIP (0.000s)
[398.280246] [095/133] (625s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[398.368222] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[398.369868] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[398.478267] [096/133] (625s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[398.566593] Starting subtest: fbc-rgb101010-draw-render
[403.167551] Subtest fbc-rgb101010-draw-render: SUCCESS (4.601s)
[404.354109] [097/133] (619s left) api_intel_bb (reset-flags)
[404.403391] Starting subtest: reset-flags
[404.413133] Subtest reset-flags: SUCCESS (0.010s)
[404.518850] [098/133] (619s left) syncobj_wait (single-wait-submitted)
[404.558826] Starting subtest: single-wait-submitted
[404.664930] Subtest single-wait-submitted: SUCCESS (0.106s)
[404.757927] [099/133] (618s left) i915_query (engine-info)
[404.806108] Starting subtest: engine-info
[404.809141] Subtest engine-info: SUCCESS (0.005s)
[404.934422] [100/133] (618s left) perf_pmu (all-busy-check-all)
[404.972362] Starting subtest: all-busy-check-all
[406.308432] Subtest all-busy-check-all: SUCCESS (1.328s)
[406.410113] [101/133] (617s left) syncobj_basic (bad-flags-fd-to-handle)
[406.459394] Starting subtest: bad-flags-fd-to-handle
[406.460363] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[406.563746] [102/133] (617s left) gem_exec_schedule (u-submit-golden-slice)
[406.622588] Starting subtest: u-submit-golden-slice
[406.623540] Starting dynamic subtest: rcs0
[406.659150] Dynamic subtest rcs0: SUCCESS (0.036s)
[406.671154] Starting dynamic subtest: bcs0
[406.691754] Dynamic subtest bcs0: SUCCESS (0.030s)
[406.703766] Starting dynamic subtest: vcs0
[406.723149] Dynamic subtest vcs0: SUCCESS (0.030s)
[406.735855] Starting dynamic subtest: vcs1
[406.755373] Dynamic subtest vcs1: SUCCESS (0.031s)
[406.770039] Starting dynamic subtest: vecs0
[406.780970] Dynamic subtest vecs0: SUCCESS (0.026s)
[406.791047] Starting dynamic subtest: ccs0
[406.808604] Dynamic subtest ccs0: SUCCESS (0.027s)
[406.809622] Subtest u-submit-golden-slice: SUCCESS (0.186s)
[408.452482] [103/133] (615s left) i915_drm_fdinfo (memory-info-shared)
[408.488411] Starting subtest: memory-info-shared
[408.489171] Starting dynamic subtest: smem0
[408.549497] Dynamic subtest smem0: SUCCESS (0.060s)
[408.550882] Subtest memory-info-shared: SUCCESS (0.061s)
[408.631959] [104/133] (615s left) gem_mmap_wc (write-read-distinct)
[408.684599] Subtest write-read-distinct: SKIP (0.000s)
[408.737092] [105/133] (615s left) kms_selftest (drm_damage_helper)
[408.764251] Starting subtest: drm_damage_helper
[408.776754] Starting dynamic subtest: drm_test_damage_iter_no_damage
[408.880859] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.102s)
[408.890789] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[408.968565] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.087s)
[408.979223] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[409.060761] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.090s)
[409.071208] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[409.156672] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.095s)
[409.167808] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[409.240517] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.082s)
[409.254088] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[409.331385] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.089s)
[409.342082] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[409.432911] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.100s)
[409.446373] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[409.524530] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.091s)
[409.535105] Starting dynamic subtest: drm_test_damage_iter_single_damage
[409.618717] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.091s)
[409.628397] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[409.716429] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.097s)
[409.725383] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[409.814071] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.095s)
[409.823568] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[409.888919] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.073s)
[409.898481] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[410.011042] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.121s)
[410.022575] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[410.119447] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.107s)
[410.130906] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[410.212377] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.093s)
[410.223119] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[410.307652] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.094s)
[410.318936] Starting dynamic subtest: drm_test_damage_iter_damage
[410.399076] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.090s)
[410.410263] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[410.484602] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.083s)
[410.493725] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[410.567615] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.082s)
[410.577842] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[410.672879] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.104s)
[410.685585] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[410.779771] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.104s)
[410.780799] Subtest drm_damage_helper: SUCCESS (2.014s)
[410.975499] [106/133] (612s left) prime_mmap (test_correct_cpu_write)
[411.021272] Starting subtest: test_correct_cpu_write
[411.022277] Starting dynamic subtest: test_correct_cpu_write-smem
[411.023265] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[411.024197] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[411.115575] [107/133] (612s left) gen9_exec_parse (secure-batches)
[411.163313] Subtest secure-batches: SKIP (0.000s)
[411.225820] [108/133] (612s left) kms_atomic (plane-immutable-zpos)
[411.314599] Starting subtest: plane-immutable-zpos
[411.315667] Starting dynamic subtest: pipe-A-eDP-1
[411.979492] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.663s)
[411.980465] Subtest plane-immutable-zpos: SUCCESS (0.664s)
[412.799937] [109/133] (611s left) gem_exec_nop (basic-parallel)
[412.867394] Starting subtest: basic-parallel
[429.286410] Subtest basic-parallel: SUCCESS (16.412s)
[429.501092] [110/133] (594s left) kms_psr (fbc-psr-sprite-render)
[429.594566] Starting subtest: fbc-psr-sprite-render
[429.595444] Starting dynamic subtest: eDP-1
[429.597019] Dynamic subtest eDP-1: SKIP (0.000s)
[429.598676] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[429.679200] [111/133] (594s left) gem_fenced_exec_thrash (2-spare-fences)
[429.727902] Subtest 2-spare-fences: SKIP (0.000s)
[429.799084] [112/133] (594s left) perf_pmu (idle)
[429.835240] Starting subtest: idle
[429.836156] Starting dynamic subtest: rcs0
[430.379031] Dynamic subtest rcs0: SUCCESS (0.531s)
[430.388975] Starting dynamic subtest: bcs0
[430.898847] Dynamic subtest bcs0: SUCCESS (0.520s)
[430.910597] Starting dynamic subtest: vcs0
[431.422990] Dynamic subtest vcs0: SUCCESS (0.521s)
[431.432756] Starting dynamic subtest: vcs1
[431.941719] Dynamic subtest vcs1: SUCCESS (0.516s)
[431.951220] Starting dynamic subtest: vecs0
[432.458040] Dynamic subtest vecs0: SUCCESS (0.513s)
[432.468382] Starting dynamic subtest: ccs0
[432.980789] Dynamic subtest ccs0: SUCCESS (0.519s)
[432.982331] Subtest idle: SUCCESS (3.138s)
[433.086795] [113/133] (591s left) kms_vblank (wait-busy-hang)
[433.171261] Starting subtest: wait-busy-hang
[433.172173] Starting dynamic subtest: pipe-A-eDP-1
[460.069126] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.895s)
[460.080406] Starting dynamic subtest: pipe-D-eDP-1
[475.099603] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.028s)
[475.100659] Subtest wait-busy-hang: SUCCESS (41.928s)
[475.953048] [114/133] (548s left) gem_exec_balancer (noheartbeat)
[476.228990] Starting subtest: noheartbeat
[476.231032] Subtest noheartbeat: SKIP (0.000s)
[476.318311] [115/133] (547s left) kms_hdr (brightness-with-hdr)
[476.407594] Starting subtest: brightness-with-hdr
[476.410304] Subtest brightness-with-hdr: SKIP (0.000s)
[476.476191] [116/133] (547s left) kms_flip (blocking-wf_vblank)
[476.556156] Starting subtest: blocking-wf_vblank
[476.558269] Starting dynamic subtest: A-eDP1
[485.538516] Dynamic subtest A-eDP1: SUCCESS (8.956s)
[485.548828] Starting dynamic subtest: B-eDP1
[494.463492] Dynamic subtest B-eDP1: SUCCESS (8.921s)
[494.475903] Starting dynamic subtest: C-eDP1
[503.397198] Dynamic subtest C-eDP1: SUCCESS (8.920s)
[503.408834] Starting dynamic subtest: D-eDP1
[512.334913] Dynamic subtest D-eDP1: SUCCESS (8.932s)
[512.336228] Subtest blocking-wf_vblank: SUCCESS (35.744s)
[513.536271] [117/133] (510s left) kms_plane (pixel-format-linear-modifier-source-clamping)
[513.620286] Starting subtest: pixel-format-linear-modifier-source-clamping
[513.646592] Starting dynamic subtest: pipe-A-plane-0
[514.235064] Dynamic subtest pipe-A-plane-0: SUCCESS (0.588s)
[514.244759] Starting dynamic subtest: pipe-A-plane-3
[514.701799] Dynamic subtest pipe-A-plane-3: SUCCESS (0.466s)
[515.814988] Starting dynamic subtest: pipe-B-plane-0
[516.395554] Dynamic subtest pipe-B-plane-0: SUCCESS (0.589s)
[516.410659] Starting dynamic subtest: pipe-B-plane-3
[516.828141] Dynamic subtest pipe-B-plane-3: SUCCESS (0.432s)
[517.149160] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (3.530s)
[517.999089] [118/133] (506s left) gem_lmem_swapping (heavy-verify-multi)
[518.034682] Subtest heavy-verify-multi: SKIP (0.000s)
[518.080908] [119/133] (506s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[518.170444] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[522.844498] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.673s)
[524.010118] [120/133] (500s left) kms_big_fb (4-tiled-addfb-size-overflow)
[524.102097] Starting subtest: 4-tiled-addfb-size-overflow
[524.103014] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[524.236811] [121/133] (500s left) gem_vm_create (invalid-create)
[524.296994] Starting subtest: invalid-create
[524.299515] Subtest invalid-create: SUCCESS (0.003s)
[524.405287] [122/133] (500s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[524.505586] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[524.506509] Starting dynamic subtest: pipe-A-eDP-1
[524.516087] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[524.526443] Starting dynamic subtest: pipe-B-eDP-1
[524.535931] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[524.545443] Starting dynamic subtest: pipe-C-eDP-1
[524.554496] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[524.563401] Starting dynamic subtest: pipe-D-eDP-1
[524.572556] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[524.574317] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[526.670806] [123/133] (497s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[526.765371] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[533.969052] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.204s)
[534.090782] [124/133] (490s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[534.185479] Starting subtest: fbc-psr2-cursor-mmap-cpu
[534.186374] Starting dynamic subtest: eDP-1
[534.188303] Dynamic subtest eDP-1: SKIP (0.000s)
[534.189865] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s)
[534.256446] [125/133] (490s left) syncobj_basic (bad-create-flags)
[534.299367] Starting subtest: bad-create-flags
[534.300379] Subtest bad-create-flags: SUCCESS (0.000s)
[534.390831] [126/133] (490s left) perf (enable-disable)
[534.528342] Starting subtest: enable-disable
[534.529249] Starting dynamic subtest: 0-rcs0
[536.794590] Dynamic subtest 0-rcs0: SUCCESS (2.266s)
[536.803948] Starting dynamic subtest: 1-vecs0
[541.322426] Dynamic subtest 1-vecs0: SUCCESS (4.481s)
[541.323469] Subtest enable-disable: SUCCESS (6.749s)
[541.358978] [127/133] (483s left) gem_ctx_shared (q-smoketest)
[541.435992] Starting subtest: Q-smoketest
[541.437078] Starting dynamic subtest: rcs0
[546.982114] Dynamic subtest rcs0: SUCCESS (5.525s)
[546.994328] Starting dynamic subtest: bcs0
[552.514425] Dynamic subtest bcs0: SUCCESS (5.487s)
[552.527035] Starting dynamic subtest: vcs0
[557.999034] Dynamic subtest vcs0: SUCCESS (5.482s)
[558.012335] Starting dynamic subtest: vcs1
[563.466918] Dynamic subtest vcs1: SUCCESS (5.471s)
[563.479247] Starting dynamic subtest: vecs0
[568.954261] Dynamic subtest vecs0: SUCCESS (5.477s)
[568.967857] Starting dynamic subtest: ccs0
[574.431730] Dynamic subtest ccs0: SUCCESS (5.512s)
[574.432640] Subtest Q-smoketest: SUCCESS (32.960s)
[574.582518] [128/133] (450s left) gem_exec_flush (basic-wb-rw-before-default)
[574.641117] Starting subtest: basic-wb-rw-before-default
[580.115972] Subtest basic-wb-rw-before-default: SUCCESS (5.474s)
[580.313041] [129/133] (444s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[580.409860] Starting subtest: psr-rgb565-draw-mmap-wc
[587.299062] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.889s)
[587.406799] [130/133] (437s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[587.497390] Starting subtest: crc-primary-basic-yf-tiled-ccs
[587.498298] Starting dynamic subtest: pipe-A-eDP-1
[587.507409] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[587.518707] Starting dynamic subtest: pipe-B-eDP-1
[587.527464] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[587.537193] Starting dynamic subtest: pipe-C-eDP-1
[587.545836] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[587.555226] Starting dynamic subtest: pipe-D-eDP-1
[587.563276] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[587.564845] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.006s)
[589.771676] [131/133] (435s left) kms_cursor_legacy (forked-move)
[589.887926] Starting subtest: forked-move
[589.888966] Starting dynamic subtest: pipe-A
[595.401381] Dynamic subtest pipe-A: SUCCESS (5.465s)
[595.415383] Starting dynamic subtest: pipe-B
[600.884274] Dynamic subtest pipe-B: SUCCESS (5.480s)
[600.902434] Starting dynamic subtest: pipe-C
[606.369486] Dynamic subtest pipe-C: SUCCESS (5.482s)
[606.382240] Starting dynamic subtest: pipe-D
[611.862897] Dynamic subtest pipe-D: SUCCESS (5.491s)
[611.876404] Starting dynamic subtest: all-pipes
[617.334267] Dynamic subtest all-pipes: SUCCESS (5.506s)
[617.335344] Subtest forked-move: SUCCESS (27.435s)
[617.484330] [132/133] (407s left) prime_vgem (fence-wait)
[617.552639] Starting subtest: fence-wait
[617.553689] Starting dynamic subtest: rcs0
[618.616371] Dynamic subtest rcs0: SUCCESS (1.055s)
[618.626844] Starting dynamic subtest: bcs0
[619.702719] Dynamic subtest bcs0: SUCCESS (1.085s)
[619.714593] Starting dynamic subtest: vcs0
[620.748274] Dynamic subtest vcs0: SUCCESS (1.044s)
[620.757497] Starting dynamic subtest: vcs1
[621.787932] Dynamic subtest vcs1: SUCCESS (1.038s)
[621.797444] Starting dynamic subtest: vecs0
[622.831254] Dynamic subtest vecs0: SUCCESS (1.041s)
[622.841463] Starting dynamic subtest: ccs0
[623.872005] Dynamic subtest ccs0: SUCCESS (1.039s)
[623.872986] Subtest fence-wait: SUCCESS (6.311s)
[623.976638] [133/133] (400s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[624.073480] Starting subtest: 2x-absolute-wf_vblank-interruptible
[624.085694] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.012s)
[624.171024] Closing watchdogs
results: parsing output: 0/ for test: kms_plane
results: parsing output: 1/ for test: gem_mmap_gtt
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_chamelium_hpd
results: parsing output: 4/ for test: kms_atomic_transition
results: parsing output: 5/ for test: gem_mmap_wc
results: parsing output: 6/ for test: kms_dsc
results: parsing output: 7/ for test: kms_addfb_basic
results: parsing output: 8/ for test: gem_pxp
results: parsing output: 9/ for test: kms_ccs
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_psr2_sf
results: parsing output: 13/ for test: kms_cursor_edge_walk
results: parsing output: 14/ for test: vgem_basic
results: parsing output: 15/ for test: kms_plane_scaling
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: gem_ctx_exec
results: parsing output: 18/ for test: gem_exec_schedule
results: parsing output: 19/ for test: device_reset
results: parsing output: 20/ for test: syncobj_timeline
results: parsing output: 21/ for test: gem_mmap_gtt
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: perf_pmu
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: kms_cursor_legacy
results: parsing output: 26/ for test: gem_tiled_swapping
results: parsing output: 27/ for test: kms_plane_multiple
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: kms_psr
results: parsing output: 30/ for test: gem_ctx_param
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_exec_whisper
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: gem_mmap_offset
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: perf_pmu
results: parsing output: 38/ for test: api_intel_allocator
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: kms_cursor_crc
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: i915_pm_rpm
results: parsing output: 43/ for test: gem_reg_read
results: parsing output: 44/ for test: gem_mmap_gtt
results: parsing output: 45/ for test: i915_hangman
results: parsing output: 46/ for test: fbdev
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: prime_self_import
results: parsing output: 49/ for test: kms_flip
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: i915_query
results: parsing output: 52/ for test: kms_pm_dc
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: kms_atomic_interruptible
results: parsing output: 55/ for test: gem_basic
results: parsing output: 56/ for test: sysfs_timeslice_duration
results: parsing output: 57/ for test: kms_cursor_crc
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_pxp
results: parsing output: 60/ for test: kms_psr2_sf
results: parsing output: 61/ for test: gem_exec_schedule
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_color_pipeline
results: parsing output: 64/ for test: gem_exec_balancer
results: parsing output: 65/ for test: kms_content_protection
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_cursor_legacy
results: parsing output: 68/ for test: kms_lease
results: parsing output: 69/ for test: kms_cursor_legacy
results: parsing output: 70/ for test: gem_render_copy
results: parsing output: 71/ for test: kms_flip_scaled_crc
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: kms_chamelium_color
results: parsing output: 74/ for test: kms_invalid_mode
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_create
results: parsing output: 77/ for test: gem_unref_active_buffers
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: gem_exec_reloc
results: parsing output: 81/ for test: kms_pm_rpm
results: parsing output: 82/ for test: kms_pipe_crc_basic
results: parsing output: 83/ for test: prime_udl
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: gem_exec_fence
results: parsing output: 87/ for test: gem_softpin
results: parsing output: 88/ for test: gem_ctx_persistence
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_chamelium_frames
results: parsing output: 91/ for test: kms_async_flips
results: parsing output: 92/ for test: kms_psr2_sf
results: parsing output: 93/ for test: gem_exec_params
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: api_intel_bb
results: parsing output: 97/ for test: syncobj_wait
results: parsing output: 98/ for test: i915_query
results: parsing output: 99/ for test: perf_pmu
results: parsing output: 100/ for test: syncobj_basic
results: parsing output: 101/ for test: gem_exec_schedule
results: parsing output: 102/ for test: i915_drm_fdinfo
results: parsing output: 103/ for test: gem_mmap_wc
results: parsing output: 104/ for test: kms_selftest
results: parsing output: 105/ for test: prime_mmap
results: parsing output: 106/ for test: gen9_exec_parse
results: parsing output: 107/ for test: kms_atomic
results: parsing output: 108/ for test: gem_exec_nop
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: gem_fenced_exec_thrash
results: parsing output: 111/ for test: perf_pmu
results: parsing output: 112/ for test: kms_vblank
results: parsing output: 113/ for test: gem_exec_balancer
results: parsing output: 114/ for test: kms_hdr
results: parsing output: 115/ for test: kms_flip
results: parsing output: 116/ for test: kms_plane
results: parsing output: 117/ for test: gem_lmem_swapping
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: gem_vm_create
results: parsing output: 121/ for test: kms_ccs
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: syncobj_basic
results: parsing output: 125/ for test: perf
results: parsing output: 126/ for test: gem_ctx_shared
results: parsing output: 127/ for test: gem_exec_flush
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_ccs
results: parsing output: 130/ for test: kms_cursor_legacy
results: parsing output: 131/ for test: prime_vgem
results: parsing output: 132/ for test: kms_flip
Done.