[58.829584] Initializing watchdogs [58.829651] /dev/watchdog0 [58.848840] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770] [58.858950] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [58.863167] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.865269] [001/130] (960s left) kms_vblank (query-forked-hang) [59.073905] Starting subtest: query-forked-hang [59.075858] Starting dynamic subtest: pipe-A-DP-4 [85.615166] Dynamic subtest pipe-A-DP-4: SUCCESS (26.539s) [85.624044] Starting dynamic subtest: pipe-D-DP-4 [110.609341] Dynamic subtest pipe-D-DP-4: SUCCESS (24.992s) [110.610265] Subtest query-forked-hang: SUCCESS (51.535s) [110.856607] [002/130] (908s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc) [111.062520] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc [111.064283] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [111.196405] [003/130] (908s left) kms_plane_scaling (planes-downscale-factor-0-25-unity-scaling) [111.394432] Starting subtest: planes-downscale-factor-0-25-unity-scaling [111.395284] Starting dynamic subtest: pipe-A [112.155394] Dynamic subtest pipe-A: SKIP (0.759s) [112.161999] Starting dynamic subtest: pipe-B [113.301875] Dynamic subtest pipe-B: SKIP (1.147s) [113.308472] Starting dynamic subtest: pipe-C [114.447533] Dynamic subtest pipe-C: SKIP (1.145s) [114.454230] Starting dynamic subtest: pipe-D [115.593899] Dynamic subtest pipe-D: SKIP (1.145s) [115.595302] Subtest planes-downscale-factor-0-25-unity-scaling: SKIP (4.197s) [115.703719] [004/130] (903s left) gem_mmap (bad-object) [115.792954] Subtest bad-object: SKIP (0.000s) [115.849986] [005/130] (903s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs) [116.051215] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs [116.052124] Starting dynamic subtest: pipe-A-DP-4 [116.060676] Dynamic subtest pipe-A-DP-4: SKIP (0.000s) [116.067530] Starting dynamic subtest: pipe-B-DP-4 [116.076164] Dynamic subtest pipe-B-DP-4: SKIP (0.000s) [116.082976] Starting dynamic subtest: pipe-C-DP-4 [116.091436] Dynamic subtest pipe-C-DP-4: SKIP (0.000s) [116.098049] Starting dynamic subtest: pipe-D-DP-4 [116.106594] Dynamic subtest pipe-D-DP-4: SKIP (0.000s) [116.108274] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SKIP (0.006s) [116.426892] [006/130] (903s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu) [116.630745] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu [116.632457] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [116.726630] [007/130] (902s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip) [116.939253] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip [118.172205] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.232s) [118.399091] [008/130] (901s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt) [118.603976] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt [118.605850] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [118.731740] [009/130] (901s left) gem_exec_reloc (basic-cpu-gtt-active) [118.813520] Subtest basic-cpu-gtt-active: SKIP (0.000s) [118.900476] [010/130] (900s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels) [119.101340] Starting subtest: plane-all-modeset-transition-fencing-internal-panels [119.103165] Subtest plane-all-modeset-transition-fencing-internal-panels: SKIP (0.000s) [119.175914] [011/130] (900s left) gem_sync (basic-many-each) [119.266730] Starting subtest: basic-many-each [121.633197] Subtest basic-many-each: SUCCESS (2.366s) [121.918801] [012/130] (898s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move) [122.125057] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move [122.126911] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [122.243704] [013/130] (897s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [122.449935] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [122.451739] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [122.585834] [014/130] (897s left) gem_exec_params (mmapped) [122.662744] Starting subtest: mmapped [122.664973] Subtest mmapped: SUCCESS (0.002s) [122.852080] [015/130] (897s left) gem_render_copy_redux (normal) [122.938589] Starting subtest: normal [123.610598] Subtest normal: SUCCESS (0.672s) [123.801853] [016/130] (896s left) kms_pipe_crc_basic (hang-read-crc) [124.003340] Starting subtest: hang-read-crc [124.004255] Starting dynamic subtest: pipe-A-DP-4 [125.478719] Dynamic subtest pipe-A-DP-4: SUCCESS (1.474s) [125.490070] Starting dynamic subtest: pipe-B-DP-4 [126.799531] Dynamic subtest pipe-B-DP-4: SUCCESS (1.318s) [126.812265] Starting dynamic subtest: pipe-C-DP-4 [128.171211] Dynamic subtest pipe-C-DP-4: SUCCESS (1.369s) [128.182446] Starting dynamic subtest: pipe-D-DP-4 [129.513253] Dynamic subtest pipe-D-DP-4: SUCCESS (1.340s) [129.514251] Subtest hang-read-crc: SUCCESS (5.510s) [129.832671] [017/130] (890s left) i915_pm_freq_api (freq-basic-api) [129.918056] Starting subtest: freq-basic-api [129.919021] Starting dynamic subtest: gt0 [129.923309] Dynamic subtest gt0: SUCCESS (0.005s) [129.924253] Subtest freq-basic-api: SUCCESS (0.006s) [130.096905] [018/130] (890s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs) [130.297515] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs [130.298424] Starting dynamic subtest: pipe-A-DP-4 [130.320289] Dynamic subtest pipe-A-DP-4: SKIP (0.002s) [130.327847] Starting dynamic subtest: pipe-B-DP-4 [130.350310] Dynamic subtest pipe-B-DP-4: SKIP (0.002s) [130.357865] Starting dynamic subtest: pipe-C-DP-4 [130.383496] Dynamic subtest pipe-C-DP-4: SKIP (0.002s) [130.391112] Starting dynamic subtest: pipe-D-DP-4 [130.412091] Dynamic subtest pipe-D-DP-4: SKIP (0.002s) [130.413479] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.013s) [130.742574] [019/130] (889s left) kms_chamelium_frames (hdmi-frame-dump) [131.016672] Subtest hdmi-frame-dump: SKIP (0.000s) [131.164983] [020/130] (889s left) syncobj_timeline (etime-multi-wait-for-submit-submitted) [131.235015] Starting subtest: etime-multi-wait-for-submit-submitted [131.343249] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.107s) [131.448515] [021/130] (889s left) drm_fdinfo (busy-hang) [131.510806] Starting subtest: busy-hang [131.511769] Starting dynamic subtest: rcs0 [131.534308] Dynamic subtest rcs0: SKIP (0.022s) [131.542829] Starting dynamic subtest: bcs0 [131.544667] Dynamic subtest bcs0: SKIP (0.001s) [131.553413] Starting dynamic subtest: vcs0 [131.555351] Dynamic subtest vcs0: SKIP (0.001s) [131.563533] Starting dynamic subtest: vcs1 [131.565487] Dynamic subtest vcs1: SKIP (0.001s) [131.573861] Starting dynamic subtest: vecs0 [131.576061] Dynamic subtest vecs0: SKIP (0.001s) [131.584934] Starting dynamic subtest: vecs1 [131.586918] Dynamic subtest vecs1: SKIP (0.001s) [131.594587] Starting dynamic subtest: ccs0 [131.596552] Dynamic subtest ccs0: SKIP (0.001s) [131.598484] Subtest busy-hang: SKIP (0.032s) [131.634168] [022/130] (889s left) kms_atomic (atomic-plane-damage) [131.833411] Starting subtest: atomic-plane-damage [132.250459] Starting dynamic subtest: pipe-A-DP-4 [133.331420] Dynamic subtest pipe-A-DP-4: SUCCESS (1.081s) [133.332694] Subtest atomic-plane-damage: SUCCESS (1.499s) [133.593719] [023/130] (887s left) gem_ctx_persistence (heartbeat-many) [133.674397] Starting subtest: heartbeat-many [133.676487] Subtest heartbeat-many: SKIP (0.000s) [133.819355] [024/130] (886s left) gen9_exec_parse (basic-rejected) [133.895980] Subtest basic-rejected: SKIP (0.000s) [133.956038] [025/130] (886s left) gem_watchdog (default-virtual) [134.035244] Starting subtest: default-virtual [141.104266] Subtest default-virtual: SUCCESS (7.066s) [141.193066] [026/130] (879s left) kms_pm_backlight (basic-brightness) [141.392108] Subtest basic-brightness: SKIP (0.000s) [141.438875] [027/130] (879s left) gem_mmap_wc (close) [141.510263] Subtest close: SKIP (0.000s) [141.578707] [028/130] (879s left) kms_pm_rpm (pm-caching) [144.109234] Starting subtest: pm-caching [144.111406] Subtest pm-caching: SKIP (0.000s) [144.500877] [029/130] (876s left) kms_big_fb (y-tiled-addfb-size-overflow) [144.708117] Starting subtest: y-tiled-addfb-size-overflow [144.709948] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s) [144.849539] [030/130] (876s left) gem_exec_whisper (basic-contexts) [144.934811] Starting subtest: basic-contexts [155.409137] Subtest basic-contexts: SUCCESS (10.473s) [155.668423] [031/130] (865s left) prime_mmap (test_aperture_limit) [155.733472] Starting subtest: test_aperture_limit [155.734408] Starting dynamic subtest: test_aperture_limit-smem [170.860361] [032/130] (850s left) perf (gen12-group-concurrent-oa-buffer-read) [171.301426] Starting subtest: gen12-group-concurrent-oa-buffer-read [181.341109] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.039s) [181.388656] [033/130] (839s left) kms_atomic_transition (plane-all-transition-fencing) [181.613768] Starting subtest: plane-all-transition-fencing [181.616998] Starting dynamic subtest: pipe-A-DP-4 [185.347185] Dynamic subtest pipe-A-DP-4: SUCCESS (3.730s) [185.435943] Starting dynamic subtest: pipe-B-DP-4 [189.199214] Dynamic subtest pipe-B-DP-4: SUCCESS (3.776s) [189.252087] Subtest plane-all-transition-fencing: SUCCESS (7.638s) [189.475596] [034/130] (831s left) kms_setmode (invalid-clone-exclusive-crtc) [189.551339] Starting subtest: invalid-clone-exclusive-crtc [189.554197] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s) [189.704926] [035/130] (831s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu) [189.910156] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu [189.911892] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [190.065799] [036/130] (831s left) kms_frontbuffer_tracking (pipe-fbc-rte) [190.273940] Starting subtest: pipe-fbc-rte [190.279257] Subtest pipe-fbc-rte: SKIP (0.000s) [190.403989] [037/130] (831s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render) [190.609069] Starting subtest: fbc-rgb565-draw-render [193.325869] Subtest fbc-rgb565-draw-render: SUCCESS (2.717s) [193.547788] [038/130] (828s left) kms_rotation_crc (primary-4-tiled-reflect-x-0) [193.746488] Starting subtest: primary-4-tiled-reflect-x-0 [204.300981] Subtest primary-4-tiled-reflect-x-0: SUCCESS (10.554s) [204.675446] [039/130] (817s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move) [204.879832] Starting subtest: psr-1p-primscrn-cur-indfb-move [204.881490] Subtest psr-1p-primscrn-cur-indfb-move: SKIP (0.000s) [205.044111] [040/130] (816s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf) [205.246118] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s) [205.303330] [041/130] (816s left) gem_ctx_param (invalid-param-get) [205.371768] Starting subtest: invalid-param-get [205.372647] Subtest invalid-param-get: SUCCESS (0.001s) [205.523334] [042/130] (816s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc) [205.730123] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc [205.731933] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [205.863343] [043/130] (816s left) kms_dp_linktrain_fallback (dsc-fallback) [206.069276] Starting subtest: dsc-fallback [206.071869] Subtest dsc-fallback: SKIP (0.000s) [206.159707] [044/130] (815s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy) [206.363524] Starting subtest: 2x-long-cursor-vs-flip-legacy [206.366548] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.002s) [206.464336] [045/130] (815s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled) [206.537780] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled [206.538701] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s) [206.693729] [046/130] (815s left) kms_invalid_mode (zero-hdisplay) [206.894054] Starting subtest: zero-hdisplay [206.894972] Starting dynamic subtest: pipe-A-DP-4 [206.972275] Dynamic subtest pipe-A-DP-4: SUCCESS (0.076s) [206.983063] Starting dynamic subtest: pipe-B-DP-4 [206.984140] Dynamic subtest pipe-B-DP-4: SUCCESS (0.001s) [206.994667] Starting dynamic subtest: pipe-C-DP-4 [206.995528] Dynamic subtest pipe-C-DP-4: SUCCESS (0.001s) [207.006199] Starting dynamic subtest: pipe-D-DP-4 [207.007232] Dynamic subtest pipe-D-DP-4: SUCCESS (0.001s) [207.008189] Subtest zero-hdisplay: SUCCESS (0.085s) [207.215960] [047/130] (815s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-blt) [207.421031] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-blt [209.832848] Subtest fbc-1p-offscren-pri-shrfb-draw-blt: SUCCESS (2.412s) [210.000070] [048/130] (812s left) kms_chamelium_hpd (vga-hpd-fast) [210.273212] Subtest vga-hpd-fast: SKIP (0.000s) [210.420446] [049/130] (811s left) kms_plane (plane-position-hole-dpms) [210.621560] Starting subtest: plane-position-hole-dpms [211.047952] Starting dynamic subtest: pipe-A-plane-1 [211.723210] Dynamic subtest pipe-A-plane-1: SUCCESS (0.675s) [211.735978] Starting dynamic subtest: pipe-A-plane-2 [212.389885] Dynamic subtest pipe-A-plane-2: SUCCESS (0.666s) [212.405168] Starting dynamic subtest: pipe-A-plane-3 [213.074412] Dynamic subtest pipe-A-plane-3: SUCCESS (0.683s) [213.086067] Starting dynamic subtest: pipe-A-plane-4 [213.733271] Dynamic subtest pipe-A-plane-4: SUCCESS (0.659s) [213.745712] Starting dynamic subtest: pipe-A-plane-5 [213.751644] Dynamic subtest pipe-A-plane-5: SUCCESS (0.017s) [214.097611] Starting dynamic subtest: pipe-B-plane-1 [214.683188] Dynamic subtest pipe-B-plane-1: SUCCESS (0.597s) [214.694294] Starting dynamic subtest: pipe-B-plane-2 [215.336693] Dynamic subtest pipe-B-plane-2: SUCCESS (0.653s) [215.346991] Starting dynamic subtest: pipe-B-plane-3 [215.990901] Dynamic subtest pipe-B-plane-3: SUCCESS (0.651s) [216.014810] Starting dynamic subtest: pipe-B-plane-4 [216.619903] Dynamic subtest pipe-B-plane-4: SUCCESS (0.627s) [216.631070] Starting dynamic subtest: pipe-B-plane-5 [216.636044] Dynamic subtest pipe-B-plane-5: SUCCESS (0.015s) [216.637050] Subtest plane-position-hole-dpms: SUCCESS (6.015s) [216.912087] [050/130] (805s left) kms_big_fb (4-tiled-16bpp-rotate-90) [217.125357] Starting subtest: 4-tiled-16bpp-rotate-90 [217.182627] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.057s) [217.375367] [051/130] (805s left) api_intel_bb (render) [217.446365] Starting subtest: render [217.447298] Starting dynamic subtest: render-none-512 [217.488532] Dynamic subtest render-none-512: SUCCESS (0.042s) [217.498714] Starting dynamic subtest: render-none-1024 [217.560184] Dynamic subtest render-none-1024: SUCCESS (0.071s) [217.570660] Starting dynamic subtest: render-x-512 [217.579195] Dynamic subtest render-x-512: SUCCESS (0.018s) [217.590518] Starting dynamic subtest: render-x-1024 [217.647101] Dynamic subtest render-x-1024: SUCCESS (0.067s) [217.657423] Starting dynamic subtest: render-y-512 [217.665707] Dynamic subtest render-y-512: SUCCESS (0.018s) [217.675954] Starting dynamic subtest: render-y-1024 [217.730066] Dynamic subtest render-y-1024: SUCCESS (0.063s) [217.731013] Subtest render: SUCCESS (0.285s) [217.871353] [052/130] (804s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render) [218.077962] Starting subtest: psr-rgb101010-draw-render [218.079713] Subtest psr-rgb101010-draw-render: SKIP (0.000s) [218.213747] [053/130] (804s left) gem_mmap_offset (open-flood) [218.287374] Starting subtest: open-flood [239.772777] Subtest open-flood: SUCCESS (21.486s) [239.934095] [054/130] (782s left) gem_partial_pwrite_pread (writes-after-reads-snoop) [240.016162] Subtest writes-after-reads-snoop: SKIP (0.000s) [240.091979] [055/130] (782s left) gem_ctx_create (basic-files) [240.174965] Starting subtest: basic-files [242.186916] Subtest basic-files: SUCCESS (2.012s) [242.700280] [056/130] (780s left) i915_pm_sseu (full-enable) [242.779589] Subtest full-enable: SKIP (0.000s) [242.904926] [057/130] (779s left) syncobj_wait (invalid-reset-bad-pad) [242.973580] Starting subtest: invalid-reset-bad-pad [242.974512] Subtest invalid-reset-bad-pad: SUCCESS (0.000s) [243.108921] [058/130] (779s left) kms_feature_discovery (display-3x) [243.315341] Starting subtest: display-3x [243.317183] Subtest display-3x: SKIP (0.000s) [243.414044] [059/130] (779s left) kms_big_fb (linear-64bpp-rotate-0) [243.619284] Starting subtest: linear-64bpp-rotate-0 [245.890514] Subtest linear-64bpp-rotate-0: SUCCESS (2.264s) [246.033807] [060/130] (777s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled) [246.108722] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled [246.109630] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.001s) [246.283941] [061/130] (776s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions) [246.483164] Starting subtest: cursorA-vs-flipB-atomic-transitions [246.485047] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s) [246.581103] [062/130] (776s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted) [246.649522] Starting subtest: etime-single-wait-all-available-unsubmitted [246.750476] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.101s) [246.897425] [063/130] (776s left) gem_exec_store (basic) [246.979113] Starting subtest: basic [247.124705] Subtest basic: SUCCESS (0.146s) [247.362375] [064/130] (775s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs) [247.571165] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs [247.572966] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s) [247.871141] [065/130] (775s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu) [248.080840] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu [248.082523] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [248.225965] [066/130] (775s left) api_intel_bb (intel-bb-blit-y) [248.300220] Starting subtest: intel-bb-blit-y [249.366036] Subtest intel-bb-blit-y: SUCCESS (1.066s) [249.517400] [067/130] (773s left) kms_psr (fbc-pr-primary-blt) [249.719748] Subtest fbc-pr-primary-blt: SKIP (0.000s) [249.774821] [068/130] (773s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite) [249.980601] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite [249.982287] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [250.122027] [069/130] (773s left) kms_chamelium_color (ctm-green-to-red) [250.319427] Subtest ctm-green-to-red: SKIP (0.000s) [250.375156] [070/130] (773s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip) [250.585069] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip [251.788608] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.203s) [251.997763] [071/130] (771s left) prime_vgem (fence-flip-hang) [252.156498] Subtest fence-flip-hang: SKIP (0.000s) [252.312287] [FACT prime_vgem (fence-flip-hang)] new: kernel.kmod_is_loaded.vgem: true [252.314920] [072/130] (771s left) kms_cursor_crc (cursor-rapid-movement-64x21) [252.650490] Starting subtest: cursor-rapid-movement-64x21 [252.655548] Starting dynamic subtest: pipe-A-DP-4 [253.086251] Dynamic subtest pipe-A-DP-4: SUCCESS (0.430s) [253.136558] Starting dynamic subtest: pipe-D-DP-4 [253.523046] Dynamic subtest pipe-D-DP-4: SUCCESS (0.395s) [253.524065] Subtest cursor-rapid-movement-64x21: SUCCESS (0.872s) [253.998220] [073/130] (769s left) kms_flip (wf_vblank-ts-check-interruptible) [254.213189] Starting subtest: wf_vblank-ts-check-interruptible [254.218549] Starting dynamic subtest: A-DP4 [262.303290] Dynamic subtest A-DP4: SUCCESS (8.084s) [262.316524] Starting dynamic subtest: B-DP4 [270.319398] Dynamic subtest B-DP4: SUCCESS (8.015s) [270.330421] Starting dynamic subtest: C-DP4 [278.332488] Dynamic subtest C-DP4: SUCCESS (8.012s) [278.344478] Starting dynamic subtest: D-DP4 [286.345718] Dynamic subtest D-DP4: SUCCESS (8.012s) [286.346650] Subtest wf_vblank-ts-check-interruptible: SUCCESS (32.133s) [286.702333] [074/130] (737s left) gem_spin_batch (spin-each) [286.794370] Starting subtest: spin-each [290.119947] Subtest spin-each: SUCCESS (3.325s) [290.455314] [075/130] (733s left) kms_psr (pr-cursor-render) [290.662600] Subtest pr-cursor-render: SKIP (0.000s) [290.722583] [076/130] (733s left) kms_cursor_crc (cursor-onscreen-64x64) [291.024296] Starting subtest: cursor-onscreen-64x64 [291.028939] Starting dynamic subtest: pipe-A-DP-4 [293.431157] Dynamic subtest pipe-A-DP-4: SUCCESS (2.401s) [293.479436] Starting dynamic subtest: pipe-D-DP-4 [296.031435] Dynamic subtest pipe-D-DP-4: SUCCESS (2.561s) [296.032403] Subtest cursor-onscreen-64x64: SUCCESS (5.006s) [296.493045] [077/130] (727s left) gem_lmem_evict (dontneed-evict-race) [299.375279] Starting subtest: dontneed-evict-race [301.480546] Subtest dontneed-evict-race: SUCCESS (2.105s) [302.655900] [FACT gem_lmem_evict (dontneed-evict-race)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [302.656954] [FACT gem_lmem_evict (dontneed-evict-race)] deleted: kernel.kmod_is_loaded.i915: true [302.659262] [078/130] (721s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled) [304.172496] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled [304.174535] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s) [304.336331] [FACT gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [304.339665] [FACT gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)] new: kernel.kmod_is_loaded.i915: true [304.342499] [079/130] (719s left) prime_vgem (basic-fence-read) [304.443577] Starting subtest: basic-fence-read [304.449273] Subtest basic-fence-read: SKIP (0.005s) [304.622511] [080/130] (719s left) gem_exec_params (dr1-dirt) [304.711537] Starting subtest: DR1-dirt [304.712502] Subtest DR1-dirt: SUCCESS (0.000s) [304.870654] [081/130] (719s left) gem_exec_fence (parallel) [305.134464] Starting subtest: parallel [305.135671] Starting dynamic subtest: rcs0 [307.285620] Dynamic subtest rcs0: SUCCESS (2.150s) [307.295312] Starting dynamic subtest: bcs0 [309.440841] Dynamic subtest bcs0: SUCCESS (2.154s) [309.450404] Starting dynamic subtest: vcs0 [311.593940] Dynamic subtest vcs0: SUCCESS (2.152s) [311.605956] Starting dynamic subtest: vcs1 [313.746866] Dynamic subtest vcs1: SUCCESS (2.152s) [313.756796] Starting dynamic subtest: vecs0 [315.899774] Dynamic subtest vecs0: SUCCESS (2.152s) [315.909597] Starting dynamic subtest: vecs1 [318.052739] Dynamic subtest vecs1: SUCCESS (2.152s) [318.062349] Starting dynamic subtest: ccs0 [320.207284] Dynamic subtest ccs0: SUCCESS (2.154s) [320.208265] Subtest parallel: SUCCESS (15.073s) [320.912983] [082/130] (703s left) kms_flip (2x-plain-flip-fb-recreate) [321.125295] Starting subtest: 2x-plain-flip-fb-recreate [321.138165] Subtest 2x-plain-flip-fb-recreate: SKIP (0.013s) [321.250615] [083/130] (703s left) kms_multipipe_modeset (basic-max-pipe-crc-check) [321.459580] Starting subtest: basic-max-pipe-crc-check [321.461709] Subtest basic-max-pipe-crc-check: SKIP (0.000s) [321.519500] [084/130] (703s left) gem_exec_schedule (semaphore-noskip) [321.615511] Starting subtest: semaphore-noskip [322.404441] Subtest semaphore-noskip: SUCCESS (0.789s) [322.846698] [085/130] (701s left) gem_ctx_freq (sysfs) [322.935490] Starting subtest: sysfs [322.936444] Starting dynamic subtest: gt0 [328.601806] Dynamic subtest gt0: SUCCESS (5.664s) [328.607862] Subtest sysfs: SUCCESS (5.668s) [328.764300] [086/130] (695s left) syncobj_timeline (single-wait-signaled) [328.851882] Starting subtest: single-wait-signaled [328.852846] Subtest single-wait-signaled: SUCCESS (0.000s) [329.010671] [087/130] (695s left) gem_exec_fence (syncobj-timeline-signal) [329.663537] Starting subtest: syncobj-timeline-signal [329.690865] Subtest syncobj-timeline-signal: SUCCESS (0.027s) [330.006045] [088/130] (694s left) gem_mmap_wc (coherency) [330.083412] Subtest coherency: SKIP (0.000s) [330.159087] [089/130] (694s left) i915_suspend (forcewake) [330.253343] Starting subtest: forcewake [368.626093] Subtest forcewake: SUCCESS (7.217s) [372.736125] [090/130] (687s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle) [372.946579] Starting subtest: short-busy-flip-before-cursor-toggle [372.948328] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s) [373.045018] [091/130] (687s left) drm_read (short-buffer-wakeup) [373.346395] Starting subtest: short-buffer-wakeup [405.802873] Subtest short-buffer-wakeup: SUCCESS (32.214s) [406.020014] [092/130] (654s left) kms_psr (fbc-psr-cursor-plane-move) [406.237545] Subtest fbc-psr-cursor-plane-move: SKIP (0.000s) [406.299541] [093/130] (654s left) perf (buffer-fill) [406.639428] Starting subtest: buffer-fill [406.640319] Starting dynamic subtest: 0-rcs0 [408.798911] Dynamic subtest 0-rcs0: SUCCESS (2.152s) [408.799883] Subtest buffer-fill: SUCCESS (2.153s) [408.876906] [094/130] (651s left) gem_mmap_gtt (basic-small-bo-tiledx) [408.959525] Subtest basic-small-bo-tiledX: SKIP (0.000s) [409.028265] [095/130] (651s left) gem_render_copy (yf-tiled-ccs-to-linear) [409.113375] Starting subtest: yf-tiled-ccs-to-linear [409.115266] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s) [409.356875] [096/130] (651s left) gem_exec_reloc (basic-gtt-wc-active) [409.441404] Subtest basic-gtt-wc-active: SKIP (0.000s) [409.548167] [097/130] (651s left) gem_exec_reloc (basic-write-gtt-active) [409.638480] Subtest basic-write-gtt-active: SKIP (0.000s) [409.716039] [098/130] (651s left) sriov_basic (enable-vfs-autoprobe-on) [409.796307] Subtest enable-vfs-autoprobe-on: SKIP (0.000s) [409.862744] [099/130] (651s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt) [410.080181] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt [410.082017] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [410.225466] [100/130] (650s left) gem_exec_parallel (contexts) [410.316850] Starting subtest: contexts [410.317848] Starting dynamic subtest: rcs0 [414.411870] Dynamic subtest rcs0: SUCCESS (4.085s) [414.452024] Starting dynamic subtest: bcs0 [418.680471] Dynamic subtest bcs0: SUCCESS (4.261s) [418.694110] Starting dynamic subtest: vcs0 [422.679719] Dynamic subtest vcs0: SUCCESS (3.995s) [422.705375] Starting dynamic subtest: vcs1 [426.267429] Dynamic subtest vcs1: SUCCESS (3.586s) [426.280846] Starting dynamic subtest: vecs0 [430.295119] Dynamic subtest vecs0: SUCCESS (4.026s) [430.341419] Starting dynamic subtest: vecs1 [434.382933] Dynamic subtest vecs1: SUCCESS (4.084s) [434.409077] Starting dynamic subtest: ccs0 [438.215108] Dynamic subtest ccs0: SUCCESS (3.830s) [438.216211] Subtest contexts: SUCCESS (27.878s) [438.500984] [101/130] (622s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling) [438.714466] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling [438.715352] Starting dynamic subtest: pipe-A-valid-mode [438.806562] Dynamic subtest pipe-A-valid-mode: SKIP (0.090s) [438.808454] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.091s) [439.035844] [102/130] (622s left) gem_mmap_gtt (big-copy-xy) [439.122581] Subtest big-copy-XY: SKIP (0.000s) [439.204033] [103/130] (622s left) kms_psr (pr-sprite-mmap-gtt) [439.412548] Subtest pr-sprite-mmap-gtt: SKIP (0.000s) [439.477796] [104/130] (621s left) gem_pwrite (basic-random) [439.563541] Subtest basic-random: SKIP (0.000s) [439.639261] [105/130] (621s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs) [439.849543] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs [439.850510] Starting dynamic subtest: pipe-A-DP-4 [439.859542] Dynamic subtest pipe-A-DP-4: SKIP (0.001s) [439.872614] Starting dynamic subtest: pipe-B-DP-4 [439.881209] Dynamic subtest pipe-B-DP-4: SKIP (0.001s) [439.893971] Starting dynamic subtest: pipe-C-DP-4 [439.902330] Dynamic subtest pipe-C-DP-4: SKIP (0.001s) [439.914886] Starting dynamic subtest: pipe-D-DP-4 [439.924826] Dynamic subtest pipe-D-DP-4: SKIP (0.001s) [439.927052] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SKIP (0.010s) [440.315581] [106/130] (621s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled) [440.398130] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [440.399090] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s) [440.513245] [107/130] (620s left) gem_mmap_wc (invalid-flags) [440.595582] Subtest invalid-flags: SKIP (0.000s) [440.671334] [108/130] (620s left) gem_ctx_persistence (legacy-engines-queued) [440.755558] Starting subtest: legacy-engines-queued [440.756472] Starting dynamic subtest: render [440.871475] Dynamic subtest render: SUCCESS (0.115s) [440.901870] Starting dynamic subtest: bsd1 [440.908460] Dynamic subtest bsd1: SUCCESS (0.035s) [440.933755] Starting dynamic subtest: bsd2 [440.996673] Dynamic subtest bsd2: SUCCESS (0.086s) [441.014099] Starting dynamic subtest: blt [441.024214] Dynamic subtest blt: SUCCESS (0.025s) [441.037169] Starting dynamic subtest: vebox [441.110595] Dynamic subtest vebox: SUCCESS (0.085s) [441.111810] Subtest legacy-engines-queued: SUCCESS (0.356s) [441.307032] [109/130] (620s left) kms_vblank (wait-idle-hang) [441.515477] Starting subtest: wait-idle-hang [441.516361] Starting dynamic subtest: pipe-A-DP-4 [467.729333] Dynamic subtest pipe-A-DP-4: SUCCESS (26.202s) [467.744476] Starting dynamic subtest: pipe-D-DP-4 [492.731203] Dynamic subtest pipe-D-DP-4: SUCCESS (24.994s) [492.732101] Subtest wait-idle-hang: SUCCESS (51.202s) [493.013294] [110/130] (568s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render) [493.234596] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render [493.236428] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [493.376514] [111/130] (568s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling) [493.591284] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling [493.592203] Starting dynamic subtest: pipe-A-valid-mode [493.663563] Dynamic subtest pipe-A-valid-mode: SKIP (0.071s) [493.665287] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.073s) [493.885314] [112/130] (568s left) syncobj_timeline (single-wait-all-for-submit-signaled) [493.965178] Starting subtest: single-wait-all-for-submit-signaled [493.966153] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [494.121254] [113/130] (567s left) gem_ccs (suspend-resume) [494.205398] Starting subtest: suspend-resume [494.207602] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0 [512.736837] Dynamic subtest linear-compressed-compfmt0-smem-lmem0: SUCCESS (3.919s) [512.750044] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0