[56.270677] Initializing watchdogs [56.270815] /dev/watchdog0 [56.286796] [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] [56.291224] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [56.293731] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [56.297567] [001/156] (960s left) kms_flip (flip-vs-suspend) [56.420249] Starting subtest: flip-vs-suspend [56.422604] Starting dynamic subtest: A-eDP1 [202.058972] Dynamic subtest A-eDP1: SUCCESS (12.070s) [202.061353] Subtest flip-vs-suspend: SUCCESS (12.072s) [202.224837] [002/156] (814s left) gem_exec_whisper (basic-contexts-priority) [202.292689] Starting subtest: basic-contexts-priority [227.152996] Subtest basic-contexts-priority: SUCCESS (24.775s) [227.351480] [003/156] (789s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi [227.420629] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted [227.525040] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.104s) [227.598839] [004/156] (789s left) kms_pm_rpm (dpms-non-lpsp) [229.124317] Starting subtest: dpms-non-lpsp [229.129508] Subtest dpms-non-lpsp: SKIP (0.001s) [229.843067] [005/156] (787s left) sw_sync (sync_multi_consumer_producer) [229.876708] Starting subtest: sync_multi_consumer_producer [230.172112] Subtest sync_multi_consumer_producer: SUCCESS (0.295s) [230.232808] [006/156] (786s left) gem_ctx_persistence (legacy-engines-cleanup) [230.286661] Starting subtest: legacy-engines-cleanup [230.289017] Starting dynamic subtest: render [230.366681] Dynamic subtest render: SUCCESS (0.079s) [230.379128] Starting dynamic subtest: bsd1 [230.415501] Dynamic subtest bsd1: SUCCESS (0.047s) [230.427133] Starting dynamic subtest: bsd2 [230.452365] Dynamic subtest bsd2: SUCCESS (0.035s) [230.462056] Starting dynamic subtest: blt [230.487283] Dynamic subtest blt: SUCCESS (0.034s) [230.500685] Starting dynamic subtest: vebox [230.546492] Dynamic subtest vebox: SUCCESS (0.058s) [230.548966] Subtest legacy-engines-cleanup: SUCCESS (0.260s) [230.625731] [007/156] (786s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff) [230.727983] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff [230.732033] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [230.834450] [008/156] (786s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc) [230.922449] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc [230.924788] Starting dynamic subtest: pipe-A-eDP-1 [230.947767] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [230.958422] Starting dynamic subtest: pipe-B-eDP-1 [230.980459] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [230.995325] Starting dynamic subtest: pipe-C-eDP-1 [231.016965] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [231.027411] Starting dynamic subtest: pipe-D-eDP-1 [231.050201] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [231.054397] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s) [233.199181] [009/156] (783s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats) [233.588361] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s) [234.412435] [010/156] (782s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes) [234.462520] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s) [234.537108] [011/156] (782s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt) [234.644210] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt [234.648395] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [234.729278] [012/156] (782s left) gem_softpin (safe-alignment) [234.779604] Starting subtest: safe-alignment [234.804286] Subtest safe-alignment: SUCCESS (0.024s) [236.880958] [013/156] (780s left) kms_cursor_crc (cursor-onscreen-128x128) [237.092827] Starting subtest: cursor-onscreen-128x128 [237.097555] Starting dynamic subtest: pipe-A-eDP-1 [239.231546] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.135s) [239.264128] Starting dynamic subtest: pipe-D-eDP-1 [242.006760] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.752s) [242.009188] Subtest cursor-onscreen-128x128: SUCCESS (4.914s) [242.887094] [014/156] (774s left) kms_dp_linktrain_fallback (dp-fallback) [242.988643] Starting subtest: dp-fallback [242.995009] Subtest dp-fallback: SKIP (0.000s) [243.059932] [015/156] (774s left) gem_ctx_shared (exec-shared-gtt) [243.117248] Starting subtest: exec-shared-gtt [243.119403] Starting dynamic subtest: rcs0 [243.124627] Dynamic subtest rcs0: SUCCESS (0.007s) [243.134856] Starting dynamic subtest: bcs0 [243.136950] Dynamic subtest bcs0: SUCCESS (0.005s) [243.147342] Starting dynamic subtest: vcs0 [243.149275] Dynamic subtest vcs0: SUCCESS (0.007s) [243.162819] Starting dynamic subtest: vcs1 [243.165033] Dynamic subtest vcs1: SUCCESS (0.007s) [243.174222] Starting dynamic subtest: vecs0 [243.176382] Dynamic subtest vecs0: SUCCESS (0.006s) [243.185922] Starting dynamic subtest: ccs0 [243.188017] Dynamic subtest ccs0: SUCCESS (0.006s) [243.190146] Subtest exec-shared-gtt: SUCCESS (0.041s) [243.342628] [016/156] (774s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy) [243.457217] Starting subtest: flip-vs-cursor-crc-legacy [244.186577] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.728s) [245.018019] [017/156] (772s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip) [245.117259] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip [246.218850] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.102s) [246.328177] [018/156] (771s left) syncobj_basic (illegal-fd-to-handle) [246.384233] Starting subtest: illegal-fd-to-handle [246.386250] Subtest illegal-fd-to-handle: SUCCESS (0.000s) [246.483456] [019/156] (771s left) kms_flip (nonexisting-fb) [246.570480] Starting subtest: nonexisting-fb [246.572460] Starting dynamic subtest: A-eDP1 [247.806116] Dynamic subtest A-eDP1: SUCCESS (1.234s) [247.819625] Starting dynamic subtest: B-eDP1 [248.935540] Dynamic subtest B-eDP1: SUCCESS (1.129s) [248.946452] Starting dynamic subtest: C-eDP1 [250.092304] Dynamic subtest C-eDP1: SUCCESS (1.155s) [250.104040] Starting dynamic subtest: D-eDP1 [251.220310] Dynamic subtest D-eDP1: SUCCESS (1.126s) [251.225402] Subtest nonexisting-fb: SUCCESS (4.655s) [252.389585] [020/156] (765s left) gem_pxp (regular-baseline-src-copy-readible) [252.513797] Starting subtest: regular-baseline-src-copy-readible [252.581286] Subtest regular-baseline-src-copy-readible: SUCCESS (0.070s) [252.729175] [021/156] (764s left) kms_vrr (seamless-rr-switch-drrs) [252.823882] Starting subtest: seamless-rr-switch-drrs [252.830562] Subtest seamless-rr-switch-drrs: SKIP (0.000s) [252.908494] [022/156] (764s left) kms_flip (2x-plain-flip) [253.004074] Starting subtest: 2x-plain-flip [253.016006] Subtest 2x-plain-flip: SKIP (0.011s) [253.091085] [023/156] (764s left) kms_fence_pin_leak [253.262623] [024/156] (764s left) kms_fb_coherency (memset-crc) [253.350118] Starting subtest: memset-crc [253.351908] Starting dynamic subtest: mmap-offset-wc [253.749675] Dynamic subtest mmap-offset-wc: SUCCESS (0.399s) [254.040201] Starting dynamic subtest: mmap-offset-uc [260.134224] Dynamic subtest mmap-offset-uc: SUCCESS (6.102s) [260.427265] Subtest memset-crc: SUCCESS (7.075s) [261.244826] [025/156] (756s left) kms_ccs (bad-rotation-90-yf-tiled-ccs) [261.343814] Starting subtest: bad-rotation-90-yf-tiled-ccs [261.346110] Starting dynamic subtest: pipe-A-eDP-1 [261.368985] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [261.378965] Starting dynamic subtest: pipe-B-eDP-1 [261.400675] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [261.409843] Starting dynamic subtest: pipe-C-eDP-1 [261.430732] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [261.439545] Starting dynamic subtest: pipe-D-eDP-1 [261.460482] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [261.464617] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.003s) [263.645705] [026/156] (754s left) gen7_exec_parse (bitmasks) [263.707961] Subtest bitmasks: SKIP (0.000s) [263.767074] [027/156] (754s left) syncobj_wait (multi-wait-all-signaled) [263.811238] Starting subtest: multi-wait-all-signaled [263.813256] Subtest multi-wait-all-signaled: SUCCESS (0.000s) [263.901329] [028/156] (754s left) kms_getfb (getfb-handle-valid) [263.997111] Starting subtest: getfb-handle-valid [263.999459] Subtest getfb-handle-valid: SUCCESS (0.000s) [264.095485] [029/156] (753s left) perf (oa-exponents) [264.231747] Starting subtest: oa-exponents [264.233958] Starting dynamic subtest: 0-rcs0 [266.000944] Dynamic subtest 0-rcs0: SUCCESS (1.769s) [266.011724] Starting dynamic subtest: 1-vcs0 [267.828895] Dynamic subtest 1-vcs0: SUCCESS (1.827s) [267.831602] Subtest oa-exponents: SUCCESS (3.598s) [267.877080] [030/156] (750s left) gem_exec_fence (concurrent) [268.053343] Starting subtest: concurrent [268.057546] Subtest concurrent: SKIP (0.000s) [269.941542] [FACT gem_exec_fence (concurrent)] new: kernel.kmod_is_loaded.vgem: true [269.945016] [031/156] (748s left) gem_exec_params (rel-constants-invalid-ring) [270.000918] Starting subtest: rel-constants-invalid-ring [270.003426] Subtest rel-constants-invalid-ring: SUCCESS (0.000s) [270.100240] [032/156] (747s left) kms_plane (pixel-format-x-tiled-modifier) [270.189606] Starting subtest: pixel-format-x-tiled-modifier [270.215457] Starting dynamic subtest: pipe-A-plane-0 [270.593373] Dynamic subtest pipe-A-plane-0: SUCCESS (0.378s) [270.604929] Starting dynamic subtest: pipe-A-plane-3 [270.926355] Dynamic subtest pipe-A-plane-3: SUCCESS (0.333s) [270.938408] Starting dynamic subtest: pipe-A-plane-5 [270.942214] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [272.023232] Starting dynamic subtest: pipe-B-plane-0 [272.414302] Dynamic subtest pipe-B-plane-0: SUCCESS (0.400s) [272.424392] Starting dynamic subtest: pipe-B-plane-3 [272.726281] Dynamic subtest pipe-B-plane-3: SUCCESS (0.309s) [272.735966] Starting dynamic subtest: pipe-B-plane-5 [272.740578] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [273.036738] Subtest pixel-format-x-tiled-modifier: SUCCESS (2.845s) [273.913487] [033/156] (744s left) gem_ctx_persistence (engines-queued) [273.966372] Starting subtest: engines-queued [273.968842] Starting dynamic subtest: rcs0 [274.042549] Dynamic subtest rcs0: SUCCESS (0.076s) [274.055054] Starting dynamic subtest: bcs0 [274.075549] Dynamic subtest bcs0: SUCCESS (0.032s) [274.089384] Starting dynamic subtest: vcs0 [275.769497] Dynamic subtest vcs0: SUCCESS (1.690s) [275.780630] Starting dynamic subtest: vcs1 [277.814182] Dynamic subtest vcs1: SUCCESS (2.042s) [277.826623] Starting dynamic subtest: vecs0 [279.798501] Dynamic subtest vecs0: SUCCESS (1.981s) [279.810609] Starting dynamic subtest: ccs0 [279.972060] Dynamic subtest ccs0: SUCCESS (0.173s) [279.974486] Subtest engines-queued: SUCCESS (6.004s) [280.112336] [034/156] (738s left) i915_drm_fdinfo (context-close-stress) [280.154847] Starting subtest: context-close-stress [290.903866] Subtest context-close-stress: SUCCESS (10.744s) [290.984244] [035/156] (727s left) kms_psr (psr-cursor-plane-onoff) [291.223605] Starting subtest: psr-cursor-plane-onoff [291.225953] Starting dynamic subtest: eDP-1 [293.001257] Dynamic subtest eDP-1: SUCCESS (1.777s) [293.003572] Subtest psr-cursor-plane-onoff: SUCCESS (1.778s) [293.864309] [036/156] (724s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs) [293.956937] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs [293.959451] Starting dynamic subtest: pipe-A-eDP-1 [293.983491] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [293.995296] Starting dynamic subtest: pipe-B-eDP-1 [294.018823] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [294.028938] Starting dynamic subtest: pipe-C-eDP-1 [294.052121] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [294.069250] Starting dynamic subtest: pipe-D-eDP-1 [294.092221] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [294.096469] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.005s) [296.223591] [037/156] (722s left) syncobj_timeline (single-wait-for-submit-available-signaled) [296.281074] Starting subtest: single-wait-for-submit-available-signaled [296.282948] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s) [296.386152] [038/156] (721s left) gem_exec_balancer (full) [296.441411] Starting subtest: full [300.650156] Subtest full: SUCCESS (4.209s) [300.977182] [039/156] (717s left) kms_psr (psr2-cursor-plane-onoff) [301.073687] Starting subtest: psr2-cursor-plane-onoff [301.075953] Starting dynamic subtest: eDP-1 [302.801381] Dynamic subtest eDP-1: SUCCESS (1.730s) [302.803623] Subtest psr2-cursor-plane-onoff: SUCCESS (1.730s) [303.684453] [040/156] (714s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling) [303.783696] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling [303.785841] Starting dynamic subtest: pipe-A-default-mode [304.935020] Dynamic subtest pipe-A-default-mode: SKIP (1.147s) [304.939115] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.148s) [305.069058] [041/156] (713s left) gem_exec_fence (basic-wait-all) [305.132765] Starting subtest: basic-wait-all [305.222307] Subtest basic-wait-all: SUCCESS (0.090s) [306.857593] [042/156] (711s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-indfb-pgflip-blt) [306.958617] Starting subtest: fbchdr-1p-primscrn-indfb-pgflip-blt [306.963032] Subtest fbchdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [307.064160] [043/156] (711s left) gem_wait (wait) [307.140245] Starting subtest: wait [307.142649] Starting dynamic subtest: all-engines [308.825329] Dynamic subtest all-engines: SUCCESS (1.684s) [308.837125] Starting dynamic subtest: rcs0 [309.871492] Dynamic subtest rcs0: SUCCESS (1.046s) [309.884359] Starting dynamic subtest: bcs0 [310.919977] Dynamic subtest bcs0: SUCCESS (1.046s) [310.932063] Starting dynamic subtest: vcs0 [311.966121] Dynamic subtest vcs0: SUCCESS (1.044s) [311.978270] Starting dynamic subtest: vcs1 [313.011996] Dynamic subtest vcs1: SUCCESS (1.044s) [313.024160] Starting dynamic subtest: vecs0 [314.057927] Dynamic subtest vecs0: SUCCESS (1.043s) [314.070284] Starting dynamic subtest: ccs0 [315.105881] Dynamic subtest ccs0: SUCCESS (1.047s) [315.108401] Subtest wait: SUCCESS (7.968s) [315.317963] [044/156] (703s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt) [315.431849] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt [315.435806] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [315.560309] [045/156] (703s left) kms_frontbuffer_tracking (fbcpsr-tiling-y) [315.667268] Starting subtest: fbcpsr-tiling-y [315.671279] Subtest fbcpsr-tiling-y: SKIP (0.000s) [315.772093] [046/156] (702s left) gem_readwrite (read-bad-handle) [315.830628] Subtest read-bad-handle: SKIP (0.000s) [315.905745] [047/156] (702s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [316.007580] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [316.011803] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [316.125961] [048/156] (702s left) kms_universal_plane (cursor-fb-leak) [316.225060] Starting subtest: cursor-fb-leak [316.227411] Starting dynamic subtest: pipe-A-eDP-1 [316.553177] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.330s) [316.565982] Starting dynamic subtest: pipe-B-eDP-1 [317.924967] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.370s) [317.939590] Starting dynamic subtest: pipe-C-eDP-1 [319.320451] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.392s) [319.333373] Starting dynamic subtest: pipe-D-eDP-1 [320.656575] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.334s) [320.659176] Subtest cursor-fb-leak: SUCCESS (4.434s) [321.839881] [049/156] (696s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-render) [321.936731] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-render [321.941061] Subtest hdr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s) [322.038479] [050/156] (696s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render) [322.134902] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render [322.139015] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [322.245081] [051/156] (696s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt) [322.340767] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt [322.345224] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [322.440506] [052/156] (696s left) i915_pm_rps (reset) [322.503866] Starting subtest: reset [330.941674] Subtest reset: SUCCESS (8.425s) [331.049265] [053/156] (687s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt) [331.156269] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt [331.160362] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [331.253764] [054/156] (687s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-render) [331.356893] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-render [331.360962] Subtest hdr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [331.446859] [055/156] (687s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-wc) [331.540095] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-wc [331.544054] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [331.631413] [056/156] (687s left) kms_flip (bo-too-big) [331.728038] Starting subtest: bo-too-big [331.729930] Starting dynamic subtest: A-eDP1 [333.084763] Dynamic subtest A-eDP1: SUCCESS (1.358s) [333.099464] Starting dynamic subtest: B-eDP1 [334.424360] Dynamic subtest B-eDP1: SUCCESS (1.337s) [334.436061] Starting dynamic subtest: C-eDP1 [335.764359] Dynamic subtest C-eDP1: SUCCESS (1.339s) [335.776059] Starting dynamic subtest: D-eDP1 [337.097487] Dynamic subtest D-eDP1: SUCCESS (1.331s) [337.099886] Subtest bo-too-big: SUCCESS (5.375s) [338.306007] [057/156] (680s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy) [338.427174] Starting subtest: 2x-flip-vs-cursor-legacy [338.433009] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s) [338.572989] [058/156] (680s left) api_intel_allocator (default-alignment) [338.623693] Starting subtest: default-alignment [338.625997] Subtest default-alignment: SUCCESS (0.003s) [338.742736] [059/156] (680s left) gem_mmap_gtt (medium-copy) [338.795712] Subtest medium-copy: SKIP (0.000s) [338.857706] [060/156] (680s left) kms_plane_scaling (2x-scaler-multi-pipe) [338.946734] Starting subtest: 2x-scaler-multi-pipe [338.950928] Subtest 2x-scaler-multi-pipe: SKIP (0.001s) [339.047007] [061/156] (680s left) gem_lmem_swapping (heavy-verify-random-ccs) [339.090163] Subtest heavy-verify-random-ccs: SKIP (0.000s) [339.135463] [062/156] (680s left) syncobj_timeline (invalid-query-illegal-handle) [339.190409] Starting subtest: invalid-query-illegal-handle [339.192403] Subtest invalid-query-illegal-handle: SUCCESS (0.000s) [339.293719] [063/156] (680s left) kms_psr (fbc-psr2-primary-mmap-gtt) [339.380408] Starting subtest: fbc-psr2-primary-mmap-gtt [339.382510] Starting dynamic subtest: eDP-1 [339.385873] Dynamic subtest eDP-1: SKIP (0.000s) [339.389232] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s) [339.457935] [064/156] (680s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc) [339.551604] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc [339.555034] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [339.644980] [065/156] (679s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted) [339.694927] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted [339.829358] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.134s) [339.952019] [066/156] (679s left) perf (invalid-remove-userspace-config) [340.038349] Starting subtest: invalid-remove-userspace-config [340.048273] Subtest invalid-remove-userspace-config: SUCCESS (0.009s) [340.089886] [067/156] (679s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff) [340.184982] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff [340.188556] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [340.285949] [068/156] (679s left) kms_flip (flip-vs-fences-interruptible) [340.371262] Starting subtest: flip-vs-fences-interruptible [340.375255] Subtest flip-vs-fences-interruptible: SKIP (0.000s) [340.479635] [069/156] (679s left) syncobj_timeline (single-wait-all-available-signaled) [340.536967] Starting subtest: single-wait-all-available-signaled [340.538912] Subtest single-wait-all-available-signaled: SUCCESS (0.000s) [340.648467] [070/156] (679s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu) [340.751093] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu [348.016307] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.268s) [348.163210] [071/156] (671s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing) [348.250766] Starting subtest: plane-all-transition-nonblocking-fencing [348.254338] Starting dynamic subtest: pipe-A-eDP-1 [350.746922] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.497s) [351.067961] Starting dynamic subtest: pipe-B-eDP-1 [354.299832] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.243s) [354.597004] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.346s) [355.420030] [072/156] (664s left) api_intel_bb (offset-control) [355.468076] Starting subtest: offset-control [355.474061] Subtest offset-control: SUCCESS (0.008s) [355.578619] [073/156] (664s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs) [355.682418] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs [355.684304] Starting dynamic subtest: pipe-A-eDP-1 [355.743360] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s) [355.753866] Starting dynamic subtest: pipe-B-eDP-1 [355.805686] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.060s) [355.815882] Starting dynamic subtest: pipe-C-eDP-1 [355.864993] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.059s) [355.875197] Starting dynamic subtest: pipe-D-eDP-1 [355.930541] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.064s) [355.932861] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.251s) [358.190655] [074/156] (661s left) kms_chamelium_color (ctm-limited-range) [358.281490] Subtest ctm-limited-range: SKIP (0.000s) [358.331088] [075/156] (661s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions) [358.445717] Starting subtest: cursorA-vs-flipA-atomic-transitions [369.609982] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.160s) [370.435996] [076/156] (649s left) syncobj_wait (multi-wait-all-submitted-signaled) [370.492627] Starting subtest: multi-wait-all-submitted-signaled [370.596593] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.103s) [370.678784] [077/156] (649s left) syncobj_eventfd (invalid-bad-pad) [370.724076] Starting subtest: invalid-bad-pad [370.725940] Subtest invalid-bad-pad: SUCCESS (0.000s) [370.818861] [078/156] (649s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-render) [370.912982] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-render [370.917094] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [371.013408] [079/156] (649s left) kms_content_protection (atomic-hdcp14) [371.165918] Starting subtest: atomic-hdcp14 [371.170257] Subtest atomic-hdcp14: SKIP (0.000s) [371.290025] [080/156] (648s left) kms_chamelium_hpd (vga-hpd-for-each-pipe) [371.673511] Subtest vga-hpd-for-each-pipe: SKIP (0.000s) [372.538610] [081/156] (647s left) gem_media_vme [372.662063] [082/156] (647s left) perf (polling-parameterized) [372.747498] Starting subtest: polling-parameterized [392.765865] Subtest polling-parameterized: SUCCESS (20.012s) [392.817013] [083/156] (627s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [392.933650] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc [392.937856] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [393.020817] [084/156] (627s left) kms_force_connector_basic (force-edid) [393.103836] Starting subtest: force-edid [393.470482] Subtest force-edid: SUCCESS (0.369s) [393.607749] [085/156] (626s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render) [393.705021] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render [393.709316] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [393.797071] [086/156] (626s left) kms_plane_multiple (2x-tiling-yf) [393.892953] Starting subtest: 2x-tiling-yf [393.896603] Subtest 2x-tiling-yf: SKIP (0.000s) [393.964750] [087/156] (626s left) kms_color (ctm-signed) [394.056159] Starting subtest: ctm-signed [394.057803] Starting dynamic subtest: pipe-A-eDP-1 [396.136757] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.080s) [396.147665] Starting dynamic subtest: pipe-B-eDP-1 [398.939222] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.801s) [398.951440] Starting dynamic subtest: pipe-C-eDP-1 [401.684738] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.743s) [401.695456] Starting dynamic subtest: pipe-D-eDP-1 [404.383649] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.695s) [404.385940] Subtest ctm-signed: SUCCESS (10.325s) [405.191550] [088/156] (615s left) kms_psr (fbc-psr-sprite-plane-move) [405.280098] Starting subtest: fbc-psr-sprite-plane-move [405.282436] Starting dynamic subtest: eDP-1 [405.286834] Dynamic subtest eDP-1: SKIP (0.000s) [405.291124] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s) [405.365861] [089/156] (615s left) kms_flip (busy-flip) [405.457901] Starting subtest: busy-flip [405.459825] Starting dynamic subtest: A-eDP1 [407.168651] Dynamic subtest A-eDP1: SUCCESS (1.712s) [407.184378] Starting dynamic subtest: B-eDP1 [408.869478] Dynamic subtest B-eDP1: SUCCESS (1.697s) [408.882723] Starting dynamic subtest: C-eDP1 [410.547937] Dynamic subtest C-eDP1: SUCCESS (1.677s) [410.560082] Starting dynamic subtest: D-eDP1 [412.255895] Dynamic subtest D-eDP1: SUCCESS (1.706s) [412.261351] Subtest busy-flip: SUCCESS (6.803s) [413.492260] [090/156] (607s left) gem_exec_params (rsvd2-dirt) [413.556140] Starting subtest: rsvd2-dirt [413.560525] Subtest rsvd2-dirt: SKIP (0.000s) [413.661226] [091/156] (606s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-mmap-wc) [413.759642] Starting subtest: fbcpsrhdr-rgb101010-draw-mmap-wc [413.763861] Subtest fbcpsrhdr-rgb101010-draw-mmap-wc: SKIP (0.000s) [413.868974] [092/156] (606s left) i915_pciid [413.999977] [093/156] (606s left) kms_invalid_mode (bad-vsync-start) [414.093441] Starting subtest: bad-vsync-start [414.095865] Starting dynamic subtest: pipe-A-eDP-1 [414.376103] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s) [414.386403] Starting dynamic subtest: pipe-B-eDP-1 [414.388314] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [414.398845] Starting dynamic subtest: pipe-C-eDP-1 [414.401066] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [414.411980] Starting dynamic subtest: pipe-D-eDP-1 [414.414362] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [414.416643] Subtest bad-vsync-start: SUCCESS (0.290s) [415.182170] [094/156] (605s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-pwrite) [415.284193] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-pwrite [415.288448] Subtest psrhdr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [415.365818] [095/156] (605s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [415.466748] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt [415.470899] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [415.547599] [096/156] (605s left) sw_sync (sync_busy_fork_unixsocket) [415.582553] Starting subtest: sync_busy_fork_unixsocket [415.587353] Subtest sync_busy_fork_unixsocket: SUCCESS (0.006s) [415.647280] [097/156] (605s left) gem_sync (basic-all) [415.720243] Starting subtest: basic-all [417.789177] Subtest basic-all: SUCCESS (2.079s) [417.978245] [098/156] (602s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-blt) [418.080502] Starting subtest: fbchdr-rgb565-draw-blt [418.084984] Subtest fbchdr-rgb565-draw-blt: SKIP (0.000s) [418.178044] [099/156] (602s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-mmap-wc) [418.275056] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-mmap-wc [418.278992] Subtest hdr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [418.368495] [100/156] (602s left) gem_fenced_exec_thrash (no-spare-fences) [418.429763] Subtest no-spare-fences: SKIP (0.000s) [418.508213] [101/156] (602s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-blt) [418.594943] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-blt [418.599307] Subtest fbchdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [418.687804] [102/156] (602s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-render) [418.782722] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-render [418.788456] Subtest hdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [418.876943] [103/156] (602s left) kms_big_fb (4-tiled-32bpp-rotate-90) [418.963540] Starting subtest: 4-tiled-32bpp-rotate-90 [418.983116] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s) [419.088397] [104/156] (602s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite) [419.186127] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite [419.189456] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [419.293670] [105/156] (601s left) gem_exec_schedule (preempt-other-chain) [419.355242] Starting subtest: preempt-other-chain [419.356899] Starting dynamic subtest: rcs0 [419.441983] Dynamic subtest rcs0: SUCCESS (0.088s) [419.456375] Starting dynamic subtest: bcs0 [419.522605] Dynamic subtest bcs0: SUCCESS (0.079s) [419.537618] Starting dynamic subtest: vcs0 [419.601523] Dynamic subtest vcs0: SUCCESS (0.079s) [419.612517] Starting dynamic subtest: vcs1 [419.684376] Dynamic subtest vcs1: SUCCESS (0.081s) [419.699395] Starting dynamic subtest: vecs0 [419.773257] Dynamic subtest vecs0: SUCCESS (0.088s) [419.784762] Starting dynamic subtest: ccs0 [419.859325] Dynamic subtest ccs0: SUCCESS (0.085s) [419.861602] Subtest preempt-other-chain: SUCCESS (0.506s) [420.940376] [106/156] (600s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation) [421.037272] Starting subtest: plane-downscale-factor-0-75-with-rotation [421.039523] Starting dynamic subtest: pipe-A [421.265518] Dynamic subtest pipe-A: SUCCESS (0.231s) [421.276416] Starting dynamic subtest: pipe-B [422.534038] Dynamic subtest pipe-B: SUCCESS (1.267s) [422.545458] Starting dynamic subtest: pipe-C [423.842107] Dynamic subtest pipe-C: SUCCESS (1.307s) [423.852704] Starting dynamic subtest: pipe-D [425.156838] Dynamic subtest pipe-D: SUCCESS (1.314s) [425.159146] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.122s) [426.289217] [107/156] (595s left) gem_partial_pwrite_pread (reads-snoop) [426.348591] Subtest reads-snoop: SKIP (0.000s) [426.414785] [108/156] (594s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-mmap-cpu) [426.513475] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-mmap-cpu [426.517628] Subtest fbchdr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [426.619527] [109/156] (594s left) sysfs_heartbeat_interval (idempotent) [426.675371] Starting subtest: idempotent [426.677817] Starting dynamic subtest: vecs0 [426.680208] Dynamic subtest vecs0: SUCCESS (0.001s) [426.691725] Starting dynamic subtest: ccs0 [426.694038] Dynamic subtest ccs0: SUCCESS (0.001s) [426.703581] Starting dynamic subtest: vcs0 [426.705850] Dynamic subtest vcs0: SUCCESS (0.000s) [426.715853] Starting dynamic subtest: bcs0 [426.718019] Dynamic subtest bcs0: SUCCESS (0.001s) [426.727765] Starting dynamic subtest: rcs0 [426.729699] Dynamic subtest rcs0: SUCCESS (0.001s) [426.740087] Starting dynamic subtest: vcs1 [426.742317] Dynamic subtest vcs1: SUCCESS (0.000s) [426.744502] Subtest idempotent: SUCCESS (0.008s) [426.794095] [110/156] (594s left) kms_plane_scaling (planes-upscale-factor-0-25) [426.886000] Starting subtest: planes-upscale-factor-0-25 [426.888364] Starting dynamic subtest: pipe-A [426.945816] Dynamic subtest pipe-A: SUCCESS (0.062s) [426.958422] Starting dynamic subtest: pipe-B [428.086477] Dynamic subtest pipe-B: SUCCESS (1.140s) [428.098935] Starting dynamic subtest: pipe-C [429.251306] Dynamic subtest pipe-C: SUCCESS (1.164s) [429.261826] Starting dynamic subtest: pipe-D [430.366441] Dynamic subtest pipe-D: SUCCESS (1.114s) [430.368829] Subtest planes-upscale-factor-0-25: SUCCESS (3.485s) [431.582240] [111/156] (589s left) kms_multipipe_modeset (basic-max-pipe-crc-check) [431.677747] Starting subtest: basic-max-pipe-crc-check [431.681925] Subtest basic-max-pipe-crc-check: SKIP (0.000s) [431.725520] [112/156] (589s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-pwrite) [431.822249] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-pwrite [431.826752] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [431.911640] [113/156] (589s left) gem_exec_reloc (basic-gtt-cpu) [431.973122] Subtest basic-gtt-cpu: SKIP (0.000s) [432.186478] [114/156] (589s left) gem_fence_thrash (bo-write-verify-threaded-x) [432.219740] Starting subtest: bo-write-verify-threaded-x [432.240224] Subtest bo-write-verify-threaded-x: SKIP (0.019s) [432.303573] [115/156] (589s left) gem_exec_fence (syncobj-timeline-chain-engines) [432.849423] Starting subtest: syncobj-timeline-chain-engines [432.974540] Subtest syncobj-timeline-chain-engines: SUCCESS (0.123s) [433.906459] [116/156] (587s left) dmabuf_sync_file (export-before-signal) [433.957625] Starting subtest: export-before-signal [433.959882] Subtest export-before-signal: SUCCESS (0.000s) [434.015455] [117/156] (587s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-shrfb-msflip-blt) [434.120091] Starting subtest: fbcpsrhdr-2p-primscrn-shrfb-msflip-blt [434.124445] Subtest fbcpsrhdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [434.228433] [118/156] (587s left) kms_hdr (static-toggle-dpms) [434.320018] Starting subtest: static-toggle-dpms [434.322348] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010 [434.326737] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s) [434.338111] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F [434.342191] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s) [434.346695] Subtest static-toggle-dpms: SKIP (0.003s) [434.397038] [119/156] (587s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt) [434.491299] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt [434.495580] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [434.592004] [120/156] (587s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu) [434.688930] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu [434.693028] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [434.795269] [121/156] (587s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt) [434.886270] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt [434.889932] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [434.998651] [122/156] (587s left) gem_exec_schedule (timeslicing) [435.066600] Starting subtest: timeslicing [435.068475] Starting dynamic subtest: rcs0 [435.082548] Dynamic subtest rcs0: SUCCESS (0.022s) [435.095055] Starting dynamic subtest: bcs0 [435.103212] Dynamic subtest bcs0: SUCCESS (0.020s) [435.113831] Starting dynamic subtest: vcs0 [435.124792] Dynamic subtest vcs0: SUCCESS (0.021s) [435.134462] Starting dynamic subtest: vcs1 [435.146136] Dynamic subtest vcs1: SUCCESS (0.021s) [435.155920] Starting dynamic subtest: vecs0 [435.169583] Dynamic subtest vecs0: SUCCESS (0.023s) [435.179361] Starting dynamic subtest: ccs0 [435.192885] Dynamic subtest ccs0: SUCCESS (0.022s) [435.194837] Subtest timeslicing: SUCCESS (0.133s) [436.875460] [123/156] (585s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu) [436.974478] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu [436.979150] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [437.082173] [124/156] (585s left) gem_mmap_offset (bad-extensions) [437.138337] Starting subtest: bad-extensions [437.140230] Subtest bad-extensions: SUCCESS (0.000s) [437.237224] [125/156] (584s left) kms_psr (fbc-pr-basic) [437.329818] Starting subtest: fbc-pr-basic [437.334306] Subtest fbc-pr-basic: SKIP (0.000s) [437.405825] [126/156] (584s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-shrfb-plflip-blt) [437.509493] Starting subtest: fbchdr-2p-primscrn-shrfb-plflip-blt [437.513439] Subtest fbchdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [437.600197] [127/156] (584s left) kms_pm_rpm (system-suspend-idle) [439.123840] Starting subtest: system-suspend-idle [458.603561] Subtest system-suspend-idle: SUCCESS (4.626s) [459.001328] [128/156] (563s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area) [459.100129] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area [459.102774] Starting dynamic subtest: pipe-A-eDP-1 [459.233552] Dynamic subtest pipe-A-eDP-1: SKIP (0.133s) [459.247149] Starting dynamic subtest: pipe-B-eDP-1 [460.464047] Dynamic subtest pipe-B-eDP-1: SKIP (1.219s) [460.469158] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.355s) [461.723292] [129/156] (560s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render) [461.833617] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render [468.723801] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.866s) [468.878941] [130/156] (553s left) kms_cursor_crc (cursor-suspend) [469.011166] Starting subtest: cursor-suspend [469.013799] Starting dynamic subtest: pipe-A-eDP-1 [501.516799] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.103s) [501.530870] Starting dynamic subtest: pipe-D-eDP-1 [535.504296] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.769s) [535.506500] Subtest cursor-suspend: SUCCESS (6.874s) [536.385407] [131/156] (486s left) kms_plane_lowres (tiling-4) [536.482485] Starting subtest: tiling-4 [536.484877] Starting dynamic subtest: pipe-A-eDP-1 [536.489638] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [536.782609] Starting dynamic subtest: pipe-B-eDP-1 [536.787324] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [536.797827] Starting dynamic subtest: pipe-C-eDP-1 [536.802504] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [536.813521] Starting dynamic subtest: pipe-D-eDP-1 [536.817826] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [536.822139] Subtest tiling-4: SKIP (0.300s) [537.603400] [132/156] (484s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-render) [537.707953] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-render [537.711996] Subtest hdr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [537.834318] [133/156] (484s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted) [537.895161] Starting subtest: etime-single-wait-all-for-submit-submitted [537.998667] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.101s) [538.077145] [134/156] (484s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc) [538.178570] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc [538.180852] Starting dynamic subtest: pipe-A-eDP-1 [554.247622] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.369s) [554.258619] Starting dynamic subtest: pipe-B-eDP-1 [571.224995] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.349s) [571.235756] Starting dynamic subtest: pipe-C-eDP-1 [588.190739] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.378s) [588.204094] Starting dynamic subtest: pipe-D-eDP-1 [605.214079] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.405s) [605.216552] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (8.506s) [606.411798] [135/156] (416s left) kms_vblank (ts-continuation-modeset) [606.509422] Starting subtest: ts-continuation-modeset [606.511717] Starting dynamic subtest: pipe-A-eDP-1 [608.031913] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.510s) [608.046915] Starting dynamic subtest: pipe-D-eDP-1 [610.231650] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.183s) [610.234018] Subtest ts-continuation-modeset: SUCCESS (3.696s) [611.116576] [136/156] (411s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [611.214982] Starting subtest: addfb25-yf-tiled-legacy [611.217104] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [611.315251] [137/156] (411s left) kms_big_fb (x-tiled-8bpp-rotate-270) [611.412752] Starting subtest: x-tiled-8bpp-rotate-270 [611.434206] Subtest x-tiled-8bpp-rotate-270: SKIP (0.021s) [611.537982] [138/156] (411s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip) [611.636782] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip [611.641305] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [611.734711] [139/156] (411s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt) [611.840812] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt [611.845367] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [611.933539] [140/156] (410s left) kms_scaling_modes (scaling-mode-full-aspect) [612.037051] Starting subtest: scaling-mode-full-aspect [612.039239] Starting dynamic subtest: pipe-A-eDP-1 [612.128794] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.094s) [612.140005] Starting dynamic subtest: pipe-B-eDP-1 [613.309142] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.173s) [613.324830] Starting dynamic subtest: pipe-C-eDP-1 [614.489040] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.173s) [614.502857] Starting dynamic subtest: pipe-D-eDP-1 [615.716619] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.220s) [615.718927] Subtest scaling-mode-full-aspect: SUCCESS (3.670s) [616.935584] [141/156] (405s left) gem_eio (wait-1us) [617.172071] Starting subtest: wait-1us [617.539009] Subtest wait-1us: SUCCESS (0.368s) [617.679985] [142/156] (405s left) i915_pm_sseu (full-enable) [617.734117] Subtest full-enable: SKIP (0.000s) [617.833226] [143/156] (405s left) syncobj_basic (bad-pad-fd-to-handle) [617.894993] Starting subtest: bad-pad-fd-to-handle [617.896816] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [617.980367] [144/156] (405s left) gem_flink_basic (basic) [618.038394] Starting subtest: basic [618.040147] Subtest basic: SUCCESS (0.000s) [618.162698] [145/156] (404s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled) [618.219161] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled [618.222862] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s) [618.403358] [146/156] (404s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt) [618.510263] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt [625.202585] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.690s) [625.341003] [147/156] (397s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-pwrite) [625.447765] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-pwrite [625.451984] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [625.560318] [148/156] (397s left) kms_big_fb (yf-tiled-32bpp-rotate-0) [625.668944] Starting subtest: yf-tiled-32bpp-rotate-0 [625.673470] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s) [625.771849] [149/156] (397s left) drm_read (short-buffer-nonblock) [625.935412] Starting subtest: short-buffer-nonblock [625.937332] Subtest short-buffer-nonblock: SUCCESS (0.000s) [626.060880] [150/156] (397s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf) [626.145652] Starting subtest: fbc-pr-cursor-plane-update-sf [626.148887] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s) [626.218290] [151/156] (397s left) gem_mmap_gtt (basic-write) [626.270567] Subtest basic-write: SKIP (0.000s) [626.323389] [152/156] (397s left) kms_cursor_crc (cursor-rapid-movement-512x170) [626.628920] Starting subtest: cursor-rapid-movement-512x170 [626.632367] Subtest cursor-rapid-movement-512x170: SKIP (0.001s) [626.769575] [153/156] (396s left) gem_create (create-ext-cpu-access-sanity-check) [626.933015] Starting subtest: create-ext-cpu-access-sanity-check [626.937215] Subtest create-ext-cpu-access-sanity-check: SKIP (0.000s) [627.002094] [154/156] (396s left) kms_atomic_transition (modeset-transition-nonblocking) [627.096940] Starting subtest: modeset-transition-nonblocking [627.099165] Starting dynamic subtest: 1x-outputs [638.233436] Dynamic subtest 1x-outputs: SUCCESS (11.129s) [638.235967] Subtest modeset-transition-nonblocking: SUCCESS (11.131s) [639.061707] [155/156] (384s left) gem_bad_reloc (negative-reloc-lut) [639.130507] Subtest negative-reloc-lut: SKIP (0.000s) [639.210677] [156/156] (384s left) gem_exec_gttfill (engines) [639.269615] Starting subtest: engines [639.272210] Starting dynamic subtest: rcs0 [662.205358] Dynamic subtest rcs0: SUCCESS (22.923s) [662.216719] Starting dynamic subtest: bcs0 [685.556086] Dynamic subtest bcs0: SUCCESS (23.336s) [685.566730] Starting dynamic subtest: vcs0 [708.866367] Dynamic subtest vcs0: SUCCESS (23.309s) [708.877370] Starting dynamic subtest: vcs1 [732.176877] Dynamic subtest vcs1: SUCCESS (23.319s) [732.188316] Starting dynamic subtest: vecs0 [755.493544] Dynamic subtest vecs0: SUCCESS (23.316s) [755.505909] Starting dynamic subtest: ccs0 [778.859082] Dynamic subtest ccs0: SUCCESS (23.359s) [778.861930] Subtest engines: SUCCESS (139.573s) [779.045768] Closing watchdogs results: parsing output: 0/ for test: kms_flip results: parsing output: 1/ for test: gem_exec_whisper results: parsing output: 2/ for test: syncobj_timeline results: parsing output: 3/ for test: kms_pm_rpm results: parsing output: 4/ for test: sw_sync results: parsing output: 5/ for test: gem_ctx_persistence results: parsing output: 6/ for test: kms_frontbuffer_tracking results: parsing output: 7/ for test: kms_ccs results: parsing output: 8/ for test: kms_chamelium_frames results: parsing output: 9/ for test: kms_pipe_b_c_ivb results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: gem_softpin results: parsing output: 12/ for test: kms_cursor_crc results: parsing output: 13/ for test: kms_dp_linktrain_fallback results: parsing output: 14/ for test: gem_ctx_shared results: parsing output: 15/ for test: kms_cursor_legacy results: parsing output: 16/ for test: kms_big_fb results: parsing output: 17/ for test: syncobj_basic results: parsing output: 18/ for test: kms_flip results: parsing output: 19/ for test: gem_pxp results: parsing output: 20/ for test: kms_vrr results: parsing output: 21/ for test: kms_flip results: parsing output: 22/ for test: kms_fence_pin_leak results: parsing output: 23/ for test: kms_fb_coherency results: parsing output: 24/ for test: kms_ccs results: parsing output: 25/ for test: gen7_exec_parse results: parsing output: 26/ for test: syncobj_wait results: parsing output: 27/ for test: kms_getfb results: parsing output: 28/ for test: perf results: parsing output: 29/ for test: gem_exec_fence results: parsing output: 30/ for test: gem_exec_params results: parsing output: 31/ for test: kms_plane results: parsing output: 32/ for test: gem_ctx_persistence results: parsing output: 33/ for test: i915_drm_fdinfo results: parsing output: 34/ for test: kms_psr results: parsing output: 35/ for test: kms_ccs results: parsing output: 36/ for test: syncobj_timeline results: parsing output: 37/ for test: gem_exec_balancer results: parsing output: 38/ for test: kms_psr results: parsing output: 39/ for test: kms_flip_scaled_crc results: parsing output: 40/ for test: gem_exec_fence results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: gem_wait results: parsing output: 43/ for test: kms_frontbuffer_tracking results: parsing output: 44/ for test: kms_frontbuffer_tracking results: parsing output: 45/ for test: gem_readwrite results: parsing output: 46/ for test: kms_big_fb results: parsing output: 47/ for test: kms_universal_plane results: parsing output: 48/ for test: kms_frontbuffer_tracking results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: kms_frontbuffer_tracking results: parsing output: 51/ for test: i915_pm_rps results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: kms_flip results: parsing output: 56/ for test: kms_cursor_legacy results: parsing output: 57/ for test: api_intel_allocator results: parsing output: 58/ for test: gem_mmap_gtt results: parsing output: 59/ for test: kms_plane_scaling results: parsing output: 60/ for test: gem_lmem_swapping results: parsing output: 61/ for test: syncobj_timeline results: parsing output: 62/ for test: kms_psr results: parsing output: 63/ for test: kms_frontbuffer_tracking results: parsing output: 64/ for test: gem_pxp results: parsing output: 65/ for test: perf results: parsing output: 66/ for test: kms_frontbuffer_tracking results: parsing output: 67/ for test: kms_flip results: parsing output: 68/ for test: syncobj_timeline results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: kms_atomic_transition results: parsing output: 71/ for test: api_intel_bb results: parsing output: 72/ for test: kms_ccs results: parsing output: 73/ for test: kms_chamelium_color results: parsing output: 74/ for test: kms_cursor_legacy results: parsing output: 75/ for test: syncobj_wait results: parsing output: 76/ for test: syncobj_eventfd results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: kms_content_protection results: parsing output: 79/ for test: kms_chamelium_hpd results: parsing output: 80/ for test: gem_media_vme results: parsing output: 81/ for test: perf results: parsing output: 82/ for test: kms_frontbuffer_tracking results: parsing output: 83/ for test: kms_force_connector_basic results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: kms_plane_multiple results: parsing output: 86/ for test: kms_color results: parsing output: 87/ for test: kms_psr results: parsing output: 88/ for test: kms_flip results: parsing output: 89/ for test: gem_exec_params results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: i915_pciid results: parsing output: 92/ for test: kms_invalid_mode results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: sw_sync results: parsing output: 96/ for test: gem_sync results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: gem_fenced_exec_thrash results: parsing output: 100/ for test: kms_frontbuffer_tracking results: parsing output: 101/ for test: kms_frontbuffer_tracking results: parsing output: 102/ for test: kms_big_fb results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: gem_exec_schedule results: parsing output: 105/ for test: kms_plane_scaling results: parsing output: 106/ for test: gem_partial_pwrite_pread results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: sysfs_heartbeat_interval results: parsing output: 109/ for test: kms_plane_scaling results: parsing output: 110/ for test: kms_multipipe_modeset results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: gem_exec_reloc results: parsing output: 113/ for test: gem_fence_thrash results: parsing output: 114/ for test: gem_exec_fence results: parsing output: 115/ for test: dmabuf_sync_file results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: kms_hdr results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: kms_frontbuffer_tracking results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: gem_exec_schedule results: parsing output: 122/ for test: kms_frontbuffer_tracking results: parsing output: 123/ for test: gem_mmap_offset results: parsing output: 124/ for test: kms_psr results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: kms_pm_rpm results: parsing output: 127/ for test: kms_psr2_sf results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: kms_cursor_crc results: parsing output: 130/ for test: kms_plane_lowres results: parsing output: 131/ for test: kms_frontbuffer_tracking results: parsing output: 132/ for test: syncobj_timeline results: parsing output: 133/ for test: kms_ccs results: parsing output: 134/ for test: kms_vblank results: parsing output: 135/ for test: kms_addfb_basic results: parsing output: 136/ for test: kms_big_fb results: parsing output: 137/ for test: kms_big_fb results: parsing output: 138/ for test: kms_frontbuffer_tracking results: parsing output: 139/ for test: kms_scaling_modes results: parsing output: 140/ for test: gem_eio results: parsing output: 141/ for test: i915_pm_sseu results: parsing output: 142/ for test: syncobj_basic results: parsing output: 143/ for test: gem_flink_basic results: parsing output: 144/ for test: gem_render_copy results: parsing output: 145/ for test: kms_frontbuffer_tracking results: parsing output: 146/ for test: kms_frontbuffer_tracking results: parsing output: 147/ for test: kms_big_fb results: parsing output: 148/ for test: drm_read results: parsing output: 149/ for test: kms_psr2_sf results: parsing output: 150/ for test: gem_mmap_gtt results: parsing output: 151/ for test: kms_cursor_crc results: parsing output: 152/ for test: gem_create results: parsing output: 153/ for test: kms_atomic_transition results: parsing output: 154/ for test: gem_bad_reloc results: parsing output: 155/ for test: gem_exec_gttfill Done.