[61.242427] Initializing watchdogs [61.242477] /dev/watchdog0 [61.257602] [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] [61.262187] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [61.264459] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [61.266295] [001/133] (960s left) gem_exec_balancer (parallel-keep-submit-fence) [61.545509] Starting subtest: parallel-keep-submit-fence [62.743828] Subtest parallel-keep-submit-fence: SUCCESS (1.196s) [62.839914] [002/133] (958s left) sriov_basic (enable-vfs-autoprobe-off) [62.899962] Starting subtest: enable-vfs-autoprobe-off [62.901024] Starting dynamic subtest: numvfs-1 [62.934875] Dynamic subtest numvfs-1: FAIL (0.017s) [62.941784] Starting dynamic subtest: numvfs-2 [62.968975] Dynamic subtest numvfs-2: FAIL (0.004s) [62.975021] Starting dynamic subtest: numvfs-3 [63.000576] Dynamic subtest numvfs-3: FAIL (0.004s) [63.006268] Starting dynamic subtest: numvfs-4 [63.031806] Dynamic subtest numvfs-4: FAIL (0.004s) [63.037488] Starting dynamic subtest: numvfs-5 [63.063789] Dynamic subtest numvfs-5: FAIL (0.004s) [63.069425] Starting dynamic subtest: numvfs-6 [63.098043] Dynamic subtest numvfs-6: FAIL (0.004s) [63.104387] Starting dynamic subtest: numvfs-7 [63.130313] Dynamic subtest numvfs-7: FAIL (0.004s) [63.135615] Starting dynamic subtest: numvfs-random [63.160227] Dynamic subtest numvfs-random: FAIL (0.004s) [63.165446] Starting dynamic subtest: numvfs-all [63.190616] Dynamic subtest numvfs-all: FAIL (0.004s) [63.191425] Subtest enable-vfs-autoprobe-off: FAIL (0.049s) [63.217052] [003/133] (958s left) i915_pm_rpm (system-suspend) [65.068068] Starting subtest: system-suspend [83.435637] Subtest system-suspend: SUCCESS (4.654s) [89.829977] [004/133] (938s left) prime_vgem (fence-flip-hang) [89.917878] Subtest fence-flip-hang: SKIP (0.000s) [90.010315] [FACT prime_vgem (fence-flip-hang)] new: kernel.kmod_is_loaded.vgem: true [90.012365] [005/133] (937s left) kms_big_fb (x-tiled-32bpp-rotate-180) [90.120445] Starting subtest: x-tiled-32bpp-rotate-180 [91.580790] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.445s) [91.709703] [006/133] (936s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions) [91.821764] Starting subtest: cursor-vs-flip-atomic-transitions [121.937841] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.036s) [122.750050] [007/133] (905s left) gem_exec_schedule (pi-userfault) [122.928785] Starting subtest: pi-userfault [122.930191] Starting dynamic subtest: rcs0 [122.935257] Dynamic subtest rcs0: SUCCESS (0.013s) [122.943506] Starting dynamic subtest: bcs0 [122.944731] Dynamic subtest bcs0: SUCCESS (0.009s) [122.951651] Starting dynamic subtest: vcs0 [122.952622] Dynamic subtest vcs0: SUCCESS (0.009s) [122.959494] Starting dynamic subtest: vcs1 [122.961547] Dynamic subtest vcs1: SUCCESS (0.008s) [122.968934] Starting dynamic subtest: vecs0 [122.970101] Dynamic subtest vecs0: SUCCESS (0.008s) [122.976907] Starting dynamic subtest: ccs0 [122.979488] Dynamic subtest ccs0: SUCCESS (0.008s) [122.980517] Subtest pi-userfault: SUCCESS (0.057s) [123.157815] [008/133] (904s left) gem_mmap_gtt (basic-write-read-distinct) [123.217257] Subtest basic-write-read-distinct: SKIP (0.000s) [123.266904] [009/133] (904s left) kms_prop_blob (basic) [123.319182] Starting subtest: basic [123.320760] Subtest basic: SUCCESS (0.000s) [123.436270] [010/133] (904s left) gem_mmap_offset (mmap-boundaries) [123.488567] Starting subtest: mmap-boundaries [123.489833] Starting dynamic subtest: smem0 [123.767851] Dynamic subtest smem0: SUCCESS (0.281s) [123.769216] Subtest mmap-boundaries: SUCCESS (0.281s) [123.870032] [011/133] (904s left) kms_hdmi_inject (inject-4k) [124.206637] Starting subtest: inject-4k [124.521020] Subtest inject-4k: SUCCESS (0.316s) [125.082477] [012/133] (903s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions) [125.190835] Starting subtest: flip-vs-cursor-atomic-transitions [132.913528] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.724s) [133.743474] [013/133] (894s left) gem_madvise (dontneed-before-mmap) [133.771824] Starting subtest: dontneed-before-mmap [133.800035] Subtest dontneed-before-mmap: SUCCESS (0.028s) [133.888569] [014/133] (894s left) gem_pxp (hw-rejects-pxp-context) [134.004612] Starting subtest: hw-rejects-pxp-context [134.007454] Subtest hw-rejects-pxp-context: SKIP (0.000s) [134.107993] [015/133] (894s left) kms_busy (basic-hang) [134.191409] Starting subtest: basic-hang [134.192410] Starting dynamic subtest: flip-pipe-A [134.783227] Dynamic subtest flip-pipe-A: SUCCESS (0.591s) [134.791144] Starting dynamic subtest: modeset-pipe-A [138.194543] Dynamic subtest modeset-pipe-A: SUCCESS (3.411s) [138.203634] Starting dynamic subtest: flip-pipe-D [139.450683] Dynamic subtest flip-pipe-D: SUCCESS (1.253s) [139.459042] Starting dynamic subtest: modeset-pipe-D [142.784765] Dynamic subtest modeset-pipe-D: SUCCESS (3.333s) [142.785818] Subtest basic-hang: SUCCESS (8.593s) [143.643961] [016/133] (884s left) kms_psr (fbc-psr2-primary-page-flip) [143.733613] Starting subtest: fbc-psr2-primary-page-flip [143.734826] Starting dynamic subtest: eDP-1 [143.737463] Dynamic subtest eDP-1: SKIP (0.000s) [143.739456] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s) [143.800408] [017/133] (884s left) kms_invalid_mode (clock-too-high) [143.886885] Starting subtest: clock-too-high [143.888093] Starting dynamic subtest: pipe-A-eDP-1 [143.890654] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [143.898727] Starting dynamic subtest: pipe-B-eDP-1 [143.900743] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [143.907994] Starting dynamic subtest: pipe-C-eDP-1 [143.909945] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [143.917492] Starting dynamic subtest: pipe-D-eDP-1 [143.919780] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [143.921553] Subtest clock-too-high: SKIP (0.003s) [143.954323] [018/133] (884s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling) [144.043066] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling [144.044470] Starting dynamic subtest: pipe-A-default-mode [145.181045] Dynamic subtest pipe-A-default-mode: SKIP (1.137s) [145.183426] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.138s) [145.337397] [019/133] (883s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset) [145.425506] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset [145.426842] Starting dynamic subtest: A-eDP1 [149.087488] Dynamic subtest A-eDP1: SUCCESS (3.660s) [149.097640] Starting dynamic subtest: B-eDP1 [152.393238] Dynamic subtest B-eDP1: SUCCESS (3.304s) [152.401484] Starting dynamic subtest: C-eDP1 [155.693510] Dynamic subtest C-eDP1: SUCCESS (3.298s) [155.701221] Starting dynamic subtest: D-eDP1 [158.994634] Dynamic subtest D-eDP1: SUCCESS (3.301s) [158.995864] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.570s) [159.867129] [020/133] (868s left) kms_psr (fbc-pr-cursor-blt) [159.954669] Starting subtest: fbc-pr-cursor-blt [159.957174] Subtest fbc-pr-cursor-blt: SKIP (0.000s) [160.026002] [021/133] (868s left) kms_fbcon_fbt (fbc) [160.080460] Starting subtest: fbc [166.513607] Subtest fbc: SUCCESS (6.420s) [167.639756] [022/133] (860s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines) [168.186243] Starting subtest: syncobj-stationary-timeline-chain-engines [168.280012] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.102s) [169.718339] [023/133] (858s left) i915_suspend (sysfs-reader) [169.780862] Starting subtest: sysfs-reader [187.715054] Subtest sysfs-reader: SUCCESS (3.590s) [193.775146] [024/133] (840s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc) [193.883221] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc [198.004846] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (4.085s) [199.197065] [025/133] (835s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs) [199.247066] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs [199.249415] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s) [199.423871] [026/133] (835s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping) [199.503959] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping [199.505636] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s) [199.572645] [027/133] (835s left) kms_psr (pr-sprite-render) [199.660272] Starting subtest: pr-sprite-render [199.662129] Subtest pr-sprite-render: SKIP (0.000s) [199.728167] [028/133] (835s left) kms_lease (lease-uevent) [199.807104] Starting subtest: lease-uevent [200.836789] Subtest lease-uevent: SUCCESS (1.015s) [200.897873] [029/133] (833s left) kms_flip (flip-vs-panning-interruptible) [200.985452] Starting subtest: flip-vs-panning-interruptible [200.987750] Starting dynamic subtest: A-eDP1 [209.695041] Dynamic subtest A-eDP1: SUCCESS (8.681s) [209.704423] Starting dynamic subtest: B-eDP1 [218.426993] Dynamic subtest B-eDP1: SUCCESS (8.718s) [218.437970] Starting dynamic subtest: C-eDP1 [227.116101] Dynamic subtest C-eDP1: SUCCESS (8.682s) [227.129424] Starting dynamic subtest: D-eDP1 [235.823242] Dynamic subtest D-eDP1: SUCCESS (8.706s) [235.826451] Subtest flip-vs-panning-interruptible: SUCCESS (34.798s) [237.044530] [030/133] (797s left) kms_flip (dpms-vs-vblank-race) [237.139109] Starting subtest: dpms-vs-vblank-race [237.139994] Starting dynamic subtest: A-eDP1 [241.020627] Dynamic subtest A-eDP1: SUCCESS (3.878s) [241.029954] Starting dynamic subtest: B-eDP1 [244.505184] Dynamic subtest B-eDP1: SUCCESS (3.483s) [244.514247] Starting dynamic subtest: C-eDP1 [248.008505] Dynamic subtest C-eDP1: SUCCESS (3.500s) [248.017713] Starting dynamic subtest: D-eDP1 [251.504824] Dynamic subtest D-eDP1: SUCCESS (3.492s) [251.507639] Subtest dpms-vs-vblank-race: SUCCESS (14.367s) [252.335702] [031/133] (782s left) kms_plane_alpha_blend (alpha-basic) [252.429843] Starting subtest: alpha-basic [252.719102] Starting dynamic subtest: pipe-A-eDP-1 [254.681637] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.962s) [254.710312] Starting dynamic subtest: pipe-D-eDP-1 [257.387350] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.684s) [257.388264] Subtest alpha-basic: SUCCESS (4.958s) [258.246442] [032/133] (776s left) syncobj_timeline (multi-wait-available-submitted-signaled) [258.316444] Starting subtest: multi-wait-available-submitted-signaled [258.317387] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s) [258.416770] [033/133] (776s left) kms_sequence (get-forked-busy) [258.508616] Starting subtest: get-forked-busy [258.509506] Starting dynamic subtest: pipe-A-eDP-1 [260.449991] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.940s) [260.462483] Starting dynamic subtest: pipe-B-eDP-1 [263.017108] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.563s) [263.025176] Starting dynamic subtest: pipe-C-eDP-1 [265.590314] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.572s) [265.598238] Starting dynamic subtest: pipe-D-eDP-1 [268.203391] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.610s) [268.204302] Subtest get-forked-busy: SUCCESS (9.691s) [269.045590] [034/133] (765s left) sysfs_preempt_timeout (timeout) [269.100161] Starting subtest: timeout [269.100975] Starting dynamic subtest: vecs0 [278.959150] Dynamic subtest vecs0: SUCCESS (9.845s) [278.970387] Starting dynamic subtest: ccs0 [280.189307] Dynamic subtest ccs0: SUCCESS (1.237s) [280.201164] Starting dynamic subtest: vcs0 [289.966642] Dynamic subtest vcs0: SUCCESS (9.762s) [289.977383] Starting dynamic subtest: bcs0 [291.220627] Dynamic subtest bcs0: SUCCESS (1.260s) [291.234375] Starting dynamic subtest: rcs0 [292.411829] Dynamic subtest rcs0: SUCCESS (1.191s) [292.421252] Starting dynamic subtest: vcs1 [301.998875] Dynamic subtest vcs1: SUCCESS (9.581s) [302.000268] Subtest timeout: SUCCESS (32.886s) [302.078169] [035/133] (732s left) kms_scaling_modes (scaling-mode-full) [302.167912] Starting subtest: scaling-mode-full [302.170422] Starting dynamic subtest: pipe-A-eDP-1 [302.285375] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.116s) [302.295135] Starting dynamic subtest: pipe-B-eDP-1 [303.443939] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.157s) [303.454678] Starting dynamic subtest: pipe-C-eDP-1 [304.622398] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.175s) [304.632171] Starting dynamic subtest: pipe-D-eDP-1 [305.816357] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.193s) [305.817427] Subtest scaling-mode-full: SUCCESS (3.650s) [307.049798] [036/133] (727s left) i915_drm_fdinfo (virtual-busy-idle-all) [307.089614] Starting subtest: virtual-busy-idle-all [307.091505] Subtest virtual-busy-idle-all: SKIP (0.000s) [307.153413] [037/133] (727s left) kms_big_fb (4-tiled-addfb-size-offset-overflow) [307.245162] Starting subtest: 4-tiled-addfb-size-offset-overflow [307.246069] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s) [307.359860] [038/133] (727s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt) [307.454854] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt [307.456819] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [307.539909] [039/133] (727s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [307.637145] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt [307.639541] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [307.746639] [040/133] (727s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode) [308.140638] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s) [308.916122] [041/133] (726s left) kms_color (ctm-0-25) [309.001047] Starting subtest: ctm-0-25 [309.001956] Starting dynamic subtest: pipe-A-eDP-1 [312.484618] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.484s) [312.492685] Starting dynamic subtest: pipe-B-eDP-1 [316.730359] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.245s) [316.738108] Starting dynamic subtest: pipe-C-eDP-1 [320.753064] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.021s) [320.760892] Starting dynamic subtest: pipe-D-eDP-1 [324.748357] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.996s) [324.749209] Subtest ctm-0-25: SUCCESS (15.749s) [325.553739] [042/133] (709s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs) [325.639321] Starting subtest: ccs-on-another-bo-yf-tiled-ccs [325.640255] Starting dynamic subtest: pipe-A-eDP-1 [325.649008] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [325.661815] Starting dynamic subtest: pipe-B-eDP-1 [325.670568] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [325.679144] Starting dynamic subtest: pipe-C-eDP-1 [325.687120] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [325.694440] Starting dynamic subtest: pipe-D-eDP-1 [325.702666] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [325.704395] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.004s) [327.836512] [043/133] (707s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt) [327.939402] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt [332.507279] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.568s) [333.642212] [044/133] (701s left) gem_vm_create (create-ext) [333.699131] Starting subtest: create-ext [333.709725] Subtest create-ext: SUCCESS (0.005s) [333.810626] [045/133] (701s left) kms_cursor_legacy (cursor-vs-flip-atomic) [333.925019] Starting subtest: cursor-vs-flip-atomic [363.401286] Subtest cursor-vs-flip-atomic: SUCCESS (29.469s) [364.243236] [046/133] (671s left) kms_content_protection (atomic-hdcp14) [364.382841] Starting subtest: atomic-hdcp14 [364.384850] Subtest atomic-hdcp14: SKIP (0.000s) [364.511406] [047/133] (670s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc) [364.595099] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc [364.595873] Starting dynamic subtest: pipe-A-eDP-1 [364.611669] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [364.623092] Starting dynamic subtest: pipe-B-eDP-1 [364.631010] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [364.638963] Starting dynamic subtest: pipe-C-eDP-1 [364.647253] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [364.654833] Starting dynamic subtest: pipe-D-eDP-1 [364.663279] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [364.665066] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s) [366.841822] [048/133] (668s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf) [366.938541] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf [366.939381] Starting dynamic subtest: pipe-A-eDP-1 [367.017558] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s) [367.030496] Starting dynamic subtest: pipe-B-eDP-1 [368.184822] Dynamic subtest pipe-B-eDP-1: SKIP (1.165s) [368.186597] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.246s) [369.456191] [049/133] (666s left) kms_async_flips (crc-atomic) [369.551471] Starting subtest: crc-atomic [369.929855] Starting dynamic subtest: pipe-A-eDP-1 [372.827435] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.897s) [373.203914] Starting dynamic subtest: pipe-B-eDP-1 [376.123941] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.927s) [376.498818] Starting dynamic subtest: pipe-C-eDP-1 [379.393548] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.900s) [379.765122] Starting dynamic subtest: pipe-D-eDP-1 [382.622336] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.864s) [382.623356] Subtest crc-atomic: SUCCESS (13.069s) [383.833326] [050/133] (651s left) kms_addfb_basic (basic-x-tiled-legacy) [383.890666] Starting subtest: basic-x-tiled-legacy [383.892302] Subtest basic-x-tiled-legacy: SKIP (0.000s) [384.023910] [051/133] (651s left) kms_cursor_legacy (single-bo) [384.136256] Starting subtest: single-bo [384.137253] Starting dynamic subtest: pipe-A [389.563751] Dynamic subtest pipe-A: SUCCESS (5.378s) [389.574632] Starting dynamic subtest: pipe-B [394.946601] Dynamic subtest pipe-B: SUCCESS (5.379s) [394.957013] Starting dynamic subtest: pipe-C [400.329563] Dynamic subtest pipe-C: SUCCESS (5.379s) [400.340332] Starting dynamic subtest: pipe-D [405.712387] Dynamic subtest pipe-D: SUCCESS (5.379s) [405.723123] Starting dynamic subtest: all-pipes [411.102719] Dynamic subtest all-pipes: SUCCESS (5.386s) [411.103735] Subtest single-bo: SUCCESS (26.913s) [411.199756] [052/133] (624s left) syncobj_timeline (wait-all-for-submit-delayed-submit) [411.244967] Starting subtest: wait-all-for-submit-delayed-submit [411.348572] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s) [411.449398] [053/133] (624s left) gem_pipe_control_store_loop (reused-buffer) [411.505306] Starting subtest: reused-buffer [413.690750] Subtest reused-buffer: SUCCESS (2.151s) [413.789300] [054/133] (621s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs) [413.886103] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs [413.886987] Starting dynamic subtest: pipe-A-eDP-1 [416.115778] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.228s) [416.125222] Starting dynamic subtest: pipe-B-eDP-1 [418.475770] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.358s) [418.485123] Starting dynamic subtest: pipe-C-eDP-1 [420.661307] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.185s) [420.670802] Starting dynamic subtest: pipe-D-eDP-1 [422.942103] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.280s) [422.942943] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (9.056s) [424.144344] [055/133] (611s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw) [424.244072] Starting subtest: fbcpsr-2p-pri-indfb-multidraw [424.245712] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s) [424.342593] [056/133] (611s left) kms_cursor_crc (cursor-rapid-movement-256x85) [424.590469] Starting subtest: cursor-rapid-movement-256x85 [424.642076] Subtest cursor-rapid-movement-256x85: SKIP (0.050s) [424.818673] [057/133] (610s left) gem_exec_schedule (submit-late-slice) [424.880278] Starting subtest: submit-late-slice [424.881155] Starting dynamic subtest: rcs0 [424.918367] Dynamic subtest rcs0: SUCCESS (0.039s) [424.926600] Starting dynamic subtest: bcs0 [424.947785] Dynamic subtest bcs0: SUCCESS (0.028s) [424.955772] Starting dynamic subtest: vcs0 [424.978449] Dynamic subtest vcs0: SUCCESS (0.030s) [424.986277] Starting dynamic subtest: vcs1 [425.007844] Dynamic subtest vcs1: SUCCESS (0.029s) [425.015774] Starting dynamic subtest: vecs0 [425.037346] Dynamic subtest vecs0: SUCCESS (0.029s) [425.046676] Starting dynamic subtest: ccs0 [425.067434] Dynamic subtest ccs0: SUCCESS (0.029s) [425.068492] Subtest submit-late-slice: SUCCESS (0.189s) [427.067329] [058/133] (608s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [427.179336] Starting subtest: basic-busy-flip-before-cursor-legacy [427.181072] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [427.331484] [059/133] (608s left) kms_big_fb (y-tiled-32bpp-rotate-180) [427.431790] Starting subtest: y-tiled-32bpp-rotate-180 [427.433585] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s) [427.527755] [060/133] (608s left) gem_exec_schedule (u-submit-golden-slice) [427.589329] Starting subtest: u-submit-golden-slice [427.590302] Starting dynamic subtest: rcs0 [427.622266] Dynamic subtest rcs0: SUCCESS (0.032s) [427.633742] Starting dynamic subtest: bcs0 [427.648460] Dynamic subtest bcs0: SUCCESS (0.025s) [427.656495] Starting dynamic subtest: vcs0 [427.676412] Dynamic subtest vcs0: SUCCESS (0.027s) [427.685704] Starting dynamic subtest: vcs1 [427.708011] Dynamic subtest vcs1: SUCCESS (0.031s) [427.717888] Starting dynamic subtest: vecs0 [427.735664] Dynamic subtest vecs0: SUCCESS (0.027s) [427.743704] Starting dynamic subtest: ccs0 [427.770950] Dynamic subtest ccs0: SUCCESS (0.034s) [427.771871] Subtest u-submit-golden-slice: SUCCESS (0.182s) [429.048800] [061/133] (606s left) gem_exec_parallel (userptr) [429.110346] Starting subtest: userptr [429.111381] Starting dynamic subtest: rcs0 [430.625317] Dynamic subtest rcs0: SUCCESS (1.514s) [430.637639] Starting dynamic subtest: bcs0 [432.138269] Dynamic subtest bcs0: SUCCESS (1.510s) [432.150282] Starting dynamic subtest: vcs0 [433.907976] Dynamic subtest vcs0: SUCCESS (1.759s) [433.918452] Starting dynamic subtest: vcs1 [435.956166] Dynamic subtest vcs1: SUCCESS (2.046s) [435.964973] Starting dynamic subtest: vecs0 [437.940103] Dynamic subtest vecs0: SUCCESS (1.982s) [437.951158] Starting dynamic subtest: ccs0 [439.422324] Dynamic subtest ccs0: SUCCESS (1.489s) [439.424472] Subtest userptr: SUCCESS (10.315s) [439.609777] [062/133] (596s left) gem_tiled_partial_pwrite_pread (writes-after-reads) [439.658302] Subtest writes-after-reads: SKIP (0.000s) [439.729126] [063/133] (596s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite) [439.824024] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite [439.825604] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [439.912240] [064/133] (596s left) kms_getfb (getfb2-handle-protection) [440.014500] Starting subtest: getfb2-handle-protection [440.033892] Subtest getfb2-handle-protection: SUCCESS (0.020s) [440.177241] [065/133] (595s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [440.268653] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [440.270392] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [440.378765] [066/133] (595s left) gem_gpgpu_fill (basic) [440.431870] Starting subtest: basic [440.432976] Starting dynamic subtest: smem [440.438080] Dynamic subtest smem: SUCCESS (0.007s) [440.439005] Subtest basic: SUCCESS (0.008s) [440.592658] [067/133] (595s left) kms_big_fb (linear-16bpp-rotate-270) [440.690650] Starting subtest: linear-16bpp-rotate-270 [440.710168] Subtest linear-16bpp-rotate-270: SKIP (0.019s) [440.820406] [068/133] (595s left) gem_ctx_sseu (engines) [440.875090] Subtest engines: SKIP (0.000s) [440.928902] [069/133] (595s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling) [441.010335] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling [441.011164] Starting dynamic subtest: pipe-A-default-mode [443.740155] Dynamic subtest pipe-A-default-mode: SUCCESS (2.729s) [443.740947] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.731s) [444.531378] [070/133] (591s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt) [444.635103] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt [451.967156] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.333s) [452.100088] [071/133] (584s left) kms_chamelium_frames (hdmi-crc-multiple) [452.479821] Subtest hdmi-crc-multiple: SKIP (0.000s) [453.314723] [072/133] (583s left) syncobj_wait (invalid-signal-illegal-handle) [453.367241] Starting subtest: invalid-signal-illegal-handle [453.368229] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [453.462960] [073/133] (582s left) gem_ctx_persistence (heartbeat-hang) [453.516175] Starting subtest: heartbeat-hang [453.518040] Subtest heartbeat-hang: SKIP (0.000s) [453.610836] [074/133] (582s left) perf_pmu (render-node-busy) [453.668551] Starting subtest: render-node-busy [453.669487] Starting dynamic subtest: rcs0 [454.261651] Dynamic subtest rcs0: SUCCESS (0.592s) [454.274633] Starting dynamic subtest: bcs0 [454.820518] Dynamic subtest bcs0: SUCCESS (0.556s) [454.833317] Starting dynamic subtest: vcs0 [455.989212] Dynamic subtest vcs0: SUCCESS (1.156s) [456.005324] Starting dynamic subtest: vcs1 [457.973773] Dynamic subtest vcs1: SUCCESS (1.981s) [457.985395] Starting dynamic subtest: vecs0 [459.957192] Dynamic subtest vecs0: SUCCESS (1.981s) [459.968551] Starting dynamic subtest: ccs0 [460.508374] Dynamic subtest ccs0: SUCCESS (0.559s) [460.509748] Subtest render-node-busy: SUCCESS (6.841s) [460.594384] [075/133] (575s left) gem_ctx_engines (execute-one) [460.642150] Starting subtest: execute-one [464.065340] Subtest execute-one: SUCCESS (3.423s) [464.980264] [076/133] (571s left) syncobj_timeline (invalid-query-zero-handles) [465.048977] Starting subtest: invalid-query-zero-handles [465.049892] Subtest invalid-query-zero-handles: SUCCESS (0.000s) [465.143442] [077/133] (571s left) gem_ccs (block-multicopy-inplace) [465.210713] Starting subtest: block-multicopy-inplace [465.212644] Subtest block-multicopy-inplace: SKIP (0.000s) [465.301008] [078/133] (571s left) gem_partial_pwrite_pread (write) [465.356882] Subtest write: SKIP (0.000s) [465.422485] [079/133] (571s left) kms_pipe_crc_basic (bad-source) [465.524993] Starting subtest: bad-source [465.525782] Subtest bad-source: SUCCESS (0.000s) [465.594493] [080/133] (571s left) core_setmaster (master-drop-set-root) [465.658349] Starting subtest: master-drop-set-root [465.671455] Subtest master-drop-set-root: SUCCESS (0.013s) [465.715537] [081/133] (570s left) kms_cursor_crc (cursor-sliding-512x170) [465.989701] Starting subtest: cursor-sliding-512x170 [465.991474] Subtest cursor-sliding-512x170: SKIP (0.001s) [466.143886] [082/133] (570s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs) [466.236267] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs [466.237123] Starting dynamic subtest: pipe-A-eDP-1 [466.246553] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [466.256281] Starting dynamic subtest: pipe-B-eDP-1 [466.265243] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [466.274206] Starting dynamic subtest: pipe-C-eDP-1 [466.283092] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [466.291726] Starting dynamic subtest: pipe-D-eDP-1 [466.300779] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [466.302387] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.004s) [468.433695] [083/133] (568s left) kms_frontbuffer_tracking (pipe-fbc-rte) [468.535648] Starting subtest: pipe-fbc-rte [468.538623] Starting dynamic subtest: pipe-B-eDP-1 [473.949129] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.414s) [473.955298] Subtest pipe-fbc-rte: SUCCESS (5.417s) [476.256105] [084/133] (560s left) kms_psr (fbc-psr-cursor-plane-move) [476.349310] Starting subtest: fbc-psr-cursor-plane-move [476.350123] Starting dynamic subtest: eDP-1 [476.351600] Dynamic subtest eDP-1: SKIP (0.000s) [476.353042] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s) [476.430102] [085/133] (560s left) kms_cursor_crc (cursor-offscreen-32x32) [476.579724] Starting subtest: cursor-offscreen-32x32 [476.626425] Subtest cursor-offscreen-32x32: SKIP (0.044s) [476.898834] [086/133] (559s left) gem_mmap_gtt (cpuset-medium-copy) [476.956739] Subtest cpuset-medium-copy: SKIP (0.000s) [477.044038] [087/133] (559s left) syncobj_timeline (etime-single-wait-available-unsubmitted) [477.090981] Starting subtest: etime-single-wait-available-unsubmitted [477.199821] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.108s) [477.274678] [088/133] (559s left) core_setmaster_vs_auth [477.421882] [089/133] (559s left) api_intel_bb (misplaced-blitter) [477.483434] Starting subtest: misplaced-blitter [477.489413] Subtest misplaced-blitter: SUCCESS (0.007s) [477.620928] [090/133] (559s left) kms_psr (psr-basic) [477.708405] Starting subtest: psr-basic [477.709306] Starting dynamic subtest: eDP-1 [479.285623] Dynamic subtest eDP-1: SUCCESS (1.576s) [479.286500] Subtest psr-basic: SUCCESS (1.577s) [480.132996] [091/133] (556s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc) [480.225253] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc [480.226954] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [480.328883] [092/133] (556s left) gem_basic (bad-close) [480.386120] Starting subtest: bad-close [480.387756] Subtest bad-close: SUCCESS (0.000s) [480.492627] [093/133] (556s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff) [480.579913] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff [480.581631] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [480.672727] [094/133] (556s left) prime_mmap (test_errors) [480.714178] Starting subtest: test_errors [480.715130] Starting dynamic subtest: test_errors-smem [480.906778] Dynamic subtest test_errors-smem: SUCCESS (0.184s) [480.907994] Subtest test_errors: SUCCESS (0.185s) [480.982327] [095/133] (556s left) prime_self_import (basic-llseek-size) [481.016483] Starting subtest: basic-llseek-size [481.028970] Subtest basic-llseek-size: SUCCESS (0.014s) [481.122759] [096/133] (556s left) syncobj_wait (single-wait-signaled) [481.173142] Starting subtest: single-wait-signaled [481.174041] Subtest single-wait-signaled: SUCCESS (0.000s) [481.268370] [097/133] (555s left) i915_drm_fdinfo (most-busy-check-all) [481.307991] Starting subtest: most-busy-check-all [481.308976] Starting dynamic subtest: rcs0 [481.312301] Dynamic subtest rcs0: SKIP (0.003s) [481.321704] Starting dynamic subtest: bcs0 [481.323352] Dynamic subtest bcs0: SKIP (0.000s) [481.332007] Starting dynamic subtest: vcs0 [481.333791] Dynamic subtest vcs0: SKIP (0.000s) [481.342113] Starting dynamic subtest: vcs1 [481.343711] Dynamic subtest vcs1: SKIP (0.000s) [481.354767] Starting dynamic subtest: vecs0 [481.356493] Dynamic subtest vecs0: SKIP (0.000s) [481.364582] Starting dynamic subtest: ccs0 [481.366431] Dynamic subtest ccs0: SKIP (0.000s) [481.368084] Subtest most-busy-check-all: SKIP (0.008s) [481.398969] [098/133] (555s left) perf (short-reads) [481.515286] Starting subtest: short-reads [481.528071] Subtest short-reads: SUCCESS (0.015s) [481.577179] [099/133] (555s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff) [481.706222] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff [481.708192] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [481.809187] [100/133] (555s left) gem_spin_batch (resubmit-new-all) [481.879275] Starting subtest: resubmit-new-all [481.880531] Starting dynamic subtest: rcs0 [481.893407] Dynamic subtest rcs0: SUCCESS (0.014s) [481.909548] Starting dynamic subtest: bcs0 [481.910575] Dynamic subtest bcs0: SUCCESS (0.010s) [481.922309] Starting dynamic subtest: vcs0 [481.923263] Dynamic subtest vcs0: SUCCESS (0.009s) [481.932112] Starting dynamic subtest: vcs1 [481.933110] Dynamic subtest vcs1: SUCCESS (0.012s) [481.941454] Starting dynamic subtest: vecs0 [481.942371] Dynamic subtest vecs0: SUCCESS (0.009s) [481.950658] Starting dynamic subtest: ccs0 [481.951593] Dynamic subtest ccs0: SUCCESS (0.009s) [481.952508] Subtest resubmit-new-all: SUCCESS (0.068s) [483.984923] [101/133] (553s left) kms_dp_link_training (uhbr-sst) [484.094392] Starting subtest: uhbr-sst [484.097890] Subtest uhbr-sst: SKIP (0.000s) [484.165422] [102/133] (553s left) gem_userptr_blits (create-destroy-sync) [484.242754] Starting subtest: create-destroy-sync [489.301949] Subtest create-destroy-sync: SUCCESS (5.015s) [489.370064] [103/133] (548s left) kms_addfb_basic (no-handle) [489.420052] Starting subtest: no-handle [489.420990] Subtest no-handle: SUCCESS (0.000s) [489.578742] [104/133] (547s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt) [489.664320] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt [497.008543] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.344s) [497.121041] [105/133] (540s left) gem_exec_reloc (basic-wc-gtt-active) [497.172821] Subtest basic-wc-gtt-active: SKIP (0.000s) [497.225407] [106/133] (540s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf) [497.310787] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf [497.311669] Starting dynamic subtest: pipe-A-eDP-1 [497.400403] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s) [497.415823] Starting dynamic subtest: pipe-B-eDP-1 [498.589957] Dynamic subtest pipe-B-eDP-1: SKIP (1.186s) [498.591779] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.280s) [499.838493] [107/133] (537s left) api_intel_bb (blit-noreloc-purge-cache) [499.889988] Starting subtest: blit-noreloc-purge-cache [499.899487] Subtest blit-noreloc-purge-cache: SUCCESS (0.010s) [500.021614] [108/133] (537s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu) [500.124675] Starting subtest: fbc-rgb565-draw-mmap-cpu [504.147954] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.023s) [505.352223] [109/133] (532s left) kms_pm_dc (dc5-psr) [506.443730] Starting subtest: dc5-psr [509.328559] Subtest dc5-psr: SUCCESS (2.886s) [510.128066] [110/133] (527s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu) [510.215127] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu [510.216940] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [510.305654] [111/133] (527s left) gem_ctx_param (invalid-set-ringsize) [510.358462] Starting subtest: invalid-set-ringsize [510.359596] Subtest invalid-set-ringsize: SUCCESS (0.000s) [510.442187] [112/133] (527s left) kms_vrr (flip-suspend) [510.537224] Starting subtest: flip-suspend [510.539826] Subtest flip-suspend: SKIP (0.000s) [510.605306] [113/133] (527s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc) [510.688119] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc [510.689055] Starting dynamic subtest: pipe-A-eDP-1 [511.173139] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.475s) [511.182062] Starting dynamic subtest: pipe-B-eDP-1 [512.683698] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.509s) [512.692604] Starting dynamic subtest: pipe-C-eDP-1 [514.049312] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.364s) [514.058895] Starting dynamic subtest: pipe-D-eDP-1 [515.477534] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.427s) [515.478376] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.780s) [516.628411] [114/133] (521s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation) [516.713115] Starting subtest: plane-downscale-factor-0-5-with-rotation [516.714006] Starting dynamic subtest: pipe-A [516.731025] Dynamic subtest pipe-A: SKIP (0.017s) [516.740170] Starting dynamic subtest: pipe-B [516.762537] Dynamic subtest pipe-B: SKIP (0.031s) [516.771831] Starting dynamic subtest: pipe-C [516.795304] Dynamic subtest pipe-C: SKIP (0.031s) [516.808485] Starting dynamic subtest: pipe-D [516.826777] Dynamic subtest pipe-D: SKIP (0.031s) [516.828826] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.113s) [516.940597] [115/133] (520s left) syncobj_wait (multi-wait-for-submit-submitted-signaled) [516.986054] Starting subtest: multi-wait-for-submit-submitted-signaled [516.986902] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s) [517.076778] [116/133] (520s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [517.165254] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip [517.857193] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.692s) [518.018516] [117/133] (519s left) gem_exec_balancer (bonded-false-hang) [518.280750] Starting subtest: bonded-false-hang [518.283533] Subtest bonded-false-hang: SKIP (0.000s) [518.389693] [118/133] (519s left) gen9_exec_parse (bb-secure) [518.449166] Subtest bb-secure: SKIP (0.000s) [518.517370] [119/133] (519s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180) [518.618847] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180 [518.620766] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s) [518.715600] [120/133] (519s left) kms_flip (blocking-absolute-wf_vblank) [518.807350] Starting subtest: blocking-absolute-wf_vblank [518.808252] Starting dynamic subtest: A-eDP1 [527.591760] Dynamic subtest A-eDP1: SUCCESS (8.756s) [527.602781] Starting dynamic subtest: B-eDP1 [536.389454] Dynamic subtest B-eDP1: SUCCESS (8.792s) [536.400735] Starting dynamic subtest: C-eDP1 [545.083261] Dynamic subtest C-eDP1: SUCCESS (8.679s) [545.093641] Starting dynamic subtest: D-eDP1 [553.790577] Dynamic subtest D-eDP1: SUCCESS (8.703s) [553.791887] Subtest blocking-absolute-wf_vblank: SUCCESS (34.945s) [554.933797] [121/133] (483s left) kms_addfb_basic (bo-too-small-due-to-tiling) [555.023826] Starting subtest: bo-too-small-due-to-tiling [555.025687] Subtest bo-too-small-due-to-tiling: SKIP (0.000s) [555.114643] [122/133] (483s left) gem_exec_params (sol-reset-not-gen7) [555.160148] Starting subtest: sol-reset-not-gen7 [555.163461] Subtest sol-reset-not-gen7: SUCCESS (0.003s) [555.295509] [123/133] (482s left) kms_plane_cursor (viewport) [555.378562] Starting subtest: viewport [555.380421] Starting dynamic subtest: pipe-A-eDP-1-size-64 [557.897997] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.520s) [557.961239] Starting dynamic subtest: pipe-A-eDP-1-size-128 [560.432963] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.482s) [560.496078] Starting dynamic subtest: pipe-A-eDP-1-size-256 [563.012525] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.527s) [563.361109] Starting dynamic subtest: pipe-B-eDP-1-size-64 [566.532969] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.180s) [566.593738] Starting dynamic subtest: pipe-B-eDP-1-size-128 [569.091311] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.504s) [569.153805] Starting dynamic subtest: pipe-B-eDP-1-size-256 [571.658455] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.516s) [572.009018] Starting dynamic subtest: pipe-C-eDP-1-size-64 [574.878649] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.879s) [574.918618] Starting dynamic subtest: pipe-C-eDP-1-size-128 [577.123582] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.214s) [577.162104] Starting dynamic subtest: pipe-C-eDP-1-size-256 [579.301532] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.147s) [579.631463] Starting dynamic subtest: pipe-D-eDP-1-size-64 [582.537794] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.915s) [582.577587] Starting dynamic subtest: pipe-D-eDP-1-size-128 [584.727678] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.159s) [584.766946] Starting dynamic subtest: pipe-D-eDP-1-size-256 [586.872129] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.114s) [587.191467] Subtest viewport: SUCCESS (31.805s) [588.034767] [124/133] (450s left) prime_vgem (coherency-gtt) [588.101496] Starting subtest: coherency-gtt [588.103495] Subtest coherency-gtt: SKIP (0.000s) [588.190891] [125/133] (450s left) kms_vrr (flip-basic) [588.277479] Starting subtest: flip-basic [588.280046] Subtest flip-basic: SKIP (0.000s) [588.347516] [126/133] (449s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25) [588.440266] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25 [588.441285] Starting dynamic subtest: pipe-A [588.505384] Dynamic subtest pipe-A: SUCCESS (0.066s) [588.515438] Starting dynamic subtest: pipe-B [589.631610] Dynamic subtest pipe-B: SUCCESS (1.124s) [589.643763] Starting dynamic subtest: pipe-C [590.727723] Dynamic subtest pipe-C: SUCCESS (1.094s) [590.736676] Starting dynamic subtest: pipe-D [591.806996] Dynamic subtest pipe-D: SUCCESS (1.078s) [591.807849] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.368s) [592.937408] [127/133] (445s left) gem_exec_flush (basic-batch-kernel-default-wb) [593.001272] Starting subtest: basic-batch-kernel-default-wb [599.957737] Subtest basic-batch-kernel-default-wb: SUCCESS (6.955s) [600.143861] [128/133] (438s left) kms_frontbuffer_tracking (fbcpsr-slowdraw) [600.239702] Starting subtest: fbcpsr-slowdraw [625.443133] Subtest fbcpsr-slowdraw: SUCCESS (25.198s) [625.561863] [129/133] (412s left) gem_pwrite (basic-random) [625.615754] Subtest basic-random: SKIP (0.000s) [625.667623] [130/133] (412s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt) [625.754387] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt [625.756411] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [625.851324] [131/133] (412s left) syncobj_eventfd (invalid-bad-pad) [625.894241] Starting subtest: invalid-bad-pad [625.895092] Subtest invalid-bad-pad: SUCCESS (0.000s) [625.985909] [132/133] (412s left) syncobj_wait (wait-any-interrupted) [626.035209] Starting subtest: wait-any-interrupted [626.154734] Subtest wait-any-interrupted: SUCCESS (0.108s) [626.233349] [133/133] (412s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt) [626.328896] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt [626.330623] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [626.424040] Closing watchdogs results: parsing output: 0/ for test: gem_exec_balancer results: parsing output: 1/ for test: sriov_basic results: parsing output: 2/ for test: i915_pm_rpm results: parsing output: 3/ for test: prime_vgem results: parsing output: 4/ for test: kms_big_fb results: parsing output: 5/ for test: kms_cursor_legacy results: parsing output: 6/ for test: gem_exec_schedule results: parsing output: 7/ for test: gem_mmap_gtt results: parsing output: 8/ for test: kms_prop_blob results: parsing output: 9/ for test: gem_mmap_offset results: parsing output: 10/ for test: kms_hdmi_inject results: parsing output: 11/ for test: kms_cursor_legacy results: parsing output: 12/ for test: gem_madvise results: parsing output: 13/ for test: gem_pxp results: parsing output: 14/ for test: kms_busy results: parsing output: 15/ for test: kms_psr results: parsing output: 16/ for test: kms_invalid_mode results: parsing output: 17/ for test: kms_flip_scaled_crc results: parsing output: 18/ for test: kms_flip results: parsing output: 19/ for test: kms_psr results: parsing output: 20/ for test: kms_fbcon_fbt results: parsing output: 21/ for test: gem_exec_fence results: parsing output: 22/ for test: i915_suspend results: parsing output: 23/ for test: kms_frontbuffer_tracking results: parsing output: 24/ for test: gem_render_copy results: parsing output: 25/ for test: kms_plane results: parsing output: 26/ for test: kms_psr results: parsing output: 27/ for test: kms_lease results: parsing output: 28/ for test: kms_flip results: parsing output: 29/ for test: kms_flip results: parsing output: 30/ for test: kms_plane_alpha_blend results: parsing output: 31/ for test: syncobj_timeline results: parsing output: 32/ for test: kms_sequence results: parsing output: 33/ for test: sysfs_preempt_timeout results: parsing output: 34/ for test: kms_scaling_modes results: parsing output: 35/ for test: i915_drm_fdinfo results: parsing output: 36/ for test: kms_big_fb results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: kms_chamelium_hpd results: parsing output: 40/ for test: kms_color results: parsing output: 41/ for test: kms_ccs results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: gem_vm_create results: parsing output: 44/ for test: kms_cursor_legacy results: parsing output: 45/ for test: kms_content_protection results: parsing output: 46/ for test: kms_ccs results: parsing output: 47/ for test: kms_psr2_sf results: parsing output: 48/ for test: kms_async_flips results: parsing output: 49/ for test: kms_addfb_basic results: parsing output: 50/ for test: kms_cursor_legacy results: parsing output: 51/ for test: syncobj_timeline results: parsing output: 52/ for test: gem_pipe_control_store_loop results: parsing output: 53/ for test: kms_ccs results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: kms_cursor_crc results: parsing output: 56/ for test: gem_exec_schedule results: parsing output: 57/ for test: kms_cursor_legacy results: parsing output: 58/ for test: kms_big_fb results: parsing output: 59/ for test: gem_exec_schedule results: parsing output: 60/ for test: gem_exec_parallel results: parsing output: 61/ for test: gem_tiled_partial_pwrite_pread results: parsing output: 62/ for test: kms_frontbuffer_tracking results: parsing output: 63/ for test: kms_getfb results: parsing output: 64/ for test: kms_frontbuffer_tracking results: parsing output: 65/ for test: gem_gpgpu_fill results: parsing output: 66/ for test: kms_big_fb results: parsing output: 67/ for test: gem_ctx_sseu results: parsing output: 68/ for test: kms_flip_scaled_crc results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: kms_chamelium_frames results: parsing output: 71/ for test: syncobj_wait results: parsing output: 72/ for test: gem_ctx_persistence results: parsing output: 73/ for test: perf_pmu results: parsing output: 74/ for test: gem_ctx_engines results: parsing output: 75/ for test: syncobj_timeline results: parsing output: 76/ for test: gem_ccs results: parsing output: 77/ for test: gem_partial_pwrite_pread results: parsing output: 78/ for test: kms_pipe_crc_basic results: parsing output: 79/ for test: core_setmaster results: parsing output: 80/ for test: kms_cursor_crc results: parsing output: 81/ for test: kms_ccs results: parsing output: 82/ for test: kms_frontbuffer_tracking results: parsing output: 83/ for test: kms_psr results: parsing output: 84/ for test: kms_cursor_crc results: parsing output: 85/ for test: gem_mmap_gtt results: parsing output: 86/ for test: syncobj_timeline results: parsing output: 87/ for test: core_setmaster_vs_auth results: parsing output: 88/ for test: api_intel_bb results: parsing output: 89/ for test: kms_psr results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: gem_basic results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: prime_mmap results: parsing output: 94/ for test: prime_self_import results: parsing output: 95/ for test: syncobj_wait results: parsing output: 96/ for test: i915_drm_fdinfo results: parsing output: 97/ for test: perf results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: gem_spin_batch results: parsing output: 100/ for test: kms_dp_link_training results: parsing output: 101/ for test: gem_userptr_blits results: parsing output: 102/ for test: kms_addfb_basic results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: gem_exec_reloc results: parsing output: 105/ for test: kms_psr2_sf results: parsing output: 106/ for test: api_intel_bb results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: kms_pm_dc results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: gem_ctx_param results: parsing output: 111/ for test: kms_vrr results: parsing output: 112/ for test: kms_ccs results: parsing output: 113/ for test: kms_plane_scaling results: parsing output: 114/ for test: syncobj_wait results: parsing output: 115/ for test: kms_big_fb results: parsing output: 116/ for test: gem_exec_balancer results: parsing output: 117/ for test: gen9_exec_parse results: parsing output: 118/ for test: kms_big_fb results: parsing output: 119/ for test: kms_flip results: parsing output: 120/ for test: kms_addfb_basic results: parsing output: 121/ for test: gem_exec_params results: parsing output: 122/ for test: kms_plane_cursor results: parsing output: 123/ for test: prime_vgem results: parsing output: 124/ for test: kms_vrr results: parsing output: 125/ for test: kms_plane_scaling results: parsing output: 126/ for test: gem_exec_flush results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: gem_pwrite results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: syncobj_eventfd results: parsing output: 131/ for test: syncobj_wait results: parsing output: 132/ for test: kms_frontbuffer_tracking Done.