[58.896332] Initializing watchdogs [58.896400] /dev/watchdog0 [58.911369] [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.916377] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.918614] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.920416] [001/133] (960s left) kms_cursor_crc (cursor-random-512x512) [59.196066] Starting subtest: cursor-random-512x512 [59.197824] Subtest cursor-random-512x512: SKIP (0.001s) [59.350775] [002/133] (960s left) gem_eio (context-create) [59.508186] Starting subtest: context-create [59.723799] Subtest context-create: SUCCESS (0.216s) [59.858725] [003/133] (959s left) kms_frontbuffer_tracking (psr-2p-rte) [59.951686] Starting subtest: psr-2p-rte [59.953419] Subtest psr-2p-rte: SKIP (0.000s) [60.076746] [004/133] (959s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs) [60.158291] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs [60.159287] Starting dynamic subtest: pipe-A-eDP-1 [60.422512] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.251s) [60.428677] Starting dynamic subtest: pipe-B-eDP-1 [61.719535] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.297s) [61.726053] Starting dynamic subtest: pipe-C-eDP-1 [63.014278] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.293s) [63.021871] Starting dynamic subtest: pipe-D-eDP-1 [64.239435] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.223s) [64.240484] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.068s) [65.383350] [005/133] (954s left) gem_exec_gttfill (all-engines) [65.454747] Starting subtest: all-engines [88.462020] Subtest all-engines: SUCCESS (23.006s) [88.648718] [006/133] (930s left) gen7_exec_parse (basic-rejected) [88.749212] Subtest basic-rejected: SKIP (0.000s) [88.810049] [007/133] (930s left) gem_set_tiling_vs_blt (tiled-to-tiled) [88.867777] Subtest tiled-to-tiled: SKIP (0.000s) [88.973738] [008/133] (930s left) syncobj_wait (multi-wait-submitted) [89.018666] Starting subtest: multi-wait-submitted [89.124044] Subtest multi-wait-submitted: SUCCESS (0.104s) [89.192583] [009/133] (930s left) gem_render_copy (y-tiled-ccs-to-x-tiled) [89.242873] Starting subtest: y-tiled-ccs-to-x-tiled [89.244974] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s) [89.419653] [010/133] (930s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff) [89.524616] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff [96.569121] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.045s) [96.696990] [011/133] (923s left) gem_exec_balancer (fairslice) [96.751132] Starting subtest: fairslice [99.740951] Subtest fairslice: SUCCESS (2.981s) [100.050019] [012/133] (919s left) gem_ctx_param (invalid-size-get) [100.105540] Starting subtest: invalid-size-get [100.106719] Subtest invalid-size-get: SUCCESS (0.001s) [100.197858] [013/133] (919s left) kms_cursor_legacy (short-flip-after-cursor-toggle) [100.317450] Starting subtest: short-flip-after-cursor-toggle [101.253205] Subtest short-flip-after-cursor-toggle: SUCCESS (0.935s) [102.049066] [014/133] (917s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs) [102.139322] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs [102.140200] Starting dynamic subtest: pipe-A-eDP-1 [102.143583] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [102.151599] Starting dynamic subtest: pipe-B-eDP-1 [102.155239] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [102.161828] Starting dynamic subtest: pipe-C-eDP-1 [102.165356] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [102.171941] Starting dynamic subtest: pipe-D-eDP-1 [102.175277] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [102.176784] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.003s) [104.405140] [015/133] (915s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats) [104.503592] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats [104.504531] Starting dynamic subtest: pipe-A [104.612104] Dynamic subtest pipe-A: SKIP (0.108s) [104.624747] Starting dynamic subtest: pipe-B [105.783214] Dynamic subtest pipe-B: SKIP (1.171s) [105.790306] Starting dynamic subtest: pipe-C [107.023230] Dynamic subtest pipe-C: SUCCESS (1.241s) [107.031457] Starting dynamic subtest: pipe-D [108.255233] Dynamic subtest pipe-D: SUCCESS (1.232s) [108.256253] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.753s) [109.454148] [016/133] (910s left) kms_color_pipeline (plane-lut1d-post-ctm3x4) [109.554838] Starting subtest: plane-lut1d-post-ctm3x4 [109.702899] Starting dynamic subtest: pipe-A-plane-0 [109.869507] Dynamic subtest pipe-A-plane-0: SUCCESS (0.167s) [109.879219] Starting dynamic subtest: pipe-A-plane-1 [110.024989] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s) [110.033082] Starting dynamic subtest: pipe-A-plane-2 [110.225073] Dynamic subtest pipe-A-plane-2: SUCCESS (0.200s) [111.456591] Starting dynamic subtest: pipe-B-plane-0 [111.616832] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s) [111.625043] Starting dynamic subtest: pipe-B-plane-1 [111.783500] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s) [111.793157] Starting dynamic subtest: pipe-B-plane-2 [111.938988] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s) [113.158061] Starting dynamic subtest: pipe-C-plane-0 [113.317384] Dynamic subtest pipe-C-plane-0: SUCCESS (0.166s) [113.325228] Starting dynamic subtest: pipe-C-plane-1 [113.461934] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s) [113.469922] Starting dynamic subtest: pipe-C-plane-2 [113.606330] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s) [114.804575] Starting dynamic subtest: pipe-D-plane-0 [114.966225] Dynamic subtest pipe-D-plane-0: SUCCESS (0.167s) [114.979505] Starting dynamic subtest: pipe-D-plane-1 [115.120677] Dynamic subtest pipe-D-plane-1: SUCCESS (0.153s) [115.128585] Starting dynamic subtest: pipe-D-plane-2 [115.276180] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s) [115.568672] Subtest plane-lut1d-post-ctm3x4: SUCCESS (6.014s) [116.357536] [017/133] (903s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier) [116.447822] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier [116.449727] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s) [116.518313] [018/133] (903s left) api_intel_allocator (fork-simple-stress) [116.574097] Starting subtest: fork-simple-stress [122.016449] Subtest fork-simple-stress: SUCCESS (5.397s) [122.081657] [019/133] (897s left) gem_reg_read (timestamp-monotonic) [122.153918] Starting subtest: timestamp-monotonic [126.522194] Subtest timestamp-monotonic: SUCCESS (4.322s) [126.551205] [020/133] (893s left) gem_workarounds (reset-fd) [126.610831] Starting subtest: reset-fd [126.814051] Subtest reset-fd: SUCCESS (0.203s) [126.941225] [021/133] (893s left) kms_flip (2x-flip-vs-modeset-vs-hang) [127.024075] Starting subtest: 2x-flip-vs-modeset-vs-hang [127.034706] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.011s) [127.107949] [022/133] (893s left) gem_exec_endless (dispatch) [127.174619] Starting subtest: dispatch [127.175728] Starting dynamic subtest: rcs0 [127.180333] Dynamic subtest rcs0: SUCCESS (0.005s) [127.190922] Starting dynamic subtest: bcs0 [127.192662] Dynamic subtest bcs0: SUCCESS (0.005s) [127.199621] Starting dynamic subtest: vcs0 [127.201461] Dynamic subtest vcs0: SUCCESS (0.007s) [127.208143] Starting dynamic subtest: vcs1 [127.210019] Dynamic subtest vcs1: SUCCESS (0.007s) [127.217395] Starting dynamic subtest: vecs0 [127.219020] Dynamic subtest vecs0: SUCCESS (0.007s) [127.225571] Starting dynamic subtest: ccs0 [127.227227] Dynamic subtest ccs0: SUCCESS (0.005s) [127.228112] Subtest dispatch: SUCCESS (0.039s) [128.965298] [023/133] (891s left) kms_tiled_display (basic-test-pattern) [129.094519] Subtest basic-test-pattern: SKIP (0.000s) [129.131781] [024/133] (891s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling) [129.227673] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling [129.228700] Starting dynamic subtest: pipe-A-default-mode [131.986204] Dynamic subtest pipe-A-default-mode: SUCCESS (2.757s) [131.987268] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.758s) [132.852813] [025/133] (887s left) gem_tiled_partial_pwrite_pread (reads) [132.901214] Subtest reads: SKIP (0.000s) [132.957622] [026/133] (887s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt) [133.048358] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt [133.050217] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [133.137524] [027/133] (887s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted) [133.177099] Starting subtest: etime-single-wait-all-for-submit-submitted [133.293644] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.106s) [133.367241] [028/133] (886s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled) [133.419309] Starting subtest: multi-wait-for-submit-available-submitted-signaled [133.420175] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s) [133.504127] [029/133] (886s left) gem_mmap_offset (bad-flags) [133.545125] Starting subtest: bad-flags [133.545961] Subtest bad-flags: SUCCESS (0.000s) [133.627659] [030/133] (886s left) kms_addfb_basic (bad-pitch-65536) [133.674351] Starting subtest: bad-pitch-65536 [133.675487] Subtest bad-pitch-65536: SUCCESS (0.000s) [133.812945] [031/133] (886s left) kms_big_fb (linear-64bpp-rotate-0) [133.914356] Starting subtest: linear-64bpp-rotate-0 [135.437440] Subtest linear-64bpp-rotate-0: SUCCESS (1.524s) [135.628800] [032/133] (884s left) kms_atomic_interruptible (legacy-setmode) [135.731257] Starting subtest: legacy-setmode [135.732147] Starting dynamic subtest: pipe-A-eDP-1 [142.624560] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.892s) [142.625454] Subtest legacy-setmode: SUCCESS (6.893s) [143.493321] [033/133] (876s left) kms_invalid_mode (zero-clock) [143.575867] Starting subtest: zero-clock [143.576842] Starting dynamic subtest: pipe-A-eDP-1 [143.861278] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s) [143.868318] Starting dynamic subtest: pipe-B-eDP-1 [143.869172] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [143.875715] Starting dynamic subtest: pipe-C-eDP-1 [143.876568] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [143.883183] Starting dynamic subtest: pipe-D-eDP-1 [143.883986] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [143.884897] Subtest zero-clock: SUCCESS (0.290s) [144.737493] [034/133] (875s left) gem_eio (in-flight-external) [144.949896] Starting subtest: in-flight-external [145.953981] Subtest in-flight-external: SUCCESS (1.005s) [146.104087] [035/133] (874s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [146.212148] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip [146.893342] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.681s) [147.048284] [036/133] (873s left) gem_exec_schedule (in-order) [147.106666] Starting subtest: in-order [147.107858] Starting dynamic subtest: rcs0 [147.211990] Dynamic subtest rcs0: SUCCESS (0.105s) [147.220390] Starting dynamic subtest: vcs0 [147.303116] Dynamic subtest vcs0: SUCCESS (0.091s) [147.312285] Starting dynamic subtest: vcs1 [147.388770] Dynamic subtest vcs1: SUCCESS (0.084s) [147.397494] Starting dynamic subtest: vecs0 [147.478264] Dynamic subtest vecs0: SUCCESS (0.089s) [147.488396] Starting dynamic subtest: ccs0 [147.572344] Dynamic subtest ccs0: SUCCESS (0.093s) [147.573892] Subtest in-order: SUCCESS (0.466s) [148.967305] [037/133] (871s left) kms_vblank (wait-forked-busy) [149.066441] Starting subtest: wait-forked-busy [149.067345] Starting dynamic subtest: pipe-A-eDP-1 [150.945052] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.878s) [150.954113] Starting dynamic subtest: pipe-D-eDP-1 [153.488440] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.541s) [153.489392] Subtest wait-forked-busy: SUCCESS (4.422s) [154.282736] [038/133] (866s left) vgem_slow (nohang) [154.406071] Starting subtest: nohang [164.514566] Subtest nohang: SUCCESS (10.063s) [164.542997] [FACT vgem_slow (nohang)] new: kernel.kmod_is_loaded.vgem: true [164.544707] [039/133] (856s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels) [164.643231] Starting subtest: plane-all-modeset-transition-internal-panels [164.644064] Starting dynamic subtest: pipe-A-eDP-1 [165.938764] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.285s) [166.204476] Starting dynamic subtest: pipe-B-eDP-1 [167.269864] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.064s) [167.526049] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.882s) [168.361911] [040/133] (852s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format) [168.440239] Starting subtest: plane-upscale-20x20-with-pixel-format [168.441055] Starting dynamic subtest: pipe-A [169.500976] Dynamic subtest pipe-A: SUCCESS (1.061s) [169.508064] Starting dynamic subtest: pipe-B [171.586824] Dynamic subtest pipe-B: SUCCESS (2.085s) [171.593912] Starting dynamic subtest: pipe-C [172.776206] Dynamic subtest pipe-C: SUCCESS (1.189s) [172.784401] Starting dynamic subtest: pipe-D [173.918164] Dynamic subtest pipe-D: SUCCESS (1.141s) [173.920088] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.479s) [175.101114] [041/133] (845s left) kms_plane_cursor (primary) [175.199519] Starting subtest: primary [175.202158] Starting dynamic subtest: pipe-A-eDP-1-size-64 [177.800329] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.601s) [177.824404] Starting dynamic subtest: pipe-A-eDP-1-size-128 [180.389607] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.572s) [180.414868] Starting dynamic subtest: pipe-A-eDP-1-size-256 [182.979810] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.572s) [183.295470] Starting dynamic subtest: pipe-B-eDP-1-size-64 [186.590066] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.304s) [186.615160] Starting dynamic subtest: pipe-B-eDP-1-size-128 [189.202273] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.594s) [189.227446] Starting dynamic subtest: pipe-B-eDP-1-size-256 [191.792563] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.572s) [192.105657] Starting dynamic subtest: pipe-C-eDP-1-size-64 [195.052416] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.954s) [195.079318] Starting dynamic subtest: pipe-C-eDP-1-size-128 [197.285849] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.214s) [197.312765] Starting dynamic subtest: pipe-C-eDP-1-size-256 [199.531225] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.226s) [199.850452] Starting dynamic subtest: pipe-D-eDP-1-size-64 [202.858524] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.016s) [202.884207] Starting dynamic subtest: pipe-D-eDP-1-size-128 [205.146286] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.269s) [205.174425] Starting dynamic subtest: pipe-D-eDP-1-size-256 [207.423946] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.258s) [207.731911] Subtest primary: SUCCESS (32.532s) [208.544246] [042/133] (812s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait) [208.632986] Starting subtest: plane-primary-toggle-with-vblank-wait [208.633955] Starting dynamic subtest: pipe-A-eDP-1 [208.807596] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s) [209.119821] Starting dynamic subtest: pipe-B-eDP-1 [210.055139] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.942s) [210.359896] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.727s) [211.206250] [043/133] (809s left) syncobj_timeline (invalid-query-illegal-handle) [211.260666] Starting subtest: invalid-query-illegal-handle [211.261589] Subtest invalid-query-illegal-handle: SUCCESS (0.000s) [211.365871] [044/133] (809s left) kms_dirtyfb (fbc-dirtyfb-ioctl) [211.455263] Starting subtest: fbc-dirtyfb-ioctl [211.456107] Starting dynamic subtest: A-eDP-1 [214.076380] Dynamic subtest A-eDP-1: SUCCESS (2.621s) [214.077245] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.622s) [214.863282] [045/133] (806s left) kms_addfb_basic (invalid-get-prop) [214.924403] Starting subtest: invalid-get-prop [214.925337] Subtest invalid-get-prop: SUCCESS (0.000s) [215.057496] [046/133] (805s left) syncobj_wait (wait-for-submit-snapshot) [215.097717] Starting subtest: wait-for-submit-snapshot [215.179416] Subtest wait-for-submit-snapshot: SUCCESS (0.081s) [215.252479] [047/133] (805s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite) [215.344420] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite [215.346054] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [215.446944] [048/133] (805s left) i915_drm_fdinfo (memory-info-active) [215.489975] Starting subtest: memory-info-active [215.490928] Starting dynamic subtest: smem0 [218.029071] Dynamic subtest smem0: SUCCESS (2.540s) [218.030682] Subtest memory-info-active: SUCCESS (2.541s) [218.113827] [049/133] (802s left) api_intel_bb (object-noreloc-purge-cache-simple) [218.162183] Starting subtest: object-noreloc-purge-cache-simple [218.165806] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.005s) [218.265038] [050/133] (802s left) kms_psr (psr-cursor-mmap-gtt) [218.361121] Starting subtest: psr-cursor-mmap-gtt [218.361999] Starting dynamic subtest: eDP-1 [220.079268] Dynamic subtest eDP-1: SUCCESS (1.718s) [220.080066] Subtest psr-cursor-mmap-gtt: SUCCESS (1.719s) [220.928739] [051/133] (800s left) kms_pipe_crc_basic (suspend-read-crc) [221.021264] Starting subtest: suspend-read-crc [221.022096] Starting dynamic subtest: pipe-A-eDP-1 [239.327878] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.134s) [239.341469] Starting dynamic subtest: pipe-B-eDP-1 [258.341252] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.481s) [258.350257] Starting dynamic subtest: pipe-C-eDP-1 [277.296562] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.381s) [277.305954] Starting dynamic subtest: pipe-D-eDP-1 [296.309874] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.415s) [296.311465] Subtest suspend-read-crc: SUCCESS (13.418s) [303.151019] [052/133] (723s left) kms_chamelium_hpd (hdmi-hpd-fast) [303.544196] Subtest hdmi-hpd-fast: SKIP (0.000s) [304.340233] [053/133] (722s left) kms_cursor_crc (cursor-tearing-position-change) [304.449400] Starting subtest: cursor-tearing-position-change [304.450534] Starting dynamic subtest: pipe-A-eDP-1 [305.024566] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.574s) [305.033978] Starting dynamic subtest: pipe-D-eDP-1 [306.290128] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.262s) [306.291140] Subtest cursor-tearing-position-change: SUCCESS (1.839s) [307.120335] [054/133] (720s left) perf (short-reads) [307.262534] Starting subtest: short-reads [307.278170] Subtest short-reads: SUCCESS (0.016s) [307.323254] [055/133] (719s left) kms_chamelium_edid (dp-mode-timings) [307.712421] Subtest dp-mode-timings: SKIP (0.000s) [308.529386] [056/133] (718s left) kms_psr (fbc-pr-sprite-mmap-gtt) [308.621377] Starting subtest: fbc-pr-sprite-mmap-gtt [308.623616] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s) [308.702302] [057/133] (718s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite) [308.784384] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite [318.230848] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.441s) [318.340588] [058/133] (709s left) gem_pxp (verify-pxp-key-change-after-suspend-resume) [318.468757] Starting subtest: verify-pxp-key-change-after-suspend-resume [325.630588] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.161s) [333.771250] [059/133] (701s left) gem_exec_reloc (basic-cpu-read-noreloc) [333.829546] Subtest basic-cpu-read-noreloc: SKIP (0.000s) [333.910862] [060/133] (701s left) perf (mi-rpc) [334.015340] Starting subtest: mi-rpc [334.017984] Subtest mi-rpc: SKIP (0.000s) [334.050661] [061/133] (701s left) kms_frontbuffer_tracking (fbcpsr-tiling-4) [334.141516] Starting subtest: fbcpsr-tiling-4 [341.190657] Subtest fbcpsr-tiling-4: SUCCESS (7.048s) [341.308628] [062/133] (694s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc) [341.409685] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc [341.411750] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [341.500297] [063/133] (694s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt) [341.593546] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt [341.595598] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [341.688799] [064/133] (693s left) kms_lease (lease-uevent) [341.780261] Starting subtest: lease-uevent [342.795962] Subtest lease-uevent: SUCCESS (1.006s) [342.855297] [065/133] (692s left) kms_pm_backlight (brightness-with-dpms) [342.956832] Starting subtest: brightness-with-dpms [343.006343] Starting dynamic subtest: eDP-1 [345.551565] Dynamic subtest eDP-1: SUCCESS (2.544s) [345.552517] Subtest brightness-with-dpms: SUCCESS (2.595s) [346.405244] [066/133] (689s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu) [346.500954] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu [346.503213] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [346.591341] [067/133] (689s left) kms_flip (2x-plain-flip-fb-recreate) [346.677409] Starting subtest: 2x-plain-flip-fb-recreate [346.690170] Subtest 2x-plain-flip-fb-recreate: SKIP (0.012s) [346.766458] [068/133] (688s left) gem_wait (await) [346.819505] Starting subtest: await [346.820507] Starting dynamic subtest: all-engines [347.942891] Dynamic subtest all-engines: SUCCESS (1.123s) [347.953754] Starting dynamic subtest: rcs0 [349.007823] Dynamic subtest rcs0: SUCCESS (1.062s) [349.026912] Starting dynamic subtest: bcs0 [350.072695] Dynamic subtest bcs0: SUCCESS (1.062s) [350.091758] Starting dynamic subtest: vcs0 [351.133644] Dynamic subtest vcs0: SUCCESS (1.058s) [351.151172] Starting dynamic subtest: vcs1 [352.194845] Dynamic subtest vcs1: SUCCESS (1.058s) [352.211668] Starting dynamic subtest: vecs0 [353.252259] Dynamic subtest vecs0: SUCCESS (1.055s) [353.269056] Starting dynamic subtest: ccs0 [354.311545] Dynamic subtest ccs0: SUCCESS (1.057s) [354.313156] Subtest await: SUCCESS (7.492s) [354.511632] [069/133] (681s left) kms_psr (fbc-psr-primary-page-flip) [354.597099] Starting subtest: fbc-psr-primary-page-flip [354.597871] Starting dynamic subtest: eDP-1 [354.599527] Dynamic subtest eDP-1: SKIP (0.000s) [354.600974] Subtest fbc-psr-primary-page-flip: SKIP (0.001s) [354.667329] [070/133] (681s left) kms_big_fb (4-tiled-32bpp-rotate-0) [354.767523] Starting subtest: 4-tiled-32bpp-rotate-0 [356.125412] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.358s) [356.245570] [071/133] (679s left) kms_async_flips (async-flip-dpms) [356.328479] Starting subtest: async-flip-dpms [356.700949] Starting dynamic subtest: pipe-A-eDP-1 [360.525630] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.824s) [360.916496] Starting dynamic subtest: pipe-B-eDP-1 [363.790984] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.880s) [364.188829] Starting dynamic subtest: pipe-C-eDP-1 [366.958650] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.776s) [367.346558] Starting dynamic subtest: pipe-D-eDP-1 [370.123836] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.784s) [370.124885] Subtest async-flip-dpms: SUCCESS (13.795s) [371.327397] [072/133] (664s left) kms_cdclk (mode-transition-all-outputs) [371.411628] Starting subtest: mode-transition-all-outputs [371.700664] Subtest mode-transition-all-outputs: SKIP (0.289s) [372.536473] [073/133] (663s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt) [372.629222] Starting subtest: fbc-rgb101010-draw-blt [377.232839] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.603s) [378.362006] [074/133] (657s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu) [378.458541] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu [385.045402] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.586s) [385.141533] [075/133] (650s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt) [385.239609] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt [385.241913] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [385.327208] [076/133] (650s left) perf_pmu (gt-awake) [385.364949] Starting subtest: gt-awake [393.797674] Subtest gt-awake: SUCCESS (8.430s) [393.909661] [077/133] (642s left) i915_getparams_basic (basic-eu-total) [393.963294] Starting subtest: basic-eu-total [393.965569] Subtest basic-eu-total: SUCCESS (0.000s) [394.067070] [078/133] (642s left) kms_prop_blob (basic) [394.115981] Starting subtest: basic [394.117588] Subtest basic: SUCCESS (0.000s) [394.204034] [079/133] (641s left) gem_mmap_wc (write-wc-read-gtt) [394.268985] Subtest write-wc-read-gtt: SKIP (0.000s) [394.327978] [080/133] (641s left) kms_cursor_crc (cursor-offscreen-128x42) [394.540321] Starting subtest: cursor-offscreen-128x42 [394.583258] Subtest cursor-offscreen-128x42: SKIP (0.042s) [394.794507] [081/133] (641s left) kms_psr (pr-sprite-render) [394.885770] Starting subtest: pr-sprite-render [394.888415] Subtest pr-sprite-render: SKIP (0.000s) [394.953818] [082/133] (641s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled) [395.000816] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled [395.106298] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.105s) [395.194323] [083/133] (641s left) perf_pmu (semaphore-wait-idle) [395.228310] Starting subtest: semaphore-wait-idle [395.229392] Starting dynamic subtest: rcs0 [395.751425] Dynamic subtest rcs0: SUCCESS (0.514s) [395.762516] Starting dynamic subtest: bcs0 [396.265299] Dynamic subtest bcs0: SUCCESS (0.510s) [396.276649] Starting dynamic subtest: vcs0 [396.778385] Dynamic subtest vcs0: SUCCESS (0.510s) [396.790600] Starting dynamic subtest: vcs1 [397.292381] Dynamic subtest vcs1: SUCCESS (0.510s) [397.303672] Starting dynamic subtest: vecs0 [397.805728] Dynamic subtest vecs0: SUCCESS (0.510s) [397.814651] Starting dynamic subtest: ccs0 [398.321349] Dynamic subtest ccs0: SUCCESS (0.512s) [398.322704] Subtest semaphore-wait-idle: SUCCESS (3.086s) [399.884957] [084/133] (636s left) gem_exec_reloc (basic-cpu) [399.940763] Subtest basic-cpu: SKIP (0.000s) [400.005500] [085/133] (636s left) gem_exec_fence (keep-in-fence) [400.180752] Starting subtest: keep-in-fence [400.182125] Starting dynamic subtest: rcs0 [400.238565] Dynamic subtest rcs0: SUCCESS (0.063s) [400.254378] Starting dynamic subtest: bcs0 [400.298454] Dynamic subtest bcs0: SUCCESS (0.057s) [400.312227] Starting dynamic subtest: vcs0 [401.806751] Dynamic subtest vcs0: SUCCESS (1.497s) [401.818238] Starting dynamic subtest: vcs1 [403.790720] Dynamic subtest vcs1: SUCCESS (1.981s) [403.802175] Starting dynamic subtest: vecs0 [405.774518] Dynamic subtest vecs0: SUCCESS (1.981s) [405.785631] Starting dynamic subtest: ccs0 [405.994318] Dynamic subtest ccs0: SUCCESS (0.226s) [405.995566] Subtest keep-in-fence: SUCCESS (5.820s) [407.831720] [086/133] (628s left) gem_exec_whisper (basic-fds-forked) [407.891649] Starting subtest: basic-fds-forked [435.535970] Subtest basic-fds-forked: SUCCESS (27.636s) [435.718215] [087/133] (600s left) gem_ctx_isolation (dirty-create) [435.784911] Starting subtest: dirty-create [435.786645] Starting dynamic subtest: rcs0 [436.029224] Dynamic subtest rcs0: SUCCESS (0.243s) [436.040077] Starting dynamic subtest: bcs0 [436.304323] Dynamic subtest bcs0: SUCCESS (0.274s) [436.315316] Starting dynamic subtest: vcs0 [436.572993] Dynamic subtest vcs0: SUCCESS (0.267s) [436.583758] Starting dynamic subtest: vcs1 [437.988929] Dynamic subtest vcs1: SUCCESS (1.415s) [437.997740] Starting dynamic subtest: vecs0 [439.972730] Dynamic subtest vecs0: SUCCESS (1.982s) [439.982015] Starting dynamic subtest: ccs0 [442.039691] Dynamic subtest ccs0: SUCCESS (2.065s) [442.040980] Subtest dirty-create: SUCCESS (6.254s) [442.260449] [088/133] (594s left) kms_content_protection (lic-type-1) [442.394763] Starting subtest: lic-type-1 [442.397256] Subtest lic-type-1: SKIP (0.000s) [442.503332] [089/133] (593s left) gem_exec_create (madvise) [442.569392] Starting subtest: madvise [442.570720] Starting dynamic subtest: smem [463.818948] Dynamic subtest smem: SUCCESS (21.238s) [463.820522] Subtest madvise: SUCCESS (21.239s) [464.702832] [090/133] (571s left) kms_prop_blob (invalid-get-prop-any) [464.754315] Starting subtest: invalid-get-prop-any [464.755722] Subtest invalid-get-prop-any: SUCCESS (0.000s) [464.860594] [091/133] (571s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs) [464.952428] Starting subtest: ccs-on-another-bo-y-tiled-ccs [464.953628] Starting dynamic subtest: pipe-A-eDP-1 [464.964782] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [464.979673] Starting dynamic subtest: pipe-B-eDP-1 [464.993544] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [465.002752] Starting dynamic subtest: pipe-C-eDP-1 [465.012669] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [465.021801] Starting dynamic subtest: pipe-D-eDP-1 [465.032547] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [465.034481] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.004s) [467.251640] [092/133] (569s left) gem_ctx_engines (execute-one) [467.315425] Starting subtest: execute-one [469.523731] Subtest execute-one: SUCCESS (2.209s) [469.820694] [093/133] (566s left) gem_spin_batch (resubmit-new) [469.875976] Starting subtest: resubmit-new [469.877546] Starting dynamic subtest: rcs0 [469.891488] Dynamic subtest rcs0: SUCCESS (0.015s) [469.904191] Starting dynamic subtest: bcs0 [469.905344] Dynamic subtest bcs0: SUCCESS (0.007s) [469.916710] Starting dynamic subtest: vcs0 [469.917833] Dynamic subtest vcs0: SUCCESS (0.011s) [469.926435] Starting dynamic subtest: vcs1 [469.927651] Dynamic subtest vcs1: SUCCESS (0.010s) [469.936235] Starting dynamic subtest: vecs0 [469.937497] Dynamic subtest vecs0: SUCCESS (0.010s) [469.946325] Starting dynamic subtest: ccs0 [469.947630] Dynamic subtest ccs0: SUCCESS (0.009s) [469.948763] Subtest resubmit-new: SUCCESS (0.069s) [471.786582] [094/133] (564s left) gem_ccs (ctrl-surf-copy) [471.843722] Starting subtest: ctrl-surf-copy [471.846347] Subtest ctrl-surf-copy: SKIP (0.000s) [471.934609] [095/133] (564s left) kms_flip (flip-vs-fences) [472.026857] Starting subtest: flip-vs-fences [472.029119] Subtest flip-vs-fences: SKIP (0.000s) [472.123857] [096/133] (564s left) kms_big_fb (x-tiled-32bpp-rotate-90) [472.214026] Starting subtest: x-tiled-32bpp-rotate-90 [472.234744] Subtest x-tiled-32bpp-rotate-90: SKIP (0.019s) [472.332292] [097/133] (564s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt) [472.417471] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt [472.419118] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [472.497491] [098/133] (564s left) gem_exec_await (wide-all) [472.710693] Starting subtest: wide-all [495.599487] Subtest wide-all: SUCCESS (22.877s) [495.814758] [099/133] (541s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling) [495.957858] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling [495.958995] Starting dynamic subtest: pipe-A-default-mode [497.117830] Dynamic subtest pipe-A-default-mode: SKIP (1.158s) [497.119957] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.160s) [497.245525] [100/133] (539s left) kms_feature_discovery (psr1) [497.331362] Starting subtest: psr1 [497.332662] Subtest psr1: SUCCESS (0.000s) [497.412346] [101/133] (539s left) gem_exec_schedule (u-lateslice) [497.479610] Starting subtest: u-lateslice [497.480615] Starting dynamic subtest: rcs0 [497.500581] Dynamic subtest rcs0: SUCCESS (0.022s) [497.510311] Starting dynamic subtest: bcs0 [497.518591] Dynamic subtest bcs0: SUCCESS (0.017s) [497.527737] Starting dynamic subtest: vcs0 [497.536963] Dynamic subtest vcs0: SUCCESS (0.018s) [497.545731] Starting dynamic subtest: vcs1 [497.555538] Dynamic subtest vcs1: SUCCESS (0.018s) [497.564783] Starting dynamic subtest: vecs0 [497.575888] Dynamic subtest vecs0: SUCCESS (0.019s) [497.584960] Starting dynamic subtest: ccs0 [497.592606] Dynamic subtest ccs0: SUCCESS (0.016s) [497.593796] Subtest u-lateslice: SUCCESS (0.115s) [498.848246] [102/133] (538s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move) [498.937306] Starting subtest: psr-1p-primscrn-spr-indfb-move [506.482508] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.546s) [506.624771] [103/133] (530s left) kms_psr_stress_test (invalidate-primary-flip-overlay) [506.716536] Starting subtest: invalidate-primary-flip-overlay [517.467324] Subtest invalidate-primary-flip-overlay: SUCCESS (10.748s) [517.572809] [104/133] (519s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area) [517.668713] Starting subtest: psr2-plane-move-sf-dmg-area [517.669715] Starting dynamic subtest: pipe-A-eDP-1 [522.189791] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.520s) [522.199403] Starting dynamic subtest: pipe-B-eDP-1 [527.510942] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.319s) [527.511906] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.842s) [528.376288] [105/133] (508s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite) [528.472748] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite [533.383298] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.912s) [534.530459] [106/133] (502s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [534.639683] Starting subtest: basic-flip-after-cursor-atomic [535.579440] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.938s) [536.437603] [107/133] (500s left) kms_flip (dpms-vs-vblank-race-interruptible) [536.522676] Starting subtest: dpms-vs-vblank-race-interruptible [536.525362] Starting dynamic subtest: A-eDP1 [541.535830] Dynamic subtest A-eDP1: SUCCESS (5.008s) [541.545605] Starting dynamic subtest: B-eDP1 [546.187591] Dynamic subtest B-eDP1: SUCCESS (4.649s) [546.198794] Starting dynamic subtest: C-eDP1 [550.821642] Dynamic subtest C-eDP1: SUCCESS (4.633s) [550.831208] Starting dynamic subtest: D-eDP1 [555.457955] Dynamic subtest D-eDP1: SUCCESS (4.634s) [555.460823] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (18.934s) [556.320071] [108/133] (480s left) gem_render_copy (y-tiled-to-vebox-yf-tiled) [556.373593] Starting subtest: y-tiled-to-vebox-yf-tiled [556.376350] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s) [556.552260] [109/133] (480s left) perf_pmu (all-busy-check-all) [556.592708] Starting subtest: all-busy-check-all [557.774548] Subtest all-busy-check-all: SUCCESS (1.175s) [557.876049] [110/133] (479s left) i915_pm_rps (thresholds-idle) [557.926350] Starting subtest: thresholds-idle [557.928817] Subtest thresholds-idle: SKIP (0.001s) [558.027161] [111/133] (479s left) kms_flip (modeset-vs-vblank-race) [558.110123] Starting subtest: modeset-vs-vblank-race [558.111140] Starting dynamic subtest: A-eDP1 [562.840122] Dynamic subtest A-eDP1: SUCCESS (4.728s) [562.851969] Starting dynamic subtest: B-eDP1 [567.565313] Dynamic subtest B-eDP1: SUCCESS (4.721s) [567.581814] Starting dynamic subtest: C-eDP1 [572.275571] Dynamic subtest C-eDP1: SUCCESS (4.706s) [572.284958] Starting dynamic subtest: D-eDP1 [576.917702] Dynamic subtest D-eDP1: SUCCESS (4.640s) [576.921656] Subtest modeset-vs-vblank-race: SUCCESS (18.809s) [578.071953] [112/133] (459s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt) [578.189612] Starting subtest: psr-rgb565-draw-mmap-gtt [578.191416] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s) [578.280176] [113/133] (459s left) dmabuf_sync_file (export-multiwait) [578.324996] Starting subtest: export-multiwait [578.326379] Subtest export-multiwait: SUCCESS (0.000s) [578.378671] [114/133] (459s left) kms_flip (nonexisting-fb) [578.469421] Starting subtest: nonexisting-fb [578.470529] Starting dynamic subtest: A-eDP1 [579.677299] Dynamic subtest A-eDP1: SUCCESS (1.207s) [579.688985] Starting dynamic subtest: B-eDP1 [580.809207] Dynamic subtest B-eDP1: SUCCESS (1.129s) [580.824864] Starting dynamic subtest: C-eDP1 [581.932555] Dynamic subtest C-eDP1: SUCCESS (1.121s) [581.942858] Starting dynamic subtest: D-eDP1 [583.062835] Dynamic subtest D-eDP1: SUCCESS (1.129s) [583.065812] Subtest nonexisting-fb: SUCCESS (4.597s) [584.252000] [115/133] (453s left) sysfs_timeslice_duration (idempotent) [584.301171] Starting subtest: idempotent [584.302208] Starting dynamic subtest: vecs0 [584.303276] Dynamic subtest vecs0: SUCCESS (0.000s) [584.315598] Starting dynamic subtest: ccs0 [584.316664] Dynamic subtest ccs0: SUCCESS (0.000s) [584.330055] Starting dynamic subtest: vcs0 [584.331514] Dynamic subtest vcs0: SUCCESS (0.000s) [584.340496] Starting dynamic subtest: bcs0 [584.341532] Dynamic subtest bcs0: SUCCESS (0.000s) [584.350392] Starting dynamic subtest: rcs0 [584.351555] Dynamic subtest rcs0: SUCCESS (0.000s) [584.361064] Starting dynamic subtest: vcs1 [584.362631] Dynamic subtest vcs1: SUCCESS (0.000s) [584.363913] Subtest idempotent: SUCCESS (0.007s) [584.399891] [116/133] (453s left) gem_exec_params (invalid-fence-in) [584.455666] Starting subtest: invalid-fence-in [584.456750] Subtest invalid-fence-in: SUCCESS (0.000s) [584.560248] [117/133] (452s left) kms_big_fb (yf-tiled-64bpp-rotate-180) [584.665295] Starting subtest: yf-tiled-64bpp-rotate-180 [584.667228] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s) [584.761110] [118/133] (452s left) gem_lmem_swapping (verify-random) [584.805217] Subtest verify-random: SKIP (0.000s) [584.846483] [119/133] (452s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs) [584.934614] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs [584.935908] Starting dynamic subtest: pipe-A-eDP-1 [584.948638] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [584.959167] Starting dynamic subtest: pipe-B-eDP-1 [584.968279] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [584.980000] Starting dynamic subtest: pipe-C-eDP-1 [584.990746] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [585.000098] Starting dynamic subtest: pipe-D-eDP-1 [585.013378] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [585.016154] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.006s) [587.112953] [120/133] (450s left) i915_pm_rpm (system-suspend-devices) [588.950077] Starting subtest: system-suspend-devices [596.658216] Subtest system-suspend-devices: SUCCESS (7.707s) [602.088990] [121/133] (440s left) gem_close_race (basic-threads) [602.155969] Starting subtest: basic-threads [603.469955] Subtest basic-threads: SUCCESS (1.313s) [603.692992] [122/133] (439s left) syncobj_timeline (wait-all-interrupted) [603.759664] Starting subtest: wait-all-interrupted [603.860306] Subtest wait-all-interrupted: SUCCESS (0.101s) [603.940882] [123/133] (438s left) kms_flip (2x-flip-vs-panning-interruptible) [604.036442] Starting subtest: 2x-flip-vs-panning-interruptible [604.048432] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s) [604.137613] [124/133] (438s left) kms_atomic (plane-primary-legacy) [604.228665] Starting subtest: plane-primary-legacy [604.229768] Starting dynamic subtest: pipe-A-eDP-1 [604.686568] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.457s) [604.687894] Subtest plane-primary-legacy: SUCCESS (0.459s) [605.567407] [125/133] (437s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt) [605.662874] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt [605.664820] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [605.753895] [126/133] (437s left) gem_lmem_swapping (massive-random) [605.787897] Subtest massive-random: SKIP (0.000s) [605.829953] [127/133] (437s left) gem_eio (in-flight-internal-10ms) [606.035488] Starting subtest: in-flight-internal-10ms [607.888154] Subtest in-flight-internal-10ms: SUCCESS (1.853s) [608.036230] [128/133] (434s left) kms_busy (extended-pageflip-hang-newfb) [608.126456] Starting subtest: extended-pageflip-hang-newfb [608.127638] Starting dynamic subtest: pipe-A [634.653630] Dynamic subtest pipe-A: SUCCESS (26.520s) [634.663737] Starting dynamic subtest: pipe-D [649.629032] Dynamic subtest pipe-D: SUCCESS (14.971s) [649.630592] Subtest extended-pageflip-hang-newfb: SUCCESS (41.495s) [650.421737] [129/133] (392s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf) [650.512216] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf [650.514440] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [650.577660] [130/133] (392s left) gem_ctx_persistence (legacy-engines-persistence) [650.644136] Starting subtest: legacy-engines-persistence [650.645524] Starting dynamic subtest: render [651.470967] Dynamic subtest render: SUCCESS (0.826s) [651.484721] Starting dynamic subtest: bsd1 [652.227133] Dynamic subtest bsd1: SUCCESS (0.753s) [652.241235] Starting dynamic subtest: bsd2 [652.992958] Dynamic subtest bsd2: SUCCESS (0.763s) [653.006750] Starting dynamic subtest: blt [653.743387] Dynamic subtest blt: SUCCESS (0.745s) [653.755388] Starting dynamic subtest: vebox [654.511297] Dynamic subtest vebox: SUCCESS (0.766s) [654.512733] Subtest legacy-engines-persistence: SUCCESS (3.866s) [654.630898] [131/133] (388s left) kms_big_fb (y-tiled-8bpp-rotate-0) [654.728830] Starting subtest: y-tiled-8bpp-rotate-0 [654.731353] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s) [654.832909] [132/133] (388s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180) [654.925802] Starting subtest: primary-yf-tiled-reflect-x-180 [654.986662] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.060s) [655.084204] [133/133] (388s left) kms_vrr (seamless-rr-switch-virtual) [655.174283] Starting subtest: seamless-rr-switch-virtual [655.177293] Subtest seamless-rr-switch-virtual: SKIP (0.000s) [655.239903] Closing watchdogs results: parsing output: 0/ for test: kms_cursor_crc results: parsing output: 1/ for test: gem_eio results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: kms_ccs results: parsing output: 4/ for test: gem_exec_gttfill results: parsing output: 5/ for test: gen7_exec_parse results: parsing output: 6/ for test: gem_set_tiling_vs_blt results: parsing output: 7/ for test: syncobj_wait results: parsing output: 8/ for test: gem_render_copy results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: gem_exec_balancer results: parsing output: 11/ for test: gem_ctx_param results: parsing output: 12/ for test: kms_cursor_legacy results: parsing output: 13/ for test: kms_ccs results: parsing output: 14/ for test: kms_plane_scaling results: parsing output: 15/ for test: kms_color_pipeline results: parsing output: 16/ for test: kms_plane results: parsing output: 17/ for test: api_intel_allocator results: parsing output: 18/ for test: gem_reg_read results: parsing output: 19/ for test: gem_workarounds results: parsing output: 20/ for test: kms_flip results: parsing output: 21/ for test: gem_exec_endless results: parsing output: 22/ for test: kms_tiled_display results: parsing output: 23/ for test: kms_flip_scaled_crc results: parsing output: 24/ for test: gem_tiled_partial_pwrite_pread results: parsing output: 25/ for test: kms_frontbuffer_tracking results: parsing output: 26/ for test: syncobj_timeline results: parsing output: 27/ for test: syncobj_timeline results: parsing output: 28/ for test: gem_mmap_offset results: parsing output: 29/ for test: kms_addfb_basic results: parsing output: 30/ for test: kms_big_fb results: parsing output: 31/ for test: kms_atomic_interruptible results: parsing output: 32/ for test: kms_invalid_mode results: parsing output: 33/ for test: gem_eio results: parsing output: 34/ for test: kms_big_fb results: parsing output: 35/ for test: gem_exec_schedule results: parsing output: 36/ for test: kms_vblank results: parsing output: 37/ for test: vgem_slow results: parsing output: 38/ for test: kms_atomic_transition results: parsing output: 39/ for test: kms_plane_scaling results: parsing output: 40/ for test: kms_plane_cursor results: parsing output: 41/ for test: kms_atomic_transition results: parsing output: 42/ for test: syncobj_timeline results: parsing output: 43/ for test: kms_dirtyfb results: parsing output: 44/ for test: kms_addfb_basic results: parsing output: 45/ for test: syncobj_wait results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: i915_drm_fdinfo results: parsing output: 48/ for test: api_intel_bb results: parsing output: 49/ for test: kms_psr results: parsing output: 50/ for test: kms_pipe_crc_basic results: parsing output: 51/ for test: kms_chamelium_hpd results: parsing output: 52/ for test: kms_cursor_crc results: parsing output: 53/ for test: perf results: parsing output: 54/ for test: kms_chamelium_edid results: parsing output: 55/ for test: kms_psr results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: gem_pxp results: parsing output: 58/ for test: gem_exec_reloc results: parsing output: 59/ for test: perf 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_lease results: parsing output: 64/ for test: kms_pm_backlight results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: kms_flip results: parsing output: 67/ for test: gem_wait results: parsing output: 68/ for test: kms_psr results: parsing output: 69/ for test: kms_big_fb results: parsing output: 70/ for test: kms_async_flips results: parsing output: 71/ for test: kms_cdclk results: parsing output: 72/ for test: kms_frontbuffer_tracking results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: perf_pmu results: parsing output: 76/ for test: i915_getparams_basic results: parsing output: 77/ for test: kms_prop_blob results: parsing output: 78/ for test: gem_mmap_wc results: parsing output: 79/ for test: kms_cursor_crc results: parsing output: 80/ for test: kms_psr results: parsing output: 81/ for test: syncobj_timeline results: parsing output: 82/ for test: perf_pmu results: parsing output: 83/ for test: gem_exec_reloc results: parsing output: 84/ for test: gem_exec_fence results: parsing output: 85/ for test: gem_exec_whisper results: parsing output: 86/ for test: gem_ctx_isolation results: parsing output: 87/ for test: kms_content_protection results: parsing output: 88/ for test: gem_exec_create results: parsing output: 89/ for test: kms_prop_blob results: parsing output: 90/ for test: kms_ccs results: parsing output: 91/ for test: gem_ctx_engines results: parsing output: 92/ for test: gem_spin_batch results: parsing output: 93/ for test: gem_ccs results: parsing output: 94/ for test: kms_flip results: parsing output: 95/ for test: kms_big_fb results: parsing output: 96/ for test: kms_frontbuffer_tracking results: parsing output: 97/ for test: gem_exec_await results: parsing output: 98/ for test: kms_flip_scaled_crc results: parsing output: 99/ for test: kms_feature_discovery 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_psr_stress_test results: parsing output: 103/ for test: kms_psr2_sf results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: kms_cursor_legacy results: parsing output: 106/ for test: kms_flip results: parsing output: 107/ for test: gem_render_copy results: parsing output: 108/ for test: perf_pmu results: parsing output: 109/ for test: i915_pm_rps results: parsing output: 110/ for test: kms_flip results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: dmabuf_sync_file results: parsing output: 113/ for test: kms_flip results: parsing output: 114/ for test: sysfs_timeslice_duration results: parsing output: 115/ for test: gem_exec_params results: parsing output: 116/ for test: kms_big_fb results: parsing output: 117/ for test: gem_lmem_swapping results: parsing output: 118/ for test: kms_ccs results: parsing output: 119/ for test: i915_pm_rpm results: parsing output: 120/ for test: gem_close_race results: parsing output: 121/ for test: syncobj_timeline results: parsing output: 122/ for test: kms_flip results: parsing output: 123/ for test: kms_atomic results: parsing output: 124/ for test: kms_frontbuffer_tracking results: parsing output: 125/ for test: gem_lmem_swapping results: parsing output: 126/ for test: gem_eio results: parsing output: 127/ for test: kms_busy results: parsing output: 128/ for test: kms_psr2_sf results: parsing output: 129/ for test: gem_ctx_persistence results: parsing output: 130/ for test: kms_big_fb results: parsing output: 131/ for test: kms_rotation_crc results: parsing output: 132/ for test: kms_vrr Done.