[57.752040] Initializing watchdogs
[57.752091]   /dev/watchdog0
[57.766784] [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]
[57.771148] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.773464] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.777711] [001/132] (960s left) gem_exec_schedule (submit-early-slice)
[57.869471] Starting subtest: submit-early-slice
[57.871715] Starting dynamic subtest: rcs0
[57.906325] Dynamic subtest rcs0: SUCCESS (0.041s)
[57.918670] Starting dynamic subtest: bcs0
[57.959707] Dynamic subtest bcs0: SUCCESS (0.053s)
[57.969708] Starting dynamic subtest: vcs0
[58.010152] Dynamic subtest vcs0: SUCCESS (0.050s)
[58.017214] Starting dynamic subtest: vcs1
[58.066631] Dynamic subtest vcs1: SUCCESS (0.055s)
[58.076097] Starting dynamic subtest: vecs0
[58.123965] Dynamic subtest vecs0: SUCCESS (0.057s)
[58.134633] Starting dynamic subtest: ccs0
[58.174345] Dynamic subtest ccs0: SUCCESS (0.050s)
[58.177062] Subtest submit-early-slice: SUCCESS (0.308s)
[60.026208] [002/132] (958s left) kms_vblank (query-forked-busy-hang)
[60.124266] Starting subtest: query-forked-busy-hang
[60.126552] Starting dynamic subtest: pipe-A-eDP-1
[86.701062] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.532s)
[86.713606] Starting dynamic subtest: pipe-D-eDP-1
[111.638580] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.928s)
[111.641098] Subtest query-forked-busy-hang: SUCCESS (51.463s)
[112.474507] [003/132] (905s left) kms_dsc (dsc-fractional-bpp)
[112.561456] Starting subtest: dsc-fractional-bpp
[112.574947] Subtest dsc-fractional-bpp: SKIP (0.000s)
[112.630464] [004/132] (905s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[112.732083] Starting subtest: yf-tiled-16bpp-rotate-90
[112.736660] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[112.841566] [005/132] (905s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[112.934783] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[112.939175] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[113.029929] [006/132] (905s left) prime_udl
[113.110999] [007/132] (905s left) gem_softpin (zero)
[113.170694] Starting subtest: zero
[113.178308] Subtest zero: SUCCESS (0.008s)
[113.296532] [008/132] (905s left) gem_ringfill (legacy-basic)
[118.938203] Starting subtest: legacy-basic
[118.940659] Starting dynamic subtest: default
[118.998250] Dynamic subtest default: SUCCESS (0.061s)
[119.007521] Starting dynamic subtest: render
[119.039987] Dynamic subtest render: SUCCESS (0.041s)
[119.056434] Starting dynamic subtest: bsd
[119.083696] Dynamic subtest bsd: SUCCESS (0.042s)
[119.096903] Starting dynamic subtest: bsd1
[119.126937] Dynamic subtest bsd1: SUCCESS (0.042s)
[119.135517] Starting dynamic subtest: bsd2
[119.166259] Dynamic subtest bsd2: SUCCESS (0.038s)
[119.174784] Starting dynamic subtest: blt
[119.210975] Dynamic subtest blt: SUCCESS (0.043s)
[119.220636] Starting dynamic subtest: vebox
[119.253065] Dynamic subtest vebox: SUCCESS (0.041s)
[119.255409] Subtest legacy-basic: SUCCESS (0.317s)
[119.324388] [FACT gem_ringfill (legacy-basic)] new: kernel.kmod_is_loaded.vgem: true
[119.327289] [009/132] (899s left) kms_big_fb (linear-64bpp-rotate-90)
[119.442749] Starting subtest: linear-64bpp-rotate-90
[119.464049] Subtest linear-64bpp-rotate-90: SKIP (0.019s)
[119.574191] [010/132] (899s left) kms_properties (colorop-properties-legacy)
[119.668358] Starting subtest: colorop-properties-legacy
[119.670648] Starting dynamic subtest: pipe-A-eDP-1
[120.052951] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.385s)
[120.062168] Starting dynamic subtest: pipe-B-eDP-1
[121.142956] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.090s)
[121.151295] Starting dynamic subtest: pipe-C-eDP-1
[122.180473] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.034s)
[122.189383] Starting dynamic subtest: pipe-D-eDP-1
[123.218020] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.037s)
[123.220353] Subtest colorop-properties-legacy: SUCCESS (3.550s)
[124.012618] [011/132] (894s left) prime_busy (after)
[124.073097] Starting subtest: after
[124.077478] Starting dynamic subtest: rcs0
[124.095499] Dynamic subtest rcs0: SUCCESS (0.020s)
[124.103589] Starting dynamic subtest: bcs0
[124.150891] Dynamic subtest bcs0: SUCCESS (0.055s)
[124.159484] Starting dynamic subtest: vcs0
[124.194534] Dynamic subtest vcs0: SUCCESS (0.043s)
[124.202614] Starting dynamic subtest: vcs1
[124.235291] Dynamic subtest vcs1: SUCCESS (0.040s)
[124.243265] Starting dynamic subtest: vecs0
[124.277111] Dynamic subtest vecs0: SUCCESS (0.041s)
[124.292864] Starting dynamic subtest: ccs0
[124.318319] Dynamic subtest ccs0: SUCCESS (0.041s)
[124.426835] Subtest after: SUCCESS (0.352s)
[124.497725] [012/132] (894s left) syncobj_timeline (wait-zero-handles)
[124.555060] Starting subtest: wait-zero-handles
[124.557420] Subtest wait-zero-handles: SUCCESS (0.000s)
[124.651218] [013/132] (894s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[124.747961] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[124.752735] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[124.865241] [014/132] (893s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[124.958172] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[124.960480] Starting dynamic subtest: pipe-A-eDP-1
[125.079060] Dynamic subtest pipe-A-eDP-1: SKIP (0.123s)
[125.089067] Starting dynamic subtest: pipe-B-eDP-1
[126.194047] Dynamic subtest pipe-B-eDP-1: SKIP (1.113s)
[126.198875] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.239s)
[127.373909] [015/132] (891s left) gem_lmem_swapping (heavy-verify-random-ccs)
[127.419149] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[127.463716] [016/132] (891s left) gem_ctx_param (invalid-ctx-get)
[127.523085] Starting subtest: invalid-ctx-get
[127.525497] Subtest invalid-ctx-get: SUCCESS (0.000s)
[127.604635] [017/132] (891s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[127.713372] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[127.718792] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[128.824652] [018/132] (890s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[128.926627] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[128.931280] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[129.029031] [019/132] (889s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[129.123025] Starting subtest: fbcpsr-rgb565-draw-render
[136.141778] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.022s)
[136.267923] [020/132] (882s left) gem_ctx_param (invalid-get-engines)
[136.331337] Starting subtest: invalid-get-engines
[136.333641] Subtest invalid-get-engines: SUCCESS (0.001s)
[136.422204] [021/132] (882s left) gen9_exec_parse (shadow-peek)
[136.478403] Subtest shadow-peek: SKIP (0.000s)
[136.543590] [022/132] (882s left) gem_readwrite (beyond-eob)
[136.611111] Subtest beyond-EOB: SKIP (0.000s)
[136.667201] [023/132] (882s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[136.730770] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[136.835452] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.103s)
[136.912661] [024/132] (882s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[137.017420] Starting subtest: y-tiled-32bpp-rotate-0
[137.021947] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[137.138202] [025/132] (882s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[137.225842] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[137.228082] Starting dynamic subtest: pipe-A-eDP-1
[137.248266] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[137.257172] Starting dynamic subtest: pipe-B-eDP-1
[137.275536] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[137.283536] Starting dynamic subtest: pipe-C-eDP-1
[137.301853] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[137.309608] Starting dynamic subtest: pipe-D-eDP-1
[137.327445] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[137.329782] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[139.513505] [026/132] (879s left) kms_psr (psr2-sprite-blt)
[139.618658] Starting subtest: psr2-sprite-blt
[139.620896] Starting dynamic subtest: eDP-1
[141.312939] Dynamic subtest eDP-1: SUCCESS (1.693s)
[141.315440] Subtest psr2-sprite-blt: SUCCESS (1.694s)
[142.176451] [027/132] (877s left) gem_exec_reloc (basic-concurrent0)
[142.242657] Subtest basic-concurrent0: SKIP (0.000s)
[142.322786] [028/132] (877s left) gem_eio (hibernate)
[142.546113] Starting subtest: hibernate
[157.195949] Subtest hibernate: SUCCESS (14.648s)
[164.335441] [029/132] (862s left) kms_scaling_modes (scaling-mode-center)
[164.460875] Starting subtest: scaling-mode-center
[164.463201] Starting dynamic subtest: pipe-A-eDP-1
[164.554516] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.094s)
[164.566143] Starting dynamic subtest: pipe-B-eDP-1
[165.708329] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.152s)
[165.719968] Starting dynamic subtest: pipe-C-eDP-1
[166.909335] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.199s)
[166.921068] Starting dynamic subtest: pipe-D-eDP-1
[168.067167] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.157s)
[168.069557] Subtest scaling-mode-center: SUCCESS (3.608s)
[169.309533] [030/132] (857s left) perf (short-reads)
[169.444645] Starting subtest: short-reads
[169.456534] Subtest short-reads: SUCCESS (0.013s)
[169.499177] [031/132] (856s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[169.590066] Starting subtest: addfb25-y-tiled-small-legacy
[169.594461] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[169.688959] [032/132] (856s left) gem_exec_reloc (basic-write-read-noreloc)
[169.765776] Subtest basic-write-read-noreloc: SKIP (0.000s)
[169.847179] [033/132] (856s left) gem_mmap_offset (oob-read)
[169.899942] Starting subtest: oob-read
[169.902228] Subtest oob-read: SUCCESS (0.000s)
[170.013762] [034/132] (856s left) gem_exec_balancer (bonded-false-hang)
[170.266069] Starting subtest: bonded-false-hang
[170.271636] Subtest bonded-false-hang: SKIP (0.000s)
[170.385822] [035/132] (856s left) core_getclient (basic)
[170.446195] Starting subtest: basic
[170.448552] Subtest basic: SUCCESS (0.000s)
[170.554342] [036/132] (856s left) kms_cursor_crc (cursor-sliding-64x64)
[170.729956] Starting subtest: cursor-sliding-64x64
[170.735098] Starting dynamic subtest: pipe-A-eDP-1
[173.977442] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.242s)
[174.007071] Starting dynamic subtest: pipe-D-eDP-1
[177.880030] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.878s)
[177.882202] Subtest cursor-sliding-64x64: SUCCESS (7.147s)
[178.684143] [037/132] (848s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[178.801312] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[182.475057] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.677s)
[183.691692] [038/132] (843s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[183.805442] Starting subtest: basic-max-pipe-crc-check
[183.809779] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[183.852703] [039/132] (842s left) kms_chamelium_edid (hdmi-mode-timings)
[184.243260] Subtest hdmi-mode-timings: SKIP (0.000s)
[185.077273] [040/132] (841s left) kms_pm_rpm (fences)
[187.008108] Starting subtest: fences
[187.012893] Subtest fences: SKIP (0.000s)
[187.391686] [041/132] (839s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[187.489620] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[187.518558] Starting dynamic subtest: pipe-A-plane-0
[187.807669] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[187.817306] Starting dynamic subtest: pipe-A-plane-3
[188.051389] Dynamic subtest pipe-A-plane-3: SUCCESS (0.244s)
[188.060395] Starting dynamic subtest: pipe-A-plane-5
[188.064934] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[189.156970] Starting dynamic subtest: pipe-B-plane-0
[189.448534] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[189.457654] Starting dynamic subtest: pipe-B-plane-3
[189.681628] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[189.691676] Starting dynamic subtest: pipe-B-plane-5
[189.695853] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[189.990253] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.499s)
[190.833320] [042/132] (836s left) dmabuf_sync_file (export-basic)
[190.877650] Starting subtest: export-basic
[190.879585] Subtest export-basic: SUCCESS (0.001s)
[190.938293] [043/132] (836s left) gem_softpin (softpin)
[190.994664] Starting subtest: softpin
[223.251824] Subtest softpin: SUCCESS (32.250s)
[223.373025] [044/132] (803s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[223.472750] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[223.475063] Starting dynamic subtest: pipe-A-eDP-1
[223.496824] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[223.506660] Starting dynamic subtest: pipe-B-eDP-1
[223.527040] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[223.535554] Starting dynamic subtest: pipe-C-eDP-1
[223.557660] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[223.567133] Starting dynamic subtest: pipe-D-eDP-1
[223.588855] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[223.593193] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[225.803310] [045/132] (801s left) api_intel_allocator (simple-allocator)
[225.872829] Starting subtest: simple-allocator
[225.875052] Starting dynamic subtest: basic
[225.877414] Dynamic subtest basic: SUCCESS (0.004s)
[225.892717] Starting dynamic subtest: parallel-one
[226.076621] Dynamic subtest parallel-one: SUCCESS (0.199s)
[226.088238] Starting dynamic subtest: print
[226.090533] Dynamic subtest print: SUCCESS (0.000s)
[226.099223] Starting dynamic subtest: reuse
[226.101077] Dynamic subtest reuse: SUCCESS (0.000s)
[226.109781] Starting dynamic subtest: reserve
[226.111695] Dynamic subtest reserve: SUCCESS (0.000s)
[226.120107] Starting dynamic subtest: fork-reopen-allocator
[226.122034] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s)
[226.123903] Subtest simple-allocator: SUCCESS (0.217s)
[226.223240] [046/132] (800s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[226.290413] Subtest writes-after-reads: SKIP (0.000s)
[226.364347] [047/132] (800s left) kms_color (ctm-0-50)
[226.472241] Starting subtest: ctm-0-50
[226.474145] Starting dynamic subtest: pipe-A-eDP-1
[230.006442] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.535s)
[230.016196] Starting dynamic subtest: pipe-B-eDP-1
[234.285492] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.275s)
[234.295296] Starting dynamic subtest: pipe-C-eDP-1
[238.246365] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.961s)
[238.255732] Starting dynamic subtest: pipe-D-eDP-1
[242.246986] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.999s)
[242.249423] Subtest ctm-0-50: SUCCESS (15.774s)
[243.092312] [048/132] (784s left) i915_pm_rps (min-max-config-idle)
[243.158744] Starting subtest: min-max-config-idle
[243.163456] Subtest min-max-config-idle: SKIP (0.001s)
[243.235972] [049/132] (784s left) kms_flip (modeset-vs-vblank-race-interruptible)
[243.329816] Starting subtest: modeset-vs-vblank-race-interruptible
[243.332137] Starting dynamic subtest: A-eDP1
[248.005813] Dynamic subtest A-eDP1: SUCCESS (4.673s)
[248.020623] Starting dynamic subtest: B-eDP1
[252.721575] Dynamic subtest B-eDP1: SUCCESS (4.713s)
[252.734851] Starting dynamic subtest: C-eDP1
[257.227285] Dynamic subtest C-eDP1: SUCCESS (4.503s)
[257.238112] Starting dynamic subtest: D-eDP1
[261.847266] Dynamic subtest D-eDP1: SUCCESS (4.618s)
[261.853144] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.520s)
[263.024799] [050/132] (764s left) kms_flip (wf_vblank-ts-check-interruptible)
[263.119252] Starting subtest: wf_vblank-ts-check-interruptible
[263.121622] Starting dynamic subtest: A-eDP1
[272.062591] Dynamic subtest A-eDP1: SUCCESS (8.942s)
[272.076998] Starting dynamic subtest: B-eDP1
[280.994788] Dynamic subtest B-eDP1: SUCCESS (8.930s)
[281.007611] Starting dynamic subtest: C-eDP1
[289.922276] Dynamic subtest C-eDP1: SUCCESS (8.925s)
[289.934562] Starting dynamic subtest: D-eDP1
[298.857066] Dynamic subtest D-eDP1: SUCCESS (8.933s)
[298.861853] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.741s)
[300.095438] [051/132] (727s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[300.201792] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[300.206206] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[300.324925] [052/132] (727s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[300.431187] Starting subtest: psr-modesetfrombusy
[306.533179] Subtest psr-modesetfrombusy: SUCCESS (6.105s)
[306.664501] [053/132] (720s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[306.746169] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[306.747943] Starting dynamic subtest: pipe-A-eDP-1
[306.766063] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[306.775068] Starting dynamic subtest: pipe-B-eDP-1
[306.792106] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[306.800997] Starting dynamic subtest: pipe-C-eDP-1
[306.819494] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[306.827821] Starting dynamic subtest: pipe-D-eDP-1
[306.845704] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[306.849212] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.004s)
[308.984778] [054/132] (718s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[309.056550] Starting subtest: map-fixed-invalidate-overlap
[309.060729] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[309.205623] [055/132] (718s left) fbdev (info)
[309.247119] Starting subtest: info
[309.248992] Subtest info: SUCCESS (0.000s)
[309.316536] [056/132] (718s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[309.703896] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[310.500144] [057/132] (717s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[310.599121] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[319.315147] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.719s)
[319.442896] [058/132] (708s left) perf_pmu (interrupts-sync)
[319.485844] Starting subtest: interrupts-sync
[320.578997] Subtest interrupts-sync: SUCCESS (1.092s)
[320.701148] [059/132] (706s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[320.797466] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[325.325811] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.531s)
[326.451430] [060/132] (701s left) gem_ctx_sseu (mmap-args)
[326.514302] Subtest mmap-args: SKIP (0.000s)
[326.596236] [061/132] (701s left) kms_psr (pr-sprite-plane-move)
[326.687104] Starting subtest: pr-sprite-plane-move
[326.691602] Subtest pr-sprite-plane-move: SKIP (0.000s)
[326.760163] [062/132] (701s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[326.857871] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[333.402916] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.548s)
[333.506101] [063/132] (694s left) kms_invalid_mode (zero-vdisplay)
[333.605549] Starting subtest: zero-vdisplay
[333.607780] Starting dynamic subtest: pipe-A-eDP-1
[333.900120] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.293s)
[333.909828] Starting dynamic subtest: pipe-B-eDP-1
[333.911962] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[333.921256] Starting dynamic subtest: pipe-C-eDP-1
[333.923489] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[333.932418] Starting dynamic subtest: pipe-D-eDP-1
[333.934318] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[333.936159] Subtest zero-vdisplay: SUCCESS (0.300s)
[334.701139] [064/132] (693s left) gem_eio (wait-10ms)
[334.938028] Starting subtest: wait-10ms
[335.304191] Subtest wait-10ms: SUCCESS (0.367s)
[335.445715] [065/132] (692s left) kms_frontbuffer_tracking (psr-1p-rte)
[335.544266] Starting subtest: psr-1p-rte
[340.918342] Subtest psr-1p-rte: SUCCESS (5.377s)
[341.060535] [066/132] (686s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[341.158704] Starting subtest: 4-tiled-16bpp-rotate-0
[342.449920] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.290s)
[342.584923] [067/132] (685s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[342.690909] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[342.703540] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.011s)
[342.834557] [068/132] (685s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[342.943253] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[342.946803] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[343.035743] [069/132] (685s left) prime_mmap_kms (buffer-sharing)
[343.129623] Starting subtest: buffer-sharing
[343.578044] Subtest buffer-sharing: SUCCESS (0.449s)
[344.461944] [070/132] (683s left) kms_sequence (queue-busy)
[344.573674] Starting subtest: queue-busy
[344.575976] Starting dynamic subtest: pipe-A-eDP-1
[346.508091] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.934s)
[346.518481] Starting dynamic subtest: pipe-B-eDP-1
[349.161723] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.652s)
[349.177028] Starting dynamic subtest: pipe-C-eDP-1
[351.778429] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.614s)
[351.788783] Starting dynamic subtest: pipe-D-eDP-1
[354.404721] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.627s)
[354.407063] Subtest queue-busy: SUCCESS (9.832s)
[355.217702] [071/132] (672s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[355.310108] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[355.314053] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[355.406997] [072/132] (672s left) gem_exec_schedule (u-submit-late-slice)
[355.470730] Starting subtest: u-submit-late-slice
[355.472747] Starting dynamic subtest: rcs0
[355.495310] Dynamic subtest rcs0: SUCCESS (0.033s)
[355.505640] Starting dynamic subtest: bcs0
[355.533421] Dynamic subtest bcs0: SUCCESS (0.037s)
[355.543112] Starting dynamic subtest: vcs0
[355.564063] Dynamic subtest vcs0: SUCCESS (0.030s)
[355.573624] Starting dynamic subtest: vcs1
[355.596090] Dynamic subtest vcs1: SUCCESS (0.031s)
[355.605837] Starting dynamic subtest: vecs0
[355.638029] Dynamic subtest vecs0: SUCCESS (0.041s)
[355.647886] Starting dynamic subtest: ccs0
[355.674973] Dynamic subtest ccs0: SUCCESS (0.036s)
[355.677318] Subtest u-submit-late-slice: SUCCESS (0.214s)
[356.970757] [073/132] (671s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[357.075631] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[357.079781] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[357.176813] [074/132] (671s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[357.241477] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[357.345623] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.102s)
[357.466576] [075/132] (670s left) gem_render_linear_blits (basic)
[357.535349] Starting subtest: basic
[357.553239] Subtest basic: SUCCESS (0.020s)
[357.639947] [076/132] (670s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[357.733318] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[357.735617] Starting dynamic subtest: pipe-A
[358.080473] Dynamic subtest pipe-A: SUCCESS (0.349s)
[358.090778] Starting dynamic subtest: pipe-B
[359.499783] Dynamic subtest pipe-B: SUCCESS (1.417s)
[359.510179] Starting dynamic subtest: pipe-C
[360.936677] Dynamic subtest pipe-C: SUCCESS (1.435s)
[360.947893] Starting dynamic subtest: pipe-D
[362.362819] Dynamic subtest pipe-D: SUCCESS (1.424s)
[362.365334] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.632s)
[363.541068] [077/132] (664s left) syncobj_timeline (single-wait-for-submit-signaled)
[363.600370] Starting subtest: single-wait-for-submit-signaled
[363.602666] Subtest single-wait-for-submit-signaled: SUCCESS (0.001s)
[363.702734] [078/132] (664s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[363.801439] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[363.805758] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[363.909490] [079/132] (664s left) kms_psr (fbc-pr-primary-render)
[364.013881] Starting subtest: fbc-pr-primary-render
[364.018182] Subtest fbc-pr-primary-render: SKIP (0.000s)
[364.088819] [080/132] (664s left) gem_ctx_engines (execute-one)
[364.164159] Starting subtest: execute-one
[366.964724] Subtest execute-one: SUCCESS (2.803s)
[367.152251] [081/132] (661s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[367.249434] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[374.160106] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.912s)
[374.310337] [082/132] (654s left) gem_exec_capture (capture-invisible)
[374.365616] Starting subtest: capture-invisible
[374.367879] Starting dynamic subtest: smem0
[374.372159] Dynamic subtest smem0: SKIP (0.000s)
[374.376153] Subtest capture-invisible: SKIP (0.001s)
[374.482953] [083/132] (654s left) gem_eio (in-flight-immediate)
[374.732673] Starting subtest: in-flight-immediate
[383.017469] Subtest in-flight-immediate: SUCCESS (8.284s)
[383.228629] [084/132] (645s left) kms_cursor_crc (cursor-alpha-opaque)
[383.330950] Starting subtest: cursor-alpha-opaque
[383.333146] Starting dynamic subtest: pipe-A-eDP-1
[383.995184] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.663s)
[384.005709] Starting dynamic subtest: pipe-D-eDP-1
[385.263749] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.266s)
[385.265633] Subtest cursor-alpha-opaque: SUCCESS (1.932s)
[386.152513] [085/132] (642s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[386.229913] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[386.303464] [086/132] (642s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[386.365857] Starting subtest: y-tiled-ccs-to-x-tiled
[386.369873] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[386.553636] [087/132] (642s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[386.614650] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[386.616989] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[386.719855] [088/132] (642s left) perf (invalid-oa-exponent)
[386.794401] Starting subtest: invalid-oa-exponent
[386.805250] Subtest invalid-oa-exponent: SUCCESS (0.010s)
[386.847794] [089/132] (642s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[386.947491] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[386.949790] Starting dynamic subtest: pipe-A-default-mode
[389.705956] Dynamic subtest pipe-A-default-mode: SUCCESS (2.759s)
[389.708340] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.761s)
[390.553935] [090/132] (638s left) i915_selftest (mock)
[393.845647] Starting subtest: mock
[393.848988] Starting dynamic subtest: sanitycheck
[394.540496] Dynamic subtest sanitycheck: SUCCESS (0.698s)
[394.551112] Starting dynamic subtest: shmem
[395.231197] Dynamic subtest shmem: SUCCESS (0.689s)
[395.241361] Starting dynamic subtest: fence
[403.053020] Dynamic subtest fence: SUCCESS (7.818s)
[403.073414] Starting dynamic subtest: scatterlist
[404.744095] Dynamic subtest scatterlist: SUCCESS (1.686s)
[404.754722] Starting dynamic subtest: syncmap
[407.905357] Dynamic subtest syncmap: SUCCESS (3.158s)
[407.916202] Starting dynamic subtest: uncore
[408.602191] Dynamic subtest uncore: SUCCESS (0.695s)
[408.610681] Starting dynamic subtest: ring
[409.297113] Dynamic subtest ring: SUCCESS (0.692s)
[409.307271] Starting dynamic subtest: engine
[410.001155] Dynamic subtest engine: SUCCESS (0.702s)
[410.011508] Starting dynamic subtest: timelines
[413.919035] Dynamic subtest timelines: SUCCESS (3.914s)
[413.929552] Starting dynamic subtest: requests
[417.723992] Dynamic subtest requests: SUCCESS (3.803s)
[417.734148] Starting dynamic subtest: objects
[418.499214] Dynamic subtest objects: SUCCESS (0.774s)
[418.508304] Starting dynamic subtest: phys
[419.296124] Dynamic subtest phys: SUCCESS (0.794s)
[419.306614] Starting dynamic subtest: dmabuf
[420.071978] Dynamic subtest dmabuf: SUCCESS (0.774s)
[420.082668] Starting dynamic subtest: vma
[425.899178] Dynamic subtest vma: SUCCESS (5.824s)
[425.909517] Starting dynamic subtest: evict
[427.355747] Dynamic subtest evict: SUCCESS (1.438s)
[427.366661] Starting dynamic subtest: gtt
[430.739063] Dynamic subtest gtt: SUCCESS (3.398s)
[430.747877] Starting dynamic subtest: hugepages
[431.634258] Dynamic subtest hugepages: SUCCESS (0.893s)
[431.644471] Starting dynamic subtest: memory_region
[434.117048] Dynamic subtest memory_region: SUCCESS (2.481s)
[434.119884] Subtest mock: SUCCESS (40.273s)
[434.152569] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[434.153297] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[434.156307] [091/132] (595s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[435.765556] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[442.737643] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.973s)
[442.881878] [FACT kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[442.883201] [FACT kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)] new: kernel.kmod_is_loaded.i915: true
[442.887371] [092/132] (586s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[442.989012] Starting subtest: fbc-psr-sprite-mmap-gtt
[442.991280] Starting dynamic subtest: eDP-1
[442.995324] Dynamic subtest eDP-1: SKIP (0.000s)
[442.999443] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[443.069262] [093/132] (586s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[443.224642] Starting subtest: dp-mst-type-1-suspend-resume
[443.229193] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[443.345893] [094/132] (585s left) kms_big_fb (x-tiled-addfb)
[443.452815] Starting subtest: x-tiled-addfb
[443.455109] Subtest x-tiled-addfb: SUCCESS (0.000s)
[443.552139] [095/132] (585s left) kms_big_fb (4-tiled-addfb-size-overflow)
[443.655360] Starting subtest: 4-tiled-addfb-size-overflow
[443.657828] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[443.769297] [096/132] (585s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[443.869417] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[443.872896] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[443.959014] [097/132] (585s left) kms_lease (cursor-implicit-plane)
[444.059261] Starting subtest: cursor-implicit-plane
[444.061129] Starting dynamic subtest: pipe-A-eDP-1
[444.517463] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.458s)
[444.527692] Starting dynamic subtest: pipe-B-eDP-1
[445.650479] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.131s)
[445.660557] Starting dynamic subtest: pipe-C-eDP-1
[446.763716] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.113s)
[446.775964] Starting dynamic subtest: pipe-D-eDP-1
[447.892950] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.128s)
[447.895618] Subtest cursor-implicit-plane: SUCCESS (3.835s)
[448.757033] [098/132] (580s left) kms_fbcon_fbt (fbc-suspend)
[448.821187] Starting subtest: fbc-suspend
[498.590148] Subtest fbc-suspend: SUCCESS (19.050s)
[499.967345] [099/132] (529s left) gem_vm_create (create-ext)
[500.038049] Starting subtest: create-ext
[500.040500] Subtest create-ext: SUCCESS (0.004s)
[500.160203] [100/132] (529s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[500.263034] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[500.267189] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[500.365320] [101/132] (529s left) gem_mmap (bad-object)
[500.445606] Subtest bad-object: SKIP (0.000s)
[500.506486] [102/132] (529s left) gem_reg_read (timestamp-moving)
[500.566047] Starting subtest: timestamp-moving
[501.567709] Subtest timestamp-moving: SUCCESS (0.989s)
[501.644634] [103/132] (528s left) gem_pxp (display-protected-crc)
[501.771765] Starting subtest: display-protected-crc
[503.495263] Subtest display-protected-crc: SUCCESS (1.708s)
[503.605345] [104/132] (526s left) syncobj_timeline (invalid-signal-illegal-point)
[503.659990] Starting subtest: invalid-signal-illegal-point
[503.662191] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[503.756179] [105/132] (526s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[503.845169] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[503.847441] Starting dynamic subtest: pipe-A-default-mode
[506.583942] Dynamic subtest pipe-A-default-mode: SUCCESS (2.718s)
[506.586401] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.719s)
[507.454723] [106/132] (522s left) gem_partial_pwrite_pread (reads)
[507.513458] Subtest reads: SKIP (0.000s)
[507.583567] [107/132] (522s left) perf (gen12-unprivileged-single-ctx-counters)
[507.704968] Starting subtest: gen12-unprivileged-single-ctx-counters
[507.707136] Starting dynamic subtest: rcs0
[507.784548] Dynamic subtest rcs0: SUCCESS (0.079s)
[507.786941] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.080s)
[507.837523] [108/132] (522s left) kms_plane (plane-position-hole)
[507.969310] Starting subtest: plane-position-hole
[508.495144] Starting dynamic subtest: pipe-A-plane-1
[509.770498] Dynamic subtest pipe-A-plane-1: SUCCESS (1.271s)
[509.780215] Starting dynamic subtest: pipe-A-plane-2
[511.088898] Dynamic subtest pipe-A-plane-2: SUCCESS (1.311s)
[511.098538] Starting dynamic subtest: pipe-A-plane-3
[512.428340] Dynamic subtest pipe-A-plane-3: SUCCESS (1.332s)
[512.438615] Starting dynamic subtest: pipe-A-plane-4
[513.754543] Dynamic subtest pipe-A-plane-4: SUCCESS (1.324s)
[513.765040] Starting dynamic subtest: pipe-A-plane-5
[513.781966] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[514.926309] Starting dynamic subtest: pipe-B-plane-1
[516.280294] Dynamic subtest pipe-B-plane-1: SUCCESS (1.361s)
[516.290151] Starting dynamic subtest: pipe-B-plane-2
[517.589511] Dynamic subtest pipe-B-plane-2: SUCCESS (1.307s)
[517.599531] Starting dynamic subtest: pipe-B-plane-3
[518.924729] Dynamic subtest pipe-B-plane-3: SUCCESS (1.330s)
[518.935815] Starting dynamic subtest: pipe-B-plane-4
[520.256948] Dynamic subtest pipe-B-plane-4: SUCCESS (1.327s)
[520.267228] Starting dynamic subtest: pipe-B-plane-5
[520.282783] Dynamic subtest pipe-B-plane-5: SUCCESS (0.026s)
[520.285018] Subtest plane-position-hole: SUCCESS (12.278s)
[521.058556] [109/132] (508s left) gem_exec_schedule (implicit-read-write)
[521.140847] Starting subtest: implicit-read-write
[521.142865] Starting dynamic subtest: rcs0
[521.260802] Dynamic subtest rcs0: SUCCESS (0.123s)
[521.274352] Starting dynamic subtest: vcs0
[521.345109] Dynamic subtest vcs0: SUCCESS (0.084s)
[521.359202] Starting dynamic subtest: vcs1
[521.423702] Dynamic subtest vcs1: SUCCESS (0.078s)
[521.435475] Starting dynamic subtest: vecs0
[521.509326] Dynamic subtest vecs0: SUCCESS (0.084s)
[521.522319] Starting dynamic subtest: ccs0
[521.589771] Dynamic subtest ccs0: SUCCESS (0.079s)
[521.592404] Subtest implicit-read-write: SUCCESS (0.452s)
[522.466132] [110/132] (507s left) gem_exec_flush (basic-batch-kernel-default-uc)
[522.550035] Starting subtest: basic-batch-kernel-default-uc
[528.438684] Subtest basic-batch-kernel-default-uc: SUCCESS (5.889s)
[528.630734] [111/132] (501s left) gem_ctx_persistence (heartbeat-stop)
[528.711585] Starting subtest: heartbeat-stop
[528.716473] Subtest heartbeat-stop: SKIP (0.000s)
[528.828941] [112/132] (501s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[529.043955] Starting subtest: cursor-rapid-movement-128x128
[529.048885] Starting dynamic subtest: pipe-A-eDP-1
[529.601785] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.553s)
[529.631892] Starting dynamic subtest: pipe-D-eDP-1
[530.858602] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.233s)
[530.860972] Subtest cursor-rapid-movement-128x128: SUCCESS (1.813s)
[531.705263] [113/132] (498s left) kms_cdclk (plane-scaling)
[531.806005] Starting subtest: plane-scaling
[531.808102] Starting dynamic subtest: pipe-A-eDP-1
[532.099781] Dynamic subtest pipe-A-eDP-1: SKIP (0.291s)
[532.109979] Starting dynamic subtest: pipe-B-eDP-1
[532.114633] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[532.126053] Starting dynamic subtest: pipe-C-eDP-1
[532.130770] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[532.140077] Starting dynamic subtest: pipe-D-eDP-1
[532.144156] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[532.148256] Subtest plane-scaling: SKIP (0.299s)
[532.926667] [114/132] (497s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[533.022144] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[533.026567] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s)
[533.094616] [115/132] (497s left) perf_pmu (idle)
[533.139138] Starting subtest: idle
[533.141424] Starting dynamic subtest: rcs0
[533.676992] Dynamic subtest rcs0: SUCCESS (0.539s)
[533.688195] Starting dynamic subtest: bcs0
[534.196952] Dynamic subtest bcs0: SUCCESS (0.517s)
[534.207366] Starting dynamic subtest: vcs0
[534.712307] Dynamic subtest vcs0: SUCCESS (0.512s)
[534.725456] Starting dynamic subtest: vcs1
[535.232871] Dynamic subtest vcs1: SUCCESS (0.518s)
[535.243246] Starting dynamic subtest: vecs0
[535.752817] Dynamic subtest vecs0: SUCCESS (0.517s)
[535.765357] Starting dynamic subtest: ccs0
[536.266872] Dynamic subtest ccs0: SUCCESS (0.512s)
[536.269816] Subtest idle: SUCCESS (3.131s)
[536.361707] [116/132] (493s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[536.465406] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[536.469892] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[536.538105] [117/132] (493s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[536.599074] Starting subtest: invalid-bsd1-flag-on-vebox
[536.601400] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[536.700641] [118/132] (493s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[536.793684] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[536.795998] Starting dynamic subtest: pipe-A-eDP-1
[538.157025] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.362s)
[538.434318] Starting dynamic subtest: pipe-B-eDP-1
[539.481693] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.057s)
[539.750009] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.955s)
[540.615193] [119/132] (489s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[540.708466] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[540.719845] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[540.800121] [120/132] (489s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[540.887883] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[540.892336] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[540.987652] [121/132] (489s left) gen7_exec_parse (basic-rejected)
[541.039869] Subtest basic-rejected: SKIP (0.000s)
[541.120776] [122/132] (489s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[541.237141] Starting subtest: psr2-cursor-plane-update-sf
[541.239444] Starting dynamic subtest: pipe-A-eDP-1
[541.816471] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.576s)
[541.827394] Starting dynamic subtest: pipe-B-eDP-1
[543.093306] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.276s)
[543.095612] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.858s)
[543.954913] [123/132] (486s left) gem_exec_fence (syncobj-timeline-chain-engines)
[544.499698] Starting subtest: syncobj-timeline-chain-engines
[544.597325] Subtest syncobj-timeline-chain-engines: SUCCESS (0.099s)
[545.438910] [124/132] (485s left) gem_workarounds (reset-fd)
[545.503407] Starting subtest: reset-fd
[545.687029] Subtest reset-fd: SUCCESS (0.183s)
[545.833276] [125/132] (484s left) i915_module_load (resize-bar)
[545.869638] Starting subtest: resize-bar
[545.880563] Subtest resize-bar: SKIP (0.009s)
[545.931808] [126/132] (484s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[546.016656] Starting subtest: crc-primary-suspend-y-tiled-ccs
[546.018883] Starting dynamic subtest: pipe-A-eDP-1
[546.027861] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[546.040649] Starting dynamic subtest: pipe-B-eDP-1
[546.049799] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[546.063377] Starting dynamic subtest: pipe-C-eDP-1
[546.072177] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[546.081889] Starting dynamic subtest: pipe-D-eDP-1
[546.090718] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[546.095153] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.005s)
[548.317207] [127/132] (482s left) syncobj_timeline (etime-single-wait-submitted)
[548.374827] Starting subtest: etime-single-wait-submitted
[548.479641] Subtest etime-single-wait-submitted: SUCCESS (0.103s)
[548.564256] [128/132] (482s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[548.680918] Starting subtest: short-busy-flip-before-cursor-toggle
[548.685494] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[548.830970] [129/132] (481s left) gem_pxp (reject-modify-context-protection-on)
[548.902824] Starting subtest: reject-modify-context-protection-on
[548.905355] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[549.033118] [130/132] (481s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[549.151800] Starting subtest: cursorB-vs-flipB-legacy
[549.156192] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[549.299280] [131/132] (481s left) kms_flip (busy-flip)
[549.399653] Starting subtest: busy-flip
[549.401572] Starting dynamic subtest: A-eDP1
[551.120759] Dynamic subtest A-eDP1: SUCCESS (1.722s)
[551.132100] Starting dynamic subtest: B-eDP1
[552.851194] Dynamic subtest B-eDP1: SUCCESS (1.728s)
[552.863472] Starting dynamic subtest: C-eDP1
[554.492153] Dynamic subtest C-eDP1: SUCCESS (1.638s)
[554.504980] Starting dynamic subtest: D-eDP1
[556.124103] Dynamic subtest D-eDP1: SUCCESS (1.629s)
[556.126484] Subtest busy-flip: SUCCESS (6.728s)
[557.285775] [132/132] (473s left) perf (whitelisted-registers-userspace-config)
[557.388257] Starting subtest: whitelisted-registers-userspace-config
[557.390780] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[557.428406] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_schedule
results: parsing output: 1/ for test: kms_vblank
results: parsing output: 2/ for test: kms_dsc
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: prime_udl
results: parsing output: 6/ for test: gem_softpin
results: parsing output: 7/ for test: gem_ringfill
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: kms_properties
results: parsing output: 10/ for test: prime_busy
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_psr2_sf
results: parsing output: 14/ for test: gem_lmem_swapping
results: parsing output: 15/ for test: gem_ctx_param
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_ctx_param
results: parsing output: 20/ for test: gen9_exec_parse
results: parsing output: 21/ for test: gem_readwrite
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: gem_exec_reloc
results: parsing output: 27/ for test: gem_eio
results: parsing output: 28/ for test: kms_scaling_modes
results: parsing output: 29/ for test: perf
results: parsing output: 30/ for test: kms_addfb_basic
results: parsing output: 31/ for test: gem_exec_reloc
results: parsing output: 32/ for test: gem_mmap_offset
results: parsing output: 33/ for test: gem_exec_balancer
results: parsing output: 34/ for test: core_getclient
results: parsing output: 35/ for test: kms_cursor_crc
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_multipipe_modeset
results: parsing output: 38/ for test: kms_chamelium_edid
results: parsing output: 39/ for test: kms_pm_rpm
results: parsing output: 40/ for test: kms_plane
results: parsing output: 41/ for test: dmabuf_sync_file
results: parsing output: 42/ for test: gem_softpin
results: parsing output: 43/ for test: kms_ccs
results: parsing output: 44/ for test: api_intel_allocator
results: parsing output: 45/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 46/ for test: kms_color
results: parsing output: 47/ for test: i915_pm_rps
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: kms_flip
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_ccs
results: parsing output: 53/ for test: gem_userptr_blits
results: parsing output: 54/ for test: fbdev
results: parsing output: 55/ for test: kms_chamelium_hpd
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: perf_pmu
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_ctx_sseu
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_invalid_mode
results: parsing output: 63/ for test: gem_eio
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: prime_mmap_kms
results: parsing output: 69/ for test: kms_sequence
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_exec_schedule
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: syncobj_wait
results: parsing output: 74/ for test: gem_render_linear_blits
results: parsing output: 75/ for test: kms_plane_scaling
results: parsing output: 76/ for test: syncobj_timeline
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: gem_ctx_engines
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_exec_capture
results: parsing output: 82/ for test: gem_eio
results: parsing output: 83/ for test: kms_cursor_crc
results: parsing output: 84/ for test: gem_mmap_gtt
results: parsing output: 85/ for test: gem_render_copy
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: perf
results: parsing output: 88/ for test: kms_flip_scaled_crc
results: parsing output: 89/ for test: i915_selftest
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: kms_content_protection
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_lease
results: parsing output: 97/ for test: kms_fbcon_fbt
results: parsing output: 98/ for test: gem_vm_create
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_mmap
results: parsing output: 101/ for test: gem_reg_read
results: parsing output: 102/ for test: gem_pxp
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: kms_flip_scaled_crc
results: parsing output: 105/ for test: gem_partial_pwrite_pread
results: parsing output: 106/ for test: perf
results: parsing output: 107/ for test: kms_plane
results: parsing output: 108/ for test: gem_exec_schedule
results: parsing output: 109/ for test: gem_exec_flush
results: parsing output: 110/ for test: gem_ctx_persistence
results: parsing output: 111/ for test: kms_cursor_crc
results: parsing output: 112/ for test: kms_cdclk
results: parsing output: 113/ for test: kms_plane
results: parsing output: 114/ for test: perf_pmu
results: parsing output: 115/ for test: kms_flip_scaled_crc
results: parsing output: 116/ for test: gem_exec_params
results: parsing output: 117/ for test: kms_atomic_transition
results: parsing output: 118/ for test: kms_flip
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: gen7_exec_parse
results: parsing output: 121/ for test: kms_psr2_sf
results: parsing output: 122/ for test: gem_exec_fence
results: parsing output: 123/ for test: gem_workarounds
results: parsing output: 124/ for test: i915_module_load
results: parsing output: 125/ for test: kms_ccs
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: kms_cursor_legacy
results: parsing output: 128/ for test: gem_pxp
results: parsing output: 129/ for test: kms_cursor_legacy
results: parsing output: 130/ for test: kms_flip
results: parsing output: 131/ for test: perf
Done.