[129.942438] Initializing watchdogs [129.942604] /dev/watchdog0 [129.981821] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600] [129.996562] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [130.004470] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [130.010238] [001/133] (960s left) gem_lmem_swapping (parallel-random-verify) [130.142996] Subtest parallel-random-verify: SKIP (0.000s) [130.237122] [002/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move) [130.428058] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move [130.432392] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [130.594204] [003/133] (960s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier) [130.767354] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier [130.770906] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s) [130.926885] [004/133] (959s left) gem_exec_suspend (basic-s0) [131.050693] Starting subtest: basic-S0 [131.052373] Starting dynamic subtest: smem [153.270913] Dynamic subtest smem: SUCCESS (7.598s) [153.273593] Subtest basic-S0: SUCCESS (7.599s) [163.550209] [005/133] (937s left) gem_ctx_sseu (invalid-sseu) [163.668631] Subtest invalid-sseu: SKIP (0.000s) [163.763319] [006/133] (937s left) kms_psr (psr2-sprite-mmap-gtt) [163.948288] Subtest psr2-sprite-mmap-gtt: SKIP (0.000s) [164.045054] [007/133] (936s left) gem_exec_basic (basic) [164.156626] Starting subtest: basic [164.158233] Starting dynamic subtest: rcs0-smem [164.159784] Dynamic subtest rcs0-smem: SUCCESS (0.005s) [164.177950] Starting dynamic subtest: bcs0-smem [164.179583] Dynamic subtest bcs0-smem: SUCCESS (0.007s) [164.198876] Starting dynamic subtest: vcs0-smem [164.201656] Dynamic subtest vcs0-smem: SUCCESS (0.002s) [164.232046] Starting dynamic subtest: vecs0-smem [164.234674] Dynamic subtest vecs0-smem: SUCCESS (0.003s) [164.236653] Subtest basic: SUCCESS (0.022s) [164.451779] [008/133] (936s left) gem_exec_schedule (preempt-other-chain) [164.587302] Starting subtest: preempt-other-chain [164.589002] Starting dynamic subtest: rcs0 [164.683153] Dynamic subtest rcs0: SUCCESS (0.092s) [164.703721] Starting dynamic subtest: bcs0 [164.764189] Dynamic subtest bcs0: SUCCESS (0.082s) [164.782134] Starting dynamic subtest: vcs0 [164.842570] Dynamic subtest vcs0: SUCCESS (0.076s) [164.860352] Starting dynamic subtest: vecs0 [164.927488] Dynamic subtest vecs0: SUCCESS (0.078s) [164.929989] Subtest preempt-other-chain: SUCCESS (0.334s) [165.323740] [009/133] (935s left) kms_cursor_crc (cursor-rapid-movement-128x128) [165.519420] Starting subtest: cursor-rapid-movement-128x128 [165.581792] Starting dynamic subtest: pipe-A-HDMI-A-1 [166.553836] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.970s) [166.659683] Starting dynamic subtest: pipe-C-HDMI-A-1 [167.189334] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.570s) [167.192495] Subtest cursor-rapid-movement-128x128: SUCCESS (1.666s) [167.527311] [010/133] (933s left) kms_fbcon_fbt (fbc) [167.638549] Starting subtest: fbc [171.753865] Subtest fbc: SUCCESS (4.107s) [171.853441] [011/133] (929s left) perf_pmu (busy-double-start) [171.960522] Starting subtest: busy-double-start [171.962706] Starting dynamic subtest: rcs0 [175.507818] Dynamic subtest rcs0: SUCCESS (3.544s) [175.530575] Starting dynamic subtest: bcs0 [179.058671] Dynamic subtest bcs0: SUCCESS (3.544s) [179.081710] Starting dynamic subtest: vcs0 [182.611489] Dynamic subtest vcs0: SUCCESS (3.545s) [182.631919] Starting dynamic subtest: vecs0 [186.159388] Dynamic subtest vecs0: SUCCESS (3.544s) [186.163085] Subtest busy-double-start: SUCCESS (14.187s) [186.330681] [012/133] (915s left) gem_lmem_swapping (parallel-multi) [186.439796] Subtest parallel-multi: SKIP (0.000s) [186.544392] [013/133] (914s left) gem_ctx_persistence (heartbeat-close) [186.651162] Starting subtest: heartbeat-close [186.784530] Subtest heartbeat-close: SUCCESS (0.132s) [186.964136] [014/133] (914s left) vgem_basic (dmabuf-export) [187.139746] Starting subtest: dmabuf-export [187.146592] Subtest dmabuf-export: SUCCESS (0.010s) [187.304612] [FACT vgem_basic (dmabuf-export)] new: kernel.kmod_is_loaded.vgem: true [187.309471] [015/133] (914s left) kms_atomic_transition (modeset-transition-nonblocking-fencing) [187.495254] Starting subtest: modeset-transition-nonblocking-fencing [187.497557] Starting dynamic subtest: 1x-outputs [191.022918] Dynamic subtest 1x-outputs: SUCCESS (3.530s) [191.044532] Starting dynamic subtest: 2x-outputs [198.382669] Dynamic subtest 2x-outputs: SUCCESS (7.360s) [198.384847] Subtest modeset-transition-nonblocking-fencing: SUCCESS (10.892s) [198.685973] [016/133] (903s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu) [198.881836] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu [201.326948] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (2.443s) [201.615246] [017/133] (900s left) i915_hangman (engine-engine-error) [201.742237] Starting subtest: engine-engine-error [201.744820] Starting dynamic subtest: rcs0 [201.820433] Dynamic subtest rcs0: SUCCESS (0.078s) [201.840535] Starting dynamic subtest: bcs0 [201.846482] Dynamic subtest bcs0: SKIP (0.008s) [201.866783] Starting dynamic subtest: vcs0 [201.929550] Dynamic subtest vcs0: SUCCESS (0.099s) [201.951623] Starting dynamic subtest: vecs0 [201.997169] Dynamic subtest vecs0: SUCCESS (0.067s) [201.998861] Subtest engine-engine-error: SUCCESS (0.258s) [202.186724] [018/133] (899s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping) [202.357636] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping [202.362592] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s) [202.516678] [019/133] (899s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render) [202.708604] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render [204.730043] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SUCCESS (2.022s) [204.967583] [020/133] (897s left) kms_big_fb (x-tiled-32bpp-rotate-180) [205.162642] Starting subtest: x-tiled-32bpp-rotate-180 [208.809499] Subtest x-tiled-32bpp-rotate-180: SUCCESS (3.644s) [209.230492] [021/133] (893s left) kms_getfb (getfb-handle-protection) [209.403424] Starting subtest: getfb-handle-protection [209.438072] Subtest getfb-handle-protection: SUCCESS (0.039s) [209.597221] [022/133] (892s left) gem_mmap_gtt (basic-small-bo-tiledx) [209.700012] Starting subtest: basic-small-bo-tiledX [210.494505] Subtest basic-small-bo-tiledX: SUCCESS (0.788s) [210.703927] [023/133] (891s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt) [211.046301] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt [211.052337] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [211.234276] [024/133] (891s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted) [211.355644] Starting subtest: etime-single-wait-for-submit-available-unsubmitted [211.466001] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.106s) [211.620474] [025/133] (891s left) gem_mmap_wc (write-read) [211.720454] Starting subtest: write-read [211.728107] Subtest write-read: SUCCESS (0.009s) [211.898496] [026/133] (890s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0) [212.092038] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0 [213.792995] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.698s) [214.078571] [027/133] (888s left) gem_exec_create (madvise) [214.200345] Starting subtest: madvise [214.201891] Starting dynamic subtest: smem [234.382402] Dynamic subtest smem: SUCCESS (20.159s) [234.388573] Subtest madvise: SUCCESS (20.160s) [235.758723] [028/133] (867s left) gem_mmap_gtt (basic-write) [235.853507] Starting subtest: basic-write [236.256072] Subtest basic-write: SUCCESS (0.404s) [236.420053] [029/133] (866s left) kms_psr (psr-primary-render) [236.602899] Subtest psr-primary-render: SKIP (0.000s) [236.713168] [030/133] (866s left) sysfs_preempt_timeout (idempotent) [236.817507] Starting subtest: idempotent [236.822892] Starting dynamic subtest: vecs0 [236.824419] Dynamic subtest vecs0: SUCCESS (0.002s) [236.845801] Starting dynamic subtest: vcs0 [236.847519] Dynamic subtest vcs0: SUCCESS (0.003s) [236.869673] Starting dynamic subtest: bcs0 [236.872014] Dynamic subtest bcs0: SUCCESS (0.004s) [236.894657] Starting dynamic subtest: rcs0 [236.897013] Dynamic subtest rcs0: SUCCESS (0.002s) [236.900158] Subtest idempotent: SUCCESS (0.020s) [237.025222] [031/133] (866s left) kms_big_fb (y-tiled-16bpp-rotate-90) [237.213740] Starting subtest: y-tiled-16bpp-rotate-90 [237.497878] Subtest y-tiled-16bpp-rotate-90: SKIP (0.283s) [237.766291] [032/133] (865s left) kms_psr (fbc-psr-cursor-plane-onoff) [237.949160] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s) [238.060263] [033/133] (865s left) kms_tiled_display (basic-test-pattern-with-chamelium) [238.349789] Starting subtest: basic-test-pattern-with-chamelium [238.352898] Subtest basic-test-pattern-with-chamelium: SKIP (0.001s) [238.541607] [034/133] (865s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling) [238.690409] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling [238.732959] Starting dynamic subtest: pipe-A-valid-mode [239.609961] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.917s) [239.612107] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SUCCESS (0.923s) [239.916097] [035/133] (863s left) syncobj_timeline (invalid-signal-bad-pad) [240.021160] Starting subtest: invalid-signal-bad-pad [240.023070] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [240.182942] [036/133] (863s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc) [240.323080] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc [240.325429] Starting dynamic subtest: pipe-A-HDMI-A-1 [240.331604] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s) [240.434702] Starting dynamic subtest: pipe-A-HDMI-A-2 [240.440707] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s) [240.462488] Starting dynamic subtest: pipe-B-HDMI-A-1 [240.468320] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.021s) [240.490056] Starting dynamic subtest: pipe-B-HDMI-A-2 [240.495648] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s) [240.517434] Starting dynamic subtest: pipe-C-HDMI-A-1 [240.523242] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s) [240.545038] Starting dynamic subtest: pipe-C-HDMI-A-2 [240.550767] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s) [240.554327] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SKIP (0.045s) [241.312465] [037/133] (862s left) perf (invalid-remove-userspace-config) [241.568107] Starting subtest: invalid-remove-userspace-config [241.596302] Subtest invalid-remove-userspace-config: SUCCESS (0.027s) [241.702102] [038/133] (862s left) kms_psr (fbc-psr2-primary-mmap-cpu) [241.828596] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.000s) [241.943879] [039/133] (862s left) gem_mmap_gtt (basic) [242.043165] Starting subtest: basic [242.045047] Subtest basic: SUCCESS (0.003s) [242.239203] [040/133] (861s left) core_auth (many-magics) [242.338188] Starting subtest: many-magics [243.436821] Subtest many-magics: SUCCESS (1.100s) [243.616809] [041/133] (860s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt) [243.761730] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt [243.765190] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [243.946231] [042/133] (860s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu) [244.085693] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu [244.089944] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [244.264447] [043/133] (860s left) perf (missing-sample-flags) [244.492617] Starting subtest: missing-sample-flags [244.494480] Subtest missing-sample-flags: SUCCESS (0.001s) [244.604652] [044/133] (859s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs) [244.725154] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs [244.726795] Starting dynamic subtest: pipe-A-HDMI-A-1 [244.744468] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s) [244.809186] Starting dynamic subtest: pipe-A-HDMI-A-2 [244.850290] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s) [244.873536] Starting dynamic subtest: pipe-B-HDMI-A-1 [244.888981] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [244.911585] Starting dynamic subtest: pipe-B-HDMI-A-2 [244.928422] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s) [244.950447] Starting dynamic subtest: pipe-C-HDMI-A-1 [244.964955] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [244.988520] Starting dynamic subtest: pipe-C-HDMI-A-2 [245.003375] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s) [245.006402] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SKIP (0.022s) [245.704874] [045/133] (858s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc) [245.862829] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc [248.646764] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (2.781s) [248.954326] [046/133] (855s left) perf_pmu (faulting-read) [249.064213] Starting subtest: faulting-read [249.066594] Starting dynamic subtest: gtt [249.068899] Dynamic subtest gtt: SUCCESS (0.005s) [249.091616] Starting dynamic subtest: wb [249.094222] Dynamic subtest wb: SUCCESS (0.002s) [249.116107] Starting dynamic subtest: wc [249.117656] Dynamic subtest wc: SUCCESS (0.001s) [249.139667] Starting dynamic subtest: uc [249.142008] Dynamic subtest uc: SUCCESS (0.001s) [249.144562] Subtest faulting-read: SUCCESS (0.014s) [249.257200] [047/133] (855s left) kms_pm_backlight (fade) [249.383076] Subtest fade: SKIP (0.000s) [249.485891] [048/133] (855s left) kms_addfb_basic (bo-too-small-due-to-tiling) [249.615753] Starting subtest: bo-too-small-due-to-tiling [249.617701] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s) [249.790615] [049/133] (855s left) kms_flip (flip-vs-panning-interruptible) [249.933577] Starting subtest: flip-vs-panning-interruptible [249.938190] Starting dynamic subtest: A-HDMI-A1 [255.554536] Dynamic subtest A-HDMI-A1: SUCCESS (5.613s) [255.581227] Starting dynamic subtest: B-HDMI-A1 [260.937583] Dynamic subtest B-HDMI-A1: SUCCESS (5.374s) [260.961165] Starting dynamic subtest: C-HDMI-A1 [266.329194] Dynamic subtest C-HDMI-A1: SUCCESS (5.391s) [266.353895] Starting dynamic subtest: A-HDMI-A2 [271.741698] Dynamic subtest A-HDMI-A2: SUCCESS (5.410s) [271.765885] Starting dynamic subtest: B-HDMI-A2 [277.100796] Dynamic subtest B-HDMI-A2: SUCCESS (5.357s) [277.126184] Starting dynamic subtest: C-HDMI-A2 [282.466995] Dynamic subtest C-HDMI-A2: SUCCESS (5.361s) [282.468596] Subtest flip-vs-panning-interruptible: SUCCESS (32.533s) [282.952289] [050/133] (822s left) gem_exec_reloc (basic-write-cpu-noreloc) [283.071815] Starting subtest: basic-write-cpu-noreloc [283.081222] Subtest basic-write-cpu-noreloc: SUCCESS (0.008s) [283.303284] [051/133] (821s left) gem_mmap_wc (write-wc-read-gtt) [283.402813] Starting subtest: write-wc-read-gtt [283.869013] Subtest write-wc-read-gtt: SUCCESS (0.465s) [284.037745] [052/133] (821s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff) [284.191343] Starting subtest: psr-1p-primscrn-spr-indfb-onoff [284.195415] Subtest psr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s) [284.371243] [053/133] (821s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs) [284.502451] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs [284.512388] Starting dynamic subtest: pipe-A-HDMI-A-1 [284.531809] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.004s) [284.633893] Starting dynamic subtest: pipe-A-HDMI-A-2 [284.674667] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.003s) [284.697429] Starting dynamic subtest: pipe-B-HDMI-A-1 [284.712873] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.003s) [284.735415] Starting dynamic subtest: pipe-B-HDMI-A-2 [284.751436] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.023s) [284.773466] Starting dynamic subtest: pipe-C-HDMI-A-1 [284.787925] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s) [284.809868] Starting dynamic subtest: pipe-C-HDMI-A-2 [284.824428] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.002s) [284.827442] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SKIP (0.067s) [285.515179] [054/133] (819s left) gem_eio (hibernate) [285.652688] Starting subtest: hibernate [300.803238] Subtest hibernate: SUCCESS (15.158s) [308.121399] [055/133] (804s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf) [308.261409] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (0.000s) [308.363955] [056/133] (804s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc) [308.535487] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc [308.572625] Starting dynamic subtest: pipe-A-HDMI-A-1 [308.594750] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.005s) [308.689394] Starting dynamic subtest: pipe-A-HDMI-A-2 [308.706038] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s) [308.730665] Starting dynamic subtest: pipe-B-HDMI-A-1 [308.744940] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s) [308.770088] Starting dynamic subtest: pipe-B-HDMI-A-2 [308.787045] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s) [308.812676] Starting dynamic subtest: pipe-C-HDMI-A-1 [308.827789] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [308.852571] Starting dynamic subtest: pipe-C-HDMI-A-2 [308.868225] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s) [308.871329] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SKIP (0.097s) [309.603272] [057/133] (803s left) gem_exec_schedule (fifo) [309.736540] Starting subtest: fifo [309.738569] Starting dynamic subtest: rcs0 [309.853894] Dynamic subtest rcs0: SUCCESS (0.110s) [309.887689] Starting dynamic subtest: bcs0 [309.994444] Dynamic subtest bcs0: SUCCESS (0.127s) [310.021775] Starting dynamic subtest: vcs0 [310.094439] Dynamic subtest vcs0: SUCCESS (0.110s) [310.119986] Starting dynamic subtest: vecs0 [310.217013] Dynamic subtest vecs0: SUCCESS (0.122s) [310.219603] Subtest fifo: SUCCESS (0.482s) [310.655871] [058/133] (802s left) gem_exec_reloc (basic-range) [310.772233] Starting subtest: basic-range [310.860534] Subtest basic-range: SUCCESS (0.076s) [311.054057] [059/133] (801s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [311.203292] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip [311.208460] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s) [311.386932] [060/133] (801s left) kms_invalid_mode (bad-hsync-start) [311.554285] Starting subtest: bad-hsync-start [311.558048] Starting dynamic subtest: pipe-A-HDMI-A-1 [311.956472] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.418s) [312.015808] Starting dynamic subtest: pipe-A-HDMI-A-2 [312.017395] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.002s) [312.069305] Starting dynamic subtest: pipe-B-HDMI-A-1 [312.070785] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.002s) [312.095862] Starting dynamic subtest: pipe-B-HDMI-A-2 [312.097449] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.002s) [312.122347] Starting dynamic subtest: pipe-C-HDMI-A-1 [312.124048] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.002s) [312.149088] Starting dynamic subtest: pipe-C-HDMI-A-2 [312.151012] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.002s) [312.152466] Subtest bad-hsync-start: SUCCESS (0.460s) [312.307312] [061/133] (800s left) syncobj_timeline (32bits-limit) [312.413584] Starting subtest: 32bits-limit [312.420619] Subtest 32bits-limit: SUCCESS (0.006s) [312.588502] [062/133] (800s left) kms_getfb (getfb-handle-closed) [312.725904] Starting subtest: getfb-handle-closed [312.727927] Subtest getfb-handle-closed: SUCCESS (0.000s) [312.922062] [063/133] (800s left) kms_content_protection (legacy-hdcp14) [313.058682] Starting subtest: legacy-hdcp14 [313.097115] Subtest legacy-hdcp14: SKIP (0.028s) [313.272010] [064/133] (800s left) kms_psr (pr-cursor-render) [313.406706] Subtest pr-cursor-render: SKIP (0.000s) [313.577893] [065/133] (800s left) sriov_basic (enable-vfs-autoprobe-on) [313.691492] Subtest enable-vfs-autoprobe-on: SKIP (0.000s) [313.803575] [066/133] (799s left) kms_frontbuffer_tracking (fbcpsr-1p-rte) [313.943531] Starting subtest: fbcpsr-1p-rte [313.948666] Subtest fbcpsr-1p-rte: SKIP (0.000s) [314.122481] [067/133] (799s left) gem_gtt_cpu_tlb [314.425482] [068/133] (799s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe) [314.917219] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s) [315.192089] [069/133] (798s left) gem_exec_params (invalid-flag) [315.314613] Starting subtest: invalid-flag [315.316228] Subtest invalid-flag: SUCCESS (0.001s) [315.503276] [070/133] (798s left) api_intel_bb (blit-reloc-keep-cache) [315.603411] Starting subtest: blit-reloc-keep-cache [315.623683] Subtest blit-reloc-keep-cache: SUCCESS (0.017s) [315.809137] [071/133] (798s left) prime_vgem (basic-fence-mmap) [315.927249] Starting subtest: basic-fence-mmap [315.990815] Subtest basic-fence-mmap: SUCCESS (0.059s) [316.158832] [072/133] (798s left) kms_addfb_basic (bad-pitch-32) [316.255573] Starting subtest: bad-pitch-32 [316.257270] Subtest bad-pitch-32: SUCCESS (0.000s) [316.476900] [073/133] (798s left) kms_cursor_legacy (single-move) [316.616331] Starting subtest: single-move [316.617980] Starting dynamic subtest: pipe-A [322.019017] Dynamic subtest pipe-A: SUCCESS (5.399s) [322.109547] Starting dynamic subtest: pipe-B [327.432119] Dynamic subtest pipe-B: SUCCESS (5.409s) [327.509748] Starting dynamic subtest: pipe-C [332.844021] Dynamic subtest pipe-C: SUCCESS (5.408s) [332.953319] Starting dynamic subtest: all-pipes [338.257493] Dynamic subtest all-pipes: SUCCESS (5.408s) [338.259945] Subtest single-move: SUCCESS (21.640s) [338.461853] [074/133] (776s left) i915_pm_rps (thresholds-idle) [338.580229] Starting subtest: thresholds-idle [338.584422] Starting dynamic subtest: gt0 [348.822018] Dynamic subtest gt0: SUCCESS (10.241s) [348.824959] Subtest thresholds-idle: SUCCESS (10.246s) [348.994648] [075/133] (765s left) kms_color (deep-color) [349.125159] Starting subtest: deep-color [349.129028] Subtest deep-color: SKIP (0.001s) [349.309845] [076/133] (765s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt) [349.451023] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt [352.384494] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (2.931s) [352.710794] [077/133] (762s left) kms_lease (lease-unleased-crtc) [352.840264] Starting subtest: lease-unleased-crtc [352.843741] Starting dynamic subtest: pipe-A-HDMI-A-1 [353.060473] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.214s) [353.143571] Starting dynamic subtest: pipe-A-HDMI-A-2 [353.145243] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.056s) [353.211837] Starting dynamic subtest: pipe-B-HDMI-A-1 [353.400748] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.248s) [353.444835] Starting dynamic subtest: pipe-B-HDMI-A-2 [353.446784] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.021s) [353.480406] Starting dynamic subtest: pipe-C-HDMI-A-1 [353.483175] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.022s) [353.542773] Starting dynamic subtest: pipe-C-HDMI-A-2 [353.549785] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.070s) [353.551893] Subtest lease-unleased-crtc: SUCCESS (0.709s) [353.880397] [078/133] (761s left) syncobj_timeline (single-wait-all-for-submit-signaled) [353.993732] Starting subtest: single-wait-all-for-submit-signaled [353.996292] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.001s) [354.176550] [079/133] (760s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc) [354.308130] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc [354.317241] Starting dynamic subtest: pipe-A-HDMI-A-1 [354.326841] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s) [354.414336] Starting dynamic subtest: pipe-A-HDMI-A-2 [354.421734] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s) [354.464387] Starting dynamic subtest: pipe-B-HDMI-A-1 [354.470258] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s) [354.496151] Starting dynamic subtest: pipe-B-HDMI-A-2 [354.502072] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s) [354.528344] Starting dynamic subtest: pipe-C-HDMI-A-1 [354.535705] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s) [354.561394] Starting dynamic subtest: pipe-C-HDMI-A-2 [354.567233] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s) [354.570221] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.061s) [355.358514] [080/133] (759s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25) [355.501046] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25 [355.503608] Starting dynamic subtest: pipe-A [355.810759] Dynamic subtest pipe-A: SUCCESS (0.311s) [355.848028] Starting dynamic subtest: pipe-B [356.232379] Dynamic subtest pipe-B: SUCCESS (0.417s) [356.259381] Starting dynamic subtest: pipe-C [356.325630] Dynamic subtest pipe-C: SUCCESS (0.089s) [356.328402] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SUCCESS (0.827s) [356.789488] [081/133] (758s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render) [356.956897] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render [356.960821] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [357.154518] [082/133] (758s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu) [357.312275] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu [359.809310] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (2.496s) [360.125930] [083/133] (755s left) kms_addfb_basic (basic-x-tiled-legacy) [360.235387] Starting subtest: basic-x-tiled-legacy [360.236973] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [360.455422] [084/133] (755s left) gem_ctx_param (invalid-ctx-get) [360.558675] Starting subtest: invalid-ctx-get [360.560731] Subtest invalid-ctx-get: SUCCESS (0.000s) [360.724820] [085/133] (755s left) gem_pxp (hw-rejects-pxp-context) [363.369940] Starting subtest: hw-rejects-pxp-context [363.372310] Subtest hw-rejects-pxp-context: SUCCESS (0.001s) [363.561636] [086/133] (752s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes) [363.664529] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s) [363.782287] [087/133] (752s left) gem_exec_schedule (preempt-queue-contexts-chain) [363.914125] Starting subtest: preempt-queue-contexts-chain [363.915714] Starting dynamic subtest: rcs0 [364.627691] Dynamic subtest rcs0: SUCCESS (0.708s) [364.661028] Starting dynamic subtest: bcs0 [365.396628] Dynamic subtest bcs0: SUCCESS (0.747s) [365.438969] Starting dynamic subtest: vcs0 [366.100677] Dynamic subtest vcs0: SUCCESS (0.723s) [366.143508] Starting dynamic subtest: vecs0 [366.849270] Dynamic subtest vecs0: SUCCESS (0.734s) [366.856449] Subtest preempt-queue-contexts-chain: SUCCESS (2.929s) [367.256558] [088/133] (748s left) kms_plane (plane-panning-bottom-right-suspend) [367.387817] Starting subtest: plane-panning-bottom-right-suspend [367.389666] Starting dynamic subtest: pipe-A