[58.570515] Initializing watchdogs [58.570559] /dev/watchdog0 [58.584107] [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.588462] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.590750] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.594783] [001/133] (960s left) kms_cursor_crc (cursor-onscreen-512x512) [58.905737] Starting subtest: cursor-onscreen-512x512 [58.909465] Subtest cursor-onscreen-512x512: SKIP (0.001s) [59.055318] [002/133] (960s left) gem_exec_whisper (basic-queues-priority-all) [59.112071] Starting subtest: basic-queues-priority-all [81.088776] Subtest basic-queues-priority-all: SUCCESS (21.963s) [81.277127] [003/133] (937s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt) [81.386496] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt [81.390471] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [81.479718] [004/133] (937s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs) [81.572226] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs [81.576763] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s) [82.672632] [005/133] (936s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip) [82.777062] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip [82.781533] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [82.850896] [006/133] (936s left) gem_ctx_param (basic-default) [82.903493] Starting subtest: basic-default [82.905980] Subtest basic-default: SUCCESS (0.000s) [82.961879] [007/133] (936s left) kms_flip (bo-too-big-interruptible) [83.049132] Starting subtest: bo-too-big-interruptible [83.051496] Starting dynamic subtest: A-eDP1 [84.322862] Dynamic subtest A-eDP1: SUCCESS (1.273s) [84.333053] Starting dynamic subtest: B-eDP1 [85.551635] Dynamic subtest B-eDP1: SUCCESS (1.228s) [85.563888] Starting dynamic subtest: C-eDP1 [86.796842] Dynamic subtest C-eDP1: SUCCESS (1.244s) [86.805556] Starting dynamic subtest: D-eDP1 [88.031515] Dynamic subtest D-eDP1: SUCCESS (1.233s) [88.034092] Subtest bo-too-big-interruptible: SUCCESS (4.984s) [89.239153] [008/133] (930s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs) [89.339100] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs [89.341445] Starting dynamic subtest: pipe-A-eDP-1 [89.483648] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.136s) [89.495174] Starting dynamic subtest: pipe-B-eDP-1 [89.514552] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [89.522430] Starting dynamic subtest: pipe-C-eDP-1 [89.542197] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s) [89.549465] Starting dynamic subtest: pipe-D-eDP-1 [89.569163] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s) [89.571078] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.143s) [91.796209] [009/133] (927s left) kms_async_flips (alternate-sync-async-flip-atomic) [91.886266] Starting subtest: alternate-sync-async-flip-atomic [92.271773] Starting dynamic subtest: pipe-A-eDP-1 [95.085433] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.814s) [95.458408] Starting dynamic subtest: pipe-B-eDP-1 [98.211945] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.761s) [98.579486] Starting dynamic subtest: pipe-C-eDP-1 [101.339190] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.767s) [101.707587] Starting dynamic subtest: pipe-D-eDP-1 [104.464406] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.768s) [104.466477] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.581s) [105.640812] [010/133] (913s left) kms_cursor_edge_walk (64x64-top-bottom) [105.729192] Starting subtest: 64x64-top-bottom [105.731584] Starting dynamic subtest: pipe-A-eDP-1 [109.216080] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.487s) [109.225640] Starting dynamic subtest: pipe-D-eDP-1 [112.353117] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.136s) [112.354990] Subtest 64x64-top-bottom: SUCCESS (6.625s) [113.149692] [011/133] (906s left) gem_cs_tlb (engines) [113.209293] Starting subtest: engines [113.211184] Starting dynamic subtest: rcs0 [115.367218] Dynamic subtest rcs0: SUCCESS (2.155s) [115.377672] Starting dynamic subtest: bcs0 [117.519770] Dynamic subtest bcs0: SUCCESS (2.152s) [117.528059] Starting dynamic subtest: vcs0 [119.671924] Dynamic subtest vcs0: SUCCESS (2.152s) [119.681125] Starting dynamic subtest: vcs1 [121.824251] Dynamic subtest vcs1: SUCCESS (2.152s) [121.831801] Starting dynamic subtest: vecs0 [123.979382] Dynamic subtest vecs0: SUCCESS (2.152s) [123.992336] Starting dynamic subtest: ccs0 [126.130309] Dynamic subtest ccs0: SUCCESS (2.153s) [126.132497] Subtest engines: SUCCESS (12.919s) [126.240621] [012/133] (893s left) kms_color (legacy-gamma-reset) [126.349296] Starting subtest: legacy-gamma-reset [126.351272] Starting dynamic subtest: pipe-A-eDP-1 [126.725195] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.376s) [126.733690] Starting dynamic subtest: pipe-B-eDP-1 [126.738272] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.012s) [126.745888] Starting dynamic subtest: pipe-C-eDP-1 [126.750531] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.012s) [126.758202] Starting dynamic subtest: pipe-D-eDP-1 [126.763206] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s) [126.765638] Subtest legacy-gamma-reset: SUCCESS (0.414s) [127.561284] [013/133] (891s left) kms_vblank (query-idle-hang) [127.659068] Starting subtest: query-idle-hang [127.661372] Starting dynamic subtest: pipe-A-eDP-1 [153.696025] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.034s) [153.711801] Starting dynamic subtest: pipe-D-eDP-1 [178.655160] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.957s) [178.657477] Subtest query-idle-hang: SUCCESS (50.996s) [179.526319] [014/133] (840s left) kms_atomic (plane-overlay-legacy) [179.617440] Starting subtest: plane-overlay-legacy [179.619693] Starting dynamic subtest: pipe-A-eDP-1 [180.038085] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.420s) [180.040666] Subtest plane-overlay-legacy: SUCCESS (0.422s) [180.847565] [015/133] (838s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc) [180.950219] Starting subtest: fbcpsr-rgb565-draw-mmap-wc [187.802117] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.856s) [187.910639] [016/133] (831s left) gem_mmap_gtt (cpuset-basic-small-copy-xy) [187.981402] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s) [188.066639] [017/133] (831s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu) [188.178725] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu [195.232293] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.055s) [195.354389] [018/133] (824s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite) [195.454438] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite [195.458581] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [195.551995] [019/133] (824s left) gem_exec_whisper (basic-contexts) [195.624848] Starting subtest: basic-contexts [202.870394] Subtest basic-contexts: SUCCESS (7.243s) [203.051879] [020/133] (816s left) gem_busy (parallel) [203.248480] Starting subtest: parallel [203.250846] Starting dynamic subtest: rcs0 [204.887415] Dynamic subtest rcs0: SUCCESS (1.636s) [204.906544] Starting dynamic subtest: bcs0 [206.936405] Dynamic subtest bcs0: SUCCESS (2.047s) [206.955230] Starting dynamic subtest: vcs0 [208.855413] Dynamic subtest vcs0: SUCCESS (1.916s) [208.874066] Starting dynamic subtest: vcs1 [210.840158] Dynamic subtest vcs1: SUCCESS (1.982s) [210.859476] Starting dynamic subtest: vecs0 [212.888799] Dynamic subtest vecs0: SUCCESS (2.044s) [212.907779] Starting dynamic subtest: ccs0 [214.870572] Dynamic subtest ccs0: SUCCESS (1.981s) [214.873378] Subtest parallel: SUCCESS (11.622s) [215.125614] [021/133] (804s left) gem_exec_schedule (implicit-boths) [215.201044] Starting subtest: implicit-boths [215.203115] Starting dynamic subtest: rcs0 [215.366507] Dynamic subtest rcs0: SUCCESS (0.175s) [215.377635] Starting dynamic subtest: vcs0 [215.472958] Dynamic subtest vcs0: SUCCESS (0.106s) [215.484788] Starting dynamic subtest: vcs1 [215.605847] Dynamic subtest vcs1: SUCCESS (0.132s) [215.616681] Starting dynamic subtest: vecs0 [215.716878] Dynamic subtest vecs0: SUCCESS (0.111s) [215.728021] Starting dynamic subtest: ccs0 [215.837800] Dynamic subtest ccs0: SUCCESS (0.120s) [215.840805] Subtest implicit-boths: SUCCESS (0.647s) [217.002822] [022/133] (802s left) gem_render_copy_redux (flink) [217.069140] Starting subtest: flink [218.175671] Subtest flink: SUCCESS (1.107s) [218.312056] [023/133] (801s left) gem_exec_schedule (u-semaphore-codependency) [218.391957] Starting subtest: u-semaphore-codependency [218.404863] Subtest u-semaphore-codependency: SUCCESS (0.017s) [218.752252] [024/133] (801s left) kms_dsc (dsc-with-formats) [218.848774] Starting subtest: dsc-with-formats [218.888033] Subtest dsc-with-formats: SKIP (0.001s) [218.931115] [025/133] (801s left) kms_psr (psr-cursor-plane-onoff) [219.022201] Starting subtest: psr-cursor-plane-onoff [219.024573] Starting dynamic subtest: eDP-1 [220.791978] Dynamic subtest eDP-1: SUCCESS (1.771s) [220.794384] Subtest psr-cursor-plane-onoff: SUCCESS (1.772s) [221.653218] [026/133] (798s left) gem_exec_balancer (bonded-sync) [221.713938] Starting subtest: bonded-sync [221.718394] Subtest bonded-sync: SKIP (0.000s) [222.009212] [027/133] (798s left) kms_flip (2x-plain-flip) [222.110457] Starting subtest: 2x-plain-flip [222.122084] Subtest 2x-plain-flip: SKIP (0.014s) [222.197829] [028/133] (797s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner) [222.284685] Starting subtest: switch-modeset-ultra-joiner-big-joiner [222.288977] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s) [222.348797] [029/133] (797s left) gem_userptr_blits (readonly-pwrite-unsync) [222.413579] Subtest readonly-pwrite-unsync: SKIP (0.000s) [222.518582] [030/133] (797s left) kms_psr (fbc-psr-cursor-mmap-cpu) [222.613141] Starting subtest: fbc-psr-cursor-mmap-cpu [222.615317] Starting dynamic subtest: eDP-1 [222.619308] Dynamic subtest eDP-1: SKIP (0.000s) [222.623271] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s) [222.683479] [031/133] (797s left) syncobj_wait (invalid-signal-illegal-handle) [222.732063] Starting subtest: invalid-signal-illegal-handle [222.733984] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [222.842549] [032/133] (797s left) kms_psr (pr-primary-mmap-gtt) [222.921333] Starting subtest: pr-primary-mmap-gtt [222.924892] Subtest pr-primary-mmap-gtt: SKIP (0.000s) [222.991237] [033/133] (797s left) gem_exec_params (invalid-fence-in) [223.051256] Starting subtest: invalid-fence-in [223.053304] Subtest invalid-fence-in: SUCCESS (0.000s) [223.144275] [034/133] (797s left) gem_eio (hibernate) [223.362922] Starting subtest: hibernate [238.788233] Subtest hibernate: SUCCESS (15.423s) [246.912312] [035/133] (781s left) gem_ctx_param (invalid-get-no-zeromap) [246.997304] Starting subtest: invalid-get-no-zeromap [246.999712] Subtest invalid-get-no-zeromap: SUCCESS (0.001s) [247.095171] [036/133] (781s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite) [247.207701] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite [247.212103] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [247.316953] [037/133] (781s left) kms_dp_linktrain_fallback (dp-fallback) [247.408821] Starting subtest: dp-fallback [247.415132] Subtest dp-fallback: SKIP (0.000s) [247.482335] [038/133] (781s left) gem_exec_suspend (basic-s4-devices) [247.549830] Starting subtest: basic-S4-devices [247.552138] Starting dynamic subtest: smem [258.903816] Dynamic subtest smem: SUCCESS (11.350s) [258.907666] Subtest basic-S4-devices: SUCCESS (11.353s) [265.103947] [039/133] (769s left) syncobj_wait (single-wait-submitted) [265.178507] Starting subtest: single-wait-submitted [265.281810] Subtest single-wait-submitted: SUCCESS (0.102s) [265.355574] [040/133] (769s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [265.460872] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu [265.465250] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [265.557726] [041/133] (769s left) gem_exec_schedule (in-order) [265.632598] Starting subtest: in-order [265.634603] Starting dynamic subtest: rcs0 [265.726909] Dynamic subtest rcs0: SUCCESS (0.102s) [265.739314] Starting dynamic subtest: vcs0 [265.810722] Dynamic subtest vcs0: SUCCESS (0.084s) [265.825912] Starting dynamic subtest: vcs1 [265.890451] Dynamic subtest vcs1: SUCCESS (0.078s) [265.904830] Starting dynamic subtest: vecs0 [265.976065] Dynamic subtest vecs0: SUCCESS (0.086s) [265.990656] Starting dynamic subtest: ccs0 [266.067024] Dynamic subtest ccs0: SUCCESS (0.090s) [266.069727] Subtest in-order: SUCCESS (0.443s) [266.997694] [042/133] (767s left) prime_mmap_coherency (read) [267.064583] Starting subtest: read [272.439047] Subtest read: SUCCESS (5.373s) [272.559323] [043/133] (762s left) gem_close (many-handles-one-vma) [272.613529] Starting subtest: many-handles-one-vma [272.658339] Subtest many-handles-one-vma: SUCCESS (0.044s) [272.773427] [044/133] (762s left) core_getversion (all-cards) [272.807731] Starting subtest: all-cards [272.812508] Subtest all-cards: SUCCESS (0.009s) [272.847814] [045/133] (761s left) prime_busy (before-wait) [272.903891] Starting subtest: before-wait [272.906304] Starting dynamic subtest: rcs0 [272.944360] Dynamic subtest rcs0: SUCCESS (0.040s) [272.956226] Starting dynamic subtest: bcs0 [273.003052] Dynamic subtest bcs0: SUCCESS (0.058s) [273.012121] Starting dynamic subtest: vcs0 [273.043704] Dynamic subtest vcs0: SUCCESS (0.040s) [273.055108] Starting dynamic subtest: vcs1 [273.085303] Dynamic subtest vcs1: SUCCESS (0.041s) [273.095176] Starting dynamic subtest: vecs0 [273.128472] Dynamic subtest vecs0: SUCCESS (0.042s) [273.138403] Starting dynamic subtest: ccs0 [273.170314] Dynamic subtest ccs0: SUCCESS (0.041s) [273.276401] Subtest before-wait: SUCCESS (0.374s) [273.363475] [046/133] (761s left) gem_mmap_wc (fault-concurrent) [273.421866] Subtest fault-concurrent: SKIP (0.000s) [273.480934] [047/133] (761s left) gem_watchdog (default-virtual) [273.549232] Starting subtest: default-virtual [279.826981] Subtest default-virtual: SUCCESS (6.287s) [279.925597] [048/133] (755s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt) [280.030650] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt [280.035143] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [280.143901] [049/133] (754s left) kms_plane_scaling (invalid-num-scalers) [280.228854] Starting subtest: invalid-num-scalers [280.231148] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers [280.246478] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.018s) [280.258711] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers [280.278459] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.031s) [280.290897] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers [280.310159] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.031s) [280.319708] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers [280.343670] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.031s) [280.346090] Subtest invalid-num-scalers: SUCCESS (0.116s) [280.446856] [050/133] (754s left) gem_spin_batch (user-each) [280.524396] Starting subtest: user-each [283.795370] Subtest user-each: SUCCESS (3.263s) [283.970843] [051/133] (751s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier) [284.082176] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier [284.107453] Starting dynamic subtest: pipe-A-plane-0 [284.529567] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s) [284.539938] Starting dynamic subtest: pipe-A-plane-3 [284.796326] Dynamic subtest pipe-A-plane-3: SUCCESS (0.265s) [284.809033] Starting dynamic subtest: pipe-A-plane-5 [284.812725] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [285.893728] Starting dynamic subtest: pipe-B-plane-0 [286.319871] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s) [286.329563] Starting dynamic subtest: pipe-B-plane-3 [286.611888] Dynamic subtest pipe-B-plane-3: SUCCESS (0.288s) [286.621177] Starting dynamic subtest: pipe-B-plane-5 [286.625820] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [286.916239] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.836s) [287.767867] [052/133] (747s left) gem_eio (wait-immediate) [287.979687] Starting subtest: wait-immediate [288.309679] Subtest wait-immediate: SUCCESS (0.330s) [288.455917] [053/133] (746s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu) [288.551286] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu [288.555518] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [288.655737] [054/133] (746s left) gem_mmap_gtt (basic-write-gtt) [288.719190] Subtest basic-write-gtt: SKIP (0.000s) [288.779915] [055/133] (746s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling) [288.865666] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling [288.867569] Starting dynamic subtest: pipe-A-default-mode [291.607308] Dynamic subtest pipe-A-default-mode: SUCCESS (2.741s) [291.609569] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.742s) [292.459704] [056/133] (742s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf) [292.555229] Starting subtest: fbc-psr2-cursor-plane-update-sf [292.557519] Starting dynamic subtest: pipe-A-eDP-1 [292.635619] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s) [292.646930] Starting dynamic subtest: pipe-B-eDP-1 [293.727998] Dynamic subtest pipe-B-eDP-1: SKIP (1.092s) [293.732278] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.174s) [294.922880] [057/133] (740s left) gem_ctx_param (invalid-ctx-get) [294.975023] Starting subtest: invalid-ctx-get [294.977411] Subtest invalid-ctx-get: SUCCESS (0.000s) [295.047635] [058/133] (740s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant) [295.143109] Starting subtest: coverage-vs-premult-vs-constant [295.426642] Starting dynamic subtest: pipe-A-eDP-1 [296.047476] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.621s) [296.057813] Starting dynamic subtest: pipe-D-eDP-1 [297.327877] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.278s) [297.330345] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.186s) [298.182311] [059/133] (737s left) kms_atomic_interruptible (legacy-setmode) [298.294278] Starting subtest: legacy-setmode [298.296551] Starting dynamic subtest: pipe-A-eDP-1 [305.225228] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.931s) [305.227594] Subtest legacy-setmode: SUCCESS (6.933s) [306.083041] [060/133] (729s left) api_intel_bb (object-reloc-purge-cache) [306.136879] Starting subtest: object-reloc-purge-cache [306.141139] Subtest object-reloc-purge-cache: SKIP (0.004s) [306.256246] [061/133] (729s left) kms_psr (psr-sprite-render) [306.353237] Starting subtest: psr-sprite-render [306.355551] Starting dynamic subtest: eDP-1 [308.117339] Dynamic subtest eDP-1: SUCCESS (1.763s) [308.119675] Subtest psr-sprite-render: SUCCESS (1.764s) [308.948928] [062/133] (726s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff) [309.057820] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff [312.909307] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.854s) [314.064396] [063/133] (721s left) kms_chamelium_hpd (vga-hpd-for-each-pipe) [314.447675] Subtest vga-hpd-for-each-pipe: SKIP (0.000s) [315.247319] [064/133] (720s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move) [315.347648] Starting subtest: fbc-2p-primscrn-spr-indfb-move [315.352079] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s) [315.447649] [065/133] (720s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format) [315.545769] Starting subtest: plane-upscale-20x20-with-pixel-format [315.548046] Starting dynamic subtest: pipe-A [316.594744] Dynamic subtest pipe-A: SUCCESS (1.051s) [316.604626] Starting dynamic subtest: pipe-B [318.674788] Dynamic subtest pipe-B: SUCCESS (2.079s) [318.685843] Starting dynamic subtest: pipe-C [319.863525] Dynamic subtest pipe-C: SUCCESS (1.187s) [319.874374] Starting dynamic subtest: pipe-D [321.092802] Dynamic subtest pipe-D: SUCCESS (1.229s) [321.095117] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.549s) [322.289602] [066/133] (713s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt) [322.393893] Starting subtest: fbc-rgb101010-draw-blt [326.981371] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.590s) [328.108147] [067/133] (707s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0) [328.196402] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0 [328.200380] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s) [328.304616] [068/133] (707s left) i915_drm_fdinfo (virtual-busy-hang) [328.347222] Starting subtest: virtual-busy-hang [328.351692] Subtest virtual-busy-hang: SKIP (0.000s) [328.408374] [069/133] (707s left) kms_pm_rpm (pc8-residency) [330.052288] Starting subtest: pc8-residency [330.059078] Subtest pc8-residency: SKIP (0.000s) [330.734570] [070/133] (705s left) i915_pm_rc6_residency (rc6-idle) [330.783898] Starting subtest: rc6-idle [330.815685] Starting dynamic subtest: gt0-rcs0 [355.168216] Dynamic subtest gt0-rcs0: SUCCESS (24.352s) [355.177907] Starting dynamic subtest: gt0-bcs0 [379.446273] Dynamic subtest gt0-bcs0: SUCCESS (24.276s) [379.455792] Starting dynamic subtest: gt0-ccs0 [403.892945] Dynamic subtest gt0-ccs0: SUCCESS (24.444s) [403.904260] Starting dynamic subtest: gt1-vcs0 [410.066344] Dynamic subtest gt1-vcs0: SUCCESS (6.170s) [410.078953] Starting dynamic subtest: gt1-vecs0 [416.238217] Dynamic subtest gt1-vecs0: SUCCESS (6.169s) [416.241105] Subtest rc6-idle: SUCCESS (85.457s) [416.321270] [071/133] (619s left) kms_cursor_legacy (flip-vs-cursor-varying-size) [416.441085] Starting subtest: flip-vs-cursor-varying-size [424.979209] Subtest flip-vs-cursor-varying-size: SUCCESS (8.537s) [425.819910] [072/133] (610s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180) [425.918346] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180 [426.874788] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.956s) [427.009378] [073/133] (608s left) prime_vgem (fence-write-hang) [427.158425] Subtest fence-write-hang: SKIP (0.000s) [427.250352] [FACT prime_vgem (fence-write-hang)] new: kernel.kmod_is_loaded.vgem: true [427.253458] [074/133] (608s left) kms_universal_plane (universal-plane-sanity) [427.347507] Starting subtest: universal-plane-sanity [427.349492] Starting dynamic subtest: pipe-A-eDP-1 [427.985141] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.638s) [427.995199] Starting dynamic subtest: pipe-B-eDP-1 [429.253753] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.266s) [429.264171] Starting dynamic subtest: pipe-C-eDP-1 [430.465642] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.207s) [430.475202] Starting dynamic subtest: pipe-D-eDP-1 [431.695538] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.230s) [431.697893] Subtest universal-plane-sanity: SUCCESS (4.348s) [432.570847] [075/133] (603s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt) [432.676596] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt [432.680957] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [432.773701] [076/133] (603s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc) [432.867528] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc [432.871635] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [432.960440] [077/133] (603s left) gen9_exec_parse (bb-start-param) [433.024925] Subtest bb-start-param: SKIP (0.000s) [433.101956] [078/133] (603s left) kms_ccs (random-ccs-data-yf-tiled-ccs) [433.194422] Starting subtest: random-ccs-data-yf-tiled-ccs [433.196741] Starting dynamic subtest: pipe-A-eDP-1 [433.222485] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [433.235872] Starting dynamic subtest: pipe-B-eDP-1 [433.259681] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [433.268995] Starting dynamic subtest: pipe-C-eDP-1 [433.292843] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [433.301679] Starting dynamic subtest: pipe-D-eDP-1 [433.325601] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [433.330058] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.005s) [435.528379] [079/133] (600s left) kms_content_protection (suspend-resume) [435.665578] Starting subtest: suspend-resume [435.670322] Subtest suspend-resume: SKIP (0.000s) [435.789480] [080/133] (600s left) kms_big_fb (x-tiled-16bpp-rotate-90) [435.899872] Starting subtest: x-tiled-16bpp-rotate-90 [435.920975] Subtest x-tiled-16bpp-rotate-90: SKIP (0.020s) [436.033479] [081/133] (600s left) gem_partial_pwrite_pread (reads-uncached) [436.108390] Subtest reads-uncached: SKIP (0.000s) [436.185207] [082/133] (600s left) sysfs_heartbeat_interval (precise) [436.254048] Starting subtest: precise [436.256400] Starting dynamic subtest: vecs0 [443.854688] Dynamic subtest vecs0: SUCCESS (7.596s) [443.872059] Starting dynamic subtest: ccs0 [445.000825] Dynamic subtest ccs0: SUCCESS (1.147s) [445.012682] Starting dynamic subtest: vcs0 [452.888138] Dynamic subtest vcs0: SUCCESS (7.885s) [452.900592] Starting dynamic subtest: bcs0 [454.024775] Dynamic subtest bcs0: SUCCESS (1.134s) [454.036514] Starting dynamic subtest: rcs0 [455.070721] Dynamic subtest rcs0: SUCCESS (1.044s) [455.083834] Starting dynamic subtest: vcs1 [462.930266] Dynamic subtest vcs1: SUCCESS (7.857s) [462.932759] Subtest precise: SUCCESS (26.677s) [463.008453] [083/133] (573s left) kms_psr (fbc-psr2-primary-page-flip) [463.113296] Starting subtest: fbc-psr2-primary-page-flip [463.115618] Starting dynamic subtest: eDP-1 [463.119760] Dynamic subtest eDP-1: SKIP (0.000s) [463.123915] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s) [463.189983] [084/133] (573s left) gem_mmap_offset (partial-remap) [463.237213] Starting subtest: partial-remap [463.239575] Starting dynamic subtest: smem0 [463.248594] Dynamic subtest smem0: SUCCESS (0.003s) [463.250990] Subtest partial-remap: SUCCESS (0.004s) [463.359377] [085/133] (573s left) syncobj_timeline (multi-wait-available-submitted) [463.425900] Starting subtest: multi-wait-available-submitted [463.427959] Subtest multi-wait-available-submitted: SUCCESS (0.001s) [463.516950] [086/133] (572s left) i915_query (hwconfig_table) [463.572720] Starting subtest: hwconfig_table [463.871801] Subtest hwconfig_table: SUCCESS (0.001s) [463.913290] [087/133] (572s left) gem_ctx_persistence (processes) [463.968984] Starting subtest: processes [465.903501] Subtest processes: SUCCESS (1.934s) [466.007788] [088/133] (570s left) kms_big_fb (4-tiled-64bpp-rotate-0) [466.112784] Starting subtest: 4-tiled-64bpp-rotate-0 [467.724070] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.611s) [467.878305] [089/133] (568s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render) [467.972348] Starting subtest: psr-rgb101010-draw-render [475.175521] Subtest psr-rgb101010-draw-render: SUCCESS (7.206s) [475.300994] [090/133] (561s left) gem_render_copy (yf-tiled-ccs-to-y-tiled) [475.361109] Starting subtest: yf-tiled-ccs-to-y-tiled [475.365587] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s) [475.560902] [091/133] (561s left) kms_cursor_crc (cursor-rapid-movement-512x512) [475.852596] Starting subtest: cursor-rapid-movement-512x512 [475.857153] Subtest cursor-rapid-movement-512x512: SKIP (0.001s) [476.027357] [092/133] (560s left) kms_pm_rpm (fences-dpms) [478.073164] Starting subtest: fences-dpms [478.078192] Subtest fences-dpms: SKIP (0.000s) [478.463240] [093/133] (558s left) kms_flip (plain-flip-ts-check-interruptible) [478.560356] Starting subtest: plain-flip-ts-check-interruptible [478.562724] Starting dynamic subtest: A-eDP1 [487.429486] Dynamic subtest A-eDP1: SUCCESS (8.867s) [487.441038] Starting dynamic subtest: B-eDP1 [496.258625] Dynamic subtest B-eDP1: SUCCESS (8.827s) [496.270353] Starting dynamic subtest: C-eDP1 [505.078634] Dynamic subtest C-eDP1: SUCCESS (8.819s) [505.089837] Starting dynamic subtest: D-eDP1 [513.909839] Dynamic subtest D-eDP1: SUCCESS (8.829s) [513.915723] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.353s) [515.095786] [094/133] (521s left) i915_pm_freq_api (freq-basic-api) [515.155738] Starting subtest: freq-basic-api [515.158098] Starting dynamic subtest: gt0 [515.160356] Dynamic subtest gt0: SUCCESS (0.002s) [515.174825] Starting dynamic subtest: gt1 [515.177224] Dynamic subtest gt1: SUCCESS (0.003s) [515.179621] Subtest freq-basic-api: SUCCESS (0.006s) [515.237114] [095/133] (521s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted) [515.352269] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted [515.494560] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.144s) [515.609144] [096/133] (521s left) perf_pmu (busy-accuracy-50) [515.649550] Starting subtest: busy-accuracy-50 [515.651612] Starting dynamic subtest: rcs0 [517.185202] Dynamic subtest rcs0: SUCCESS (1.533s) [517.194786] Starting dynamic subtest: bcs0 [518.726805] Dynamic subtest bcs0: SUCCESS (1.539s) [518.737861] Starting dynamic subtest: vcs0 [520.270544] Dynamic subtest vcs0: SUCCESS (1.542s) [520.282511] Starting dynamic subtest: vcs1 [521.814182] Dynamic subtest vcs1: SUCCESS (1.540s) [521.826544] Starting dynamic subtest: vecs0 [523.352397] Dynamic subtest vecs0: SUCCESS (1.537s) [523.362180] Starting dynamic subtest: ccs0 [524.900498] Dynamic subtest ccs0: SUCCESS (1.545s) [524.902897] Subtest busy-accuracy-50: SUCCESS (9.249s) [525.013327] [097/133] (511s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move) [525.128538] Starting subtest: psr-1p-primscrn-spr-indfb-move [532.661528] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.535s) [532.811032] [098/133] (504s left) gem_pipe_control_store_loop (reused-buffer) [532.867392] Starting subtest: reused-buffer [535.020184] Subtest reused-buffer: SUCCESS (2.151s) [535.138977] [099/133] (501s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs) [535.231179] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs [535.233389] Starting dynamic subtest: pipe-A-eDP-1 [535.659790] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.401s) [535.671373] Starting dynamic subtest: pipe-B-eDP-1 [537.015522] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.352s) [537.027102] Starting dynamic subtest: pipe-C-eDP-1 [538.431302] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.416s) [538.442405] Starting dynamic subtest: pipe-D-eDP-1 [539.758951] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s) [539.761247] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.502s) [540.943597] [100/133] (496s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic) [541.067527] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic [541.072182] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s) [541.220395] [101/133] (495s left) kms_chamelium_frames (dp-crc-single) [541.609795] Subtest dp-crc-single: SKIP (0.000s) [542.468720] [102/133] (494s left) gem_readwrite (read-bad-handle) [542.534905] Subtest read-bad-handle: SKIP (0.000s) [542.598670] [103/133] (494s left) gem_exec_fence (basic-await) [542.775951] Starting subtest: basic-await [542.778349] Starting dynamic subtest: rcs0 [542.850195] Dynamic subtest rcs0: SUCCESS (0.077s) [542.864663] Starting dynamic subtest: bcs0 [542.925533] Dynamic subtest bcs0: SUCCESS (0.074s) [542.937324] Starting dynamic subtest: vcs0 [543.000274] Dynamic subtest vcs0: SUCCESS (0.073s) [543.012918] Starting dynamic subtest: vcs1 [543.075447] Dynamic subtest vcs1: SUCCESS (0.072s) [543.088045] Starting dynamic subtest: vecs0 [543.149357] Dynamic subtest vecs0: SUCCESS (0.072s) [543.162024] Starting dynamic subtest: ccs0 [543.222459] Dynamic subtest ccs0: SUCCESS (0.072s) [543.224880] Subtest basic-await: SUCCESS (0.451s) [545.001645] [104/133] (492s left) kms_big_fb (yf-tiled-32bpp-rotate-90) [545.105445] Starting subtest: yf-tiled-32bpp-rotate-90 [545.109792] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s) [545.207045] [105/133] (492s left) gem_pxp (reject-modify-context-protection-off-1) [545.267411] Starting subtest: reject-modify-context-protection-off-1 [545.269696] Subtest reject-modify-context-protection-off-1: SUCCESS (0.001s) [545.370244] [106/133] (491s left) gem_exec_reloc (basic-cpu-noreloc) [545.426346] Subtest basic-cpu-noreloc: SKIP (0.000s) [545.508608] [107/133] (491s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite) [545.600738] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite [554.918844] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.320s) [555.047964] [108/133] (482s left) kms_rotation_crc (primary-x-tiled-reflect-x-180) [555.147948] Starting subtest: primary-x-tiled-reflect-x-180 [562.177683] Subtest primary-x-tiled-reflect-x-180: SUCCESS (7.033s) [563.345719] [109/133] (474s left) gem_exec_reloc (basic-write-wc-active) [563.424227] Subtest basic-write-wc-active: SKIP (0.000s) [563.499926] [110/133] (474s left) syncobj_timeline (wait-all-complex) [563.555448] Starting subtest: wait-all-complex [563.771211] Subtest wait-all-complex: SUCCESS (0.214s) [563.853672] [111/133] (473s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area) [563.949635] Starting subtest: psr2-plane-move-sf-dmg-area [563.951973] Starting dynamic subtest: pipe-A-eDP-1 [568.498650] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.552s) [568.509396] Starting dynamic subtest: pipe-B-eDP-1 [573.838853] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.341s) [573.841341] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.895s) [574.714030] [112/133] (462s left) gem_exec_fence (syncobj-timeline-invalid-flags) [575.263282] Starting subtest: syncobj-timeline-invalid-flags [575.266049] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s) [577.009459] [113/133] (460s left) perf (blocking) [577.130376] Starting subtest: blocking [577.132523] Starting dynamic subtest: 0-rcs0 [587.149713] Dynamic subtest 0-rcs0: SUCCESS (10.018s) [587.161356] Starting dynamic subtest: 1-vcs1 [597.170140] Dynamic subtest 1-vcs1: SUCCESS (10.018s) [597.173329] Subtest blocking: SUCCESS (20.039s) [597.223447] [114/133] (440s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted) [597.283309] Starting subtest: etime-multi-wait-for-submit-unsubmitted [597.386247] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.103s) [597.486164] [115/133] (440s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf) [597.592854] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf [597.597319] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [597.690869] [116/133] (440s left) kms_invalid_mode (bad-vsync-start) [597.785327] Starting subtest: bad-vsync-start [597.787676] Starting dynamic subtest: pipe-A-eDP-1 [598.070497] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s) [598.080848] Starting dynamic subtest: pipe-B-eDP-1 [598.083074] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [598.092552] Starting dynamic subtest: pipe-C-eDP-1 [598.094801] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [598.104222] Starting dynamic subtest: pipe-D-eDP-1 [598.106405] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [598.108636] Subtest bad-vsync-start: SUCCESS (0.290s) [598.926169] [117/133] (438s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff) [599.025803] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff [606.114354] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.092s) [606.271138] [118/133] (431s left) gem_exec_reloc (basic-gtt-wc) [606.333050] Subtest basic-gtt-wc: SKIP (0.000s) [606.409048] [119/133] (431s left) kms_plane_lowres (tiling-x) [606.498575] Starting subtest: tiling-x [606.500819] Starting dynamic subtest: pipe-A-eDP-1 [606.505225] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [606.797105] Starting dynamic subtest: pipe-B-eDP-1 [606.801537] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [606.813215] Starting dynamic subtest: pipe-C-eDP-1 [606.817717] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [606.828836] Starting dynamic subtest: pipe-D-eDP-1 [606.833134] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [606.837431] Subtest tiling-x: SKIP (0.300s) [607.596146] [120/133] (430s left) gem_ctx_shared (q-smoketest-all) [607.673054] Starting subtest: Q-smoketest-all [640.058695] Subtest Q-smoketest-all: SUCCESS (32.337s) [640.966224] [121/133] (397s left) gem_softpin (evict-snoop) [641.035976] Starting subtest: evict-snoop [641.040384] Subtest evict-snoop: SKIP (0.000s) [641.172878] [122/133] (396s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling) [641.271061] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling [641.275577] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s) [641.341508] [123/133] (396s left) syncobj_wait (multi-wait-submitted-signaled) [641.404658] Starting subtest: multi-wait-submitted-signaled [641.406686] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s) [641.528410] [124/133] (396s left) syncobj_wait (reset-unsignaled) [641.592763] Starting subtest: reset-unsignaled [641.594737] Subtest reset-unsignaled: SUCCESS (0.000s) [641.684694] [125/133] (396s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [641.792155] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [642.683009] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.892s) [642.857057] [126/133] (395s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs) [642.943297] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs [642.945462] Starting dynamic subtest: pipe-A-eDP-1 [642.968635] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [642.983686] Starting dynamic subtest: pipe-B-eDP-1 [643.004742] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [643.014631] Starting dynamic subtest: pipe-C-eDP-1 [643.035878] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [643.045570] Starting dynamic subtest: pipe-D-eDP-1 [643.068306] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [643.072610] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.004s) [645.169371] [127/133] (393s left) syncobj_wait (invalid-single-wait-unsubmitted) [645.230636] Starting subtest: invalid-single-wait-unsubmitted [645.232874] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s) [645.348163] [128/133] (392s left) perf_pmu (render-node-busy-idle) [645.407042] Starting subtest: render-node-busy-idle [645.409399] Starting dynamic subtest: rcs0 [646.070787] Dynamic subtest rcs0: SUCCESS (0.663s) [646.083656] Starting dynamic subtest: bcs0 [646.726313] Dynamic subtest bcs0: SUCCESS (0.653s) [646.738140] Starting dynamic subtest: vcs0 [647.893335] Dynamic subtest vcs0: SUCCESS (1.163s) [647.905859] Starting dynamic subtest: vcs1 [649.942353] Dynamic subtest vcs1: SUCCESS (2.045s) [649.954927] Starting dynamic subtest: vecs0 [651.926138] Dynamic subtest vecs0: SUCCESS (1.981s) [651.939499] Starting dynamic subtest: ccs0 [652.590216] Dynamic subtest ccs0: SUCCESS (0.663s) [652.592781] Subtest render-node-busy-idle: SUCCESS (7.184s) [652.682097] [129/133] (385s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted) [652.731533] Starting subtest: multi-wait-all-for-submit-available-submitted [652.733847] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s) [652.836270] [130/133] (385s left) prime_vgem (basic-fence-read) [652.907062] Starting subtest: basic-fence-read [652.929634] Subtest basic-fence-read: SKIP (0.020s) [653.048713] [131/133] (385s left) kms_addfb_basic (bad-pitch-65536) [653.093791] Starting subtest: bad-pitch-65536 [653.096462] Subtest bad-pitch-65536: SUCCESS (0.000s) [653.242477] [132/133] (385s left) kms_fbcon_fbt (psr-suspend) [653.300622] Starting subtest: psr-suspend [702.306215] Subtest psr-suspend: SUCCESS (19.691s) [702.401246] [133/133] (336s left) syncobj_eventfd (binary-wait-before-signal) [702.472759] Starting subtest: binary-wait-before-signal [702.501799] Subtest binary-wait-before-signal: SUCCESS (0.031s) [702.574641] 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.