[61.986961] Initializing watchdogs [61.987026] /dev/watchdog0 [62.001545] [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] [62.005671] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [62.007965] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [62.011409] [001/129] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt) [62.210137] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt [62.214106] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [62.303475] [002/129] (960s left) gem_render_copy (y-tiled-ccs-to-y-tiled) [62.377098] Starting subtest: y-tiled-ccs-to-y-tiled [62.381648] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s) [62.552854] [003/129] (960s left) gem_render_copy (linear-to-vebox-yf-tiled) [62.605503] Starting subtest: linear-to-vebox-yf-tiled [62.609783] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s) [62.784265] [004/129] (959s left) kms_psr (pr-cursor-blt) [62.884843] Starting subtest: pr-cursor-blt [62.889336] Subtest pr-cursor-blt: SKIP (0.000s) [62.949756] [005/129] (959s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw) [63.056521] Starting subtest: fbcpsr-2p-pri-indfb-multidraw [63.060797] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s) [63.161129] [006/129] (959s left) kms_busy (extended-pageflip-hang-newfb) [63.267987] Starting subtest: extended-pageflip-hang-newfb [63.270439] Starting dynamic subtest: pipe-A [89.722381] Dynamic subtest pipe-A: SUCCESS (26.451s) [89.730372] Starting dynamic subtest: pipe-D [104.699429] Dynamic subtest pipe-D: SUCCESS (14.976s) [104.701951] Subtest extended-pageflip-hang-newfb: SUCCESS (41.430s) [105.512079] [007/129] (917s left) gem_exec_reloc (basic-write-read-noreloc) [105.583214] Subtest basic-write-read-noreloc: SKIP (0.000s) [105.636076] [008/129] (917s left) gem_madvise (dontneed-before-exec) [105.670857] Starting subtest: dontneed-before-exec [105.694483] Subtest dontneed-before-exec: SKIP (0.020s) [105.752443] [009/129] (917s left) kms_flip (2x-flip-vs-rmfb-interruptible) [105.856776] Starting subtest: 2x-flip-vs-rmfb-interruptible [105.869449] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.011s) [105.936344] [010/129] (916s left) kms_busy (basic-hang) [106.033123] Starting subtest: basic-hang [106.035478] Starting dynamic subtest: flip-pipe-A [106.628486] Dynamic subtest flip-pipe-A: SUCCESS (0.592s) [106.634716] Starting dynamic subtest: modeset-pipe-A [110.005945] Dynamic subtest modeset-pipe-A: SUCCESS (3.379s) [110.014400] Starting dynamic subtest: flip-pipe-D [111.245172] Dynamic subtest flip-pipe-D: SUCCESS (1.236s) [111.253568] Starting dynamic subtest: modeset-pipe-D [114.609662] Dynamic subtest modeset-pipe-D: SUCCESS (3.365s) [114.612198] Subtest basic-hang: SUCCESS (8.576s) [115.406818] [011/129] (907s left) kms_async_flips (test-cursor) [115.504045] Starting subtest: test-cursor [115.508264] Subtest test-cursor: SKIP (0.000s) [116.733776] [012/129] (906s left) kms_cursor_crc (cursor-alpha-opaque) [116.831051] Starting subtest: cursor-alpha-opaque [116.833486] Starting dynamic subtest: pipe-A-eDP-1 [117.471056] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.637s) [117.478961] Starting dynamic subtest: pipe-D-eDP-1 [118.721154] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.251s) [118.723441] Subtest cursor-alpha-opaque: SUCCESS (1.889s) [119.579759] [013/129] (903s left) dumb_buffer (invalid-bpp) [119.647015] Starting subtest: invalid-bpp [119.649387] Subtest invalid-bpp: SUCCESS (0.000s) [119.746784] [014/129] (903s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [119.856383] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [119.860705] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [119.939851] [015/129] (903s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-25) [120.040815] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-25 [120.043065] Starting dynamic subtest: pipe-A [120.057412] Dynamic subtest pipe-A: SKIP (0.012s) [120.064615] Starting dynamic subtest: pipe-B [120.085267] Dynamic subtest pipe-B: SKIP (0.026s) [120.092390] Starting dynamic subtest: pipe-C [120.111516] Dynamic subtest pipe-C: SKIP (0.026s) [120.118250] Starting dynamic subtest: pipe-D [120.132967] Dynamic subtest pipe-D: SKIP (0.022s) [120.137308] Subtest planes-upscale-factor-0-25-downscale-factor-0-25: SKIP (0.087s) [120.236913] [016/129] (902s left) gem_create (create-ext-placement-all) [120.407578] Starting subtest: create-ext-placement-all [120.409561] Subtest create-ext-placement-all: SUCCESS (0.000s) [120.502299] [017/129] (902s left) syncobj_wait (single-wait-signaled) [120.563659] Starting subtest: single-wait-signaled [120.566075] Subtest single-wait-signaled: SUCCESS (0.000s) [120.663286] [018/129] (902s left) gem_flink_race (flink_name) [120.698571] Starting subtest: flink_name [126.107907] Subtest flink_name: SUCCESS (5.407s) [126.201072] [019/129] (896s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs) [126.309071] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs [126.311502] Starting dynamic subtest: pipe-A-eDP-1 [126.337234] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [126.344726] Starting dynamic subtest: pipe-B-eDP-1 [126.368027] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [126.374395] Starting dynamic subtest: pipe-C-eDP-1 [126.397709] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [126.404273] Starting dynamic subtest: pipe-D-eDP-1 [126.428901] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [126.432990] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.002s) [128.429447] [020/129] (894s left) device_reset (unbind-cold-reset-rebind) [128.476453] Starting subtest: unbind-cold-reset-rebind [128.481050] Subtest unbind-cold-reset-rebind: SKIP (0.000s) [128.529458] [021/129] (894s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-wc) [128.635341] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-wc [131.693297] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-wc: SUCCESS (3.062s) [131.822308] [022/129] (891s left) gem_mmap_wc (write-cpu-read-wc) [131.884362] Subtest write-cpu-read-wc: SKIP (0.000s) [131.940592] [023/129] (891s left) syncobj_timeline (wait-all-for-submit-snapshot) [131.998657] Starting subtest: wait-all-for-submit-snapshot [132.081560] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s) [132.149511] [024/129] (891s left) kms_concurrent (multi-plane-atomic-lowres) [132.249359] Starting subtest: multi-plane-atomic-lowres [132.251257] Starting dynamic subtest: pipe-A-eDP-1 [132.756680] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.507s) [132.759108] Subtest multi-plane-atomic-lowres: SUCCESS (0.508s) [133.587931] [025/129] (889s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [133.688626] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [134.567316] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.881s) [134.777647] [026/129] (888s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines) [135.341902] Starting subtest: syncobj-stationary-timeline-chain-engines [135.429817] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.089s) [137.029093] [FACT gem_exec_fence (syncobj-stationary-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true [137.032210] [027/129] (886s left) prime_busy (before) [137.087521] Starting subtest: before [137.092695] Starting dynamic subtest: rcs0 [137.123064] Dynamic subtest rcs0: SUCCESS (0.032s) [137.132255] Starting dynamic subtest: bcs0 [137.181070] Dynamic subtest bcs0: SUCCESS (0.058s) [137.188041] Starting dynamic subtest: vcs0 [137.220869] Dynamic subtest vcs0: SUCCESS (0.039s) [137.228486] Starting dynamic subtest: vcs1 [137.261964] Dynamic subtest vcs1: SUCCESS (0.041s) [137.269627] Starting dynamic subtest: vecs0 [137.302073] Dynamic subtest vecs0: SUCCESS (0.040s) [137.309354] Starting dynamic subtest: ccs0 [137.345354] Dynamic subtest ccs0: SUCCESS (0.043s) [137.454950] Subtest before: SUCCESS (0.366s) [137.524430] [028/129] (885s left) kms_big_fb (linear-32bpp-rotate-270) [137.634575] Starting subtest: linear-32bpp-rotate-270 [137.653407] Subtest linear-32bpp-rotate-270: SKIP (0.018s) [137.784667] [029/129] (885s left) api_intel_bb (simple-bb-ctx) [137.849392] Starting subtest: simple-bb-ctx [137.857145] Subtest simple-bb-ctx: SUCCESS (0.009s) [137.985927] [030/129] (885s left) gem_tiling_max_stride [138.107983] [031/129] (885s left) kms_addfb_basic (bad-pitch-0) [138.170046] Starting subtest: bad-pitch-0 [138.172323] Subtest bad-pitch-0: SUCCESS (0.000s) [138.326898] [032/129] (885s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render) [138.425272] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render [142.989092] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (4.567s) [143.131890] [033/129] (880s left) kms_vrr (lobf) [143.244033] Starting subtest: lobf [143.248378] Subtest lobf: SKIP (0.000s) [143.316982] [034/129] (880s left) gem_ringfill (legacy-basic) [148.910080] Starting subtest: legacy-basic [148.912842] Starting dynamic subtest: default [148.978878] Dynamic subtest default: SUCCESS (0.070s) [148.988801] Starting dynamic subtest: render [149.021200] Dynamic subtest render: SUCCESS (0.041s) [149.029976] Starting dynamic subtest: bsd [149.062047] Dynamic subtest bsd: SUCCESS (0.040s) [149.070199] Starting dynamic subtest: bsd1 [149.104085] Dynamic subtest bsd1: SUCCESS (0.041s) [149.112552] Starting dynamic subtest: bsd2 [149.144077] Dynamic subtest bsd2: SUCCESS (0.039s) [149.154172] Starting dynamic subtest: blt [149.191140] Dynamic subtest blt: SUCCESS (0.046s) [149.199880] Starting dynamic subtest: vebox [149.231932] Dynamic subtest vebox: SUCCESS (0.040s) [149.234404] Subtest legacy-basic: SUCCESS (0.324s) [149.310313] [035/129] (874s left) gem_ctx_shared (exec-shared-gtt) [149.377800] Starting subtest: exec-shared-gtt [149.379984] Starting dynamic subtest: rcs0 [149.390913] Dynamic subtest rcs0: SUCCESS (0.013s) [149.397883] Starting dynamic subtest: bcs0 [149.402674] Dynamic subtest bcs0: SUCCESS (0.011s) [149.409542] Starting dynamic subtest: vcs0 [149.411852] Dynamic subtest vcs0: SUCCESS (0.008s) [149.418987] Starting dynamic subtest: vcs1 [149.420901] Dynamic subtest vcs1: SUCCESS (0.007s) [149.428166] Starting dynamic subtest: vecs0 [149.430276] Dynamic subtest vecs0: SUCCESS (0.008s) [149.437127] Starting dynamic subtest: ccs0 [149.439066] Dynamic subtest ccs0: SUCCESS (0.007s) [149.440875] Subtest exec-shared-gtt: SUCCESS (0.055s) [149.616230] [036/129] (874s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [149.729783] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip [149.734337] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s) [149.838676] [037/129] (873s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt) [149.938086] Starting subtest: psr-rgb101010-draw-blt [155.095450] Subtest psr-rgb101010-draw-blt: SUCCESS (5.162s) [155.217281] [038/129] (868s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic) [155.344425] Starting subtest: 2x-flip-vs-cursor-atomic [155.348617] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s) [155.471489] [039/129] (868s left) syncobj_timeline (multi-wait-available-submitted) [155.530966] Starting subtest: multi-wait-available-submitted [155.533252] Subtest multi-wait-available-submitted: SUCCESS (0.000s) [155.645067] [040/129] (868s left) kms_atomic (test-only) [155.746907] Starting subtest: test-only [155.809838] Starting dynamic subtest: pipe-A-eDP-1 [158.289540] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.485s) [158.291886] Subtest test-only: SUCCESS (2.542s) [159.147447] [041/129] (864s left) kms_pm_rpm (modeset-pc8-residency-stress) [161.088477] Starting subtest: modeset-pc8-residency-stress [161.094072] Subtest modeset-pc8-residency-stress: SKIP (0.000s) [161.435937] [042/129] (862s left) api_intel_allocator (execbuf-with-allocator) [161.491927] Starting subtest: execbuf-with-allocator [161.496885] Subtest execbuf-with-allocator: SUCCESS (0.006s) [161.605296] [043/129] (862s left) api_intel_bb (blit-reloc-keep-cache) [161.672396] Starting subtest: blit-reloc-keep-cache [161.677100] Subtest blit-reloc-keep-cache: SKIP (0.001s) [161.800760] [044/129] (862s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render) [161.914403] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render [161.918646] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [162.011710] [045/129] (862s left) gem_exec_schedule (u-submit-golden-slice) [162.092677] Starting subtest: u-submit-golden-slice [162.094696] Starting dynamic subtest: rcs0 [162.119778] Dynamic subtest rcs0: SUCCESS (0.033s) [162.127984] Starting dynamic subtest: bcs0 [162.145155] Dynamic subtest bcs0: SUCCESS (0.025s) [162.152262] Starting dynamic subtest: vcs0 [162.172168] Dynamic subtest vcs0: SUCCESS (0.027s) [162.179365] Starting dynamic subtest: vcs1 [162.201083] Dynamic subtest vcs1: SUCCESS (0.029s) [162.208437] Starting dynamic subtest: vecs0 [162.226641] Dynamic subtest vecs0: SUCCESS (0.025s) [162.234487] Starting dynamic subtest: ccs0 [162.259439] Dynamic subtest ccs0: SUCCESS (0.032s) [162.261773] Subtest u-submit-golden-slice: SUCCESS (0.173s) [164.036700] [046/129] (860s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite) [164.138203] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite [164.142683] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [164.250293] [047/129] (859s left) syncobj_timeline (single-wait-all-available-signaled) [164.301893] Starting subtest: single-wait-all-available-signaled [164.304172] Subtest single-wait-all-available-signaled: SUCCESS (0.000s) [164.399261] [048/129] (859s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled) [164.461344] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled [164.463659] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s) [164.564672] [049/129] (859s left) vgem_basic (dmabuf-fence-before) [164.609277] Starting subtest: dmabuf-fence-before [164.611107] Subtest dmabuf-fence-before: SUCCESS (0.000s) [164.663256] [050/129] (859s left) gem_ctx_persistence (heartbeat-many) [164.715071] Starting subtest: heartbeat-many [164.719767] Subtest heartbeat-many: SKIP (0.000s) [164.815295] [051/129] (859s left) prime_mmap (test_refcounting) [164.876773] Starting subtest: test_refcounting [164.878875] Starting dynamic subtest: test_refcounting-smem [164.909864] Dynamic subtest test_refcounting-smem: SUCCESS (0.036s) [164.912335] Subtest test_refcounting: SUCCESS (0.036s) [164.995628] [052/129] (859s left) i915_pm_rpm (sysfs-read) [167.138869] Starting subtest: sysfs-read [168.324508] Subtest sysfs-read: SUCCESS (1.171s) [168.664179] [053/129] (855s left) kms_plane_scaling (plane-downscale-factor-0-25-with-modifiers) [168.765086] Starting subtest: plane-downscale-factor-0-25-with-modifiers [168.767429] Starting dynamic subtest: pipe-A [168.782572] Dynamic subtest pipe-A: SKIP (0.011s) [168.791071] Starting dynamic subtest: pipe-B [168.816263] Dynamic subtest pipe-B: SKIP (0.035s) [168.825338] Starting dynamic subtest: pipe-C [168.846557] Dynamic subtest pipe-C: SKIP (0.029s) [168.855161] Starting dynamic subtest: pipe-D [168.870231] Dynamic subtest pipe-D: SKIP (0.024s) [168.873992] Subtest plane-downscale-factor-0-25-with-modifiers: SKIP (0.101s) [168.951873] [054/129] (855s left) gem_lmem_swapping (parallel-multi) [168.998362] Subtest parallel-multi: SKIP (0.000s) [169.035150] [055/129] (855s left) kms_plane_lowres (tiling-4) [169.130061] Starting subtest: tiling-4 [169.132281] Starting dynamic subtest: pipe-A-eDP-1 [169.136824] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [169.420813] Starting dynamic subtest: pipe-B-eDP-1 [169.425531] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [169.432676] Starting dynamic subtest: pipe-C-eDP-1 [169.437372] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [169.444454] Starting dynamic subtest: pipe-D-eDP-1 [169.449017] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [169.453469] Subtest tiling-4: SKIP (0.288s) [170.274140] [056/129] (854s left) gem_exec_whisper (basic-normal) [170.349286] Starting subtest: basic-normal [173.760753] Subtest basic-normal: SUCCESS (3.410s) [173.934831] [057/129] (850s left) gem_pxp (create-protected-buffer) [174.058729] Starting subtest: create-protected-buffer [174.061339] Subtest create-protected-buffer: SUCCESS (0.000s) [174.168748] [058/129] (850s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy) [174.302651] Starting subtest: flip-vs-cursor-busy-crc-legacy [175.063526] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.760s) [175.898212] [059/129] (848s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu) [176.016319] Starting subtest: fbc-rgb101010-draw-mmap-cpu [179.565173] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (3.552s) [179.675465] [060/129] (844s left) kms_flip (blocking-absolute-wf_vblank) [179.775157] Starting subtest: blocking-absolute-wf_vblank [179.777298] Starting dynamic subtest: A-eDP1 [188.487208] Dynamic subtest A-eDP1: SUCCESS (8.711s) [188.499272] Starting dynamic subtest: B-eDP1 [197.208890] Dynamic subtest B-eDP1: SUCCESS (8.719s) [197.218182] Starting dynamic subtest: C-eDP1 [205.920098] Dynamic subtest C-eDP1: SUCCESS (8.710s) [205.930957] Starting dynamic subtest: D-eDP1 [214.646334] Dynamic subtest D-eDP1: SUCCESS (8.724s) [214.649031] Subtest blocking-absolute-wf_vblank: SUCCESS (34.873s) [215.851423] [061/129] (808s left) syncobj_eventfd (invalid-bad-pad) [215.910840] Starting subtest: invalid-bad-pad [215.913390] Subtest invalid-bad-pad: SUCCESS (0.000s) [216.017998] [062/129] (808s left) kms_chamelium_hpd (dp-hpd-storm) [216.420259] Subtest dp-hpd-storm: SKIP (0.000s) [217.259976] [063/129] (807s left) syncobj_wait (single-wait-for-submit-submitted) [217.313726] Starting subtest: single-wait-for-submit-submitted [217.422943] Subtest single-wait-for-submit-submitted: SUCCESS (0.108s) [217.500367] [064/129] (807s left) gem_exec_endless (dispatch) [217.571487] Starting subtest: dispatch [217.573913] Starting dynamic subtest: rcs0 [217.578681] Dynamic subtest rcs0: SUCCESS (0.005s) [217.588141] Starting dynamic subtest: bcs0 [217.593086] Dynamic subtest bcs0: SUCCESS (0.004s) [217.605633] Starting dynamic subtest: vcs0 [217.610225] Dynamic subtest vcs0: SUCCESS (0.004s) [217.617676] Starting dynamic subtest: vcs1 [217.622246] Dynamic subtest vcs1: SUCCESS (0.005s) [217.629574] Starting dynamic subtest: vecs0 [217.634167] Dynamic subtest vecs0: SUCCESS (0.004s) [217.641510] Starting dynamic subtest: ccs0 [217.646069] Dynamic subtest ccs0: SUCCESS (0.004s) [217.648324] Subtest dispatch: SUCCESS (0.028s) [218.956029] [065/129] (805s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa [219.020475] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled [219.127065] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.105s) [219.200469] [066/129] (805s left) perf (polling) [219.317553] Starting subtest: polling [219.319522] Starting dynamic subtest: 0-rcs0 [229.344624] Dynamic subtest 0-rcs0: SUCCESS (10.027s) [229.352549] Starting dynamic subtest: 1-vecs0 [239.366424] Dynamic subtest 1-vecs0: SUCCESS (10.022s) [239.369056] Subtest polling: SUCCESS (20.050s) [239.409777] [067/129] (785s left) gem_tiled_fence_blits (basic) [239.475968] Subtest basic: SKIP (0.000s) [239.545826] [068/129] (785s left) i915_pm_freq_api (freq-reset) [239.621056] Starting subtest: freq-reset [239.623413] Starting dynamic subtest: gt0 [239.826635] Dynamic subtest gt0: SUCCESS (0.204s) [239.834244] Starting dynamic subtest: gt1 [240.004034] Dynamic subtest gt1: SUCCESS (0.173s) [240.006848] Subtest freq-reset: SUCCESS (0.378s) [240.074890] [069/129] (784s left) kms_draw_crc (draw-method-mmap-gtt) [240.185691] Starting subtest: draw-method-mmap-gtt [240.189663] Subtest draw-method-mmap-gtt: SKIP (0.000s) [240.288709] [070/129] (784s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff) [240.385042] Starting subtest: psr-1p-primscrn-cur-indfb-onoff [245.163991] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (4.782s) [245.296845] [071/129] (779s left) kms_frontbuffer_tracking (fbcpsr-suspend) [245.395648] Starting subtest: fbcpsr-suspend [283.762410] Subtest fbcpsr-suspend: SUCCESS (7.637s) [283.896754] [072/129] (771s left) kms_invalid_mode (bad-vsync-start) [283.996714] Starting subtest: bad-vsync-start [283.999336] Starting dynamic subtest: pipe-A-eDP-1 [284.279286] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.281s) [284.288709] Starting dynamic subtest: pipe-B-eDP-1 [284.291614] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [284.300581] Starting dynamic subtest: pipe-C-eDP-1 [284.303581] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [284.314253] Starting dynamic subtest: pipe-D-eDP-1 [284.316945] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [284.319477] Subtest bad-vsync-start: SUCCESS (0.287s) [285.097467] [073/129] (770s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move) [285.196450] Starting subtest: psr-2p-primscrn-spr-indfb-move [285.201482] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [285.278059] [074/129] (770s left) kms_flip (flip-vs-panning-vs-hang) [285.373592] Starting subtest: flip-vs-panning-vs-hang [285.376426] Starting dynamic subtest: A-eDP1 [336.153311] Dynamic subtest A-eDP1: SUCCESS (50.771s) [336.165393] Starting dynamic subtest: D-eDP1 [376.158708] Dynamic subtest D-eDP1: SUCCESS (40.000s) [376.161800] Subtest flip-vs-panning-vs-hang: SUCCESS (90.775s) [377.373874] [075/129] (678s left) kms_lease (lease-invalid-crtc) [377.473465] Starting subtest: lease-invalid-crtc [377.476189] Starting dynamic subtest: pipe-A-eDP-1 [377.478740] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [377.487574] Starting dynamic subtest: pipe-B-eDP-1 [377.490181] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [377.499027] Starting dynamic subtest: pipe-C-eDP-1 [377.501706] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [377.510597] Starting dynamic subtest: pipe-D-eDP-1 [377.512914] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [377.515125] Subtest lease-invalid-crtc: SUCCESS (0.004s) [377.548327] [076/129] (678s left) kms_psr (fbc-pr-primary-blt) [377.655502] Starting subtest: fbc-pr-primary-blt [377.660396] Subtest fbc-pr-primary-blt: SKIP (0.000s) [377.721055] [077/129] (678s left) gem_mmap_offset (mmap-boundaries) [377.781714] Starting subtest: mmap-boundaries [377.784272] Starting dynamic subtest: smem0 [378.910513] Dynamic subtest smem0: SUCCESS (1.131s) [378.913622] Subtest mmap-boundaries: SUCCESS (1.132s) [379.081031] [078/129] (676s left) kms_psr (psr-primary-render) [379.180691] Starting subtest: psr-primary-render [379.183219] Starting dynamic subtest: eDP-1 [380.971861] Dynamic subtest eDP-1: SUCCESS (1.792s) [380.974634] Subtest psr-primary-render: SUCCESS (1.792s) [381.822912] [079/129] (674s left) gem_ccs (block-copy-uncompressed) [381.886501] Starting subtest: block-copy-uncompressed [381.889185] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem [381.910074] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.023s) [381.919687] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem [381.927679] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s) [381.936220] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem [381.945205] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s) [381.953389] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem [381.962637] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s) [381.965347] Subtest block-copy-uncompressed: SUCCESS (0.077s) [382.113617] [080/129] (673s left) kms_chamelium_edid (dp-edid-read) [382.505574] Subtest dp-edid-read: SKIP (0.000s) [383.324375] [081/129] (672s left) gen9_exec_parse (bb-start-far) [383.391101] Subtest bb-start-far: SKIP (0.000s) [383.468389] [082/129] (672s left) kms_selftest (drm_dp_mst_helper) [383.508853] Starting subtest: drm_dp_mst_helper [383.519602] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode [383.664570] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.141s) [383.674307] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div [383.804433] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.141s) [383.814730] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode [383.956687] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.154s) [383.959512] Subtest drm_dp_mst_helper: SUCCESS (0.452s) [384.155905] [083/129] (671s left) kms_big_fb (y-tiled-64bpp-rotate-0) [384.256186] Starting subtest: y-tiled-64bpp-rotate-0 [384.261166] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s) [384.368040] [084/129] (671s left) gem_exec_schedule (noreorder-priority) [384.553931] Starting subtest: noreorder-priority [384.556874] Starting dynamic subtest: rcs0 [385.694960] Dynamic subtest rcs0: SUCCESS (1.141s) [385.705339] Starting dynamic subtest: vcs0 [387.639574] Dynamic subtest vcs0: SUCCESS (1.941s) [387.651710] Starting dynamic subtest: vcs1 [389.712707] Dynamic subtest vcs1: SUCCESS (2.071s) [389.722541] Starting dynamic subtest: vecs0 [391.651732] Dynamic subtest vecs0: SUCCESS (1.937s) [391.664098] Starting dynamic subtest: ccs0 [392.819997] Dynamic subtest ccs0: SUCCESS (1.168s) [392.823030] Subtest noreorder-priority: SUCCESS (8.267s) [393.004987] [085/129] (663s left) gem_exec_params (dr4-dirt) [393.071428] Starting subtest: DR4-dirt [393.074391] Subtest DR4-dirt: SUCCESS (0.000s) [393.181970] [086/129] (663s left) gem_exec_params (readonly) [393.234851] Starting subtest: readonly [393.240596] Subtest readonly: SUCCESS (0.006s) [393.375438] [087/129] (662s left) gem_spin_batch (legacy-resubmit) [393.433235] Starting subtest: legacy-resubmit [393.435719] Starting dynamic subtest: default [393.444419] Dynamic subtest default: SUCCESS (0.010s) [393.454895] Starting dynamic subtest: render [393.457667] Dynamic subtest render: SUCCESS (0.001s) [393.466345] Starting dynamic subtest: bsd [393.468971] Dynamic subtest bsd: SUCCESS (0.003s) [393.477708] Starting dynamic subtest: bsd1 [393.480121] Dynamic subtest bsd1: SUCCESS (0.005s) [393.488887] Starting dynamic subtest: bsd2 [393.491190] Dynamic subtest bsd2: SUCCESS (0.001s) [393.499452] Starting dynamic subtest: blt [393.501712] Dynamic subtest blt: SUCCESS (0.004s) [393.509959] Starting dynamic subtest: vebox [393.512266] Dynamic subtest vebox: SUCCESS (0.006s) [393.514486] Subtest legacy-resubmit: SUCCESS (0.036s) [393.711723] [088/129] (662s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy) [393.835616] Starting subtest: 2x-long-cursor-vs-flip-legacy [393.841048] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s) [393.929038] [089/129] (662s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs) [394.031991] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs [394.035899] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s) [395.168051] [090/129] (661s left) kms_cursor_legacy (single-move) [395.292743] Starting subtest: single-move [395.295519] Starting dynamic subtest: pipe-A [400.678714] Dynamic subtest pipe-A: SUCCESS (5.382s) [400.689848] Starting dynamic subtest: pipe-B [406.063964] Dynamic subtest pipe-B: SUCCESS (5.382s) [406.075341] Starting dynamic subtest: pipe-C [411.448747] Dynamic subtest pipe-C: SUCCESS (5.383s) [411.459877] Starting dynamic subtest: pipe-D [416.833107] Dynamic subtest pipe-D: SUCCESS (5.382s) [416.844724] Starting dynamic subtest: all-pipes [422.225067] Dynamic subtest all-pipes: SUCCESS (5.390s) [422.227747] Subtest single-move: SUCCESS (26.928s) [422.353031] [091/129] (634s left) gem_exec_params (rel-constants-invalid) [422.405765] Starting subtest: rel-constants-invalid [422.408595] Subtest rel-constants-invalid: SUCCESS (0.000s) [422.498882] [092/129] (633s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf) [427.517624] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf [427.520481] Starting dynamic subtest: pipe-A-eDP-1 [438.950428] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.430s) [438.960106] Starting dynamic subtest: pipe-B-eDP-1 [450.372696] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.418s) [450.375337] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.852s) [451.211647] [093/129] (605s left) kms_cursor_crc (cursor-rapid-movement-256x85) [451.445051] Starting subtest: cursor-rapid-movement-256x85 [451.483479] Subtest cursor-rapid-movement-256x85: SKIP (0.036s) [451.650478] [094/129] (604s left) prime_mmap (test_invalid_sync_flags) [451.711264] Starting subtest: test_invalid_sync_flags [451.713708] Starting dynamic subtest: test_invalid_sync_flags-smem [451.716142] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s) [451.718303] Subtest test_invalid_sync_flags: SUCCESS (0.002s) [451.812076] [095/129] (604s left) gem_mmap_gtt (close-race) [451.875241] Subtest close-race: SKIP (0.000s) [451.935973] [096/129] (604s left) gem_partial_pwrite_pread (reads-display) [452.008570] Subtest reads-display: SKIP (0.000s) [452.070092] [097/129] (604s left) kms_psr (fbc-psr2-primary-page-flip) [452.169862] Starting subtest: fbc-psr2-primary-page-flip [452.171980] Starting dynamic subtest: eDP-1 [452.176485] Dynamic subtest eDP-1: SKIP (0.000s) [452.180423] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s) [452.238153] [098/129] (604s left) kms_getfb (getfb2-handle-protection) [452.290810] Starting subtest: getfb2-handle-protection [452.320944] Subtest getfb2-handle-protection: SUCCESS (0.031s) [452.432445] [099/129] (604s left) gem_close (many-handles-one-vma) [452.491416] Starting subtest: many-handles-one-vma [452.516229] Subtest many-handles-one-vma: SUCCESS (0.025s) [452.653043] [100/129] (604s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu) [452.748557] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu [452.753633] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [452.835113] [101/129] (603s left) kms_feature_discovery (psr2) [452.942330] Starting subtest: psr2 [452.944449] Subtest psr2: SUCCESS (0.000s) [453.009841] [102/129] (603s left) gem_partial_pwrite_pread (write-display) [453.077681] Subtest write-display: SKIP (0.000s) [453.147192] [103/129] (603s left) gem_exec_balancer (indices) [453.214003] Starting subtest: indices [455.634744] Subtest indices: SUCCESS (2.418s) [455.938962] [104/129] (600s left) gen7_exec_parse (basic-rejected) [455.997036] Subtest basic-rejected: SKIP (0.000s) [456.063668] [105/129] (600s left) kms_pm_rpm (pm-caching) [457.811557] Starting subtest: pm-caching [457.816680] Subtest pm-caching: SKIP (0.000s) [458.348626] [106/129] (598s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled) [458.413199] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled [458.415526] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s) [458.501118] [107/129] (598s left) kms_vblank (query-busy) [458.591284] Starting subtest: query-busy [458.593848] Starting dynamic subtest: pipe-A-eDP-1 [460.478571] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.884s) [460.493596] Starting dynamic subtest: pipe-D-eDP-1 [462.991898] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.511s) [462.994028] Subtest query-busy: SUCCESS (4.398s) [463.786019] [108/129] (593s left) kms_flip (plain-flip-interruptible) [463.895192] Starting subtest: plain-flip-interruptible [463.897691] Starting dynamic subtest: A-eDP1 [465.590012] Dynamic subtest A-eDP1: SUCCESS (1.693s) [465.598953] Starting dynamic subtest: B-eDP1 [467.313420] Dynamic subtest B-eDP1: SUCCESS (1.722s) [467.324124] Starting dynamic subtest: C-eDP1 [468.934592] Dynamic subtest C-eDP1: SUCCESS (1.619s) [468.945870] Starting dynamic subtest: D-eDP1 [470.557388] Dynamic subtest D-eDP1: SUCCESS (1.622s) [470.564000] Subtest plain-flip-interruptible: SUCCESS (6.667s) [471.715754] [109/129] (585s left) kms_big_fb (linear-8bpp-rotate-270) [471.823715] Starting subtest: linear-8bpp-rotate-270 [471.848414] Subtest linear-8bpp-rotate-270: SKIP (0.021s) [471.955119] [110/129] (585s left) gem_ctx_create (basic-files) [472.017948] Starting subtest: basic-files [474.029035] Subtest basic-files: SUCCESS (2.010s) [475.674201] [111/129] (581s left) kms_rotation_crc (bad-pixel-format) [475.779391] Starting subtest: bad-pixel-format [475.784691] Subtest bad-pixel-format: SKIP (0.001s) [475.849669] [112/129] (581s left) kms_cursor_crc (cursor-random-128x42) [476.054200] Starting subtest: cursor-random-128x42 [476.096212] Subtest cursor-random-128x42: SKIP (0.034s) [476.301144] [113/129] (580s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs) [476.400425] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs [476.405535] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s) [477.539316] [114/129] (579s left) kms_flip (absolute-wf_vblank) [477.645816] Starting subtest: absolute-wf_vblank [477.648449] Starting dynamic subtest: A-eDP1 [486.405343] Dynamic subtest A-eDP1: SUCCESS (8.758s) [486.415132] Starting dynamic subtest: B-eDP1 [495.135350] Dynamic subtest B-eDP1: SUCCESS (8.728s) [495.146716] Starting dynamic subtest: C-eDP1 [503.857519] Dynamic subtest C-eDP1: SUCCESS (8.721s) [503.866198] Starting dynamic subtest: D-eDP1 [512.583250] Dynamic subtest D-eDP1: SUCCESS (8.724s) [512.585927] Subtest absolute-wf_vblank: SUCCESS (34.939s) [513.792877] [115/129] (543s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling) [513.898313] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling [513.900932] Starting dynamic subtest: pipe-A-default-mode [514.184571] Dynamic subtest pipe-A-default-mode: SKIP (0.285s) [514.189494] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.287s) [515.018079] [116/129] (542s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu) [515.118348] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu [519.436696] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (4.323s) [519.543975] [117/129] (537s left) syncobj_wait (invalid-signal-zero-handles) [519.603568] Starting subtest: invalid-signal-zero-handles [519.606419] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [519.710974] [118/129] (537s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs) [519.806473] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs [519.809258] Starting dynamic subtest: pipe-A-eDP-1 [520.659250] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.839s) [520.669440] Starting dynamic subtest: pipe-B-eDP-1 [522.165112] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.507s) [522.175083] Starting dynamic subtest: pipe-C-eDP-1 [523.669486] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.503s) [523.679728] Starting dynamic subtest: pipe-D-eDP-1 [525.107410] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.435s) [525.109605] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.289s) [526.282232] [119/129] (531s left) i915_suspend (fence-restore-tiled2untiled) [526.348398] Starting subtest: fence-restore-tiled2untiled [526.353717] Subtest fence-restore-tiled2untiled: SKIP (0.000s) [526.456113] [120/129] (531s left) perf_pmu (busy-hang) [526.497361] Starting subtest: busy-hang [526.499807] Starting dynamic subtest: rcs0 [527.784328] Dynamic subtest rcs0: SUCCESS (1.288s) [527.793729] Starting dynamic subtest: bcs0 [529.020593] Dynamic subtest bcs0: SUCCESS (1.230s) [529.030738] Starting dynamic subtest: vcs0 [531.202537] Dynamic subtest vcs0: SUCCESS (2.180s) [531.222110] Starting dynamic subtest: vcs1 [533.183885] Dynamic subtest vcs1: SUCCESS (1.980s) [533.194948] Starting dynamic subtest: vecs0 [535.163140] Dynamic subtest vecs0: SUCCESS (1.981s) [535.174909] Starting dynamic subtest: ccs0 [536.413000] Dynamic subtest ccs0: SUCCESS (1.244s) [536.416008] Subtest busy-hang: SUCCESS (9.914s) [536.517107] [121/129] (521s left) perf_pmu (all-busy-check-all) [536.562504] Starting subtest: all-busy-check-all [537.653715] Subtest all-busy-check-all: SUCCESS (1.093s) [537.761395] [122/129] (519s left) gem_tiled_partial_pwrite_pread (writes-after-reads) [537.831002] Subtest writes-after-reads: SKIP (0.000s) [537.913323] [123/129] (519s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf) [542.948335] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf [542.953465] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.002s) [543.785223] [124/129] (513s left) gem_basic (create-fd-close) [543.852529] Starting subtest: create-fd-close [543.858499] Subtest create-fd-close: SUCCESS (0.000s) [543.961648] [125/129] (513s left) gem_mmap_gtt (basic-wc) [544.033758] Subtest basic-wc: SKIP (0.000s) [544.095986] [126/129] (513s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling) [544.197080] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling [544.199396] Starting dynamic subtest: pipe-A-default-mode [544.486463] Dynamic subtest pipe-A-default-mode: SKIP (0.284s) [544.491983] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.285s) [545.306404] [127/129] (512s left) kms_psr (pr-sprite-mmap-cpu) [545.417217] Starting subtest: pr-sprite-mmap-cpu [545.421678] Subtest pr-sprite-mmap-cpu: SKIP (0.000s) [545.483939] [128/129] (512s left) kms_plane_scaling (planes-downscale-factor-0-5) [545.590213] Starting subtest: planes-downscale-factor-0-5 [545.592689] Starting dynamic subtest: pipe-A [545.603411] Dynamic subtest pipe-A: SKIP (0.005s) [545.612867] Starting dynamic subtest: pipe-B [545.623761] Dynamic subtest pipe-B: SKIP (0.016s) [545.632709] Starting dynamic subtest: pipe-C [545.642920] Dynamic subtest pipe-C: SKIP (0.016s) [545.651698] Starting dynamic subtest: pipe-D [545.661772] Dynamic subtest pipe-D: SKIP (0.016s) [545.667239] Subtest planes-downscale-factor-0-5: SKIP (0.054s) [545.734705] [129/129] (512s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt) [545.839551] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt [545.844842] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [545.940745] Closing watchdogs Done.