[58.531830] Initializing watchdogs
[58.532067]   /dev/watchdog0
[58.550604] [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]
[58.554821] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.557164] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.560286] [001/156] (960s left) kms_dsc (dsc-with-output-formats)
[58.690695] Starting subtest: dsc-with-output-formats
[58.712200] Subtest dsc-with-output-formats: SKIP (0.001s)
[58.771907] [002/156] (960s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-onoff)
[58.877696] Starting subtest: psrhdr-2p-primscrn-cur-indfb-onoff
[58.882169] Subtest psrhdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[58.991187] [003/156] (960s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[59.079401] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[59.081581] Starting dynamic subtest: pipe-A-eDP-1
[59.105225] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[59.115468] Starting dynamic subtest: pipe-B-eDP-1
[59.137728] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[59.144932] Starting dynamic subtest: pipe-C-eDP-1
[59.169088] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[59.177991] Starting dynamic subtest: pipe-D-eDP-1
[59.200655] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[59.204548] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.002s)
[61.329681] [004/156] (957s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[61.437163] Starting subtest: fbc-pr-sprite-mmap-cpu
[61.441067] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[61.503852] [005/156] (957s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[61.597400] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[61.599753] Starting dynamic subtest: pipe-A
[62.635970] Dynamic subtest pipe-A: SUCCESS (1.050s)
[62.642835] Starting dynamic subtest: pipe-B
[64.793668] Dynamic subtest pipe-B: SUCCESS (2.176s)
[64.800630] Starting dynamic subtest: pipe-C
[65.989252] Dynamic subtest pipe-C: SUCCESS (1.203s)
[65.996357] Starting dynamic subtest: pipe-D
[67.220944] Dynamic subtest pipe-D: SUCCESS (1.238s)
[67.223233] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.669s)
[68.407861] [006/156] (950s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[68.526701] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[68.531280] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[68.627047] [007/156] (950s left) kms_psr (psr-primary-mmap-gtt)
[68.717777] Starting subtest: psr-primary-mmap-gtt
[68.720114] Starting dynamic subtest: eDP-1
[70.203816] Dynamic subtest eDP-1: SKIP (1.490s)
[70.208297] Subtest psr-primary-mmap-gtt: SKIP (1.491s)
[70.334642] [008/156] (948s left) kms_color (ctm-blue-to-red)
[70.431146] Starting subtest: ctm-blue-to-red
[70.433072] Starting dynamic subtest: pipe-A-eDP-1
[71.117410] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.688s)
[71.127645] Starting dynamic subtest: pipe-B-eDP-1
[72.553063] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.439s)
[72.560878] Starting dynamic subtest: pipe-C-eDP-1
[73.872362] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.324s)
[73.881273] Starting dynamic subtest: pipe-D-eDP-1
[75.208687] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.336s)
[75.210881] Subtest ctm-blue-to-red: SUCCESS (4.789s)
[76.054853] [009/156] (943s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-render)
[76.152599] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-render
[76.157041] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[76.265560] [010/156] (943s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[76.368796] Starting subtest: y-tiled-8bpp-rotate-270
[76.372945] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[76.452511] [011/156] (942s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[76.556999] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[76.561280] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[76.634916] [012/156] (942s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[76.722581] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[76.726888] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[76.827774] [013/156] (942s left) syncobj_eventfd (invalid-bad-pad)
[76.888235] Starting subtest: invalid-bad-pad
[76.890491] Subtest invalid-bad-pad: SUCCESS (0.000s)
[76.976949] [014/156] (942s left) gem_exec_reloc (basic-write-cpu)
[77.045472] Subtest basic-write-cpu: SKIP (0.000s)
[77.117695] [015/156] (942s left) i915_drm_fdinfo (virtual-busy)
[77.152395] Starting subtest: virtual-busy
[77.156217] Subtest virtual-busy: SKIP (0.000s)
[77.221644] [016/156] (942s left) kms_chamelium_hpd (common-hpd-after-suspend)
[77.597265] Subtest common-hpd-after-suspend: SKIP (0.000s)
[78.458684] [017/156] (941s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[78.552468] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[78.556619] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[78.627815] [018/156] (941s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-render)
[78.730826] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-render
[78.735262] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[78.832085] [019/156] (940s left) kms_setmode (basic)
[78.883122] Starting subtest: basic
[79.236832] Starting dynamic subtest: pipe-A-eDP-1
[82.788931] Dynamic subtest pipe-A-eDP-1: FAIL (3.432s)
[83.001100] Starting dynamic subtest: pipe-B-eDP-1
[86.491046] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.491s)
[86.798857] Subtest basic: FAIL (7.916s)
[87.685888] [020/156] (932s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[87.777527] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[87.781615] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[87.874794] [021/156] (931s left) gem_exec_store (basic)
[87.931143] Starting subtest: basic
[88.037518] Subtest basic: SUCCESS (0.106s)
[88.216751] [022/156] (931s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[88.269321] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[88.271790] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[88.362237] [023/156] (931s left) gem_lmem_swapping (parallel-multi)
[88.401739] Subtest parallel-multi: SKIP (0.000s)
[88.440297] [024/156] (931s left) gem_watchdog (default-virtual)
[88.515466] Starting subtest: default-virtual
[94.797781] Subtest default-virtual: SUCCESS (6.287s)
[94.881863] [025/156] (925s left) kms_vblank (query-forked-busy-hang)
[94.972241] Starting subtest: query-forked-busy-hang
[94.974453] Starting dynamic subtest: pipe-A-eDP-1
[102.199978] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.224s)
[102.212787] Starting dynamic subtest: pipe-D-eDP-1
[110.266121] Dynamic subtest pipe-D-eDP-1: SUCCESS (8.063s)
[110.268446] Subtest query-forked-busy-hang: SUCCESS (15.290s)
[111.078272] [026/156] (908s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[111.178038] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[111.180352] Starting dynamic subtest: pipe-A-eDP-1
[111.205066] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[111.214216] Starting dynamic subtest: pipe-B-eDP-1
[111.236250] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[111.245639] Starting dynamic subtest: pipe-C-eDP-1
[111.267106] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[111.276515] Starting dynamic subtest: pipe-D-eDP-1
[111.298248] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[111.302581] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.003s)
[113.439096] [027/156] (906s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[113.551785] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[113.555823] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[113.655745] [028/156] (906s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[113.754598] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[120.292114] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.544s)
[120.411201] [029/156] (899s left) kms_vrr (seamless-rr-switch-vrr)
[120.520937] Starting subtest: seamless-rr-switch-vrr
[120.527853] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[120.590545] [030/156] (899s left) kms_pm_dc (dc6-dpms)
[121.704803] Starting subtest: dc6-dpms
[123.758109] Subtest dc6-dpms: SUCCESS (2.054s)
[123.843335] [031/156] (896s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[123.945848] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[131.187321] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.246s)
[131.319879] [032/156] (888s left) gem_render_copy_redux (normal)
[131.375478] Starting subtest: normal
[131.626409] Subtest normal: SUCCESS (0.250s)
[131.757092] [033/156] (888s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-mmap-wc)
[131.853690] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-mmap-wc
[131.857861] Subtest fbchdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[131.943072] [034/156] (888s left) gem_basic (bad-close)
[131.996714] Starting subtest: bad-close
[132.001118] Subtest bad-close: SUCCESS (0.000s)
[132.093475] [035/156] (888s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-blt)
[132.184964] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-blt
[132.188820] Subtest hdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[132.268412] [036/156] (888s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[132.391529] Starting subtest: short-busy-flip-before-cursor-toggle
[132.395430] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[132.535636] [037/156] (887s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-indfb-pgflip-blt)
[132.637746] Starting subtest: psrhdr-2p-primscrn-indfb-pgflip-blt
[132.641267] Subtest psrhdr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[132.736873] [038/156] (887s left) gem_userptr_blits (unsync-overlap)
[132.791236] Subtest unsync-overlap: SKIP (0.000s)
[132.912859] [039/156] (887s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-render)
[133.009491] Starting subtest: fbchdr-rgb565-draw-render
[133.012796] Subtest fbchdr-rgb565-draw-render: SKIP (0.000s)
[133.113667] [040/156] (887s left) gem_mmap_offset (pf-nonblock)
[133.181027] Starting subtest: pf-nonblock
[133.188442] Subtest pf-nonblock: SUCCESS (0.008s)
[133.310892] [041/156] (887s left) kms_chamelium_color (gamma)
[133.403547] Subtest gamma: SKIP (0.000s)
[133.445180] [042/156] (887s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[133.502615] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[133.504697] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[133.613198] [043/156] (887s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[133.867297] Starting subtest: cursor-rapid-movement-256x85
[133.911975] Subtest cursor-rapid-movement-256x85: SKIP (0.041s)
[134.071029] [044/156] (886s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[134.179229] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[135.149949] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (0.970s)
[135.267703] [045/156] (885s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[135.378592] Starting subtest: 2x-cursor-vs-flip-legacy
[135.382544] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[135.520783] [046/156] (885s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-mmap-gtt)
[135.611839] Starting subtest: fbcpsrhdr-rgb565-draw-mmap-gtt
[135.615546] Subtest fbcpsrhdr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[135.717838] [047/156] (885s left) gem_ctx_persistence (engines-queued)
[135.768843] Starting subtest: engines-queued
[135.770820] Starting dynamic subtest: rcs0
[135.847956] Dynamic subtest rcs0: SUCCESS (0.079s)
[135.857254] Starting dynamic subtest: bcs0
[135.916066] Dynamic subtest bcs0: SUCCESS (0.067s)
[135.925861] Starting dynamic subtest: vcs0
[137.241210] Dynamic subtest vcs0: SUCCESS (1.321s)
[137.250736] Starting dynamic subtest: vcs1
[139.223592] Dynamic subtest vcs1: SUCCESS (1.980s)
[139.236179] Starting dynamic subtest: vecs0
[141.272370] Dynamic subtest vecs0: SUCCESS (2.046s)
[141.283334] Starting dynamic subtest: ccs0
[141.447616] Dynamic subtest ccs0: SUCCESS (0.175s)
[141.450055] Subtest engines-queued: SUCCESS (5.678s)
[141.566622] [048/156] (879s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-fullscreen)
[141.672742] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-fullscreen
[141.676771] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[141.776458] [049/156] (879s left) gem_ctx_shared (q-out-order)
[141.832479] Starting subtest: Q-out-order
[141.834849] Starting dynamic subtest: rcs0
[141.980092] Dynamic subtest rcs0: SUCCESS (0.145s)
[141.995025] Starting dynamic subtest: vcs0
[142.073539] Dynamic subtest vcs0: SUCCESS (0.095s)
[142.081724] Starting dynamic subtest: vcs1
[142.152653] Dynamic subtest vcs1: SUCCESS (0.078s)
[142.167547] Starting dynamic subtest: vecs0
[142.222196] Dynamic subtest vecs0: SUCCESS (0.069s)
[142.237242] Starting dynamic subtest: ccs0
[142.303933] Dynamic subtest ccs0: SUCCESS (0.081s)
[142.306519] Subtest Q-out-order: SUCCESS (0.471s)
[143.395548] [FACT gem_ctx_shared (q-out-order)] new: kernel.kmod_is_loaded.vgem: true
[143.398731] [050/156] (877s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-mmap-wc)
[143.492261] Starting subtest: psrhdr-rgb565-draw-mmap-wc
[143.496797] Subtest psrhdr-rgb565-draw-mmap-wc: SKIP (0.000s)
[143.600999] [051/156] (877s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[143.694801] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt
[143.698991] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[143.796892] [052/156] (877s left) kms_properties (crtc-properties-atomic)
[143.887076] Starting subtest: crtc-properties-atomic
[143.889337] Starting dynamic subtest: pipe-A-eDP-1
[144.319655] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.432s)
[144.327721] Starting dynamic subtest: pipe-B-eDP-1
[145.475071] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.157s)
[145.484736] Starting dynamic subtest: pipe-C-eDP-1
[146.609153] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.131s)
[146.618565] Starting dynamic subtest: pipe-D-eDP-1
[147.742767] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.131s)
[147.745101] Subtest crtc-properties-atomic: SUCCESS (3.855s)
[148.567845] [053/156] (872s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[148.671591] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-mmap-wc
[148.675775] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[148.782974] [054/156] (872s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[148.873134] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[148.877187] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[148.969906] [055/156] (872s left) i915_module_load (reload-no-display)
[149.008036] Starting subtest: reload-no-display
[154.880414] Subtest reload-no-display: SUCCESS (5.874s)
[154.909404] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[154.910186] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[154.913686] [056/156] (866s left) sysfs_heartbeat_interval (precise)
[156.377011] Starting subtest: precise
[156.379302] Starting dynamic subtest: vecs0
[164.276903] Dynamic subtest vecs0: SUCCESS (7.900s)
[164.289685] Starting dynamic subtest: ccs0
[165.248076] Dynamic subtest ccs0: SUCCESS (0.969s)
[165.258607] Starting dynamic subtest: vcs0
[173.309255] Dynamic subtest vcs0: SUCCESS (8.061s)
[173.320156] Starting dynamic subtest: bcs0
[174.380211] Dynamic subtest bcs0: SUCCESS (1.067s)
[174.391642] Starting dynamic subtest: rcs0
[177.219757] Dynamic subtest rcs0: SUCCESS (2.840s)
[177.227550] Starting dynamic subtest: vcs1
[185.275895] Dynamic subtest vcs1: SUCCESS (8.052s)
[185.278654] Subtest precise: SUCCESS (28.899s)
[185.336911] [FACT sysfs_heartbeat_interval (precise)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[185.338125] [FACT sysfs_heartbeat_interval (precise)] new: kernel.kmod_is_loaded.i915: true
[185.342045] [057/156] (835s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[185.452996] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[185.457268] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[185.549243] [058/156] (835s left) kms_cursor_crc (cursor-alpha-opaque)
[185.646125] Starting subtest: cursor-alpha-opaque
[185.648017] Starting dynamic subtest: pipe-A-eDP-1
[186.288654] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.643s)
[186.297269] Starting dynamic subtest: pipe-D-eDP-1
[187.574964] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.284s)
[187.577329] Subtest cursor-alpha-opaque: SUCCESS (1.930s)
[188.471780] [059/156] (832s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[188.565613] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[188.569675] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[188.659417] [060/156] (832s left) syncobj_wait (single-wait-all-submitted)
[188.722070] Starting subtest: single-wait-all-submitted
[188.830171] Subtest single-wait-all-submitted: SUCCESS (0.107s)
[188.905543] [061/156] (832s left) i915_selftest (perf)
[190.567315] Starting subtest: perf
[190.569826] Starting dynamic subtest: engine_cs
[194.905457] Dynamic subtest engine_cs: SUCCESS (4.338s)
[194.915064] Starting dynamic subtest: request
[200.274617] Dynamic subtest request: SUCCESS (5.367s)
[200.284249] Starting dynamic subtest: migrate
[204.605898] Dynamic subtest migrate: SUCCESS (4.329s)
[204.616477] Starting dynamic subtest: region
[208.811379] Dynamic subtest region: SUCCESS (4.204s)
[208.814078] Subtest perf: SUCCESS (18.245s)
[208.845181] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[208.845882] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[208.848962] [062/156] (812s left) prime_vgem (basic-read)
[210.362733] Starting subtest: basic-read
[210.376451] Subtest basic-read: SKIP (0.009s)
[210.470449] [FACT prime_vgem (basic-read)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[210.471670] [FACT prime_vgem (basic-read)] new: kernel.kmod_is_loaded.i915: true
[210.475389] [063/156] (810s left) kms_vblank (ts-continuation-modeset-hang)
[210.590929] Starting subtest: ts-continuation-modeset-hang
[210.592962] Starting dynamic subtest: pipe-A-eDP-1
[237.122643] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.530s)
[237.134924] Starting dynamic subtest: pipe-D-eDP-1
[262.070029] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.944s)
[262.072265] Subtest ts-continuation-modeset-hang: SUCCESS (51.478s)
[262.889854] [064/156] (758s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[262.995953] Starting subtest: yf-tiled-32bpp-rotate-90
[263.000261] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[263.116845] [065/156] (758s left) gem_tiled_pread_pwrite
[263.231279] [066/156] (758s left) sw_sync (timeline_closed_signaled)
[263.266663] Starting subtest: timeline_closed_signaled
[263.268609] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[263.318172] [067/156] (758s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)
[263.401191] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping
[263.405554] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s)
[263.470377] [068/156] (758s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[263.569065] Starting subtest: fbcpsr-tiling-y
[263.573362] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[263.663750] [069/156] (757s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[263.722524] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[263.726726] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[263.898735] [070/156] (757s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[264.008872] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt
[264.013281] Subtest psrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[264.099122] [071/156] (757s left) kms_flip (bo-too-big-interruptible)
[264.198287] Starting subtest: bo-too-big-interruptible
[264.200611] Starting dynamic subtest: A-eDP1
[265.528912] Dynamic subtest A-eDP1: SUCCESS (1.329s)
[265.539721] Starting dynamic subtest: B-eDP1
[266.863452] Dynamic subtest B-eDP1: SUCCESS (1.332s)
[266.872290] Starting dynamic subtest: C-eDP1
[268.187325] Dynamic subtest C-eDP1: SUCCESS (1.323s)
[268.196038] Starting dynamic subtest: D-eDP1
[269.508069] Dynamic subtest D-eDP1: SUCCESS (1.319s)
[269.510467] Subtest bo-too-big-interruptible: SUCCESS (5.313s)
[270.743380] [072/156] (751s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[270.838622] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[270.842718] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[270.949904] [073/156] (750s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[271.003397] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[271.005531] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[271.116425] [074/156] (750s left) gem_ccs (block-multicopy-inplace)
[271.175082] Starting subtest: block-multicopy-inplace
[271.179170] Subtest block-multicopy-inplace: SKIP (0.000s)
[271.265754] [075/156] (750s left) kms_plane_alpha_blend (coverage-7efc)
[271.349782] Starting subtest: coverage-7efc
[271.641650] Starting dynamic subtest: pipe-A-eDP-1
[272.239125] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.595s)
[272.263625] Starting dynamic subtest: pipe-D-eDP-1
[273.552062] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.295s)
[273.554300] Subtest coverage-7efc: SUCCESS (2.204s)
[274.395892] [076/156] (747s left) gem_exec_reloc (basic-write-wc)
[274.453344] Subtest basic-write-wc: SKIP (0.000s)
[274.538405] [077/156] (747s left) prime_vgem (fence-write-hang)
[274.615822] Subtest fence-write-hang: SKIP (0.000s)
[274.696296] [078/156] (747s left) core_getstats (basic)
[274.752551] Starting subtest: basic
[274.754764] Subtest basic: SUCCESS (0.000s)
[274.864520] [079/156] (747s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[274.914277] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[274.975801] [080/156] (747s left) kms_plane (plane-panning-bottom-right)
[275.061163] Starting subtest: plane-panning-bottom-right
[275.063105] Starting dynamic subtest: pipe-A
[276.739686] Dynamic subtest pipe-A: SUCCESS (1.678s)
[276.749568] Starting dynamic subtest: pipe-B
[279.132570] Dynamic subtest pipe-B: SUCCESS (2.392s)
[279.134884] Subtest plane-panning-bottom-right: SUCCESS (4.073s)
[280.047910] [081/156] (742s left) kms_addfb_basic (master-rmfb)
[280.102644] Starting subtest: master-rmfb
[280.104783] Subtest master-rmfb: SUCCESS (0.002s)
[280.252803] [082/156] (741s left) gem_exec_schedule (fifo)
[280.320920] Starting subtest: fifo
[280.323261] Starting dynamic subtest: rcs0
[280.413867] Dynamic subtest rcs0: SUCCESS (0.103s)
[280.424582] Starting dynamic subtest: vcs0
[280.497764] Dynamic subtest vcs0: SUCCESS (0.083s)
[280.509653] Starting dynamic subtest: vcs1
[280.579314] Dynamic subtest vcs1: SUCCESS (0.081s)
[280.590542] Starting dynamic subtest: vecs0
[280.657684] Dynamic subtest vecs0: SUCCESS (0.078s)
[280.666203] Starting dynamic subtest: ccs0
[280.742177] Dynamic subtest ccs0: SUCCESS (0.082s)
[280.744693] Subtest fifo: SUCCESS (0.432s)
[282.341688] [083/156] (739s left) gem_exec_reloc (basic-gtt-active)
[282.401666] Subtest basic-gtt-active: SKIP (0.000s)
[282.473167] [084/156] (739s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[282.565817] Starting subtest: fbcpsr-rgb565-draw-render
[289.654432] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.093s)
[289.792357] [085/156] (732s left) kms_atomic (plane-invalid-params)
[289.893491] Starting subtest: plane-invalid-params
[289.895798] Starting dynamic subtest: pipe-A-eDP-1
[290.292734] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.399s)
[290.295086] Subtest plane-invalid-params: SUCCESS (0.400s)
[291.179973] [086/156] (731s left) i915_pm_rpm (debugfs-forcewake-user)
[293.509623] Starting subtest: debugfs-forcewake-user
[304.905527] Subtest debugfs-forcewake-user: SUCCESS (11.395s)
[305.289441] [087/156] (717s left) gem_mmap_wc (bad-size)
[305.352488] Subtest bad-size: SKIP (0.000s)
[305.407252] [088/156] (717s left) gem_exec_schedule (pi-userfault)
[305.580078] Starting subtest: pi-userfault
[305.581965] Starting dynamic subtest: rcs0
[305.589392] Dynamic subtest rcs0: SUCCESS (0.012s)
[305.599242] Starting dynamic subtest: bcs0
[305.601410] Dynamic subtest bcs0: SUCCESS (0.007s)
[305.613042] Starting dynamic subtest: vcs0
[305.615508] Dynamic subtest vcs0: SUCCESS (0.008s)
[305.624822] Starting dynamic subtest: vcs1
[305.627329] Dynamic subtest vcs1: SUCCESS (0.008s)
[305.637993] Starting dynamic subtest: vecs0
[305.640269] Dynamic subtest vecs0: SUCCESS (0.010s)
[305.648236] Starting dynamic subtest: ccs0
[305.650211] Dynamic subtest ccs0: SUCCESS (0.010s)
[305.651990] Subtest pi-userfault: SUCCESS (0.060s)
[305.821251] [089/156] (716s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[305.916518] Starting subtest: x-tiled-32bpp-rotate-0
[307.396128] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.479s)
[307.515805] [090/156] (715s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[307.605822] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[307.609211] Subtest hdr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[307.721395] [091/156] (714s left) kms_frontbuffer_tracking (hdr-modesetfrombusy)
[307.816852] Starting subtest: hdr-modesetfrombusy
[307.820255] Subtest hdr-modesetfrombusy: SKIP (0.000s)
[307.922688] [092/156] (714s left) kms_flip (2x-absolute-wf_vblank)
[308.005329] Starting subtest: 2x-absolute-wf_vblank
[308.017516] Subtest 2x-absolute-wf_vblank: SKIP (0.011s)
[308.093912] [093/156] (714s left) gem_exec_create (legacy)
[308.152483] Starting subtest: legacy
[308.154527] Starting dynamic subtest: smem
[310.246182] Dynamic subtest smem: SUCCESS (2.093s)
[310.248647] Subtest legacy: SUCCESS (2.095s)
[310.430470] [094/156] (712s left) kms_cursor_crc (cursor-offscreen-32x10)
[310.592883] Starting subtest: cursor-offscreen-32x10
[310.637786] Subtest cursor-offscreen-32x10: SKIP (0.040s)
[310.916178] [095/156] (711s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-pwrite)
[311.028429] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-pwrite
[311.032760] Subtest hdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[311.119431] [096/156] (711s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[311.177452] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[311.179620] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[311.288094] [097/156] (711s left) gem_tiled_partial_pwrite_pread (reads)
[311.340386] Subtest reads: SKIP (0.000s)
[311.419168] [098/156] (711s left) gem_workarounds (reset-context)
[311.472558] Starting subtest: reset-context
[311.654076] Subtest reset-context: SUCCESS (0.183s)
[311.760700] [099/156] (711s left) kms_flip_event_leak (basic)
[311.851283] Starting subtest: basic
[311.852847] Starting dynamic subtest: pipe-A-eDP-1
[312.283406] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.433s)
[312.293055] Starting dynamic subtest: pipe-B-eDP-1
[313.400655] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.114s)
[313.411042] Starting dynamic subtest: pipe-C-eDP-1
[314.519272] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.117s)
[314.528403] Starting dynamic subtest: pipe-D-eDP-1
[315.634250] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.114s)
[315.636479] Subtest basic: SUCCESS (3.783s)
[316.513755] [100/156] (706s left) perf_pmu (invalid-init)
[316.555076] Starting subtest: invalid-init
[316.557784] Subtest invalid-init: SUCCESS (0.000s)
[316.657997] [101/156] (706s left) gen9_exec_parse (bb-start-far)
[316.724265] Subtest bb-start-far: SKIP (0.000s)
[316.804647] [102/156] (706s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[316.889804] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[316.892108] Starting dynamic subtest: pipe-A-default-mode
[318.056044] Dynamic subtest pipe-A-default-mode: SKIP (1.165s)
[318.060321] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.166s)
[318.204428] [103/156] (704s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[318.288929] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[318.291175] Starting dynamic subtest: pipe-A-eDP-1
[318.312889] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[318.321684] Starting dynamic subtest: pipe-B-eDP-1
[318.341271] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[318.349774] Starting dynamic subtest: pipe-C-eDP-1
[318.370167] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[318.378505] Starting dynamic subtest: pipe-D-eDP-1
[318.400210] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[318.404364] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[320.591158] [104/156] (702s left) syncobj_timeline (32bits-limit)
[320.650678] Starting subtest: 32bits-limit
[320.652942] Subtest 32bits-limit: SUCCESS (0.001s)
[320.752014] [105/156] (702s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[320.849729] Starting subtest: pr-overlay-plane-move-continuous-sf
[320.853702] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[320.928715] [106/156] (702s left) gem_spin_batch (resubmit-all)
[320.992956] Starting subtest: resubmit-all
[320.995360] Starting dynamic subtest: rcs0
[321.004610] Dynamic subtest rcs0: SUCCESS (0.011s)
[321.015835] Starting dynamic subtest: bcs0
[321.018228] Dynamic subtest bcs0: SUCCESS (0.002s)
[321.029945] Starting dynamic subtest: vcs0
[321.032073] Dynamic subtest vcs0: SUCCESS (0.002s)
[321.040694] Starting dynamic subtest: vcs1
[321.042872] Dynamic subtest vcs1: SUCCESS (0.003s)
[321.052083] Starting dynamic subtest: vecs0
[321.054379] Dynamic subtest vecs0: SUCCESS (0.002s)
[321.062903] Starting dynamic subtest: ccs0
[321.065151] Dynamic subtest ccs0: SUCCESS (0.003s)
[321.067332] Subtest resubmit-all: SUCCESS (0.028s)
[322.339581] [107/156] (700s left) syncobj_basic (illegal-fd-to-handle)
[322.388539] Starting subtest: illegal-fd-to-handle
[322.390898] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[322.498842] [108/156] (700s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[322.588314] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[322.590538] Starting dynamic subtest: pipe-A-eDP-1
[322.612984] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[322.624309] Starting dynamic subtest: pipe-B-eDP-1
[322.645078] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[322.653622] Starting dynamic subtest: pipe-C-eDP-1
[322.674263] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[322.682588] Starting dynamic subtest: pipe-D-eDP-1
[322.704599] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[322.708715] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[324.855221] [109/156] (698s left) gem_mmap_wc (coherency)
[324.904647] Subtest coherency: SKIP (0.000s)
[324.963683] [110/156] (698s left) gem_ctx_param (basic)
[325.013926] Starting subtest: basic
[325.016519] Subtest basic: SUCCESS (0.001s)
[325.101206] [111/156] (698s left) kms_cursor_edge_walk (128x128-top-edge)
[325.188361] Starting subtest: 128x128-top-edge
[325.190668] Starting dynamic subtest: pipe-A-eDP-1
[328.626151] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.435s)
[328.636676] Starting dynamic subtest: pipe-D-eDP-1
[331.761085] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.135s)
[331.763487] Subtest 128x128-top-edge: SUCCESS (6.573s)
[332.587572] [112/156] (690s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[332.696442] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[332.698775] Starting dynamic subtest: pipe-A-eDP-1
[332.708106] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[332.718636] Starting dynamic subtest: pipe-B-eDP-1
[332.727066] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[332.735253] Starting dynamic subtest: pipe-C-eDP-1
[332.743200] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[332.751231] Starting dynamic subtest: pipe-D-eDP-1
[332.759123] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[332.763126] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.004s)
[334.966480] [113/156] (688s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[335.063716] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[335.067840] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[335.178599] [114/156] (688s left) gem_create (create-clear)
[335.234573] Starting subtest: create-clear
[335.237212] Starting dynamic subtest: smem0
[367.983862] Dynamic subtest smem0: SUCCESS (32.745s)
[367.985888] Subtest create-clear: SUCCESS (32.746s)
[368.169433] [115/156] (655s left) gem_eio (in-flight-10ms)
[368.424030] Starting subtest: in-flight-10ms
[377.260323] Subtest in-flight-10ms: SUCCESS (8.835s)
[377.383749] [116/156] (646s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[377.474162] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[377.476467] Starting dynamic subtest: A-eDP1
[381.061956] Dynamic subtest A-eDP1: SUCCESS (3.586s)
[381.071426] Starting dynamic subtest: B-eDP1
[384.271404] Dynamic subtest B-eDP1: SUCCESS (3.208s)
[384.282996] Starting dynamic subtest: C-eDP1
[387.486795] Dynamic subtest C-eDP1: SUCCESS (3.213s)
[387.497359] Starting dynamic subtest: D-eDP1
[390.687650] Dynamic subtest D-eDP1: SUCCESS (3.196s)
[390.689816] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.213s)
[391.513872] [117/156] (632s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-shrfb-pgflip-blt)
[391.619083] Starting subtest: fbcpsrhdr-1p-primscrn-shrfb-pgflip-blt
[391.623306] Subtest fbcpsrhdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[391.728620] [118/156] (631s left) kms_plane_scaling (intel-max-src-size)
[391.831399] Starting subtest: intel-max-src-size
[391.838165] Subtest intel-max-src-size: SKIP (0.000s)
[391.924474] [119/156] (631s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[392.030071] Starting subtest: primary-y-tiled-reflect-x-180
[392.102248] Subtest primary-y-tiled-reflect-x-180: SKIP (0.071s)
[392.215419] [120/156] (631s left) kms_setmode (clone-exclusive-crtc)
[392.276606] Starting subtest: clone-exclusive-crtc
[392.283424] Subtest clone-exclusive-crtc: SKIP (0.000s)
[392.359530] [121/156] (631s left) kms_pm_rpm (modeset-stress-extra-wait)
[394.490100] Starting subtest: modeset-stress-extra-wait
[448.868985] Subtest modeset-stress-extra-wait: SUCCESS (54.378s)
[448.974144] [122/156] (574s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[449.083974] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[449.088416] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[449.189954] [123/156] (574s left) gem_ctx_persistence (idempotent)
[449.245296] Starting subtest: idempotent
[449.247714] Subtest idempotent: SUCCESS (0.000s)
[449.344604] [124/156] (574s left) gem_workarounds (suspend-resume-context)
[449.413689] Starting subtest: suspend-resume-context
[465.740967] Subtest suspend-resume-context: SUCCESS (2.065s)
[465.898232] [125/156] (558s left) syncobj_timeline (single-wait-all-signaled)
[465.967006] Starting subtest: single-wait-all-signaled
[465.969453] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[466.078532] [126/156] (557s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[466.211793] Starting subtest: basic-flip-after-cursor-atomic
[467.115945] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.940s)
[467.927384] [127/156] (556s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[468.030785] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[474.817788] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.944s)
[474.945164] [128/156] (549s left) kms_flip (2x-flip-vs-wf_vblank)
[475.038575] Starting subtest: 2x-flip-vs-wf_vblank
[475.047223] Subtest 2x-flip-vs-wf_vblank: SKIP (0.010s)
[475.146713] [129/156] (549s left) kms_invalid_mode (clock-too-high)
[475.237360] Starting subtest: clock-too-high
[475.239621] Starting dynamic subtest: pipe-A-eDP-1
[475.522860] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[475.534969] Starting dynamic subtest: pipe-B-eDP-1
[475.539300] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[475.548442] Starting dynamic subtest: pipe-C-eDP-1
[475.552568] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[475.562355] Starting dynamic subtest: pipe-D-eDP-1
[475.567255] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[475.569545] Subtest clock-too-high: SUCCESS (0.293s)
[476.337834] [130/156] (547s left) gem_mmap_wc (set-cache-level)
[476.392763] Subtest set-cache-level: SKIP (0.000s)
[476.453261] [131/156] (547s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[476.552880] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[483.428675] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.931s)
[483.580268] [132/156] (540s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[483.686619] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu
[483.690863] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[483.788177] [133/156] (540s left) kms_getfb (getfb2-handle-protection)
[483.877533] Starting subtest: getfb2-handle-protection
[483.898311] Subtest getfb2-handle-protection: SUCCESS (0.022s)
[484.022073] [134/156] (540s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[484.095705] Starting subtest: multi-wait-all-for-submit-available-signaled
[484.098005] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[484.213478] [135/156] (540s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[484.265430] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[484.267766] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[484.378176] [136/156] (540s left) perf_pmu (multi-client)
[484.412305] Starting subtest: multi-client
[484.414430] Starting dynamic subtest: rcs0
[485.474626] Dynamic subtest rcs0: SUCCESS (1.067s)
[485.488706] Starting dynamic subtest: bcs0
[486.525620] Dynamic subtest bcs0: SUCCESS (1.051s)
[486.539451] Starting dynamic subtest: vcs0
[487.579450] Dynamic subtest vcs0: SUCCESS (1.054s)
[487.593420] Starting dynamic subtest: vcs1
[489.577683] Dynamic subtest vcs1: SUCCESS (2.001s)
[489.590412] Starting dynamic subtest: vecs0
[491.559873] Dynamic subtest vecs0: SUCCESS (1.983s)
[491.571627] Starting dynamic subtest: ccs0
[493.546622] Dynamic subtest ccs0: SUCCESS (1.987s)
[493.549565] Subtest multi-client: SUCCESS (9.160s)
[493.667865] [137/156] (530s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-render)
[493.774375] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-render
[493.778584] Subtest hdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[493.875916] [138/156] (530s left) kms_psr (psr-primary-render)
[493.968427] Starting subtest: psr-primary-render
[493.970728] Starting dynamic subtest: eDP-1
[495.678821] Dynamic subtest eDP-1: SUCCESS (1.713s)
[495.681266] Subtest psr-primary-render: SUCCESS (1.714s)
[496.541099] [139/156] (528s left) kms_psr (fbc-psr2-suspend)
[496.631239] Starting subtest: fbc-psr2-suspend
[496.633516] Starting dynamic subtest: eDP-1
[496.637681] Dynamic subtest eDP-1: SKIP (0.000s)
[496.641967] Subtest fbc-psr2-suspend: SKIP (0.001s)
[496.705482] [140/156] (527s left) device_reset (unbind-reset-rebind)
[496.747335] Starting subtest: unbind-reset-rebind
[501.704851] Subtest unbind-reset-rebind: SUCCESS (4.951s)
[501.745762] [141/156] (522s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[501.809972] Starting subtest: yf-tiled-ccs-to-yf-tiled
[501.814201] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[501.992365] [142/156] (522s left) kms_psr (psr2-dpms)
[502.093511] Starting subtest: psr2-dpms
[502.095819] Starting dynamic subtest: eDP-1
[505.063040] Dynamic subtest eDP-1: SUCCESS (2.969s)
[505.065430] Subtest psr2-dpms: SUCCESS (2.970s)
[505.965234] [143/156] (518s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[506.055506] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[506.068795] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.011s)
[506.174221] [144/156] (518s left) kms_psr (fbc-psr-primary-mmap-cpu)
[506.267234] Starting subtest: fbc-psr-primary-mmap-cpu
[506.269551] Starting dynamic subtest: eDP-1
[506.273893] Dynamic subtest eDP-1: SKIP (0.000s)
[506.278333] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[506.353869] [145/156] (518s left) gem_exec_balancer (bonded-true-hang)
[506.612047] Starting subtest: bonded-true-hang
[506.616876] Subtest bonded-true-hang: SKIP (0.000s)
[506.723179] [146/156] (518s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[506.825217] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[506.829367] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[506.921296] [147/156] (518s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[507.019638] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[507.021943] Starting dynamic subtest: pipe-A-eDP-1
[507.042451] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[507.055076] Starting dynamic subtest: pipe-B-eDP-1
[507.074601] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[507.087676] Starting dynamic subtest: pipe-C-eDP-1
[507.108583] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[507.130612] Starting dynamic subtest: pipe-D-eDP-1
[507.150448] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[507.152486] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.007s)
[509.304510] [148/156] (515s left) gem_fence_thrash (bo-write-verify-none)
[509.337644] Starting subtest: bo-write-verify-none
[509.361159] Subtest bo-write-verify-none: SKIP (0.020s)
[509.417770] [149/156] (515s left) gem_exec_schedule (submit-late-slice)
[509.488402] Starting subtest: submit-late-slice
[509.490720] Starting dynamic subtest: rcs0
[509.519736] Dynamic subtest rcs0: SUCCESS (0.037s)
[509.533095] Starting dynamic subtest: bcs0
[509.552153] Dynamic subtest bcs0: SUCCESS (0.032s)
[509.562981] Starting dynamic subtest: vcs0
[509.583141] Dynamic subtest vcs0: SUCCESS (0.030s)
[509.594107] Starting dynamic subtest: vcs1
[509.614212] Dynamic subtest vcs1: SUCCESS (0.030s)
[509.624703] Starting dynamic subtest: vecs0
[509.646407] Dynamic subtest vecs0: SUCCESS (0.031s)
[509.659486] Starting dynamic subtest: ccs0
[509.675563] Dynamic subtest ccs0: SUCCESS (0.028s)
[509.677862] Subtest submit-late-slice: SUCCESS (0.194s)
[511.645028] [150/156] (513s left) kms_big_fb (linear-8bpp-rotate-90)
[511.739317] Starting subtest: linear-8bpp-rotate-90
[511.765134] Subtest linear-8bpp-rotate-90: SKIP (0.024s)
[511.891407] [151/156] (513s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[511.986138] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[511.990127] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[512.095867] [152/156] (513s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[512.211022] Starting subtest: 2x-long-flip-vs-cursor-legacy
[512.215454] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s)
[512.365357] [153/156] (512s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[512.458842] Starting subtest: yf-tiled-8bpp-rotate-90
[512.462961] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[512.563357] [154/156] (512s left) gem_exec_fence (long-history)
[512.966849] Starting subtest: long-history
[520.309515] Subtest long-history: SUCCESS (7.343s)
[520.934076] [155/156] (504s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[521.030654] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[521.034938] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[521.145117] [156/156] (504s left) kms_lease (lease-again)
[521.228427] Starting subtest: lease-again
[521.230515] Starting dynamic subtest: pipe-A-eDP-1
[521.232752] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.003s)
[521.243194] Starting dynamic subtest: pipe-B-eDP-1
[521.245033] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[521.254843] Starting dynamic subtest: pipe-C-eDP-1
[521.256695] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[521.266184] Starting dynamic subtest: pipe-D-eDP-1
[521.268120] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[521.270024] Subtest lease-again: SUCCESS (0.013s)
[521.350902] Closing watchdogs
results: parsing output: 0/ for test: kms_dsc
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: kms_psr
results: parsing output: 4/ for test: kms_plane_scaling
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: kms_color
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: kms_psr2_sf
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: syncobj_eventfd
results: parsing output: 13/ for test: gem_exec_reloc
results: parsing output: 14/ for test: i915_drm_fdinfo
results: parsing output: 15/ for test: kms_chamelium_hpd
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_setmode
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gem_exec_store
results: parsing output: 21/ for test: syncobj_wait
results: parsing output: 22/ for test: gem_lmem_swapping
results: parsing output: 23/ for test: gem_watchdog
results: parsing output: 24/ for test: kms_vblank
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_vrr
results: parsing output: 29/ for test: kms_pm_dc
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_render_copy_redux
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: gem_basic
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_cursor_legacy
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_userptr_blits
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_mmap_offset
results: parsing output: 40/ for test: kms_chamelium_color
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: kms_cursor_legacy
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_ctx_persistence
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_ctx_shared
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_properties
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: i915_module_load
results: parsing output: 55/ for test: sysfs_heartbeat_interval
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_cursor_crc
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: syncobj_wait
results: parsing output: 60/ for test: i915_selftest
results: parsing output: 61/ for test: prime_vgem
results: parsing output: 62/ for test: kms_vblank
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: gem_tiled_pread_pwrite
results: parsing output: 65/ for test: sw_sync
results: parsing output: 66/ for test: kms_plane
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_render_copy
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: syncobj_wait
results: parsing output: 73/ for test: gem_ccs
results: parsing output: 74/ for test: kms_plane_alpha_blend
results: parsing output: 75/ for test: gem_exec_reloc
results: parsing output: 76/ for test: prime_vgem
results: parsing output: 77/ for test: core_getstats
results: parsing output: 78/ for test: gem_mmap_gtt
results: parsing output: 79/ for test: kms_plane
results: parsing output: 80/ for test: kms_addfb_basic
results: parsing output: 81/ for test: gem_exec_schedule
results: parsing output: 82/ for test: gem_exec_reloc
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_atomic
results: parsing output: 85/ for test: i915_pm_rpm
results: parsing output: 86/ for test: gem_mmap_wc
results: parsing output: 87/ for test: gem_exec_schedule
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_flip
results: parsing output: 92/ for test: gem_exec_create
results: parsing output: 93/ for test: kms_cursor_crc
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: syncobj_wait
results: parsing output: 96/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 97/ for test: gem_workarounds
results: parsing output: 98/ for test: kms_flip_event_leak
results: parsing output: 99/ for test: perf_pmu
results: parsing output: 100/ for test: gen9_exec_parse
results: parsing output: 101/ for test: kms_flip_scaled_crc
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: kms_psr2_sf
results: parsing output: 105/ for test: gem_spin_batch
results: parsing output: 106/ for test: syncobj_basic
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: gem_mmap_wc
results: parsing output: 109/ for test: gem_ctx_param
results: parsing output: 110/ for test: kms_cursor_edge_walk
results: parsing output: 111/ for test: kms_ccs
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_create
results: parsing output: 114/ for test: gem_eio
results: parsing output: 115/ for test: kms_flip
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_plane_scaling
results: parsing output: 118/ for test: kms_rotation_crc
results: parsing output: 119/ for test: kms_setmode
results: parsing output: 120/ for test: kms_pm_rpm
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gem_ctx_persistence
results: parsing output: 123/ for test: gem_workarounds
results: parsing output: 124/ for test: syncobj_timeline
results: parsing output: 125/ for test: kms_cursor_legacy
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_flip
results: parsing output: 128/ for test: kms_invalid_mode
results: parsing output: 129/ for test: gem_mmap_wc
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_getfb
results: parsing output: 133/ for test: syncobj_timeline
results: parsing output: 134/ for test: syncobj_timeline
results: parsing output: 135/ for test: perf_pmu
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: kms_psr
results: parsing output: 138/ for test: kms_psr
results: parsing output: 139/ for test: device_reset
results: parsing output: 140/ for test: gem_render_copy
results: parsing output: 141/ for test: kms_psr
results: parsing output: 142/ for test: kms_flip
results: parsing output: 143/ for test: kms_psr
results: parsing output: 144/ for test: gem_exec_balancer
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: kms_ccs
results: parsing output: 147/ for test: gem_fence_thrash
results: parsing output: 148/ for test: gem_exec_schedule
results: parsing output: 149/ for test: kms_big_fb
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: kms_cursor_legacy
results: parsing output: 152/ for test: kms_big_fb
results: parsing output: 153/ for test: gem_exec_fence
results: parsing output: 154/ for test: kms_frontbuffer_tracking
results: parsing output: 155/ for test: kms_lease
Done.