[62.682874] Initializing watchdogs
[62.682922]   /dev/watchdog0
[62.697916] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[62.702979] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.705339] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.708631] [001/133] (960s left) gem_exec_reloc (basic-wc-read-noreloc)
[62.789709] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[62.879571] [002/133] (960s left) kms_flip (flip-vs-modeset-vs-hang)
[62.980099] Starting subtest: flip-vs-modeset-vs-hang
[62.982442] Starting dynamic subtest: A-eDP1
[114.416379] Dynamic subtest A-eDP1: SUCCESS (51.382s)
[114.427148] Starting dynamic subtest: D-eDP1
[164.398031] Dynamic subtest D-eDP1: SUCCESS (49.976s)
[164.400700] Subtest flip-vs-modeset-vs-hang: SUCCESS (101.362s)
[164.808556] [003/133] (858s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[164.898993] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[164.901300] Starting dynamic subtest: pipe-A-eDP-1
[164.910165] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[164.918065] Starting dynamic subtest: pipe-B-eDP-1
[164.926684] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[164.933786] Starting dynamic subtest: pipe-C-eDP-1
[164.943060] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[164.952248] Starting dynamic subtest: pipe-D-eDP-1
[164.960737] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[164.965064] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.003s)
[167.069798] [004/133] (856s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[167.175717] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[167.799409] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.625s)
[167.994801] [005/133] (855s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[168.105044] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[168.109599] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[168.209871] [006/133] (855s left) gem_mmap_wc (write)
[168.276865] Subtest write: SKIP (0.000s)
[168.343949] [007/133] (855s left) gem_exec_whisper (basic-forked)
[168.419711] Starting subtest: basic-forked
[174.792392] Subtest basic-forked: SUCCESS (6.370s)
[174.985335] [008/133] (848s left) i915_drm_fdinfo (memory-info-resident)
[175.020499] Starting subtest: memory-info-resident
[175.022544] Starting dynamic subtest: smem0
[177.724822] Dynamic subtest smem0: SUCCESS (2.706s)
[177.727078] Subtest memory-info-resident: SUCCESS (2.706s)
[177.810492] [009/133] (845s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[177.925293] Starting subtest: fbcpsr-rgb101010-draw-blt
[184.733787] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.811s)
[184.889927] [010/133] (838s left) syncobj_wait (invalid-wait-bad-flags)
[184.951709] Starting subtest: invalid-wait-bad-flags
[184.954033] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[185.062751] [011/133] (838s left) kms_flip (2x-dpms-vs-vblank-race)
[185.164139] Starting subtest: 2x-dpms-vs-vblank-race
[185.175606] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s)
[185.303929] [012/133] (838s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[185.403926] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[192.849418] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.448s)
[193.004192] [013/133] (830s left) gem_ctx_param (invalid-set-no-zeromap)
[193.074046] Starting subtest: invalid-set-no-zeromap
[193.076428] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[193.162747] [014/133] (830s left) gem_lmem_swapping (parallel-random)
[193.200325] Subtest parallel-random: SKIP (0.000s)
[193.244231] [015/133] (830s left) kms_scaling_modes (scaling-mode-none)
[193.352313] Starting subtest: scaling-mode-none
[193.354271] Starting dynamic subtest: pipe-A-eDP-1
[193.448784] Dynamic subtest pipe-A-eDP-1: SKIP (0.095s)
[193.459592] Starting dynamic subtest: pipe-B-eDP-1
[193.485710] Dynamic subtest pipe-B-eDP-1: SKIP (0.035s)
[193.494205] Starting dynamic subtest: pipe-C-eDP-1
[193.520463] Dynamic subtest pipe-C-eDP-1: SKIP (0.034s)
[193.528892] Starting dynamic subtest: pipe-D-eDP-1
[193.557458] Dynamic subtest pipe-D-eDP-1: SKIP (0.036s)
[193.561653] Subtest scaling-mode-none: SKIP (0.205s)
[193.716601] [016/133] (830s left) kms_flip (busy-flip)
[193.824915] Starting subtest: busy-flip
[193.826578] Starting dynamic subtest: A-eDP1
[195.520636] Dynamic subtest A-eDP1: SUCCESS (1.696s)
[195.534066] Starting dynamic subtest: B-eDP1
[197.248040] Dynamic subtest B-eDP1: SUCCESS (1.727s)
[197.258670] Starting dynamic subtest: C-eDP1
[198.973531] Dynamic subtest C-eDP1: SUCCESS (1.725s)
[198.984816] Starting dynamic subtest: D-eDP1
[200.614302] Dynamic subtest D-eDP1: SUCCESS (1.639s)
[200.616403] Subtest busy-flip: SUCCESS (6.793s)
[201.878614] [017/133] (821s left) gem_spin_batch (legacy-resubmit-new)
[201.943116] Starting subtest: legacy-resubmit-new
[201.945834] Starting dynamic subtest: default
[201.950858] Dynamic subtest default: SUCCESS (0.007s)
[201.960140] Starting dynamic subtest: render
[201.962306] Dynamic subtest render: SUCCESS (0.003s)
[201.970112] Starting dynamic subtest: bsd
[201.972436] Dynamic subtest bsd: SUCCESS (0.004s)
[201.980474] Starting dynamic subtest: bsd1
[201.982852] Dynamic subtest bsd1: SUCCESS (0.004s)
[201.991282] Starting dynamic subtest: bsd2
[201.993144] Dynamic subtest bsd2: SUCCESS (0.007s)
[202.000150] Starting dynamic subtest: blt
[202.002060] Dynamic subtest blt: SUCCESS (0.007s)
[202.009300] Starting dynamic subtest: vebox
[202.011224] Dynamic subtest vebox: SUCCESS (0.007s)
[202.013084] Subtest legacy-resubmit-new: SUCCESS (0.045s)
[203.973932] [018/133] (819s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[204.071774] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[204.076387] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[204.190514] [019/133] (819s left) syncobj_wait (single-wait-all-for-submit-submitted)
[204.253946] Starting subtest: single-wait-all-for-submit-submitted
[204.361056] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.106s)
[204.458083] [020/133] (819s left) i915_pm_rc6_residency (rc6-accuracy)
[204.519198] Starting subtest: rc6-accuracy
[204.521396] Starting dynamic subtest: gt0
[207.692838] Dynamic subtest gt0: SUCCESS (3.171s)
[207.703278] Starting dynamic subtest: gt1
[210.863872] Dynamic subtest gt1: SUCCESS (3.168s)
[210.866469] Subtest rc6-accuracy: SUCCESS (6.343s)
[210.946205] [021/133] (813s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[211.062495] Starting subtest: 4-tiled-16bpp-rotate-270
[211.081683] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.019s)
[211.238856] [022/133] (812s left) fbdev (write)
[211.279654] Starting subtest: write
[211.641061] Subtest write: SUCCESS (0.359s)
[211.714221] [023/133] (812s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[211.902512] Starting subtest: cursor-rapid-movement-128x128
[211.907440] Starting dynamic subtest: pipe-A-eDP-1
[212.442272] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.536s)
[212.467392] Starting dynamic subtest: pipe-D-eDP-1
[213.673196] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.211s)
[213.675544] Subtest cursor-rapid-movement-128x128: SUCCESS (1.770s)
[214.538980] [024/133] (809s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[214.645267] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[221.938106] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.296s)
[222.137301] [025/133] (801s left) kms_sequence (get-forked)
[222.225971] Starting subtest: get-forked
[222.227839] Starting dynamic subtest: pipe-A-eDP-1
[224.107569] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.879s)
[224.117079] Starting dynamic subtest: pipe-B-eDP-1
[226.698184] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.590s)
[226.706064] Starting dynamic subtest: pipe-C-eDP-1
[229.226211] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.528s)
[229.235066] Starting dynamic subtest: pipe-D-eDP-1
[231.755644] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.527s)
[231.757548] Subtest get-forked: SUCCESS (9.528s)
[232.611789] [026/133] (791s left) core_auth (getclient-simple)
[232.651729] Starting subtest: getclient-simple
[232.676904] Subtest getclient-simple: SUCCESS (0.024s)
[232.796638] [027/133] (791s left) gem_vm_create (isolation)
[232.854221] Starting subtest: isolation
[232.862536] Subtest isolation: SUCCESS (0.008s)
[233.008469] [028/133] (791s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[233.144234] Starting subtest: verify-pxp-key-change-after-suspend-resume
[240.450411] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.307s)
[249.628155] [029/133] (783s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[249.769387] Starting subtest: fbc-pr-cursor-plane-update-sf
[249.773735] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[249.849085] [030/133] (783s left) gem_userptr_blits (sync-overlap)
[249.914738] Starting subtest: sync-overlap
[249.916903] Subtest sync-overlap: SUCCESS (0.000s)
[250.055874] [031/133] (783s left) kms_big_fb (linear-32bpp-rotate-90)
[250.152728] Starting subtest: linear-32bpp-rotate-90
[250.171284] Subtest linear-32bpp-rotate-90: SKIP (0.018s)
[250.328096] [032/133] (783s left) kms_dp_link_training (uhbr-sst)
[250.426885] Starting subtest: uhbr-sst
[250.434258] Subtest uhbr-sst: SKIP (0.000s)
[250.511139] [033/133] (782s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[250.604782] Starting subtest: fbc-pr-cursor-mmap-gtt
[250.609520] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[250.689789] [034/133] (782s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[250.797159] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[250.799162] Starting dynamic subtest: pipe-A-eDP-1
[250.897148] Dynamic subtest pipe-A-eDP-1: SKIP (0.101s)
[250.906114] Starting dynamic subtest: pipe-B-eDP-1
[252.007915] Dynamic subtest pipe-B-eDP-1: SKIP (1.108s)
[252.012429] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.211s)
[253.201624] [035/133] (780s left) gem_exec_fence (syncobj-repeat)
[253.662702] Starting subtest: syncobj-repeat
[253.844102] Subtest syncobj-repeat: SUCCESS (0.180s)
[255.041738] [FACT gem_exec_fence (syncobj-repeat)] new: kernel.kmod_is_loaded.vgem: true
[255.044810] [036/133] (778s left) syncobj_timeline (transfer-timeline-point)
[255.104171] Starting subtest: transfer-timeline-point
[255.106475] Subtest transfer-timeline-point: SUCCESS (0.000s)
[255.232715] [037/133] (778s left) kms_addfb_basic (bad-pitch-0)
[255.296320] Starting subtest: bad-pitch-0
[255.298462] Subtest bad-pitch-0: SUCCESS (0.000s)
[255.463129] [038/133] (778s left) dmabuf_sync_file (import-multiple-read-write)
[255.504304] Starting subtest: import-multiple-read-write
[255.508749] Subtest import-multiple-read-write: SUCCESS (0.005s)
[255.580039] [039/133] (778s left) kms_plane (plane-position-covered)
[255.681909] Starting subtest: plane-position-covered
[256.188502] Starting dynamic subtest: pipe-A-plane-1
[257.490306] Dynamic subtest pipe-A-plane-1: SUCCESS (1.302s)
[257.500588] Starting dynamic subtest: pipe-A-plane-2
[258.780211] Dynamic subtest pipe-A-plane-2: SUCCESS (1.290s)
[258.791635] Starting dynamic subtest: pipe-A-plane-3
[260.010400] Dynamic subtest pipe-A-plane-3: SUCCESS (1.231s)
[260.020982] Starting dynamic subtest: pipe-A-plane-4
[261.244950] Dynamic subtest pipe-A-plane-4: SUCCESS (1.235s)
[261.255418] Starting dynamic subtest: pipe-A-plane-5
[261.271162] Dynamic subtest pipe-A-plane-5: SUCCESS (0.022s)
[262.387813] Starting dynamic subtest: pipe-B-plane-1
[263.622972] Dynamic subtest pipe-B-plane-1: SUCCESS (1.239s)
[263.631973] Starting dynamic subtest: pipe-B-plane-2
[264.846120] Dynamic subtest pipe-B-plane-2: SUCCESS (1.223s)
[264.856066] Starting dynamic subtest: pipe-B-plane-3
[266.078140] Dynamic subtest pipe-B-plane-3: SUCCESS (1.233s)
[266.088408] Starting dynamic subtest: pipe-B-plane-4
[267.315289] Dynamic subtest pipe-B-plane-4: SUCCESS (1.237s)
[267.325724] Starting dynamic subtest: pipe-B-plane-5
[267.344889] Dynamic subtest pipe-B-plane-5: SUCCESS (0.027s)
[267.347130] Subtest plane-position-covered: SUCCESS (11.664s)
[268.143335] [040/133] (765s left) kms_addfb_basic (invalid-get-prop)
[268.203113] Starting subtest: invalid-get-prop
[268.205330] Subtest invalid-get-prop: SUCCESS (0.000s)
[268.339758] [041/133] (765s left) kms_plane_alpha_blend (coverage-7efc)
[268.433278] Starting subtest: coverage-7efc
[268.722460] Starting dynamic subtest: pipe-A-eDP-1
[269.287256] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.562s)
[269.310872] Starting dynamic subtest: pipe-D-eDP-1
[270.622754] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.319s)
[270.625129] Subtest coverage-7efc: SUCCESS (2.189s)
[271.502188] [042/133] (762s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[271.599938] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[271.604385] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[271.738331] [043/133] (762s left) kms_flip (flip-vs-expired-vblank)
[271.837092] Starting subtest: flip-vs-expired-vblank
[271.838957] Starting dynamic subtest: A-eDP1
[280.495095] Dynamic subtest A-eDP1: SUCCESS (8.660s)
[280.505474] Starting dynamic subtest: B-eDP1
[289.125269] Dynamic subtest B-eDP1: SUCCESS (8.628s)
[289.135939] Starting dynamic subtest: C-eDP1
[297.759045] Dynamic subtest C-eDP1: SUCCESS (8.632s)
[297.776552] Starting dynamic subtest: D-eDP1
[306.381748] Dynamic subtest D-eDP1: SUCCESS (8.620s)
[306.387519] Subtest flip-vs-expired-vblank: SUCCESS (34.554s)
[307.581389] [044/133] (726s left) perf_pmu (pmu-read)
[307.629405] Starting subtest: pmu-read
[307.631715] Subtest pmu-read: SUCCESS (0.003s)
[307.762827] [045/133] (726s left) kms_lease (master-vs-lease)
[307.852076] Starting subtest: master-vs-lease
[307.854316] Subtest master-vs-lease: SUCCESS (0.002s)
[308.001444] [046/133] (725s left) kms_prime (basic-modeset-hybrid)
[308.083533] Subtest basic-modeset-hybrid: SKIP (0.000s)
[308.176842] [047/133] (725s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[308.317950] Starting subtest: cursor-vs-flip-toggle
[339.140501] Subtest cursor-vs-flip-toggle: SUCCESS (30.820s)
[340.018045] [048/133] (694s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[340.077436] Starting subtest: multi-wait-all-for-submit-signaled
[340.079787] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[340.225951] [049/133] (693s left) kms_atomic_interruptible (legacy-pageflip)
[340.321268] Starting subtest: legacy-pageflip
[340.323561] Starting dynamic subtest: pipe-A-eDP-1
[347.708340] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.384s)
[347.710538] Subtest legacy-pageflip: SUCCESS (7.386s)
[348.556035] [050/133] (685s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[348.656830] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[348.659066] Starting dynamic subtest: pipe-A-eDP-1
[348.714486] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[348.724804] Starting dynamic subtest: pipe-B-eDP-1
[348.781360] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[348.791858] Starting dynamic subtest: pipe-C-eDP-1
[348.847988] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[348.857035] Starting dynamic subtest: pipe-D-eDP-1
[348.912561] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[348.916792] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.009s)
[350.921448] [051/133] (683s left) kms_flip (2x-plain-flip-interruptible)
[351.019676] Starting subtest: 2x-plain-flip-interruptible
[351.032930] Subtest 2x-plain-flip-interruptible: SKIP (0.011s)
[351.120624] [052/133] (683s left) kms_psr (psr2-cursor-mmap-cpu)
[351.209823] Starting subtest: psr2-cursor-mmap-cpu
[351.212082] Starting dynamic subtest: eDP-1
[352.875070] Dynamic subtest eDP-1: SUCCESS (1.664s)
[352.877402] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.666s)
[353.684154] [053/133] (680s left) gem_fence_thrash (bo-write-verify-y)
[353.720351] Starting subtest: bo-write-verify-y
[353.736867] Subtest bo-write-verify-y: SKIP (0.015s)
[353.812234] [054/133] (680s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[353.905830] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[353.910074] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[354.016850] [055/133] (680s left) gem_exec_balancer (bonded-pair)
[354.084831] Starting subtest: bonded-pair
[354.089441] Subtest bonded-pair: SKIP (0.000s)
[354.403403] [056/133] (680s left) kms_invalid_mode (clock-too-high)
[354.502157] Starting subtest: clock-too-high
[354.504512] Starting dynamic subtest: pipe-A-eDP-1
[354.508969] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[354.518807] Starting dynamic subtest: pipe-B-eDP-1
[354.523062] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[354.531594] Starting dynamic subtest: pipe-C-eDP-1
[354.536039] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[354.544487] Starting dynamic subtest: pipe-D-eDP-1
[354.548889] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[354.553200] Subtest clock-too-high: SKIP (0.005s)
[354.597372] [057/133] (679s left) kms_cdclk (mode-transition)
[354.700021] Starting subtest: mode-transition
[354.702286] Starting dynamic subtest: pipe-A-eDP-1
[354.999569] Dynamic subtest pipe-A-eDP-1: SKIP (0.298s)
[355.008795] Starting dynamic subtest: pipe-B-eDP-1
[355.013279] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[355.021870] Starting dynamic subtest: pipe-C-eDP-1
[355.026483] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[355.034798] Starting dynamic subtest: pipe-D-eDP-1
[355.039167] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[355.043496] Subtest mode-transition: SKIP (0.306s)
[355.806359] [058/133] (678s left) gen9_exec_parse (batch-zero-length)
[355.879546] Subtest batch-zero-length: SKIP (0.000s)
[355.941031] [059/133] (678s left) kms_flip (plain-flip-ts-check)
[356.038527] Starting subtest: plain-flip-ts-check
[356.040761] Starting dynamic subtest: A-eDP1
[364.885225] Dynamic subtest A-eDP1: SUCCESS (8.848s)
[364.900226] Starting dynamic subtest: B-eDP1
[373.706625] Dynamic subtest B-eDP1: SUCCESS (8.819s)
[373.717907] Starting dynamic subtest: C-eDP1
[382.528852] Dynamic subtest C-eDP1: SUCCESS (8.820s)
[382.543678] Starting dynamic subtest: D-eDP1
[391.354423] Dynamic subtest D-eDP1: SUCCESS (8.823s)
[391.360855] Subtest plain-flip-ts-check: SUCCESS (35.324s)
[392.546752] [060/133] (642s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[392.650977] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[392.655534] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[392.748098] [061/133] (641s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[392.806323] Starting subtest: invalid-bsd1-flag-on-blt
[392.808596] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[392.939979] [062/133] (641s left) perf (gen8-unprivileged-single-ctx-counters)
[393.055311] Starting subtest: gen8-unprivileged-single-ctx-counters
[393.059754] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[393.110328] [063/133] (641s left) kms_vrr (lobf)
[393.190948] Starting subtest: lobf
[393.195349] Subtest lobf: SKIP (0.000s)
[393.279981] [064/133] (641s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[393.385225] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[393.389465] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[393.493152] [065/133] (641s left) kms_psr (psr-cursor-blt)
[393.579383] Starting subtest: psr-cursor-blt
[393.581299] Starting dynamic subtest: eDP-1
[395.317837] Dynamic subtest eDP-1: SUCCESS (1.737s)
[395.320205] Subtest psr-cursor-blt: SUCCESS (1.738s)
[396.206079] [066/133] (638s left) syncobj_timeline (etime-multi-wait-all-submitted)
[396.268818] Starting subtest: etime-multi-wait-all-submitted
[396.376375] Subtest etime-multi-wait-all-submitted: SUCCESS (0.108s)
[396.465773] [067/133] (638s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[396.551257] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[396.553579] Starting dynamic subtest: pipe-A-eDP-1
[396.576720] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[396.587548] Starting dynamic subtest: pipe-B-eDP-1
[396.609208] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[396.617792] Starting dynamic subtest: pipe-C-eDP-1
[396.639135] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[396.648949] Starting dynamic subtest: pipe-D-eDP-1
[396.670809] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[396.675188] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[398.801373] [068/133] (636s left) i915_getparams_basic (basic-eu-total)
[398.862793] Starting subtest: basic-eu-total
[398.867078] Subtest basic-eu-total: SUCCESS (0.000s)
[398.971227] [069/133] (635s left) kms_cursor_edge_walk (128x128-top-edge)
[399.084252] Starting subtest: 128x128-top-edge
[399.086570] Starting dynamic subtest: pipe-A-eDP-1
[402.561855] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.478s)
[402.572775] Starting dynamic subtest: pipe-D-eDP-1
[405.678282] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.115s)
[405.680597] Subtest 128x128-top-edge: SUCCESS (6.596s)
[406.500473] [070/133] (628s left) gen3_render_linear_blits
[406.619113] [071/133] (628s left) kms_flip (flip-vs-wf_vblank-interruptible)
[406.712199] Starting subtest: flip-vs-wf_vblank-interruptible
[406.714492] Starting dynamic subtest: A-eDP1
[408.638963] Dynamic subtest A-eDP1: SUCCESS (1.925s)
[408.650478] Starting dynamic subtest: B-eDP1
[410.561614] Dynamic subtest B-eDP1: SUCCESS (1.921s)
[410.572723] Starting dynamic subtest: C-eDP1
[412.488949] Dynamic subtest C-eDP1: SUCCESS (1.926s)
[412.500357] Starting dynamic subtest: D-eDP1
[414.414077] Dynamic subtest D-eDP1: SUCCESS (1.924s)
[414.416350] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.705s)
[415.659470] [072/133] (619s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[415.758938] Starting subtest: fbc-shrfb-scaledprimary
[418.804394] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.048s)
[419.960777] [073/133] (615s left) kms_vblank (query-idle-hang)
[420.053090] Starting subtest: query-idle-hang
[420.055271] Starting dynamic subtest: pipe-A-eDP-1
[447.628527] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.569s)
[447.642510] Starting dynamic subtest: pipe-D-eDP-1
[462.744464] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.113s)
[462.747078] Subtest query-idle-hang: SUCCESS (42.687s)
[463.590491] [074/133] (571s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[463.698564] Starting subtest: y-tiled-64bpp-rotate-0
[463.702981] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[463.804224] [075/133] (571s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[463.862069] Starting subtest: multi-wait-all-available-submitted-signaled
[463.864237] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[463.982159] [076/133] (571s left) syncobj_basic (bad-flags-handle-to-fd)
[464.040910] Starting subtest: bad-flags-handle-to-fd
[464.043238] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[464.161300] [077/133] (571s left) gem_pread (self)
[464.223548] Subtest self: SKIP (0.000s)
[464.292551] [078/133] (571s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[464.419317] Starting subtest: basic-flip-after-cursor-legacy
[465.341638] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.921s)
[466.221634] [079/133] (569s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[466.327633] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[466.329761] Starting dynamic subtest: pipe-A-default-mode
[469.061689] Dynamic subtest pipe-A-default-mode: SUCCESS (2.732s)
[469.063855] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.734s)
[469.900971] [080/133] (565s left) syncobj_basic (bad-destroy-pad)
[469.966259] Starting subtest: bad-destroy-pad
[469.968197] Subtest bad-destroy-pad: SUCCESS (0.000s)
[470.077072] [081/133] (565s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[470.172636] Starting subtest: psr-dirtyfb-ioctl
[470.174796] Starting dynamic subtest: A-eDP-1
[473.988722] Dynamic subtest A-eDP-1: SUCCESS (3.816s)
[473.991168] Subtest psr-dirtyfb-ioctl: SUCCESS (3.817s)
[474.799682] [082/133] (560s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[474.904271] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[478.908985] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (4.007s)
[480.100298] [083/133] (555s left) sysfs_preempt_timeout (idempotent)
[480.160604] Starting subtest: idempotent
[480.162944] Starting dynamic subtest: vecs0
[480.165303] Dynamic subtest vecs0: SUCCESS (0.000s)
[480.175741] Starting dynamic subtest: ccs0
[480.177633] Dynamic subtest ccs0: SUCCESS (0.000s)
[480.185692] Starting dynamic subtest: vcs0
[480.187513] Dynamic subtest vcs0: SUCCESS (0.000s)
[480.195435] Starting dynamic subtest: bcs0
[480.197316] Dynamic subtest bcs0: SUCCESS (0.000s)
[480.205233] Starting dynamic subtest: rcs0
[480.207082] Dynamic subtest rcs0: SUCCESS (0.000s)
[480.215043] Starting dynamic subtest: vcs1
[480.216867] Dynamic subtest vcs1: SUCCESS (0.000s)
[480.219093] Subtest idempotent: SUCCESS (0.007s)
[480.291340] [084/133] (555s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[480.394262] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[480.398240] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[480.540494] [085/133] (555s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[480.631783] Starting subtest: fbc-psr2-sprite-mmap-cpu
[480.633962] Starting dynamic subtest: eDP-1
[480.637991] Dynamic subtest eDP-1: SKIP (0.000s)
[480.641941] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[480.715838] [086/133] (554s left) prime_self_import (export-vs-gem_close-race)
[480.757369] Starting subtest: export-vs-gem_close-race
[485.865920] Subtest export-vs-gem_close-race: SUCCESS (5.107s)
[485.957551] [087/133] (549s left) kms_content_protection (srm)
[486.100303] Starting subtest: srm
[486.107764] Subtest srm: SKIP (0.002s)
[486.259285] [088/133] (549s left) gem_exec_async (concurrent-writes)
[486.316660] Starting subtest: concurrent-writes
[486.318976] Starting dynamic subtest: rcs0
[486.334206] Dynamic subtest rcs0: SUCCESS (0.017s)
[486.343375] Starting dynamic subtest: bcs0
[486.345215] Dynamic subtest bcs0: SUCCESS (0.007s)
[486.354600] Starting dynamic subtest: vcs0
[486.356864] Dynamic subtest vcs0: SUCCESS (0.006s)
[486.365910] Starting dynamic subtest: vcs1
[486.367831] Dynamic subtest vcs1: SUCCESS (0.007s)
[486.376677] Starting dynamic subtest: vecs0
[486.378746] Dynamic subtest vecs0: SUCCESS (0.006s)
[486.387483] Starting dynamic subtest: ccs0
[486.389639] Dynamic subtest ccs0: SUCCESS (0.005s)
[486.391721] Subtest concurrent-writes: SUCCESS (0.054s)
[486.635713] [089/133] (549s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[487.013591] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[487.787098] [090/133] (548s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[487.874043] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[487.876173] Starting dynamic subtest: pipe-A-eDP-1
[488.314076] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.441s)
[488.325515] Starting dynamic subtest: pipe-B-eDP-1
[488.345768] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.003s)
[488.354734] Starting dynamic subtest: pipe-C-eDP-1
[488.374141] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[488.382775] Starting dynamic subtest: pipe-D-eDP-1
[488.401794] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[488.403975] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.456s)
[490.580942] [091/133] (545s left) gem_create (create-size-update)
[490.652965] Starting subtest: create-size-update
[490.655335] Subtest create-size-update: SUCCESS (0.000s)
[490.879433] [092/133] (545s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[490.974464] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[490.976737] Starting dynamic subtest: A-eDP1
[494.582680] Dynamic subtest A-eDP1: SUCCESS (3.609s)
[494.592283] Starting dynamic subtest: B-eDP1
[497.779086] Dynamic subtest B-eDP1: SUCCESS (3.193s)
[497.789049] Starting dynamic subtest: C-eDP1
[500.896523] Dynamic subtest C-eDP1: SUCCESS (3.118s)
[500.906654] Starting dynamic subtest: D-eDP1
[504.012788] Dynamic subtest D-eDP1: SUCCESS (3.113s)
[504.015082] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.041s)
[504.822477] [093/133] (531s left) kms_cursor_crc (cursor-alpha-transparent)
[504.917197] Starting subtest: cursor-alpha-transparent
[504.919045] Starting dynamic subtest: pipe-A-eDP-1
[505.539889] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.622s)
[505.549059] Starting dynamic subtest: pipe-D-eDP-1
[506.805038] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.261s)
[506.806876] Subtest cursor-alpha-transparent: SUCCESS (1.886s)
[507.695887] [094/133] (528s left) kms_plane_multiple (tiling-yf)
[507.781747] Starting subtest: tiling-yf
[507.785657] Subtest tiling-yf: SKIP (0.000s)
[507.863415] [095/133] (528s left) i915_query (query-topology-garbage-items)
[507.928645] Starting subtest: query-topology-garbage-items
[507.930607] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[508.052186] [096/133] (528s left) gem_mmap_gtt (bad-object)
[508.110371] Subtest bad-object: SKIP (0.000s)
[508.177330] [097/133] (527s left) gem_exec_schedule (preempt-queue-contexts-chain)
[508.255252] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[508.564006] [098/133] (527s left) gem_exec_reloc (basic-write-read-noreloc)
[508.628173] Subtest basic-write-read-noreloc: SKIP (0.000s)
[508.709071] [099/133] (527s left) kms_atomic (plane-primary-legacy)
[508.815758] Starting subtest: plane-primary-legacy
[508.817900] Starting dynamic subtest: pipe-A-eDP-1
[509.258333] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.442s)
[509.260569] Subtest plane-primary-legacy: SUCCESS (0.443s)
[510.131758] [100/133] (526s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[510.244978] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[517.584213] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.343s)
[517.721546] [101/133] (518s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[517.830247] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[517.834237] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[517.941737] [102/133] (518s left) prime_vgem (basic-fence-flip)
[518.022590] Starting subtest: basic-fence-flip
[518.319518] Subtest basic-fence-flip: SUCCESS (0.297s)
[518.438028] [103/133] (517s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[518.522992] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[518.536068] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s)
[518.608613] [104/133] (517s left) gem_ctx_persistence (userptr)
[518.678588] Starting subtest: userptr
[518.881710] Subtest userptr: SUCCESS (0.203s)
[518.973603] [105/133] (517s left) sw_sync (sync_busy_fork_unixsocket)
[519.013597] Starting subtest: sync_busy_fork_unixsocket
[519.018579] Subtest sync_busy_fork_unixsocket: SUCCESS (0.006s)
[519.106560] [106/133] (517s left) gem_userptr_blits (sync-unmap-cycles)
[519.174282] Starting subtest: sync-unmap-cycles
[524.546586] Subtest sync-unmap-cycles: SUCCESS (5.375s)
[524.711658] [107/133] (511s left) gem_mmap_gtt (zero-extend)
[524.767189] Subtest zero-extend: SKIP (0.000s)
[524.839674] [108/133] (511s left) kms_properties (plane-properties-atomic)
[524.931502] Starting subtest: plane-properties-atomic
[524.933130] Starting dynamic subtest: pipe-A-eDP-1
[525.478495] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.547s)
[525.488670] Starting dynamic subtest: pipe-B-eDP-1
[526.708545] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.229s)
[526.719524] Starting dynamic subtest: pipe-C-eDP-1
[527.935676] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.226s)
[527.946302] Starting dynamic subtest: pipe-D-eDP-1
[529.180075] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.243s)
[529.182325] Subtest plane-properties-atomic: SUCCESS (4.250s)
[529.993348] [109/133] (506s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[530.090023] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[530.094392] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[530.229957] [110/133] (506s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[530.330165] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[530.708952] Starting dynamic subtest: pipe-A-eDP-1
[533.452798] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.743s)
[533.826758] Starting dynamic subtest: pipe-B-eDP-1
[536.590920] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.771s)
[536.960625] Starting dynamic subtest: pipe-C-eDP-1
[539.716932] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.762s)
[540.075070] Starting dynamic subtest: pipe-D-eDP-1
[542.852134] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.783s)
[542.854605] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.523s)
[544.054581] [111/133] (492s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[544.167424] Starting subtest: pipe-fbc-rte
[544.173965] Starting dynamic subtest: pipe-B-eDP-1
[549.624252] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.460s)
[549.631331] Subtest pipe-fbc-rte: SUCCESS (5.463s)
[551.881895] [112/133] (484s left) api_intel_allocator (execbuf-with-allocator)
[551.945307] Starting subtest: execbuf-with-allocator
[551.950117] Subtest execbuf-with-allocator: SUCCESS (0.005s)
[552.100077] [113/133] (484s left) gem_exec_reloc (basic-gtt-noreloc)
[552.170366] Subtest basic-gtt-noreloc: SKIP (0.000s)
[552.244886] [114/133] (484s left) gem_exec_params (invalid-batch-start-offset)
[552.299648] Starting subtest: invalid-batch-start-offset
[552.301938] Subtest invalid-batch-start-offset: SUCCESS (0.002s)
[552.434155] [115/133] (484s left) kms_color (legacy-gamma-reset)
[552.528817] Starting subtest: legacy-gamma-reset
[552.530610] Starting dynamic subtest: pipe-A-eDP-1
[552.909039] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.382s)
[552.918249] Starting dynamic subtest: pipe-B-eDP-1
[552.923085] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.012s)
[552.932225] Starting dynamic subtest: pipe-C-eDP-1
[552.934488] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.012s)
[552.943272] Starting dynamic subtest: pipe-D-eDP-1
[552.947938] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.013s)
[552.950321] Subtest legacy-gamma-reset: SUCCESS (0.422s)
[553.725877] [116/133] (483s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[553.793381] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[553.797708] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[553.985499] [117/133] (482s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[554.089059] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[554.093090] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[554.172861] [118/133] (482s left) prime_busy (hang-wait)
[554.241107] Starting subtest: hang-wait
[554.243444] Starting dynamic subtest: rcs0
[580.402545] Dynamic subtest rcs0: SUCCESS (26.156s)
[580.412067] Starting dynamic subtest: bcs0
[587.557922] Dynamic subtest bcs0: SUCCESS (7.155s)
[587.566186] Starting dynamic subtest: vcs0
[594.533820] Dynamic subtest vcs0: SUCCESS (6.971s)
[594.543697] Starting dynamic subtest: vcs1
[601.507952] Dynamic subtest vcs1: SUCCESS (6.973s)
[601.518222] Starting dynamic subtest: vecs0
[608.547744] Dynamic subtest vecs0: SUCCESS (7.038s)
[608.557678] Starting dynamic subtest: ccs0
[622.453897] Dynamic subtest ccs0: SUCCESS (13.903s)
[622.456330] Subtest hang-wait: SUCCESS (68.208s)
[622.612676] [119/133] (414s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[624.137371] Starting subtest: dpms-mode-unset-lpsp
[628.190636] Subtest dpms-mode-unset-lpsp: SUCCESS (4.054s)
[628.597087] [120/133] (408s left) gem_exec_balancer (waits)
[628.670458] Starting subtest: waits
[635.164081] Subtest waits: SUCCESS (6.495s)
[635.489803] [121/133] (401s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[635.597917] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[640.088109] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.496s)
[641.272301] [122/133] (395s left) syncobj_eventfd (timeline-wait-signaled)
[641.334242] Starting subtest: timeline-wait-signaled
[641.336600] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[641.435920] [123/133] (395s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[641.530442] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[641.534885] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[641.685920] [124/133] (395s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[641.752500] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[641.819209] [125/133] (395s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[641.923071] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[641.927163] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[642.057430] [126/133] (395s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[642.453630] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[643.252795] [127/133] (394s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[643.311457] Starting subtest: invalid-bsd2-flag-on-blt
[643.313909] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[643.434197] [128/133] (393s left) gem_exec_schedule (in-order)
[643.507444] Starting subtest: in-order
[643.509750] Starting dynamic subtest: rcs0
[643.603060] Dynamic subtest rcs0: SUCCESS (0.104s)
[643.614219] Starting dynamic subtest: vcs0
[643.682916] Dynamic subtest vcs0: SUCCESS (0.079s)
[643.694894] Starting dynamic subtest: vcs1
[643.761069] Dynamic subtest vcs1: SUCCESS (0.077s)
[643.774104] Starting dynamic subtest: vecs0
[643.832264] Dynamic subtest vecs0: SUCCESS (0.071s)
[643.845340] Starting dynamic subtest: ccs0
[643.911474] Dynamic subtest ccs0: SUCCESS (0.078s)
[643.914348] Subtest in-order: SUCCESS (0.413s)
[645.023087] [129/133] (392s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[645.115867] Starting subtest: fbc-psr2-sprite-plane-onoff
[645.118199] Starting dynamic subtest: eDP-1
[645.122218] Dynamic subtest eDP-1: SKIP (0.000s)
[645.126280] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[645.200078] [130/133] (392s left) gem_exec_reloc (basic-write-cpu)
[645.266105] Subtest basic-write-cpu: SKIP (0.000s)
[645.330615] [131/133] (392s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[645.426321] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[645.428649] Starting dynamic subtest: pipe-A
[645.443657] Dynamic subtest pipe-A: SKIP (0.015s)
[645.453473] Starting dynamic subtest: pipe-B
[645.472981] Dynamic subtest pipe-B: SKIP (0.028s)
[645.491395] Starting dynamic subtest: pipe-C
[645.500877] Dynamic subtest pipe-C: SKIP (0.027s)
[645.518703] Starting dynamic subtest: pipe-D
[645.527640] Dynamic subtest pipe-D: SKIP (0.027s)
[645.531529] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.100s)
[645.651775] [132/133] (391s left) kms_hdr (brightness-with-hdr)
[645.750955] Starting subtest: brightness-with-hdr
[645.757343] Subtest brightness-with-hdr: SKIP (0.000s)
[645.839051] [133/133] (391s left) gem_close_race (basic-process)
[645.898784] Starting subtest: basic-process
[645.968765] Subtest basic-process: SUCCESS (0.070s)
[646.158123] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_reloc
results: parsing output: 1/ for test: kms_flip
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: gem_mmap_wc
results: parsing output: 6/ for test: gem_exec_whisper
results: parsing output: 7/ for test: i915_drm_fdinfo
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: syncobj_wait
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_ctx_param
results: parsing output: 13/ for test: gem_lmem_swapping
results: parsing output: 14/ for test: kms_scaling_modes
results: parsing output: 15/ for test: kms_flip
results: parsing output: 16/ for test: gem_spin_batch
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: syncobj_wait
results: parsing output: 19/ for test: i915_pm_rc6_residency
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: fbdev
results: parsing output: 22/ for test: kms_cursor_crc
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_sequence
results: parsing output: 25/ for test: core_auth
results: parsing output: 26/ for test: gem_vm_create
results: parsing output: 27/ for test: gem_pxp
results: parsing output: 28/ for test: kms_psr2_sf
results: parsing output: 29/ for test: gem_userptr_blits
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_dp_link_training
results: parsing output: 32/ for test: kms_psr
results: parsing output: 33/ for test: kms_psr2_sf
results: parsing output: 34/ for test: gem_exec_fence
results: parsing output: 35/ for test: syncobj_timeline
results: parsing output: 36/ for test: kms_addfb_basic
results: parsing output: 37/ for test: dmabuf_sync_file
results: parsing output: 38/ for test: kms_plane
results: parsing output: 39/ for test: kms_addfb_basic
results: parsing output: 40/ for test: kms_plane_alpha_blend
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: perf_pmu
results: parsing output: 44/ for test: kms_lease
results: parsing output: 45/ for test: kms_prime
results: parsing output: 46/ for test: kms_cursor_legacy
results: parsing output: 47/ for test: syncobj_timeline
results: parsing output: 48/ for test: kms_atomic_interruptible
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: gem_fence_thrash
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_exec_balancer
results: parsing output: 55/ for test: kms_invalid_mode
results: parsing output: 56/ for test: kms_cdclk
results: parsing output: 57/ for test: gen9_exec_parse
results: parsing output: 58/ for test: kms_flip
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_exec_params
results: parsing output: 61/ for test: perf
results: parsing output: 62/ for test: kms_vrr
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: syncobj_timeline
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: i915_getparams_basic
results: parsing output: 68/ for test: kms_cursor_edge_walk
results: parsing output: 69/ for test: gen3_render_linear_blits
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_vblank
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: syncobj_timeline
results: parsing output: 75/ for test: syncobj_basic
results: parsing output: 76/ for test: gem_pread
results: parsing output: 77/ for test: kms_cursor_legacy
results: parsing output: 78/ for test: kms_flip_scaled_crc
results: parsing output: 79/ for test: syncobj_basic
results: parsing output: 80/ for test: kms_dirtyfb
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: sysfs_preempt_timeout
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: prime_self_import
results: parsing output: 86/ for test: kms_content_protection
results: parsing output: 87/ for test: gem_exec_async
results: parsing output: 88/ for test: kms_chamelium_hpd
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: gem_create
results: parsing output: 91/ for test: kms_flip
results: parsing output: 92/ for test: kms_cursor_crc
results: parsing output: 93/ for test: kms_plane_multiple
results: parsing output: 94/ for test: i915_query
results: parsing output: 95/ for test: gem_mmap_gtt
results: parsing output: 96/ for test: gem_exec_schedule
results: parsing output: 97/ for test: gem_exec_reloc
results: parsing output: 98/ for test: kms_atomic
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: prime_vgem
results: parsing output: 102/ for test: kms_plane
results: parsing output: 103/ for test: gem_ctx_persistence
results: parsing output: 104/ for test: sw_sync
results: parsing output: 105/ for test: gem_userptr_blits
results: parsing output: 106/ for test: gem_mmap_gtt
results: parsing output: 107/ for test: kms_properties
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: kms_async_flips
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: api_intel_allocator
results: parsing output: 112/ for test: gem_exec_reloc
results: parsing output: 113/ for test: gem_exec_params
results: parsing output: 114/ for test: kms_color
results: parsing output: 115/ for test: gem_render_copy
results: parsing output: 116/ for test: kms_flip_scaled_crc
results: parsing output: 117/ for test: prime_busy
results: parsing output: 118/ for test: kms_pm_rpm
results: parsing output: 119/ for test: gem_exec_balancer
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: syncobj_eventfd
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_pipe_b_c_ivb
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_chamelium_frames
results: parsing output: 126/ for test: gem_exec_params
results: parsing output: 127/ for test: gem_exec_schedule
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: gem_exec_reloc
results: parsing output: 130/ for test: kms_plane_scaling
results: parsing output: 131/ for test: kms_hdr
results: parsing output: 132/ for test: gem_close_race
Done.