[56.162529] Initializing watchdogs
[56.162606]   /dev/watchdog0
[56.177712] [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]
[56.181989] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.184358] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.187759] [001/133] (960s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[56.313996] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[56.318511] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[56.381811] [002/133] (960s left) gem_mmap_gtt (fault-concurrent-y)
[56.438661] Subtest fault-concurrent-Y: SKIP (0.000s)
[56.501838] [003/133] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[56.596052] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[56.600380] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[56.694404] [004/133] (960s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[57.069623] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[57.891866] [005/133] (958s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[57.986447] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[57.988837] Starting dynamic subtest: pipe-A-eDP-1
[59.285052] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.299s)
[59.564194] Starting dynamic subtest: pipe-B-eDP-1
[60.607474] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.050s)
[60.880715] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.896s)
[61.717831] [006/133] (955s left) gem_mmap_wc (read)
[61.779771] Subtest read: SKIP (0.000s)
[61.839162] [007/133] (955s left) kms_dsc (dsc-basic)
[61.944731] Starting subtest: dsc-basic
[61.957429] Subtest dsc-basic: SKIP (0.000s)
[62.026631] [008/133] (954s left) kms_addfb_basic (unused-offsets)
[62.080170] Starting subtest: unused-offsets
[62.082653] Subtest unused-offsets: SUCCESS (0.000s)
[62.214320] [009/133] (954s left) gem_pxp (create-valid-protected-context)
[62.345526] Starting subtest: create-valid-protected-context
[62.348368] Subtest create-valid-protected-context: SUCCESS (0.003s)
[62.468751] [010/133] (954s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[62.567316] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[62.569338] Starting dynamic subtest: pipe-A-eDP-1
[63.462391] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.891s)
[63.470578] Starting dynamic subtest: pipe-B-eDP-1
[65.101699] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.637s)
[65.110095] Starting dynamic subtest: pipe-C-eDP-1
[66.638092] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.535s)
[66.647179] Starting dynamic subtest: pipe-D-eDP-1
[68.156411] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.517s)
[68.158266] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.582s)
[69.343616] [011/133] (947s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[69.452739] Starting subtest: fbcpsr-stridechange
[75.633100] Subtest fbcpsr-stridechange: SUCCESS (6.184s)
[75.777834] [012/133] (941s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[75.870567] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[75.875107] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[75.960354] [013/133] (941s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[76.056177] Starting subtest: psr2-plane-move-sf-dmg-area
[76.058913] Starting dynamic subtest: pipe-A-eDP-1
[80.618031] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.565s)
[80.626437] Starting dynamic subtest: pipe-B-eDP-1
[85.944148] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.326s)
[85.946651] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.895s)
[86.817233] [014/133] (930s left) kms_cursor_edge_walk (64x64-top-edge)
[86.913340] Starting subtest: 64x64-top-edge
[86.915711] Starting dynamic subtest: pipe-A-eDP-1
[90.378092] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.462s)
[90.387107] Starting dynamic subtest: pipe-D-eDP-1
[93.492844] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.114s)
[93.494998] Subtest 64x64-top-edge: SUCCESS (6.578s)
[94.301377] [015/133] (922s left) vgem_basic (dmabuf-mmap)
[94.382887] Starting subtest: dmabuf-mmap
[94.389088] Subtest dmabuf-mmap: SUCCESS (0.009s)
[94.446183] [FACT vgem_basic (dmabuf-mmap)] new: kernel.kmod_is_loaded.vgem: true
[94.450297] [016/133] (922s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[94.543122] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[94.545426] Starting dynamic subtest: pipe-A
[94.605814] Dynamic subtest pipe-A: SUCCESS (0.065s)
[94.615900] Starting dynamic subtest: pipe-B
[95.725906] Dynamic subtest pipe-B: SUCCESS (1.119s)
[95.735998] Starting dynamic subtest: pipe-C
[96.833378] Dynamic subtest pipe-C: SUCCESS (1.107s)
[96.841330] Starting dynamic subtest: pipe-D
[97.975705] Dynamic subtest pipe-D: SUCCESS (1.141s)
[97.978319] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.435s)
[99.114969] [017/133] (918s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[99.203325] Starting subtest: bad-rotation-90-yf-tiled-ccs
[99.205732] Starting dynamic subtest: pipe-A-eDP-1
[99.229809] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[99.238908] Starting dynamic subtest: pipe-B-eDP-1
[99.261528] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[99.269167] Starting dynamic subtest: pipe-C-eDP-1
[99.291687] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[99.299135] Starting dynamic subtest: pipe-D-eDP-1
[99.321298] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[99.325754] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.003s)
[101.473128] [018/133] (915s left) gem_ctx_exec (basic)
[101.528904] Starting subtest: basic
[101.533479] Subtest basic: SUCCESS (0.005s)
[101.664094] [019/133] (915s left) gem_exec_schedule (pi-shared-iova)
[101.840554] Starting subtest: pi-shared-iova
[101.842642] Starting dynamic subtest: rcs0
[101.922109] Dynamic subtest rcs0: SUCCESS (0.084s)
[101.930745] Starting dynamic subtest: vcs0
[101.981072] Dynamic subtest vcs0: SUCCESS (0.057s)
[101.995757] Starting dynamic subtest: vcs1
[102.033276] Dynamic subtest vcs1: SUCCESS (0.052s)
[102.043876] Starting dynamic subtest: vecs0
[102.091465] Dynamic subtest vecs0: SUCCESS (0.057s)
[102.101146] Starting dynamic subtest: ccs0
[102.152173] Dynamic subtest ccs0: SUCCESS (0.060s)
[102.155147] Subtest pi-shared-iova: SUCCESS (0.314s)
[103.399853] [020/133] (914s left) device_reset (unbind-reset-rebind)
[103.447840] Starting subtest: unbind-reset-rebind
[108.397024] Subtest unbind-reset-rebind: SUCCESS (4.943s)
[108.439427] [021/133] (909s left) syncobj_timeline (wait-all-snapshot)
[108.505494] Starting subtest: wait-all-snapshot
[108.586334] Subtest wait-all-snapshot: SUCCESS (0.082s)
[108.678405] [022/133] (908s left) gem_mmap_gtt (medium-copy-xy)
[108.737107] Subtest medium-copy-XY: SKIP (0.000s)
[108.807349] [023/133] (908s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[108.859042] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[108.861321] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[108.960106] [024/133] (908s left) perf_pmu (busy-check-all)
[108.999893] Starting subtest: busy-check-all
[109.002077] Starting dynamic subtest: rcs0
[109.563713] Dynamic subtest rcs0: SUCCESS (0.564s)
[109.575492] Starting dynamic subtest: bcs0
[110.118278] Dynamic subtest bcs0: SUCCESS (0.553s)
[110.131144] Starting dynamic subtest: vcs0
[111.303297] Dynamic subtest vcs0: SUCCESS (1.182s)
[111.315643] Starting dynamic subtest: vcs1
[113.284248] Dynamic subtest vcs1: SUCCESS (1.979s)
[113.296630] Starting dynamic subtest: vecs0
[115.269558] Dynamic subtest vecs0: SUCCESS (1.982s)
[115.282080] Starting dynamic subtest: ccs0
[115.823215] Dynamic subtest ccs0: SUCCESS (0.554s)
[115.825733] Subtest busy-check-all: SUCCESS (6.824s)
[115.909331] [025/133] (901s left) syncobj_timeline (invalid-query-illegal-handle)
[115.953098] Starting subtest: invalid-query-illegal-handle
[115.954965] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[116.044736] [026/133] (901s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[116.160492] Starting subtest: cursorA-vs-flipA-atomic-transitions
[127.360451] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.199s)
[128.169900] [027/133] (889s left) gem_tiled_swapping (non-threaded)
[128.231110] Subtest non-threaded: SKIP (0.000s)
[128.294149] [028/133] (889s left) kms_plane_multiple (tiling-x)
[128.401624] Starting subtest: tiling-x
[128.403959] Starting dynamic subtest: pipe-A-eDP-1
[132.113077] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.711s)
[132.122202] Starting dynamic subtest: pipe-B-eDP-1
[136.618875] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.505s)
[136.628288] Starting dynamic subtest: pipe-C-eDP-1
[140.938068] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.320s)
[140.950988] Starting dynamic subtest: pipe-D-eDP-1
[145.260456] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.319s)
[145.262665] Subtest tiling-x: SUCCESS (16.860s)
[146.078311] [029/133] (871s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[146.179610] Starting subtest: yf-tiled-16bpp-rotate-270
[146.183749] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[146.289993] [030/133] (871s left) kms_psr (pr-cursor-mmap-cpu)
[146.386035] Starting subtest: pr-cursor-mmap-cpu
[146.390423] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[146.470427] [031/133] (871s left) gem_ctx_param (invalid-get-ringsize)
[146.526256] Starting subtest: invalid-get-ringsize
[146.528646] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[146.624635] [032/133] (871s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[146.723095] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[153.333021] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.613s)
[153.485299] [033/133] (864s left) gem_exec_whisper (basic-fds-all)
[153.542833] Starting subtest: basic-fds-all
[165.283762] Subtest basic-fds-all: SUCCESS (11.738s)
[165.472231] [034/133] (852s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[165.575673] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[165.579709] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[165.670311] [035/133] (852s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[165.723019] Starting subtest: invalid-multi-wait-unsubmitted
[165.725285] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[165.813957] [036/133] (852s left) gem_mmap_offset (close-race)
[165.865152] Starting subtest: close-race
[185.972623] Subtest close-race: SUCCESS (20.106s)
[186.114925] [037/133] (832s left) kms_psr (psr-cursor-render)
[186.207952] Starting subtest: psr-cursor-render
[186.210147] Starting dynamic subtest: eDP-1
[187.882557] Dynamic subtest eDP-1: SUCCESS (1.673s)
[187.884964] Subtest psr-cursor-render: SUCCESS (1.674s)
[188.743848] [038/133] (829s left) perf_pmu (interrupts)
[188.784441] Starting subtest: interrupts
[189.866119] Subtest interrupts: SUCCESS (1.081s)
[189.973417] [039/133] (828s left) api_intel_allocator (alloc-simple)
[190.022071] Starting subtest: alloc-simple
[190.024576] Subtest alloc-simple: SUCCESS (0.002s)
[190.150614] [040/133] (828s left) kms_psr (psr-primary-blt)
[190.234144] Starting subtest: psr-primary-blt
[190.236393] Starting dynamic subtest: eDP-1
[191.937088] Dynamic subtest eDP-1: SUCCESS (1.703s)
[191.939539] Subtest psr-primary-blt: SUCCESS (1.704s)
[192.803150] [041/133] (825s left) kms_cursor_crc (cursor-random-512x170)
[193.077262] Starting subtest: cursor-random-512x170
[193.081717] Subtest cursor-random-512x170: SKIP (0.001s)
[193.232489] [042/133] (825s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[193.293563] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[193.399563] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.105s)
[193.480431] [043/133] (824s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[195.410022] Starting subtest: gem-execbuf-stress-pc8
[195.449063] Subtest gem-execbuf-stress-pc8: SKIP (0.041s)
[195.800212] [044/133] (822s left) gem_reg_read (bad-register)
[195.849076] Starting subtest: bad-register
[195.850954] Subtest bad-register: SUCCESS (0.000s)
[195.955014] [045/133] (822s left) gem_mmap_gtt (basic-small-copy-odd)
[196.005884] Subtest basic-small-copy-odd: SKIP (0.000s)
[196.063558] [046/133] (822s left) i915_hangman (gt-engine-hang)
[196.116578] Starting subtest: gt-engine-hang
[196.118646] Starting dynamic subtest: rcs0
[197.285771] Dynamic subtest rcs0: SUCCESS (1.167s)
[197.297155] Starting dynamic subtest: bcs0
[199.265418] Dynamic subtest bcs0: SUCCESS (1.977s)
[199.278689] Starting dynamic subtest: vcs0
[201.250595] Dynamic subtest vcs0: SUCCESS (1.982s)
[201.262522] Starting dynamic subtest: vcs1
[203.234102] Dynamic subtest vcs1: SUCCESS (1.980s)
[203.247396] Starting dynamic subtest: vecs0
[205.282516] Dynamic subtest vecs0: SUCCESS (2.045s)
[205.296363] Starting dynamic subtest: ccs0
[207.266728] Dynamic subtest ccs0: SUCCESS (1.980s)
[207.269771] Subtest gt-engine-hang: SUCCESS (11.150s)
[207.350130] [047/133] (811s left) fbdev (pan)
[207.385224] Starting subtest: pan
[207.410370] Subtest pan: SUCCESS (0.029s)
[207.482980] [048/133] (811s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[207.586474] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[208.686626] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: FAIL (0.510s)
[208.729590] [049/133] (809s left) prime_self_import (basic-with_one_bo)
[208.765811] Starting subtest: basic-with_one_bo
[208.785684] Subtest basic-with_one_bo: SUCCESS (0.022s)
[208.915041] [050/133] (809s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[208.999057] Starting subtest: 2x-flip-vs-modeset-vs-hang
[209.003429] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.002s)
[209.114688] [051/133] (809s left) kms_flip (2x-flip-vs-suspend)
[209.207593] Starting subtest: 2x-flip-vs-suspend
[209.211457] Subtest 2x-flip-vs-suspend: SKIP (0.002s)
[209.310439] [052/133] (809s left) i915_query (query-garbage)
[209.359471] Starting subtest: query-garbage
[209.361292] Subtest query-garbage: SUCCESS (0.000s)
[209.457795] [053/133] (809s left) kms_pm_dc (dc5-retention-flops)
[210.564155] Starting subtest: dc5-retention-flops
[210.568723] Subtest dc5-retention-flops: SKIP (0.000s)
[210.649445] [054/133] (808s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[210.742255] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[210.746499] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[210.834264] [055/133] (808s left) kms_atomic_interruptible (legacy-dpms)
[210.924354] Starting subtest: legacy-dpms
[210.926550] Starting dynamic subtest: pipe-A-eDP-1
[218.308377] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.383s)
[218.310673] Subtest legacy-dpms: SUCCESS (7.384s)
[219.165893] [056/133] (799s left) gem_basic (create-close)
[219.221298] Starting subtest: create-close
[219.225354] Subtest create-close: SUCCESS (0.000s)
[219.307745] [057/133] (799s left) sysfs_timeslice_duration (idempotent)
[219.365049] Starting subtest: idempotent
[219.367312] Starting dynamic subtest: vecs0
[219.369663] Dynamic subtest vecs0: SUCCESS (0.000s)
[219.381218] Starting dynamic subtest: ccs0
[219.383456] Dynamic subtest ccs0: SUCCESS (0.001s)
[219.393214] Starting dynamic subtest: vcs0
[219.395402] Dynamic subtest vcs0: SUCCESS (0.000s)
[219.404767] Starting dynamic subtest: bcs0
[219.406783] Dynamic subtest bcs0: SUCCESS (0.000s)
[219.418587] Starting dynamic subtest: rcs0
[219.420508] Dynamic subtest rcs0: SUCCESS (0.000s)
[219.430079] Starting dynamic subtest: vcs1
[219.431953] Dynamic subtest vcs1: SUCCESS (0.000s)
[219.433893] Subtest idempotent: SUCCESS (0.006s)
[219.472164] [058/133] (799s left) kms_cursor_crc (cursor-offscreen-128x128)
[219.686046] Starting subtest: cursor-offscreen-128x128
[219.688337] Starting dynamic subtest: pipe-A-eDP-1
[221.620141] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.930s)
[221.650832] Starting dynamic subtest: pipe-D-eDP-1
[224.245565] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.601s)
[224.247588] Subtest cursor-offscreen-128x128: SUCCESS (4.558s)
[225.118121] [059/133] (793s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[225.214686] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[225.219305] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[225.311078] [060/133] (793s left) gem_pxp (regular-baseline-src-copy-readible)
[225.426394] Starting subtest: regular-baseline-src-copy-readible
[225.482199] Subtest regular-baseline-src-copy-readible: SUCCESS (0.059s)
[225.590927] [061/133] (793s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[225.698700] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[225.703340] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[225.765265] [062/133] (793s left) gem_exec_schedule (fairslice)
[225.839703] Starting subtest: fairslice
[225.841852] Starting dynamic subtest: rcs0
[227.860315] Dynamic subtest rcs0: SUCCESS (2.021s)
[227.870784] Starting dynamic subtest: bcs0
[229.885965] Dynamic subtest bcs0: SUCCESS (2.024s)
[229.898489] Starting dynamic subtest: vcs0
[231.908167] Dynamic subtest vcs0: SUCCESS (2.021s)
[231.918787] Starting dynamic subtest: vcs1
[233.929020] Dynamic subtest vcs1: SUCCESS (2.020s)
[233.938392] Starting dynamic subtest: vecs0
[235.951052] Dynamic subtest vecs0: SUCCESS (2.020s)
[235.963047] Starting dynamic subtest: ccs0
[237.970859] Dynamic subtest ccs0: SUCCESS (2.021s)
[237.972862] Subtest fairslice: SUCCESS (12.134s)
[238.269711] [063/133] (780s left) kms_frontbuffer_tracking (psr-2p-rte)
[238.383619] Starting subtest: psr-2p-rte
[238.387669] Subtest psr-2p-rte: SKIP (0.000s)
[238.465895] [064/133] (780s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[238.562523] Starting subtest: plane-lut1d-pre-ctm3x4
[238.708532] Starting dynamic subtest: pipe-A-plane-0
[238.907803] Dynamic subtest pipe-A-plane-0: SUCCESS (0.200s)
[238.918946] Starting dynamic subtest: pipe-A-plane-1
[239.074615] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[239.084699] Starting dynamic subtest: pipe-A-plane-2
[239.230174] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s)
[240.419551] Starting dynamic subtest: pipe-B-plane-0
[240.574473] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[240.587394] Starting dynamic subtest: pipe-B-plane-1
[240.752337] Dynamic subtest pipe-B-plane-1: SUCCESS (0.177s)
[240.763269] Starting dynamic subtest: pipe-B-plane-2
[240.907993] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s)
[242.135509] Starting dynamic subtest: pipe-C-plane-0
[242.259666] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[242.272601] Starting dynamic subtest: pipe-C-plane-1
[242.392960] Dynamic subtest pipe-C-plane-1: SUCCESS (0.132s)
[242.403477] Starting dynamic subtest: pipe-C-plane-2
[242.560013] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[243.764994] Starting dynamic subtest: pipe-D-plane-0
[243.890055] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[243.900224] Starting dynamic subtest: pipe-D-plane-1
[244.045574] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[244.055975] Starting dynamic subtest: pipe-D-plane-2
[244.212397] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[244.508578] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (5.948s)
[245.336607] [065/133] (773s left) gem_exec_balancer (semaphore)
[245.395361] Starting subtest: semaphore
[247.277966] Subtest semaphore: SUCCESS (1.881s)
[247.607546] [066/133] (771s left) kms_content_protection (dp-mst-type-0)
[247.750767] Starting subtest: dp-mst-type-0
[247.755378] Subtest dp-mst-type-0: SKIP (0.000s)
[247.882250] [067/133] (771s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[247.981251] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[247.985473] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[248.083481] [068/133] (771s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[248.198578] Starting subtest: 2x-flip-vs-cursor-atomic
[248.203114] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[248.346807] [069/133] (771s left) kms_lease (lease-invalid-crtc)
[248.432075] Starting subtest: lease-invalid-crtc
[248.434294] Starting dynamic subtest: pipe-A-eDP-1
[248.436484] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[248.446746] Starting dynamic subtest: pipe-B-eDP-1
[248.449044] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[248.458843] Starting dynamic subtest: pipe-C-eDP-1
[248.460679] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[248.469894] Starting dynamic subtest: pipe-D-eDP-1
[248.471707] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[248.473598] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[248.517520] [070/133] (770s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[248.628230] Starting subtest: cursor-vs-flip-atomic-transitions
[278.906896] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.276s)
[279.765308] [071/133] (739s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[279.845120] Starting subtest: yf-tiled-to-vebox-y-tiled
[279.849516] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[280.026905] [072/133] (739s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[280.108533] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[280.110889] Starting dynamic subtest: pipe-A-default-mode
[281.229867] Dynamic subtest pipe-A-default-mode: SKIP (1.118s)
[281.234605] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.119s)
[281.360901] [073/133] (738s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[281.422298] Starting subtest: etime-single-wait-available-unsubmitted
[281.528158] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.105s)
[281.606948] [074/133] (738s left) kms_chamelium_color (ctm-0-50)
[281.701368] Subtest ctm-0-50: SKIP (0.000s)
[281.745989] [075/133] (737s left) kms_invalid_mode (overflow-vrefresh)
[281.834365] Starting subtest: overflow-vrefresh
[281.836741] Starting dynamic subtest: pipe-A-eDP-1
[282.131024] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.297s)
[282.142016] Starting dynamic subtest: pipe-B-eDP-1
[282.144118] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[282.154158] Starting dynamic subtest: pipe-C-eDP-1
[282.156076] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[282.165687] Starting dynamic subtest: pipe-D-eDP-1
[282.167616] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[282.169542] Subtest overflow-vrefresh: SUCCESS (0.303s)
[282.937872] [076/133] (736s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[283.039041] Starting subtest: psr-1p-primscrn-spr-indfb-move
[290.455451] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.421s)
[290.605675] [077/133] (729s left) gem_create (hog-create)
[290.665178] Starting subtest: hog-create
[290.667560] Starting dynamic subtest: smem0
[324.301545] Dynamic subtest smem0: SUCCESS (33.632s)
[324.304642] Subtest hog-create: SUCCESS (33.634s)
[324.493527] [078/133] (695s left) gem_unref_active_buffers
[324.707282] [079/133] (695s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[324.812190] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[324.816557] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[324.925404] [080/133] (695s left) kms_big_fb (y-tiled-addfb-size-overflow)
[325.040389] Starting subtest: y-tiled-addfb-size-overflow
[325.044687] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[325.143199] [081/133] (694s left) gem_exec_reloc (basic-write-cpu-active)
[325.206854] Subtest basic-write-cpu-active: SKIP (0.000s)
[325.280607] [082/133] (694s left) kms_pm_rpm (legacy-planes-dpms)
[327.522513] Starting subtest: legacy-planes-dpms
[327.525484] Starting dynamic subtest: plane-65
[335.811404] Dynamic subtest plane-65: SUCCESS (8.289s)
[335.825804] Starting dynamic subtest: plane-95
[344.107049] Dynamic subtest plane-95: SUCCESS (8.292s)
[344.129217] Starting dynamic subtest: plane-125
[352.420791] Dynamic subtest plane-125: SUCCESS (8.310s)
[352.440217] Starting dynamic subtest: plane-135
[361.069388] Dynamic subtest plane-135: SUCCESS (8.645s)
[361.072483] Subtest legacy-planes-dpms: SUCCESS (33.548s)
[361.459393] [083/133] (658s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[361.554772] Starting subtest: disable-crc-after-crtc
[361.557273] Starting dynamic subtest: pipe-A-eDP-1
[363.196067] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.644s)
[363.208050] Starting dynamic subtest: pipe-B-eDP-1
[365.566083] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.368s)
[365.577285] Starting dynamic subtest: pipe-C-eDP-1
[367.817216] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.247s)
[367.828272] Starting dynamic subtest: pipe-D-eDP-1
[370.087644] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.270s)
[370.090039] Subtest disable-crc-after-crtc: SUCCESS (8.537s)
[370.910201] [084/133] (649s left) prime_udl
[370.985497] [085/133] (649s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[371.073896] Starting subtest: fbcpsr-modesetfrombusy
[377.180075] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.111s)
[377.307039] [086/133] (642s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[377.414191] Starting subtest: x-tiled-8bpp-rotate-270
[377.434487] Subtest x-tiled-8bpp-rotate-270: SKIP (0.020s)
[377.540540] [087/133] (642s left) gem_exec_fence (syncobj-repeat)
[377.987269] Starting subtest: syncobj-repeat
[378.173070] Subtest syncobj-repeat: SUCCESS (0.184s)
[379.388363] [088/133] (640s left) gem_softpin (zero)
[379.449378] Starting subtest: zero
[379.456483] Subtest zero: SUCCESS (0.005s)
[379.561853] [089/133] (640s left) gem_ctx_persistence (heartbeat-hostile)
[379.634068] Starting subtest: heartbeat-hostile
[379.638601] Subtest heartbeat-hostile: SKIP (0.000s)
[379.733703] [090/133] (640s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[379.825880] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[379.830066] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[379.917044] [091/133] (640s left) kms_chamelium_frames (hdmi-crc-multiple)
[380.316322] Subtest hdmi-crc-multiple: SKIP (0.000s)
[381.170917] [092/133] (639s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[381.265052] Starting subtest: async-flip-with-page-flip-events-linear
[381.634381] Starting dynamic subtest: pipe-A-eDP-1
[384.364205] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.729s)
[384.730901] Starting dynamic subtest: pipe-B-eDP-1
[387.492784] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.770s)
[387.871865] Starting dynamic subtest: pipe-C-eDP-1
[390.623926] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.758s)
[390.991717] Starting dynamic subtest: pipe-D-eDP-1
[393.754914] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.772s)
[393.757956] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.491s)
[394.941913] [093/133] (625s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[395.038689] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[395.042995] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[395.108102] [094/133] (625s left) gem_exec_params (secure-non-master)
[395.169034] Starting subtest: secure-non-master
[395.173115] Subtest secure-non-master: SKIP (0.000s)
[395.273667] [095/133] (625s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[395.382064] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[395.386286] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[395.489640] [096/133] (625s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[395.595318] Starting subtest: fbc-rgb101010-draw-render
[400.165896] Subtest fbc-rgb101010-draw-render: SUCCESS (4.574s)
[401.353435] [097/133] (619s left) api_intel_bb (reset-flags)
[401.408977] Starting subtest: reset-flags
[401.414495] Subtest reset-flags: SUCCESS (0.006s)
[401.549092] [098/133] (619s left) syncobj_wait (single-wait-submitted)
[401.593430] Starting subtest: single-wait-submitted
[401.695440] Subtest single-wait-submitted: SUCCESS (0.102s)
[401.772460] [099/133] (618s left) i915_query (engine-info)
[401.830393] Starting subtest: engine-info
[401.835471] Subtest engine-info: SUCCESS (0.005s)
[401.958623] [100/133] (618s left) perf_pmu (all-busy-check-all)
[401.998199] Starting subtest: all-busy-check-all
[403.268777] Subtest all-busy-check-all: SUCCESS (1.271s)
[403.381906] [101/133] (617s left) syncobj_basic (bad-flags-fd-to-handle)
[403.443171] Starting subtest: bad-flags-fd-to-handle
[403.445214] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[403.569488] [102/133] (617s left) gem_exec_schedule (u-submit-golden-slice)
[403.644098] Starting subtest: u-submit-golden-slice
[403.646073] Starting dynamic subtest: rcs0
[403.677208] Dynamic subtest rcs0: SUCCESS (0.040s)
[403.692422] Starting dynamic subtest: bcs0
[403.704820] Dynamic subtest bcs0: SUCCESS (0.027s)
[403.716609] Starting dynamic subtest: vcs0
[403.739972] Dynamic subtest vcs0: SUCCESS (0.034s)
[403.751378] Starting dynamic subtest: vcs1
[403.772192] Dynamic subtest vcs1: SUCCESS (0.031s)
[403.786841] Starting dynamic subtest: vecs0
[403.806418] Dynamic subtest vecs0: SUCCESS (0.033s)
[403.817579] Starting dynamic subtest: ccs0
[403.854780] Dynamic subtest ccs0: SUCCESS (0.047s)
[403.857317] Subtest u-submit-golden-slice: SUCCESS (0.219s)
[405.335308] [103/133] (615s left) i915_drm_fdinfo (memory-info-shared)
[405.378312] Starting subtest: memory-info-shared
[405.380535] Starting dynamic subtest: smem0
[405.410596] Dynamic subtest smem0: SUCCESS (0.031s)
[405.413033] Subtest memory-info-shared: SUCCESS (0.032s)
[405.498917] [104/133] (615s left) gem_mmap_wc (write-read-distinct)
[405.554643] Subtest write-read-distinct: SKIP (0.000s)
[405.622559] [105/133] (615s left) kms_selftest (drm_damage_helper)
[405.658480] Starting subtest: drm_damage_helper
[405.669152] Starting dynamic subtest: drm_test_damage_iter_no_damage
[405.772576] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.101s)
[405.788632] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[405.872014] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.099s)
[405.882754] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[405.972461] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.099s)
[405.982239] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[406.071072] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.099s)
[406.081584] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[406.179403] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.108s)
[406.189069] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[406.265116] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.084s)
[406.276119] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[406.365420] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.100s)
[406.377238] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[406.467393] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.101s)
[406.478593] Starting dynamic subtest: drm_test_damage_iter_single_damage
[406.572046] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.104s)
[406.581368] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[406.657918] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.084s)
[406.667189] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[406.767533] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.110s)
[406.776971] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[406.876124] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.107s)
[406.885278] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[406.966583] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.090s)
[406.975734] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[407.069284] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.102s)
[407.078317] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[407.166619] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.097s)
[407.177588] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[407.261075] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.092s)
[407.270863] Starting dynamic subtest: drm_test_damage_iter_damage
[407.363828] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.101s)
[407.373135] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[407.451097] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.089s)
[407.460474] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[407.541467] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.087s)
[407.552508] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[407.637796] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.097s)
[407.647254] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[407.735788] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.096s)
[407.737569] Subtest drm_damage_helper: SUCCESS (2.077s)
[407.891065] [106/133] (613s left) prime_mmap (test_correct_cpu_write)
[407.946698] Starting subtest: test_correct_cpu_write
[407.948849] Starting dynamic subtest: test_correct_cpu_write-smem
[407.950881] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[407.952858] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[408.050214] [107/133] (613s left) gen9_exec_parse (secure-batches)
[408.106477] Subtest secure-batches: SKIP (0.000s)
[408.174922] [108/133] (612s left) kms_atomic (plane-immutable-zpos)
[408.263279] Starting subtest: plane-immutable-zpos
[408.265187] Starting dynamic subtest: pipe-A-eDP-1
[408.893894] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.631s)
[408.896277] Subtest plane-immutable-zpos: SUCCESS (0.632s)
[409.770091] [109/133] (611s left) gem_exec_nop (basic-parallel)
[409.847985] Starting subtest: basic-parallel
[426.244928] Subtest basic-parallel: SUCCESS (16.406s)
[426.494719] [110/133] (594s left) kms_psr (fbc-psr-sprite-render)
[426.586923] Starting subtest: fbc-psr-sprite-render
[426.589125] Starting dynamic subtest: eDP-1
[426.593233] Dynamic subtest eDP-1: SKIP (0.000s)
[426.597162] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[426.660432] [111/133] (594s left) gem_fenced_exec_thrash (2-spare-fences)
[426.716644] Subtest 2-spare-fences: SKIP (0.000s)
[426.785822] [112/133] (594s left) perf_pmu (idle)
[426.828157] Starting subtest: idle
[426.830503] Starting dynamic subtest: rcs0
[427.370684] Dynamic subtest rcs0: SUCCESS (0.542s)
[427.385315] Starting dynamic subtest: bcs0
[427.892982] Dynamic subtest bcs0: SUCCESS (0.519s)
[427.905110] Starting dynamic subtest: vcs0
[428.415616] Dynamic subtest vcs0: SUCCESS (0.521s)
[428.427340] Starting dynamic subtest: vcs1
[428.934360] Dynamic subtest vcs1: SUCCESS (0.516s)
[428.947099] Starting dynamic subtest: vecs0
[429.452047] Dynamic subtest vecs0: SUCCESS (0.514s)
[429.465540] Starting dynamic subtest: ccs0
[429.968806] Dynamic subtest ccs0: SUCCESS (0.513s)
[429.971823] Subtest idle: SUCCESS (3.143s)
[430.080606] [113/133] (591s left) kms_vblank (wait-busy-hang)
[430.174853] Starting subtest: wait-busy-hang
[430.176746] Starting dynamic subtest: pipe-A-eDP-1
[457.030156] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.852s)
[457.048231] Starting dynamic subtest: pipe-D-eDP-1
[472.068372] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.038s)
[472.070704] Subtest wait-busy-hang: SUCCESS (41.894s)
[472.924224] [114/133] (548s left) gem_exec_balancer (noheartbeat)
[473.210081] Starting subtest: noheartbeat
[473.214830] Subtest noheartbeat: SKIP (0.000s)
[473.309112] [115/133] (548s left) kms_hdr (brightness-with-hdr)
[473.392858] Starting subtest: brightness-with-hdr
[473.399322] Subtest brightness-with-hdr: SKIP (0.000s)
[473.475534] [116/133] (547s left) kms_flip (blocking-wf_vblank)
[473.559307] Starting subtest: blocking-wf_vblank
[473.561695] Starting dynamic subtest: A-eDP1
[482.472243] Dynamic subtest A-eDP1: SUCCESS (8.914s)
[482.486607] Starting dynamic subtest: B-eDP1
[491.396787] Dynamic subtest B-eDP1: SUCCESS (8.922s)
[491.407832] Starting dynamic subtest: C-eDP1
[500.309911] Dynamic subtest C-eDP1: SUCCESS (8.910s)
[500.320699] Starting dynamic subtest: D-eDP1
[509.236642] Dynamic subtest D-eDP1: SUCCESS (8.926s)
[509.242614] Subtest blocking-wf_vblank: SUCCESS (35.685s)
[510.479704] [117/133] (511s left) kms_plane (pixel-format-linear-modifier-source-clamping)
[510.563821] Starting subtest: pixel-format-linear-modifier-source-clamping
[510.591602] Starting dynamic subtest: pipe-A-plane-0
[511.189685] Dynamic subtest pipe-A-plane-0: SUCCESS (0.600s)
[511.203073] Starting dynamic subtest: pipe-A-plane-3
[511.634637] Dynamic subtest pipe-A-plane-3: SUCCESS (0.444s)
[512.770047] Starting dynamic subtest: pipe-B-plane-0
[513.350660] Dynamic subtest pipe-B-plane-0: SUCCESS (0.589s)
[513.362061] Starting dynamic subtest: pipe-B-plane-3
[513.794647] Dynamic subtest pipe-B-plane-3: SUCCESS (0.442s)
[514.123272] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (3.558s)
[514.954500] [118/133] (506s left) gem_lmem_swapping (heavy-verify-multi)
[514.992858] Subtest heavy-verify-multi: SKIP (0.000s)
[515.037689] [119/133] (506s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[515.127318] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[519.593776] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.470s)
[520.752263] [120/133] (500s left) kms_big_fb (4-tiled-addfb-size-overflow)
[520.857986] Starting subtest: 4-tiled-addfb-size-overflow
[520.860385] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[520.957341] [121/133] (500s left) gem_vm_create (invalid-create)
[521.010661] Starting subtest: invalid-create
[521.015280] Subtest invalid-create: SUCCESS (0.002s)
[521.111154] [122/133] (500s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[521.202033] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[521.204307] Starting dynamic subtest: pipe-A-eDP-1
[521.229581] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[521.242695] Starting dynamic subtest: pipe-B-eDP-1
[521.266646] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[521.276405] Starting dynamic subtest: pipe-C-eDP-1
[521.300176] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[521.309979] Starting dynamic subtest: pipe-D-eDP-1
[521.334299] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[521.338755] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[523.511007] [123/133] (498s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[523.607057] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[530.688598] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.083s)
[530.814957] [124/133] (490s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[530.909902] Starting subtest: fbc-psr2-cursor-mmap-cpu
[530.912073] Starting dynamic subtest: eDP-1
[530.916066] Dynamic subtest eDP-1: SKIP (0.000s)
[530.919907] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s)
[530.985920] [125/133] (490s left) syncobj_basic (bad-create-flags)
[531.032986] Starting subtest: bad-create-flags
[531.034866] Subtest bad-create-flags: SUCCESS (0.000s)
[531.134144] [126/133] (490s left) perf (enable-disable)
[531.268530] Starting subtest: enable-disable
[531.270821] Starting dynamic subtest: 0-rcs0
[533.516085] Dynamic subtest 0-rcs0: SUCCESS (2.245s)
[533.527912] Starting dynamic subtest: 1-vecs0
[537.952761] Dynamic subtest 1-vecs0: SUCCESS (4.435s)
[537.955293] Subtest enable-disable: SUCCESS (6.683s)
[538.002414] [127/133] (483s left) gem_ctx_shared (q-smoketest)
[538.060287] Starting subtest: Q-smoketest
[538.062607] Starting dynamic subtest: rcs0
[543.616744] Dynamic subtest rcs0: SUCCESS (5.509s)
[543.629521] Starting dynamic subtest: bcs0
[549.103397] Dynamic subtest bcs0: SUCCESS (5.479s)
[549.118455] Starting dynamic subtest: vcs0
[554.571210] Dynamic subtest vcs0: SUCCESS (5.473s)
[554.583022] Starting dynamic subtest: vcs1
[560.045932] Dynamic subtest vcs1: SUCCESS (5.472s)
[560.058339] Starting dynamic subtest: vecs0
[565.523587] Dynamic subtest vecs0: SUCCESS (5.469s)
[565.534788] Starting dynamic subtest: ccs0
[571.006079] Dynamic subtest ccs0: SUCCESS (5.484s)
[571.008519] Subtest Q-smoketest: SUCCESS (32.893s)
[571.150734] [128/133] (450s left) gem_exec_flush (basic-wb-rw-before-default)
[571.211478] Starting subtest: basic-wb-rw-before-default
[576.674909] Subtest basic-wb-rw-before-default: SUCCESS (5.463s)
[576.910905] [129/133] (445s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[577.012236] Starting subtest: psr-rgb565-draw-mmap-wc
[583.931190] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.922s)
[584.048715] [130/133] (438s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[584.155182] Starting subtest: crc-primary-basic-yf-tiled-ccs
[584.157525] Starting dynamic subtest: pipe-A-eDP-1
[584.179551] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[584.192585] Starting dynamic subtest: pipe-B-eDP-1
[584.214260] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[584.223744] Starting dynamic subtest: pipe-C-eDP-1
[584.244597] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[584.254026] Starting dynamic subtest: pipe-D-eDP-1
[584.276580] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[584.281261] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.005s)
[586.422029] [131/133] (435s left) kms_cursor_legacy (forked-move)
[586.547338] Starting subtest: forked-move
[586.549196] Starting dynamic subtest: pipe-A
[592.006411] Dynamic subtest pipe-A: SUCCESS (5.456s)
[592.020799] Starting dynamic subtest: pipe-B
[597.481538] Dynamic subtest pipe-B: SUCCESS (5.472s)
[597.503088] Starting dynamic subtest: pipe-C
[602.960496] Dynamic subtest pipe-C: SUCCESS (5.477s)
[602.973651] Starting dynamic subtest: pipe-D
[608.434125] Dynamic subtest pipe-D: SUCCESS (5.471s)
[608.446100] Starting dynamic subtest: all-pipes
[613.930965] Dynamic subtest all-pipes: SUCCESS (5.493s)
[613.933455] Subtest forked-move: SUCCESS (27.380s)
[614.080996] [132/133] (408s left) prime_vgem (fence-wait)
[614.159244] Starting subtest: fence-wait
[614.161648] Starting dynamic subtest: rcs0
[615.220768] Dynamic subtest rcs0: SUCCESS (1.061s)
[615.232707] Starting dynamic subtest: bcs0
[616.296206] Dynamic subtest bcs0: SUCCESS (1.074s)
[616.308119] Starting dynamic subtest: vcs0
[617.347238] Dynamic subtest vcs0: SUCCESS (1.051s)
[617.359866] Starting dynamic subtest: vcs1
[618.390368] Dynamic subtest vcs1: SUCCESS (1.041s)
[618.403221] Starting dynamic subtest: vecs0
[619.435223] Dynamic subtest vecs0: SUCCESS (1.042s)
[619.447734] Starting dynamic subtest: ccs0
[620.479942] Dynamic subtest ccs0: SUCCESS (1.043s)
[620.482597] Subtest fence-wait: SUCCESS (6.321s)
[620.617462] [133/133] (401s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[620.706965] Starting subtest: 2x-absolute-wf_vblank-interruptible
[620.718052] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.010s)
[620.799458] 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.