[58.452382] Initializing watchdogs [58.452430] /dev/watchdog0 [58.467055] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [58.471645] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.473968] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.477307] [001/133] (960s left) kms_cursor_crc (cursor-onscreen-512x512) [58.788784] Starting subtest: cursor-onscreen-512x512 [58.793752] Subtest cursor-onscreen-512x512: SKIP (0.001s) [58.965414] [002/133] (960s left) gem_exec_whisper (basic-queues-priority-all) [59.023758] Starting subtest: basic-queues-priority-all [79.363047] Subtest basic-queues-priority-all: SUCCESS (20.355s) [79.544208] [003/133] (939s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt) [79.650479] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt [79.655106] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [79.748886] [004/133] (939s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs) [79.835691] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs [79.840625] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s) [80.960085] [005/133] (938s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip) [81.069891] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip [81.073866] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [81.176974] [006/133] (937s left) gem_ctx_param (basic-default) [81.224668] Starting subtest: basic-default [81.227169] Subtest basic-default: SUCCESS (0.000s) [81.289216] [007/133] (937s left) kms_flip (bo-too-big-interruptible) [81.394431] Starting subtest: bo-too-big-interruptible [81.396653] Starting dynamic subtest: A-eDP1 [82.727056] Dynamic subtest A-eDP1: SUCCESS (1.332s) [82.737230] Starting dynamic subtest: B-eDP1 [83.967075] Dynamic subtest B-eDP1: SUCCESS (1.240s) [83.977106] Starting dynamic subtest: C-eDP1 [85.201653] Dynamic subtest C-eDP1: SUCCESS (1.234s) [85.211428] Starting dynamic subtest: D-eDP1 [86.453454] Dynamic subtest D-eDP1: SUCCESS (1.251s) [86.456055] Subtest bo-too-big-interruptible: SUCCESS (5.062s) [87.653550] [008/133] (931s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs) [87.751282] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs [87.753324] Starting dynamic subtest: pipe-A-eDP-1 [87.897414] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.138s) [87.906964] Starting dynamic subtest: pipe-B-eDP-1 [87.927070] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [87.938077] Starting dynamic subtest: pipe-C-eDP-1 [87.957705] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s) [87.965474] Starting dynamic subtest: pipe-D-eDP-1 [87.984761] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s) [87.986983] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.145s) [90.130738] [009/133] (929s left) kms_async_flips (alternate-sync-async-flip-atomic) [90.229082] Starting subtest: alternate-sync-async-flip-atomic [90.608055] Starting dynamic subtest: pipe-A-eDP-1 [93.421698] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.814s) [93.817114] Starting dynamic subtest: pipe-B-eDP-1 [96.561245] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.752s) [96.937975] Starting dynamic subtest: pipe-C-eDP-1 [99.688250] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.758s) [100.066181] Starting dynamic subtest: pipe-D-eDP-1 [102.826680] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.769s) [102.828703] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.601s) [103.993812] [010/133] (915s left) kms_cursor_edge_walk (64x64-top-bottom) [104.085355] Starting subtest: 64x64-top-bottom [104.088048] Starting dynamic subtest: pipe-A-eDP-1 [107.568077] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.484s) [107.577920] Starting dynamic subtest: pipe-D-eDP-1 [110.696359] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.128s) [110.698754] Subtest 64x64-top-bottom: SUCCESS (6.614s) [111.502042] [011/133] (907s left) gem_cs_tlb (engines) [111.557919] Starting subtest: engines [111.560244] Starting dynamic subtest: rcs0 [113.713949] Dynamic subtest rcs0: SUCCESS (2.152s) [113.723844] Starting dynamic subtest: bcs0 [115.866593] Dynamic subtest bcs0: SUCCESS (2.151s) [115.877426] Starting dynamic subtest: vcs0 [118.018697] Dynamic subtest vcs0: SUCCESS (2.152s) [118.029660] Starting dynamic subtest: vcs1 [120.170460] Dynamic subtest vcs1: SUCCESS (2.151s) [120.180632] Starting dynamic subtest: vecs0 [122.322401] Dynamic subtest vecs0: SUCCESS (2.152s) [122.332531] Starting dynamic subtest: ccs0 [124.475504] Dynamic subtest ccs0: SUCCESS (2.152s) [124.477586] Subtest engines: SUCCESS (12.915s) [124.583716] [012/133] (894s left) kms_color (legacy-gamma-reset) [124.675564] Starting subtest: legacy-gamma-reset [124.677636] Starting dynamic subtest: pipe-A-eDP-1 [125.047088] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.374s) [125.055032] Starting dynamic subtest: pipe-B-eDP-1 [125.061972] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.012s) [125.069697] Starting dynamic subtest: pipe-C-eDP-1 [125.074167] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.013s) [125.081659] Starting dynamic subtest: pipe-D-eDP-1 [125.085843] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s) [125.088077] Subtest legacy-gamma-reset: SUCCESS (0.413s) [125.850443] [013/133] (893s left) kms_vblank (query-idle-hang) [125.951523] Starting subtest: query-idle-hang [125.953849] Starting dynamic subtest: pipe-A-eDP-1 [152.727336] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.774s) [152.741831] Starting dynamic subtest: pipe-D-eDP-1 [177.687546] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.958s) [177.689988] Subtest query-idle-hang: SUCCESS (51.736s) [178.496282] [014/133] (840s left) kms_atomic (plane-overlay-legacy) [178.593304] Starting subtest: plane-overlay-legacy [178.595734] Starting dynamic subtest: pipe-A-eDP-1 [179.045291] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.452s) [179.047677] Subtest plane-overlay-legacy: SUCCESS (0.454s) [179.848588] [015/133] (839s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc) [179.944503] Starting subtest: fbcpsr-rgb565-draw-mmap-wc [186.798917] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.857s) [186.918424] [016/133] (832s left) gem_mmap_gtt (cpuset-basic-small-copy-xy) [186.978252] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s) [187.036249] [017/133] (832s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu) [187.137357] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu [194.211067] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.077s) [194.310247] [018/133] (825s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite) [194.405346] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite [194.409753] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [194.495623] [019/133] (825s left) gem_exec_whisper (basic-contexts) [194.561165] Starting subtest: basic-contexts [200.421194] Subtest basic-contexts: SUCCESS (5.857s) [200.614897] [020/133] (819s left) gem_busy (parallel) [200.796497] Starting subtest: parallel [200.798815] Starting dynamic subtest: rcs0 [202.903489] Dynamic subtest rcs0: SUCCESS (2.105s) [202.914324] Starting dynamic subtest: bcs0 [204.888305] Dynamic subtest bcs0: SUCCESS (1.982s) [204.899940] Starting dynamic subtest: vcs0 [206.871768] Dynamic subtest vcs0: SUCCESS (1.982s) [206.883226] Starting dynamic subtest: vcs1 [208.920079] Dynamic subtest vcs1: SUCCESS (2.046s) [208.931271] Starting dynamic subtest: vecs0 [210.903175] Dynamic subtest vecs0: SUCCESS (1.982s) [210.915784] Starting dynamic subtest: ccs0 [212.887189] Dynamic subtest ccs0: SUCCESS (1.982s) [212.890104] Subtest parallel: SUCCESS (12.090s) [213.130278] [021/133] (806s left) gem_exec_schedule (implicit-boths) [213.208481] Starting subtest: implicit-boths [213.211224] Starting dynamic subtest: rcs0 [213.393671] Dynamic subtest rcs0: SUCCESS (0.193s) [213.406422] Starting dynamic subtest: vcs0 [213.532344] Dynamic subtest vcs0: SUCCESS (0.140s) [213.542455] Starting dynamic subtest: vcs1 [213.640175] Dynamic subtest vcs1: SUCCESS (0.107s) [213.650345] Starting dynamic subtest: vecs0 [213.754515] Dynamic subtest vecs0: SUCCESS (0.113s) [213.765878] Starting dynamic subtest: ccs0 [213.878071] Dynamic subtest ccs0: SUCCESS (0.123s) [213.881043] Subtest implicit-boths: SUCCESS (0.679s) [215.045271] [022/133] (804s left) gem_render_copy_redux (flink) [215.116142] Starting subtest: flink [216.273243] Subtest flink: SUCCESS (1.160s) [216.408950] [023/133] (803s left) gem_exec_schedule (u-semaphore-codependency) [216.487687] Starting subtest: u-semaphore-codependency [216.503466] Subtest u-semaphore-codependency: SUCCESS (0.020s) [216.848360] [024/133] (802s left) kms_dsc (dsc-with-formats) [216.943760] Starting subtest: dsc-with-formats [216.982274] Subtest dsc-with-formats: SKIP (0.001s) [217.019445] [025/133] (802s left) kms_psr (psr-cursor-plane-onoff) [217.102775] Starting subtest: psr-cursor-plane-onoff [217.105143] Starting dynamic subtest: eDP-1 [218.838201] Dynamic subtest eDP-1: SUCCESS (1.736s) [218.840614] Subtest psr-cursor-plane-onoff: SUCCESS (1.736s) [219.698614] [026/133] (800s left) gem_exec_balancer (bonded-sync) [219.760856] Starting subtest: bonded-sync [219.765285] Subtest bonded-sync: SKIP (0.000s) [220.053554] [027/133] (799s left) kms_flip (2x-plain-flip) [220.145206] Starting subtest: 2x-plain-flip [220.154174] Subtest 2x-plain-flip: SKIP (0.011s) [220.232745] [028/133] (799s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner) [220.327667] Starting subtest: switch-modeset-ultra-joiner-big-joiner [220.331891] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s) [220.432481] [029/133] (799s left) gem_userptr_blits (readonly-pwrite-unsync) [220.501948] Subtest readonly-pwrite-unsync: SKIP (0.000s) [220.627989] [030/133] (799s left) kms_psr (fbc-psr-cursor-mmap-cpu) [220.716917] Starting subtest: fbc-psr-cursor-mmap-cpu [220.719216] Starting dynamic subtest: eDP-1 [220.723386] Dynamic subtest eDP-1: SKIP (0.000s) [220.727628] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s) [220.785625] [031/133] (799s left) syncobj_wait (invalid-signal-illegal-handle) [220.843393] Starting subtest: invalid-signal-illegal-handle [220.845651] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [220.951442] [032/133] (799s left) kms_psr (pr-primary-mmap-gtt) [221.045187] Starting subtest: pr-primary-mmap-gtt [221.048872] Subtest pr-primary-mmap-gtt: SKIP (0.000s) [221.118841] [033/133] (799s left) gem_exec_params (invalid-fence-in) [221.169130] Starting subtest: invalid-fence-in [221.171047] Subtest invalid-fence-in: SUCCESS (0.000s) [221.272878] [034/133] (799s left) gem_eio (hibernate) [221.529972] Starting subtest: hibernate [237.022463] Subtest hibernate: SUCCESS (15.491s) [243.149186] [035/133] (783s left) gem_ctx_param (invalid-get-no-zeromap) [243.229581] Starting subtest: invalid-get-no-zeromap [243.232070] Subtest invalid-get-no-zeromap: SUCCESS (0.001s) [243.331742] [036/133] (783s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite) [243.428453] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite [243.432539] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [243.531411] [037/133] (782s left) kms_dp_linktrain_fallback (dp-fallback) [243.637358] Starting subtest: dp-fallback [243.644068] Subtest dp-fallback: SKIP (0.001s) [243.717032] [038/133] (782s left) gem_exec_suspend (basic-s4-devices) [243.777887] Starting subtest: basic-S4-devices [243.780145] Starting dynamic subtest: smem [254.871082] Dynamic subtest smem: SUCCESS (11.092s) [254.874257] Subtest basic-S4-devices: SUCCESS (11.093s) [259.071045] [039/133] (771s left) syncobj_wait (single-wait-submitted) [259.145337] Starting subtest: single-wait-submitted [259.250806] Subtest single-wait-submitted: SUCCESS (0.105s) [259.326991] [040/133] (771s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [259.432657] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu [259.436779] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [259.527014] [041/133] (771s left) gem_exec_schedule (in-order) [259.591339] Starting subtest: in-order [259.593653] Starting dynamic subtest: rcs0 [259.695222] Dynamic subtest rcs0: SUCCESS (0.103s) [259.705228] Starting dynamic subtest: vcs0 [259.778860] Dynamic subtest vcs0: SUCCESS (0.084s) [259.790747] Starting dynamic subtest: vcs1 [259.856086] Dynamic subtest vcs1: SUCCESS (0.076s) [259.866631] Starting dynamic subtest: vecs0 [259.942175] Dynamic subtest vecs0: SUCCESS (0.085s) [259.954884] Starting dynamic subtest: ccs0 [260.031968] Dynamic subtest ccs0: SUCCESS (0.089s) [260.034872] Subtest in-order: SUCCESS (0.441s) [260.967899] [042/133] (769s left) prime_mmap_coherency (read) [261.026962] Starting subtest: read [266.404073] Subtest read: SUCCESS (5.379s) [266.527059] [043/133] (764s left) gem_close (many-handles-one-vma) [266.586324] Starting subtest: many-handles-one-vma [266.627408] Subtest many-handles-one-vma: SUCCESS (0.041s) [266.732736] [044/133] (763s left) core_getversion (all-cards) [266.764330] Starting subtest: all-cards [266.770991] Subtest all-cards: SUCCESS (0.009s) [266.823271] [045/133] (763s left) prime_busy (before-wait) [266.881985] Starting subtest: before-wait [266.886881] Starting dynamic subtest: rcs0 [266.919597] Dynamic subtest rcs0: SUCCESS (0.033s) [266.930286] Starting dynamic subtest: bcs0 [266.984895] Dynamic subtest bcs0: SUCCESS (0.065s) [267.001031] Starting dynamic subtest: vcs0 [267.028237] Dynamic subtest vcs0: SUCCESS (0.043s) [267.038522] Starting dynamic subtest: vcs1 [267.070119] Dynamic subtest vcs1: SUCCESS (0.041s) [267.081875] Starting dynamic subtest: vecs0 [267.112356] Dynamic subtest vecs0: SUCCESS (0.042s) [267.123705] Starting dynamic subtest: ccs0 [267.154888] Dynamic subtest ccs0: SUCCESS (0.042s) [267.262446] Subtest before-wait: SUCCESS (0.380s) [267.339027] [046/133] (763s left) gem_mmap_wc (fault-concurrent) [267.406558] Subtest fault-concurrent: SKIP (0.000s) [267.472735] [047/133] (763s left) gem_watchdog (default-virtual) [267.542193] Starting subtest: default-virtual [273.826280] Subtest default-virtual: SUCCESS (6.288s) [273.925724] [048/133] (756s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt) [274.033198] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt [274.037195] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [274.122577] [049/133] (756s left) kms_plane_scaling (invalid-num-scalers) [274.211183] Starting subtest: invalid-num-scalers [274.213429] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers [274.229347] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.019s) [274.239901] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers [274.264036] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.033s) [274.273707] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers [274.297296] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.032s) [274.307068] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers [274.329247] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.032s) [274.331442] Subtest invalid-num-scalers: SUCCESS (0.121s) [274.429169] [050/133] (756s left) gem_spin_batch (user-each) [274.501199] Starting subtest: user-each [277.773588] Subtest user-each: SUCCESS (3.263s) [277.997422] [051/133] (752s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier) [278.106823] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier [278.133797] Starting dynamic subtest: pipe-A-plane-0 [278.567557] Dynamic subtest pipe-A-plane-0: SUCCESS (0.433s) [278.580501] Starting dynamic subtest: pipe-A-plane-3 [278.823343] Dynamic subtest pipe-A-plane-3: SUCCESS (0.254s) [278.833526] Starting dynamic subtest: pipe-A-plane-5 [278.837819] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [279.902351] Starting dynamic subtest: pipe-B-plane-0 [280.325392] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s) [280.335666] Starting dynamic subtest: pipe-B-plane-3 [280.592265] Dynamic subtest pipe-B-plane-3: SUCCESS (0.266s) [280.602751] Starting dynamic subtest: pipe-B-plane-5 [280.607062] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [280.903301] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.795s) [281.774642] [052/133] (749s left) gem_eio (wait-immediate) [281.989718] Starting subtest: wait-immediate [282.336511] Subtest wait-immediate: SUCCESS (0.347s) [282.450993] [053/133] (748s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu) [282.549630] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu [282.553952] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [282.648609] [054/133] (748s left) gem_mmap_gtt (basic-write-gtt) [282.700571] Subtest basic-write-gtt: SKIP (0.000s) [282.756818] [055/133] (748s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling) [282.840256] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling [282.842095] Starting dynamic subtest: pipe-A-default-mode [285.609206] Dynamic subtest pipe-A-default-mode: SUCCESS (2.767s) [285.611859] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.769s) [286.474734] [056/133] (744s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf) [286.573152] Starting subtest: fbc-psr2-cursor-plane-update-sf [286.575654] Starting dynamic subtest: pipe-A-eDP-1 [286.644129] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s) [286.656062] Starting dynamic subtest: pipe-B-eDP-1 [287.746919] Dynamic subtest pipe-B-eDP-1: SKIP (1.100s) [287.751081] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.180s) [288.926258] [057/133] (742s left) gem_ctx_param (invalid-ctx-get) [288.992276] Starting subtest: invalid-ctx-get [288.994701] Subtest invalid-ctx-get: SUCCESS (0.000s) [289.067326] [058/133] (742s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant) [289.159915] Starting subtest: coverage-vs-premult-vs-constant [289.446676] Starting dynamic subtest: pipe-A-eDP-1 [290.014322] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.566s) [290.024278] Starting dynamic subtest: pipe-D-eDP-1 [291.356129] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.340s) [291.358526] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.197s) [292.183062] [059/133] (739s left) kms_atomic_interruptible (legacy-setmode) [292.275359] Starting subtest: legacy-setmode [292.277687] Starting dynamic subtest: pipe-A-eDP-1 [299.174910] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.898s) [299.177323] Subtest legacy-setmode: SUCCESS (6.899s) [300.056456] [060/133] (731s left) api_intel_bb (object-reloc-purge-cache) [300.113955] Starting subtest: object-reloc-purge-cache [300.118405] Subtest object-reloc-purge-cache: SKIP (0.002s) [300.236868] [061/133] (731s left) kms_psr (psr-sprite-render) [300.330111] Starting subtest: psr-sprite-render [300.332418] Starting dynamic subtest: eDP-1 [302.066544] Dynamic subtest eDP-1: SUCCESS (1.735s) [302.068795] Subtest psr-sprite-render: SUCCESS (1.736s) [302.903092] [062/133] (728s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff) [302.999779] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff [306.883826] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.888s) [308.018193] [063/133] (723s left) kms_chamelium_hpd (vga-hpd-for-each-pipe) [308.403953] Subtest vga-hpd-for-each-pipe: SKIP (0.000s) [309.219612] [064/133] (722s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move) [309.325806] Starting subtest: fbc-2p-primscrn-spr-indfb-move [309.330059] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s) [309.408942] [065/133] (722s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format) [309.508893] Starting subtest: plane-upscale-20x20-with-pixel-format [309.511575] Starting dynamic subtest: pipe-A [310.555238] Dynamic subtest pipe-A: SUCCESS (1.050s) [310.565038] Starting dynamic subtest: pipe-B [312.643539] Dynamic subtest pipe-B: SUCCESS (2.087s) [312.653976] Starting dynamic subtest: pipe-C [313.835153] Dynamic subtest pipe-C: SUCCESS (1.190s) [313.845782] Starting dynamic subtest: pipe-D [315.073127] Dynamic subtest pipe-D: SUCCESS (1.237s) [315.075481] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.568s) [316.281937] [066/133] (715s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt) [316.383295] Starting subtest: fbc-rgb101010-draw-blt [320.991503] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.610s) [322.177248] [067/133] (709s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0) [322.289628] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0 [322.294137] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s) [322.385510] [068/133] (709s left) i915_drm_fdinfo (virtual-busy-hang) [322.426349] Starting subtest: virtual-busy-hang [322.430704] Subtest virtual-busy-hang: SKIP (0.000s) [322.489843] [069/133] (709s left) kms_pm_rpm (pc8-residency) [324.031446] Starting subtest: pc8-residency [324.036227] Subtest pc8-residency: SKIP (0.000s) [324.810179] [070/133] (706s left) i915_pm_rc6_residency (rc6-idle) [324.871216] Starting subtest: rc6-idle [324.891168] Starting dynamic subtest: gt0-rcs0 [349.174998] Dynamic subtest gt0-rcs0: SUCCESS (24.283s) [349.187573] Starting dynamic subtest: gt0-bcs0 [373.387353] Dynamic subtest gt0-bcs0: SUCCESS (24.210s) [373.397025] Starting dynamic subtest: gt0-ccs0 [397.750030] Dynamic subtest gt0-ccs0: SUCCESS (24.360s) [397.762601] Starting dynamic subtest: gt1-vcs0 [403.925066] Dynamic subtest gt1-vcs0: SUCCESS (6.170s) [403.936990] Starting dynamic subtest: gt1-vecs0 [410.096853] Dynamic subtest gt1-vecs0: SUCCESS (6.169s) [410.099499] Subtest rc6-idle: SUCCESS (85.229s) [410.190057] [071/133] (621s left) kms_cursor_legacy (flip-vs-cursor-varying-size) [410.317680] Starting subtest: flip-vs-cursor-varying-size [419.013529] Subtest flip-vs-cursor-varying-size: SUCCESS (8.696s) [419.814472] [072/133] (612s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180) [419.934708] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180 [420.913821] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.979s) [421.049466] [073/133] (610s left) prime_vgem (fence-write-hang) [421.230962] Subtest fence-write-hang: SKIP (0.000s) [421.334562] [FACT prime_vgem (fence-write-hang)] new: kernel.kmod_is_loaded.vgem: true [421.338731] [074/133] (610s left) kms_universal_plane (universal-plane-sanity) [421.435561] Starting subtest: universal-plane-sanity [421.437381] Starting dynamic subtest: pipe-A-eDP-1 [422.040054] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.605s) [422.050105] Starting dynamic subtest: pipe-B-eDP-1 [423.265541] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.220s) [423.275863] Starting dynamic subtest: pipe-C-eDP-1 [424.462996] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.199s) [424.475431] Starting dynamic subtest: pipe-D-eDP-1 [425.688796] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.225s) [425.691475] Subtest universal-plane-sanity: SUCCESS (4.255s) [426.547892] [075/133] (605s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt) [426.652056] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt [426.656307] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [426.763166] [076/133] (605s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc) [426.855852] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc [426.859789] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [426.947891] [077/133] (605s left) gen9_exec_parse (bb-start-param) [427.021129] Subtest bb-start-param: SKIP (0.000s) [427.093627] [078/133] (604s left) kms_ccs (random-ccs-data-yf-tiled-ccs) [427.191178] Starting subtest: random-ccs-data-yf-tiled-ccs [427.193461] Starting dynamic subtest: pipe-A-eDP-1 [427.217718] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [427.228418] Starting dynamic subtest: pipe-B-eDP-1 [427.251698] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [427.261889] Starting dynamic subtest: pipe-C-eDP-1 [427.284885] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [427.294657] Starting dynamic subtest: pipe-D-eDP-1 [427.317996] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [427.322025] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.004s) [429.512183] [079/133] (602s left) kms_content_protection (suspend-resume) [429.646570] Starting subtest: suspend-resume [429.651515] Subtest suspend-resume: SKIP (0.000s) [429.773550] [080/133] (602s left) kms_big_fb (x-tiled-16bpp-rotate-90) [429.871315] Starting subtest: x-tiled-16bpp-rotate-90 [429.894172] Subtest x-tiled-16bpp-rotate-90: SKIP (0.020s) [430.017891] [081/133] (602s left) gem_partial_pwrite_pread (reads-uncached) [430.081143] Subtest reads-uncached: SKIP (0.000s) [430.145865] [082/133] (602s left) sysfs_heartbeat_interval (precise) [430.203428] Starting subtest: precise [430.205805] Starting dynamic subtest: vecs0 [437.909676] Dynamic subtest vecs0: SUCCESS (7.705s) [437.934047] Starting dynamic subtest: ccs0 [439.078686] Dynamic subtest ccs0: SUCCESS (1.167s) [439.090566] Starting dynamic subtest: vcs0 [446.929250] Dynamic subtest vcs0: SUCCESS (7.849s) [446.941923] Starting dynamic subtest: bcs0 [448.060504] Dynamic subtest bcs0: SUCCESS (1.128s) [448.072412] Starting dynamic subtest: rcs0 [449.140712] Dynamic subtest rcs0: SUCCESS (1.077s) [449.153709] Starting dynamic subtest: vcs1 [456.913575] Dynamic subtest vcs1: SUCCESS (7.773s) [456.916099] Subtest precise: SUCCESS (26.711s) [456.995494] [083/133] (575s left) kms_psr (fbc-psr2-primary-page-flip) [457.091812] Starting subtest: fbc-psr2-primary-page-flip [457.093962] Starting dynamic subtest: eDP-1 [457.097948] Dynamic subtest eDP-1: SKIP (0.000s) [457.101958] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s) [457.167037] [084/133] (575s left) gem_mmap_offset (partial-remap) [457.216171] Starting subtest: partial-remap [457.218341] Starting dynamic subtest: smem0 [457.226796] Dynamic subtest smem0: SUCCESS (0.003s) [457.228955] Subtest partial-remap: SUCCESS (0.004s) [457.335600] [085/133] (575s left) syncobj_timeline (multi-wait-available-submitted) [457.386360] Starting subtest: multi-wait-available-submitted [457.388590] Subtest multi-wait-available-submitted: SUCCESS (0.001s) [457.488249] [086/133] (574s left) i915_query (hwconfig_table) [457.534992] Starting subtest: hwconfig_table [457.830800] Subtest hwconfig_table: SUCCESS (0.001s) [457.875238] [087/133] (574s left) gem_ctx_persistence (processes) [457.928647] Starting subtest: processes [459.870526] Subtest processes: SUCCESS (1.941s) [459.964920] [088/133] (572s left) kms_big_fb (4-tiled-64bpp-rotate-0) [460.064054] Starting subtest: 4-tiled-64bpp-rotate-0 [461.602507] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.538s) [461.773630] [089/133] (570s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render) [461.863493] Starting subtest: psr-rgb101010-draw-render [469.219482] Subtest psr-rgb101010-draw-render: SUCCESS (7.358s) [469.345977] [090/133] (563s left) gem_render_copy (yf-tiled-ccs-to-y-tiled) [469.414196] Starting subtest: yf-tiled-ccs-to-y-tiled [469.418838] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s) [469.598996] [091/133] (563s left) kms_cursor_crc (cursor-rapid-movement-512x512) [469.889547] Starting subtest: cursor-rapid-movement-512x512 [469.894327] Subtest cursor-rapid-movement-512x512: SKIP (0.001s) [470.061963] [092/133] (562s left) kms_pm_rpm (fences-dpms) [472.001015] Starting subtest: fences-dpms [472.005782] Subtest fences-dpms: SKIP (0.000s) [472.406378] [093/133] (560s left) kms_flip (plain-flip-ts-check-interruptible) [472.515918] Starting subtest: plain-flip-ts-check-interruptible [472.518626] Starting dynamic subtest: A-eDP1 [481.379355] Dynamic subtest A-eDP1: SUCCESS (8.862s) [481.392650] Starting dynamic subtest: B-eDP1 [490.204065] Dynamic subtest B-eDP1: SUCCESS (8.821s) [490.216169] Starting dynamic subtest: C-eDP1 [499.023601] Dynamic subtest C-eDP1: SUCCESS (8.819s) [499.035063] Starting dynamic subtest: D-eDP1 [507.858832] Dynamic subtest D-eDP1: SUCCESS (8.834s) [507.864102] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.348s) [509.043121] [094/133] (523s left) i915_pm_freq_api (freq-basic-api) [509.111024] Starting subtest: freq-basic-api [509.113403] Starting dynamic subtest: gt0 [509.115754] Dynamic subtest gt0: SUCCESS (0.003s) [509.126209] Starting dynamic subtest: gt1 [509.128140] Dynamic subtest gt1: SUCCESS (0.003s) [509.130112] Subtest freq-basic-api: SUCCESS (0.007s) [509.230890] [095/133] (523s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted) [509.343451] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted [509.475292] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.134s) [509.603325] [096/133] (523s left) perf_pmu (busy-accuracy-50) [509.645558] Starting subtest: busy-accuracy-50 [509.647449] Starting dynamic subtest: rcs0 [511.180152] Dynamic subtest rcs0: SUCCESS (1.532s) [511.192198] Starting dynamic subtest: bcs0 [512.725286] Dynamic subtest bcs0: SUCCESS (1.542s) [512.737066] Starting dynamic subtest: vcs0 [514.266732] Dynamic subtest vcs0: SUCCESS (1.540s) [514.279313] Starting dynamic subtest: vcs1 [515.810269] Dynamic subtest vcs1: SUCCESS (1.540s) [515.822911] Starting dynamic subtest: vecs0 [517.352465] Dynamic subtest vecs0: SUCCESS (1.538s) [517.362885] Starting dynamic subtest: ccs0 [518.898946] Dynamic subtest ccs0: SUCCESS (1.545s) [518.901455] Subtest busy-accuracy-50: SUCCESS (9.252s) [519.013249] [097/133] (513s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move) [519.110742] Starting subtest: psr-1p-primscrn-spr-indfb-move [526.709306] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.601s) [526.848504] [098/133] (506s left) gem_pipe_control_store_loop (reused-buffer) [526.916538] Starting subtest: reused-buffer [529.069726] Subtest reused-buffer: SUCCESS (2.151s) [529.174849] [099/133] (503s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs) [529.267279] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs [529.269521] Starting dynamic subtest: pipe-A-eDP-1 [529.754047] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.461s) [529.764683] Starting dynamic subtest: pipe-B-eDP-1 [531.249394] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.490s) [531.260264] Starting dynamic subtest: pipe-C-eDP-1 [532.593587] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.345s) [532.606414] Starting dynamic subtest: pipe-D-eDP-1 [534.007168] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.411s) [534.009372] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.712s) [535.190355] [100/133] (497s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic) [535.325055] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic [535.329768] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s) [535.468346] [101/133] (497s left) kms_chamelium_frames (dp-crc-single) [535.858899] Subtest dp-crc-single: SKIP (0.000s) [536.701902] [102/133] (496s left) gem_readwrite (read-bad-handle) [536.757683] Subtest read-bad-handle: SKIP (0.000s) [536.816756] [103/133] (496s left) gem_exec_fence (basic-await) [536.988617] Starting subtest: basic-await [536.990684] Starting dynamic subtest: rcs0 [537.060516] Dynamic subtest rcs0: SUCCESS (0.075s) [537.075919] Starting dynamic subtest: bcs0 [537.136653] Dynamic subtest bcs0: SUCCESS (0.073s) [537.149602] Starting dynamic subtest: vcs0 [537.216809] Dynamic subtest vcs0: SUCCESS (0.080s) [537.229735] Starting dynamic subtest: vcs1 [537.291586] Dynamic subtest vcs1: SUCCESS (0.072s) [537.304049] Starting dynamic subtest: vecs0 [537.364705] Dynamic subtest vecs0: SUCCESS (0.072s) [537.378084] Starting dynamic subtest: ccs0 [537.439818] Dynamic subtest ccs0: SUCCESS (0.073s) [537.442547] Subtest basic-await: SUCCESS (0.455s) [538.998503] [104/133] (494s left) kms_big_fb (yf-tiled-32bpp-rotate-90) [539.106062] Starting subtest: yf-tiled-32bpp-rotate-90 [539.110569] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s) [539.210859] [105/133] (494s left) gem_pxp (reject-modify-context-protection-off-1) [539.271846] Starting subtest: reject-modify-context-protection-off-1 [539.274186] Subtest reject-modify-context-protection-off-1: SUCCESS (0.001s) [539.395305] [106/133] (493s left) gem_exec_reloc (basic-cpu-noreloc) [539.452361] Subtest basic-cpu-noreloc: SKIP (0.000s) [539.526341] [107/133] (493s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite) [539.613740] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite [549.006361] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.393s) [549.124901] [108/133] (484s left) kms_rotation_crc (primary-x-tiled-reflect-x-180) [549.237833] Starting subtest: primary-x-tiled-reflect-x-180 [556.213463] Subtest primary-x-tiled-reflect-x-180: SUCCESS (6.977s) [557.390267] [109/133] (476s left) gem_exec_reloc (basic-write-wc-active) [557.448669] Subtest basic-write-wc-active: SKIP (0.000s) [557.525462] [110/133] (475s left) syncobj_timeline (wait-all-complex) [557.591302] Starting subtest: wait-all-complex [557.811112] Subtest wait-all-complex: SUCCESS (0.218s) [557.893225] [111/133] (475s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area) [557.986875] Starting subtest: psr2-plane-move-sf-dmg-area [557.989036] Starting dynamic subtest: pipe-A-eDP-1 [562.522567] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.538s) [562.534881] Starting dynamic subtest: pipe-B-eDP-1 [567.854739] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.329s) [567.856899] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.870s) [568.725135] [112/133] (464s left) gem_exec_fence (syncobj-timeline-invalid-flags) [569.288598] Starting subtest: syncobj-timeline-invalid-flags [569.290855] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s) [570.975863] [113/133] (462s left) perf (blocking) [571.111828] Starting subtest: blocking [571.113686] Starting dynamic subtest: 0-rcs0 [581.143464] Dynamic subtest 0-rcs0: SUCCESS (10.032s) [581.157912] Starting dynamic subtest: 1-vecs0 [591.162475] Dynamic subtest 1-vecs0: SUCCESS (10.016s) [591.165360] Subtest blocking: SUCCESS (20.052s) [591.216998] [114/133] (442s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted) [591.272077] Starting subtest: etime-multi-wait-for-submit-unsubmitted [591.379348] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.106s) [591.460974] [115/133] (442s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf) [591.567377] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf [591.571684] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [591.634228] [116/133] (442s left) kms_invalid_mode (bad-vsync-start) [591.730093] Starting subtest: bad-vsync-start [591.732248] Starting dynamic subtest: pipe-A-eDP-1 [592.016271] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s) [592.026951] Starting dynamic subtest: pipe-B-eDP-1 [592.028835] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [592.038428] Starting dynamic subtest: pipe-C-eDP-1 [592.040692] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [592.050603] Starting dynamic subtest: pipe-D-eDP-1 [592.052914] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [592.055056] Subtest bad-vsync-start: SUCCESS (0.294s) [592.858732] [117/133] (440s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff) [592.953205] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff [600.077891] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.127s) [600.224969] [118/133] (433s left) gem_exec_reloc (basic-gtt-wc) [600.280724] Subtest basic-gtt-wc: SKIP (0.000s) [600.349145] [119/133] (433s left) kms_plane_lowres (tiling-x) [600.439118] Starting subtest: tiling-x [600.441328] Starting dynamic subtest: pipe-A-eDP-1 [600.445624] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [600.747992] Starting dynamic subtest: pipe-B-eDP-1 [600.752325] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [600.762475] Starting dynamic subtest: pipe-C-eDP-1 [600.767047] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [600.777066] Starting dynamic subtest: pipe-D-eDP-1 [600.781755] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [600.786316] Subtest tiling-x: SKIP (0.319s) [601.621482] [120/133] (432s left) gem_ctx_shared (q-smoketest-all) [601.688329] Starting subtest: Q-smoketest-all [634.072990] Subtest Q-smoketest-all: SUCCESS (32.337s) [635.016723] [121/133] (398s left) gem_softpin (evict-snoop) [635.079845] Starting subtest: evict-snoop [635.084113] Subtest evict-snoop: SKIP (0.000s) [635.208347] [122/133] (398s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling) [635.306844] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling [635.311134] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s) [635.382326] [123/133] (398s left) syncobj_wait (multi-wait-submitted-signaled) [635.439169] Starting subtest: multi-wait-submitted-signaled [635.441284] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s) [635.536641] [124/133] (398s left) syncobj_wait (reset-unsignaled) [635.590054] Starting subtest: reset-unsignaled [635.592366] Subtest reset-unsignaled: SUCCESS (0.000s) [635.682590] [125/133] (398s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [635.786986] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [636.611059] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.826s) [636.766494] [126/133] (397s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs) [636.862019] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs [636.864263] Starting dynamic subtest: pipe-A-eDP-1 [636.886254] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [636.898545] Starting dynamic subtest: pipe-B-eDP-1 [636.920088] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [636.930234] Starting dynamic subtest: pipe-C-eDP-1 [636.951468] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [636.963718] Starting dynamic subtest: pipe-D-eDP-1 [636.985993] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [636.990063] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.008s) [639.169467] [127/133] (395s left) syncobj_wait (invalid-single-wait-unsubmitted) [639.223629] Starting subtest: invalid-single-wait-unsubmitted [639.225879] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s) [639.321378] [128/133] (394s left) perf_pmu (render-node-busy-idle) [639.388988] Starting subtest: render-node-busy-idle [639.391442] Starting dynamic subtest: rcs0 [640.071853] Dynamic subtest rcs0: SUCCESS (0.682s) [640.084892] Starting dynamic subtest: bcs0 [640.734074] Dynamic subtest bcs0: SUCCESS (0.660s) [640.747182] Starting dynamic subtest: vcs0 [641.878028] Dynamic subtest vcs0: SUCCESS (1.141s) [641.889856] Starting dynamic subtest: vcs1 [643.926773] Dynamic subtest vcs1: SUCCESS (2.046s) [643.938207] Starting dynamic subtest: vecs0 [645.910804] Dynamic subtest vecs0: SUCCESS (1.981s) [645.921823] Starting dynamic subtest: ccs0 [646.582444] Dynamic subtest ccs0: SUCCESS (0.670s) [646.585437] Subtest render-node-busy-idle: SUCCESS (7.194s) [646.661252] [129/133] (387s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted) [646.717810] Starting subtest: multi-wait-all-for-submit-available-submitted [646.720204] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s) [646.819060] [130/133] (387s left) prime_vgem (basic-fence-read) [646.888030] Starting subtest: basic-fence-read [646.907195] Subtest basic-fence-read: SKIP (0.017s) [647.025021] [131/133] (387s left) kms_addfb_basic (bad-pitch-65536) [647.089601] Starting subtest: bad-pitch-65536 [647.091644] Subtest bad-pitch-65536: SUCCESS (0.000s) [647.229221] [132/133] (387s left) kms_fbcon_fbt (psr-suspend) [647.295187] Starting subtest: psr-suspend [697.864842] Subtest psr-suspend: SUCCESS (20.543s) [699.947538] [133/133] (336s left) syncobj_eventfd (binary-wait-before-signal) [700.022470] Starting subtest: binary-wait-before-signal [700.052346] Subtest binary-wait-before-signal: SUCCESS (0.031s) [700.139112] 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.