[58.458859] Initializing watchdogs [58.458905] /dev/watchdog0 [58.474116] [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.478623] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.481280] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.484641] [001/155] (960s left) gem_eio (throttle) [58.666130] Starting subtest: throttle [58.840051] Subtest throttle: SUCCESS (0.171s) [58.965903] [002/155] (960s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc) [59.059113] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc [59.063434] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [59.146991] [003/155] (959s left) gen9_exec_parse (valid-registers) [59.212131] Subtest valid-registers: SKIP (0.000s) [59.288013] [004/155] (959s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt) [59.385818] Starting subtest: psr-rgb101010-draw-mmap-gtt [59.389366] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [59.500775] [005/155] (959s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant) [59.589538] Starting subtest: coverage-vs-premult-vs-constant [59.892204] Starting dynamic subtest: pipe-A-eDP-1 [60.499815] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.597s) [60.509773] Starting dynamic subtest: pipe-D-eDP-1 [61.801629] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.286s) [61.804082] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.184s) [62.660164] [006/155] (956s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu) [62.760664] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu [67.115648] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.328s) [68.304429] [007/155] (950s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-pgflip-blt) [68.406515] Starting subtest: psrhdr-2p-scndscrn-shrfb-pgflip-blt [68.410851] Subtest psrhdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [68.499997] [008/155] (950s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs) [68.588210] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs [68.590552] Starting dynamic subtest: pipe-A-eDP-1 [68.613830] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [68.623910] Starting dynamic subtest: pipe-B-eDP-1 [68.645586] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [68.653977] Starting dynamic subtest: pipe-C-eDP-1 [68.676229] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [68.684103] Starting dynamic subtest: pipe-D-eDP-1 [68.706624] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [68.711022] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.004s) [70.862826] [009/155] (948s left) gem_lmem_swapping (parallel-random) [70.904296] Subtest parallel-random: SKIP (0.000s) [70.952088] [010/155] (948s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc) [71.043636] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc [71.048069] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [71.142675] [011/155] (948s left) gem_exec_reloc (basic-gtt) [71.205422] Subtest basic-gtt: SKIP (0.000s) [71.288233] [012/155] (948s left) kms_psr (psr2-cursor-blt) [71.379942] Starting subtest: psr2-cursor-blt [71.382346] Starting dynamic subtest: eDP-1 [73.066062] Dynamic subtest eDP-1: SUCCESS (1.681s) [73.068500] Subtest psr2-cursor-blt: SUCCESS (1.682s) [73.962244] [013/155] (945s left) kms_chamelium_color (ctm-0-25) [74.057429] Subtest ctm-0-25: SKIP (0.000s) [74.098753] [014/155] (945s left) gem_ctx_engines (none) [74.164990] Starting subtest: none [74.167462] Subtest none: SUCCESS (0.001s) [74.348061] [015/155] (945s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-onoff) [74.451578] Starting subtest: hdr-1p-primscrn-cur-indfb-onoff [74.456306] Subtest hdr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s) [74.556517] [016/155] (944s left) perf (polling-parameterized) [74.681272] Starting subtest: polling-parameterized [94.754784] Subtest polling-parameterized: SUCCESS (20.005s) [94.792809] [017/155] (924s left) api_intel_allocator (open-vm) [94.849518] Starting subtest: open-vm [94.852082] Subtest open-vm: SUCCESS (0.003s) [94.964628] [018/155] (924s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-pwrite) [95.067575] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-pwrite [95.071982] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [95.148613] [019/155] (924s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-mmap-gtt) [95.249176] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-mmap-gtt [95.253707] Subtest fbchdr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [95.344634] [020/155] (924s left) gem_exec_params (invalid-bsd1-flag-on-render) [95.394821] Starting subtest: invalid-bsd1-flag-on-render [95.397039] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s) [95.498460] [021/155] (924s left) syncobj_timeline (single-wait-all-for-submit-available-submitted) [95.562870] Starting subtest: single-wait-all-for-submit-available-submitted [95.565179] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s) [95.649224] [022/155] (924s left) gem_ctx_isolation (dirty-create) [95.712046] Starting subtest: dirty-create [95.714370] Starting dynamic subtest: rcs0 [95.918134] Dynamic subtest rcs0: SUCCESS (0.206s) [95.928540] Starting dynamic subtest: bcs0 [96.127169] Dynamic subtest bcs0: SUCCESS (0.209s) [96.138988] Starting dynamic subtest: vcs0 [96.332628] Dynamic subtest vcs0: SUCCESS (0.205s) [96.342873] Starting dynamic subtest: vcs1 [97.445062] Dynamic subtest vcs1: SUCCESS (1.111s) [97.454395] Starting dynamic subtest: vecs0 [99.451112] Dynamic subtest vecs0: SUCCESS (2.005s) [99.462176] Starting dynamic subtest: ccs0 [101.517730] Dynamic subtest ccs0: SUCCESS (2.065s) [101.520142] Subtest dirty-create: SUCCESS (5.804s) [101.778598] [023/155] (918s left) kms_content_protection (dp-mst-type-0-hdcp14) [101.924989] Starting subtest: dp-mst-type-0-hdcp14 [101.929754] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s) [102.046347] [024/155] (917s left) kms_cursor_legacy (flip-vs-cursor-toggle) [102.161809] Starting subtest: flip-vs-cursor-toggle [111.124444] Subtest flip-vs-cursor-toggle: SUCCESS (8.959s) [112.011687] [025/155] (907s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu) [112.117208] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu [112.121527] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [112.216653] [026/155] (907s left) kms_plane_multiple (tiling-x) [112.300902] Starting subtest: tiling-x [112.303310] Starting dynamic subtest: pipe-A-eDP-1 [116.085078] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.782s) [116.093593] Starting dynamic subtest: pipe-B-eDP-1 [120.609777] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.523s) [120.619183] Starting dynamic subtest: pipe-C-eDP-1 [125.076912] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.466s) [125.086933] Starting dynamic subtest: pipe-D-eDP-1 [129.620070] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.541s) [129.622038] Subtest tiling-x: SUCCESS (17.316s) [130.450658] [027/155] (889s left) kms_scaling_modes (scaling-mode-center) [130.550138] Starting subtest: scaling-mode-center [130.552454] Starting dynamic subtest: pipe-A-eDP-1 [130.662939] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.115s) [130.671700] Starting dynamic subtest: pipe-B-eDP-1 [131.859399] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.196s) [131.870038] Starting dynamic subtest: pipe-C-eDP-1 [132.987871] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.127s) [132.996243] Starting dynamic subtest: pipe-D-eDP-1 [134.115102] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.125s) [134.117440] Subtest scaling-mode-center: SUCCESS (3.568s) [135.285348] [028/155] (884s left) gem_softpin (allocator-basic) [135.344312] Starting subtest: allocator-basic [135.411254] Subtest allocator-basic: SUCCESS (0.067s) [135.532142] [029/155] (884s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-blt) [135.625972] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-blt [135.630229] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [135.737785] [030/155] (884s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-blt) [135.833227] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-blt [135.837065] Subtest hdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [135.937557] [031/155] (884s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt) [136.037905] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt [136.042066] Subtest psrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [136.162177] [032/155] (884s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt) [136.270175] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt [136.273588] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [136.365614] [033/155] (883s left) gem_softpin (softpin) [136.425252] Starting subtest: softpin [168.676299] Subtest softpin: SUCCESS (32.244s) [168.793571] [034/155] (851s left) kms_plane (plane-panning-top-left) [168.880892] Starting subtest: plane-panning-top-left [168.882820] Starting dynamic subtest: pipe-A [170.567448] Dynamic subtest pipe-A: SUCCESS (1.687s) [170.576702] Starting dynamic subtest: pipe-B [172.993853] Dynamic subtest pipe-B: SUCCESS (2.424s) [172.995831] Subtest plane-panning-top-left: SUCCESS (4.113s) [173.809532] [035/155] (846s left) gem_ctx_shared (exec-shared-gtt) [173.863648] Starting subtest: exec-shared-gtt [173.866131] Starting dynamic subtest: rcs0 [173.873429] Dynamic subtest rcs0: SUCCESS (0.010s) [173.885894] Starting dynamic subtest: bcs0 [173.888300] Dynamic subtest bcs0: SUCCESS (0.005s) [173.899631] Starting dynamic subtest: vcs0 [173.901831] Dynamic subtest vcs0: SUCCESS (0.007s) [173.910310] Starting dynamic subtest: vcs1 [173.912500] Dynamic subtest vcs1: SUCCESS (0.006s) [173.920359] Starting dynamic subtest: vecs0 [173.922594] Dynamic subtest vecs0: SUCCESS (0.006s) [173.930831] Starting dynamic subtest: ccs0 [173.933151] Dynamic subtest ccs0: SUCCESS (0.007s) [173.935427] Subtest exec-shared-gtt: SUCCESS (0.045s) [174.086507] [036/155] (846s left) kms_cursor_edge_walk (128x128-top-bottom) [174.179769] Starting subtest: 128x128-top-bottom [174.182072] Starting dynamic subtest: pipe-A-eDP-1 [177.671049] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.490s) [177.681806] Starting dynamic subtest: pipe-D-eDP-1 [180.807712] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.135s) [180.810043] Subtest 128x128-top-bottom: SUCCESS (6.627s) [181.618817] [037/155] (838s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted) [181.673460] Starting subtest: etime-single-wait-all-available-unsubmitted [181.782916] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.107s) [181.867843] [038/155] (838s left) i915_hangman (detector) [181.936482] Starting subtest: detector [181.938737] Starting dynamic subtest: rcs0 [193.241732] Dynamic subtest rcs0: SUCCESS (11.305s) [193.253685] Starting dynamic subtest: bcs0 [204.249653] Dynamic subtest bcs0: SUCCESS (11.004s) [204.260714] Starting dynamic subtest: vcs0 [216.218845] Dynamic subtest vcs0: SUCCESS (11.966s) [216.230230] Starting dynamic subtest: vcs1 [228.185457] Dynamic subtest vcs1: SUCCESS (11.963s) [228.197749] Starting dynamic subtest: vecs0 [239.193312] Dynamic subtest vecs0: SUCCESS (11.005s) [239.205016] Starting dynamic subtest: ccs0 [250.265849] Dynamic subtest ccs0: SUCCESS (11.069s) [250.268768] Subtest detector: SUCCESS (68.327s) [250.417696] [039/155] (770s left) perf (invalid-oa-format-id) [250.507883] Starting subtest: invalid-oa-format-id [250.516532] Subtest invalid-oa-format-id: SUCCESS (0.008s) [250.561693] [040/155] (769s left) kms_draw_crc (draw-method-mmap-cpu) [250.660892] Starting subtest: draw-method-mmap-cpu [250.663793] Starting dynamic subtest: xrgb8888-untiled [250.925823] Dynamic subtest xrgb8888-untiled: SUCCESS (0.266s) [250.934512] Starting dynamic subtest: rgb565-untiled [251.149512] Dynamic subtest rgb565-untiled: SUCCESS (0.222s) [251.158847] Starting dynamic subtest: xrgb2101010-untiled [251.370039] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s) [251.379352] Starting dynamic subtest: xbgr16161616f-untiled [251.581184] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.211s) [251.590360] Starting dynamic subtest: xrgb8888-xtiled [251.716059] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.132s) [251.725057] Starting dynamic subtest: rgb565-xtiled [251.837464] Dynamic subtest rgb565-xtiled: SUCCESS (0.120s) [251.846605] Starting dynamic subtest: xrgb2101010-xtiled [251.958868] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s) [251.967971] Starting dynamic subtest: xbgr16161616f-xtiled [252.092062] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s) [252.100304] Starting dynamic subtest: xrgb8888-4tiled [252.225719] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.133s) [252.233944] Starting dynamic subtest: rgb565-4tiled [252.370066] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s) [252.378524] Starting dynamic subtest: xrgb2101010-4tiled [252.503418] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s) [252.512526] Starting dynamic subtest: xbgr16161616f-4tiled [252.637116] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s) [252.638956] Subtest draw-method-mmap-cpu: SUCCESS (1.978s) [252.727804] [041/155] (767s left) kms_color (ctm-0-25) [252.827102] Starting subtest: ctm-0-25 [252.829080] Starting dynamic subtest: pipe-A-eDP-1 [256.323864] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.494s) [256.333090] Starting dynamic subtest: pipe-B-eDP-1 [260.633248] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.306s) [260.643065] Starting dynamic subtest: pipe-C-eDP-1 [264.655999] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.022s) [264.664940] Starting dynamic subtest: pipe-D-eDP-1 [268.649712] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.992s) [268.652282] Subtest ctm-0-25: SUCCESS (15.818s) [269.475234] [042/155] (751s left) kms_rmfb (close-fd) [269.593073] Starting subtest: close-fd [269.595322] Starting dynamic subtest: pipe-A-eDP-1 [269.699400] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s) [269.709509] Starting dynamic subtest: pipe-B-eDP-1 [270.867381] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.165s) [270.879082] Starting dynamic subtest: pipe-C-eDP-1 [272.088924] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.224s) [272.097940] Starting dynamic subtest: pipe-D-eDP-1 [273.228234] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.136s) [273.230544] Subtest close-fd: SUCCESS (3.636s) [274.434814] [043/155] (746s left) kms_flip (plain-flip-fb-recreate) [274.527790] Starting subtest: plain-flip-fb-recreate [274.530227] Starting dynamic subtest: A-eDP1 [283.425690] Dynamic subtest A-eDP1: SUCCESS (8.900s) [283.434596] Starting dynamic subtest: B-eDP1 [292.260333] Dynamic subtest B-eDP1: SUCCESS (8.833s) [292.271026] Starting dynamic subtest: C-eDP1 [301.097080] Dynamic subtest C-eDP1: SUCCESS (8.836s) [301.107910] Starting dynamic subtest: D-eDP1 [309.935661] Dynamic subtest D-eDP1: SUCCESS (8.836s) [309.940848] Subtest plain-flip-fb-recreate: SUCCESS (35.417s) [311.120616] [044/155] (709s left) syncobj_timeline (multi-wait-for-submit-available-submitted) [311.173785] Starting subtest: multi-wait-for-submit-available-submitted [311.175856] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s) [311.273192] [045/155] (709s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [311.375150] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-mmap-gtt [311.379266] Subtest hdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [311.492229] [046/155] (709s left) gem_userptr_blits (map-fixed-invalidate-busy) [311.560615] Starting subtest: map-fixed-invalidate-busy [311.564859] Subtest map-fixed-invalidate-busy: SKIP (0.000s) [311.673117] [047/155] (709s left) kms_big_fb (yf-tiled-32bpp-rotate-0) [311.760683] Starting subtest: yf-tiled-32bpp-rotate-0 [311.764850] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s) [311.852288] [048/155] (708s left) gem_exec_schedule (smoketest-all) [311.921614] Starting subtest: smoketest-all [344.292448] Subtest smoketest-all: SUCCESS (32.330s) [345.411451] [049/155] (675s left) kms_frontbuffer_tracking (fbchdr-2p-pri-indfb-multidraw) [345.516729] Starting subtest: fbchdr-2p-pri-indfb-multidraw [345.521305] Subtest fbchdr-2p-pri-indfb-multidraw: SKIP (0.000s) [345.624332] [050/155] (675s left) kms_debugfs (display-on-read-all) [345.721646] Starting subtest: display-on-read-all [345.887275] Subtest display-on-read-all: SUCCESS (0.166s) [346.020717] [051/155] (674s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs) [346.116594] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs [346.118874] Starting dynamic subtest: pipe-A-eDP-1 [346.139197] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.020s) [346.148208] Starting dynamic subtest: pipe-B-eDP-1 [346.167918] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.021s) [346.176945] Starting dynamic subtest: pipe-C-eDP-1 [346.195544] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s) [346.204340] Starting dynamic subtest: pipe-D-eDP-1 [346.223936] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s) [346.226205] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.086s) [348.486467] [052/155] (672s left) i915_pm_rc6_residency (rc6-idle) [348.534558] Starting subtest: rc6-idle [348.565505] Starting dynamic subtest: gt0-rcs0 [372.863944] Dynamic subtest gt0-rcs0: SUCCESS (24.298s) [372.873472] Starting dynamic subtest: gt0-bcs0 [397.132868] Dynamic subtest gt0-bcs0: SUCCESS (24.266s) [397.141854] Starting dynamic subtest: gt0-ccs0 [421.499845] Dynamic subtest gt0-ccs0: SUCCESS (24.363s) [421.511309] Starting dynamic subtest: gt1-vcs0 [427.728233] Dynamic subtest gt1-vcs0: SUCCESS (6.170s) [427.740590] Starting dynamic subtest: gt1-vecs0 [433.898142] Dynamic subtest gt1-vecs0: SUCCESS (6.169s) [433.900628] Subtest rc6-idle: SUCCESS (85.314s) [433.940788] [053/155] (587s left) gem_workarounds (reset-fd) [434.015710] Starting subtest: reset-fd [434.216783] Subtest reset-fd: SUCCESS (0.201s) [434.334892] [054/155] (586s left) perf (short-reads) [434.418754] Starting subtest: short-reads [434.433478] Subtest short-reads: SUCCESS (0.015s) [434.476463] [055/155] (586s left) gem_eio (wait-wedge-10ms) [434.701243] Starting subtest: wait-wedge-10ms [436.376712] Subtest wait-wedge-10ms: SUCCESS (1.677s) [436.528431] [056/155] (584s left) syncobj_basic (bad-flags-handle-to-fd) [436.586020] Starting subtest: bad-flags-handle-to-fd [436.588228] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s) [436.684443] [057/155] (584s left) kms_flip (2x-flip-vs-modeset) [436.783481] Starting subtest: 2x-flip-vs-modeset [436.793943] Subtest 2x-flip-vs-modeset: SKIP (0.010s) [436.895126] [058/155] (584s left) gem_exec_balancer (invalid-balancer) [436.962054] Starting subtest: invalid-balancer [437.856500] Subtest invalid-balancer: SUCCESS (0.894s) [438.166390] [059/155] (583s left) gem_render_tiled_blits (basic) [438.220247] Subtest basic: SKIP (0.000s) [438.282974] [060/155] (583s left) kms_rotation_crc (sprite-rotation-90) [438.370259] Starting subtest: sprite-rotation-90 [438.374826] Subtest sprite-rotation-90: SKIP (0.001s) [438.457155] [061/155] (582s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu) [438.567861] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu [438.572271] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [438.676300] [062/155] (582s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt) [438.777545] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt [438.781759] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [438.867732] [063/155] (582s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt) [438.975610] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt [438.979941] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [439.129954] [064/155] (582s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [439.224937] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip [439.228695] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s) [439.374251] [065/155] (582s left) perf_pmu (frequency) [439.410140] Starting subtest: frequency [439.414064] Starting dynamic subtest: gt0 [441.550511] Dynamic subtest gt0: SUCCESS (2.132s) [441.560862] Starting dynamic subtest: idle-gt0 [442.056231] Dynamic subtest idle-gt0: SUCCESS (0.504s) [442.066194] Starting dynamic subtest: gt1 [446.271077] Dynamic subtest gt1: SUCCESS (4.209s) [446.280526] Starting dynamic subtest: idle-gt1 [446.774876] Dynamic subtest idle-gt1: SUCCESS (0.505s) [446.777147] Subtest frequency: SUCCESS (7.367s) [446.875882] [066/155] (574s left) kms_rotation_crc (primary-x-tiled-reflect-x-180) [446.975670] Starting subtest: primary-x-tiled-reflect-x-180 [453.885052] Subtest primary-x-tiled-reflect-x-180: SUCCESS (6.911s) [455.145054] [067/155] (566s left) kms_multipipe_modeset (basic-max-pipe-crc-check) [455.239436] Starting subtest: basic-max-pipe-crc-check [455.244056] Subtest basic-max-pipe-crc-check: SKIP (0.000s) [455.283069] [068/155] (566s left) kms_psr (psr2-sprite-plane-onoff) [455.384755] Starting subtest: psr2-sprite-plane-onoff [455.387161] Starting dynamic subtest: eDP-1 [457.144929] Dynamic subtest eDP-1: SUCCESS (1.760s) [457.147301] Subtest psr2-sprite-plane-onoff: SUCCESS (1.760s) [458.002984] [069/155] (563s left) kms_cursor_legacy (cursor-vs-flip-legacy) [458.122852] Starting subtest: cursor-vs-flip-legacy [487.787644] Subtest cursor-vs-flip-legacy: SUCCESS (29.661s) [488.624124] [070/155] (533s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels) [488.721172] Starting subtest: plane-all-modeset-transition-internal-panels [488.723276] Starting dynamic subtest: pipe-A-eDP-1 [490.077040] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.355s) [490.359293] Starting dynamic subtest: pipe-B-eDP-1 [491.401088] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.050s) [491.669579] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.947s) [492.509353] [071/155] (529s left) gem_vm_create (create-ext) [492.574378] Starting subtest: create-ext [492.579312] Subtest create-ext: SUCCESS (0.005s) [492.713752] [072/155] (529s left) kms_frontbuffer_tracking (fbc-stridechange) [492.818442] Starting subtest: fbc-stridechange [496.069670] Subtest fbc-stridechange: SUCCESS (3.255s) [497.417680] [073/155] (524s left) gem_mmap_gtt (cpuset-basic-small-copy-xy) [497.478180] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s) [497.533754] [074/155] (524s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-mmap-wc) [497.641158] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-mmap-wc [497.645634] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [497.766189] [075/155] (524s left) gem_bad_reloc (negative-reloc-bltcopy) [497.824525] Subtest negative-reloc-bltcopy: SKIP (0.000s) [497.907770] [076/155] (524s left) gem_exec_reloc (basic-scanout) [497.961655] Subtest basic-scanout: SKIP (0.000s) [498.038316] [077/155] (524s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move) [498.144714] Starting subtest: psr-2p-primscrn-spr-indfb-move [498.149127] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [498.243870] [078/155] (523s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc) [498.327634] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc [498.329596] Starting dynamic subtest: pipe-A-eDP-1 [514.284834] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.529s) [514.294856] Starting dynamic subtest: pipe-B-eDP-1 [532.291882] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.497s) [532.303935] Starting dynamic subtest: pipe-C-eDP-1 [549.219002] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.390s) [549.230804] Starting dynamic subtest: pipe-D-eDP-1 [566.219518] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.362s) [566.221866] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (8.783s) [567.500547] [079/155] (454s left) perf_pmu (busy-accuracy-50) [567.546668] Starting subtest: busy-accuracy-50 [567.548644] Starting dynamic subtest: rcs0 [569.283464] Dynamic subtest rcs0: SUCCESS (1.688s) [569.299809] Starting dynamic subtest: bcs0 [571.031049] Dynamic subtest bcs0: SUCCESS (1.708s) [571.045280] Starting dynamic subtest: vcs0 [572.769415] Dynamic subtest vcs0: SUCCESS (1.707s) [572.783013] Starting dynamic subtest: vcs1 [574.509521] Dynamic subtest vcs1: SUCCESS (1.715s) [574.522801] Starting dynamic subtest: vecs0 [576.240976] Dynamic subtest vecs0: SUCCESS (1.711s) [576.252853] Starting dynamic subtest: ccs0 [577.787612] Dynamic subtest ccs0: SUCCESS (1.532s) [577.789543] Subtest busy-accuracy-50: SUCCESS (10.069s) [578.205833] [080/155] (444s left) gem_pxp (verify-pxp-execution-after-suspend-resume) [578.332649] Starting subtest: verify-pxp-execution-after-suspend-resume [585.388185] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.019s) [585.523941] [081/155] (436s left) gem_exec_params (secure-non-master) [585.589039] Starting subtest: secure-non-master [585.593500] Subtest secure-non-master: SKIP (0.000s) [585.680026] [082/155] (436s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling) [585.772487] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling [585.776857] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.000s) [585.844139] [083/155] (436s left) kms_psr (pr-basic) [585.930364] Starting subtest: pr-basic [585.934635] Subtest pr-basic: SKIP (0.000s) [586.011520] [084/155] (436s left) prime_busy (hang-wait) [586.064419] Starting subtest: hang-wait [586.066812] Starting dynamic subtest: rcs0 [612.649400] Dynamic subtest rcs0: SUCCESS (26.550s) [612.661835] Starting dynamic subtest: bcs0 [619.793337] Dynamic subtest bcs0: SUCCESS (7.149s) [619.803796] Starting dynamic subtest: vcs0 [626.771168] Dynamic subtest vcs0: SUCCESS (6.971s) [626.781413] Starting dynamic subtest: vcs1 [633.817475] Dynamic subtest vcs1: SUCCESS (7.039s) [633.829999] Starting dynamic subtest: vecs0 [640.854565] Dynamic subtest vecs0: SUCCESS (7.031s) [640.867162] Starting dynamic subtest: ccs0 [654.622743] Dynamic subtest ccs0: SUCCESS (13.759s) [654.624909] Subtest hang-wait: SUCCESS (68.513s) [654.771276] [085/155] (367s left) kms_properties (connector-properties-atomic) [654.872095] Starting subtest: connector-properties-atomic [654.874021] Starting dynamic subtest: pipe-A-eDP-1 [662.833603] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.956s) [662.845177] Starting dynamic subtest: pipe-None-DP-1 [662.849803] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s) [662.859782] Starting dynamic subtest: pipe-None-HDMI-A-1 [662.864044] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s) [662.873694] Starting dynamic subtest: pipe-None-DP-2 [662.877701] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s) [662.887216] Starting dynamic subtest: pipe-None-HDMI-A-2 [662.891363] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s) [662.901134] Starting dynamic subtest: pipe-None-DP-3 [662.905704] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s) [662.918363] Starting dynamic subtest: pipe-None-DP-4 [662.922844] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s) [662.924789] Subtest connector-properties-atomic: SUCCESS (7.967s) [663.704546] [086/155] (358s left) sysfs_timeslice_duration (duration) [663.768160] Starting subtest: duration [663.770398] Starting dynamic subtest: vecs0 [678.114377] Dynamic subtest vecs0: SUCCESS (14.336s) [678.127638] Starting dynamic subtest: ccs0 [691.278132] Dynamic subtest ccs0: SUCCESS (13.150s) [691.288178] Starting dynamic subtest: vcs0 [705.183513] Dynamic subtest vcs0: SUCCESS (13.900s) [705.197636] Starting dynamic subtest: bcs0 [718.349708] Dynamic subtest bcs0: SUCCESS (13.149s) [718.362728] Starting dynamic subtest: rcs0 [731.463166] Dynamic subtest rcs0: SUCCESS (13.137s) [731.476405] Starting dynamic subtest: vcs1 [745.118708] Dynamic subtest vcs1: SUCCESS (13.662s) [745.121773] Subtest duration: SUCCESS (81.350s) [745.207252] [087/155] (277s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-pwrite) [745.310627] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-pwrite [745.314930] Subtest psrhdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [745.403579] [088/155] (277s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-render) [745.500687] Starting subtest: fbchdr-rgb565-draw-render [745.504700] Subtest fbchdr-rgb565-draw-render: SKIP (0.000s) [745.598609] [089/155] (276s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5) [745.700208] Starting subtest: planes-upscale-20x20-downscale-factor-0-5 [745.702508] Starting dynamic subtest: pipe-A [745.722681] Dynamic subtest pipe-A: SKIP (0.019s) [745.734358] Starting dynamic subtest: pipe-B [745.754822] Dynamic subtest pipe-B: SKIP (0.033s) [745.765791] Starting dynamic subtest: pipe-C [745.788803] Dynamic subtest pipe-C: SKIP (0.031s) [745.801286] Starting dynamic subtest: pipe-D [745.820551] Dynamic subtest pipe-D: SKIP (0.030s) [745.825179] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.116s) [745.920089] [090/155] (276s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt) [746.031853] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt [746.035890] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [746.127555] [091/155] (276s left) gem_ctx_persistence (heartbeat-many) [746.194050] Starting subtest: heartbeat-many [746.198120] Subtest heartbeat-many: SKIP (0.000s) [746.311181] [092/155] (276s left) kms_vrr (flip-basic) [746.407726] Starting subtest: flip-basic [746.412966] Subtest flip-basic: SKIP (0.000s) [746.477689] [093/155] (276s left) kms_busy (extended-modeset-hang-newfb) [746.574845] Starting subtest: extended-modeset-hang-newfb [746.576738] Starting dynamic subtest: pipe-A [781.086887] Dynamic subtest pipe-A: SUCCESS (34.517s) [781.099666] Starting dynamic subtest: pipe-D [804.114123] Dynamic subtest pipe-D: SUCCESS (23.025s) [804.116529] Subtest extended-modeset-hang-newfb: SUCCESS (57.548s) [805.019554] [094/155] (217s left) kms_big_fb (4-tiled-addfb-size-offset-overflow) [805.118163] Starting subtest: 4-tiled-addfb-size-offset-overflow [805.120516] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s) [805.200524] [095/155] (217s left) gem_busy (busy) [805.252036] Starting subtest: busy [805.254635] Starting dynamic subtest: all-engines [805.308972] Dynamic subtest all-engines: SUCCESS (0.057s) [805.320706] Starting dynamic subtest: rcs0 [807.176156] Dynamic subtest rcs0: SUCCESS (1.864s) [807.187360] Starting dynamic subtest: bcs0 [807.231438] Dynamic subtest bcs0: SUCCESS (0.052s) [807.242337] Starting dynamic subtest: vcs0 [807.270391] Dynamic subtest vcs0: SUCCESS (0.039s) [807.280497] Starting dynamic subtest: vcs1 [809.158753] Dynamic subtest vcs1: SUCCESS (1.884s) [809.170349] Starting dynamic subtest: vecs0 [811.261428] Dynamic subtest vecs0: SUCCESS (2.047s) [811.275130] Starting dynamic subtest: ccs0 [813.191585] Dynamic subtest ccs0: SUCCESS (1.982s) [813.194271] Subtest busy: SUCCESS (7.935s) [813.555347] [096/155] (209s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary) [813.658452] Starting subtest: fbc-shrfb-scaledprimary [816.499194] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.845s) [817.707498] [097/155] (205s left) kms_prop_blob (blob-multiple) [817.761246] Starting subtest: blob-multiple [817.763432] Subtest blob-multiple: SUCCESS (0.002s) [817.878557] [098/155] (205s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt) [817.979018] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt [817.983205] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [818.078505] [099/155] (204s left) i915_suspend (sysfs-reader) [818.126008] Starting subtest: sysfs-reader [836.031814] Subtest sysfs-reader: SUCCESS (3.124s) [836.086285] [100/155] (186s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs) [836.189771] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs [836.191634] Starting dynamic subtest: pipe-A-eDP-1 [836.607235] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.421s) [836.620561] Starting dynamic subtest: pipe-B-eDP-1 [836.638333] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s) [836.649266] Starting dynamic subtest: pipe-C-eDP-1 [836.665280] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s) [836.675764] Starting dynamic subtest: pipe-D-eDP-1 [836.691834] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s) [836.693405] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.435s) [838.868147] [101/155] (184s left) gem_exec_schedule (preempt-queue-chain) [838.941346] Subtest preempt-queue-chain: SKIP (0.000s) [839.225638] [102/155] (183s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt) [839.326109] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt [839.330498] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [839.416356] [103/155] (183s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip) [839.518802] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip [839.523185] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s) [839.616641] [104/155] (183s left) kms_color (deep-color) [839.703575] Starting subtest: deep-color [840.757830] Starting dynamic subtest: pipe-A-eDP-1-gamma [841.468415] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.716s) [841.480428] Starting dynamic subtest: pipe-A-eDP-1-degamma [842.941249] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.475s) [842.953071] Starting dynamic subtest: pipe-A-eDP-1-ctm [844.367424] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.432s) [845.141737] Starting dynamic subtest: pipe-B-eDP-1-gamma [845.840874] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.713s) [845.852115] Starting dynamic subtest: pipe-B-eDP-1-degamma [847.326997] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.487s) [847.337525] Starting dynamic subtest: pipe-B-eDP-1-ctm [848.765734] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.439s) [849.529621] Starting dynamic subtest: pipe-C-eDP-1-gamma [850.210119] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.691s) [850.221845] Starting dynamic subtest: pipe-C-eDP-1-degamma [851.687795] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.476s) [851.699193] Starting dynamic subtest: pipe-C-eDP-1-ctm [853.108623] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.424s) [853.931492] Starting dynamic subtest: pipe-D-eDP-1-gamma [854.629566] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.708s) [854.640408] Starting dynamic subtest: pipe-D-eDP-1-degamma [856.084194] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.456s) [856.095260] Starting dynamic subtest: pipe-D-eDP-1-ctm [857.502799] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.417s) [857.504941] Subtest deep-color: SUCCESS (17.834s) [858.377743] [105/155] (164s left) kms_cursor_crc (cursor-rapid-movement-64x64) [858.575293] Starting subtest: cursor-rapid-movement-64x64 [858.577560] Starting dynamic subtest: pipe-A-eDP-1 [859.130287] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.553s) [859.158564] Starting dynamic subtest: pipe-D-eDP-1 [860.389934] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.241s) [860.392342] Subtest cursor-rapid-movement-64x64: SUCCESS (1.818s) [861.227331] [106/155] (162s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt) [861.319450] Starting subtest: fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt [861.324078] Subtest fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [861.416404] [107/155] (161s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-blt) [861.517055] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-blt [861.521322] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [861.619207] [108/155] (161s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-mmap-cpu) [861.716663] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-mmap-cpu [861.720688] Subtest hdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [861.820775] [109/155] (161s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier) [861.909067] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier [861.935355] Starting dynamic subtest: pipe-A-plane-0 [862.223450] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s) [862.234475] Starting dynamic subtest: pipe-A-plane-3 [862.456321] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s) [862.466633] Starting dynamic subtest: pipe-A-plane-5 [862.470289] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [863.619854] Starting dynamic subtest: pipe-B-plane-0 [863.910488] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s) [863.923854] Starting dynamic subtest: pipe-B-plane-3 [864.165861] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s) [864.177089] Starting dynamic subtest: pipe-B-plane-5 [864.181791] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [864.474706] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.567s) [865.288153] [110/155] (158s left) kms_frontbuffer_tracking (psrhdr-suspend) [865.387809] Starting subtest: psrhdr-suspend [865.391865] Subtest psrhdr-suspend: SKIP (0.000s) [865.493689] [111/155] (158s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling) [865.581072] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling [865.585359] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s) [865.669469] [112/155] (157s left) kms_flip (2x-plain-flip-interruptible) [865.772592] Starting subtest: 2x-plain-flip-interruptible [865.783680] Subtest 2x-plain-flip-interruptible: SKIP (0.010s) [865.859723] [113/155] (157s left) kms_psr (fbc-psr2-sprite-plane-move) [865.958581] Starting subtest: fbc-psr2-sprite-plane-move [865.960488] Starting dynamic subtest: eDP-1 [865.964430] Dynamic subtest eDP-1: SKIP (0.000s) [865.968356] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s) [866.043750] [114/155] (157s left) core_setmaster (master-drop-set-shared-fd) [866.130253] Starting subtest: master-drop-set-shared-fd [866.148782] Subtest master-drop-set-shared-fd: SUCCESS (0.021s) [866.186565] [115/155] (157s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt) [866.282760] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt [866.286154] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [866.377382] [116/155] (157s left) kms_big_fb (linear-16bpp-rotate-90) [866.473680] Starting subtest: linear-16bpp-rotate-90 [866.493259] Subtest linear-16bpp-rotate-90: SKIP (0.019s) [866.616977] [117/155] (157s left) kms_chamelium_frames (hdmi-crc-multiple) [867.000125] Subtest hdmi-crc-multiple: SKIP (0.000s) [867.804313] [118/155] (155s left) kms_async_flips (crc) [867.902561] Starting subtest: crc [868.265885] Starting dynamic subtest: pipe-A-eDP-1 [871.239059] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.972s) [871.632049] Starting dynamic subtest: pipe-B-eDP-1 [874.578596] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.956s) [874.961580] Starting dynamic subtest: pipe-C-eDP-1 [877.881129] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.931s) [878.259669] Starting dynamic subtest: pipe-D-eDP-1 [881.123422] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.877s) [881.125848] Subtest crc: SUCCESS (13.220s) [882.284609] [119/155] (141s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-pwrite) [882.383186] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-pwrite [882.387576] Subtest psrhdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [882.464578] [120/155] (141s left) vgem_basic (dmabuf-fence) [882.576252] Starting subtest: dmabuf-fence [882.578441] Subtest dmabuf-fence: SUCCESS (0.001s) [882.629905] [FACT vgem_basic (dmabuf-fence)] new: kernel.kmod_is_loaded.vgem: true [882.633697] [121/155] (141s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-mmap-gtt) [882.736163] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-mmap-gtt [882.740329] Subtest hdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [882.828166] [122/155] (141s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [882.940078] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu [882.944097] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [883.036220] [123/155] (140s left) syncobj_timeline (etime-multi-wait-all-submitted) [883.098154] Starting subtest: etime-multi-wait-all-submitted [883.199430] Subtest etime-multi-wait-all-submitted: SUCCESS (0.102s) [883.275404] [124/155] (140s left) kms_force_connector_basic (force-load-detect) [883.346901] Starting subtest: force-load-detect [883.350738] Subtest force-load-detect: SKIP (0.000s) [883.476827] [125/155] (140s left) gem_mmap_offset (open-flood) [883.537541] Starting subtest: open-flood [905.019687] Subtest open-flood: SUCCESS (21.489s) [905.137996] [126/155] (118s left) kms_psr2_su (frontbuffer-xrgb8888) [905.192640] Subtest frontbuffer-XRGB8888: SKIP (0.000s) [905.248445] [127/155] (118s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-gtt) [905.348080] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-gtt [905.351590] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [905.471116] [128/155] (118s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt) [905.566781] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt [905.570248] Subtest psrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [905.665375] [129/155] (118s left) kms_atomic_transition (modeset-transition-fencing) [905.753284] Starting subtest: modeset-transition-fencing [905.754901] Starting dynamic subtest: 1x-outputs [916.846250] Dynamic subtest 1x-outputs: SUCCESS (11.097s) [916.848766] Subtest modeset-transition-fencing: SUCCESS (11.098s) [917.720575] [130/155] (106s left) gem_exec_capture (pi) [917.780071] Starting subtest: pi [917.782003] Starting dynamic subtest: rcs0 [922.189175] Dynamic subtest rcs0: SUCCESS (4.412s) [922.200456] Starting dynamic subtest: bcs0 [926.263253] Dynamic subtest bcs0: SUCCESS (4.074s) [926.274901] Starting dynamic subtest: vcs0 [930.253549] Dynamic subtest vcs0: SUCCESS (3.990s) [930.268236] Starting dynamic subtest: vcs1 [934.256199] Dynamic subtest vcs1: SUCCESS (3.999s) [934.268688] Starting dynamic subtest: vecs0 [938.268035] Dynamic subtest vecs0: SUCCESS (4.009s) [938.281426] Starting dynamic subtest: ccs0 [942.354750] Dynamic subtest ccs0: SUCCESS (4.084s) [942.356987] Subtest pi: SUCCESS (24.577s) [942.435552] [131/155] ( 81s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf) [942.589998] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf [942.594460] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [942.661999] [132/155] ( 81s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite) [942.767906] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite [942.771932] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [942.855832] [133/155] ( 81s left) kms_vblank (query-idle) [942.946846] Starting subtest: query-idle [942.948735] Starting dynamic subtest: pipe-A-eDP-1 [944.691243] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.744s) [944.708712] Starting dynamic subtest: pipe-D-eDP-1 [947.150400] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.458s) [947.152837] Subtest query-idle: SUCCESS (4.205s) [947.970013] [134/155] ( 76s left) gem_mmap_wc (bad-object) [948.021954] Subtest bad-object: SKIP (0.000s) [948.081457] [135/155] ( 76s left) prime_self_import (basic-with_one_bo_two_files) [948.112958] Starting subtest: basic-with_one_bo_two_files [948.131791] Subtest basic-with_one_bo_two_files: SUCCESS (0.019s) [948.232873] [136/155] ( 76s left) syncobj_wait (invalid-wait-illegal-handle) [948.287753] Starting subtest: invalid-wait-illegal-handle [948.290012] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s) [948.359459] [137/155] ( 76s left) kms_cursor_crc (cursor-alpha-transparent) [948.450533] Starting subtest: cursor-alpha-transparent [948.452820] Starting dynamic subtest: pipe-A-eDP-1 [949.086533] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.633s) [949.097831] Starting dynamic subtest: pipe-D-eDP-1 [950.349682] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.264s) [950.352129] Subtest cursor-alpha-transparent: SUCCESS (1.899s) [951.252291] [138/155] ( 73s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff) [951.355538] Starting subtest: psr-1p-primscrn-cur-indfb-onoff [958.379640] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.029s) [958.495615] [139/155] ( 66s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc) [958.598965] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc [958.603418] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [958.707555] [140/155] ( 66s left) kms_big_fb (x-tiled-32bpp-rotate-90) [958.826980] Starting subtest: x-tiled-32bpp-rotate-90 [958.846108] Subtest x-tiled-32bpp-rotate-90: SKIP (0.019s) [958.961977] [141/155] ( 65s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf) [959.054792] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf [959.057054] Starting dynamic subtest: pipe-A-eDP-1 [959.152737] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s) [959.165022] Starting dynamic subtest: pipe-B-eDP-1 [960.342526] Dynamic subtest pipe-B-eDP-1: SKIP (1.187s) [960.347157] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.289s) [961.532482] [142/155] ( 63s left) gem_readwrite (write-bad-handle) [961.596371] Subtest write-bad-handle: SKIP (0.000s) [961.665132] [143/155] ( 63s left) kms_atomic_interruptible (universal-setplane-cursor) [961.763119] Starting subtest: universal-setplane-cursor [961.765391] Starting dynamic subtest: pipe-A-eDP-1 [969.145848] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.381s) [969.147779] Subtest universal-setplane-cursor: SUCCESS (7.382s) [969.996950] [144/155] ( 54s left) gem_exec_store (basic) [970.062993] Starting subtest: basic [970.158842] Subtest basic: SUCCESS (0.097s) [970.359120] [145/155] ( 54s left) gen9_exec_parse (bb-start-out) [970.422479] Subtest bb-start-out: SKIP (0.000s) [970.507572] [146/155] ( 54s left) api_intel_bb (misplaced-blitter) [970.575951] Starting subtest: misplaced-blitter [970.582094] Subtest misplaced-blitter: SUCCESS (0.007s) [970.711699] [147/155] ( 54s left) perf (buffer-fill) [970.800509] Starting subtest: buffer-fill [970.802930] Starting dynamic subtest: 0-rcs0 [973.063608] Dynamic subtest 0-rcs0: SUCCESS (2.262s) [973.077033] Starting dynamic subtest: 1-vcs0 [977.468984] Dynamic subtest 1-vcs0: SUCCESS (4.404s) [977.471474] Subtest buffer-fill: SUCCESS (6.668s) [977.514783] [148/155] ( 47s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted) [977.573450] Starting subtest: multi-wait-all-for-submit-available-submitted [977.575860] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s) [977.692297] [149/155] ( 47s left) kms_joiner (basic-max-non-joiner) [977.795838] Starting subtest: basic-max-non-joiner [977.800260] Subtest basic-max-non-joiner: SKIP (0.000s) [977.874484] [150/155] ( 47s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [977.979340] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-wc [977.983599] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [978.101295] [151/155] ( 47s left) gem_exec_schedule (semaphore-power) [978.285672] Subtest semaphore-power: SKIP (0.000s) [978.476748] [152/155] ( 46s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-fullscreen) [978.569041] Starting subtest: hdr-2p-scndscrn-spr-indfb-fullscreen [978.573385] Subtest hdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [978.662123] [153/155] ( 46s left) gem_spin_batch (spin-all) [978.723497] Starting subtest: spin-all [978.735067] Subtest spin-all: SUCCESS (0.013s) [980.016348] [154/155] ( 45s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines) [980.577987] Starting subtest: syncobj-stationary-timeline-chain-engines [980.684878] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.107s) [982.051242] [155/155] ( 43s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt) [982.156037] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt [982.160519] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s) [982.259974] Closing watchdogs results: parsing output: 0/ for test: gem_eio results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: gen9_exec_parse results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: kms_plane_alpha_blend results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: kms_frontbuffer_tracking results: parsing output: 7/ for test: kms_ccs results: parsing output: 8/ for test: gem_lmem_swapping results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: gem_exec_reloc results: parsing output: 11/ for test: kms_psr results: parsing output: 12/ for test: kms_chamelium_color results: parsing output: 13/ for test: gem_ctx_engines results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: perf results: parsing output: 16/ for test: api_intel_allocator results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: gem_exec_params results: parsing output: 20/ for test: syncobj_timeline results: parsing output: 21/ for test: gem_ctx_isolation results: parsing output: 22/ for test: kms_content_protection results: parsing output: 23/ for test: kms_cursor_legacy results: parsing output: 24/ for test: kms_frontbuffer_tracking results: parsing output: 25/ for test: kms_plane_multiple results: parsing output: 26/ for test: kms_scaling_modes results: parsing output: 27/ for test: gem_softpin results: parsing output: 28/ for test: kms_frontbuffer_tracking results: parsing output: 29/ for test: kms_frontbuffer_tracking results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: gem_softpin results: parsing output: 33/ for test: kms_plane results: parsing output: 34/ for test: gem_ctx_shared results: parsing output: 35/ for test: kms_cursor_edge_walk results: parsing output: 36/ for test: syncobj_timeline results: parsing output: 37/ for test: i915_hangman results: parsing output: 38/ for test: perf results: parsing output: 39/ for test: kms_draw_crc results: parsing output: 40/ for test: kms_color results: parsing output: 41/ for test: kms_rmfb results: parsing output: 42/ for test: kms_flip results: parsing output: 43/ for test: syncobj_timeline results: parsing output: 44/ for test: kms_frontbuffer_tracking results: parsing output: 45/ for test: gem_userptr_blits results: parsing output: 46/ for test: kms_big_fb results: parsing output: 47/ for test: gem_exec_schedule results: parsing output: 48/ for test: kms_frontbuffer_tracking results: parsing output: 49/ for test: kms_debugfs results: parsing output: 50/ for test: kms_ccs results: parsing output: 51/ for test: i915_pm_rc6_residency results: parsing output: 52/ for test: gem_workarounds results: parsing output: 53/ for test: perf results: parsing output: 54/ for test: gem_eio results: parsing output: 55/ for test: syncobj_basic results: parsing output: 56/ for test: kms_flip results: parsing output: 57/ for test: gem_exec_balancer results: parsing output: 58/ for test: gem_render_tiled_blits results: parsing output: 59/ for test: kms_rotation_crc results: parsing output: 60/ for test: kms_frontbuffer_tracking results: parsing output: 61/ for test: kms_frontbuffer_tracking results: parsing output: 62/ for test: kms_frontbuffer_tracking results: parsing output: 63/ for test: kms_big_fb results: parsing output: 64/ for test: perf_pmu results: parsing output: 65/ for test: kms_rotation_crc results: parsing output: 66/ for test: kms_multipipe_modeset results: parsing output: 67/ for test: kms_psr results: parsing output: 68/ for test: kms_cursor_legacy results: parsing output: 69/ for test: kms_atomic_transition results: parsing output: 70/ for test: gem_vm_create results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: gem_mmap_gtt results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: gem_bad_reloc results: parsing output: 75/ for test: gem_exec_reloc results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: kms_ccs results: parsing output: 78/ for test: perf_pmu results: parsing output: 79/ for test: gem_pxp results: parsing output: 80/ for test: gem_exec_params results: parsing output: 81/ for test: kms_flip_scaled_crc results: parsing output: 82/ for test: kms_psr results: parsing output: 83/ for test: prime_busy results: parsing output: 84/ for test: kms_properties results: parsing output: 85/ for test: sysfs_timeslice_duration results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: kms_frontbuffer_tracking results: parsing output: 88/ for test: kms_plane_scaling results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: gem_ctx_persistence results: parsing output: 91/ for test: kms_vrr results: parsing output: 92/ for test: kms_busy results: parsing output: 93/ for test: kms_big_fb results: parsing output: 94/ for test: gem_busy results: parsing output: 95/ for test: kms_frontbuffer_tracking results: parsing output: 96/ for test: kms_prop_blob results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: i915_suspend results: parsing output: 99/ for test: kms_ccs results: parsing output: 100/ for test: gem_exec_schedule results: parsing output: 101/ for test: kms_frontbuffer_tracking results: parsing output: 102/ for test: kms_big_fb results: parsing output: 103/ for test: kms_color results: parsing output: 104/ for test: kms_cursor_crc results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: kms_frontbuffer_tracking results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: kms_plane results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: kms_flip_scaled_crc results: parsing output: 111/ for test: kms_flip results: parsing output: 112/ for test: kms_psr results: parsing output: 113/ for test: core_setmaster results: parsing output: 114/ for test: kms_frontbuffer_tracking results: parsing output: 115/ for test: kms_big_fb results: parsing output: 116/ for test: kms_chamelium_frames results: parsing output: 117/ for test: kms_async_flips results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: vgem_basic results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: syncobj_timeline results: parsing output: 123/ for test: kms_force_connector_basic results: parsing output: 124/ for test: gem_mmap_offset results: parsing output: 125/ for test: kms_psr2_su results: parsing output: 126/ for test: kms_frontbuffer_tracking results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: kms_atomic_transition results: parsing output: 129/ for test: gem_exec_capture results: parsing output: 130/ for test: kms_psr2_sf results: parsing output: 131/ for test: kms_frontbuffer_tracking results: parsing output: 132/ for test: kms_vblank results: parsing output: 133/ for test: gem_mmap_wc results: parsing output: 134/ for test: prime_self_import results: parsing output: 135/ for test: syncobj_wait results: parsing output: 136/ for test: kms_cursor_crc results: parsing output: 137/ for test: kms_frontbuffer_tracking results: parsing output: 138/ for test: kms_frontbuffer_tracking results: parsing output: 139/ for test: kms_big_fb results: parsing output: 140/ for test: kms_psr2_sf results: parsing output: 141/ for test: gem_readwrite results: parsing output: 142/ for test: kms_atomic_interruptible results: parsing output: 143/ for test: gem_exec_store results: parsing output: 144/ for test: gen9_exec_parse results: parsing output: 145/ for test: api_intel_bb results: parsing output: 146/ for test: perf results: parsing output: 147/ for test: syncobj_timeline results: parsing output: 148/ for test: kms_joiner results: parsing output: 149/ for test: kms_frontbuffer_tracking results: parsing output: 150/ for test: gem_exec_schedule results: parsing output: 151/ for test: kms_frontbuffer_tracking results: parsing output: 152/ for test: gem_spin_batch results: parsing output: 153/ for test: gem_exec_fence results: parsing output: 154/ for test: kms_frontbuffer_tracking Done.