[45.753764] Initializing watchdogs [45.753824] /dev/watchdog0 [45.770931] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics] [45.776925] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [45.779479] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [45.781433] [001/156] (960s left) gem_exec_schedule (fairslice-all) [45.832467] Starting subtest: fairslice-all [47.870792] Subtest fairslice-all: SUCCESS (2.019s) [48.187551] [002/156] (958s left) gem_tiled_wc [50.538777] [003/156] (955s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-mmap-cpu) [50.637372] Starting subtest: fbchdr-rgb565-draw-mmap-cpu [50.638743] Subtest fbchdr-rgb565-draw-mmap-cpu: SKIP (0.000s) [50.725440] [004/156] (955s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-4) [50.820175] Starting subtest: fbcpsrhdr-tiling-4 [50.821572] Subtest fbcpsrhdr-tiling-4: SKIP (0.000s) [50.910938] [005/156] (955s left) prime_self_import (basic-llseek-size) [50.943432] Starting subtest: basic-llseek-size [50.946421] Subtest basic-llseek-size: SUCCESS (0.003s) [51.042352] [006/156] (955s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc) [51.135296] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc [52.224828] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (1.080s) [52.353786] [007/156] (954s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [52.445508] Starting subtest: basic-flip-after-cursor-varying-size [52.998946] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.549s) [53.153246] [008/156] (953s left) kms_dirtyfb (default-dirtyfb-ioctl) [53.245742] Starting subtest: default-dirtyfb-ioctl [53.246467] Starting dynamic subtest: A-HDMI-A-1 [54.454221] Dynamic subtest A-HDMI-A-1: SUCCESS (1.199s) [54.454997] Subtest default-dirtyfb-ioctl: SUCCESS (1.200s) [54.571792] [009/156] (952s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt) [54.677342] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt [54.678827] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [54.757352] [010/156] (951s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted) [54.792425] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted [54.793153] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.001s) [54.863347] [011/156] (951s left) api_intel_allocator (fork-simple-stress) [54.898017] Starting subtest: fork-simple-stress [60.366121] Subtest fork-simple-stress: SUCCESS (5.410s) [60.453993] [012/156] (946s left) gem_exec_flush (basic-uc-set-default) [60.496447] Starting subtest: basic-uc-set-default [65.939156] Subtest basic-uc-set-default: SUCCESS (5.431s) [66.139131] [013/156] (940s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area) [66.230776] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (0.000s) [66.273631] [014/156] (940s left) kms_psr (psr2-cursor-plane-move) [66.362127] Subtest psr2-cursor-plane-move: SKIP (0.000s) [66.398948] [015/156] (940s left) syncobj_timeline (wait-for-submit-complex) [66.432998] Starting subtest: wait-for-submit-complex [66.496328] Subtest wait-for-submit-complex: SUCCESS (0.062s) [66.563464] [016/156] (940s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-move) [66.655432] Starting subtest: hdr-2p-scndscrn-cur-indfb-move [66.656864] Subtest hdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [66.813147] [017/156] (940s left) kms_pm_backlight (fade) [66.906275] Subtest fade: SKIP (0.000s) [66.969800] [018/156] (940s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt) [67.280919] Starting subtest: psr-2p-primscrn-indfb-msflip-blt [67.283014] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [67.548646] [019/156] (939s left) gem_caching (reads) [67.688556] Starting subtest: reads [69.572671] Subtest reads: SUCCESS (1.882s) [69.676082] [020/156] (937s left) kms_flip_event_leak (basic) [69.768734] Starting subtest: basic [69.769485] Starting dynamic subtest: pipe-A-HDMI-A-1 [69.967195] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.198s) [69.974934] Starting dynamic subtest: pipe-B-HDMI-A-1 [70.128155] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.159s) [70.135781] Starting dynamic subtest: pipe-C-HDMI-A-1 [70.291276] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.162s) [70.298219] Starting dynamic subtest: pipe-D-HDMI-A-1 [70.455467] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.164s) [70.456242] Subtest basic: SUCCESS (0.687s) [70.631238] [021/156] (936s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs) [70.722625] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs [70.723382] Starting dynamic subtest: pipe-A-HDMI-A-1 [70.729809] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s) [70.738447] Starting dynamic subtest: pipe-B-HDMI-A-1 [70.744804] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s) [70.753853] Starting dynamic subtest: pipe-C-HDMI-A-1 [70.760116] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.000s) [70.768029] Starting dynamic subtest: pipe-D-HDMI-A-1 [70.774503] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s) [70.775289] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SUCCESS (0.005s) [70.992569] [022/156] (936s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf) [71.082735] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s) [71.119693] [023/156] (936s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-move) [71.211471] Starting subtest: psrhdr-2p-primscrn-cur-indfb-move [71.212925] Subtest psrhdr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [71.309685] [024/156] (935s left) kms_joiner (invalid-modeset-ultra-joiner) [71.399750] Starting subtest: invalid-modeset-ultra-joiner [71.401151] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s) [71.448740] [025/156] (935s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-move) [71.540096] Starting subtest: hdr-1p-primscrn-cur-indfb-move [71.541450] Subtest hdr-1p-primscrn-cur-indfb-move: SKIP (0.000s) [71.631846] [026/156] (935s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff) [71.726334] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff [73.102387] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (1.376s) [73.250634] [027/156] (934s left) kms_frontbuffer_tracking (psr-slowdraw) [73.345318] Starting subtest: psr-slowdraw [73.346747] Subtest psr-slowdraw: SKIP (0.000s) [73.443045] [028/156] (933s left) syncobj_timeline (invalid-single-wait-unsubmitted) [73.477063] Starting subtest: invalid-single-wait-unsubmitted [73.477791] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s) [73.553174] [029/156] (933s left) perf (polling) [73.640111] Starting subtest: polling [73.640824] Starting dynamic subtest: 0-rcs0 [83.660831] Dynamic subtest 0-rcs0: SUCCESS (10.018s) [83.661687] Subtest polling: SUCCESS (10.018s) [83.694975] [030/156] (923s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible) [83.797036] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible [83.807131] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.009s) [83.863736] [031/156] (923s left) kms_cursor_legacy (cursora-vs-flipa-varying-size) [83.952341] Starting subtest: cursorA-vs-flipA-varying-size [94.823336] Subtest cursorA-vs-flipA-varying-size: SUCCESS (10.863s) [94.962758] [032/156] (912s left) gem_lmem_swapping (heavy-verify-random) [95.006475] Subtest heavy-verify-random: SKIP (0.000s) [95.047464] [033/156] (912s left) prime_vgem (wait) [95.127036] Starting subtest: wait [95.127782] Starting dynamic subtest: rcs0 [95.152953] Dynamic subtest rcs0: SUCCESS (0.026s) [95.160050] Starting dynamic subtest: bcs0 [95.169807] Dynamic subtest bcs0: SUCCESS (0.016s) [95.176981] Starting dynamic subtest: vcs0 [95.191650] Dynamic subtest vcs0: SUCCESS (0.021s) [95.201339] Starting dynamic subtest: vcs1 [95.211420] Dynamic subtest vcs1: SUCCESS (0.019s) [95.220895] Starting dynamic subtest: vecs0 [95.229307] Dynamic subtest vecs0: SUCCESS (0.017s) [95.230229] Subtest wait: SUCCESS (0.104s) [95.331856] [FACT prime_vgem (wait)] new: kernel.kmod_is_loaded.vgem: true [95.333860] [034/156] (912s left) kms_plane_alpha_blend (alpha-basic) [95.425514] Starting subtest: alpha-basic [95.493073] Starting dynamic subtest: pipe-A-HDMI-A-1 [96.818573] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.325s) [96.851342] Starting dynamic subtest: pipe-D-HDMI-A-1 [98.383086] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.539s) [98.383860] Subtest alpha-basic: SUCCESS (2.958s) [98.565865] [035/156] (909s left) i915_drm_fdinfo (context-close-stress) [98.609881] Starting subtest: context-close-stress [109.390427] Subtest context-close-stress: SUCCESS (10.746s) [109.424544] [036/156] (898s left) gem_eio (throttle) [109.469041] Starting subtest: throttle [109.503306] Subtest throttle: SUCCESS (0.033s) [109.624462] [037/156] (898s left) perf_pmu (enable-race) [109.661107] Starting subtest: enable-race [109.661877] Starting dynamic subtest: rcs0 [122.251680] Dynamic subtest rcs0: SUCCESS (12.567s) [122.267641] Starting dynamic subtest: bcs0 [134.824393] Dynamic subtest bcs0: SUCCESS (12.568s) [134.840786] Starting dynamic subtest: vcs0 [147.394632] Dynamic subtest vcs0: SUCCESS (12.573s) [147.410634] Starting dynamic subtest: vcs1 [159.968636] Dynamic subtest vcs1: SUCCESS (12.570s) [159.985631] Starting dynamic subtest: vecs0 [172.512965] Dynamic subtest vecs0: SUCCESS (12.571s) [172.513721] Subtest enable-race: SUCCESS (62.852s) [172.596713] [038/156] (835s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt) [172.691862] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt [172.693286] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [172.766653] [039/156] (835s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa [172.802688] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled [172.911602] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.108s) [172.980973] [040/156] (834s left) gem_eio (wait-wedge-10ms) [173.025130] Starting subtest: wait-wedge-10ms [173.284274] Subtest wait-wedge-10ms: SUCCESS (0.259s) [173.415924] [041/156] (834s left) kms_big_fb (yf-tiled-8bpp-rotate-90) [173.516487] Starting subtest: yf-tiled-8bpp-rotate-90 [173.517916] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s) [173.620806] [042/156] (834s left) gem_softpin (allocator-basic-reserve) [173.659714] Starting subtest: allocator-basic-reserve [173.740080] Subtest allocator-basic-reserve: SUCCESS (0.081s) [173.862469] [043/156] (834s left) gem_exec_balancer (bonded-pair) [173.904595] Starting subtest: bonded-pair [206.280776] Subtest bonded-pair: SUCCESS (32.368s) [206.464735] [044/156] (801s left) kms_chamelium_audio (dp-audio) [206.610564] Subtest dp-audio: SKIP (0.000s) [206.727306] [045/156] (801s left) kms_cursor_crc (cursor-rapid-movement-256x85) [206.825862] Starting subtest: cursor-rapid-movement-256x85 [206.830298] Starting dynamic subtest: pipe-A-HDMI-A-1 [207.065747] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.235s) [207.100116] Starting dynamic subtest: pipe-D-HDMI-A-1 [207.323740] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.232s) [207.324447] Subtest cursor-rapid-movement-256x85: SUCCESS (0.499s) [207.504903] [046/156] (800s left) i915_suspend (basic-s2idle-without-i915) [207.541176] Starting subtest: basic-s2idle-without-i915 [225.489040] Subtest basic-s2idle-without-i915: SUCCESS (3.143s) [233.605537] [047/156] (782s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted) [233.651194] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted [233.651906] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s) [233.715001] [048/156] (782s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-render) [233.810047] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-render [233.811460] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s) [233.915807] [049/156] (782s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt) [234.009004] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt [234.010429] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [234.113463] [050/156] (782s left) gem_mmap (pf-nonblock) [234.148796] Starting subtest: pf-nonblock [234.153750] Subtest pf-nonblock: SUCCESS (0.006s) [234.269660] [051/156] (782s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [234.363994] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu [234.365428] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [234.466318] [052/156] (781s left) gem_basic (multigpu-create-close) [234.501819] Starting subtest: multigpu-create-close [234.503299] Subtest multigpu-create-close: SKIP (0.000s) [234.586271] [053/156] (781s left) kms_frontbuffer_tracking (fbchdr-2p-shrfb-fliptrack-mmap-gtt) [234.682095] Starting subtest: fbchdr-2p-shrfb-fliptrack-mmap-gtt [234.683612] Subtest fbchdr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [234.791256] [054/156] (781s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move) [234.887004] Starting subtest: fbc-1p-primscrn-spr-indfb-move [236.464899] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (1.556s) [236.611078] [055/156] (779s left) gem_exec_params (no-vebox) [236.652866] Starting subtest: no-vebox [236.653705] Subtest no-vebox: SUCCESS (0.001s) [236.787387] [056/156] (779s left) gem_exec_schedule (smoketest-all) [236.835199] Starting subtest: smoketest-all [269.208068] Subtest smoketest-all: SUCCESS (32.262s) [269.541547] [057/156] (747s left) kms_properties (connector-properties-legacy) [269.631459] Starting subtest: connector-properties-legacy [269.632576] Starting dynamic subtest: pipe-A-HDMI-A-1 [270.193030] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.561s) [270.201916] Starting dynamic subtest: pipe-None-DP-1 [270.203356] Dynamic subtest pipe-None-DP-1: SUCCESS (0.003s) [270.211079] Starting dynamic subtest: pipe-None-DP-2 [270.212499] Dynamic subtest pipe-None-DP-2: SUCCESS (0.003s) [270.220134] Starting dynamic subtest: pipe-None-DP-3 [270.221510] Dynamic subtest pipe-None-DP-3: SUCCESS (0.003s) [270.228868] Starting dynamic subtest: pipe-None-DP-4 [270.230306] Dynamic subtest pipe-None-DP-4: SUCCESS (0.002s) [270.232044] Subtest connector-properties-legacy: SUCCESS (0.580s) [270.367252] [058/156] (746s left) gem_userptr_blits (set-cache-level) [270.410976] Starting subtest: set-cache-level [270.411693] Subtest set-cache-level: SUCCESS (0.000s) [270.529728] [059/156] (746s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling) [270.618406] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling [270.620104] Starting dynamic subtest: pipe-A-valid-mode [271.492621] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.873s) [271.493400] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (0.874s) [271.642013] [060/156] (745s left) gem_set_tiling_vs_blt (tiled-to-tiled) [271.684514] Starting subtest: tiled-to-tiled [271.814928] Subtest tiled-to-tiled: SUCCESS (0.124s) [271.926611] [061/156] (744s left) kms_color_pipeline (plane-lut1d-ctm3x4) [272.016341] Starting subtest: plane-lut1d-ctm3x4 [272.102136] Starting dynamic subtest: pipe-A-plane-0 [272.201447] Dynamic subtest pipe-A-plane-0: SUCCESS (0.099s) [272.217495] Starting dynamic subtest: pipe-A-plane-1 [272.292921] Dynamic subtest pipe-A-plane-1: SUCCESS (0.089s) [272.305931] Starting dynamic subtest: pipe-A-plane-2 [272.393082] Dynamic subtest pipe-A-plane-2: SUCCESS (0.098s) [272.608195] Starting dynamic subtest: pipe-B-plane-0 [272.685969] Dynamic subtest pipe-B-plane-0: SUCCESS (0.083s) [272.697983] Starting dynamic subtest: pipe-B-plane-1 [272.778186] Dynamic subtest pipe-B-plane-1: SUCCESS (0.090s) [272.790511] Starting dynamic subtest: pipe-B-plane-2 [272.870238] Dynamic subtest pipe-B-plane-2: SUCCESS (0.089s) [273.091865] Starting dynamic subtest: pipe-C-plane-0 [273.176760] Dynamic subtest pipe-C-plane-0: SUCCESS (0.092s) [273.188786] Starting dynamic subtest: pipe-C-plane-1 [273.276831] Dynamic subtest pipe-C-plane-1: SUCCESS (0.098s) [273.290179] Starting dynamic subtest: pipe-C-plane-2 [273.376758] Dynamic subtest pipe-C-plane-2: SUCCESS (0.098s) [273.611766] Starting dynamic subtest: pipe-D-plane-0 [273.712658] Dynamic subtest pipe-D-plane-0: SUCCESS (0.108s) [273.721353] Starting dynamic subtest: pipe-D-plane-1 [273.804653] Dynamic subtest pipe-D-plane-1: SUCCESS (0.091s) [273.814857] Starting dynamic subtest: pipe-D-plane-2 [273.904595] Dynamic subtest pipe-D-plane-2: SUCCESS (0.098s) [273.953689] Subtest plane-lut1d-ctm3x4: SUCCESS (1.937s) [274.077496] [062/156] (742s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt) [274.176304] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt [275.566112] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (1.391s) [275.697880] [063/156] (741s left) gem_userptr_blits (sync-unmap-after-close) [275.743515] Starting subtest: sync-unmap-after-close [275.760771] Subtest sync-unmap-after-close: SUCCESS (0.017s) [275.878529] [064/156] (741s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff) [275.975844] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff [277.366318] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (1.390s) [277.512573] [065/156] (739s left) gem_exec_schedule (thriceslice) [277.556731] Starting subtest: thriceslice [277.557456] Starting dynamic subtest: rcs0 [277.562240] Dynamic subtest rcs0: SUCCESS (0.005s) [277.572940] Starting dynamic subtest: bcs0 [277.573687] Dynamic subtest bcs0: SUCCESS (0.005s) [277.582761] Starting dynamic subtest: vcs0 [277.583562] Dynamic subtest vcs0: SUCCESS (0.004s) [277.591960] Starting dynamic subtest: vcs1 [277.592664] Dynamic subtest vcs1: SUCCESS (0.004s) [277.599980] Starting dynamic subtest: vecs0 [277.600694] Dynamic subtest vecs0: SUCCESS (0.005s) [277.601386] Subtest thriceslice: SUCCESS (0.027s) [277.888103] [066/156] (739s left) gem_render_copy_redux (interruptible) [277.926514] Starting subtest: interruptible [278.290082] Subtest interruptible: SUCCESS (0.355s) [278.383705] [067/156] (738s left) i915_pm_rps (fence-order) [278.423734] Starting subtest: fence-order [279.959415] Subtest fence-order: SUCCESS (1.526s) [280.058319] [068/156] (737s left) kms_content_protection (legacy-hdcp14) [280.152662] Starting subtest: legacy-hdcp14 [280.158771] Subtest legacy-hdcp14: SKIP (0.004s) [280.255312] [069/156] (736s left) gem_tiled_blits (basic) [280.648551] Starting subtest: basic [280.664722] Subtest basic: SUCCESS (0.020s) [280.808944] [070/156] (736s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-shrfb-plflip-blt) [280.958022] Starting subtest: psrhdr-2p-primscrn-shrfb-plflip-blt [280.959493] Subtest psrhdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [281.056088] [071/156] (736s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu) [281.147768] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu [281.149312] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [281.238211] [072/156] (736s left) kms_cursor_crc (cursor-offscreen-64x21) [281.339892] Starting subtest: cursor-offscreen-64x21 [281.348181] Starting dynamic subtest: pipe-A-HDMI-A-1 [282.617176] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.269s) [282.662393] Starting dynamic subtest: pipe-D-HDMI-A-1 [283.891934] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.236s) [283.892741] Subtest cursor-offscreen-64x21: SUCCESS (2.551s) [284.041603] [073/156] (733s left) kms_psr (fbc-psr-sprite-plane-onoff) [284.138822] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.000s) [284.191210] [074/156] (733s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20) [284.282273] Starting subtest: planes-downscale-factor-0-5-upscale-20x20 [284.283064] Starting dynamic subtest: pipe-A [284.421281] Dynamic subtest pipe-A: SUCCESS (0.139s) [284.434135] Starting dynamic subtest: pipe-B [284.571313] Dynamic subtest pipe-B: SUCCESS (0.149s) [284.583301] Starting dynamic subtest: pipe-C [284.706357] Dynamic subtest pipe-C: SUCCESS (0.134s) [284.716206] Starting dynamic subtest: pipe-D [284.857110] Dynamic subtest pipe-D: SUCCESS (0.149s) [284.857893] Subtest planes-downscale-factor-0-5-upscale-20x20: SUCCESS (0.575s) [285.052556] [075/156] (732s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs) [285.143956] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs [285.146254] Starting dynamic subtest: pipe-A-HDMI-A-1 [285.152793] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s) [285.164876] Starting dynamic subtest: pipe-B-HDMI-A-1 [285.171568] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s) [285.182221] Starting dynamic subtest: pipe-C-HDMI-A-1 [285.188697] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s) [285.198975] Starting dynamic subtest: pipe-D-HDMI-A-1 [285.205318] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s) [285.206116] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SUCCESS (0.009s) [285.398549] [076/156] (732s left) core_setmaster (master-drop-set-shared-fd) [285.478560] Starting subtest: master-drop-set-shared-fd [285.493876] Subtest master-drop-set-shared-fd: SUCCESS (0.016s) [285.532555] [077/156] (731s left) syncobj_wait (wait-all-interrupted) [285.568890] Starting subtest: wait-all-interrupted [285.675406] Subtest wait-all-interrupted: SUCCESS (0.106s) [285.760759] [078/156] (731s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier) [285.853042] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier [285.854562] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s) [285.913830] [079/156] (731s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-render) [286.005811] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-render [286.007278] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [286.099959] [080/156] (731s left) perf_pmu (rc6) [286.138968] Starting subtest: rc6 [286.139718] Starting dynamic subtest: gt0 [292.511943] Dynamic subtest gt0: SUCCESS (6.337s) [292.521675] Starting dynamic subtest: runtime-pm-gt0 [299.990704] Dynamic subtest runtime-pm-gt0: SUCCESS (7.499s) [300.002367] Starting dynamic subtest: runtime-pm-long-gt0 [312.432294] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.436s) [312.444361] Starting dynamic subtest: other-idle-gt0 [312.445907] Dynamic subtest other-idle-gt0: SKIP (0.000s) [312.446664] Subtest rc6: SUCCESS (26.279s) [312.814078] [081/156] (704s left) kms_flip (2x-flip-vs-panning-vs-hang) [312.904789] Starting subtest: 2x-flip-vs-panning-vs-hang [312.907754] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.002s) [312.957856] [082/156] (704s left) gen9_exec_parse (allowed-single) [312.997680] Subtest allowed-single: SKIP (0.000s) [313.039815] [083/156] (704s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite) [313.132254] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite [313.133679] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [313.204389] [084/156] (704s left) kms_feature_discovery (psr2) [313.293227] Starting subtest: psr2 [313.294673] Subtest psr2: SKIP (0.000s) [313.334663] [085/156] (704s left) kms_cursor_legacy (cursorb-vs-flipb-legacy) [313.423611] Starting subtest: cursorB-vs-flipB-legacy [313.426057] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s) [313.468546] [086/156] (704s left) kms_frontbuffer_tracking (hdr-rgb565-draw-mmap-cpu) [313.564226] Starting subtest: hdr-rgb565-draw-mmap-cpu [313.565641] Subtest hdr-rgb565-draw-mmap-cpu: SKIP (0.000s) [313.631554] [087/156] (704s left) gem_exec_flush (basic-uc-rw-default) [313.674326] Starting subtest: basic-uc-rw-default [319.103352] Subtest basic-uc-rw-default: SUCCESS (5.427s) [319.302473] [088/156] (698s left) gem_cs_tlb (engines) [319.339731] Starting subtest: engines [319.340489] Starting dynamic subtest: rcs0 [321.500411] Dynamic subtest rcs0: SUCCESS (2.150s) [321.509057] Starting dynamic subtest: bcs0 [323.652622] Dynamic subtest bcs0: SUCCESS (2.150s) [323.661336] Starting dynamic subtest: vcs0 [325.804216] Dynamic subtest vcs0: SUCCESS (2.150s) [325.813094] Starting dynamic subtest: vcs1 [327.955550] Dynamic subtest vcs1: SUCCESS (2.150s) [327.964756] Starting dynamic subtest: vecs0 [330.105473] Dynamic subtest vecs0: SUCCESS (2.149s) [330.106207] Subtest engines: SUCCESS (10.755s) [330.191200] [089/156] (687s left) gem_exec_fence (syncobj-timeline-invalid-wait) [330.651568] Starting subtest: syncobj-timeline-invalid-wait [330.652815] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.003s) [330.810962] [090/156] (687s left) i915_module_load (reload-no-display) [330.851596] Starting subtest: reload-no-display [333.306470] Subtest reload-no-display: SUCCESS (2.455s) [333.338688] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [333.339475] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true [333.343245] [091/156] (684s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [334.495587] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [334.497047] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [334.558447] [FACT kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [334.559829] [FACT kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)] new: kernel.kmod_is_loaded.i915: true [334.562164] [092/156] (683s left) kms_cursor_legacy (forked-bo) [334.651574] Starting subtest: forked-bo [334.652376] Starting dynamic subtest: pipe-A [340.073306] Dynamic subtest pipe-A: SUCCESS (5.413s) [340.082718] Starting dynamic subtest: pipe-B [345.528311] Dynamic subtest pipe-B: SUCCESS (5.429s) [345.540048] Starting dynamic subtest: pipe-C [350.966029] Dynamic subtest pipe-C: SUCCESS (5.436s) [350.974902] Starting dynamic subtest: pipe-D [356.414628] Dynamic subtest pipe-D: SUCCESS (5.446s) [356.424116] Starting dynamic subtest: all-pipes [361.853708] Dynamic subtest all-pipes: SUCCESS (5.436s) [361.854829] Subtest forked-bo: SUCCESS (27.169s) [361.894174] [093/156] (656s left) perf_pmu (busy-hang) [361.934997] Starting subtest: busy-hang [361.935749] Starting dynamic subtest: rcs0 [362.990074] Dynamic subtest rcs0: SUCCESS (1.052s) [363.002326] Starting dynamic subtest: bcs0 [364.038631] Dynamic subtest bcs0: SUCCESS (1.044s) [364.048952] Starting dynamic subtest: vcs0 [365.075811] Dynamic subtest vcs0: SUCCESS (1.034s) [365.085254] Starting dynamic subtest: vcs1 [366.121117] Dynamic subtest vcs1: SUCCESS (1.045s) [366.132789] Starting dynamic subtest: vecs0 [367.167088] Dynamic subtest vecs0: SUCCESS (1.041s) [367.167878] Subtest busy-hang: SUCCESS (5.231s) [367.223463] [094/156] (651s left) kms_hdr (bpc-switch-suspend) [367.315670] Starting subtest: bpc-switch-suspend [367.316717] Starting dynamic subtest: pipe-A-HDMI-A-1-XRGB2101010 [367.318108] Dynamic subtest pipe-A-HDMI-A-1-XRGB2101010: SKIP (0.000s) [367.326873] Starting dynamic subtest: pipe-A-HDMI-A-1-XRGB16161616F [367.328470] Dynamic subtest pipe-A-HDMI-A-1-XRGB16161616F: SKIP (0.000s) [367.329955] Subtest bpc-switch-suspend: SKIP (0.005s) [367.363896] [095/156] (650s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs) [367.451825] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs [367.453757] Starting dynamic subtest: pipe-A-HDMI-A-1 [367.460824] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s) [367.469371] Starting dynamic subtest: pipe-B-HDMI-A-1 [367.476326] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s) [367.484686] Starting dynamic subtest: pipe-C-HDMI-A-1 [367.491686] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s) [367.500765] Starting dynamic subtest: pipe-D-HDMI-A-1 [367.507706] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s) [367.509067] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SKIP (0.009s) [367.712008] [096/156] (650s left) syncobj_wait (invalid-multi-wait-unsubmitted) [367.748449] Starting subtest: invalid-multi-wait-unsubmitted [367.749174] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [367.789816] [097/156] (650s left) gem_exec_balancer (smoke) [367.832423] Starting subtest: smoke [390.908006] Subtest smoke: SUCCESS (23.038s) [391.444441] [098/156] (626s left) gem_exec_schedule (preempt-engines) [391.491199] Starting subtest: preempt-engines [391.491938] Starting dynamic subtest: rcs0 [391.575729] Dynamic subtest rcs0: SUCCESS (0.084s) [391.588578] Starting dynamic subtest: bcs0 [391.665736] Dynamic subtest bcs0: SUCCESS (0.088s) [391.678947] Starting dynamic subtest: vcs0 [391.750058] Dynamic subtest vcs0: SUCCESS (0.083s) [391.761866] Starting dynamic subtest: vcs1 [391.840715] Dynamic subtest vcs1: SUCCESS (0.089s) [391.851559] Starting dynamic subtest: vecs0 [391.928241] Dynamic subtest vecs0: SUCCESS (0.086s) [391.928985] Subtest preempt-engines: SUCCESS (0.437s) [392.226392] [099/156] (626s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt) [392.322163] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt [392.323571] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [392.386832] [100/156] (626s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs) [392.429223] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs [392.429974] Starting dynamic subtest: smem [392.556044] Dynamic subtest smem: SUCCESS (0.117s) [392.556825] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SUCCESS (0.119s) [392.717792] [101/156] (625s left) gem_ctx_persistence (processes) [392.757021] Starting subtest: processes [393.198261] Subtest processes: SUCCESS (0.441s) [393.264733] [102/156] (625s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-mmap-wc) [393.358327] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-mmap-wc [393.359774] Subtest fbchdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [393.427872] [103/156] (625s left) kms_chamelium_frames (dp-crc-fast) [393.573280] Subtest dp-crc-fast: SKIP (0.000s) [393.666850] [104/156] (624s left) kms_psr (fbc-pr-sprite-mmap-gtt) [393.756408] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s) [393.799284] [105/156] (624s left) gem_mmap_offset (bad-flags) [393.836024] Starting subtest: bad-flags [393.836825] Subtest bad-flags: SUCCESS (0.000s) [393.922436] [106/156] (624s left) kms_getfb (getfb-handle-valid) [394.012633] Starting subtest: getfb-handle-valid [394.013391] Subtest getfb-handle-valid: SUCCESS (0.000s) [394.079544] [107/156] (624s left) gem_mmap_gtt (cpuset-big-copy-xy) [394.113854] Starting subtest: cpuset-big-copy-XY [414.591264] Subtest cpuset-big-copy-XY: SUCCESS (20.472s) [414.668355] [108/156] (604s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu) [414.813725] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu [414.815283] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [414.877348] [109/156] (603s left) core_getclient (basic) [414.912693] Starting subtest: basic [414.913599] Subtest basic: SUCCESS (0.000s) [414.951022] [110/156] (603s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [415.044763] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu [415.046243] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [415.118816] [111/156] (603s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt) [415.213619] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt [415.215049] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [415.277404] [112/156] (603s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu) [415.371260] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu [415.372678] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [415.448675] [113/156] (603s left) kms_sequence (queue-busy) [415.538657] Starting subtest: queue-busy [415.539383] Starting dynamic subtest: pipe-A-HDMI-A-1 [416.849495] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.309s) [416.861951] Starting dynamic subtest: pipe-B-HDMI-A-1 [418.122389] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.271s) [418.133133] Starting dynamic subtest: pipe-C-HDMI-A-1 [419.392384] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.268s) [419.402802] Starting dynamic subtest: pipe-D-HDMI-A-1 [420.666798] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.272s) [420.667588] Subtest queue-busy: SUCCESS (5.128s) [420.765168] [114/156] (598s left) gem_eio (in-flight-internal-10ms) [420.812665] Starting subtest: in-flight-internal-10ms [421.081914] Subtest in-flight-internal-10ms: SUCCESS (0.270s) [421.189682] [115/156] (597s left) kms_flip (2x-flip-vs-expired-vblank-interruptible) [421.282921] Starting subtest: 2x-flip-vs-expired-vblank-interruptible [421.292933] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.009s) [421.338905] [116/156] (597s left) kms_async_flips (crc) [421.428067] Starting subtest: crc [421.552540] Starting dynamic subtest: pipe-A-HDMI-A-1 [423.700871] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.139s) [423.837110] Starting dynamic subtest: pipe-B-HDMI-A-1 [425.961340] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.124s) [426.077442] Starting dynamic subtest: pipe-C-HDMI-A-1 [428.203211] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.125s) [428.320846] Starting dynamic subtest: pipe-D-HDMI-A-1 [430.452308] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.133s) [430.453225] Subtest crc: SUCCESS (9.014s) [430.651706] [117/156] (588s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [430.748103] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [430.749641] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [430.821144] [118/156] (588s left) kms_big_fb (x-tiled-32bpp-rotate-180) [430.920940] Starting subtest: x-tiled-32bpp-rotate-180 [432.324571] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.403s) [432.452058] [119/156] (586s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [432.545938] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt [432.547370] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [432.614415] [120/156] (586s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip) [432.712438] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip [432.713864] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s) [432.783721] [121/156] (586s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-pwrite) [432.878310] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-pwrite [432.879790] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [432.949969] [122/156] (586s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-blt) [433.042367] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-blt [433.043827] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [433.126876] [123/156] (586s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc) [433.219520] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc [433.220959] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [433.278367] [124/156] (586s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [433.371736] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt [433.373219] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [433.450908] [125/156] (586s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite) [433.545279] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite [433.546721] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [433.601837] [126/156] (585s left) gem_pxp (protected-encrypted-src-copy-not-readible) [433.705513] Starting subtest: protected-encrypted-src-copy-not-readible [433.786629] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.082s) [433.869201] [127/156] (585s left) kms_psr (psr-cursor-render) [433.959517] Subtest psr-cursor-render: SKIP (0.000s) [434.000673] [128/156] (585s left) kms_psr (fbc-psr2-primary-render) [434.088603] Subtest fbc-psr2-primary-render: SKIP (0.000s) [434.133320] [129/156] (585s left) gem_ctx_persistence (engines-hostile-preempt) [434.173023] Starting subtest: engines-hostile-preempt [434.173822] Starting dynamic subtest: rcs0 [434.268469] Dynamic subtest rcs0: SUCCESS (0.094s) [434.291023] Starting dynamic subtest: bcs0 [434.363385] Dynamic subtest bcs0: SUCCESS (0.092s) [434.379284] Starting dynamic subtest: vcs0 [434.461381] Dynamic subtest vcs0: SUCCESS (0.095s) [434.483480] Starting dynamic subtest: vcs1 [434.564390] Dynamic subtest vcs1: SUCCESS (0.100s) [434.586210] Starting dynamic subtest: vecs0 [434.669443] Dynamic subtest vecs0: SUCCESS (0.102s) [434.670762] Subtest engines-hostile-preempt: SUCCESS (0.497s) [434.733286] [130/156] (584s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [434.826655] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt [434.828168] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [434.886861] [131/156] (584s left) kms_plane_multiple (2x-tiling-x) [434.974631] Starting subtest: 2x-tiling-x [434.976065] Subtest 2x-tiling-x: SKIP (0.000s) [435.020519] [132/156] (584s left) sysfs_heartbeat_interval (invalid) [435.058544] Starting subtest: invalid [435.060453] Starting dynamic subtest: vecs0 [435.061394] Dynamic subtest vecs0: SUCCESS (0.000s) [435.071138] Starting dynamic subtest: vcs0 [435.071867] Dynamic subtest vcs0: SUCCESS (0.000s) [435.081385] Starting dynamic subtest: bcs0 [435.082116] Dynamic subtest bcs0: SUCCESS (0.000s) [435.091124] Starting dynamic subtest: rcs0 [435.091847] Dynamic subtest rcs0: SUCCESS (0.000s) [435.100375] Starting dynamic subtest: vcs1 [435.101085] Dynamic subtest vcs1: SUCCESS (0.000s) [435.101786] Subtest invalid: SUCCESS (0.007s) [435.135754] [133/156] (584s left) gem_exec_reloc (basic-cpu-read-active) [435.174979] Starting subtest: basic-cpu-read-active [435.304335] Subtest basic-cpu-read-active: SUCCESS (0.120s) [435.404410] [134/156] (584s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-mmap-wc) [435.498072] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-mmap-wc [435.499468] Subtest hdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [435.563523] [135/156] (584s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode) [435.701817] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s) [435.797764] [136/156] (584s left) gem_mmap_wc (set-cache-level) [435.834976] Starting subtest: set-cache-level [435.835767] Subtest set-cache-level: SUCCESS (0.001s) [435.903666] [137/156] (584s left) kms_pm_rpm (universal-planes-dpms) [447.359375] Starting subtest: universal-planes-dpms [447.360424] Starting dynamic subtest: plane-35 [455.564331] Dynamic subtest plane-35: SUCCESS (8.203s) [455.576814] Starting dynamic subtest: plane-65 [463.961327] Dynamic subtest plane-65: SUCCESS (8.397s) [463.973820] Starting dynamic subtest: plane-95 [472.392375] Dynamic subtest plane-95: SUCCESS (8.431s) [472.405219] Starting dynamic subtest: plane-125 [481.157625] Dynamic subtest plane-125: SUCCESS (8.765s) [481.170607] Starting dynamic subtest: plane-135 [489.918807] Dynamic subtest plane-135: SUCCESS (8.760s) [489.934794] Starting dynamic subtest: plane-145 [498.666995] Dynamic subtest plane-145: SUCCESS (8.747s) [498.679866] Starting dynamic subtest: plane-155 [507.325279] Dynamic subtest plane-155: SUCCESS (8.656s) [507.349954] Starting dynamic subtest: plane-165 [516.010508] Dynamic subtest plane-165: SUCCESS (8.683s) [516.011799] Subtest universal-planes-dpms: SUCCESS (68.667s) [516.217537] [138/156] (503s left) gem_exec_alignment (many) [516.259215] Starting subtest: many [549.922279] Subtest many: SUCCESS (33.628s) [550.609328] [139/156] (469s left) gem_exec_params (invalid-bsd1-flag-on-render) [550.698919] Starting subtest: invalid-bsd1-flag-on-render [550.699688] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s) [550.772382] [140/156] (469s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-mmap-wc) [550.871063] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-mmap-wc [550.872480] Subtest hdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [550.945360] [141/156] (469s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [551.046560] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip [551.351769] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.305s) [551.468009] [142/156] (468s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen) [551.563544] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen [551.565042] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [551.643518] [143/156] (468s left) kms_atomic (plane-overlay-legacy) [551.735734] Starting subtest: plane-overlay-legacy [551.737595] Starting dynamic subtest: pipe-A-HDMI-A-1 [551.885049] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.147s) [551.885868] Subtest plane-overlay-legacy: SUCCESS (0.149s) [552.009379] [144/156] (468s left) gem_eio (wait-1us) [552.055793] Starting subtest: wait-1us [552.207612] Subtest wait-1us: SUCCESS (0.151s) [552.306936] [145/156] (467s left) perf (short-reads) [552.386484] Starting subtest: short-reads [552.401017] Subtest short-reads: SUCCESS (0.016s) [552.439894] [146/156] (467s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs) [552.528604] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs [552.529305] Starting dynamic subtest: pipe-A-HDMI-A-1 [552.535935] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s) [552.545636] Starting dynamic subtest: pipe-B-HDMI-A-1 [552.552271] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s) [552.561629] Starting dynamic subtest: pipe-C-HDMI-A-1 [552.568227] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s) [552.577436] Starting dynamic subtest: pipe-D-HDMI-A-1 [552.584197] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s) [552.585535] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SKIP (0.009s) [552.774299] [147/156] (467s left) kms_lease (lease-unleased-connector) [552.863133] Starting subtest: lease-unleased-connector [552.865358] Starting dynamic subtest: pipe-A-HDMI-A-1 [552.927935] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.062s) [552.962335] Starting dynamic subtest: pipe-B-HDMI-A-1 [552.992613] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.061s) [553.029720] Starting dynamic subtest: pipe-C-HDMI-A-1 [553.052852] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.060s) [553.085645] Starting dynamic subtest: pipe-D-HDMI-A-1 [553.116714] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.060s) [553.117523] Subtest lease-unleased-connector: SUCCESS (0.253s) [553.162870] [148/156] (467s left) kms_big_fb (linear-addfb) [553.262944] Starting subtest: linear-addfb [553.263702] Subtest linear-addfb: SUCCESS (0.000s) [553.344753] [149/156] (467s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-plflip-blt) [553.439059] Starting subtest: psrhdr-2p-scndscrn-shrfb-plflip-blt [553.440468] Subtest psrhdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [553.504726] [150/156] (466s left) kms_pm_dc (dc5-dpms-negative) [564.652039] Starting subtest: dc5-dpms-negative [578.953615] Subtest dc5-dpms-negative: SUCCESS (14.266s) [578.994596] [151/156] (441s left) gem_exec_store (dword) [579.038862] Starting subtest: dword [579.039611] Starting dynamic subtest: rcs0 [579.071274] Dynamic subtest rcs0: SUCCESS (0.033s) [579.090430] Starting dynamic subtest: bcs0 [579.091221] Dynamic subtest bcs0: SUCCESS (0.017s) [579.101495] Starting dynamic subtest: vcs0 [579.106540] Dynamic subtest vcs0: SUCCESS (0.016s) [579.117512] Starting dynamic subtest: vcs1 [579.119557] Dynamic subtest vcs1: SUCCESS (0.012s) [579.131539] Starting dynamic subtest: vecs0 [579.137461] Dynamic subtest vecs0: SUCCESS (0.017s) [579.138268] Subtest dword: SUCCESS (0.101s) [579.305962] [152/156] (441s left) kms_vblank (wait-forked) [579.396995] Starting subtest: wait-forked [579.397750] Starting dynamic subtest: pipe-A-HDMI-A-1 [580.604183] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.206s) [580.616445] Starting dynamic subtest: pipe-D-HDMI-A-1 [581.808255] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.193s) [581.809075] Subtest wait-forked: SUCCESS (2.404s) [581.911401] [153/156] (438s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180) [582.011706] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180 [582.598488] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.586s) [582.692811] [154/156] (437s left) kms_psr (psr-sprite-mmap-gtt) [582.784521] Subtest psr-sprite-mmap-gtt: SKIP (0.000s) [582.833242] [155/156] (437s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions) [582.924068] Starting subtest: cursorA-vs-flipB-atomic-transitions [582.925569] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s) [582.968860] [156/156] (437s left) gem_ctx_param (set-priority-not-supported) [583.002645] Starting subtest: set-priority-not-supported [583.004035] Subtest set-priority-not-supported: SKIP (0.000s) [583.048048] Closing watchdogs results: parsing output: 0/ for test: gem_exec_schedule results: parsing output: 1/ for test: gem_tiled_wc results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: prime_self_import results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: kms_cursor_legacy results: parsing output: 7/ for test: kms_dirtyfb results: parsing output: 8/ for test: kms_frontbuffer_tracking results: parsing output: 9/ for test: syncobj_timeline results: parsing output: 10/ for test: api_intel_allocator results: parsing output: 11/ for test: gem_exec_flush results: parsing output: 12/ for test: kms_psr2_sf results: parsing output: 13/ for test: kms_psr results: parsing output: 14/ for test: syncobj_timeline results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: kms_pm_backlight results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: gem_caching results: parsing output: 19/ for test: kms_flip_event_leak results: parsing output: 20/ for test: kms_ccs results: parsing output: 21/ for test: kms_psr2_sf results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: kms_joiner results: parsing output: 24/ for test: kms_frontbuffer_tracking results: parsing output: 25/ for test: kms_frontbuffer_tracking results: parsing output: 26/ for test: kms_frontbuffer_tracking results: parsing output: 27/ for test: syncobj_timeline results: parsing output: 28/ for test: perf results: parsing output: 29/ for test: kms_flip results: parsing output: 30/ for test: kms_cursor_legacy results: parsing output: 31/ for test: gem_lmem_swapping results: parsing output: 32/ for test: prime_vgem results: parsing output: 33/ for test: kms_plane_alpha_blend results: parsing output: 34/ for test: i915_drm_fdinfo results: parsing output: 35/ for test: gem_eio results: parsing output: 36/ for test: perf_pmu results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: syncobj_timeline results: parsing output: 39/ for test: gem_eio results: parsing output: 40/ for test: kms_big_fb results: parsing output: 41/ for test: gem_softpin results: parsing output: 42/ for test: gem_exec_balancer results: parsing output: 43/ for test: kms_chamelium_audio results: parsing output: 44/ for test: kms_cursor_crc results: parsing output: 45/ for test: i915_suspend results: parsing output: 46/ for test: syncobj_timeline results: parsing output: 47/ for test: kms_frontbuffer_tracking results: parsing output: 48/ for test: kms_frontbuffer_tracking results: parsing output: 49/ for test: gem_mmap results: parsing output: 50/ for test: kms_frontbuffer_tracking results: parsing output: 51/ for test: gem_basic results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: gem_exec_params results: parsing output: 55/ for test: gem_exec_schedule results: parsing output: 56/ for test: kms_properties results: parsing output: 57/ for test: gem_userptr_blits results: parsing output: 58/ for test: kms_flip_scaled_crc results: parsing output: 59/ for test: gem_set_tiling_vs_blt results: parsing output: 60/ for test: kms_color_pipeline results: parsing output: 61/ for test: kms_frontbuffer_tracking results: parsing output: 62/ for test: gem_userptr_blits results: parsing output: 63/ for test: kms_frontbuffer_tracking results: parsing output: 64/ for test: gem_exec_schedule results: parsing output: 65/ for test: gem_render_copy_redux results: parsing output: 66/ for test: i915_pm_rps results: parsing output: 67/ for test: kms_content_protection results: parsing output: 68/ for test: gem_tiled_blits results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: kms_cursor_crc results: parsing output: 72/ for test: kms_psr results: parsing output: 73/ for test: kms_plane_scaling results: parsing output: 74/ for test: kms_ccs results: parsing output: 75/ for test: core_setmaster results: parsing output: 76/ for test: syncobj_wait results: parsing output: 77/ for test: kms_plane results: parsing output: 78/ for test: kms_frontbuffer_tracking results: parsing output: 79/ for test: perf_pmu results: parsing output: 80/ for test: kms_flip results: parsing output: 81/ for test: gen9_exec_parse results: parsing output: 82/ for test: kms_frontbuffer_tracking results: parsing output: 83/ for test: kms_feature_discovery results: parsing output: 84/ for test: kms_cursor_legacy results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: gem_exec_flush results: parsing output: 87/ for test: gem_cs_tlb results: parsing output: 88/ for test: gem_exec_fence results: parsing output: 89/ for test: i915_module_load results: parsing output: 90/ for test: kms_big_fb results: parsing output: 91/ for test: kms_cursor_legacy results: parsing output: 92/ for test: perf_pmu results: parsing output: 93/ for test: kms_hdr results: parsing output: 94/ for test: kms_ccs results: parsing output: 95/ for test: syncobj_wait results: parsing output: 96/ for test: gem_exec_balancer results: parsing output: 97/ for test: gem_exec_schedule results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: gem_render_copy results: parsing output: 100/ for test: gem_ctx_persistence results: parsing output: 101/ for test: kms_frontbuffer_tracking results: parsing output: 102/ for test: kms_chamelium_frames results: parsing output: 103/ for test: kms_psr results: parsing output: 104/ for test: gem_mmap_offset results: parsing output: 105/ for test: kms_getfb results: parsing output: 106/ for test: gem_mmap_gtt results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: core_getclient results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: kms_sequence results: parsing output: 113/ for test: gem_eio results: parsing output: 114/ for test: kms_flip results: parsing output: 115/ for test: kms_async_flips results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: kms_big_fb results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: kms_big_fb results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: kms_frontbuffer_tracking results: parsing output: 123/ for test: kms_frontbuffer_tracking results: parsing output: 124/ for test: kms_frontbuffer_tracking results: parsing output: 125/ for test: gem_pxp results: parsing output: 126/ for test: kms_psr results: parsing output: 127/ for test: kms_psr results: parsing output: 128/ for test: gem_ctx_persistence results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: kms_plane_multiple results: parsing output: 131/ for test: sysfs_heartbeat_interval results: parsing output: 132/ for test: gem_exec_reloc results: parsing output: 133/ for test: kms_frontbuffer_tracking results: parsing output: 134/ for test: kms_chamelium_hpd results: parsing output: 135/ for test: gem_mmap_wc results: parsing output: 136/ for test: kms_pm_rpm results: parsing output: 137/ for test: gem_exec_alignment results: parsing output: 138/ for test: gem_exec_params results: parsing output: 139/ for test: kms_frontbuffer_tracking results: parsing output: 140/ for test: kms_big_fb results: parsing output: 141/ for test: kms_frontbuffer_tracking results: parsing output: 142/ for test: kms_atomic results: parsing output: 143/ for test: gem_eio results: parsing output: 144/ for test: perf results: parsing output: 145/ for test: kms_ccs results: parsing output: 146/ for test: kms_lease results: parsing output: 147/ for test: kms_big_fb results: parsing output: 148/ for test: kms_frontbuffer_tracking results: parsing output: 149/ for test: kms_pm_dc results: parsing output: 150/ for test: gem_exec_store results: parsing output: 151/ for test: kms_vblank results: parsing output: 152/ for test: kms_big_fb results: parsing output: 153/ for test: kms_psr results: parsing output: 154/ for test: kms_cursor_legacy results: parsing output: 155/ for test: gem_ctx_param Done.