[57.294139] Initializing watchdogs [57.294184] /dev/watchdog0 [57.318690] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics] [57.322637] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.324782] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.328449] [001/156] (960s left) kms_rotation_crc (sprite-rotation-180) [57.450369] Starting subtest: sprite-rotation-180 [64.277360] Subtest sprite-rotation-180: SUCCESS (6.829s) [65.525459] [002/156] (952s left) gem_ctx_create (basic) [65.596920] Starting subtest: basic [65.599484] Subtest basic: SUCCESS (0.000s) [65.786416] [003/156] (952s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-mmap-cpu) [65.875363] Starting subtest: hdr-rgb101010-draw-mmap-cpu [65.879635] Subtest hdr-rgb101010-draw-mmap-cpu: SKIP (0.000s) [65.968418] [004/156] (951s left) kms_pm_rpm (i2c) [67.494272] Starting subtest: i2c [73.160821] Subtest i2c: SUCCESS (5.669s) [73.270643] [005/156] (944s left) sw_sync (sync_multi_consumer) [73.308889] Starting subtest: sync_multi_consumer [73.717198] Subtest sync_multi_consumer: SUCCESS (0.407s) [73.773425] [006/156] (944s left) api_intel_bb (object-noreloc-purge-cache-simple) [73.826191] Starting subtest: object-noreloc-purge-cache-simple [73.829597] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.006s) [73.942638] [007/156] (944s left) kms_big_fb (4-tiled-8bpp-rotate-180) [74.019899] Starting subtest: 4-tiled-8bpp-rotate-180 [75.188266] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.170s) [75.295674] [008/156] (942s left) kms_psr (psr-suspend) [75.377140] Starting subtest: psr-suspend [75.379033] Starting dynamic subtest: eDP-1 [93.583972] Dynamic subtest eDP-1: SUCCESS (3.084s) [93.586363] Subtest psr-suspend: SUCCESS (3.084s) [94.436802] [009/156] (923s left) kms_async_flips (test-cursor-atomic) [94.529037] Starting subtest: test-cursor-atomic [94.901580] Starting dynamic subtest: pipe-A-eDP-1 [95.725782] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.824s) [96.119653] Starting dynamic subtest: pipe-B-eDP-1 [96.886227] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.773s) [97.259216] Starting dynamic subtest: pipe-C-eDP-1 [98.011437] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.762s) [98.380123] Starting dynamic subtest: pipe-D-eDP-1 [99.139332] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.770s) [99.141830] Subtest test-cursor-atomic: SUCCESS (4.613s) [100.315668] [010/156] (917s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-mmap-gtt) [100.400812] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-mmap-gtt [100.405343] Subtest hdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [100.503303] [011/156] (917s left) perf_pmu (interrupts) [100.540217] Starting subtest: interrupts [101.660571] Subtest interrupts: SUCCESS (1.120s) [101.757778] [FACT perf_pmu (interrupts)] new: kernel.kmod_is_loaded.vgem: true [101.760863] [012/156] (916s left) kms_lease (atomic-implicit-crtc) [101.840555] Starting subtest: atomic-implicit-crtc [101.842672] Starting dynamic subtest: pipe-A-eDP-1 [101.853768] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [101.863343] Starting dynamic subtest: pipe-B-eDP-1 [101.874410] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s) [101.883320] Starting dynamic subtest: pipe-C-eDP-1 [101.894182] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s) [101.903213] Starting dynamic subtest: pipe-D-eDP-1 [101.914026] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s) [101.916240] Subtest atomic-implicit-crtc: SUCCESS (0.033s) [102.009564] [013/156] (916s left) gem_eio (wait-wedge-1us) [102.229049] Starting subtest: wait-wedge-1us [103.447409] Subtest wait-wedge-1us: SUCCESS (1.217s) [103.584054] [014/156] (914s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move) [103.662668] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move [103.666901] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [103.752344] [015/156] (914s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render) [103.846008] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render [111.092478] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.254s) [111.221295] [016/156] (907s left) kms_properties (plane-properties-legacy) [111.299787] Starting subtest: plane-properties-legacy [111.301913] Starting dynamic subtest: pipe-A-eDP-1 [111.851418] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.550s) [111.863385] Starting dynamic subtest: pipe-B-eDP-1 [113.086970] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.235s) [113.098240] Starting dynamic subtest: pipe-C-eDP-1 [114.326302] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.239s) [114.337548] Starting dynamic subtest: pipe-D-eDP-1 [115.567933] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.242s) [115.570344] Subtest plane-properties-legacy: SUCCESS (4.270s) [116.379853] [017/156] (902s left) kms_plane_scaling (planes-upscale-20x20) [116.464909] Starting subtest: planes-upscale-20x20 [116.467167] Starting dynamic subtest: pipe-A [116.525825] Dynamic subtest pipe-A: SUCCESS (0.062s) [116.538297] Starting dynamic subtest: pipe-B [117.711367] Dynamic subtest pipe-B: SUCCESS (1.185s) [117.724045] Starting dynamic subtest: pipe-C [118.832528] Dynamic subtest pipe-C: SUCCESS (1.120s) [118.842021] Starting dynamic subtest: pipe-D [119.943262] Dynamic subtest pipe-D: SUCCESS (1.111s) [119.945532] Subtest planes-upscale-20x20: SUCCESS (3.480s) [121.110066] [018/156] (897s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu) [121.204169] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu [121.208899] Subtest psrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [121.309439] [019/156] (897s left) syncobj_wait (wait-for-submit-delayed-submit) [121.362323] Starting subtest: wait-for-submit-delayed-submit [121.462840] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s) [121.554578] [020/156] (897s left) kms_big_fb (x-tiled-64bpp-rotate-0) [121.654730] Starting subtest: x-tiled-64bpp-rotate-0 [123.154973] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.500s) [123.332754] [021/156] (895s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc) [123.415754] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc [123.420416] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [123.512311] [022/156] (895s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping) [123.588350] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping [123.591809] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s) [123.662926] [023/156] (895s left) kms_chamelium_edid (dp-edid-read) [124.051146] Subtest dp-edid-read: SKIP (0.000s) [124.841821] [024/156] (893s left) gem_exec_reloc (basic-gtt-active) [124.896710] Subtest basic-gtt-active: SKIP (0.000s) [124.978274] [025/156] (893s left) kms_universal_plane (universal-plane-sanity) [125.048169] Starting subtest: universal-plane-sanity [125.050504] Starting dynamic subtest: pipe-A-eDP-1 [125.643311] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.593s) [125.656421] Starting dynamic subtest: pipe-B-eDP-1 [126.875110] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.233s) [126.885017] Starting dynamic subtest: pipe-C-eDP-1 [128.091697] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.215s) [128.103628] Starting dynamic subtest: pipe-D-eDP-1 [129.313580] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.220s) [129.315920] Subtest universal-plane-sanity: SUCCESS (4.266s) [130.183916] [026/156] (888s left) gem_exec_big (single) [130.240612] Starting subtest: single [131.246517] Subtest single: SUCCESS (1.004s) [131.389455] [027/156] (887s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling) [131.516481] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling [131.518808] Starting dynamic subtest: pipe-A-default-mode [132.664387] Dynamic subtest pipe-A-default-mode: SKIP (1.145s) [132.668845] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.146s) [132.819309] [028/156] (886s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-blt) [132.902937] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-blt [132.906953] Subtest psrhdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [133.022528] [029/156] (885s left) kms_content_protection (dp-mst-type-0) [133.147977] Starting subtest: dp-mst-type-0 [133.153210] Subtest dp-mst-type-0: SKIP (0.000s) [133.261600] [030/156] (885s left) kms_psr (pr-sprite-blt) [133.331116] Starting subtest: pr-sprite-blt [133.335828] Subtest pr-sprite-blt: SKIP (0.000s) [133.408859] [031/156] (885s left) gem_exec_balancer (parallel) [133.677685] Starting subtest: parallel [134.603366] Subtest parallel: SUCCESS (0.928s) [135.415340] [032/156] (883s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled) [135.487494] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled [135.489859] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s) [135.582242] [033/156] (883s left) gem_media_fill (media-fill) [135.634876] Subtest media-fill: SKIP (0.000s) [135.752258] [034/156] (883s left) gem_set_tiling_vs_blt (untiled-to-tiled) [135.816149] Subtest untiled-to-tiled: SKIP (0.000s) [135.883057] [035/156] (883s left) prime_vgem (basic-fence-blt) [135.945996] Starting subtest: basic-fence-blt [136.030700] Subtest basic-fence-blt: SUCCESS (0.084s) [136.171504] [036/156] (883s left) i915_drm_fdinfo (busy) [136.213179] Starting subtest: busy [136.215535] Starting dynamic subtest: rcs0 [136.252100] Dynamic subtest rcs0: SKIP (0.037s) [136.264710] Starting dynamic subtest: bcs0 [136.269515] Dynamic subtest bcs0: SKIP (0.000s) [136.279513] Starting dynamic subtest: vcs0 [136.284067] Dynamic subtest vcs0: SKIP (0.000s) [136.294110] Starting dynamic subtest: vcs1 [136.298497] Dynamic subtest vcs1: SKIP (0.000s) [136.309475] Starting dynamic subtest: vecs0 [136.313857] Dynamic subtest vecs0: SKIP (0.000s) [136.323420] Starting dynamic subtest: ccs0 [136.327795] Dynamic subtest ccs0: SKIP (0.000s) [136.332187] Subtest busy: SKIP (0.041s) [136.369154] [037/156] (882s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render) [136.452360] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render [140.599394] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.152s) [141.737721] [038/156] (877s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc) [141.823894] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc [148.510497] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.691s) [148.650095] [039/156] (870s left) dmabuf (all-tests) [148.688310] Starting subtest: all-tests [148.692629] Subtest all-tests: SKIP (0.000s) [148.748794] [040/156] (870s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted) [148.809540] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted [148.811441] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s) [148.909621] [041/156] (870s left) kms_prime (d3hot) [148.977376] Subtest D3hot: SKIP (0.000s) [149.067307] [042/156] (870s left) gem_userptr_blits (usage-restrictions) [149.134498] Starting subtest: usage-restrictions [149.136738] Subtest usage-restrictions: SUCCESS (0.000s) [149.273777] [043/156] (870s left) perf_pmu (busy-accuracy-98) [149.314940] Starting subtest: busy-accuracy-98 [149.317406] Starting dynamic subtest: rcs0 [152.351209] Dynamic subtest rcs0: SUCCESS (3.033s) [152.363662] Starting dynamic subtest: bcs0 [155.404255] Dynamic subtest bcs0: SUCCESS (3.051s) [155.418099] Starting dynamic subtest: vcs0 [158.448484] Dynamic subtest vcs0: SUCCESS (3.042s) [158.461086] Starting dynamic subtest: vcs1 [161.490240] Dynamic subtest vcs1: SUCCESS (3.040s) [161.503241] Starting dynamic subtest: vecs0 [164.531612] Dynamic subtest vecs0: SUCCESS (3.039s) [164.546971] Starting dynamic subtest: ccs0 [167.581081] Dynamic subtest ccs0: SUCCESS (3.047s) [167.583523] Subtest busy-accuracy-98: SUCCESS (18.264s) [167.697490] [044/156] (851s left) kms_busy (basic) [167.795220] Starting subtest: basic [167.797456] Starting dynamic subtest: flip [168.410854] Dynamic subtest flip: SUCCESS (0.613s) [168.421352] Starting dynamic subtest: modeset [172.092849] Dynamic subtest modeset: SUCCESS (3.682s) [172.095099] Subtest basic: SUCCESS (4.297s) [172.899864] [045/156] (846s left) i915_pm_rpm (gem-idle) [174.501539] Starting subtest: gem-idle [180.702785] Subtest gem-idle: SUCCESS (6.205s) [181.046377] [046/156] (838s left) kms_cursor_legacy (cursorb-vs-flipb-atomic) [182.372529] Starting subtest: cursorB-vs-flipB-atomic [182.377105] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s) [182.517673] [047/156] (837s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs) [182.588035] Starting subtest: crc-primary-rotation-180-y-tiled-ccs [182.590285] Starting dynamic subtest: pipe-A-eDP-1 [182.614866] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [182.627723] Starting dynamic subtest: pipe-B-eDP-1 [182.648876] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [182.661884] Starting dynamic subtest: pipe-C-eDP-1 [182.684016] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [182.694249] Starting dynamic subtest: pipe-D-eDP-1 [182.715880] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [182.719865] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.005s) [184.912641] [048/156] (834s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-blt) [184.997324] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-blt [185.001598] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [185.092005] [049/156] (834s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb) [185.172942] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb [185.175249] Starting dynamic subtest: pipe-A-eDP-1 [191.912917] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.743s) [191.924366] Starting dynamic subtest: pipe-B-eDP-1 [198.921565] Dynamic subtest pipe-B-eDP-1: SUCCESS (7.008s) [198.923981] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.754s) [199.789743] [050/156] (820s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip) [199.880968] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip [199.885434] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [199.978379] [051/156] (819s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area) [200.058068] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area [200.060389] Starting dynamic subtest: pipe-A-eDP-1 [200.155682] Dynamic subtest pipe-A-eDP-1: SKIP (0.101s) [200.171174] Starting dynamic subtest: pipe-B-eDP-1 [201.286499] Dynamic subtest pipe-B-eDP-1: SKIP (1.128s) [201.291224] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.232s) [202.486976] [052/156] (817s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs) [202.555799] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs [202.558236] Starting dynamic subtest: pipe-A-eDP-1 [202.582186] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [202.593424] Starting dynamic subtest: pipe-B-eDP-1 [202.616256] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [202.625836] Starting dynamic subtest: pipe-C-eDP-1 [202.648817] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [202.658317] Starting dynamic subtest: pipe-D-eDP-1 [202.682095] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [202.686518] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.007s) [204.847560] [053/156] (815s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-mmap-gtt) [204.933701] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-mmap-gtt [204.937921] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [205.033791] [054/156] (814s left) gem_ctx_persistence (file) [205.082197] Starting subtest: file [205.206867] Subtest file: SUCCESS (0.125s) [205.333601] [055/156] (814s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt) [205.417040] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt [205.421535] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [205.527287] [056/156] (814s left) syncobj_timeline (invalid-signal-zero-handles) [205.572458] Starting subtest: invalid-signal-zero-handles [205.574654] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [205.662436] [057/156] (814s left) kms_flip (2x-flip-vs-modeset-vs-hang) [205.734586] Starting subtest: 2x-flip-vs-modeset-vs-hang [205.738830] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.001s) [205.842477] [058/156] (814s left) gem_softpin (evict-single-offset) [205.889544] Starting subtest: evict-single-offset [230.350524] Subtest evict-single-offset: SUCCESS (24.458s) [230.434990] [059/156] (789s left) kms_psr2_sf (pr-plane-move-sf-dmg-area) [230.555195] Starting subtest: pr-plane-move-sf-dmg-area [230.559510] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s) [230.623599] [060/156] (789s left) kms_chamelium_hpd (vga-hpd-without-ddc) [231.001266] Subtest vga-hpd-without-ddc: SKIP (0.000s) [231.856662] [061/156] (788s left) perf (whitelisted-registers-userspace-config) [231.994997] Starting subtest: whitelisted-registers-userspace-config [231.996858] Subtest whitelisted-registers-userspace-config: SUCCESS (0.000s) [232.037554] [062/156] (788s left) kms_setmode (basic-clone-single-crtc) [232.092852] Starting subtest: basic-clone-single-crtc [232.099175] Subtest basic-clone-single-crtc: SKIP (0.000s) [232.205659] [063/156] (788s left) gem_exec_async (forked-writes) [232.265541] Starting subtest: forked-writes [232.267962] Starting dynamic subtest: rcs0 [232.298737] Dynamic subtest rcs0: SUCCESS (0.033s) [232.314122] Starting dynamic subtest: bcs0 [232.321056] Dynamic subtest bcs0: SUCCESS (0.021s) [232.332828] Starting dynamic subtest: vcs0 [232.342193] Dynamic subtest vcs0: SUCCESS (0.020s) [232.353784] Starting dynamic subtest: vcs1 [232.363038] Dynamic subtest vcs1: SUCCESS (0.020s) [232.376409] Starting dynamic subtest: vecs0 [232.384657] Dynamic subtest vecs0: SUCCESS (0.021s) [232.395314] Starting dynamic subtest: ccs0 [232.408324] Dynamic subtest ccs0: SUCCESS (0.023s) [232.410604] Subtest forked-writes: SUCCESS (0.143s) [232.629560] [064/156] (787s left) syncobj_timeline (single-wait-all-for-submit-signaled) [232.681391] Starting subtest: single-wait-all-for-submit-signaled [232.683535] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [232.792689] [065/156] (787s left) kms_lease (lease-invalid-crtc) [232.864459] Starting subtest: lease-invalid-crtc [232.866708] Starting dynamic subtest: pipe-A-eDP-1 [232.869169] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [232.879742] Starting dynamic subtest: pipe-B-eDP-1 [232.882126] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [232.892365] Starting dynamic subtest: pipe-C-eDP-1 [232.894202] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [232.903712] Starting dynamic subtest: pipe-D-eDP-1 [232.905583] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [232.907345] Subtest lease-invalid-crtc: SUCCESS (0.004s) [232.945972] [066/156] (787s left) kms_plane_alpha_blend (alpha-7efc) [233.017478] Starting subtest: alpha-7efc [233.299641] Starting dynamic subtest: pipe-A-eDP-1 [233.894535] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.594s) [233.924467] Starting dynamic subtest: pipe-D-eDP-1 [235.200193] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.284s) [235.202887] Subtest alpha-7efc: SUCCESS (2.183s) [236.053926] [067/156] (784s left) gem_create (create-ext-cpu-access-sanity-check) [236.228177] Starting subtest: create-ext-cpu-access-sanity-check [236.233199] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s) [236.315503] [068/156] (784s left) kms_psr (fbc-pr-sprite-render) [236.390371] Starting subtest: fbc-pr-sprite-render [236.394826] Subtest fbc-pr-sprite-render: SKIP (0.000s) [236.470358] [069/156] (784s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt) [236.547683] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt [236.551943] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [236.629738] [070/156] (784s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt) [236.710735] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt [236.714914] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [236.810963] [071/156] (783s left) syncobj_wait (single-wait-all-for-submit-signaled) [236.870579] Starting subtest: single-wait-all-for-submit-signaled [236.872583] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [236.984462] [072/156] (783s left) gem_ctx_persistence (hang) [237.048023] Starting subtest: hang [237.052458] Subtest hang: SKIP (0.000s) [237.142825] [073/156] (783s left) api_intel_allocator (gem-pool) [237.191027] Starting subtest: gem-pool [237.195788] Subtest gem-pool: SUCCESS (0.006s) [237.280869] [074/156] (783s left) kms_hdr (static-toggle-suspend) [237.351438] Starting subtest: static-toggle-suspend [237.353700] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010 [237.357713] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s) [237.370641] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F [237.374055] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s) [237.377628] Subtest static-toggle-suspend: SKIP (0.003s) [237.424714] [075/156] (783s left) gem_busy (busy) [237.478786] Starting subtest: busy [237.480688] Starting dynamic subtest: all-engines [237.512374] Dynamic subtest all-engines: SUCCESS (0.033s) [237.526513] Starting dynamic subtest: rcs0 [239.382444] Dynamic subtest rcs0: SUCCESS (1.868s) [239.393212] Starting dynamic subtest: bcs0 [239.423014] Dynamic subtest bcs0: SUCCESS (0.039s) [239.433268] Starting dynamic subtest: vcs0 [239.462767] Dynamic subtest vcs0: SUCCESS (0.037s) [239.472773] Starting dynamic subtest: vcs1 [241.363054] Dynamic subtest vcs1: SUCCESS (1.898s) [241.376171] Starting dynamic subtest: vecs0 [243.347887] Dynamic subtest vecs0: SUCCESS (1.982s) [243.358824] Starting dynamic subtest: ccs0 [245.331233] Dynamic subtest ccs0: SUCCESS (1.984s) [245.333599] Subtest busy: SUCCESS (7.850s) [245.661907] [076/156] (775s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-mmap-wc) [245.749235] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-mmap-wc [245.753376] Subtest hdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [245.847365] [077/156] (775s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw) [245.930464] Starting subtest: fbc-2p-pri-indfb-multidraw [245.934347] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s) [246.026992] [078/156] (775s left) kms_big_fb (yf-tiled-addfb-size-overflow) [246.112102] Starting subtest: yf-tiled-addfb-size-overflow [246.116546] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s) [246.226717] [079/156] (774s left) gem_exec_reloc (basic-cpu-read-noreloc) [246.282715] Subtest basic-cpu-read-noreloc: SKIP (0.000s) [246.356328] [080/156] (774s left) perf_pmu (most-busy-idle-check-all) [246.395606] Starting subtest: most-busy-idle-check-all [246.397844] Starting dynamic subtest: rcs0 [248.333793] Dynamic subtest rcs0: SUCCESS (1.938s) [248.348130] Starting dynamic subtest: bcs0 [250.318198] Dynamic subtest bcs0: SUCCESS (1.981s) [250.332946] Starting dynamic subtest: vcs0 [252.365642] Dynamic subtest vcs0: SUCCESS (2.045s) [252.380654] Starting dynamic subtest: vcs1 [254.349761] Dynamic subtest vcs1: SUCCESS (1.982s) [254.363873] Starting dynamic subtest: vecs0 [256.334019] Dynamic subtest vecs0: SUCCESS (1.981s) [256.347980] Starting dynamic subtest: ccs0 [258.318183] Dynamic subtest ccs0: SUCCESS (1.981s) [258.321194] Subtest most-busy-idle-check-all: SUCCESS (11.924s) [258.446524] [081/156] (762s left) kms_cursor_legacy (torture-bo) [258.553786] Starting subtest: torture-bo [258.556206] Starting dynamic subtest: pipe-A [264.440863] Dynamic subtest pipe-A: SUCCESS (5.882s) [264.462045] Starting dynamic subtest: pipe-B [270.684920] Dynamic subtest pipe-B: SUCCESS (6.242s) [270.703846] Starting dynamic subtest: pipe-C [277.562904] Dynamic subtest pipe-C: SUCCESS (6.875s) [277.577340] Starting dynamic subtest: pipe-D [284.077163] Dynamic subtest pipe-D: SUCCESS (6.509s) [284.090100] Starting dynamic subtest: all-pipes [290.543110] Dynamic subtest all-pipes: SUCCESS (6.466s) [290.545949] Subtest torture-bo: SUCCESS (31.987s) [290.707831] [082/156] (730s left) kms_frontbuffer_tracking (fbcpsr-slowdraw) [290.801906] Starting subtest: fbcpsr-slowdraw [316.052221] Subtest fbcpsr-slowdraw: SUCCESS (25.255s) [316.189821] [083/156] (705s left) sw_sync (sync_expired_merge) [316.230848] Starting subtest: sync_expired_merge [317.304635] Subtest sync_expired_merge: SUCCESS (1.074s) [317.370173] [084/156] (703s left) syncobj_eventfd (timeline-wait) [317.414943] Starting subtest: timeline-wait [317.423645] Subtest timeline-wait: SUCCESS (0.011s) [317.503142] [085/156] (703s left) drm_read (invalid-buffer) [317.654896] Starting subtest: invalid-buffer [317.657724] Subtest invalid-buffer: SUCCESS (0.000s) [317.775840] [086/156] (703s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc) [317.857665] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc [324.578578] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.727s) [324.690750] [087/156] (696s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [324.766439] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-mmap-gtt [324.770707] Subtest hdr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [324.867836] [088/156] (696s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu) [324.950323] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu [328.559789] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.615s) [329.698172] [089/156] (691s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-mmap-wc) [329.787211] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-mmap-wc [329.791632] Subtest hdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [329.891850] [090/156] (691s left) gem_exec_whisper (basic-sync-all) [329.956459] Starting subtest: basic-sync-all [337.301974] Subtest basic-sync-all: SUCCESS (7.345s) [337.487618] [091/156] (684s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt) [337.578987] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt [337.583254] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [337.668865] [092/156] (683s left) syncobj_timeline (multi-wait-for-submit-signaled) [337.723195] Starting subtest: multi-wait-for-submit-signaled [337.725545] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s) [337.827735] [093/156] (683s left) kms_cursor_crc (cursor-rapid-movement-256x85) [338.058529] Starting subtest: cursor-rapid-movement-256x85 [338.105368] Subtest cursor-rapid-movement-256x85: SKIP (0.041s) [338.274993] [094/156] (683s left) kms_addfb_basic (too-wide) [338.349971] Starting subtest: too-wide [338.352116] Subtest too-wide: SUCCESS (0.000s) [338.457015] [095/156] (683s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs) [338.525206] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs [338.527068] Starting dynamic subtest: pipe-A-eDP-1 [338.675224] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.141s) [338.685832] Starting dynamic subtest: pipe-B-eDP-1 [338.702237] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [338.712275] Starting dynamic subtest: pipe-C-eDP-1 [338.727703] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s) [338.738204] Starting dynamic subtest: pipe-D-eDP-1 [338.753489] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s) [338.755240] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.151s) [340.940246] [096/156] (680s left) gem_exec_flush (basic-uc-rw-default) [341.007931] Starting subtest: basic-uc-rw-default [346.464415] Subtest basic-uc-rw-default: SUCCESS (5.456s) [346.654630] [097/156] (675s left) gem_ringfill (basic-all) [352.338019] Starting subtest: basic-all [353.517401] Subtest basic-all: SUCCESS (1.179s) [353.654715] [098/156] (668s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [353.749248] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [353.753696] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [353.854653] [099/156] (668s left) kms_3d (basic) [353.909113] Starting subtest: basic [353.913723] Subtest basic: SKIP (0.000s) [353.998399] [100/156] (667s left) gem_userptr_blits (userfault) [354.069557] Starting subtest: userfault [354.071492] Subtest userfault: SUCCESS (0.004s) [354.203814] [101/156] (667s left) vgem_basic (busy-fence) [354.252720] Starting subtest: busy-fence [354.255150] Subtest busy-fence: SUCCESS (0.000s) [354.316884] [102/156] (667s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-pwrite) [354.394049] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-pwrite [354.398148] Subtest fbchdr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [354.507539] [103/156] (667s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-blt) [354.591910] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-blt [354.595585] Subtest psrhdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s) [354.684384] [104/156] (667s left) gem_exec_params (invalid-ring2) [354.757744] Starting subtest: invalid-ring2 [354.759780] Subtest invalid-ring2: SUCCESS (0.000s) [354.869030] [105/156] (667s left) gem_pwrite (basic-self) [354.923688] Subtest basic-self: SKIP (0.000s) [354.980083] [106/156] (667s left) gem_exec_fence (long-history) [355.380963] Starting subtest: long-history [363.049639] Subtest long-history: SUCCESS (7.669s) [363.646238] [107/156] (658s left) kms_color_pipeline (plane-ctm3x4-lut1d) [363.730183] Starting subtest: plane-ctm3x4-lut1d [363.854561] Starting dynamic subtest: pipe-A-plane-0 [364.010833] Dynamic subtest pipe-A-plane-0: SUCCESS (0.155s) [364.022341] Starting dynamic subtest: pipe-A-plane-1 [364.143694] Dynamic subtest pipe-A-plane-1: SUCCESS (0.132s) [364.156595] Starting dynamic subtest: pipe-A-plane-2 [364.276739] Dynamic subtest pipe-A-plane-2: SUCCESS (0.132s) [365.565313] Starting dynamic subtest: pipe-B-plane-0 [365.743902] Dynamic subtest pipe-B-plane-0: SUCCESS (0.189s) [365.756201] Starting dynamic subtest: pipe-B-plane-1 [365.890059] Dynamic subtest pipe-B-plane-1: SUCCESS (0.144s) [365.902792] Starting dynamic subtest: pipe-B-plane-2 [366.021685] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s) [367.243247] Starting dynamic subtest: pipe-C-plane-0 [367.377328] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s) [367.388621] Starting dynamic subtest: pipe-C-plane-1 [367.510835] Dynamic subtest pipe-C-plane-1: SUCCESS (0.133s) [367.523880] Starting dynamic subtest: pipe-C-plane-2 [367.644179] Dynamic subtest pipe-C-plane-2: SUCCESS (0.133s) [368.885498] Starting dynamic subtest: pipe-D-plane-0 [369.015722] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s) [369.026887] Starting dynamic subtest: pipe-D-plane-1 [369.171424] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s) [369.182863] Starting dynamic subtest: pipe-D-plane-2 [369.316227] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s) [369.602714] Subtest plane-ctm3x4-lut1d: SUCCESS (5.871s) [370.441986] [108/156] (651s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-pwrite) [370.530382] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-pwrite [370.534797] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [370.630556] [109/156] (651s left) kms_psr (psr2-primary-mmap-gtt) [370.710874] Starting subtest: psr2-primary-mmap-gtt [370.713172] Starting dynamic subtest: eDP-1 [372.128895] Dynamic subtest eDP-1: SKIP (1.415s) [372.133642] Subtest psr2-primary-mmap-gtt: SKIP (1.417s) [372.259625] [110/156] (650s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs) [372.339798] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs [372.342036] Starting dynamic subtest: pipe-A-eDP-1 [372.399545] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [372.412193] Starting dynamic subtest: pipe-B-eDP-1 [372.467794] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [372.478728] Starting dynamic subtest: pipe-C-eDP-1 [372.534233] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [372.544575] Starting dynamic subtest: pipe-D-eDP-1 [372.598326] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [372.602469] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s) [374.629989] [111/156] (647s left) prime_mmap (test_correct_cpu_write) [374.697367] Starting subtest: test_correct_cpu_write [374.699629] Starting dynamic subtest: test_correct_cpu_write-smem [374.701789] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s) [374.703895] Subtest test_correct_cpu_write: SUCCESS (0.001s) [374.783392] [112/156] (647s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt) [374.863103] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt [374.867406] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [374.953359] [113/156] (647s left) kms_big_fb (linear-addfb) [375.027672] Starting subtest: linear-addfb [375.029624] Subtest linear-addfb: SUCCESS (0.000s) [375.134212] [114/156] (647s left) gem_pxp (protected-raw-src-copy-not-readible) [375.253382] Starting subtest: protected-raw-src-copy-not-readible [375.309812] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.058s) [375.443457] [115/156] (647s left) gem_exec_schedule (semaphore-user) [375.510742] Starting subtest: semaphore-user [375.561033] Subtest semaphore-user: SUCCESS (0.058s) [377.411777] [116/156] (645s left) kms_plane (plane-position-hole) [377.498079] Starting subtest: plane-position-hole [378.002519] Starting dynamic subtest: pipe-A-plane-1 [379.270044] Dynamic subtest pipe-A-plane-1: SUCCESS (1.270s) [379.281612] Starting dynamic subtest: pipe-A-plane-2 [380.538095] Dynamic subtest pipe-A-plane-2: SUCCESS (1.266s) [380.552798] Starting dynamic subtest: pipe-A-plane-3 [381.830700] Dynamic subtest pipe-A-plane-3: SUCCESS (1.290s) [381.842040] Starting dynamic subtest: pipe-A-plane-4 [383.046414] Dynamic subtest pipe-A-plane-4: SUCCESS (1.216s) [383.058349] Starting dynamic subtest: pipe-A-plane-5 [383.071327] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s) [384.261554] Starting dynamic subtest: pipe-B-plane-1 [385.523471] Dynamic subtest pipe-B-plane-1: SUCCESS (1.271s) [385.534691] Starting dynamic subtest: pipe-B-plane-2 [386.802253] Dynamic subtest pipe-B-plane-2: SUCCESS (1.278s) [386.813830] Starting dynamic subtest: pipe-B-plane-3 [388.124990] Dynamic subtest pipe-B-plane-3: SUCCESS (1.320s) [388.136094] Starting dynamic subtest: pipe-B-plane-4 [389.335773] Dynamic subtest pipe-B-plane-4: SUCCESS (1.210s) [389.347093] Starting dynamic subtest: pipe-B-plane-5 [389.359592] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s) [389.361634] Subtest plane-position-hole: SUCCESS (11.863s) [390.175057] [117/156] (632s left) gem_exec_whisper (basic-contexts-priority-all) [390.229618] Starting subtest: basic-contexts-priority-all [413.487845] Subtest basic-contexts-priority-all: SUCCESS (23.252s) [413.673552] [118/156] (609s left) gem_userptr_blits (unsync-unmap) [413.739994] Subtest unsync-unmap: SKIP (0.000s) [413.861932] [119/156] (608s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary) [413.953088] Starting subtest: fbc-indfb-scaledprimary [416.842025] Subtest fbc-indfb-scaledprimary: SUCCESS (2.893s) [417.992926] [120/156] (604s left) gem_eio (reset-stress) [418.209437] Starting subtest: reset-stress [418.211833] Starting dynamic subtest: render [423.094720] Dynamic subtest render: SUCCESS (4.884s) [423.107324] Starting dynamic subtest: bsd1 [440.833658] Dynamic subtest bsd1: SUCCESS (17.736s) [440.852802] Starting dynamic subtest: bsd2 [458.858055] Dynamic subtest bsd2: SUCCESS (18.024s) [458.875814] Starting dynamic subtest: blt [458.880396] Dynamic subtest blt: SKIP (0.000s) [458.891500] Starting dynamic subtest: vebox [476.893830] Dynamic subtest vebox: SUCCESS (18.033s) [476.896173] Subtest reset-stress: SUCCESS (58.683s) [478.394911] [121/156] (544s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc) [478.479220] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc [478.481472] Starting dynamic subtest: pipe-A-eDP-1 [478.504381] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [478.516491] Starting dynamic subtest: pipe-B-eDP-1 [478.537967] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [478.548793] Starting dynamic subtest: pipe-C-eDP-1 [478.571974] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [478.595305] Starting dynamic subtest: pipe-D-eDP-1 [478.618929] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [478.623181] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [480.722590] [122/156] (542s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-indfb-plflip-blt) [480.810074] Starting subtest: fbcpsrhdr-2p-scndscrn-indfb-plflip-blt [480.814537] Subtest fbcpsrhdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [480.923708] [123/156] (542s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-shrfb-msflip-blt) [481.007594] Starting subtest: fbchdr-1p-primscrn-shrfb-msflip-blt [481.011946] Subtest fbchdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [481.112179] [124/156] (541s left) kms_cursor_crc (cursor-onscreen-256x256) [481.339801] Starting subtest: cursor-onscreen-256x256 [481.341863] Starting dynamic subtest: pipe-A-eDP-1 [483.431775] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.088s) [483.465082] Starting dynamic subtest: pipe-D-eDP-1 [486.216319] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.758s) [486.218750] Subtest cursor-onscreen-256x256: SUCCESS (4.876s) [487.096970] [125/156] (535s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc) [487.171525] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc [494.239781] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.073s) [494.352346] [126/156] (528s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary) [494.430615] Starting subtest: fbc-shrfb-scaledprimary [497.322161] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.899s) [498.531579] [127/156] (524s left) gem_exec_reloc (basic-write-wc-noreloc) [498.578224] Subtest basic-write-wc-noreloc: SKIP (0.000s) [498.648051] [128/156] (524s left) gem_exec_reloc (basic-active) [498.713826] Subtest basic-active: SKIP (0.000s) [498.807754] [129/156] (524s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-blt) [498.890924] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-blt [498.895111] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [498.989006] [130/156] (524s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling) [499.060308] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling [499.062618] Starting dynamic subtest: pipe-A-default-mode [500.271831] Dynamic subtest pipe-A-default-mode: SKIP (1.208s) [500.276357] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.210s) [500.429053] [131/156] (522s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-move) [500.507860] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-move [500.512043] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-move: SKIP (0.000s) [500.605507] [132/156] (522s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c) [500.664388] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s) [500.739629] [133/156] (522s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc) [500.813502] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc [500.817577] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [500.935379] [134/156] (522s left) kms_flip (flip-vs-rmfb-interruptible) [501.013142] Starting subtest: flip-vs-rmfb-interruptible [501.015422] Starting dynamic subtest: A-eDP1 [509.642973] Dynamic subtest A-eDP1: SUCCESS (8.629s) [509.659787] Starting dynamic subtest: B-eDP1 [518.274934] Dynamic subtest B-eDP1: SUCCESS (8.629s) [518.285929] Starting dynamic subtest: C-eDP1 [526.892186] Dynamic subtest C-eDP1: SUCCESS (8.615s) [526.908219] Starting dynamic subtest: D-eDP1 [535.514990] Dynamic subtest D-eDP1: SUCCESS (8.620s) [535.519555] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.505s) [536.698909] [135/156] (486s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-y) [536.775395] Starting subtest: fbcpsrhdr-tiling-y [536.779869] Subtest fbcpsrhdr-tiling-y: SKIP (0.000s) [536.866188] [136/156] (486s left) kms_cursor_edge_walk (256x256-left-edge) [536.932932] Starting subtest: 256x256-left-edge [536.936689] Starting dynamic subtest: pipe-A-eDP-1 [540.360199] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.428s) [540.371763] Starting dynamic subtest: pipe-D-eDP-1 [543.489202] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.127s) [543.491335] Subtest 256x256-left-edge: SUCCESS (6.557s) [544.314606] [137/156] (479s left) gem_caching (writes) [544.366652] Subtest writes: SKIP (0.000s) [544.432660] [138/156] (479s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt) [544.511389] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt [544.515634] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [544.598619] [139/156] (479s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-render) [544.677150] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-render [544.681701] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [544.783402] [140/156] (478s left) i915_hangman (engine-engine-error) [544.844604] Starting subtest: engine-engine-error [544.846488] Starting dynamic subtest: rcs0 [546.348249] Dynamic subtest rcs0: SUCCESS (1.503s) [546.361322] Starting dynamic subtest: bcs0 [548.331495] Dynamic subtest bcs0: SUCCESS (1.980s) [548.344605] Starting dynamic subtest: vcs0 [550.315391] Dynamic subtest vcs0: SUCCESS (1.981s) [550.329704] Starting dynamic subtest: vcs1 [552.299950] Dynamic subtest vcs1: SUCCESS (1.982s) [552.313854] Starting dynamic subtest: vecs0 [554.283333] Dynamic subtest vecs0: SUCCESS (1.980s) [554.297572] Starting dynamic subtest: ccs0 [556.331216] Dynamic subtest ccs0: SUCCESS (2.045s) [556.334085] Subtest engine-engine-error: SUCCESS (11.489s) [556.462423] [141/156] (467s left) gem_exec_schedule (preemptive-hang) [556.640641] Starting subtest: preemptive-hang [556.642994] Starting dynamic subtest: rcs0 [565.495177] Dynamic subtest rcs0: SUCCESS (8.857s) [565.508258] Starting dynamic subtest: bcs0 [574.520725] Dynamic subtest bcs0: SUCCESS (9.026s) [574.531978] Starting dynamic subtest: vcs0 [583.536940] Dynamic subtest vcs0: SUCCESS (9.013s) [583.551407] Starting dynamic subtest: vcs1 [592.497853] Dynamic subtest vcs1: SUCCESS (8.957s) [592.511626] Starting dynamic subtest: vecs0 [601.459741] Dynamic subtest vecs0: SUCCESS (8.962s) [601.473658] Starting dynamic subtest: ccs0 [610.483545] Dynamic subtest ccs0: SUCCESS (9.020s) [610.486021] Subtest preemptive-hang: SUCCESS (53.843s) [610.731867] [142/156] (413s left) kms_plane_multiple (tiling-none) [610.805791] Starting subtest: tiling-none [610.808071] Starting dynamic subtest: pipe-A-eDP-1 [614.560441] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.755s) [614.572201] Starting dynamic subtest: pipe-B-eDP-1 [619.086317] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.523s) [619.097451] Starting dynamic subtest: pipe-C-eDP-1 [623.535704] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.448s) [623.547485] Starting dynamic subtest: pipe-D-eDP-1 [627.962840] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.426s) [627.965184] Subtest tiling-none: SUCCESS (17.157s) [628.775486] [143/156] (395s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [628.855640] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-mmap-gtt [628.859668] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [628.955581] [144/156] (394s left) gem_workarounds (reset-fd) [629.011289] Starting subtest: reset-fd [629.164909] Subtest reset-fd: SUCCESS (0.154s) [629.285853] [145/156] (394s left) kms_dsc (dsc-fractional-bpp-with-bpc) [629.350223] Starting subtest: dsc-fractional-bpp-with-bpc [629.380747] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.001s) [629.426744] [146/156] (394s left) gem_mmap_offset (perf) [629.477480] Starting subtest: perf [629.479622] Starting dynamic subtest: smem0 [629.831010] Dynamic subtest smem0: SUCCESS (0.352s) [629.833370] Subtest perf: SUCCESS (0.353s) [629.948385] [147/156] (394s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu) [630.029249] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu [634.350774] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.327s) [635.559400] [148/156] (388s left) kms_big_fb (yf-tiled-32bpp-rotate-270) [635.631551] Starting subtest: yf-tiled-32bpp-rotate-270 [635.635831] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s) [635.743119] [149/156] (388s left) syncobj_wait (invalid-signal-one-illegal-handle) [635.796260] Starting subtest: invalid-signal-one-illegal-handle [635.798463] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s) [635.923010] [150/156] (388s left) kms_psr (pr-cursor-mmap-gtt) [635.998518] Starting subtest: pr-cursor-mmap-gtt [636.002281] Subtest pr-cursor-mmap-gtt: SKIP (0.000s) [636.073817] [151/156] (388s left) kms_vblank (ts-continuation-modeset-rpm) [636.161867] Starting subtest: ts-continuation-modeset-rpm [636.163959] Starting dynamic subtest: pipe-A-eDP-1 [638.727949] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.563s) [638.747250] Starting dynamic subtest: pipe-D-eDP-1 [640.984125] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.255s) [640.986621] Subtest ts-continuation-modeset-rpm: SUCCESS (4.822s) [641.888056] [152/156] (382s left) gem_exec_flush (basic-wb-set-default) [641.938207] Starting subtest: basic-wb-set-default [647.389989] Subtest basic-wb-set-default: SUCCESS (5.453s) [647.578561] [153/156] (376s left) gen9_exec_parse (shadow-peek) [647.632031] Subtest shadow-peek: SKIP (0.000s) [647.710670] [154/156] (376s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt) [647.789529] Starting subtest: fbc-rgb565-draw-mmap-gtt [647.793455] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s) [647.877667] [155/156] (376s left) gem_partial_pwrite_pread (writes-after-reads) [647.934640] Subtest writes-after-reads: SKIP (0.000s) [648.013300] [156/156] (376s left) i915_pm_rps (thresholds-idle) [648.068375] Starting subtest: thresholds-idle [648.072836] Subtest thresholds-idle: SKIP (0.001s) [648.173617] Closing watchdogs results: parsing output: 0/ for test: kms_rotation_crc results: parsing output: 1/ for test: gem_ctx_create results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: kms_pm_rpm results: parsing output: 4/ for test: sw_sync results: parsing output: 5/ for test: api_intel_bb results: parsing output: 6/ for test: kms_big_fb results: parsing output: 7/ for test: kms_psr results: parsing output: 8/ for test: kms_async_flips results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: perf_pmu results: parsing output: 11/ for test: kms_lease results: parsing output: 12/ for test: gem_eio results: parsing output: 13/ for test: kms_frontbuffer_tracking results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: kms_properties results: parsing output: 16/ for test: kms_plane_scaling results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: syncobj_wait results: parsing output: 19/ for test: kms_big_fb results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: kms_plane results: parsing output: 22/ for test: kms_chamelium_edid results: parsing output: 23/ for test: gem_exec_reloc results: parsing output: 24/ for test: kms_universal_plane results: parsing output: 25/ for test: gem_exec_big results: parsing output: 26/ for test: kms_flip_scaled_crc results: parsing output: 27/ for test: kms_frontbuffer_tracking results: parsing output: 28/ for test: kms_content_protection results: parsing output: 29/ for test: kms_psr results: parsing output: 30/ for test: gem_exec_balancer results: parsing output: 31/ for test: syncobj_timeline results: parsing output: 32/ for test: gem_media_fill results: parsing output: 33/ for test: gem_set_tiling_vs_blt results: parsing output: 34/ for test: prime_vgem results: parsing output: 35/ for test: i915_drm_fdinfo results: parsing output: 36/ for test: kms_frontbuffer_tracking results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: dmabuf results: parsing output: 39/ for test: syncobj_wait results: parsing output: 40/ for test: kms_prime results: parsing output: 41/ for test: gem_userptr_blits results: parsing output: 42/ for test: perf_pmu results: parsing output: 43/ for test: kms_busy results: parsing output: 44/ for test: i915_pm_rpm results: parsing output: 45/ for test: kms_cursor_legacy results: parsing output: 46/ for test: kms_ccs results: parsing output: 47/ for test: kms_frontbuffer_tracking results: parsing output: 48/ for test: kms_psr2_sf results: parsing output: 49/ for test: kms_big_fb results: parsing output: 50/ for test: kms_psr2_sf results: parsing output: 51/ for test: kms_ccs results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: gem_ctx_persistence results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: syncobj_timeline results: parsing output: 56/ for test: kms_flip results: parsing output: 57/ for test: gem_softpin results: parsing output: 58/ for test: kms_psr2_sf results: parsing output: 59/ for test: kms_chamelium_hpd results: parsing output: 60/ for test: perf results: parsing output: 61/ for test: kms_setmode results: parsing output: 62/ for test: gem_exec_async results: parsing output: 63/ for test: syncobj_timeline results: parsing output: 64/ for test: kms_lease results: parsing output: 65/ for test: kms_plane_alpha_blend results: parsing output: 66/ for test: gem_create results: parsing output: 67/ for test: kms_psr results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: syncobj_wait results: parsing output: 71/ for test: gem_ctx_persistence results: parsing output: 72/ for test: api_intel_allocator results: parsing output: 73/ for test: kms_hdr results: parsing output: 74/ for test: gem_busy results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: kms_big_fb results: parsing output: 78/ for test: gem_exec_reloc results: parsing output: 79/ for test: perf_pmu results: parsing output: 80/ for test: kms_cursor_legacy results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: sw_sync results: parsing output: 83/ for test: syncobj_eventfd results: parsing output: 84/ for test: drm_read results: parsing output: 85/ for test: kms_frontbuffer_tracking 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: gem_exec_whisper results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: syncobj_timeline results: parsing output: 92/ for test: kms_cursor_crc results: parsing output: 93/ for test: kms_addfb_basic results: parsing output: 94/ for test: kms_ccs results: parsing output: 95/ for test: gem_exec_flush results: parsing output: 96/ for test: gem_ringfill results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: kms_3d results: parsing output: 99/ for test: gem_userptr_blits results: parsing output: 100/ for test: vgem_basic results: parsing output: 101/ for test: kms_frontbuffer_tracking results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: gem_exec_params results: parsing output: 104/ for test: gem_pwrite results: parsing output: 105/ for test: gem_exec_fence results: parsing output: 106/ for test: kms_color_pipeline results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: kms_psr results: parsing output: 109/ for test: kms_ccs results: parsing output: 110/ for test: prime_mmap results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: kms_big_fb results: parsing output: 113/ for test: gem_pxp results: parsing output: 114/ for test: gem_exec_schedule results: parsing output: 115/ for test: kms_plane results: parsing output: 116/ for test: gem_exec_whisper results: parsing output: 117/ for test: gem_userptr_blits results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: gem_eio results: parsing output: 120/ for test: kms_ccs results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: kms_frontbuffer_tracking results: parsing output: 123/ for test: kms_cursor_crc results: parsing output: 124/ for test: kms_frontbuffer_tracking results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: gem_exec_reloc results: parsing output: 127/ for test: gem_exec_reloc results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: kms_flip_scaled_crc results: parsing output: 130/ for test: kms_frontbuffer_tracking results: parsing output: 131/ for test: kms_pipe_b_c_ivb results: parsing output: 132/ for test: kms_frontbuffer_tracking results: parsing output: 133/ for test: kms_flip results: parsing output: 134/ for test: kms_frontbuffer_tracking results: parsing output: 135/ for test: kms_cursor_edge_walk results: parsing output: 136/ for test: gem_caching results: parsing output: 137/ for test: kms_frontbuffer_tracking results: parsing output: 138/ for test: kms_frontbuffer_tracking results: parsing output: 139/ for test: i915_hangman results: parsing output: 140/ for test: gem_exec_schedule results: parsing output: 141/ for test: kms_plane_multiple results: parsing output: 142/ for test: kms_frontbuffer_tracking results: parsing output: 143/ for test: gem_workarounds results: parsing output: 144/ for test: kms_dsc results: parsing output: 145/ for test: gem_mmap_offset results: parsing output: 146/ for test: kms_frontbuffer_tracking results: parsing output: 147/ for test: kms_big_fb results: parsing output: 148/ for test: syncobj_wait results: parsing output: 149/ for test: kms_psr results: parsing output: 150/ for test: kms_vblank results: parsing output: 151/ for test: gem_exec_flush results: parsing output: 152/ for test: gen9_exec_parse results: parsing output: 153/ for test: kms_frontbuffer_tracking results: parsing output: 154/ for test: gem_partial_pwrite_pread results: parsing output: 155/ for test: i915_pm_rps Done.