[57.344769] Initializing watchdogs
[57.344843]   /dev/watchdog0
[57.360478] [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.364908] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.367559] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.371375] [001/155] (960s left) kms_pm_rpm (cursor)
[59.465484] Starting subtest: cursor
[59.471037] Subtest cursor: SKIP (0.000s)
[59.857676] [002/155] (958s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[59.964875] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[63.727076] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.751s)
[64.881077] [003/155] (953s left) kms_invalid_mode (overflow-vrefresh)
[64.976658] Starting subtest: overflow-vrefresh
[64.979120] Starting dynamic subtest: pipe-A-eDP-1
[65.269079] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.296s)
[65.277865] Starting dynamic subtest: pipe-B-eDP-1
[65.280059] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[65.287677] Starting dynamic subtest: pipe-C-eDP-1
[65.289877] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[65.297826] Starting dynamic subtest: pipe-D-eDP-1
[65.300342] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[65.302754] Subtest overflow-vrefresh: SUCCESS (0.301s)
[66.109471] [004/155] (951s left) kms_cursor_crc (cursor-alpha-transparent)
[66.212371] Starting subtest: cursor-alpha-transparent
[66.214774] Starting dynamic subtest: pipe-A-eDP-1
[66.860726] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.649s)
[66.869186] Starting dynamic subtest: pipe-D-eDP-1
[68.193920] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.327s)
[68.196304] Subtest cursor-alpha-transparent: SUCCESS (1.978s)
[69.078542] [005/155] (948s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[69.183957] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[69.188622] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[69.274795] [006/155] (948s left) kms_flip (2x-blocking-wf_vblank)
[69.375079] Starting subtest: 2x-blocking-wf_vblank
[69.384598] Subtest 2x-blocking-wf_vblank: SKIP (0.011s)
[69.464925] [007/155] (948s left) kms_big_fb (linear-32bpp-rotate-0)
[69.570401] Starting subtest: linear-32bpp-rotate-0
[70.163877] Subtest linear-32bpp-rotate-0: FAIL (0.041s)
[70.198151] [008/155] (947s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-render)
[70.300843] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-render
[70.304521] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[70.408794] [009/155] (947s left) perf (low-oa-exponent-permissions)
[70.522392] Starting subtest: low-oa-exponent-permissions
[70.561442] Subtest low-oa-exponent-permissions: SUCCESS (0.040s)
[70.611064] [010/155] (947s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[70.698193] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[70.701932] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[70.780547] [011/155] (947s left) gem_exec_schedule (thriceslice)
[70.853276] Starting subtest: thriceslice
[70.855295] Starting dynamic subtest: rcs0
[70.878617] Dynamic subtest rcs0: SUCCESS (0.031s)
[70.889464] Starting dynamic subtest: bcs0
[70.907595] Dynamic subtest bcs0: SUCCESS (0.029s)
[70.915470] Starting dynamic subtest: vcs0
[70.960579] Dynamic subtest vcs0: SUCCESS (0.052s)
[70.971276] Starting dynamic subtest: vcs1
[70.994336] Dynamic subtest vcs1: SUCCESS (0.033s)
[71.003076] Starting dynamic subtest: vecs0
[71.045854] Dynamic subtest vecs0: SUCCESS (0.050s)
[71.057597] Starting dynamic subtest: ccs0
[71.076137] Dynamic subtest ccs0: SUCCESS (0.030s)
[71.078171] Subtest thriceslice: SUCCESS (0.229s)
[71.380422] [012/155] (946s left) gem_exec_schedule (out-order)
[71.449845] Starting subtest: out-order
[71.451746] Starting dynamic subtest: rcs0
[71.555102] Dynamic subtest rcs0: SUCCESS (0.108s)
[71.567101] Starting dynamic subtest: vcs0
[71.634212] Dynamic subtest vcs0: SUCCESS (0.078s)
[71.645885] Starting dynamic subtest: vcs1
[71.712739] Dynamic subtest vcs1: SUCCESS (0.078s)
[71.725088] Starting dynamic subtest: vecs0
[71.788448] Dynamic subtest vecs0: SUCCESS (0.075s)
[71.799995] Starting dynamic subtest: ccs0
[71.878901] Dynamic subtest ccs0: SUCCESS (0.090s)
[71.881630] Subtest out-order: SUCCESS (0.431s)
[73.427254] [013/155] (944s left) gem_sync (basic-all)
[73.589029] Starting subtest: basic-all
[76.616988] Subtest basic-all: SUCCESS (3.013s)
[76.779810] [014/155] (941s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-blt)
[76.879206] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-blt
[76.883755] Subtest fbchdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[76.969960] [015/155] (941s left) i915_pm_rps (waitboost)
[77.025348] Starting subtest: waitboost
[83.098704] Subtest waitboost: SUCCESS (6.072s)
[83.233209] [016/155] (935s left) kms_pm_rpm (pm-tiling)
[85.477089] Starting subtest: pm-tiling
[85.482181] Subtest pm-tiling: SKIP (0.000s)
[85.862735] [017/155] (932s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-blt)
[85.965773] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-blt
[85.970185] Subtest fbchdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[86.050789] [018/155] (932s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[86.157195] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[92.957739] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.805s)
[93.116228] [019/155] (925s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-move)
[93.224956] Starting subtest: fbchdr-1p-primscrn-spr-indfb-move
[93.229234] Subtest fbchdr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[93.312960] [020/155] (925s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[93.408231] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[93.412567] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.000s)
[93.479105] [021/155] (925s left) gem_lmem_swapping (random-engines)
[93.521417] Subtest random-engines: SKIP (0.000s)
[93.563046] [022/155] (925s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[93.665079] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[93.669387] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[93.771693] [023/155] (924s left) gem_ppgtt (shrink-vs-evict-any)
[93.829765] Starting subtest: shrink-vs-evict-any
[99.351102] Subtest shrink-vs-evict-any: SUCCESS (5.465s)
[99.386124] [024/155] (919s left) gem_mmap_gtt (big-copy)
[99.440640] Subtest big-copy: SKIP (0.000s)
[99.497561] [025/155] (919s left) gem_mmap_gtt (basic-read-write)
[99.556334] Subtest basic-read-write: SKIP (0.000s)
[99.612677] [026/155] (919s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-onoff)
[99.716425] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-onoff
[99.720450] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[99.810851] [027/155] (919s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[99.904604] Starting subtest: bad-rotation-90-y-tiled-ccs
[99.906953] Starting dynamic subtest: pipe-A-eDP-1
[99.929351] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[99.938659] Starting dynamic subtest: pipe-B-eDP-1
[99.960112] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[99.968461] Starting dynamic subtest: pipe-C-eDP-1
[99.990904] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[99.998983] Starting dynamic subtest: pipe-D-eDP-1
[100.021031] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[100.025405] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.003s)
[102.499337] [028/155] (916s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[102.596346] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[102.598740] Starting dynamic subtest: pipe-A-eDP-1
[102.621964] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[102.633055] Starting dynamic subtest: pipe-B-eDP-1
[102.654239] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[102.662643] Starting dynamic subtest: pipe-C-eDP-1
[102.683381] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[102.691311] Starting dynamic subtest: pipe-D-eDP-1
[102.713170] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[102.717514] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.003s)
[104.932447] [029/155] (914s left) vgem_basic (sysfs)
[105.030968] Starting subtest: sysfs
[105.033302] Subtest sysfs: SUCCESS (0.002s)
[105.084742] [FACT vgem_basic (sysfs)] new: kernel.kmod_is_loaded.vgem: true
[105.087726] [030/155] (913s left) kms_cursor_crc (cursor-random-32x10)
[105.251492] Starting subtest: cursor-random-32x10
[105.302671] Subtest cursor-random-32x10: SKIP (0.046s)
[105.559762] [031/155] (913s left) perf_pmu (most-busy-check-all)
[105.598832] Starting subtest: most-busy-check-all
[105.601288] Starting dynamic subtest: rcs0
[107.275281] Dynamic subtest rcs0: SUCCESS (1.675s)
[107.286687] Starting dynamic subtest: bcs0
[109.259672] Dynamic subtest bcs0: SUCCESS (1.983s)
[109.272049] Starting dynamic subtest: vcs0
[111.307913] Dynamic subtest vcs0: SUCCESS (2.047s)
[111.319042] Starting dynamic subtest: vcs1
[113.293229] Dynamic subtest vcs1: SUCCESS (1.984s)
[113.305081] Starting dynamic subtest: vecs0
[115.340082] Dynamic subtest vecs0: SUCCESS (2.045s)
[115.353216] Starting dynamic subtest: ccs0
[117.324353] Dynamic subtest ccs0: SUCCESS (1.983s)
[117.327374] Subtest most-busy-check-all: SUCCESS (11.724s)
[117.430606] [032/155] (901s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[117.534341] Starting subtest: 2x-flip-vs-rmfb-interruptible
[117.547042] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.012s)
[117.622953] [033/155] (901s left) gem_softpin (allocator-basic)
[117.676362] Starting subtest: allocator-basic
[117.751271] Subtest allocator-basic: SUCCESS (0.074s)
[117.892705] [034/155] (901s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[118.001213] Starting subtest: x-tiled-32bpp-rotate-270
[118.020355] Subtest x-tiled-32bpp-rotate-270: SKIP (0.019s)
[118.121296] [035/155] (901s left) kms_frontbuffer_tracking (psrhdr-suspend)
[118.219306] Starting subtest: psrhdr-suspend
[118.223424] Subtest psrhdr-suspend: SKIP (0.000s)
[118.321270] [036/155] (900s left) gem_userptr_blits (sync-unmap-cycles)
[118.384814] Starting subtest: sync-unmap-cycles
[123.756565] Subtest sync-unmap-cycles: SUCCESS (5.373s)
[123.875860] [037/155] (895s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[123.974648] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[123.976637] Starting dynamic subtest: pipe-A-eDP-1
[124.072930] Dynamic subtest pipe-A-eDP-1: SKIP (0.101s)
[124.084787] Starting dynamic subtest: pipe-B-eDP-1
[125.216325] Dynamic subtest pipe-B-eDP-1: SKIP (1.140s)
[125.220849] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.243s)
[126.490187] [038/155] (892s left) kms_frontbuffer_tracking (fbc-2p-rte)
[126.589660] Starting subtest: fbc-2p-rte
[126.593701] Subtest fbc-2p-rte: SKIP (0.000s)
[126.686464] [039/155] (892s left) gem_mmap_gtt (basic)
[126.741237] Subtest basic: SKIP (0.000s)
[126.809269] [040/155] (892s left) gem_softpin (evict-single-offset)
[126.863022] Starting subtest: evict-single-offset
[154.253333] Subtest evict-single-offset: SUCCESS (27.388s)
[154.352576] [041/155] (865s left) gem_exec_balancer (invalid-balancer)
[154.457615] Starting subtest: invalid-balancer
[155.398715] Subtest invalid-balancer: SUCCESS (0.940s)
[155.700098] [042/155] (863s left) syncobj_timeline (signal)
[155.758229] Starting subtest: signal
[155.760547] Subtest signal: SUCCESS (0.000s)
[155.864709] [043/155] (863s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-linear)
[155.969721] Starting subtest: fbcpsrhdr-tiling-linear
[155.973966] Subtest fbcpsrhdr-tiling-linear: SKIP (0.000s)
[156.073845] [044/155] (863s left) kms_plane (pixel-format-4-tiled-modifier)
[156.176313] Starting subtest: pixel-format-4-tiled-modifier
[156.201729] Starting dynamic subtest: pipe-A-plane-0
[156.623623] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[156.633926] Starting dynamic subtest: pipe-A-plane-3
[156.957248] Dynamic subtest pipe-A-plane-3: SUCCESS (0.333s)
[156.968707] Starting dynamic subtest: pipe-A-plane-5
[156.972708] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[158.072381] Starting dynamic subtest: pipe-B-plane-0
[158.475981] Dynamic subtest pipe-B-plane-0: SUCCESS (0.411s)
[158.487828] Starting dynamic subtest: pipe-B-plane-3
[158.809252] Dynamic subtest pipe-B-plane-3: SUCCESS (0.333s)
[158.821168] Starting dynamic subtest: pipe-B-plane-5
[158.825735] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[159.134562] Subtest pixel-format-4-tiled-modifier: SUCCESS (2.958s)
[159.943071] [045/155] (859s left) syncobj_timeline (single-wait-for-submit-signaled)
[160.004992] Starting subtest: single-wait-for-submit-signaled
[160.007084] Subtest single-wait-for-submit-signaled: SUCCESS (0.001s)
[160.109791] [046/155] (859s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[160.205381] Starting subtest: read-crc-frame-sequence
[160.207686] Starting dynamic subtest: pipe-A-eDP-1
[160.907642] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.702s)
[160.919798] Starting dynamic subtest: pipe-B-eDP-1
[162.318466] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.410s)
[162.328484] Starting dynamic subtest: pipe-C-eDP-1
[163.715648] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.395s)
[163.728085] Starting dynamic subtest: pipe-D-eDP-1
[165.050471] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.334s)
[165.052883] Subtest read-crc-frame-sequence: SUCCESS (4.847s)
[165.875769] [047/155] (853s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[165.969674] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-mmap-cpu
[165.974089] Subtest hdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[166.080307] [048/155] (853s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[166.173165] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[166.175494] Starting dynamic subtest: pipe-A-eDP-1
[166.184711] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[166.196179] Starting dynamic subtest: pipe-B-eDP-1
[166.205105] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[166.214936] Starting dynamic subtest: pipe-C-eDP-1
[166.223765] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[166.233224] Starting dynamic subtest: pipe-D-eDP-1
[166.242063] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[166.246180] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[168.427193] [049/155] (851s left) kms_psr (pr-cursor-mmap-cpu)
[168.527111] Starting subtest: pr-cursor-mmap-cpu
[168.531572] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[168.602042] [050/155] (851s left) gem_ctx_isolation (clean)
[168.662664] Starting subtest: clean
[168.664886] Starting dynamic subtest: rcs0
[168.713465] Dynamic subtest rcs0: SUCCESS (0.051s)
[168.723941] Starting dynamic subtest: bcs0
[168.785790] Dynamic subtest bcs0: SUCCESS (0.072s)
[168.796497] Starting dynamic subtest: vcs0
[168.852752] Dynamic subtest vcs0: SUCCESS (0.066s)
[168.864643] Starting dynamic subtest: vcs1
[170.307434] Dynamic subtest vcs1: SUCCESS (1.453s)
[170.318673] Starting dynamic subtest: vecs0
[172.296756] Dynamic subtest vecs0: SUCCESS (1.989s)
[172.307222] Starting dynamic subtest: ccs0
[174.278588] Dynamic subtest ccs0: SUCCESS (1.981s)
[174.280929] Subtest clean: SUCCESS (5.616s)
[174.524047] [051/155] (845s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-shrfb-msflip-blt)
[174.615217] Starting subtest: fbchdr-2p-scndscrn-shrfb-msflip-blt
[174.619536] Subtest fbchdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[174.719434] [052/155] (845s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-blt)
[174.811296] Starting subtest: psrhdr-rgb565-draw-blt
[174.815547] Subtest psrhdr-rgb565-draw-blt: SKIP (0.000s)
[174.902160] [053/155] (845s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[174.995871] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[180.118433] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (5.127s)
[180.230742] [054/155] (839s left) kms_setmode (invalid-clone-single-crtc)
[180.283530] Starting subtest: invalid-clone-single-crtc
[180.290069] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[180.376337] [055/155] (839s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[180.465476] Starting subtest: fbc-shrfb-scaledprimary
[183.390344] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.929s)
[184.613076] [056/155] (835s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-mmap-cpu)
[184.712099] Starting subtest: fbchdr-rgb565-draw-mmap-cpu
[184.716479] Subtest fbchdr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[184.809204] [057/155] (835s left) kms_psr (pr-dpms)
[184.897036] Starting subtest: pr-dpms
[184.901483] Subtest pr-dpms: SKIP (0.000s)
[184.970502] [058/155] (835s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[185.029459] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[185.093357] [059/155] (835s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[185.193682] Starting subtest: psr-rgb565-draw-mmap-cpu
[192.027605] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.843s)
[192.131095] [060/155] (828s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[192.220887] Starting subtest: fbc-psr2-cursor-plane-onoff
[192.223528] Starting dynamic subtest: eDP-1
[192.228409] Dynamic subtest eDP-1: SKIP (0.000s)
[192.233232] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[192.296113] [061/155] (828s left) prime_vgem (coherency-blt)
[192.364796] Starting subtest: coherency-blt
[193.477676] Subtest coherency-blt: SUCCESS (1.110s)
[193.624328] [062/155] (826s left) perf (gen8-unprivileged-single-ctx-counters)
[193.742877] Starting subtest: gen8-unprivileged-single-ctx-counters
[193.747613] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[193.793850] [063/155] (826s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-pwrite)
[193.896143] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-pwrite
[193.900241] Subtest hdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[194.006841] [064/155] (826s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[194.105828] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[201.524864] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.424s)
[201.641866] [065/155] (818s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[201.750688] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[202.884975] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.135s)
[203.028627] [066/155] (817s left) kms_async_flips (alternate-sync-async-flip)
[203.121225] Starting subtest: alternate-sync-async-flip
[203.499494] Starting dynamic subtest: pipe-A-eDP-1
[206.247430] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.750s)
[206.620078] Starting dynamic subtest: pipe-B-eDP-1
[209.372097] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.761s)
[209.752809] Starting dynamic subtest: pipe-C-eDP-1
[212.495136] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.754s)
[212.865922] Starting dynamic subtest: pipe-D-eDP-1
[215.626050] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.768s)
[215.628095] Subtest alternate-sync-async-flip: SUCCESS (12.506s)
[216.804986] [067/155] (803s left) gem_exec_schedule (implicit-boths)
[216.879134] Starting subtest: implicit-boths
[216.880973] Starting dynamic subtest: rcs0
[216.983724] Dynamic subtest rcs0: SUCCESS (0.113s)
[216.995383] Starting dynamic subtest: vcs0
[217.070786] Dynamic subtest vcs0: SUCCESS (0.086s)
[217.083258] Starting dynamic subtest: vcs1
[217.154838] Dynamic subtest vcs1: SUCCESS (0.081s)
[217.167882] Starting dynamic subtest: vecs0
[217.231700] Dynamic subtest vecs0: SUCCESS (0.077s)
[217.247666] Starting dynamic subtest: ccs0
[217.319787] Dynamic subtest ccs0: SUCCESS (0.084s)
[217.322320] Subtest implicit-boths: SUCCESS (0.450s)
[218.414596] [068/155] (802s left) gem_exec_fence (basic-busy-all)
[218.478034] Starting subtest: basic-busy-all
[218.555667] Subtest basic-busy-all: SUCCESS (0.078s)
[220.390722] [069/155] (800s left) sw_sync (alloc_fence_invalid_timeline)
[220.427589] Starting subtest: alloc_fence_invalid_timeline
[220.429831] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[220.502304] [070/155] (800s left) kms_cursor_crc (cursor-size-change)
[220.609965] Starting subtest: cursor-size-change
[220.612317] Starting dynamic subtest: pipe-A-eDP-1
[221.435619] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.824s)
[221.445848] Starting dynamic subtest: pipe-D-eDP-1
[222.876083] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.437s)
[222.878369] Subtest cursor-size-change: SUCCESS (2.266s)
[223.772148] [071/155] (796s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[223.885223] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[223.889302] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[223.983713] [072/155] (796s left) kms_psr (psr-cursor-render)
[224.067148] Starting subtest: psr-cursor-render
[224.069397] Starting dynamic subtest: eDP-1
[225.769694] Dynamic subtest eDP-1: SUCCESS (1.702s)
[225.771967] Subtest psr-cursor-render: SUCCESS (1.703s)
[226.642426] [073/155] (794s left) sw_sync (sync_busy_fork)
[226.682374] Starting subtest: sync_busy_fork
[227.697070] Subtest sync_busy_fork: SUCCESS (1.013s)
[227.774704] [074/155] (793s left) sysfs_heartbeat_interval (precise)
[227.834212] Starting subtest: precise
[227.836077] Starting dynamic subtest: vecs0
[235.268959] Dynamic subtest vecs0: SUCCESS (7.436s)
[235.287750] Starting dynamic subtest: ccs0
[236.455550] Dynamic subtest ccs0: SUCCESS (1.184s)
[236.468068] Starting dynamic subtest: vcs0
[244.289824] Dynamic subtest vcs0: SUCCESS (7.829s)
[244.302657] Starting dynamic subtest: bcs0
[245.396164] Dynamic subtest bcs0: SUCCESS (1.106s)
[245.413118] Starting dynamic subtest: rcs0
[246.492865] Dynamic subtest rcs0: SUCCESS (1.093s)
[246.503752] Starting dynamic subtest: vcs1
[254.281714] Dynamic subtest vcs1: SUCCESS (7.787s)
[254.284624] Subtest precise: SUCCESS (26.450s)
[254.366882] [075/155] (766s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[254.471320] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[254.475420] Subtest hdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[254.589088] [076/155] (766s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[254.975931] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[255.761329] [077/155] (765s left) syncobj_wait (signal)
[255.827571] Starting subtest: signal
[255.829896] Subtest signal: SUCCESS (0.000s)
[255.947632] [078/155] (765s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-move)
[256.058105] Starting subtest: hdr-1p-primscrn-spr-indfb-move
[256.062071] Subtest hdr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[256.157655] [079/155] (764s left) gem_fence_thrash (bo-write-verify-y)
[256.194547] Starting subtest: bo-write-verify-y
[256.215873] Subtest bo-write-verify-y: SKIP (0.018s)
[256.278713] [080/155] (764s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[256.329270] Starting subtest: multi-wait-for-submit-unsubmitted
[256.432747] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.102s)
[256.518270] [081/155] (764s left) kms_plane (plane-position-hole)
[256.608285] Starting subtest: plane-position-hole
[257.233699] Starting dynamic subtest: pipe-A-plane-1
[258.587988] Dynamic subtest pipe-A-plane-1: SUCCESS (1.352s)
[258.598025] Starting dynamic subtest: pipe-A-plane-2
[259.930320] Dynamic subtest pipe-A-plane-2: SUCCESS (1.343s)
[259.941713] Starting dynamic subtest: pipe-A-plane-3
[261.257505] Dynamic subtest pipe-A-plane-3: SUCCESS (1.324s)
[261.268143] Starting dynamic subtest: pipe-A-plane-4
[262.593338] Dynamic subtest pipe-A-plane-4: SUCCESS (1.337s)
[262.603564] Starting dynamic subtest: pipe-A-plane-5
[262.620633] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[263.836587] Starting dynamic subtest: pipe-B-plane-1
[265.162355] Dynamic subtest pipe-B-plane-1: SUCCESS (1.334s)
[265.172873] Starting dynamic subtest: pipe-B-plane-2
[266.501252] Dynamic subtest pipe-B-plane-2: SUCCESS (1.339s)
[266.511933] Starting dynamic subtest: pipe-B-plane-3
[267.822914] Dynamic subtest pipe-B-plane-3: SUCCESS (1.322s)
[267.834809] Starting dynamic subtest: pipe-B-plane-4
[269.158245] Dynamic subtest pipe-B-plane-4: SUCCESS (1.333s)
[269.169159] Starting dynamic subtest: pipe-B-plane-5
[269.184499] Dynamic subtest pipe-B-plane-5: SUCCESS (0.026s)
[269.186785] Subtest plane-position-hole: SUCCESS (12.576s)
[270.011090] [082/155] (751s left) gem_render_copy (yf-tiled)
[270.068636] Starting subtest: yf-tiled
[270.072915] Subtest yf-tiled: SKIP (0.000s)
[270.271918] [083/155] (750s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-blt)
[270.370145] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-blt
[270.374405] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[270.468218] [084/155] (750s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[270.573104] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[270.577505] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[270.666780] [085/155] (750s left) i915_pm_rpm (sysfs-read)
[272.514818] Starting subtest: sysfs-read
[273.674990] Subtest sysfs-read: SUCCESS (1.158s)
[274.072300] [086/155] (747s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[274.206749] Starting subtest: basic-busy-flip-before-cursor-varying-size
[274.211314] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[274.349053] [087/155] (747s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[274.444719] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt
[274.448807] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[274.524532] [088/155] (746s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-render)
[274.620965] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-render
[274.625390] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[274.735951] [089/155] (746s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[274.830487] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[274.834535] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[274.930278] [090/155] (746s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[275.032361] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[275.034321] Starting dynamic subtest: pipe-A-eDP-1
[275.110117] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s)
[275.120762] Starting dynamic subtest: pipe-B-eDP-1
[276.238035] Dynamic subtest pipe-B-eDP-1: SKIP (1.123s)
[276.243151] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.204s)
[277.414876] [091/155] (744s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[277.503538] Starting subtest: random-ccs-data-yf-tiled-ccs
[277.505687] Starting dynamic subtest: pipe-A-eDP-1
[277.530075] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[277.540816] Starting dynamic subtest: pipe-B-eDP-1
[277.563651] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[277.573025] Starting dynamic subtest: pipe-C-eDP-1
[277.595690] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[277.605089] Starting dynamic subtest: pipe-D-eDP-1
[277.628724] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[277.633134] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.004s)
[279.771578] [092/155] (741s left) core_setmaster (master-drop-set-root)
[279.829627] Starting subtest: master-drop-set-root
[279.854219] Subtest master-drop-set-root: SUCCESS (0.024s)
[279.905244] [093/155] (741s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[280.011166] Starting subtest: flip-primary-invalidate-overlay
[294.996340] Subtest flip-primary-invalidate-overlay: SUCCESS (14.988s)
[295.143103] [094/155] (726s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[295.534262] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[296.383273] [095/155] (725s left) gem_ctx_persistence (legacy-engines-cleanup)
[296.437414] Starting subtest: legacy-engines-cleanup
[296.439866] Starting dynamic subtest: render
[296.516653] Dynamic subtest render: SUCCESS (0.078s)
[296.531323] Starting dynamic subtest: bsd1
[296.570577] Dynamic subtest bsd1: SUCCESS (0.051s)
[296.585669] Starting dynamic subtest: bsd2
[296.624704] Dynamic subtest bsd2: SUCCESS (0.051s)
[296.636425] Starting dynamic subtest: blt
[296.681706] Dynamic subtest blt: SUCCESS (0.054s)
[296.696762] Starting dynamic subtest: vebox
[296.728465] Dynamic subtest vebox: SUCCESS (0.044s)
[296.730920] Subtest legacy-engines-cleanup: SUCCESS (0.292s)
[296.836716] [096/155] (724s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[296.953968] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[303.924520] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.974s)
[304.062278] [097/155] (717s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[304.164121] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[304.168230] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[304.254668] [098/155] (717s left) core_getstats (basic)
[304.300907] Starting subtest: basic
[304.303202] Subtest basic: SUCCESS (0.000s)
[304.412292] [099/155] (717s left) kms_color_pipeline (plane-lut1d)
[304.504945] Starting subtest: plane-lut1d
[304.674023] Starting dynamic subtest: pipe-A-plane-0
[304.862417] Dynamic subtest pipe-A-plane-0: SUCCESS (0.189s)
[304.872686] Starting dynamic subtest: pipe-A-plane-1
[305.017897] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s)
[305.027781] Starting dynamic subtest: pipe-A-plane-2
[305.184634] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[306.478697] Starting dynamic subtest: pipe-B-plane-0
[306.669862] Dynamic subtest pipe-B-plane-0: SUCCESS (0.200s)
[306.685875] Starting dynamic subtest: pipe-B-plane-1
[306.859301] Dynamic subtest pipe-B-plane-1: SUCCESS (0.186s)
[306.874126] Starting dynamic subtest: pipe-B-plane-2
[307.025021] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[308.287723] Starting dynamic subtest: pipe-C-plane-0
[308.442622] Dynamic subtest pipe-C-plane-0: SUCCESS (0.166s)
[308.453973] Starting dynamic subtest: pipe-C-plane-1
[308.609470] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[308.620281] Starting dynamic subtest: pipe-C-plane-2
[308.776253] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[310.012546] Starting dynamic subtest: pipe-D-plane-0
[310.170382] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s)
[310.181612] Starting dynamic subtest: pipe-D-plane-1
[310.336972] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[310.348233] Starting dynamic subtest: pipe-D-plane-2
[310.503539] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[310.793468] Subtest plane-lut1d: SUCCESS (6.287s)
[311.663897] [100/155] (710s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-render)
[311.773088] Starting subtest: hdr-rgb101010-draw-render
[311.777593] Subtest hdr-rgb101010-draw-render: SKIP (0.000s)
[311.870365] [101/155] (710s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[311.968206] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[311.972191] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[312.077153] [102/155] (709s left) gem_wait (invalid-buf)
[312.137641] Starting subtest: invalid-buf
[312.140052] Subtest invalid-buf: SUCCESS (0.000s)
[312.385770] [103/155] (709s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[312.482069] Starting subtest: psr-dirtyfb-ioctl
[312.483931] Starting dynamic subtest: A-eDP-1
[316.489682] Dynamic subtest A-eDP-1: SUCCESS (4.008s)
[316.492131] Subtest psr-dirtyfb-ioctl: SUCCESS (4.010s)
[317.365117] [104/155] (704s left) gen9_exec_parse (bb-secure)
[317.428838] Subtest bb-secure: SKIP (0.000s)
[317.505911] [105/155] (704s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[317.615681] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[321.684536] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (4.074s)
[322.863130] [106/155] (699s left) gem_eio (wait-immediate)
[323.085483] Starting subtest: wait-immediate
[323.449128] Subtest wait-immediate: SUCCESS (0.365s)
[323.572316] [107/155] (698s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[323.678627] Starting subtest: extended-modeset-hang-oldfb-with-reset
[323.681077] Starting dynamic subtest: pipe-A
[335.539674] Dynamic subtest pipe-A: SUCCESS (11.858s)
[335.551358] Starting dynamic subtest: pipe-D
[348.014605] Dynamic subtest pipe-D: SUCCESS (12.474s)
[348.016982] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.336s)
[348.901868] [108/155] (673s left) gem_exec_balancer (parallel-keep-in-fence)
[349.165446] Starting subtest: parallel-keep-in-fence
[350.382112] Subtest parallel-keep-in-fence: SUCCESS (1.217s)
[350.503483] [109/155] (671s left) gem_busy (extended)
[350.693399] Starting subtest: extended
[350.695877] Starting dynamic subtest: rcs0
[350.771738] Dynamic subtest rcs0: SUCCESS (0.078s)
[350.783518] Starting dynamic subtest: bcs0
[350.813484] Dynamic subtest bcs0: SUCCESS (0.040s)
[350.824712] Starting dynamic subtest: vcs0
[352.332060] Dynamic subtest vcs0: SUCCESS (1.515s)
[352.344856] Starting dynamic subtest: vcs1
[354.316482] Dynamic subtest vcs1: SUCCESS (1.981s)
[354.330351] Starting dynamic subtest: vecs0
[356.300550] Dynamic subtest vecs0: SUCCESS (1.979s)
[356.314403] Starting dynamic subtest: ccs0
[356.345695] Dynamic subtest ccs0: SUCCESS (0.044s)
[356.348224] Subtest extended: SUCCESS (5.653s)
[356.600369] [110/155] (665s left) syncobj_eventfd (timeline-wait-signaled)
[356.653232] Starting subtest: timeline-wait-signaled
[356.655549] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[356.753989] [111/155] (665s left) gem_userptr_blits (invalid-null-pointer)
[356.811469] Starting subtest: invalid-null-pointer
[356.813734] Subtest invalid-null-pointer: SUCCESS (0.001s)
[356.927655] [112/155] (665s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-render)
[357.038489] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-render
[357.042855] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[357.135232] [113/155] (665s left) kms_atomic (plane-primary-legacy)
[357.235621] Starting subtest: plane-primary-legacy
[357.237724] Starting dynamic subtest: pipe-A-eDP-1
[357.669231] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.432s)
[357.671116] Subtest plane-primary-legacy: SUCCESS (0.434s)
[358.556671] [114/155] (664s left) gem_lmem_swapping (massive)
[358.595777] Subtest massive: SKIP (0.000s)
[358.645410] [115/155] (663s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[358.748625] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu
[358.752669] Subtest psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[358.855030] [116/155] (663s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[358.950081] Starting subtest: 4-tiled-64bpp-rotate-90
[358.969736] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.019s)
[359.085954] [117/155] (663s left) kms_vblank (ts-continuation-modeset-rpm)
[359.183893] Starting subtest: ts-continuation-modeset-rpm
[359.186682] Starting dynamic subtest: pipe-A-eDP-1
[361.724256] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.537s)
[361.742292] Starting dynamic subtest: pipe-D-eDP-1
[363.977518] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.250s)
[363.980030] Subtest ts-continuation-modeset-rpm: SUCCESS (4.791s)
[364.865623] [118/155] (657s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-blt)
[364.970693] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-blt
[364.974717] Subtest psrhdr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[365.097704] [119/155] (657s left) kms_vblank (query-forked)
[365.186140] Starting subtest: query-forked
[365.188381] Starting dynamic subtest: pipe-A-eDP-1
[367.010455] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.825s)
[367.026733] Starting dynamic subtest: pipe-D-eDP-1
[369.587991] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.573s)
[369.590238] Subtest query-forked: SUCCESS (4.402s)
[370.437899] [120/155] (652s left) gem_ctx_param (invalid-param-get)
[370.504224] Starting subtest: invalid-param-get
[370.506829] Subtest invalid-param-get: SUCCESS (0.001s)
[370.616027] [121/155] (652s left) kms_tv_load_detect (load-detect)
[370.687717] Subtest load-detect: SKIP (0.000s)
[370.752611] [122/155] (652s left) gem_exec_whisper (basic-fds-forked-all)
[370.810677] Starting subtest: basic-fds-forked-all
[392.983663] Subtest basic-fds-forked-all: SUCCESS (22.172s)
[393.176310] [123/155] (629s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[393.278059] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[393.280367] Starting dynamic subtest: pipe-A-default-mode
[396.005359] Dynamic subtest pipe-A-default-mode: SUCCESS (2.725s)
[396.007371] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.727s)
[396.842018] [124/155] (626s left) i915_drm_fdinfo (busy-check-all)
[396.881809] Starting subtest: busy-check-all
[396.883941] Starting dynamic subtest: rcs0
[396.888184] Dynamic subtest rcs0: SKIP (0.004s)
[396.899840] Starting dynamic subtest: bcs0
[396.904260] Dynamic subtest bcs0: SKIP (0.000s)
[396.916299] Starting dynamic subtest: vcs0
[396.920666] Dynamic subtest vcs0: SKIP (0.000s)
[396.939422] Starting dynamic subtest: vcs1
[396.944613] Dynamic subtest vcs1: SKIP (0.000s)
[396.966153] Starting dynamic subtest: vecs0
[396.970994] Dynamic subtest vecs0: SKIP (0.000s)
[396.993119] Starting dynamic subtest: ccs0
[396.998943] Dynamic subtest ccs0: SKIP (0.000s)
[397.004094] Subtest busy-check-all: SKIP (0.010s)
[397.081768] [125/155] (626s left) gem_fenced_exec_thrash (no-spare-fences)
[397.172841] Subtest no-spare-fences: SKIP (0.000s)
[397.260106] [126/155] (625s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[397.368522] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[397.379476] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.011s)
[397.476937] [127/155] (625s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[397.581290] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[404.651401] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.076s)
[404.786386] [128/155] (618s left) syncobj_timeline (multi-wait-all-available-signaled)
[404.836754] Starting subtest: multi-wait-all-available-signaled
[404.839553] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s)
[404.942047] [129/155] (618s left) kms_flip (flip-vs-rmfb)
[405.039266] Starting subtest: flip-vs-rmfb
[405.041468] Starting dynamic subtest: A-eDP1
[413.753292] Dynamic subtest A-eDP1: SUCCESS (8.713s)
[413.764067] Starting dynamic subtest: B-eDP1
[422.389118] Dynamic subtest B-eDP1: SUCCESS (8.634s)
[422.402297] Starting dynamic subtest: C-eDP1
[431.004243] Dynamic subtest C-eDP1: SUCCESS (8.614s)
[431.016418] Starting dynamic subtest: D-eDP1
[439.637061] Dynamic subtest D-eDP1: SUCCESS (8.631s)
[439.641921] Subtest flip-vs-rmfb: SUCCESS (34.600s)
[440.839205] [130/155] (582s left) i915_drm_fdinfo (virtual-busy-idle-all)
[440.880040] Starting subtest: virtual-busy-idle-all
[440.884623] Subtest virtual-busy-idle-all: SKIP (0.000s)
[440.956419] [131/155] (582s left) kms_content_protection (type1)
[441.104078] Starting subtest: type1
[441.108689] Subtest type1: SKIP (0.000s)
[441.221419] [132/155] (582s left) syncobj_timeline (etime-multi-wait-submitted)
[441.275440] Starting subtest: etime-multi-wait-submitted
[441.385755] Subtest etime-multi-wait-submitted: SUCCESS (0.108s)
[441.475741] [133/155] (581s left) gem_exec_reloc (basic-cpu-read)
[441.534622] Subtest basic-cpu-read: SKIP (0.000s)
[441.626855] [134/155] (581s left) perf (gen12-mi-rpc)
[441.723095] Starting subtest: gen12-mi-rpc
[441.725485] Starting dynamic subtest: rcs0
[441.742631] Dynamic subtest rcs0: SUCCESS (0.017s)
[441.744886] Subtest gen12-mi-rpc: SUCCESS (0.018s)
[441.794060] [135/155] (581s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[441.924397] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[441.926673] Starting dynamic subtest: pipe-A-eDP-1
[441.946935] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[441.958238] Starting dynamic subtest: pipe-B-eDP-1
[441.977254] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[441.987387] Starting dynamic subtest: pipe-C-eDP-1
[442.006139] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[442.016271] Starting dynamic subtest: pipe-D-eDP-1
[442.035418] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[442.037307] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[444.180960] [136/155] (579s left) syncobj_wait (wait-all-delayed-signal)
[444.240628] Starting subtest: wait-all-delayed-signal
[444.346239] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[444.428292] [137/155] (579s left) gen3_render_mixed_blits
[444.553297] [138/155] (579s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-indfb-msflip-blt)
[444.653498] Starting subtest: fbcpsrhdr-2p-scndscrn-indfb-msflip-blt
[444.657699] Subtest fbcpsrhdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[444.769406] [139/155] (578s left) kms_rotation_crc (sprite-rotation-90)
[444.852382] Starting subtest: sprite-rotation-90
[444.856831] Subtest sprite-rotation-90: SKIP (0.001s)
[444.940856] [140/155] (578s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[445.030317] Starting subtest: plane-all-transition-nonblocking-fencing
[445.032632] Starting dynamic subtest: pipe-A-eDP-1
[447.530701] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.499s)
[447.853280] Starting dynamic subtest: pipe-B-eDP-1
[451.116079] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.276s)
[451.427377] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.397s)
[452.246337] [141/155] (571s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[452.353524] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[452.358099] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[452.443682] [142/155] (571s left) kms_lease (master-vs-lease)
[452.541179] Starting subtest: master-vs-lease
[452.543326] Subtest master-vs-lease: SUCCESS (0.001s)
[452.669935] [143/155] (571s left) kms_psr (fbc-pr-sprite-blt)
[452.759953] Starting subtest: fbc-pr-sprite-blt
[452.764487] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[452.836844] [144/155] (571s left) gen7_exec_parse (basic-allocation)
[452.896890] Subtest basic-allocation: SKIP (0.000s)
[452.981634] [145/155] (571s left) gem_create (create-ext-placement-sanity-check)
[453.143668] Starting subtest: create-ext-placement-sanity-check
[453.150468] Subtest create-ext-placement-sanity-check: SUCCESS (0.005s)
[453.264730] [146/155] (570s left) kms_feature_discovery (display-1x)
[453.363523] Starting subtest: display-1x
[453.365575] Subtest display-1x: SUCCESS (0.000s)
[453.438361] [147/155] (570s left) api_intel_allocator (two-level-inception-interruptible)
[453.500925] Starting subtest: two-level-inception-interruptible
[458.961605] Subtest two-level-inception-interruptible: SUCCESS (5.406s)
[459.046525] [148/155] (565s left) gem_mmap_offset (perf)
[459.108522] Starting subtest: perf
[459.110658] Starting dynamic subtest: smem0
[459.451908] Dynamic subtest smem0: SUCCESS (0.339s)
[459.454045] Subtest perf: SUCCESS (0.341s)
[459.569443] [149/155] (564s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[459.664977] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[459.667313] Starting dynamic subtest: pipe-A
[459.687758] Dynamic subtest pipe-A: SKIP (0.020s)
[459.699058] Starting dynamic subtest: pipe-B
[459.723661] Dynamic subtest pipe-B: SKIP (0.034s)
[459.735088] Starting dynamic subtest: pipe-C
[459.758855] Dynamic subtest pipe-C: SKIP (0.033s)
[459.770228] Starting dynamic subtest: pipe-D
[459.791452] Dynamic subtest pipe-D: SKIP (0.034s)
[459.795825] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.124s)
[459.924441] [150/155] (564s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[460.024480] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[460.028994] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[460.140824] [151/155] (564s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-pwrite)
[460.248053] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-pwrite
[460.252149] Subtest fbchdr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[460.362459] [152/155] (563s left) gem_exec_fence (nb-await)
[460.545991] Starting subtest: nb-await
[460.548662] Starting dynamic subtest: rcs0
[460.615670] Dynamic subtest rcs0: SUCCESS (0.069s)
[460.626755] Starting dynamic subtest: bcs0
[460.674447] Dynamic subtest bcs0: SUCCESS (0.056s)
[460.689406] Starting dynamic subtest: vcs0
[460.733994] Dynamic subtest vcs0: SUCCESS (0.057s)
[460.744911] Starting dynamic subtest: vcs1
[460.792396] Dynamic subtest vcs1: SUCCESS (0.056s)
[460.804984] Starting dynamic subtest: vecs0
[460.851083] Dynamic subtest vecs0: SUCCESS (0.056s)
[460.862603] Starting dynamic subtest: ccs0
[460.909252] Dynamic subtest ccs0: SUCCESS (0.056s)
[460.911660] Subtest nb-await: SUCCESS (0.365s)
[462.368531] [153/155] (561s left) kms_flip (modeset-vs-vblank-race-interruptible)
[462.456124] Starting subtest: modeset-vs-vblank-race-interruptible
[462.458415] Starting dynamic subtest: A-eDP1
[467.270588] Dynamic subtest A-eDP1: SUCCESS (4.812s)
[467.286619] Starting dynamic subtest: B-eDP1
[472.104218] Dynamic subtest B-eDP1: SUCCESS (4.830s)
[472.119554] Starting dynamic subtest: C-eDP1
[476.831082] Dynamic subtest C-eDP1: SUCCESS (4.725s)
[476.844929] Starting dynamic subtest: D-eDP1
[481.573910] Dynamic subtest D-eDP1: SUCCESS (4.740s)
[481.578754] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (19.120s)
[482.747350] [154/155] (541s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[482.813959] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[482.878942] [155/155] (541s left) gem_gtt_cpu_tlb
[482.988862] Closing watchdogs
results: parsing output: 0/ for test: kms_pm_rpm
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_invalid_mode
results: parsing output: 3/ for test: kms_cursor_crc
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_flip
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: perf
results: parsing output: 9/ for test: kms_plane
results: parsing output: 10/ for test: gem_exec_schedule
results: parsing output: 11/ for test: gem_exec_schedule
results: parsing output: 12/ for test: gem_sync
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: i915_pm_rps
results: parsing output: 15/ for test: kms_pm_rpm
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_flip_scaled_crc
results: parsing output: 20/ for test: gem_lmem_swapping
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_ppgtt
results: parsing output: 23/ for test: gem_mmap_gtt
results: parsing output: 24/ for test: gem_mmap_gtt
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_ccs
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: vgem_basic
results: parsing output: 29/ for test: kms_cursor_crc
results: parsing output: 30/ for test: perf_pmu
results: parsing output: 31/ for test: kms_flip
results: parsing output: 32/ for test: gem_softpin
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_userptr_blits
results: parsing output: 36/ for test: kms_psr2_sf
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_mmap_gtt
results: parsing output: 39/ for test: gem_softpin
results: parsing output: 40/ for test: gem_exec_balancer
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_plane
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: kms_pipe_crc_basic
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_ccs
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: gem_ctx_isolation
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_frontbuffer_tracking
results: parsing output: 53/ for test: kms_setmode
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: gem_exec_reloc
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: prime_vgem
results: parsing output: 61/ for test: perf
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: kms_async_flips
results: parsing output: 66/ for test: gem_exec_schedule
results: parsing output: 67/ for test: gem_exec_fence
results: parsing output: 68/ for test: sw_sync
results: parsing output: 69/ for test: kms_cursor_crc
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: sw_sync
results: parsing output: 73/ for test: sysfs_heartbeat_interval
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_chamelium_hpd
results: parsing output: 76/ for test: syncobj_wait
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_fence_thrash
results: parsing output: 79/ for test: syncobj_wait
results: parsing output: 80/ for test: kms_plane
results: parsing output: 81/ for test: gem_render_copy
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: i915_pm_rpm
results: parsing output: 85/ for test: kms_cursor_legacy
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_psr2_sf
results: parsing output: 90/ for test: kms_ccs
results: parsing output: 91/ for test: core_setmaster
results: parsing output: 92/ for test: kms_psr_stress_test
results: parsing output: 93/ for test: kms_chamelium_edid
results: parsing output: 94/ for test: gem_ctx_persistence
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: core_getstats
results: parsing output: 98/ for test: kms_color_pipeline
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_wait
results: parsing output: 102/ for test: kms_dirtyfb
results: parsing output: 103/ for test: gen9_exec_parse
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_eio
results: parsing output: 106/ for test: kms_busy
results: parsing output: 107/ for test: gem_exec_balancer
results: parsing output: 108/ for test: gem_busy
results: parsing output: 109/ for test: syncobj_eventfd
results: parsing output: 110/ for test: gem_userptr_blits
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_atomic
results: parsing output: 113/ for test: gem_lmem_swapping
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: kms_vblank
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_vblank
results: parsing output: 119/ for test: gem_ctx_param
results: parsing output: 120/ for test: kms_tv_load_detect
results: parsing output: 121/ for test: gem_exec_whisper
results: parsing output: 122/ for test: kms_flip_scaled_crc
results: parsing output: 123/ for test: i915_drm_fdinfo
results: parsing output: 124/ for test: gem_fenced_exec_thrash
results: parsing output: 125/ for test: kms_flip
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: syncobj_timeline
results: parsing output: 128/ for test: kms_flip
results: parsing output: 129/ for test: i915_drm_fdinfo
results: parsing output: 130/ for test: kms_content_protection
results: parsing output: 131/ for test: syncobj_timeline
results: parsing output: 132/ for test: gem_exec_reloc
results: parsing output: 133/ for test: perf
results: parsing output: 134/ for test: kms_ccs
results: parsing output: 135/ for test: syncobj_wait
results: parsing output: 136/ for test: gen3_render_mixed_blits
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: kms_rotation_crc
results: parsing output: 139/ for test: kms_atomic_transition
results: parsing output: 140/ for test: kms_big_fb
results: parsing output: 141/ for test: kms_lease
results: parsing output: 142/ for test: kms_psr
results: parsing output: 143/ for test: gen7_exec_parse
results: parsing output: 144/ for test: gem_create
results: parsing output: 145/ for test: kms_feature_discovery
results: parsing output: 146/ for test: api_intel_allocator
results: parsing output: 147/ for test: gem_mmap_offset
results: parsing output: 148/ for test: kms_plane_scaling
results: parsing output: 149/ for test: kms_big_fb
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: gem_exec_fence
results: parsing output: 152/ for test: kms_flip
results: parsing output: 153/ for test: gem_fenced_exec_thrash
results: parsing output: 154/ for test: gem_gtt_cpu_tlb
Done.