[56.979505] Initializing watchdogs
[56.979554]   /dev/watchdog0
[56.994969] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[56.999018] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.001151] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.004531] [001/133] (960s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[57.118999] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[57.123276] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[57.201239] [002/133] (960s left) gem_mmap_gtt (fault-concurrent-y)
[57.265418] Subtest fault-concurrent-Y: SKIP (0.000s)
[57.328620] [003/133] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[57.412114] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[57.416257] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[57.513425] [004/133] (960s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[57.879658] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[58.674560] [005/133] (958s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[58.752994] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[58.755360] Starting dynamic subtest: pipe-A-eDP-1
[60.054029] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.285s)
[60.335088] Starting dynamic subtest: pipe-B-eDP-1
[61.426908] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.088s)
[61.696890] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.911s)
[62.530480] [006/133] (955s left) gem_mmap_wc (read)
[62.588986] Subtest read: SKIP (0.000s)
[62.652833] [007/133] (955s left) kms_dsc (dsc-basic)
[62.736835] Starting subtest: dsc-basic
[62.749958] Subtest dsc-basic: SKIP (0.000s)
[62.803996] [008/133] (955s left) kms_addfb_basic (unused-offsets)
[62.861145] Starting subtest: unused-offsets
[62.863530] Subtest unused-offsets: SUCCESS (0.000s)
[63.003340] [009/133] (954s left) gem_pxp (create-valid-protected-context)
[63.137862] Starting subtest: create-valid-protected-context
[63.140534] Subtest create-valid-protected-context: SUCCESS (0.003s)
[63.268024] [010/133] (954s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[63.353722] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[63.356060] Starting dynamic subtest: pipe-A-eDP-1
[64.258870] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.893s)
[64.267994] Starting dynamic subtest: pipe-B-eDP-1
[66.005907] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.733s)
[66.015667] Starting dynamic subtest: pipe-C-eDP-1
[67.482586] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.471s)
[67.492514] Starting dynamic subtest: pipe-D-eDP-1
[69.027126] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.538s)
[69.029078] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.639s)
[70.194054] [011/133] (947s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[70.285407] Starting subtest: fbcpsr-stridechange
[76.507295] Subtest fbcpsr-stridechange: SUCCESS (6.215s)
[76.628628] [012/133] (941s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[76.711281] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[76.715173] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[76.797393] [013/133] (941s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[76.884979] Starting subtest: psr2-plane-move-sf-dmg-area
[76.887332] Starting dynamic subtest: pipe-A-eDP-1
[81.467915] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.583s)
[81.477834] Starting dynamic subtest: pipe-B-eDP-1
[86.776705] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.305s)
[86.778650] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.890s)
[87.638218] [014/133] (930s left) kms_cursor_edge_walk (64x64-top-edge)
[87.713335] Starting subtest: 64x64-top-edge
[87.715582] Starting dynamic subtest: pipe-A-eDP-1
[91.215414] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.499s)
[91.225116] Starting dynamic subtest: pipe-D-eDP-1
[94.346169] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.129s)
[94.348570] Subtest 64x64-top-edge: SUCCESS (6.631s)
[95.168562] [015/133] (922s left) vgem_basic (dmabuf-mmap)
[95.257101] Starting subtest: dmabuf-mmap
[95.263201] Subtest dmabuf-mmap: SUCCESS (0.008s)
[95.308207] [FACT vgem_basic (dmabuf-mmap)] new: kernel.kmod_is_loaded.vgem: true
[95.311644] [016/133] (922s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[95.389791] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[95.392509] Starting dynamic subtest: pipe-A
[95.455157] Dynamic subtest pipe-A: SUCCESS (0.065s)
[95.465812] Starting dynamic subtest: pipe-B
[96.576038] Dynamic subtest pipe-B: SUCCESS (1.120s)
[96.586346] Starting dynamic subtest: pipe-C
[97.680433] Dynamic subtest pipe-C: SUCCESS (1.103s)
[97.689481] Starting dynamic subtest: pipe-D
[98.813069] Dynamic subtest pipe-D: SUCCESS (1.132s)
[98.815366] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.424s)
[99.981916] [017/133] (918s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[100.059097] Starting subtest: bad-rotation-90-yf-tiled-ccs
[100.061383] Starting dynamic subtest: pipe-A-eDP-1
[100.085470] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[100.093922] Starting dynamic subtest: pipe-B-eDP-1
[100.115414] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[100.123641] Starting dynamic subtest: pipe-C-eDP-1
[100.144716] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[100.154841] Starting dynamic subtest: pipe-D-eDP-1
[100.176988] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[100.181144] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.003s)
[102.333842] [018/133] (915s left) gem_ctx_exec (basic)
[102.393736] Starting subtest: basic
[102.398882] Subtest basic: SUCCESS (0.005s)
[102.517303] [019/133] (915s left) gem_exec_schedule (pi-shared-iova)
[102.702132] Starting subtest: pi-shared-iova
[102.704554] Starting dynamic subtest: rcs0
[102.771046] Dynamic subtest rcs0: SUCCESS (0.072s)
[102.781104] Starting dynamic subtest: vcs0
[102.827683] Dynamic subtest vcs0: SUCCESS (0.056s)
[102.840045] Starting dynamic subtest: vcs1
[102.885706] Dynamic subtest vcs1: SUCCESS (0.057s)
[102.896842] Starting dynamic subtest: vecs0
[102.937926] Dynamic subtest vecs0: SUCCESS (0.052s)
[102.947507] Starting dynamic subtest: ccs0
[102.995768] Dynamic subtest ccs0: SUCCESS (0.057s)
[102.998127] Subtest pi-shared-iova: SUCCESS (0.299s)
[104.353193] [020/133] (913s left) device_reset (unbind-reset-rebind)
[104.407365] Starting subtest: unbind-reset-rebind
[110.545420] Subtest unbind-reset-rebind: SUCCESS (6.135s)
[110.594542] [021/133] (907s left) syncobj_timeline (wait-all-snapshot)
[110.655985] Starting subtest: wait-all-snapshot
[110.737336] Subtest wait-all-snapshot: SUCCESS (0.082s)
[110.808985] [022/133] (907s left) gem_mmap_gtt (medium-copy-xy)
[110.858260] Subtest medium-copy-XY: SKIP (0.000s)
[110.918778] [023/133] (907s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[110.968347] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[110.970358] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[111.105477] [024/133] (907s left) perf_pmu (busy-check-all)
[111.143719] Starting subtest: busy-check-all
[111.145992] Starting dynamic subtest: rcs0
[111.694719] Dynamic subtest rcs0: SUCCESS (0.551s)
[111.706949] Starting dynamic subtest: bcs0
[112.244918] Dynamic subtest bcs0: SUCCESS (0.548s)
[112.257527] Starting dynamic subtest: vcs0
[114.238414] Dynamic subtest vcs0: SUCCESS (1.990s)
[114.250895] Starting dynamic subtest: vcs1
[116.222995] Dynamic subtest vcs1: SUCCESS (1.982s)
[116.236918] Starting dynamic subtest: vecs0
[118.207594] Dynamic subtest vecs0: SUCCESS (1.982s)
[118.220632] Starting dynamic subtest: ccs0
[118.761866] Dynamic subtest ccs0: SUCCESS (0.555s)
[118.764348] Subtest busy-check-all: SUCCESS (7.618s)
[118.870331] [025/133] (899s left) syncobj_timeline (invalid-query-illegal-handle)
[118.929578] Starting subtest: invalid-query-illegal-handle
[118.931921] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[119.043981] [026/133] (899s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[119.150976] Starting subtest: cursorA-vs-flipA-atomic-transitions
[130.341798] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.186s)
[131.148913] [027/133] (887s left) gem_tiled_swapping (non-threaded)
[131.215158] Subtest non-threaded: SKIP (0.000s)
[131.284797] [028/133] (887s left) kms_plane_multiple (tiling-x)
[131.359773] Starting subtest: tiling-x
[131.362148] Starting dynamic subtest: pipe-A-eDP-1
[135.090560] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.727s)
[135.101819] Starting dynamic subtest: pipe-B-eDP-1
[139.449296] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.360s)
[139.460879] Starting dynamic subtest: pipe-C-eDP-1
[143.790309] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.338s)
[143.800750] Starting dynamic subtest: pipe-D-eDP-1
[148.132966] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.340s)
[148.135830] Subtest tiling-x: SUCCESS (16.772s)
[148.938781] [029/133] (869s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[149.036386] Starting subtest: yf-tiled-16bpp-rotate-270
[149.040717] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[149.140207] [030/133] (869s left) kms_psr (pr-cursor-mmap-cpu)
[149.215633] Starting subtest: pr-cursor-mmap-cpu
[149.219579] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[149.290610] [031/133] (869s left) gem_ctx_param (invalid-get-ringsize)
[149.346134] Starting subtest: invalid-get-ringsize
[149.348376] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[149.453161] [032/133] (869s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[149.533765] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[156.174999] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.643s)
[156.331290] [033/133] (862s left) gem_exec_whisper (basic-fds-all)
[156.391428] Starting subtest: basic-fds-all
[167.143072] Subtest basic-fds-all: SUCCESS (10.751s)
[167.325842] [034/133] (851s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[167.420729] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[167.425175] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[167.513461] [035/133] (851s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[167.573374] Starting subtest: invalid-multi-wait-unsubmitted
[167.575678] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[167.672936] [036/133] (851s left) gem_mmap_offset (close-race)
[167.729466] Starting subtest: close-race
[187.842926] Subtest close-race: SUCCESS (20.109s)
[187.978853] [037/133] (831s left) kms_psr (psr-cursor-render)
[188.056957] Starting subtest: psr-cursor-render
[188.059339] Starting dynamic subtest: eDP-1
[189.759578] Dynamic subtest eDP-1: SUCCESS (1.701s)
[189.761909] Subtest psr-cursor-render: SUCCESS (1.702s)
[190.622819] [038/133] (828s left) perf_pmu (interrupts)
[190.665649] Starting subtest: interrupts
[191.753096] Subtest interrupts: SUCCESS (1.088s)
[191.857553] [039/133] (827s left) api_intel_allocator (alloc-simple)
[191.906052] Starting subtest: alloc-simple
[191.910695] Subtest alloc-simple: SUCCESS (0.004s)
[192.019489] [040/133] (827s left) kms_psr (psr-primary-blt)
[192.092057] Starting subtest: psr-primary-blt
[192.094288] Starting dynamic subtest: eDP-1
[193.814757] Dynamic subtest eDP-1: SUCCESS (1.723s)
[193.817123] Subtest psr-primary-blt: SUCCESS (1.724s)
[194.683606] [041/133] (824s left) kms_cursor_crc (cursor-random-512x170)
[194.932098] Starting subtest: cursor-random-512x170
[194.936442] Subtest cursor-random-512x170: SKIP (0.001s)
[195.082564] [042/133] (824s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[195.141586] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[195.252287] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.108s)
[195.338610] [043/133] (823s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[197.443701] Starting subtest: gem-execbuf-stress-pc8
[197.483106] Subtest gem-execbuf-stress-pc8: SKIP (0.040s)
[197.850197] [044/133] (821s left) gem_reg_read (bad-register)
[197.891635] Starting subtest: bad-register
[197.894063] Subtest bad-register: SUCCESS (0.000s)
[198.009071] [045/133] (821s left) gem_mmap_gtt (basic-small-copy-odd)
[198.064828] Subtest basic-small-copy-odd: SKIP (0.000s)
[198.127284] [046/133] (821s left) i915_hangman (gt-engine-hang)
[198.190735] Starting subtest: gt-engine-hang
[198.192996] Starting dynamic subtest: rcs0
[200.222356] Dynamic subtest rcs0: SUCCESS (2.031s)
[200.235370] Starting dynamic subtest: bcs0
[202.205300] Dynamic subtest bcs0: SUCCESS (1.980s)
[202.222802] Starting dynamic subtest: vcs0
[204.189105] Dynamic subtest vcs0: SUCCESS (1.981s)
[204.202058] Starting dynamic subtest: vcs1
[206.172883] Dynamic subtest vcs1: SUCCESS (1.981s)
[206.184053] Starting dynamic subtest: vecs0
[208.221278] Dynamic subtest vecs0: SUCCESS (2.046s)
[208.235880] Starting dynamic subtest: ccs0
[210.204444] Dynamic subtest ccs0: SUCCESS (1.980s)
[210.207092] Subtest gt-engine-hang: SUCCESS (12.014s)
[210.298262] [047/133] (809s left) fbdev (pan)
[210.334358] Starting subtest: pan
[210.361941] Subtest pan: SUCCESS (0.031s)
[210.451441] [048/133] (809s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[210.525314] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[211.514840] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.991s)
[211.634569] [049/133] (807s left) prime_self_import (basic-with_one_bo)
[211.667523] Starting subtest: basic-with_one_bo
[211.687806] Subtest basic-with_one_bo: SUCCESS (0.021s)
[211.820837] [050/133] (807s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[211.902274] Starting subtest: 2x-flip-vs-modeset-vs-hang
[211.906240] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.002s)
[212.022255] [051/133] (807s left) kms_flip (2x-flip-vs-suspend)
[212.092319] Starting subtest: 2x-flip-vs-suspend
[212.096419] Subtest 2x-flip-vs-suspend: SKIP (0.001s)
[212.198191] [052/133] (807s left) i915_query (query-garbage)
[212.257054] Starting subtest: query-garbage
[212.258720] Subtest query-garbage: SUCCESS (0.000s)
[212.356543] [053/133] (807s left) kms_pm_dc (dc5-retention-flops)
[213.427227] Starting subtest: dc5-retention-flops
[213.431685] Subtest dc5-retention-flops: SKIP (0.000s)
[213.504301] [054/133] (806s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[213.593181] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[213.597819] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[213.689600] [055/133] (806s left) kms_atomic_interruptible (legacy-dpms)
[213.767250] Starting subtest: legacy-dpms
[213.769531] Starting dynamic subtest: pipe-A-eDP-1
[221.157920] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.388s)
[221.160087] Subtest legacy-dpms: SUCCESS (7.389s)
[221.988033] [056/133] (797s left) gem_basic (create-close)
[222.040305] Starting subtest: create-close
[222.044963] Subtest create-close: SUCCESS (0.000s)
[222.136874] [057/133] (797s left) sysfs_timeslice_duration (idempotent)
[222.192108] Starting subtest: idempotent
[222.194470] Starting dynamic subtest: vecs0
[222.196750] Dynamic subtest vecs0: SUCCESS (0.001s)
[222.207798] Starting dynamic subtest: ccs0
[222.210360] Dynamic subtest ccs0: SUCCESS (0.000s)
[222.220455] Starting dynamic subtest: vcs0
[222.222701] Dynamic subtest vcs0: SUCCESS (0.000s)
[222.232644] Starting dynamic subtest: bcs0
[222.234865] Dynamic subtest bcs0: SUCCESS (0.000s)
[222.247809] Starting dynamic subtest: rcs0
[222.250244] Dynamic subtest rcs0: SUCCESS (0.000s)
[222.260088] Starting dynamic subtest: vcs1
[222.262062] Dynamic subtest vcs1: SUCCESS (0.000s)
[222.264435] Subtest idempotent: SUCCESS (0.006s)
[222.325105] [058/133] (797s left) kms_cursor_crc (cursor-offscreen-128x128)
[222.507340] Starting subtest: cursor-offscreen-128x128
[222.509624] Starting dynamic subtest: pipe-A-eDP-1
[224.452070] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.941s)
[224.483026] Starting dynamic subtest: pipe-D-eDP-1
[227.083346] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.609s)
[227.085875] Subtest cursor-offscreen-128x128: SUCCESS (4.578s)
[227.938663] [059/133] (792s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[228.036419] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[228.040574] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[228.140850] [060/133] (791s left) gem_pxp (regular-baseline-src-copy-readible)
[228.253195] Starting subtest: regular-baseline-src-copy-readible
[228.308529] Subtest regular-baseline-src-copy-readible: SUCCESS (0.058s)
[228.436865] [061/133] (791s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[228.509369] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[228.513450] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[228.576577] [062/133] (791s left) gem_exec_schedule (fairslice)
[228.652293] Starting subtest: fairslice
[228.654155] Starting dynamic subtest: rcs0
[230.665203] Dynamic subtest rcs0: SUCCESS (2.019s)
[230.675274] Starting dynamic subtest: bcs0
[232.686949] Dynamic subtest bcs0: SUCCESS (2.019s)
[232.696766] Starting dynamic subtest: vcs0
[234.705102] Dynamic subtest vcs0: SUCCESS (2.018s)
[234.716741] Starting dynamic subtest: vcs1
[236.722801] Dynamic subtest vcs1: SUCCESS (2.018s)
[236.735077] Starting dynamic subtest: vecs0
[238.741687] Dynamic subtest vecs0: SUCCESS (2.017s)
[238.751482] Starting dynamic subtest: ccs0
[240.761363] Dynamic subtest ccs0: SUCCESS (2.017s)
[240.763878] Subtest fairslice: SUCCESS (12.113s)
[241.060199] [063/133] (779s left) kms_frontbuffer_tracking (psr-2p-rte)
[241.140126] Starting subtest: psr-2p-rte
[241.144229] Subtest psr-2p-rte: SKIP (0.000s)
[241.263008] [064/133] (778s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[241.327184] Starting subtest: plane-lut1d-pre-ctm3x4
[241.473626] Starting dynamic subtest: pipe-A-plane-0
[241.640085] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[241.652816] Starting dynamic subtest: pipe-A-plane-1
[241.796604] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s)
[241.807138] Starting dynamic subtest: pipe-A-plane-2
[241.940321] Dynamic subtest pipe-A-plane-2: SUCCESS (0.144s)
[243.137120] Starting dynamic subtest: pipe-B-plane-0
[243.292648] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[243.303944] Starting dynamic subtest: pipe-B-plane-1
[243.470604] Dynamic subtest pipe-B-plane-1: SUCCESS (0.177s)
[243.484953] Starting dynamic subtest: pipe-B-plane-2
[243.625838] Dynamic subtest pipe-B-plane-2: SUCCESS (0.154s)
[244.857518] Starting dynamic subtest: pipe-C-plane-0
[244.981403] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[244.992646] Starting dynamic subtest: pipe-C-plane-1
[245.125762] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[245.136630] Starting dynamic subtest: pipe-C-plane-2
[245.260372] Dynamic subtest pipe-C-plane-2: SUCCESS (0.133s)
[246.490680] Starting dynamic subtest: pipe-D-plane-0
[246.624072] Dynamic subtest pipe-D-plane-0: SUCCESS (0.142s)
[246.634471] Starting dynamic subtest: pipe-D-plane-1
[246.757522] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s)
[246.767714] Starting dynamic subtest: pipe-D-plane-2
[246.890606] Dynamic subtest pipe-D-plane-2: SUCCESS (0.132s)
[247.190555] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (5.861s)
[248.075508] [065/133] (772s left) gem_exec_balancer (semaphore)
[248.138492] Starting subtest: semaphore
[250.229230] Subtest semaphore: SUCCESS (2.089s)
[250.539816] [066/133] (769s left) kms_content_protection (dp-mst-type-0)
[250.671815] Starting subtest: dp-mst-type-0
[250.676150] Subtest dp-mst-type-0: SKIP (0.000s)
[250.787167] [067/133] (769s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[250.862383] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[250.866783] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[250.962605] [068/133] (769s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[251.063586] Starting subtest: 2x-flip-vs-cursor-atomic
[251.068186] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[251.211974] [069/133] (769s left) kms_lease (lease-invalid-crtc)
[251.281901] Starting subtest: lease-invalid-crtc
[251.284262] Starting dynamic subtest: pipe-A-eDP-1
[251.286567] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[251.295974] Starting dynamic subtest: pipe-B-eDP-1
[251.298358] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[251.308079] Starting dynamic subtest: pipe-C-eDP-1
[251.310329] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[251.319639] Starting dynamic subtest: pipe-D-eDP-1
[251.321541] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[251.323448] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[251.368838] [070/133] (769s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[251.476072] Starting subtest: cursor-vs-flip-atomic-transitions
[281.611938] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.133s)
[282.416479] [071/133] (738s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[282.465921] Starting subtest: yf-tiled-to-vebox-y-tiled
[282.470715] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[282.651298] [072/133] (737s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[282.725984] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[282.728221] Starting dynamic subtest: pipe-A-default-mode
[283.862522] Dynamic subtest pipe-A-default-mode: SKIP (1.134s)
[283.866595] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.135s)
[283.997386] [073/133] (736s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[284.055360] Starting subtest: etime-single-wait-available-unsubmitted
[284.162475] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.107s)
[284.258270] [074/133] (736s left) kms_chamelium_color (ctm-0-50)
[284.331104] Subtest ctm-0-50: SKIP (0.000s)
[284.377663] [075/133] (736s left) kms_invalid_mode (overflow-vrefresh)
[284.449177] Starting subtest: overflow-vrefresh
[284.451404] Starting dynamic subtest: pipe-A-eDP-1
[284.744803] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.295s)
[284.755480] Starting dynamic subtest: pipe-B-eDP-1
[284.757419] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[284.767741] Starting dynamic subtest: pipe-C-eDP-1
[284.770272] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[284.781671] Starting dynamic subtest: pipe-D-eDP-1
[284.784051] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[284.786379] Subtest overflow-vrefresh: SUCCESS (0.302s)
[285.562911] [076/133] (735s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[285.636903] Starting subtest: psr-1p-primscrn-spr-indfb-move
[293.081432] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.447s)
[293.219026] [077/133] (727s left) gem_create (hog-create)
[293.268971] Starting subtest: hog-create
[293.271907] Starting dynamic subtest: smem0
[327.239041] Dynamic subtest smem0: SUCCESS (33.967s)
[327.241860] Subtest hog-create: SUCCESS (33.969s)
[327.425376] [078/133] (693s left) gem_unref_active_buffers
[327.619091] [079/133] (693s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[327.719704] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[327.724342] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[327.831450] [080/133] (693s left) kms_big_fb (y-tiled-addfb-size-overflow)
[327.911132] Starting subtest: y-tiled-addfb-size-overflow
[327.915537] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[328.030244] [081/133] (692s left) gem_exec_reloc (basic-write-cpu-active)
[328.076432] Subtest basic-write-cpu-active: SKIP (0.000s)
[328.140463] [082/133] (692s left) kms_pm_rpm (legacy-planes-dpms)
[330.436467] Starting subtest: legacy-planes-dpms
[330.439875] Starting dynamic subtest: plane-65
[338.731905] Dynamic subtest plane-65: SUCCESS (8.295s)
[338.745642] Starting dynamic subtest: plane-95
[347.008630] Dynamic subtest plane-95: SUCCESS (8.274s)
[347.021684] Starting dynamic subtest: plane-125
[355.307561] Dynamic subtest plane-125: SUCCESS (8.296s)
[355.321155] Starting dynamic subtest: plane-135
[363.589122] Dynamic subtest plane-135: SUCCESS (8.279s)
[363.591574] Subtest legacy-planes-dpms: SUCCESS (33.155s)
[363.978563] [083/133] (656s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[364.072103] Starting subtest: disable-crc-after-crtc
[364.074612] Starting dynamic subtest: pipe-A-eDP-1
[365.720915] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.648s)
[365.733602] Starting dynamic subtest: pipe-B-eDP-1
[367.970322] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.246s)
[367.981584] Starting dynamic subtest: pipe-C-eDP-1
[370.226165] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.254s)
[370.236639] Starting dynamic subtest: pipe-D-eDP-1
[372.475640] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.248s)
[372.477977] Subtest disable-crc-after-crtc: SUCCESS (8.403s)
[373.303032] [084/133] (647s left) prime_udl
[373.387682] [085/133] (647s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[373.471160] Starting subtest: fbcpsr-modesetfrombusy
[379.663507] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.196s)
[379.801477] [086/133] (641s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[379.881642] Starting subtest: x-tiled-8bpp-rotate-270
[379.900687] Subtest x-tiled-8bpp-rotate-270: SKIP (0.019s)
[380.013797] [087/133] (641s left) gem_exec_fence (syncobj-repeat)
[380.460736] Starting subtest: syncobj-repeat
[380.640528] Subtest syncobj-repeat: SUCCESS (0.182s)
[382.267869] [088/133] (638s left) gem_softpin (zero)
[382.329456] Starting subtest: zero
[382.334250] Subtest zero: SUCCESS (0.003s)
[382.467357] [089/133] (638s left) gem_ctx_persistence (heartbeat-hostile)
[382.535516] Starting subtest: heartbeat-hostile
[382.540065] Subtest heartbeat-hostile: SKIP (0.000s)
[382.645459] [090/133] (638s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[382.720955] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[382.725260] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[382.826148] [091/133] (638s left) kms_chamelium_frames (hdmi-crc-multiple)
[383.183976] Subtest hdmi-crc-multiple: SKIP (0.000s)
[383.945892] [092/133] (637s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[384.025118] Starting subtest: async-flip-with-page-flip-events-linear
[384.397634] Starting dynamic subtest: pipe-A-eDP-1
[387.138983] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.741s)
[387.502817] Starting dynamic subtest: pipe-B-eDP-1
[390.263916] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.769s)
[390.630825] Starting dynamic subtest: pipe-C-eDP-1
[393.386306] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.762s)
[393.749847] Starting dynamic subtest: pipe-D-eDP-1
[396.510937] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.771s)
[396.513207] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.487s)
[397.733410] [093/133] (623s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[397.819914] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[397.824425] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[397.893905] [094/133] (623s left) gem_exec_params (secure-non-master)
[397.947783] Starting subtest: secure-non-master
[397.952208] Subtest secure-non-master: SKIP (0.000s)
[398.056777] [095/133] (623s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[398.130659] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[398.134793] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[398.237570] [096/133] (623s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[398.319207] Starting subtest: fbc-rgb101010-draw-render
[402.911879] Subtest fbc-rgb101010-draw-render: SUCCESS (4.594s)
[404.110980] [097/133] (617s left) api_intel_bb (reset-flags)
[404.165525] Starting subtest: reset-flags
[404.171041] Subtest reset-flags: SUCCESS (0.007s)
[404.277739] [098/133] (617s left) syncobj_wait (single-wait-submitted)
[404.324168] Starting subtest: single-wait-submitted
[404.427520] Subtest single-wait-submitted: SUCCESS (0.103s)
[404.503259] [099/133] (617s left) i915_query (engine-info)
[404.562048] Starting subtest: engine-info
[404.566847] Subtest engine-info: SUCCESS (0.005s)
[404.699462] [100/133] (617s left) perf_pmu (all-busy-check-all)
[404.736780] Starting subtest: all-busy-check-all
[406.207225] Subtest all-busy-check-all: SUCCESS (1.470s)
[406.298227] [101/133] (615s left) syncobj_basic (bad-flags-fd-to-handle)
[406.352269] Starting subtest: bad-flags-fd-to-handle
[406.354663] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[406.468657] [102/133] (615s left) gem_exec_schedule (u-submit-golden-slice)
[406.531564] Starting subtest: u-submit-golden-slice
[406.533710] Starting dynamic subtest: rcs0
[406.563313] Dynamic subtest rcs0: SUCCESS (0.038s)
[406.573786] Starting dynamic subtest: bcs0
[406.606535] Dynamic subtest bcs0: SUCCESS (0.043s)
[406.617267] Starting dynamic subtest: vcs0
[406.652391] Dynamic subtest vcs0: SUCCESS (0.044s)
[406.666398] Starting dynamic subtest: vcs1
[406.699435] Dynamic subtest vcs1: SUCCESS (0.047s)
[406.715160] Starting dynamic subtest: vecs0
[406.741951] Dynamic subtest vecs0: SUCCESS (0.041s)
[406.755846] Starting dynamic subtest: ccs0
[406.784455] Dynamic subtest ccs0: SUCCESS (0.042s)
[406.786819] Subtest u-submit-golden-slice: SUCCESS (0.260s)
[408.343309] [103/133] (613s left) i915_drm_fdinfo (memory-info-shared)
[408.381077] Starting subtest: memory-info-shared
[408.383359] Starting dynamic subtest: smem0
[408.438549] Dynamic subtest smem0: SUCCESS (0.057s)
[408.441313] Subtest memory-info-shared: SUCCESS (0.058s)
[408.518258] [104/133] (613s left) gem_mmap_wc (write-read-distinct)
[408.568516] Subtest write-read-distinct: SKIP (0.000s)
[408.632429] [105/133] (613s left) kms_selftest (drm_damage_helper)
[408.669949] Starting subtest: drm_damage_helper
[408.684354] Starting dynamic subtest: drm_test_damage_iter_no_damage
[408.782409] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.099s)
[408.792095] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[408.870222] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.087s)
[408.880625] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[408.974073] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.103s)
[408.984102] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[409.065989] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.091s)
[409.075600] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[409.163586] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.096s)
[409.175407] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[409.264995] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.101s)
[409.277140] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[409.357567] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.091s)
[409.369708] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[409.456227] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.099s)
[409.465766] Starting dynamic subtest: drm_test_damage_iter_single_damage
[409.564595] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.107s)
[409.574340] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[409.654718] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.091s)
[409.664235] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[409.753488] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.096s)
[409.763052] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[409.848982] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.096s)
[409.858538] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[409.933629] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.084s)
[409.944904] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[410.028835] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.094s)
[410.038252] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[410.127705] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.097s)
[410.142476] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[410.218261] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.091s)
[410.227539] Starting dynamic subtest: drm_test_damage_iter_damage
[410.311754] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.092s)
[410.321139] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[410.411256] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.099s)
[410.422551] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[410.511977] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.099s)
[410.521331] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[410.596502] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.085s)
[410.606544] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[410.692949] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.095s)
[410.694840] Subtest drm_damage_helper: SUCCESS (2.021s)
[410.848837] [106/133] (611s left) prime_mmap (test_correct_cpu_write)
[410.895807] Starting subtest: test_correct_cpu_write
[410.897759] Starting dynamic subtest: test_correct_cpu_write-smem
[410.899380] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[410.901047] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[411.005705] [107/133] (610s left) gen9_exec_parse (secure-batches)
[411.056454] Subtest secure-batches: SKIP (0.000s)
[411.125882] [108/133] (610s left) kms_atomic (plane-immutable-zpos)
[411.198277] Starting subtest: plane-immutable-zpos
[411.200290] Starting dynamic subtest: pipe-A-eDP-1
[411.827429] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.629s)
[411.829700] Subtest plane-immutable-zpos: SUCCESS (0.630s)
[412.624670] [109/133] (609s left) gem_exec_nop (basic-parallel)
[412.698908] Starting subtest: basic-parallel
[430.171487] Subtest basic-parallel: SUCCESS (17.483s)
[430.381790] [110/133] (591s left) kms_psr (fbc-psr-sprite-render)
[430.463506] Starting subtest: fbc-psr-sprite-render
[430.465807] Starting dynamic subtest: eDP-1
[430.469901] Dynamic subtest eDP-1: SKIP (0.000s)
[430.473990] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[430.533737] [111/133] (591s left) gem_fenced_exec_thrash (2-spare-fences)
[430.594250] Subtest 2-spare-fences: SKIP (0.000s)
[430.663722] [112/133] (591s left) perf_pmu (idle)
[430.701861] Starting subtest: idle
[430.704322] Starting dynamic subtest: rcs0
[431.244740] Dynamic subtest rcs0: SUCCESS (0.541s)
[431.257937] Starting dynamic subtest: bcs0
[431.777032] Dynamic subtest bcs0: SUCCESS (0.525s)
[431.788733] Starting dynamic subtest: vcs0
[432.292516] Dynamic subtest vcs0: SUCCESS (0.516s)
[432.305307] Starting dynamic subtest: vcs1
[432.814565] Dynamic subtest vcs1: SUCCESS (0.518s)
[432.828142] Starting dynamic subtest: vecs0
[433.345826] Dynamic subtest vecs0: SUCCESS (0.529s)
[433.359684] Starting dynamic subtest: ccs0
[433.874630] Dynamic subtest ccs0: SUCCESS (0.526s)
[433.877808] Subtest idle: SUCCESS (3.172s)
[433.993440] [113/133] (588s left) kms_vblank (wait-busy-hang)
[434.068166] Starting subtest: wait-busy-hang
[434.070504] Starting dynamic subtest: pipe-A-eDP-1
[461.047479] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.976s)
[461.063781] Starting dynamic subtest: pipe-D-eDP-1
[486.016198] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.965s)
[486.018163] Subtest wait-busy-hang: SUCCESS (51.945s)
[486.885869] [114/133] (535s left) gem_exec_balancer (noheartbeat)
[487.153961] Starting subtest: noheartbeat
[487.158665] Subtest noheartbeat: SKIP (0.000s)
[487.281692] [115/133] (535s left) kms_hdr (brightness-with-hdr)
[487.358714] Starting subtest: brightness-with-hdr
[487.364730] Subtest brightness-with-hdr: SKIP (0.000s)
[487.430099] [116/133] (534s left) kms_flip (blocking-wf_vblank)
[487.505738] Starting subtest: blocking-wf_vblank
[487.508144] Starting dynamic subtest: A-eDP1
[496.416721] Dynamic subtest A-eDP1: SUCCESS (8.913s)
[496.429666] Starting dynamic subtest: B-eDP1
[505.349921] Dynamic subtest B-eDP1: SUCCESS (8.931s)
[505.363413] Starting dynamic subtest: C-eDP1
[514.275303] Dynamic subtest C-eDP1: SUCCESS (8.922s)
[514.287975] Starting dynamic subtest: D-eDP1
[523.197447] Dynamic subtest D-eDP1: SUCCESS (8.921s)
[523.199764] Subtest blocking-wf_vblank: SUCCESS (35.695s)
[524.424777] [117/133] (497s left) kms_plane (pixel-format-linear-modifier-source-clamping)
[524.494802] Starting subtest: pixel-format-linear-modifier-source-clamping
[524.522048] Starting dynamic subtest: pipe-A-plane-0
[525.088626] Dynamic subtest pipe-A-plane-0: SUCCESS (0.566s)
[525.101192] Starting dynamic subtest: pipe-A-plane-3
[525.555911] Dynamic subtest pipe-A-plane-3: SUCCESS (0.464s)
[526.618451] Starting dynamic subtest: pipe-B-plane-0
[527.209471] Dynamic subtest pipe-B-plane-0: SUCCESS (0.600s)
[527.220046] Starting dynamic subtest: pipe-B-plane-3
[527.654354] Dynamic subtest pipe-B-plane-3: SUCCESS (0.444s)
[527.982204] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (3.486s)
[528.797696] [118/133] (493s left) gem_lmem_swapping (heavy-verify-multi)
[528.840904] Subtest heavy-verify-multi: SKIP (0.000s)
[528.881451] [119/133] (493s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[528.962638] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[533.485541] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.526s)
[534.630074] [120/133] (487s left) kms_big_fb (4-tiled-addfb-size-overflow)
[534.722709] Starting subtest: 4-tiled-addfb-size-overflow
[534.724966] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[534.829197] [121/133] (487s left) gem_vm_create (invalid-create)
[534.885701] Starting subtest: invalid-create
[534.888166] Subtest invalid-create: SUCCESS (0.002s)
[534.997382] [122/133] (487s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[535.067867] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[535.070045] Starting dynamic subtest: pipe-A-eDP-1
[535.094799] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[535.111037] Starting dynamic subtest: pipe-B-eDP-1
[535.134489] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[535.145120] Starting dynamic subtest: pipe-C-eDP-1
[535.168823] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[535.181444] Starting dynamic subtest: pipe-D-eDP-1
[535.205266] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[535.209660] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[537.296944] [123/133] (485s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[537.378819] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[544.498358] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.124s)
[544.637441] [124/133] (478s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[544.710958] Starting subtest: fbc-psr2-cursor-mmap-cpu
[544.713474] Starting dynamic subtest: eDP-1
[544.717518] Dynamic subtest eDP-1: SKIP (0.000s)
[544.721597] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s)
[544.786868] [125/133] (477s left) syncobj_basic (bad-create-flags)
[544.840163] Starting subtest: bad-create-flags
[544.842468] Subtest bad-create-flags: SUCCESS (0.000s)
[544.943886] [126/133] (477s left) perf (enable-disable)
[545.067521] Starting subtest: enable-disable
[545.069768] Starting dynamic subtest: 0-rcs0
[547.313740] Dynamic subtest 0-rcs0: SUCCESS (2.246s)
[547.324633] Starting dynamic subtest: 1-vecs0
[551.774080] Dynamic subtest 1-vecs0: SUCCESS (4.458s)
[551.776865] Subtest enable-disable: SUCCESS (6.706s)
[551.824621] [127/133] (470s left) gem_ctx_shared (q-smoketest)
[551.881483] Starting subtest: Q-smoketest
[551.883856] Starting dynamic subtest: rcs0
[557.421600] Dynamic subtest rcs0: SUCCESS (5.485s)
[557.438154] Starting dynamic subtest: bcs0
[562.888296] Dynamic subtest bcs0: SUCCESS (5.469s)
[562.902560] Starting dynamic subtest: vcs0
[568.364090] Dynamic subtest vcs0: SUCCESS (5.474s)
[568.377619] Starting dynamic subtest: vcs1
[573.841462] Dynamic subtest vcs1: SUCCESS (5.482s)
[573.852988] Starting dynamic subtest: vecs0
[579.323419] Dynamic subtest vecs0: SUCCESS (5.478s)
[579.335931] Starting dynamic subtest: ccs0
[584.806233] Dynamic subtest ccs0: SUCCESS (5.483s)
[584.808464] Subtest Q-smoketest: SUCCESS (32.877s)
[584.947680] [128/133] (437s left) gem_exec_flush (basic-wb-rw-before-default)
[585.004896] Starting subtest: basic-wb-rw-before-default
[590.460197] Subtest basic-wb-rw-before-default: SUCCESS (5.457s)
[590.647489] [129/133] (432s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[590.729068] Starting subtest: psr-rgb565-draw-mmap-wc
[597.598228] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.870s)
[597.701930] [130/133] (425s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[597.774134] Starting subtest: crc-primary-basic-yf-tiled-ccs
[597.776387] Starting dynamic subtest: pipe-A-eDP-1
[597.799627] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[597.811429] Starting dynamic subtest: pipe-B-eDP-1
[597.832484] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[597.842868] Starting dynamic subtest: pipe-C-eDP-1
[597.864330] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[597.877944] Starting dynamic subtest: pipe-D-eDP-1
[597.901019] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[597.905159] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.005s)
[600.030425] [131/133] (422s left) kms_cursor_legacy (forked-move)
[600.137307] Starting subtest: forked-move
[600.139685] Starting dynamic subtest: pipe-A
[605.601097] Dynamic subtest pipe-A: SUCCESS (5.460s)
[605.621579] Starting dynamic subtest: pipe-B
[611.067531] Dynamic subtest pipe-B: SUCCESS (5.464s)
[611.087475] Starting dynamic subtest: pipe-C
[616.554865] Dynamic subtest pipe-C: SUCCESS (5.484s)
[616.567635] Starting dynamic subtest: pipe-D
[622.027178] Dynamic subtest pipe-D: SUCCESS (5.471s)
[622.040205] Starting dynamic subtest: all-pipes
[627.541728] Dynamic subtest all-pipes: SUCCESS (5.511s)
[627.544230] Subtest forked-move: SUCCESS (27.401s)
[627.682249] [132/133] (395s left) prime_vgem (fence-wait)
[627.743058] Starting subtest: fence-wait
[627.745445] Starting dynamic subtest: rcs0
[628.797494] Dynamic subtest rcs0: SUCCESS (1.053s)
[628.809714] Starting dynamic subtest: bcs0
[629.875226] Dynamic subtest bcs0: SUCCESS (1.076s)
[629.888044] Starting dynamic subtest: vcs0
[630.918886] Dynamic subtest vcs0: SUCCESS (1.042s)
[630.931642] Starting dynamic subtest: vcs1
[631.961925] Dynamic subtest vcs1: SUCCESS (1.042s)
[631.974926] Starting dynamic subtest: vecs0
[633.004481] Dynamic subtest vecs0: SUCCESS (1.040s)
[633.017416] Starting dynamic subtest: ccs0
[634.045808] Dynamic subtest ccs0: SUCCESS (1.039s)
[634.048760] Subtest fence-wait: SUCCESS (6.302s)
[634.170424] [133/133] (388s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[634.259601] Starting subtest: 2x-absolute-wf_vblank-interruptible
[634.269213] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.008s)
[634.339666] 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.