[57.315573] Initializing watchdogs [57.315619] /dev/watchdog0 [57.329987] [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] [57.334661] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.336924] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.340507] [001/133] (960s left) kms_cursor_crc (cursor-onscreen-512x512) [57.670753] Starting subtest: cursor-onscreen-512x512 [57.675448] Subtest cursor-onscreen-512x512: SKIP (0.002s) [57.835981] [002/133] (960s left) gem_exec_whisper (basic-queues-priority-all) [57.911893] Starting subtest: basic-queues-priority-all [80.062212] Subtest basic-queues-priority-all: SUCCESS (22.113s) [80.252292] [003/133] (937s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt) [80.351182] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt [80.355142] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [80.454930] [004/133] (937s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs) [80.536265] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs [80.540507] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s) [81.622740] [005/133] (936s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip) [81.725295] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip [81.729585] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [81.820204] [006/133] (936s left) gem_ctx_param (basic-default) [81.881485] Starting subtest: basic-default [81.883785] Subtest basic-default: SUCCESS (0.000s) [81.953667] [007/133] (936s left) kms_flip (bo-too-big-interruptible) [82.052622] Starting subtest: bo-too-big-interruptible [82.054835] Starting dynamic subtest: A-eDP1 [83.641333] Dynamic subtest A-eDP1: SUCCESS (1.587s) [83.649128] Starting dynamic subtest: B-eDP1 [84.870449] Dynamic subtest B-eDP1: SUCCESS (1.228s) [84.879499] Starting dynamic subtest: C-eDP1 [86.116373] Dynamic subtest C-eDP1: SUCCESS (1.245s) [86.126825] Starting dynamic subtest: D-eDP1 [87.358093] Dynamic subtest D-eDP1: SUCCESS (1.241s) [87.360450] Subtest bo-too-big-interruptible: SUCCESS (5.306s) [88.557219] [008/133] (929s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs) [88.664107] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs [88.666489] Starting dynamic subtest: pipe-A-eDP-1 [88.808568] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.135s) [88.817936] Starting dynamic subtest: pipe-B-eDP-1 [88.837919] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [88.846940] Starting dynamic subtest: pipe-C-eDP-1 [88.866249] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s) [88.873602] Starting dynamic subtest: pipe-D-eDP-1 [88.892774] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s) [88.894612] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.143s) [91.119122] [009/133] (927s left) kms_async_flips (alternate-sync-async-flip-atomic) [91.206574] Starting subtest: alternate-sync-async-flip-atomic [91.590433] Starting dynamic subtest: pipe-A-eDP-1 [94.417231] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.827s) [94.787741] Starting dynamic subtest: pipe-B-eDP-1 [97.543100] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.762s) [97.928315] Starting dynamic subtest: pipe-C-eDP-1 [100.672524] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.751s) [101.051247] Starting dynamic subtest: pipe-D-eDP-1 [103.804478] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.761s) [103.806377] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.599s) [104.960702] [010/133] (913s left) kms_cursor_edge_walk (64x64-top-bottom) [105.070859] Starting subtest: 64x64-top-bottom [105.073181] Starting dynamic subtest: pipe-A-eDP-1 [108.538399] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.466s) [108.547160] Starting dynamic subtest: pipe-D-eDP-1 [111.669139] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.131s) [111.671474] Subtest 64x64-top-bottom: SUCCESS (6.599s) [112.471744] [011/133] (905s left) gem_cs_tlb (engines) [112.529832] Starting subtest: engines [112.532104] Starting dynamic subtest: rcs0 [114.687378] Dynamic subtest rcs0: SUCCESS (2.155s) [114.697260] Starting dynamic subtest: bcs0 [116.840361] Dynamic subtest bcs0: SUCCESS (2.151s) [116.850783] Starting dynamic subtest: vcs0 [118.991997] Dynamic subtest vcs0: SUCCESS (2.152s) [119.002071] Starting dynamic subtest: vcs1 [121.145738] Dynamic subtest vcs1: SUCCESS (2.153s) [121.156541] Starting dynamic subtest: vecs0 [123.296668] Dynamic subtest vecs0: SUCCESS (2.151s) [123.307268] Starting dynamic subtest: ccs0 [125.450091] Dynamic subtest ccs0: SUCCESS (2.153s) [125.451980] Subtest engines: SUCCESS (12.918s) [125.556209] [012/133] (892s left) kms_color (legacy-gamma-reset) [125.653615] Starting subtest: legacy-gamma-reset [125.655744] Starting dynamic subtest: pipe-A-eDP-1 [126.036998] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.385s) [126.045893] Starting dynamic subtest: pipe-B-eDP-1 [126.050680] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.013s) [126.058193] Starting dynamic subtest: pipe-C-eDP-1 [126.064220] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.013s) [126.071814] Starting dynamic subtest: pipe-D-eDP-1 [126.076990] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.013s) [126.079425] Subtest legacy-gamma-reset: SUCCESS (0.426s) [126.913795] [013/133] (891s left) kms_vblank (query-idle-hang) [127.002382] Starting subtest: query-idle-hang [127.004808] Starting dynamic subtest: pipe-A-eDP-1 [153.686431] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.682s) [153.702128] Starting dynamic subtest: pipe-D-eDP-1 [168.679243] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.989s) [168.681641] Subtest query-idle-hang: SUCCESS (41.675s) [169.491994] [014/133] (848s left) kms_atomic (plane-overlay-legacy) [169.599771] Starting subtest: plane-overlay-legacy [169.602245] Starting dynamic subtest: pipe-A-eDP-1 [170.019045] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.421s) [170.021356] Subtest plane-overlay-legacy: SUCCESS (0.422s) [170.813716] [015/133] (847s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc) [170.915078] Starting subtest: fbcpsr-rgb565-draw-mmap-wc [177.801730] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.890s) [177.912208] [016/133] (840s left) gem_mmap_gtt (cpuset-basic-small-copy-xy) [177.968944] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s) [178.031287] [017/133] (840s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu) [178.133329] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu [185.251957] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.122s) [185.363762] [018/133] (833s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite) [185.457342] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite [185.461785] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [185.540410] [019/133] (832s left) gem_exec_whisper (basic-contexts) [185.600740] Starting subtest: basic-contexts [192.883279] Subtest basic-contexts: SUCCESS (7.280s) [193.076377] [020/133] (825s left) gem_busy (parallel) [193.267524] Starting subtest: parallel [193.270050] Starting dynamic subtest: rcs0 [194.902879] Dynamic subtest rcs0: SUCCESS (1.633s) [194.914598] Starting dynamic subtest: bcs0 [196.886499] Dynamic subtest bcs0: SUCCESS (1.982s) [196.897385] Starting dynamic subtest: vcs0 [198.933973] Dynamic subtest vcs0: SUCCESS (2.046s) [198.944610] Starting dynamic subtest: vcs1 [200.918611] Dynamic subtest vcs1: SUCCESS (1.982s) [200.929529] Starting dynamic subtest: vecs0 [202.902982] Dynamic subtest vecs0: SUCCESS (1.982s) [202.913862] Starting dynamic subtest: ccs0 [204.886053] Dynamic subtest ccs0: SUCCESS (1.981s) [204.889063] Subtest parallel: SUCCESS (11.618s) [205.115919] [021/133] (813s left) gem_exec_schedule (implicit-boths) [205.179846] Starting subtest: implicit-boths [205.182137] Starting dynamic subtest: rcs0 [205.356478] Dynamic subtest rcs0: SUCCESS (0.183s) [205.368707] Starting dynamic subtest: vcs0 [205.465458] Dynamic subtest vcs0: SUCCESS (0.108s) [205.476788] Starting dynamic subtest: vcs1 [205.566063] Dynamic subtest vcs1: SUCCESS (0.101s) [205.575848] Starting dynamic subtest: vecs0 [205.674963] Dynamic subtest vecs0: SUCCESS (0.109s) [205.683438] Starting dynamic subtest: ccs0 [205.799666] Dynamic subtest ccs0: SUCCESS (0.123s) [205.802583] Subtest implicit-boths: SUCCESS (0.627s) [207.029376] [022/133] (811s left) gem_render_copy_redux (flink) [207.088923] Starting subtest: flink [208.204651] Subtest flink: SUCCESS (1.116s) [208.319878] [023/133] (810s left) gem_exec_schedule (u-semaphore-codependency) [208.392914] Starting subtest: u-semaphore-codependency [208.407456] Subtest u-semaphore-codependency: SUCCESS (0.019s) [208.758107] [024/133] (809s left) kms_dsc (dsc-with-formats) [208.852764] Starting subtest: dsc-with-formats [208.891174] Subtest dsc-with-formats: SKIP (0.001s) [208.926420] [025/133] (809s left) kms_psr (psr-cursor-plane-onoff) [209.018756] Starting subtest: psr-cursor-plane-onoff [209.021041] Starting dynamic subtest: eDP-1 [210.767656] Dynamic subtest eDP-1: SUCCESS (1.749s) [210.769798] Subtest psr-cursor-plane-onoff: SUCCESS (1.750s) [211.626125] [026/133] (807s left) gem_exec_balancer (bonded-sync) [211.679614] Starting subtest: bonded-sync [211.684293] Subtest bonded-sync: SKIP (0.000s) [211.993786] [027/133] (806s left) kms_flip (2x-plain-flip) [212.083062] Starting subtest: 2x-plain-flip [212.094707] Subtest 2x-plain-flip: SKIP (0.011s) [212.176039] [028/133] (806s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner) [212.275845] Starting subtest: switch-modeset-ultra-joiner-big-joiner [212.280156] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s) [212.341380] [029/133] (806s left) gem_userptr_blits (readonly-pwrite-unsync) [212.408109] Subtest readonly-pwrite-unsync: SKIP (0.000s) [212.520815] [030/133] (806s left) kms_psr (fbc-psr-cursor-mmap-cpu) [212.610091] Starting subtest: fbc-psr-cursor-mmap-cpu [212.612370] Starting dynamic subtest: eDP-1 [212.616742] Dynamic subtest eDP-1: SKIP (0.000s) [212.621209] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s) [212.683346] [031/133] (806s left) syncobj_wait (invalid-signal-illegal-handle) [212.731273] Starting subtest: invalid-signal-illegal-handle [212.733212] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [212.818891] [032/133] (806s left) kms_psr (pr-primary-mmap-gtt) [212.901990] Starting subtest: pr-primary-mmap-gtt [212.905643] Subtest pr-primary-mmap-gtt: SKIP (0.000s) [212.979872] [033/133] (806s left) gem_exec_params (invalid-fence-in) [213.036223] Starting subtest: invalid-fence-in [213.038131] Subtest invalid-fence-in: SUCCESS (0.000s) [213.122759] [034/133] (806s left) gem_eio (hibernate) [213.355069] Starting subtest: hibernate [228.240599] Subtest hibernate: SUCCESS (14.886s) [236.382141] [035/133] (790s left) gem_ctx_param (invalid-get-no-zeromap) [236.444751] Starting subtest: invalid-get-no-zeromap [236.447193] Subtest invalid-get-no-zeromap: SUCCESS (0.001s) [236.533748] [036/133] (790s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite) [236.630290] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite [236.634135] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [236.729267] [037/133] (790s left) kms_dp_linktrain_fallback (dp-fallback) [236.825022] Starting subtest: dp-fallback [236.831515] Subtest dp-fallback: SKIP (0.000s) [236.896496] [038/133] (790s left) gem_exec_suspend (basic-s4-devices) [236.960795] Starting subtest: basic-S4-devices [236.963132] Starting dynamic subtest: smem [248.855096] Dynamic subtest smem: SUCCESS (11.891s) [248.858962] Subtest basic-S4-devices: SUCCESS (11.893s) [254.053913] [039/133] (778s left) syncobj_wait (single-wait-submitted) [254.128492] Starting subtest: single-wait-submitted [254.234348] Subtest single-wait-submitted: SUCCESS (0.104s) [254.312784] [040/133] (778s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [254.412406] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu [254.416687] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [254.502465] [041/133] (777s left) gem_exec_schedule (in-order) [254.574681] Starting subtest: in-order [254.576671] Starting dynamic subtest: rcs0 [254.666093] Dynamic subtest rcs0: SUCCESS (0.099s) [254.678882] Starting dynamic subtest: vcs0 [254.754835] Dynamic subtest vcs0: SUCCESS (0.089s) [254.766625] Starting dynamic subtest: vcs1 [254.841042] Dynamic subtest vcs1: SUCCESS (0.086s) [254.853374] Starting dynamic subtest: vecs0 [254.921341] Dynamic subtest vecs0: SUCCESS (0.080s) [254.933741] Starting dynamic subtest: ccs0 [255.020338] Dynamic subtest ccs0: SUCCESS (0.096s) [255.023068] Subtest in-order: SUCCESS (0.454s) [255.998066] [042/133] (776s left) prime_mmap_coherency (read) [256.052928] Starting subtest: read [261.430306] Subtest read: SUCCESS (5.375s) [261.546453] [043/133] (770s left) gem_close (many-handles-one-vma) [261.617822] Starting subtest: many-handles-one-vma [261.673459] Subtest many-handles-one-vma: SUCCESS (0.056s) [261.801400] [044/133] (770s left) core_getversion (all-cards) [261.840612] Starting subtest: all-cards [261.847897] Subtest all-cards: SUCCESS (0.009s) [261.894695] [045/133] (770s left) prime_busy (before-wait) [261.957417] Starting subtest: before-wait [261.962169] Starting dynamic subtest: rcs0 [261.996430] Dynamic subtest rcs0: SUCCESS (0.035s) [262.008749] Starting dynamic subtest: bcs0 [262.047241] Dynamic subtest bcs0: SUCCESS (0.050s) [262.058178] Starting dynamic subtest: vcs0 [262.088987] Dynamic subtest vcs0: SUCCESS (0.041s) [262.099063] Starting dynamic subtest: vcs1 [262.131318] Dynamic subtest vcs1: SUCCESS (0.042s) [262.141420] Starting dynamic subtest: vecs0 [262.174123] Dynamic subtest vecs0: SUCCESS (0.042s) [262.183537] Starting dynamic subtest: ccs0 [262.217764] Dynamic subtest ccs0: SUCCESS (0.043s) [262.327177] Subtest before-wait: SUCCESS (0.368s) [262.403317] [046/133] (770s left) gem_mmap_wc (fault-concurrent) [262.452039] Subtest fault-concurrent: SKIP (0.000s) [262.511219] [047/133] (770s left) gem_watchdog (default-virtual) [262.573320] Starting subtest: default-virtual [268.850237] Subtest default-virtual: SUCCESS (6.285s) [268.938036] [048/133] (763s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt) [269.035128] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt [269.039229] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [269.132131] [049/133] (763s left) kms_plane_scaling (invalid-num-scalers) [269.240968] Starting subtest: invalid-num-scalers [269.243197] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers [269.262316] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.020s) [269.272286] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers [269.295805] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.034s) [269.305450] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers [269.332514] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.035s) [269.341792] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers [269.366298] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.033s) [269.368505] Subtest invalid-num-scalers: SUCCESS (0.127s) [269.478956] [050/133] (763s left) gem_spin_batch (user-each) [269.547243] Starting subtest: user-each [272.905102] Subtest user-each: SUCCESS (3.357s) [273.145614] [051/133] (759s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier) [273.275179] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier [273.308926] Starting dynamic subtest: pipe-A-plane-0 [273.730629] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s) [273.742848] Starting dynamic subtest: pipe-A-plane-3 [273.985800] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s) [273.995863] Starting dynamic subtest: pipe-A-plane-5 [274.000299] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [275.096970] Starting dynamic subtest: pipe-B-plane-0 [275.522590] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s) [275.542763] Starting dynamic subtest: pipe-B-plane-3 [275.777387] Dynamic subtest pipe-B-plane-3: SUCCESS (0.253s) [275.787435] Starting dynamic subtest: pipe-B-plane-5 [275.791780] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [276.088725] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.810s) [276.970516] [052/133] (755s left) gem_eio (wait-immediate) [277.182710] Starting subtest: wait-immediate [277.525683] Subtest wait-immediate: SUCCESS (0.343s) [277.654367] [053/133] (755s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu) [277.756074] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu [277.760153] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [277.843782] [054/133] (755s left) gem_mmap_gtt (basic-write-gtt) [277.898496] Subtest basic-write-gtt: SKIP (0.000s) [277.958189] [055/133] (755s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling) [278.050185] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling [278.052110] Starting dynamic subtest: pipe-A-default-mode [280.832290] Dynamic subtest pipe-A-default-mode: SUCCESS (2.782s) [280.834924] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.783s) [281.672783] [056/133] (751s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf) [281.768825] Starting subtest: fbc-psr2-cursor-plane-update-sf [281.771147] Starting dynamic subtest: pipe-A-eDP-1 [281.843117] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s) [281.855611] Starting dynamic subtest: pipe-B-eDP-1 [282.934924] Dynamic subtest pipe-B-eDP-1: SKIP (1.090s) [282.940259] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.170s) [284.124995] [057/133] (748s left) gem_ctx_param (invalid-ctx-get) [284.178025] Starting subtest: invalid-ctx-get [284.180702] Subtest invalid-ctx-get: SUCCESS (0.000s) [284.262763] [058/133] (748s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant) [284.368708] Starting subtest: coverage-vs-premult-vs-constant [284.667396] Starting dynamic subtest: pipe-A-eDP-1 [285.243034] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.573s) [285.252587] Starting dynamic subtest: pipe-D-eDP-1 [286.534719] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.293s) [286.537125] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.169s) [287.382454] [059/133] (745s left) kms_atomic_interruptible (legacy-setmode) [287.484663] Starting subtest: legacy-setmode [287.486837] Starting dynamic subtest: pipe-A-eDP-1 [294.392392] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.908s) [294.394725] Subtest legacy-setmode: SUCCESS (6.910s) [295.279108] [060/133] (737s left) api_intel_bb (object-reloc-purge-cache) [295.339842] Starting subtest: object-reloc-purge-cache [295.345440] Subtest object-reloc-purge-cache: SKIP (0.006s) [295.464641] [061/133] (737s left) kms_psr (psr-sprite-render) [295.556220] Starting subtest: psr-sprite-render [295.558454] Starting dynamic subtest: eDP-1 [297.302597] Dynamic subtest eDP-1: SUCCESS (1.746s) [297.304989] Subtest psr-sprite-render: SUCCESS (1.747s) [298.113853] [062/133] (735s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff) [298.216847] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff [302.115035] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.901s) [303.318030] [063/133] (730s left) kms_chamelium_hpd (vga-hpd-for-each-pipe) [303.693628] Subtest vga-hpd-for-each-pipe: SKIP (0.000s) [304.514458] [064/133] (728s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move) [304.620374] Starting subtest: fbc-2p-primscrn-spr-indfb-move [304.624768] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s) [304.730228] [065/133] (728s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format) [304.825362] Starting subtest: plane-upscale-20x20-with-pixel-format [304.827687] Starting dynamic subtest: pipe-A [305.884372] Dynamic subtest pipe-A: SUCCESS (1.061s) [305.893763] Starting dynamic subtest: pipe-B [308.052403] Dynamic subtest pipe-B: SUCCESS (2.167s) [308.061651] Starting dynamic subtest: pipe-C [309.244392] Dynamic subtest pipe-C: SUCCESS (1.191s) [309.256069] Starting dynamic subtest: pipe-D [310.390176] Dynamic subtest pipe-D: SUCCESS (1.145s) [310.392469] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.567s) [311.580502] [066/133] (721s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt) [311.690661] Starting subtest: fbc-rgb101010-draw-blt [316.304971] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.618s) [317.488375] [067/133] (716s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0) [317.597311] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0 [317.601681] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s) [317.691490] [068/133] (715s left) i915_drm_fdinfo (virtual-busy-hang) [317.730170] Starting subtest: virtual-busy-hang [317.734659] Subtest virtual-busy-hang: SKIP (0.000s) [317.803611] [069/133] (715s left) kms_pm_rpm (pc8-residency) [319.344235] Starting subtest: pc8-residency [319.349525] Subtest pc8-residency: SKIP (0.000s) [320.111820] [070/133] (713s left) i915_pm_rc6_residency (rc6-idle) [320.171090] Starting subtest: rc6-idle [320.193553] Starting dynamic subtest: gt0-rcs0 [344.549033] Dynamic subtest gt0-rcs0: SUCCESS (24.355s) [344.559232] Starting dynamic subtest: gt0-bcs0 [368.850869] Dynamic subtest gt0-bcs0: SUCCESS (24.299s) [368.861278] Starting dynamic subtest: gt0-ccs0 [393.130495] Dynamic subtest gt0-ccs0: SUCCESS (24.278s) [393.142529] Starting dynamic subtest: gt1-vcs0 [399.304666] Dynamic subtest gt1-vcs0: SUCCESS (6.170s) [399.317891] Starting dynamic subtest: gt1-vecs0 [405.478419] Dynamic subtest gt1-vecs0: SUCCESS (6.168s) [405.481136] Subtest rc6-idle: SUCCESS (85.306s) [405.575503] [071/133] (628s left) kms_cursor_legacy (flip-vs-cursor-varying-size) [405.719518] Starting subtest: flip-vs-cursor-varying-size [414.563265] Subtest flip-vs-cursor-varying-size: SUCCESS (8.841s) [415.420537] [072/133] (618s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180) [415.528405] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180 [416.641059] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.112s) [416.762651] [073/133] (616s left) prime_vgem (fence-write-hang) [416.908753] Subtest fence-write-hang: SKIP (0.000s) [417.014810] [FACT prime_vgem (fence-write-hang)] new: kernel.kmod_is_loaded.vgem: true [417.017788] [074/133] (616s left) kms_universal_plane (universal-plane-sanity) [417.112485] Starting subtest: universal-plane-sanity [417.114224] Starting dynamic subtest: pipe-A-eDP-1 [417.733448] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.621s) [417.746314] Starting dynamic subtest: pipe-B-eDP-1 [418.931975] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.192s) [418.942567] Starting dynamic subtest: pipe-C-eDP-1 [420.140085] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.209s) [420.151794] Starting dynamic subtest: pipe-D-eDP-1 [421.368723] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.227s) [421.371146] Subtest universal-plane-sanity: SUCCESS (4.258s) [422.231734] [075/133] (611s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt) [422.329332] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt [422.333308] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [422.442045] [076/133] (611s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc) [422.540166] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc [422.544479] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [422.638129] [077/133] (611s left) gen9_exec_parse (bb-start-param) [422.696735] Subtest bb-start-param: SKIP (0.000s) [422.762918] [078/133] (611s left) kms_ccs (random-ccs-data-yf-tiled-ccs) [422.858597] Starting subtest: random-ccs-data-yf-tiled-ccs [422.860845] Starting dynamic subtest: pipe-A-eDP-1 [422.885650] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [422.897859] Starting dynamic subtest: pipe-B-eDP-1 [422.921324] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [422.932036] Starting dynamic subtest: pipe-C-eDP-1 [422.955602] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [422.965940] Starting dynamic subtest: pipe-D-eDP-1 [422.989641] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [422.994563] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.005s) [425.016809] [079/133] (608s left) kms_content_protection (suspend-resume) [425.164235] Starting subtest: suspend-resume [425.168850] Subtest suspend-resume: SKIP (0.000s) [425.277737] [080/133] (608s left) kms_big_fb (x-tiled-16bpp-rotate-90) [425.363610] Starting subtest: x-tiled-16bpp-rotate-90 [425.384307] Subtest x-tiled-16bpp-rotate-90: SKIP (0.020s) [425.499175] [081/133] (608s left) gem_partial_pwrite_pread (reads-uncached) [425.549404] Subtest reads-uncached: SKIP (0.000s) [425.613956] [082/133] (608s left) sysfs_heartbeat_interval (precise) [425.667607] Starting subtest: precise [425.669801] Starting dynamic subtest: vecs0 [432.917454] Dynamic subtest vecs0: SUCCESS (7.245s) [432.929502] Starting dynamic subtest: ccs0 [435.911870] Dynamic subtest ccs0: SUCCESS (2.995s) [435.934772] Starting dynamic subtest: vcs0 [443.933778] Dynamic subtest vcs0: SUCCESS (8.016s) [443.946651] Starting dynamic subtest: bcs0 [445.067700] Dynamic subtest bcs0: SUCCESS (1.135s) [445.080439] Starting dynamic subtest: rcs0 [446.148785] Dynamic subtest rcs0: SUCCESS (1.078s) [446.162192] Starting dynamic subtest: vcs1 [453.911470] Dynamic subtest vcs1: SUCCESS (7.759s) [453.914072] Subtest precise: SUCCESS (28.241s) [453.987782] [083/133] (580s left) kms_psr (fbc-psr2-primary-page-flip) [454.101958] Starting subtest: fbc-psr2-primary-page-flip [454.104265] Starting dynamic subtest: eDP-1 [454.108605] Dynamic subtest eDP-1: SKIP (0.000s) [454.112947] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s) [454.180980] [084/133] (580s left) gem_mmap_offset (partial-remap) [454.227340] Starting subtest: partial-remap [454.229312] Starting dynamic subtest: smem0 [454.238167] Dynamic subtest smem0: SUCCESS (0.005s) [454.240089] Subtest partial-remap: SUCCESS (0.006s) [454.357318] [085/133] (579s left) syncobj_timeline (multi-wait-available-submitted) [454.409045] Starting subtest: multi-wait-available-submitted [454.411348] Subtest multi-wait-available-submitted: SUCCESS (0.001s) [454.506528] [086/133] (579s left) i915_query (hwconfig_table) [454.559936] Starting subtest: hwconfig_table [454.853452] Subtest hwconfig_table: SUCCESS (0.001s) [454.896695] [087/133] (579s left) gem_ctx_persistence (processes) [454.950063] Starting subtest: processes [456.866459] Subtest processes: SUCCESS (1.918s) [456.946403] [088/133] (577s left) kms_big_fb (4-tiled-64bpp-rotate-0) [457.059617] Starting subtest: 4-tiled-64bpp-rotate-0 [458.594768] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.534s) [458.764909] [089/133] (575s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render) [458.863900] Starting subtest: psr-rgb101010-draw-render [466.162145] Subtest psr-rgb101010-draw-render: SUCCESS (7.301s) [466.289641] [090/133] (568s left) gem_render_copy (yf-tiled-ccs-to-y-tiled) [466.357532] Starting subtest: yf-tiled-ccs-to-y-tiled [466.361694] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s) [466.552368] [091/133] (567s left) kms_cursor_crc (cursor-rapid-movement-512x512) [466.841966] Starting subtest: cursor-rapid-movement-512x512 [466.846471] Subtest cursor-rapid-movement-512x512: SKIP (0.001s) [467.017551] [092/133] (567s left) kms_pm_rpm (fences-dpms) [469.044298] Starting subtest: fences-dpms [469.049068] Subtest fences-dpms: SKIP (0.000s) [469.430961] [093/133] (565s left) kms_flip (plain-flip-ts-check-interruptible) [469.527251] Starting subtest: plain-flip-ts-check-interruptible [469.529538] Starting dynamic subtest: A-eDP1 [478.406081] Dynamic subtest A-eDP1: SUCCESS (8.877s) [478.417736] Starting dynamic subtest: B-eDP1 [487.231309] Dynamic subtest B-eDP1: SUCCESS (8.824s) [487.248182] Starting dynamic subtest: C-eDP1 [496.062129] Dynamic subtest C-eDP1: SUCCESS (8.829s) [496.077544] Starting dynamic subtest: D-eDP1 [504.893724] Dynamic subtest D-eDP1: SUCCESS (8.830s) [504.896242] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.368s) [506.103632] [094/133] (528s left) i915_pm_freq_api (freq-basic-api) [506.180037] Starting subtest: freq-basic-api [506.182467] Starting dynamic subtest: gt0 [506.184768] Dynamic subtest gt0: SUCCESS (0.002s) [506.196771] Starting dynamic subtest: gt1 [506.199204] Dynamic subtest gt1: SUCCESS (0.002s) [506.201361] Subtest freq-basic-api: SUCCESS (0.006s) [506.296634] [095/133] (528s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted) [506.428047] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted [506.558817] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.133s) [506.713392] [096/133] (528s left) perf_pmu (busy-accuracy-50) [506.756549] Starting subtest: busy-accuracy-50 [506.758584] Starting dynamic subtest: rcs0 [508.290085] Dynamic subtest rcs0: SUCCESS (1.531s) [508.302237] Starting dynamic subtest: bcs0 [509.835393] Dynamic subtest bcs0: SUCCESS (1.543s) [509.847802] Starting dynamic subtest: vcs0 [511.380107] Dynamic subtest vcs0: SUCCESS (1.542s) [511.392440] Starting dynamic subtest: vcs1 [512.923577] Dynamic subtest vcs1: SUCCESS (1.541s) [512.934562] Starting dynamic subtest: vecs0 [514.466029] Dynamic subtest vecs0: SUCCESS (1.540s) [514.478318] Starting dynamic subtest: ccs0 [516.015076] Dynamic subtest ccs0: SUCCESS (1.546s) [516.018123] Subtest busy-accuracy-50: SUCCESS (9.258s) [516.169587] [097/133] (518s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move) [516.274330] Starting subtest: psr-1p-primscrn-spr-indfb-move [523.875853] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.605s) [523.977804] [098/133] (510s left) gem_pipe_control_store_loop (reused-buffer) [524.047436] Starting subtest: reused-buffer [526.201247] Subtest reused-buffer: SUCCESS (2.153s) [526.309036] [099/133] (508s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs) [526.392093] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs [526.394414] Starting dynamic subtest: pipe-A-eDP-1 [526.901842] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.480s) [526.914312] Starting dynamic subtest: pipe-B-eDP-1 [528.376031] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.474s) [528.386248] Starting dynamic subtest: pipe-C-eDP-1 [529.723261] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.347s) [529.734293] Starting dynamic subtest: pipe-D-eDP-1 [531.088292] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.365s) [531.090083] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.671s) [532.245827] [100/133] (502s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic) [532.365238] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic [532.369564] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s) [532.510280] [101/133] (502s left) kms_chamelium_frames (dp-crc-single) [532.893324] Subtest dp-crc-single: SKIP (0.000s) [533.663338] [102/133] (501s left) gem_readwrite (read-bad-handle) [533.721496] Subtest read-bad-handle: SKIP (0.000s) [533.785520] [103/133] (501s left) gem_exec_fence (basic-await) [533.956620] Starting subtest: basic-await [533.958954] Starting dynamic subtest: rcs0 [534.035575] Dynamic subtest rcs0: SUCCESS (0.078s) [534.051383] Starting dynamic subtest: bcs0 [534.108034] Dynamic subtest bcs0: SUCCESS (0.071s) [534.122191] Starting dynamic subtest: vcs0 [534.179922] Dynamic subtest vcs0: SUCCESS (0.071s) [534.191529] Starting dynamic subtest: vcs1 [534.253287] Dynamic subtest vcs1: SUCCESS (0.072s) [534.265882] Starting dynamic subtest: vecs0 [534.326520] Dynamic subtest vecs0: SUCCESS (0.071s) [534.340147] Starting dynamic subtest: ccs0 [534.400422] Dynamic subtest ccs0: SUCCESS (0.072s) [534.403382] Subtest basic-await: SUCCESS (0.445s) [535.884492] [104/133] (499s left) kms_big_fb (yf-tiled-32bpp-rotate-90) [535.986109] Starting subtest: yf-tiled-32bpp-rotate-90 [535.990489] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s) [536.123271] [105/133] (499s left) gem_pxp (reject-modify-context-protection-off-1) [536.180644] Starting subtest: reject-modify-context-protection-off-1 [536.182854] Subtest reject-modify-context-protection-off-1: SUCCESS (0.001s) [536.275496] [106/133] (498s left) gem_exec_reloc (basic-cpu-noreloc) [536.352078] Subtest basic-cpu-noreloc: SKIP (0.000s) [536.420537] [107/133] (498s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite) [536.518099] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite [546.139279] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.622s) [546.270196] [108/133] (489s left) kms_rotation_crc (primary-x-tiled-reflect-x-180) [546.371307] Starting subtest: primary-x-tiled-reflect-x-180 [553.508651] Subtest primary-x-tiled-reflect-x-180: SUCCESS (7.139s) [554.726677] [109/133] (480s left) gem_exec_reloc (basic-write-wc-active) [554.778746] Subtest basic-write-wc-active: SKIP (0.000s) [554.859132] [110/133] (480s left) syncobj_timeline (wait-all-complex) [554.912012] Starting subtest: wait-all-complex [555.127297] Subtest wait-all-complex: SUCCESS (0.215s) [555.205627] [111/133] (480s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area) [555.305091] Starting subtest: psr2-plane-move-sf-dmg-area [555.307246] Starting dynamic subtest: pipe-A-eDP-1 [559.888881] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.587s) [559.899509] Starting dynamic subtest: pipe-B-eDP-1 [565.220725] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.330s) [565.222976] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.920s) [566.096885] [112/133] (469s left) gem_exec_fence (syncobj-timeline-invalid-flags) [566.651026] Starting subtest: syncobj-timeline-invalid-flags [566.653723] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s) [567.982842] [113/133] (467s left) perf (blocking) [568.109350] Starting subtest: blocking [568.111177] Starting dynamic subtest: 0-rcs0 [578.137887] Dynamic subtest 0-rcs0: SUCCESS (10.027s) [578.149107] Starting dynamic subtest: 1-vcs0 [588.160031] Dynamic subtest 1-vcs0: SUCCESS (10.020s) [588.163076] Subtest blocking: SUCCESS (20.050s) [588.211858] [114/133] (447s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted) [588.281661] Starting subtest: etime-multi-wait-for-submit-unsubmitted [588.385579] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.103s) [588.468198] [115/133] (447s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf) [588.571805] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf [588.575750] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [588.640313] [116/133] (446s left) kms_invalid_mode (bad-vsync-start) [588.743816] Starting subtest: bad-vsync-start [588.746059] Starting dynamic subtest: pipe-A-eDP-1 [589.034914] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s) [589.045912] Starting dynamic subtest: pipe-B-eDP-1 [589.048226] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [589.058866] Starting dynamic subtest: pipe-C-eDP-1 [589.060723] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [589.070414] Starting dynamic subtest: pipe-D-eDP-1 [589.072370] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [589.074297] Subtest bad-vsync-start: SUCCESS (0.298s) [589.904010] [117/133] (445s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff) [590.025859] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff [597.142067] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.118s) [597.293193] [118/133] (438s left) gem_exec_reloc (basic-gtt-wc) [597.363170] Subtest basic-gtt-wc: SKIP (0.000s) [597.427870] [119/133] (438s left) kms_plane_lowres (tiling-x) [597.510910] Starting subtest: tiling-x [597.513172] Starting dynamic subtest: pipe-A-eDP-1 [597.517689] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [597.807679] Starting dynamic subtest: pipe-B-eDP-1 [597.812388] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [597.822609] Starting dynamic subtest: pipe-C-eDP-1 [597.827342] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [597.837680] Starting dynamic subtest: pipe-D-eDP-1 [597.842234] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [597.846672] Subtest tiling-x: SKIP (0.295s) [598.642711] [120/133] (437s left) gem_ctx_shared (q-smoketest-all) [598.698346] Starting subtest: Q-smoketest-all [631.105248] Subtest Q-smoketest-all: SUCCESS (32.359s) [632.006259] [121/133] (403s left) gem_softpin (evict-snoop) [632.071178] Starting subtest: evict-snoop [632.075528] Subtest evict-snoop: SKIP (0.000s) [632.183609] [122/133] (403s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling) [632.272593] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling [632.276597] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s) [632.346305] [123/133] (403s left) syncobj_wait (multi-wait-submitted-signaled) [632.396922] Starting subtest: multi-wait-submitted-signaled [632.399252] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s) [632.502965] [124/133] (403s left) syncobj_wait (reset-unsignaled) [632.547961] Starting subtest: reset-unsignaled [632.550253] Subtest reset-unsignaled: SUCCESS (0.000s) [632.692969] [125/133] (403s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [632.795758] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [633.664735] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.870s) [633.816862] [126/133] (402s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs) [633.910848] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs [633.913024] Starting dynamic subtest: pipe-A-eDP-1 [633.934410] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [633.946235] Starting dynamic subtest: pipe-B-eDP-1 [633.966815] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [633.977080] Starting dynamic subtest: pipe-C-eDP-1 [633.997645] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [634.007816] Starting dynamic subtest: pipe-D-eDP-1 [634.029257] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [634.033174] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.005s) [636.207080] [127/133] (399s left) syncobj_wait (invalid-single-wait-unsubmitted) [636.266620] Starting subtest: invalid-single-wait-unsubmitted [636.268575] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s) [636.370248] [128/133] (399s left) perf_pmu (render-node-busy-idle) [636.445762] Starting subtest: render-node-busy-idle [636.448179] Starting dynamic subtest: rcs0 [637.137298] Dynamic subtest rcs0: SUCCESS (0.690s) [637.151531] Starting dynamic subtest: bcs0 [637.808049] Dynamic subtest bcs0: SUCCESS (0.669s) [637.821472] Starting dynamic subtest: vcs0 [638.933873] Dynamic subtest vcs0: SUCCESS (1.121s) [638.947352] Starting dynamic subtest: vcs1 [640.918395] Dynamic subtest vcs1: SUCCESS (1.982s) [640.932076] Starting dynamic subtest: vecs0 [642.902324] Dynamic subtest vecs0: SUCCESS (1.981s) [642.915185] Starting dynamic subtest: ccs0 [643.578078] Dynamic subtest ccs0: SUCCESS (0.674s) [643.580872] Subtest render-node-busy-idle: SUCCESS (7.133s) [643.656516] [129/133] (392s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted) [643.725317] Starting subtest: multi-wait-all-for-submit-available-submitted [643.727589] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s) [643.836928] [130/133] (392s left) prime_vgem (basic-fence-read) [643.910680] Starting subtest: basic-fence-read [643.931340] Subtest basic-fence-read: SKIP (0.019s) [644.048531] [131/133] (392s left) kms_addfb_basic (bad-pitch-65536) [644.100829] Starting subtest: bad-pitch-65536 [644.103056] Subtest bad-pitch-65536: SUCCESS (0.000s) [644.244100] [132/133] (392s left) kms_fbcon_fbt (psr-suspend) [644.308580] Starting subtest: psr-suspend [693.213580] Subtest psr-suspend: SUCCESS (19.536s) [693.290976] [133/133] (343s left) syncobj_eventfd (binary-wait-before-signal) [693.354794] Starting subtest: binary-wait-before-signal [693.383503] Subtest binary-wait-before-signal: SUCCESS (0.030s) [693.461175] Closing watchdogs results: parsing output: 0/ for test: kms_cursor_crc results: parsing output: 1/ for test: gem_exec_whisper results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: kms_ccs results: parsing output: 4/ for test: kms_big_fb results: parsing output: 5/ for test: gem_ctx_param results: parsing output: 6/ for test: kms_flip results: parsing output: 7/ for test: kms_ccs results: parsing output: 8/ for test: kms_async_flips results: parsing output: 9/ for test: kms_cursor_edge_walk results: parsing output: 10/ for test: gem_cs_tlb results: parsing output: 11/ for test: kms_color results: parsing output: 12/ for test: kms_vblank results: parsing output: 13/ for test: kms_atomic results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: gem_mmap_gtt results: parsing output: 16/ for test: kms_frontbuffer_tracking results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: gem_exec_whisper results: parsing output: 19/ for test: gem_busy results: parsing output: 20/ for test: gem_exec_schedule results: parsing output: 21/ for test: gem_render_copy_redux results: parsing output: 22/ for test: gem_exec_schedule results: parsing output: 23/ for test: kms_dsc results: parsing output: 24/ for test: kms_psr results: parsing output: 25/ for test: gem_exec_balancer results: parsing output: 26/ for test: kms_flip results: parsing output: 27/ for test: kms_joiner results: parsing output: 28/ for test: gem_userptr_blits results: parsing output: 29/ for test: kms_psr results: parsing output: 30/ for test: syncobj_wait results: parsing output: 31/ for test: kms_psr results: parsing output: 32/ for test: gem_exec_params results: parsing output: 33/ for test: gem_eio results: parsing output: 34/ for test: gem_ctx_param results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: kms_dp_linktrain_fallback results: parsing output: 37/ for test: gem_exec_suspend results: parsing output: 38/ for test: syncobj_wait results: parsing output: 39/ for test: kms_frontbuffer_tracking results: parsing output: 40/ for test: gem_exec_schedule results: parsing output: 41/ for test: prime_mmap_coherency results: parsing output: 42/ for test: gem_close results: parsing output: 43/ for test: core_getversion results: parsing output: 44/ for test: prime_busy results: parsing output: 45/ for test: gem_mmap_wc results: parsing output: 46/ for test: gem_watchdog results: parsing output: 47/ for test: kms_frontbuffer_tracking results: parsing output: 48/ for test: kms_plane_scaling results: parsing output: 49/ for test: gem_spin_batch results: parsing output: 50/ for test: kms_plane results: parsing output: 51/ for test: gem_eio results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: gem_mmap_gtt results: parsing output: 54/ for test: kms_flip_scaled_crc results: parsing output: 55/ for test: kms_psr2_sf results: parsing output: 56/ for test: gem_ctx_param results: parsing output: 57/ for test: kms_plane_alpha_blend results: parsing output: 58/ for test: kms_atomic_interruptible results: parsing output: 59/ for test: api_intel_bb results: parsing output: 60/ for test: kms_psr results: parsing output: 61/ for test: kms_frontbuffer_tracking results: parsing output: 62/ for test: kms_chamelium_hpd results: parsing output: 63/ for test: kms_frontbuffer_tracking results: parsing output: 64/ for test: kms_plane_scaling results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: kms_big_fb results: parsing output: 67/ for test: i915_drm_fdinfo results: parsing output: 68/ for test: kms_pm_rpm results: parsing output: 69/ for test: i915_pm_rc6_residency results: parsing output: 70/ for test: kms_cursor_legacy results: parsing output: 71/ for test: kms_big_fb results: parsing output: 72/ for test: prime_vgem results: parsing output: 73/ for test: kms_universal_plane results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: gen9_exec_parse results: parsing output: 77/ for test: kms_ccs results: parsing output: 78/ for test: kms_content_protection results: parsing output: 79/ for test: kms_big_fb results: parsing output: 80/ for test: gem_partial_pwrite_pread results: parsing output: 81/ for test: sysfs_heartbeat_interval results: parsing output: 82/ for test: kms_psr results: parsing output: 83/ for test: gem_mmap_offset results: parsing output: 84/ for test: syncobj_timeline results: parsing output: 85/ for test: i915_query results: parsing output: 86/ for test: gem_ctx_persistence results: parsing output: 87/ for test: kms_big_fb results: parsing output: 88/ for test: kms_frontbuffer_tracking results: parsing output: 89/ for test: gem_render_copy results: parsing output: 90/ for test: kms_cursor_crc results: parsing output: 91/ for test: kms_pm_rpm results: parsing output: 92/ for test: kms_flip results: parsing output: 93/ for test: i915_pm_freq_api results: parsing output: 94/ for test: gem_pxp results: parsing output: 95/ for test: perf_pmu results: parsing output: 96/ for test: kms_frontbuffer_tracking results: parsing output: 97/ for test: gem_pipe_control_store_loop results: parsing output: 98/ for test: kms_ccs results: parsing output: 99/ for test: kms_cursor_legacy results: parsing output: 100/ for test: kms_chamelium_frames results: parsing output: 101/ for test: gem_readwrite results: parsing output: 102/ for test: gem_exec_fence results: parsing output: 103/ for test: kms_big_fb results: parsing output: 104/ for test: gem_pxp results: parsing output: 105/ for test: gem_exec_reloc results: parsing output: 106/ for test: kms_frontbuffer_tracking results: parsing output: 107/ for test: kms_rotation_crc results: parsing output: 108/ for test: gem_exec_reloc results: parsing output: 109/ for test: syncobj_timeline results: parsing output: 110/ for test: kms_psr2_sf results: parsing output: 111/ for test: gem_exec_fence results: parsing output: 112/ for test: perf results: parsing output: 113/ for test: syncobj_timeline results: parsing output: 114/ for test: kms_psr2_sf results: parsing output: 115/ for test: kms_invalid_mode results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: gem_exec_reloc results: parsing output: 118/ for test: kms_plane_lowres results: parsing output: 119/ for test: gem_ctx_shared results: parsing output: 120/ for test: gem_softpin results: parsing output: 121/ for test: kms_flip_scaled_crc results: parsing output: 122/ for test: syncobj_wait results: parsing output: 123/ for test: syncobj_wait results: parsing output: 124/ for test: kms_big_fb results: parsing output: 125/ for test: kms_ccs results: parsing output: 126/ for test: syncobj_wait results: parsing output: 127/ for test: perf_pmu results: parsing output: 128/ for test: syncobj_timeline results: parsing output: 129/ for test: prime_vgem results: parsing output: 130/ for test: kms_addfb_basic results: parsing output: 131/ for test: kms_fbcon_fbt results: parsing output: 132/ for test: syncobj_eventfd Done.