[56.467099] Initializing watchdogs
[56.467145]   /dev/watchdog0
[56.482614] [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.486593] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.488595] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.492110] [001/133] (960s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[56.597959] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[56.602325] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[56.678036] [002/133] (960s left) gem_mmap_gtt (fault-concurrent-y)
[56.735271] Subtest fault-concurrent-Y: SKIP (0.000s)
[56.800011] [003/133] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[56.896335] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[56.900708] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[56.980036] [004/133] (960s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[58.146260] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[58.452548] [005/133] (958s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[58.535957] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[58.538274] Starting dynamic subtest: pipe-A-eDP-1
[59.828277] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.286s)
[60.109543] Starting dynamic subtest: pipe-B-eDP-1
[61.155999] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.049s)
[61.425636] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.876s)
[62.264586] [006/133] (954s left) gem_mmap_wc (read)
[62.318635] Subtest read: SKIP (0.000s)
[62.372777] [007/133] (954s left) kms_dsc (dsc-basic)
[62.446092] Starting subtest: dsc-basic
[62.458968] Subtest dsc-basic: SKIP (0.000s)
[62.516044] [008/133] (954s left) kms_addfb_basic (unused-offsets)
[62.572444] Starting subtest: unused-offsets
[62.574712] Subtest unused-offsets: SUCCESS (0.000s)
[62.673467] [009/133] (954s left) gem_pxp (create-valid-protected-context)
[62.793257] Starting subtest: create-valid-protected-context
[62.795738] Subtest create-valid-protected-context: SUCCESS (0.003s)
[62.910207] [010/133] (954s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[62.987786] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[62.990020] Starting dynamic subtest: pipe-A-eDP-1
[63.897261] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.900s)
[63.906647] Starting dynamic subtest: pipe-B-eDP-1
[65.470800] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.567s)
[65.480532] Starting dynamic subtest: pipe-C-eDP-1
[67.078761] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.605s)
[67.088631] Starting dynamic subtest: pipe-D-eDP-1
[68.549224] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.467s)
[68.551522] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.542s)
[69.729084] [011/133] (947s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[69.815500] Starting subtest: fbcpsr-stridechange
[76.028867] Subtest fbcpsr-stridechange: SUCCESS (6.215s)
[76.150798] [012/133] (941s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[76.241948] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[76.246240] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[76.343314] [013/133] (941s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[76.420711] Starting subtest: psr2-plane-move-sf-dmg-area
[76.423084] Starting dynamic subtest: pipe-A-eDP-1
[80.921254] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.503s)
[80.930767] Starting dynamic subtest: pipe-B-eDP-1
[86.257491] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.333s)
[86.259842] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.839s)
[87.132789] [014/133] (930s left) kms_cursor_edge_walk (64x64-top-edge)
[87.211419] Starting subtest: 64x64-top-edge
[87.213823] Starting dynamic subtest: pipe-A-eDP-1
[90.703597] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.489s)
[90.713938] Starting dynamic subtest: pipe-D-eDP-1
[93.824864] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.120s)
[93.827251] Subtest 64x64-top-edge: SUCCESS (6.611s)
[94.640617] [015/133] (922s left) vgem_basic (dmabuf-mmap)
[94.716934] Starting subtest: dmabuf-mmap
[94.724343] Subtest dmabuf-mmap: SUCCESS (0.009s)
[94.783983] [FACT vgem_basic (dmabuf-mmap)] new: kernel.kmod_is_loaded.vgem: true
[94.787800] [016/133] (922s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[94.861122] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[94.863356] Starting dynamic subtest: pipe-A
[94.925879] Dynamic subtest pipe-A: SUCCESS (0.066s)
[94.934127] Starting dynamic subtest: pipe-B
[96.068576] Dynamic subtest pipe-B: SUCCESS (1.142s)
[96.078008] Starting dynamic subtest: pipe-C
[97.185457] Dynamic subtest pipe-C: SUCCESS (1.116s)
[97.195185] Starting dynamic subtest: pipe-D
[98.319566] Dynamic subtest pipe-D: SUCCESS (1.133s)
[98.321998] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.459s)
[99.494696] [017/133] (918s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[99.568882] Starting subtest: bad-rotation-90-yf-tiled-ccs
[99.571183] Starting dynamic subtest: pipe-A-eDP-1
[99.594600] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[99.604385] Starting dynamic subtest: pipe-B-eDP-1
[99.625847] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[99.633855] Starting dynamic subtest: pipe-C-eDP-1
[99.655064] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[99.662613] Starting dynamic subtest: pipe-D-eDP-1
[99.683664] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[99.687782] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.003s)
[101.843609] [018/133] (915s left) gem_ctx_exec (basic)
[101.895023] Starting subtest: basic
[101.899618] Subtest basic: SUCCESS (0.005s)
[102.019288] [019/133] (915s left) gem_exec_schedule (pi-shared-iova)
[102.199725] Starting subtest: pi-shared-iova
[102.202225] Starting dynamic subtest: rcs0
[102.269937] Dynamic subtest rcs0: SUCCESS (0.074s)
[102.279425] Starting dynamic subtest: vcs0
[102.332052] Dynamic subtest vcs0: SUCCESS (0.062s)
[102.342376] Starting dynamic subtest: vcs1
[102.382611] Dynamic subtest vcs1: SUCCESS (0.050s)
[102.397803] Starting dynamic subtest: vecs0
[102.439641] Dynamic subtest vecs0: SUCCESS (0.057s)
[102.449031] Starting dynamic subtest: ccs0
[102.495082] Dynamic subtest ccs0: SUCCESS (0.055s)
[102.497464] Subtest pi-shared-iova: SUCCESS (0.300s)
[104.341620] [020/133] (913s left) device_reset (unbind-reset-rebind)
[104.393724] Starting subtest: unbind-reset-rebind
[109.269562] Subtest unbind-reset-rebind: SUCCESS (4.870s)
[109.309051] [021/133] (908s left) syncobj_timeline (wait-all-snapshot)
[109.366381] Starting subtest: wait-all-snapshot
[109.446971] Subtest wait-all-snapshot: SUCCESS (0.082s)
[109.522326] [022/133] (908s left) gem_mmap_gtt (medium-copy-xy)
[109.582584] Subtest medium-copy-XY: SKIP (0.000s)
[109.646610] [023/133] (908s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[109.704411] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[109.706794] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[109.810987] [024/133] (908s left) perf_pmu (busy-check-all)
[109.850726] Starting subtest: busy-check-all
[109.853094] Starting dynamic subtest: rcs0
[110.423894] Dynamic subtest rcs0: SUCCESS (0.573s)
[110.437283] Starting dynamic subtest: bcs0
[110.975409] Dynamic subtest bcs0: SUCCESS (0.550s)
[110.988147] Starting dynamic subtest: vcs0
[112.255110] Dynamic subtest vcs0: SUCCESS (1.276s)
[112.270072] Starting dynamic subtest: vcs1
[114.238230] Dynamic subtest vcs1: SUCCESS (1.982s)
[114.248387] Starting dynamic subtest: vecs0
[116.223289] Dynamic subtest vecs0: SUCCESS (1.983s)
[116.236359] Starting dynamic subtest: ccs0
[116.779377] Dynamic subtest ccs0: SUCCESS (0.556s)
[116.781784] Subtest busy-check-all: SUCCESS (6.930s)
[116.900312] [025/133] (901s left) syncobj_timeline (invalid-query-illegal-handle)
[116.950225] Starting subtest: invalid-query-illegal-handle
[116.952620] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[117.039414] [026/133] (900s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[117.150418] Starting subtest: cursorA-vs-flipA-atomic-transitions
[128.351291] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.199s)
[129.158413] [027/133] (888s left) gem_tiled_swapping (non-threaded)
[129.213767] Subtest non-threaded: SKIP (0.000s)
[129.275997] [028/133] (888s left) kms_plane_multiple (tiling-x)
[129.354154] Starting subtest: tiling-x
[129.356151] Starting dynamic subtest: pipe-A-eDP-1
[133.084841] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.731s)
[133.094135] Starting dynamic subtest: pipe-B-eDP-1
[137.545885] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.461s)
[137.555406] Starting dynamic subtest: pipe-C-eDP-1
[141.883416] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.333s)
[141.893219] Starting dynamic subtest: pipe-D-eDP-1
[146.240092] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.356s)
[146.242313] Subtest tiling-x: SUCCESS (16.886s)
[147.064339] [029/133] (871s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[147.156529] Starting subtest: yf-tiled-16bpp-rotate-270
[147.160497] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[147.254161] [030/133] (870s left) kms_psr (pr-cursor-mmap-cpu)
[147.327953] Starting subtest: pr-cursor-mmap-cpu
[147.332608] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[147.416187] [031/133] (870s left) gem_ctx_param (invalid-get-ringsize)
[147.465831] Starting subtest: invalid-get-ringsize
[147.468252] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[147.580817] [032/133] (870s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[147.659314] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[154.262485] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.605s)
[154.387585] [033/133] (863s left) gem_exec_whisper (basic-fds-all)
[154.449584] Starting subtest: basic-fds-all
[166.176702] Subtest basic-fds-all: SUCCESS (11.723s)
[166.371786] [034/133] (851s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[166.458679] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[166.462884] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[166.568272] [035/133] (851s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[166.632531] Starting subtest: invalid-multi-wait-unsubmitted
[166.634446] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[166.728293] [036/133] (851s left) gem_mmap_offset (close-race)
[166.779727] Starting subtest: close-race
[186.883526] Subtest close-race: SUCCESS (20.104s)
[187.033040] [037/133] (831s left) kms_psr (psr-cursor-render)
[187.106782] Starting subtest: psr-cursor-render
[187.108990] Starting dynamic subtest: eDP-1
[188.866814] Dynamic subtest eDP-1: SUCCESS (1.759s)
[188.869279] Subtest psr-cursor-render: SUCCESS (1.760s)
[189.734591] [038/133] (828s left) perf_pmu (interrupts)
[189.774618] Starting subtest: interrupts
[190.870340] Subtest interrupts: SUCCESS (1.094s)
[190.999681] [039/133] (827s left) api_intel_allocator (alloc-simple)
[191.048134] Starting subtest: alloc-simple
[191.050566] Subtest alloc-simple: SUCCESS (0.003s)
[191.166079] [040/133] (827s left) kms_psr (psr-primary-blt)
[191.238203] Starting subtest: psr-primary-blt
[191.240717] Starting dynamic subtest: eDP-1
[192.940256] Dynamic subtest eDP-1: SUCCESS (1.702s)
[192.942541] Subtest psr-primary-blt: SUCCESS (1.703s)
[193.811430] [041/133] (824s left) kms_cursor_crc (cursor-random-512x170)
[194.075873] Starting subtest: cursor-random-512x170
[194.080287] Subtest cursor-random-512x170: SKIP (0.001s)
[194.209365] [042/133] (824s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[194.265588] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[194.371710] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.105s)
[194.446925] [043/133] (824s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[196.362461] Starting subtest: gem-execbuf-stress-pc8
[196.409809] Subtest gem-execbuf-stress-pc8: SKIP (0.048s)
[196.739620] [044/133] (821s left) gem_reg_read (bad-register)
[196.784218] Starting subtest: bad-register
[196.786394] Subtest bad-register: SUCCESS (0.000s)
[196.888283] [045/133] (821s left) gem_mmap_gtt (basic-small-copy-odd)
[196.938535] Subtest basic-small-copy-odd: SKIP (0.000s)
[196.996702] [046/133] (821s left) i915_hangman (gt-engine-hang)
[197.053843] Starting subtest: gt-engine-hang
[197.056111] Starting dynamic subtest: rcs0
[198.173337] Dynamic subtest rcs0: SUCCESS (1.119s)
[198.185456] Starting dynamic subtest: bcs0
[200.222215] Dynamic subtest bcs0: SUCCESS (2.046s)
[200.235186] Starting dynamic subtest: vcs0
[202.204431] Dynamic subtest vcs0: SUCCESS (1.979s)
[202.218105] Starting dynamic subtest: vcs1
[204.188903] Dynamic subtest vcs1: SUCCESS (1.983s)
[204.201314] Starting dynamic subtest: vecs0
[206.174650] Dynamic subtest vecs0: SUCCESS (1.982s)
[206.186729] Starting dynamic subtest: ccs0
[208.220845] Dynamic subtest ccs0: SUCCESS (2.044s)
[208.223492] Subtest gt-engine-hang: SUCCESS (11.168s)
[208.320737] [047/133] (810s left) fbdev (pan)
[208.355656] Starting subtest: pan
[208.389467] Subtest pan: SUCCESS (0.034s)
[208.460161] [048/133] (810s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[208.536742] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[209.631597] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: FAIL (0.495s)
[209.672648] [049/133] (809s left) prime_self_import (basic-with_one_bo)
[209.708504] Starting subtest: basic-with_one_bo
[209.721794] Subtest basic-with_one_bo: SUCCESS (0.017s)
[209.851177] [050/133] (809s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[209.934029] Starting subtest: 2x-flip-vs-modeset-vs-hang
[209.937573] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.001s)
[210.049394] [051/133] (808s left) kms_flip (2x-flip-vs-suspend)
[210.131057] Starting subtest: 2x-flip-vs-suspend
[210.134673] Subtest 2x-flip-vs-suspend: SKIP (0.003s)
[210.245819] [052/133] (808s left) i915_query (query-garbage)
[210.296096] Starting subtest: query-garbage
[210.298104] Subtest query-garbage: SUCCESS (0.000s)
[210.397268] [053/133] (808s left) kms_pm_dc (dc5-retention-flops)
[211.482769] Starting subtest: dc5-retention-flops
[211.486868] Subtest dc5-retention-flops: SKIP (0.000s)
[211.567414] [054/133] (807s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[211.650426] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[211.654877] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[211.744801] [055/133] (807s left) kms_atomic_interruptible (legacy-dpms)
[211.822929] Starting subtest: legacy-dpms
[211.825224] Starting dynamic subtest: pipe-A-eDP-1
[219.274076] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.449s)
[219.276284] Subtest legacy-dpms: SUCCESS (7.451s)
[220.097711] [056/133] (799s left) gem_basic (create-close)
[220.148804] Starting subtest: create-close
[220.153063] Subtest create-close: SUCCESS (0.000s)
[220.262361] [057/133] (798s left) sysfs_timeslice_duration (idempotent)
[220.329629] Starting subtest: idempotent
[220.331809] Starting dynamic subtest: vecs0
[220.334070] Dynamic subtest vecs0: SUCCESS (0.000s)
[220.343701] Starting dynamic subtest: ccs0
[220.345599] Dynamic subtest ccs0: SUCCESS (0.000s)
[220.355336] Starting dynamic subtest: vcs0
[220.357534] Dynamic subtest vcs0: SUCCESS (0.001s)
[220.366814] Starting dynamic subtest: bcs0
[220.368682] Dynamic subtest bcs0: SUCCESS (0.000s)
[220.377775] Starting dynamic subtest: rcs0
[220.379648] Dynamic subtest rcs0: SUCCESS (0.000s)
[220.388450] Starting dynamic subtest: vcs1
[220.390312] Dynamic subtest vcs1: SUCCESS (0.000s)
[220.392187] Subtest idempotent: SUCCESS (0.006s)
[220.429303] [058/133] (798s left) kms_cursor_crc (cursor-offscreen-128x128)
[220.611621] Starting subtest: cursor-offscreen-128x128
[220.613792] Starting dynamic subtest: pipe-A-eDP-1
[222.573772] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.959s)
[222.603839] Starting dynamic subtest: pipe-D-eDP-1
[225.199030] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.603s)
[225.201508] Subtest cursor-offscreen-128x128: SUCCESS (4.589s)
[226.079226] [059/133] (793s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[226.155078] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[226.159062] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[226.242511] [060/133] (793s left) gem_pxp (regular-baseline-src-copy-readible)
[226.356447] Starting subtest: regular-baseline-src-copy-readible
[226.438763] Subtest regular-baseline-src-copy-readible: SUCCESS (0.084s)
[226.573749] [061/133] (792s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[226.655112] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[226.659456] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[226.722570] [062/133] (792s left) gem_exec_schedule (fairslice)
[226.786032] Starting subtest: fairslice
[226.788353] Starting dynamic subtest: rcs0
[228.798684] Dynamic subtest rcs0: SUCCESS (2.020s)
[228.809789] Starting dynamic subtest: bcs0
[230.817120] Dynamic subtest bcs0: SUCCESS (2.017s)
[230.826790] Starting dynamic subtest: vcs0
[232.836223] Dynamic subtest vcs0: SUCCESS (2.017s)
[232.846395] Starting dynamic subtest: vcs1
[234.875623] Dynamic subtest vcs1: SUCCESS (2.019s)
[234.887052] Starting dynamic subtest: vecs0
[236.873718] Dynamic subtest vecs0: SUCCESS (2.016s)
[236.884501] Starting dynamic subtest: ccs0
[238.894438] Dynamic subtest ccs0: SUCCESS (2.020s)
[238.896358] Subtest fairslice: SUCCESS (12.115s)
[239.194272] [063/133] (780s left) kms_frontbuffer_tracking (psr-2p-rte)
[239.271191] Starting subtest: psr-2p-rte
[239.275474] Subtest psr-2p-rte: SKIP (0.000s)
[239.372750] [064/133] (780s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[239.444229] Starting subtest: plane-lut1d-pre-ctm3x4
[239.590642] Starting dynamic subtest: pipe-A-plane-0
[239.756891] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[239.769542] Starting dynamic subtest: pipe-A-plane-1
[239.946603] Dynamic subtest pipe-A-plane-1: SUCCESS (0.189s)
[239.956954] Starting dynamic subtest: pipe-A-plane-2
[240.112786] Dynamic subtest pipe-A-plane-2: SUCCESS (0.165s)
[241.269778] Starting dynamic subtest: pipe-B-plane-0
[241.426513] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[241.437572] Starting dynamic subtest: pipe-B-plane-1
[241.582094] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s)
[241.592671] Starting dynamic subtest: pipe-B-plane-2
[241.782255] Dynamic subtest pipe-B-plane-2: SUCCESS (0.199s)
[242.999879] Starting dynamic subtest: pipe-C-plane-0
[243.124499] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[243.134660] Starting dynamic subtest: pipe-C-plane-1
[243.257514] Dynamic subtest pipe-C-plane-1: SUCCESS (0.132s)
[243.267750] Starting dynamic subtest: pipe-C-plane-2
[243.391267] Dynamic subtest pipe-C-plane-2: SUCCESS (0.132s)
[244.614986] Starting dynamic subtest: pipe-D-plane-0
[244.772835] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s)
[244.786525] Starting dynamic subtest: pipe-D-plane-1
[244.917480] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[244.928184] Starting dynamic subtest: pipe-D-plane-2
[245.050647] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s)
[245.336535] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (5.892s)
[246.190996] [065/133] (773s left) gem_exec_balancer (semaphore)
[246.248109] Starting subtest: semaphore
[248.254089] Subtest semaphore: SUCCESS (2.005s)
[248.538896] [066/133] (771s left) kms_content_protection (dp-mst-type-0)
[248.659951] Starting subtest: dp-mst-type-0
[248.664550] Subtest dp-mst-type-0: SKIP (0.000s)
[248.801340] [067/133] (770s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[248.885886] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[248.890187] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[248.979200] [068/133] (770s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[249.091124] Starting subtest: 2x-flip-vs-cursor-atomic
[249.095389] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[249.236438] [069/133] (770s left) kms_lease (lease-invalid-crtc)
[249.312479] Starting subtest: lease-invalid-crtc
[249.314815] Starting dynamic subtest: pipe-A-eDP-1
[249.317454] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[249.331611] Starting dynamic subtest: pipe-B-eDP-1
[249.333686] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[249.343290] Starting dynamic subtest: pipe-C-eDP-1
[249.345075] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[249.354244] Starting dynamic subtest: pipe-D-eDP-1
[249.356104] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[249.357892] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[249.396906] [070/133] (770s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[249.493284] Starting subtest: cursor-vs-flip-atomic-transitions
[279.690873] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.193s)
[280.543596] [071/133] (739s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[280.592969] Starting subtest: yf-tiled-to-vebox-y-tiled
[280.597458] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[280.775695] [072/133] (739s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[280.854991] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[280.857687] Starting dynamic subtest: pipe-A-default-mode
[281.976384] Dynamic subtest pipe-A-default-mode: SKIP (1.119s)
[281.980801] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.120s)
[282.138809] [073/133] (737s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[282.191335] Starting subtest: etime-single-wait-available-unsubmitted
[282.298487] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.107s)
[282.376906] [074/133] (737s left) kms_chamelium_color (ctm-0-50)
[282.449438] Subtest ctm-0-50: SKIP (0.000s)
[282.494723] [075/133] (737s left) kms_invalid_mode (overflow-vrefresh)
[282.576649] Starting subtest: overflow-vrefresh
[282.579015] Starting dynamic subtest: pipe-A-eDP-1
[282.859901] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[282.870326] Starting dynamic subtest: pipe-B-eDP-1
[282.872302] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[282.881522] Starting dynamic subtest: pipe-C-eDP-1
[282.883912] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[282.893561] Starting dynamic subtest: pipe-D-eDP-1
[282.895812] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[282.898069] Subtest overflow-vrefresh: SUCCESS (0.293s)
[283.681497] [076/133] (736s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[283.774428] Starting subtest: psr-1p-primscrn-spr-indfb-move
[291.221942] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.451s)
[291.358465] [077/133] (728s left) gem_create (hog-create)
[291.417330] Starting subtest: hog-create
[291.419632] Starting dynamic subtest: smem0
[325.229832] Dynamic subtest smem0: SUCCESS (33.809s)
[325.232687] Subtest hog-create: SUCCESS (33.811s)
[325.430202] [078/133] (694s left) gem_unref_active_buffers
[325.645255] [079/133] (694s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[325.724412] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[325.728711] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[325.821501] [080/133] (694s left) kms_big_fb (y-tiled-addfb-size-overflow)
[325.904935] Starting subtest: y-tiled-addfb-size-overflow
[325.909600] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[326.023297] [081/133] (694s left) gem_exec_reloc (basic-write-cpu-active)
[326.089643] Subtest basic-write-cpu-active: SKIP (0.000s)
[326.168754] [082/133] (694s left) kms_pm_rpm (legacy-planes-dpms)
[328.390983] Starting subtest: legacy-planes-dpms
[328.393093] Starting dynamic subtest: plane-65
[336.685975] Dynamic subtest plane-65: SUCCESS (8.296s)
[336.700187] Starting dynamic subtest: plane-95
[344.985934] Dynamic subtest plane-95: SUCCESS (8.297s)
[344.999652] Starting dynamic subtest: plane-125
[353.280103] Dynamic subtest plane-125: SUCCESS (8.292s)
[353.292553] Starting dynamic subtest: plane-135
[361.569406] Dynamic subtest plane-135: SUCCESS (8.286s)
[361.572312] Subtest legacy-planes-dpms: SUCCESS (33.181s)
[361.942347] [083/133] (658s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[362.021053] Starting subtest: disable-crc-after-crtc
[362.023332] Starting dynamic subtest: pipe-A-eDP-1
[363.688993] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.665s)
[363.700113] Starting dynamic subtest: pipe-B-eDP-1
[365.940404] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.253s)
[365.952070] Starting dynamic subtest: pipe-C-eDP-1
[368.207891] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.267s)
[368.218739] Starting dynamic subtest: pipe-D-eDP-1
[370.441512] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.232s)
[370.443724] Subtest disable-crc-after-crtc: SUCCESS (8.422s)
[371.280792] [084/133] (649s left) prime_udl
[371.397891] [085/133] (649s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[371.474443] Starting subtest: fbcpsr-modesetfrombusy
[377.673047] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.204s)
[377.822670] [086/133] (642s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[377.902590] Starting subtest: x-tiled-8bpp-rotate-270
[377.922960] Subtest x-tiled-8bpp-rotate-270: SKIP (0.020s)
[378.048332] [087/133] (642s left) gem_exec_fence (syncobj-repeat)
[378.500677] Starting subtest: syncobj-repeat
[378.682561] Subtest syncobj-repeat: SUCCESS (0.183s)
[380.298385] [088/133] (640s left) gem_softpin (zero)
[380.347620] Starting subtest: zero
[380.351884] Subtest zero: SUCCESS (0.004s)
[380.492923] [089/133] (640s left) gem_ctx_persistence (heartbeat-hostile)
[380.545182] Starting subtest: heartbeat-hostile
[380.549822] Subtest heartbeat-hostile: SKIP (0.000s)
[380.641112] [090/133] (640s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[380.718176] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[380.722199] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[380.830327] [091/133] (639s left) kms_chamelium_frames (hdmi-crc-multiple)
[381.215462] Subtest hdmi-crc-multiple: SKIP (0.000s)
[382.059338] [092/133] (638s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[382.135186] Starting subtest: async-flip-with-page-flip-events-linear
[382.527528] Starting dynamic subtest: pipe-A-eDP-1
[385.257546] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.730s)
[385.630566] Starting dynamic subtest: pipe-B-eDP-1
[388.377425] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.762s)
[388.750727] Starting dynamic subtest: pipe-C-eDP-1
[391.504323] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.761s)
[391.866951] Starting dynamic subtest: pipe-D-eDP-1
[394.631463] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.772s)
[394.634199] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.497s)
[395.830403] [093/133] (624s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[395.914344] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[395.918418] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[395.986172] [094/133] (624s left) gem_exec_params (secure-non-master)
[396.029956] Starting subtest: secure-non-master
[396.034602] Subtest secure-non-master: SKIP (0.000s)
[396.151784] [095/133] (624s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[396.227578] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[396.232077] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[396.319314] [096/133] (624s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[396.413784] Starting subtest: fbc-rgb101010-draw-render
[401.032265] Subtest fbc-rgb101010-draw-render: SUCCESS (4.623s)
[402.220631] [097/133] (618s left) api_intel_bb (reset-flags)
[402.279281] Starting subtest: reset-flags
[402.286266] Subtest reset-flags: SUCCESS (0.009s)
[402.401336] [098/133] (618s left) syncobj_wait (single-wait-submitted)
[402.452051] Starting subtest: single-wait-submitted
[402.553518] Subtest single-wait-submitted: SUCCESS (0.101s)
[402.636097] [099/133] (618s left) i915_query (engine-info)
[402.692036] Starting subtest: engine-info
[402.694618] Subtest engine-info: SUCCESS (0.004s)
[402.814362] [100/133] (618s left) perf_pmu (all-busy-check-all)
[402.851867] Starting subtest: all-busy-check-all
[404.223194] Subtest all-busy-check-all: SUCCESS (1.372s)
[404.316335] [101/133] (616s left) syncobj_basic (bad-flags-fd-to-handle)
[404.380941] Starting subtest: bad-flags-fd-to-handle
[404.383369] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[404.484992] [102/133] (616s left) gem_exec_schedule (u-submit-golden-slice)
[404.549598] Starting subtest: u-submit-golden-slice
[404.551748] Starting dynamic subtest: rcs0
[404.577714] Dynamic subtest rcs0: SUCCESS (0.036s)
[404.589020] Starting dynamic subtest: bcs0
[404.604579] Dynamic subtest bcs0: SUCCESS (0.026s)
[404.615374] Starting dynamic subtest: vcs0
[404.635533] Dynamic subtest vcs0: SUCCESS (0.030s)
[404.646191] Starting dynamic subtest: vcs1
[404.664592] Dynamic subtest vcs1: SUCCESS (0.028s)
[404.675404] Starting dynamic subtest: vecs0
[404.692500] Dynamic subtest vecs0: SUCCESS (0.026s)
[404.702516] Starting dynamic subtest: ccs0
[404.730478] Dynamic subtest ccs0: SUCCESS (0.037s)
[404.732786] Subtest u-submit-golden-slice: SUCCESS (0.189s)
[406.295422] [103/133] (614s left) i915_drm_fdinfo (memory-info-shared)
[406.336709] Starting subtest: memory-info-shared
[406.339230] Starting dynamic subtest: smem0
[406.386544] Dynamic subtest smem0: SUCCESS (0.051s)
[406.389371] Subtest memory-info-shared: SUCCESS (0.052s)
[406.464046] [104/133] (614s left) gem_mmap_wc (write-read-distinct)
[406.515102] Subtest write-read-distinct: SKIP (0.000s)
[406.584781] [105/133] (614s left) kms_selftest (drm_damage_helper)
[406.622342] Starting subtest: drm_damage_helper
[406.637800] Starting dynamic subtest: drm_test_damage_iter_no_damage
[406.738096] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.100s)
[406.749451] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[406.829739] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.091s)
[406.841042] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[406.936431] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.105s)
[406.946265] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[407.042196] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.104s)
[407.054443] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[407.140392] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.098s)
[407.151997] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[407.242507] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.101s)
[407.253489] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[407.359119] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.114s)
[407.370650] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[407.456211] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.097s)
[407.466281] Starting dynamic subtest: drm_test_damage_iter_single_damage
[407.553257] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.094s)
[407.562846] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[407.650731] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.096s)
[407.661758] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[407.743787] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.092s)
[407.759413] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[407.825436] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.082s)
[407.837394] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[407.920072] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.094s)
[407.931274] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[408.012198] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.091s)
[408.022115] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[408.114105] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.100s)
[408.124982] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[408.216044] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.100s)
[408.225762] Starting dynamic subtest: drm_test_damage_iter_damage
[408.308768] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.091s)
[408.319332] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[408.402540] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.093s)
[408.412198] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[408.507263] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.102s)
[408.517243] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[408.602725] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.095s)
[408.611774] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[408.701291] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.098s)
[408.702916] Subtest drm_damage_helper: SUCCESS (2.078s)
[408.850147] [106/133] (612s left) prime_mmap (test_correct_cpu_write)
[408.895512] Starting subtest: test_correct_cpu_write
[408.897556] Starting dynamic subtest: test_correct_cpu_write-smem
[408.899240] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[408.900938] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[408.985168] [107/133] (612s left) gen9_exec_parse (secure-batches)
[409.052900] Subtest secure-batches: SKIP (0.000s)
[409.129933] [108/133] (612s left) kms_atomic (plane-immutable-zpos)
[409.202282] Starting subtest: plane-immutable-zpos
[409.204254] Starting dynamic subtest: pipe-A-eDP-1
[409.871543] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.666s)
[409.876294] Subtest plane-immutable-zpos: SUCCESS (0.668s)
[410.747487] [109/133] (610s left) gem_exec_nop (basic-parallel)
[410.811172] Starting subtest: basic-parallel
[427.263058] Subtest basic-parallel: SUCCESS (16.462s)
[427.496024] [110/133] (593s left) kms_psr (fbc-psr-sprite-render)
[427.583437] Starting subtest: fbc-psr-sprite-render
[427.585726] Starting dynamic subtest: eDP-1
[427.590246] Dynamic subtest eDP-1: SKIP (0.000s)
[427.594758] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[427.659803] [111/133] (593s left) gem_fenced_exec_thrash (2-spare-fences)
[427.716971] Subtest 2-spare-fences: SKIP (0.000s)
[427.790513] [112/133] (593s left) perf_pmu (idle)
[427.832249] Starting subtest: idle
[427.834596] Starting dynamic subtest: rcs0
[428.383437] Dynamic subtest rcs0: SUCCESS (0.551s)
[428.396506] Starting dynamic subtest: bcs0
[428.902477] Dynamic subtest bcs0: SUCCESS (0.516s)
[428.913530] Starting dynamic subtest: vcs0
[429.428992] Dynamic subtest vcs0: SUCCESS (0.524s)
[429.441226] Starting dynamic subtest: vcs1
[429.958932] Dynamic subtest vcs1: SUCCESS (0.524s)
[429.970614] Starting dynamic subtest: vecs0
[430.484556] Dynamic subtest vecs0: SUCCESS (0.527s)
[430.498526] Starting dynamic subtest: ccs0
[431.005983] Dynamic subtest ccs0: SUCCESS (0.515s)
[431.008617] Subtest idle: SUCCESS (3.172s)
[431.117871] [113/133] (590s left) kms_vblank (wait-busy-hang)
[431.206082] Starting subtest: wait-busy-hang
[431.208318] Starting dynamic subtest: pipe-A-eDP-1
[458.055385] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.846s)
[458.072598] Starting dynamic subtest: pipe-D-eDP-1
[473.028133] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.972s)
[473.030483] Subtest wait-busy-hang: SUCCESS (41.822s)
[473.896939] [114/133] (547s left) gem_exec_balancer (noheartbeat)
[474.146567] Starting subtest: noheartbeat
[474.151158] Subtest noheartbeat: SKIP (0.000s)
[474.248855] [115/133] (547s left) kms_hdr (brightness-with-hdr)
[474.324200] Starting subtest: brightness-with-hdr
[474.330829] Subtest brightness-with-hdr: SKIP (0.000s)
[474.397505] [116/133] (547s left) kms_flip (blocking-wf_vblank)
[474.470251] Starting subtest: blocking-wf_vblank
[474.472644] Starting dynamic subtest: A-eDP1
[483.432616] Dynamic subtest A-eDP1: SUCCESS (8.962s)
[483.445803] Starting dynamic subtest: B-eDP1
[492.366248] Dynamic subtest B-eDP1: SUCCESS (8.931s)
[492.379080] Starting dynamic subtest: C-eDP1
[501.291772] Dynamic subtest C-eDP1: SUCCESS (8.923s)
[501.303957] Starting dynamic subtest: D-eDP1
[510.215537] Dynamic subtest D-eDP1: SUCCESS (8.923s)
[510.221601] Subtest blocking-wf_vblank: SUCCESS (35.751s)
[511.452985] [117/133] (510s left) kms_plane (pixel-format-linear-modifier-source-clamping)
[511.526447] Starting subtest: pixel-format-linear-modifier-source-clamping
[511.553347] Starting dynamic subtest: pipe-A-plane-0
[512.152813] Dynamic subtest pipe-A-plane-0: SUCCESS (0.599s)
[512.163392] Starting dynamic subtest: pipe-A-plane-3
[512.597747] Dynamic subtest pipe-A-plane-3: SUCCESS (0.444s)
[513.735019] Starting dynamic subtest: pipe-B-plane-0
[514.326072] Dynamic subtest pipe-B-plane-0: SUCCESS (0.600s)
[514.336667] Starting dynamic subtest: pipe-B-plane-3
[514.758981] Dynamic subtest pipe-B-plane-3: SUCCESS (0.432s)
[515.075993] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (3.549s)
[515.905657] [118/133] (505s left) gem_lmem_swapping (heavy-verify-multi)
[515.949685] Subtest heavy-verify-multi: SKIP (0.000s)
[515.997196] [119/133] (505s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[516.075399] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[520.556616] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.487s)
[521.715869] [120/133] (500s left) kms_big_fb (4-tiled-addfb-size-overflow)
[521.800094] Starting subtest: 4-tiled-addfb-size-overflow
[521.802362] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[521.900903] [121/133] (500s left) gem_vm_create (invalid-create)
[521.949495] Starting subtest: invalid-create
[521.954221] Subtest invalid-create: SUCCESS (0.002s)
[522.072442] [122/133] (499s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[522.140756] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[522.143066] Starting dynamic subtest: pipe-A-eDP-1
[522.167566] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[522.178972] Starting dynamic subtest: pipe-B-eDP-1
[522.201899] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[522.211740] Starting dynamic subtest: pipe-C-eDP-1
[522.235280] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[522.244820] Starting dynamic subtest: pipe-D-eDP-1
[522.269574] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[522.273987] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[524.382458] [123/133] (497s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[524.461207] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[531.561465] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.102s)
[531.698854] [124/133] (490s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[531.768030] Starting subtest: fbc-psr2-cursor-mmap-cpu
[531.770277] Starting dynamic subtest: eDP-1
[531.774108] Dynamic subtest eDP-1: SKIP (0.000s)
[531.778168] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s)
[531.841961] [125/133] (490s left) syncobj_basic (bad-create-flags)
[531.889195] Starting subtest: bad-create-flags
[531.891390] Subtest bad-create-flags: SUCCESS (0.000s)
[531.983882] [126/133] (490s left) perf (enable-disable)
[532.125824] Starting subtest: enable-disable
[532.128089] Starting dynamic subtest: 0-rcs0
[534.372868] Dynamic subtest 0-rcs0: SUCCESS (2.247s)
[534.384762] Starting dynamic subtest: 1-vecs0
[538.819787] Dynamic subtest 1-vecs0: SUCCESS (4.445s)
[538.822368] Subtest enable-disable: SUCCESS (6.694s)
[538.872795] [127/133] (483s left) gem_ctx_shared (q-smoketest)
[538.933843] Starting subtest: Q-smoketest
[538.935807] Starting dynamic subtest: rcs0
[544.469353] Dynamic subtest rcs0: SUCCESS (5.487s)
[544.481870] Starting dynamic subtest: bcs0
[549.987298] Dynamic subtest bcs0: SUCCESS (5.486s)
[550.000133] Starting dynamic subtest: vcs0
[555.438065] Dynamic subtest vcs0: SUCCESS (5.480s)
[555.452973] Starting dynamic subtest: vcs1
[560.930255] Dynamic subtest vcs1: SUCCESS (5.493s)
[560.946525] Starting dynamic subtest: vecs0
[566.413724] Dynamic subtest vecs0: SUCCESS (5.483s)
[566.428740] Starting dynamic subtest: ccs0
[571.875122] Dynamic subtest ccs0: SUCCESS (5.458s)
[571.877050] Subtest Q-smoketest: SUCCESS (32.893s)
[572.029264] [128/133] (450s left) gem_exec_flush (basic-wb-rw-before-default)
[572.094269] Starting subtest: basic-wb-rw-before-default
[577.559163] Subtest basic-wb-rw-before-default: SUCCESS (5.465s)
[577.747322] [129/133] (444s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[577.831832] Starting subtest: psr-rgb565-draw-mmap-wc
[584.592071] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.765s)
[584.693308] [130/133] (437s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[584.777953] Starting subtest: crc-primary-basic-yf-tiled-ccs
[584.780407] Starting dynamic subtest: pipe-A-eDP-1
[584.803742] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[584.816776] Starting dynamic subtest: pipe-B-eDP-1
[584.838232] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[584.848058] Starting dynamic subtest: pipe-C-eDP-1
[584.869701] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[584.879463] Starting dynamic subtest: pipe-D-eDP-1
[584.900992] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[584.905453] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.005s)
[586.997065] [131/133] (435s left) kms_cursor_legacy (forked-move)
[587.098249] Starting subtest: forked-move
[587.100409] Starting dynamic subtest: pipe-A
[592.569072] Dynamic subtest pipe-A: SUCCESS (5.467s)
[592.590950] Starting dynamic subtest: pipe-B
[598.044770] Dynamic subtest pipe-B: SUCCESS (5.473s)
[598.069042] Starting dynamic subtest: pipe-C
[603.522754] Dynamic subtest pipe-C: SUCCESS (5.476s)
[603.545507] Starting dynamic subtest: pipe-D
[608.998423] Dynamic subtest pipe-D: SUCCESS (5.473s)
[609.009445] Starting dynamic subtest: all-pipes
[614.498215] Dynamic subtest all-pipes: SUCCESS (5.497s)
[614.500571] Subtest forked-move: SUCCESS (27.397s)
[614.644678] [132/133] (407s left) prime_vgem (fence-wait)
[614.709778] Starting subtest: fence-wait
[614.712120] Starting dynamic subtest: rcs0
[615.760409] Dynamic subtest rcs0: SUCCESS (1.049s)
[615.772754] Starting dynamic subtest: bcs0
[616.807454] Dynamic subtest bcs0: SUCCESS (1.045s)
[616.820555] Starting dynamic subtest: vcs0
[617.859630] Dynamic subtest vcs0: SUCCESS (1.050s)
[617.871823] Starting dynamic subtest: vcs1
[618.901472] Dynamic subtest vcs1: SUCCESS (1.040s)
[618.913522] Starting dynamic subtest: vecs0
[619.943289] Dynamic subtest vecs0: SUCCESS (1.040s)
[619.955859] Starting dynamic subtest: ccs0
[620.986565] Dynamic subtest ccs0: SUCCESS (1.041s)
[620.989624] Subtest fence-wait: SUCCESS (6.276s)
[621.110237] [133/133] (401s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[621.199018] Starting subtest: 2x-absolute-wf_vblank-interruptible
[621.208775] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.008s)
[621.324824] 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.