[57.335107] Initializing watchdogs [57.335149] /dev/watchdog0 [57.348198] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [57.351896] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.354013] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.357492] [001/131] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu) [57.583972] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu [60.938115] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (3.375s) [61.054715] [002/131] (956s left) gem_exec_schedule (pi-ringfull) [61.250787] Starting subtest: pi-ringfull [61.253220] Starting dynamic subtest: rcs0 [61.341209] Dynamic subtest rcs0: SUCCESS (0.093s) [61.354370] Starting dynamic subtest: bcs0 [61.414313] Dynamic subtest bcs0: SUCCESS (0.073s) [61.427431] Starting dynamic subtest: vcs0 [61.488458] Dynamic subtest vcs0: SUCCESS (0.074s) [61.501515] Starting dynamic subtest: vcs1 [61.561672] Dynamic subtest vcs1: SUCCESS (0.073s) [61.575138] Starting dynamic subtest: vecs0 [61.635376] Dynamic subtest vecs0: SUCCESS (0.074s) [61.649237] Starting dynamic subtest: ccs0 [61.709093] Dynamic subtest ccs0: SUCCESS (0.074s) [61.711878] Subtest pi-ringfull: SUCCESS (0.462s) [61.939729] [FACT gem_exec_schedule (pi-ringfull)] new: kernel.kmod_is_loaded.vgem: true [61.942593] [003/131] (955s left) gem_ctx_param (invalid-ctx-set) [61.991748] Starting subtest: invalid-ctx-set [61.994299] Subtest invalid-ctx-set: SUCCESS (0.001s) [62.092180] [004/131] (955s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [62.194190] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s) [62.294216] [005/131] (955s left) kms_addfb_basic (small-bo) [62.397888] Starting subtest: small-bo [62.400318] Subtest small-bo: SUCCESS (0.000s) [62.500174] [006/131] (955s left) gem_flink_basic (flink-lifetime) [62.559138] Starting subtest: flink-lifetime [62.561575] Subtest flink-lifetime: SUCCESS (0.002s) [62.662554] [007/131] (955s left) kms_big_fb (4-tiled-8bpp-rotate-90) [62.758823] Starting subtest: 4-tiled-8bpp-rotate-90 [62.778089] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.019s) [62.895666] [008/131] (955s left) kms_big_fb (yf-tiled-8bpp-rotate-0) [62.999155] Starting subtest: yf-tiled-8bpp-rotate-0 [63.002737] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s) [63.095801] [009/131] (954s left) i915_pm_rps (fence-order) [63.149468] Starting subtest: fence-order [65.685033] Subtest fence-order: SUCCESS (2.540s) [65.756834] [010/131] (952s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs) [65.854653] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs [65.857283] Starting dynamic subtest: pipe-A-eDP-1 [98.555879] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.900s) [98.568647] Starting dynamic subtest: pipe-B-eDP-1 [131.459752] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.987s) [131.468824] Starting dynamic subtest: pipe-C-eDP-1 [164.439777] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.385s) [164.449319] Starting dynamic subtest: pipe-D-eDP-1 [197.471435] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.440s) [197.473911] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (13.714s) [198.632850] [011/131] (937s left) perf_pmu (busy-idle) [198.673389] Starting subtest: busy-idle [198.675585] Starting dynamic subtest: rcs0 [199.400956] Dynamic subtest rcs0: SUCCESS (0.737s) [199.410951] Starting dynamic subtest: bcs0 [200.072220] Dynamic subtest bcs0: SUCCESS (0.679s) [200.082356] Starting dynamic subtest: vcs0 [202.013622] Dynamic subtest vcs0: SUCCESS (1.959s) [202.024199] Starting dynamic subtest: vcs1 [204.000326] Dynamic subtest vcs1: SUCCESS (2.001s) [204.011446] Starting dynamic subtest: vecs0 [205.980054] Dynamic subtest vecs0: SUCCESS (1.992s) [205.989295] Starting dynamic subtest: ccs0 [206.653230] Dynamic subtest ccs0: SUCCESS (0.677s) [206.655935] Subtest busy-idle: SUCCESS (8.049s) [206.753470] [012/131] (929s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc) [206.856403] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc [206.858907] Starting dynamic subtest: pipe-A-eDP-1 [207.599519] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.737s) [207.609362] Starting dynamic subtest: pipe-B-eDP-1 [209.388380] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.794s) [209.395931] Starting dynamic subtest: pipe-C-eDP-1 [211.202293] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.820s) [211.211227] Starting dynamic subtest: pipe-D-eDP-1 [213.024235] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.826s) [213.026291] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.180s) [214.144283] [013/131] (921s left) gem_render_copy (yf-tiled) [214.202630] Starting subtest: yf-tiled [214.207230] Subtest yf-tiled: SKIP (0.000s) [214.380606] [014/131] (921s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-pwrite) [214.481816] Starting subtest: fbc-1p-offscren-pri-indfb-draw-pwrite [218.395967] Subtest fbc-1p-offscren-pri-indfb-draw-pwrite: SUCCESS (3.925s) [218.502992] [015/131] (917s left) syncobj_eventfd (invalid-bad-pad) [218.567621] Starting subtest: invalid-bad-pad [218.569844] Subtest invalid-bad-pad: SUCCESS (0.000s) [218.664078] [016/131] (917s left) kms_flip (basic-plain-flip) [218.761595] Starting subtest: basic-plain-flip [218.763985] Starting dynamic subtest: A-eDP1 [220.466880] Dynamic subtest A-eDP1: SUCCESS (1.707s) [220.479299] Starting dynamic subtest: B-eDP1 [222.190292] Dynamic subtest B-eDP1: SUCCESS (1.725s) [222.200742] Starting dynamic subtest: C-eDP1 [223.902042] Dynamic subtest C-eDP1: SUCCESS (1.713s) [223.912182] Starting dynamic subtest: D-eDP1 [225.630128] Dynamic subtest D-eDP1: SUCCESS (1.728s) [225.632701] Subtest basic-plain-flip: SUCCESS (6.880s) [226.778317] [017/131] (909s left) kms_prop_blob (blob-prop-lifetime) [226.837069] Starting subtest: blob-prop-lifetime [226.839149] Subtest blob-prop-lifetime: SUCCESS (0.001s) [226.945955] [018/131] (909s left) gem_exec_whisper (basic-normal-all) [227.003899] Starting subtest: basic-normal-all [229.236155] Subtest basic-normal-all: SUCCESS (2.232s) [229.409969] [019/131] (906s left) kms_psr (psr2-no-drrs) [229.506192] Starting subtest: psr2-no-drrs [229.509042] Starting dynamic subtest: eDP-1 [231.144262] Dynamic subtest eDP-1: SUCCESS (1.638s) [231.146656] Subtest psr2-no-drrs: SUCCESS (1.639s) [231.932574] [020/131] (904s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt) [232.040911] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt [232.045582] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [232.131423] [021/131] (904s left) kms_cursor_crc (cursor-sliding-64x64) [232.291224] Starting subtest: cursor-sliding-64x64 [232.296316] Starting dynamic subtest: pipe-A-eDP-1 [235.782884] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.490s) [235.810016] Starting dynamic subtest: pipe-D-eDP-1 [239.838958] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.039s) [239.841131] Subtest cursor-sliding-64x64: SUCCESS (7.550s) [240.688399] [022/131] (895s left) kms_psr (fbc-psr2-suspend) [240.792816] Starting subtest: fbc-psr2-suspend [240.795084] Starting dynamic subtest: eDP-1 [240.799208] Dynamic subtest eDP-1: SKIP (0.000s) [240.803304] Subtest fbc-psr2-suspend: SKIP (0.001s) [240.858505] [023/131] (895s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled) [240.932595] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled [241.041807] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.107s) [241.107739] [024/131] (895s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt) [241.209849] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt [241.214254] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [241.315351] [025/131] (895s left) kms_chamelium_edid (dp-edid-read) [241.707202] Subtest dp-edid-read: SKIP (0.000s) [242.497750] [026/131] (893s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite) [242.600547] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite [242.604550] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [242.696035] [027/131] (893s left) syncobj_timeline (etime-single-wait-available-unsubmitted) [242.763616] Starting subtest: etime-single-wait-available-unsubmitted [242.864600] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.101s) [242.933307] [028/131] (893s left) kms_scaling_modes (scaling-mode-none) [243.031539] Starting subtest: scaling-mode-none [243.033819] Starting dynamic subtest: pipe-A-eDP-1 [243.145202] Dynamic subtest pipe-A-eDP-1: SKIP (0.111s) [243.153509] Starting dynamic subtest: pipe-B-eDP-1 [243.192178] Dynamic subtest pipe-B-eDP-1: SKIP (0.046s) [243.199763] Starting dynamic subtest: pipe-C-eDP-1 [243.237864] Dynamic subtest pipe-C-eDP-1: SKIP (0.045s) [243.247868] Starting dynamic subtest: pipe-D-eDP-1 [243.282299] Dynamic subtest pipe-D-eDP-1: SKIP (0.044s) [243.286302] Subtest scaling-mode-none: SKIP (0.249s) [243.397754] [029/131] (893s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt) [243.514556] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt [243.518877] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [243.603222] [030/131] (892s left) gem_unref_active_buffers [243.805379] [031/131] (892s left) gem_userptr_blits (probe) [243.872098] Starting subtest: probe [243.953526] Subtest probe: SUCCESS (0.081s) [244.080596] [032/131] (892s left) syncobj_timeline (wait-any-complex) [244.139246] Starting subtest: wait-any-complex [244.199326] Subtest wait-any-complex: SUCCESS (0.062s) [244.269176] [033/131] (892s left) kms_vblank (query-idle) [244.369979] Starting subtest: query-idle [244.371866] Starting dynamic subtest: pipe-A-eDP-1 [246.121509] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.751s) [246.134726] Starting dynamic subtest: pipe-D-eDP-1 [248.545067] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.423s) [248.547479] Subtest query-idle: SUCCESS (4.176s) [249.363658] [034/131] (887s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf) [254.412895] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf [254.417593] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.004s) [255.258561] [035/131] (881s left) gem_exec_balancer (noheartbeat) [255.512381] Starting subtest: noheartbeat [255.518098] Subtest noheartbeat: SKIP (0.000s) [255.607812] [036/131] (881s left) gem_madvise (dontneed-before-mmap) [255.641197] Starting subtest: dontneed-before-mmap [255.656762] Subtest dontneed-before-mmap: SUCCESS (0.019s) [255.754903] [037/131] (881s left) gem_exec_reloc (basic-cpu-noreloc) [255.813140] Subtest basic-cpu-noreloc: SKIP (0.000s) [255.886772] [038/131] (880s left) kms_psr (psr-primary-render) [255.992762] Starting subtest: psr-primary-render [255.995094] Starting dynamic subtest: eDP-1 [257.764211] Dynamic subtest eDP-1: SUCCESS (1.770s) [257.766134] Subtest psr-primary-render: SUCCESS (1.770s) [258.604458] [039/131] (878s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs) [258.714581] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs [258.716947] Starting dynamic subtest: pipe-A-eDP-1 [258.763317] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.048s) [258.772753] Starting dynamic subtest: pipe-B-eDP-1 [258.811146] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.047s) [258.820140] Starting dynamic subtest: pipe-C-eDP-1 [258.859228] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.047s) [258.869242] Starting dynamic subtest: pipe-D-eDP-1 [258.909327] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.049s) [258.911755] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.195s) [261.051656] [040/131] (875s left) gem_exec_reloc (basic-cpu-gtt-noreloc) [261.124188] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s) [261.200011] [041/131] (875s left) gem_eio (wait-immediate) [261.427090] Starting subtest: wait-immediate [261.806008] Subtest wait-immediate: SUCCESS (0.379s) [261.951869] [042/131] (874s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu) [262.058755] Starting subtest: fbc-rgb101010-draw-mmap-cpu [265.606504] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (3.552s) [265.713967] [043/131] (871s left) gem_fenced_exec_thrash (no-spare-fences) [265.783978] Subtest no-spare-fences: SKIP (0.000s) [265.864409] [044/131] (871s left) kms_writeback (writeback-invalid-parameters) [265.967530] Subtest writeback-invalid-parameters: SKIP (0.000s) [266.009409] [045/131] (871s left) prime_vgem (fence-flip-hang) [266.099706] Subtest fence-flip-hang: SKIP (0.000s) [266.220897] [046/131] (870s left) i915_pm_freq_api (freq-reset-multiple) [266.281091] Starting subtest: freq-reset-multiple [266.283442] Starting dynamic subtest: gt0 [276.025050] Dynamic subtest gt0: SUCCESS (9.746s) [276.034357] Starting dynamic subtest: gt1 [284.392331] Dynamic subtest gt1: SUCCESS (8.370s) [284.395279] Subtest freq-reset-multiple: SUCCESS (18.119s) [284.463311] [047/131] (852s left) gem_close_race (multigpu-basic-process) [284.531951] Starting subtest: multigpu-basic-process [284.536305] Subtest multigpu-basic-process: SKIP (0.000s) [284.769479] [048/131] (852s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [284.878180] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip [285.723599] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.848s) [285.910847] [049/131] (851s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff) [286.018461] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff [286.022504] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [286.097605] [050/131] (851s left) gem_exec_reloc (basic-write-wc) [286.160139] Subtest basic-write-wc: SKIP (0.000s) [286.231663] [051/131] (851s left) kms_chamelium_frames (hdmi-frame-dump) [286.614552] Subtest hdmi-frame-dump: SKIP (0.000s) [287.462207] [052/131] (849s left) gem_render_copy_redux (flink-interruptible) [287.528012] Starting subtest: flink-interruptible [288.466343] Subtest flink-interruptible: SUCCESS (0.939s) [288.595229] [053/131] (848s left) api_intel_bb (object-noreloc-keep-cache-simple) [288.650357] Starting subtest: object-noreloc-keep-cache-simple [288.652904] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.004s) [288.778620] [054/131] (848s left) gem_ctx_param (set-priority-invalid-size) [288.831999] Starting subtest: set-priority-invalid-size [288.834258] Subtest set-priority-invalid-size: SUCCESS (0.000s) [288.900208] [055/131] (848s left) kms_plane_cursor (viewport) [289.003007] Starting subtest: viewport [289.006677] Starting dynamic subtest: pipe-A-eDP-1-size-64 [291.852214] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.850s) [291.911246] Starting dynamic subtest: pipe-A-eDP-1-size-128 [294.717957] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.815s) [294.776728] Starting dynamic subtest: pipe-A-eDP-1-size-256 [297.615518] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.848s) [297.964522] Starting dynamic subtest: pipe-B-eDP-1-size-64 [301.456190] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.505s) [301.518316] Starting dynamic subtest: pipe-B-eDP-1-size-128 [304.367851] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.858s) [304.431338] Starting dynamic subtest: pipe-B-eDP-1-size-256 [307.266613] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.848s) [307.619031] Starting dynamic subtest: pipe-C-eDP-1-size-64 [310.698793] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.091s) [310.736437] Starting dynamic subtest: pipe-C-eDP-1-size-128 [313.185752] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.457s) [313.224056] Starting dynamic subtest: pipe-C-eDP-1-size-256 [315.640574] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.424s) [315.966098] Starting dynamic subtest: pipe-D-eDP-1-size-64 [318.995990] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.040s) [319.037955] Starting dynamic subtest: pipe-D-eDP-1-size-128 [321.438688] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.413s) [321.476659] Starting dynamic subtest: pipe-D-eDP-1-size-256 [323.892606] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.424s) [324.210590] Subtest viewport: SUCCESS (35.224s) [325.065970] [056/131] (812s left) kms_cursor_edge_walk (256x256-top-edge) [325.157564] Starting subtest: 256x256-top-edge [325.162113] Starting dynamic subtest: pipe-A-eDP-1 [328.613867] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.456s) [328.623280] Starting dynamic subtest: pipe-D-eDP-1 [331.719608] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.104s) [331.721635] Subtest 256x256-top-edge: SUCCESS (6.562s) [332.534199] [057/131] (804s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75) [332.628885] Starting subtest: planes-upscale-20x20-downscale-factor-0-75 [332.631319] Starting dynamic subtest: pipe-A [332.651722] Dynamic subtest pipe-A: SKIP (0.016s) [332.660775] Starting dynamic subtest: pipe-B [332.676377] Dynamic subtest pipe-B: SKIP (0.024s) [332.685213] Starting dynamic subtest: pipe-C [332.700178] Dynamic subtest pipe-C: SKIP (0.024s) [332.708316] Starting dynamic subtest: pipe-D [332.725033] Dynamic subtest pipe-D: SKIP (0.024s) [332.729557] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.091s) [332.814572] [058/131] (804s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling) [332.909788] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling [332.912069] Starting dynamic subtest: pipe-A-default-mode [333.272806] Dynamic subtest pipe-A-default-mode: SKIP (0.359s) [333.277210] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.361s) [334.055235] [059/131] (803s left) kms_dsc (dsc-with-bpc-formats) [334.153530] Starting subtest: dsc-with-bpc-formats [334.265528] Subtest dsc-with-bpc-formats: SKIP (0.003s) [334.298561] [060/131] (803s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size) [334.433957] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size [335.406274] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.972s) [336.273955] [061/131] (801s left) gen7_exec_parse (basic-allocation) [336.335935] Subtest basic-allocation: SKIP (0.000s) [336.417899] [062/131] (801s left) kms_frontbuffer_tracking (psr-1p-rte) [336.526732] Starting subtest: psr-1p-rte [339.749015] Subtest psr-1p-rte: SUCCESS (3.229s) [339.844985] [063/131] (797s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [339.948711] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip [341.204917] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (1.259s) [341.461318] [064/131] (796s left) syncobj_wait (single-wait-all-for-submit-signaled) [341.532397] Starting subtest: single-wait-all-for-submit-signaled [341.534817] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [341.634003] [065/131] (796s left) kms_flip (2x-flip-vs-rmfb) [341.735329] Starting subtest: 2x-flip-vs-rmfb [341.746204] Subtest 2x-flip-vs-rmfb: SKIP (0.010s) [341.844318] [066/131] (795s left) gem_eio (wait-wedge-1us) [342.083238] Starting subtest: wait-wedge-1us [343.075578] Subtest wait-wedge-1us: SUCCESS (0.992s) [343.222432] [067/131] (794s left) kms_legacy_colorkey (invalid-plane) [343.320720] Starting subtest: invalid-plane [343.323078] Starting dynamic subtest: zero-id [343.325261] Dynamic subtest zero-id: SUCCESS (0.000s) [343.335708] Starting dynamic subtest: outrange-id [343.337676] Dynamic subtest outrange-id: SUCCESS (0.000s) [343.339459] Subtest invalid-plane: SUCCESS (0.001s) [343.391460] [068/131] (794s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite) [343.507278] Starting subtest: fbcpsr-rgb101010-draw-pwrite [348.453974] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (4.953s) [348.586902] [069/131] (789s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc) [348.691985] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc [352.988346] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (4.302s) [353.099747] [070/131] (784s left) dmabuf_sync_file (import-multiple-read-only) [353.142639] Starting subtest: import-multiple-read-only [353.145004] Subtest import-multiple-read-only: SUCCESS (0.003s) [353.211793] [071/131] (784s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [353.329870] Starting subtest: basic-flip-after-cursor-legacy [354.232724] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.904s) [355.044601] [072/131] (782s left) gem_ctx_persistence (heartbeat-close) [355.100874] Starting subtest: heartbeat-close [355.105266] Subtest heartbeat-close: SKIP (0.000s) [355.205730] [073/131] (782s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format) [355.304730] Starting subtest: plane-downscale-factor-0-5-with-pixel-format [355.307091] Starting dynamic subtest: pipe-A [355.316264] Dynamic subtest pipe-A: SKIP (0.004s) [355.326600] Starting dynamic subtest: pipe-B [355.335761] Dynamic subtest pipe-B: SKIP (0.014s) [355.344205] Starting dynamic subtest: pipe-C [355.353292] Dynamic subtest pipe-C: SKIP (0.015s) [355.361611] Starting dynamic subtest: pipe-D [355.369409] Dynamic subtest pipe-D: SKIP (0.014s) [355.373934] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.048s) [355.459158] [074/131] (782s left) gen9_exec_parse (allowed-single) [355.532459] Subtest allowed-single: SKIP (0.000s) [355.607859] [075/131] (782s left) perf_pmu (invalid-init) [355.646343] Starting subtest: invalid-init [355.696863] Subtest invalid-init: FAIL (0.004s) [355.756559] [076/131] (782s left) gem_exec_schedule (fairslice-all) [355.827258] Starting subtest: fairslice-all [357.886834] Subtest fairslice-all: SUCCESS (2.069s) [358.185592] [077/131] (779s left) kms_async_flips (test-time-stamp) [358.282978] Starting subtest: test-time-stamp [358.665916] Starting dynamic subtest: pipe-A-eDP-1 [359.452371] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.785s) [359.824838] Starting dynamic subtest: pipe-B-eDP-1 [360.575151] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.754s) [360.937199] Starting dynamic subtest: pipe-C-eDP-1 [361.700060] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.768s) [362.061560] Starting dynamic subtest: pipe-D-eDP-1 [362.827256] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.772s) [362.829777] Subtest test-time-stamp: SUCCESS (4.545s) [363.975892] [078/131] (774s left) syncobj_wait (single-wait-for-submit-submitted) [364.040799] Starting subtest: single-wait-for-submit-submitted [364.144872] Subtest single-wait-for-submit-submitted: SUCCESS (0.104s) [364.219188] [079/131] (773s left) gem_exec_reloc (basic-cpu-wc) [364.271255] Subtest basic-cpu-wc: SKIP (0.000s) [364.323364] [080/131] (773s left) api_intel_bb (add-remove-objects) [364.373675] Starting subtest: add-remove-objects [364.378618] Subtest add-remove-objects: SUCCESS (0.008s) [364.506695] [081/131] (773s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc) [364.613387] Starting subtest: psr-rgb565-draw-mmap-wc [369.135951] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (4.527s) [369.257239] [082/131] (769s left) drm_fdinfo (virtual-idle) [369.298024] Starting subtest: virtual-idle [372.394821] Subtest virtual-idle: SUCCESS (3.096s) [372.464105] [083/131] (765s left) syncobj_timeline (single-wait-all-signaled) [372.528552] Starting subtest: single-wait-all-signaled [372.530955] Subtest single-wait-all-signaled: SUCCESS (0.000s) [372.621434] [084/131] (765s left) gem_pwrite_snooped [372.748215] [085/131] (765s left) gem_mmap_wc (write-cpu-read-wc) [372.806964] Subtest write-cpu-read-wc: SKIP (0.000s) [372.863892] [086/131] (765s left) gem_mmap_gtt (flink-race) [372.928470] Subtest flink-race: SKIP (0.000s) [372.986813] [087/131] (765s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf) [377.973895] Starting subtest: psr2-overlay-plane-move-continuous-sf [377.976329] Starting dynamic subtest: pipe-A-eDP-1 [384.667046] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.693s) [384.676833] Starting dynamic subtest: pipe-B-eDP-1 [391.389974] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.726s) [391.392503] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (13.423s) [392.260001] [088/131] (746s left) kms_cursor_crc (cursor-random-max-size) [392.554105] Starting subtest: cursor-random-max-size [392.560614] Subtest cursor-random-max-size: SKIP (0.000s) [392.658390] [089/131] (745s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite) [392.762946] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite [392.767046] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [392.860260] [090/131] (745s left) gem_lmem_swapping (verify-random) [392.903042] Subtest verify-random: SKIP (0.000s) [392.943871] [091/131] (745s left) kms_busy (extended-pageflip-modeset-hang-oldfb) [393.048421] Starting subtest: extended-pageflip-modeset-hang-oldfb [393.050902] Starting dynamic subtest: pipe-A [400.945004] Dynamic subtest pipe-A: SUCCESS (7.897s) [400.954743] Starting dynamic subtest: pipe-D [409.559927] Dynamic subtest pipe-D: SUCCESS (8.616s) [409.562377] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.519s) [410.395959] [092/131] (728s left) kms_fbcon_fbt (fbc) [410.461682] Starting subtest: fbc [415.754155] Subtest fbc: SUCCESS (5.293s) [415.828501] [093/131] (722s left) kms_flip (flip-vs-rmfb) [415.937479] Starting subtest: flip-vs-rmfb [415.939805] Starting dynamic subtest: A-eDP1 [424.623474] Dynamic subtest A-eDP1: SUCCESS (8.690s) [424.633766] Starting dynamic subtest: B-eDP1 [433.339534] Dynamic subtest B-eDP1: SUCCESS (8.720s) [433.349793] Starting dynamic subtest: C-eDP1 [442.085863] Dynamic subtest C-eDP1: SUCCESS (8.748s) [442.095099] Starting dynamic subtest: D-eDP1 [450.808668] Dynamic subtest D-eDP1: SUCCESS (8.728s) [450.813376] Subtest flip-vs-rmfb: SUCCESS (34.894s) [452.045394] [094/131] (686s left) kms_cursor_crc (cursor-dpms) [452.164026] Starting subtest: cursor-dpms [452.166471] Starting dynamic subtest: pipe-A-eDP-1 [455.207146] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.041s) [455.218197] Starting dynamic subtest: pipe-D-eDP-1 [458.820399] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.565s) [458.822562] Subtest cursor-dpms: SUCCESS (6.609s) [459.659969] [095/131] (679s left) gem_exec_params (invalid-bsd-ring) [459.721155] Starting subtest: invalid-bsd-ring [459.723642] Subtest invalid-bsd-ring: SUCCESS (0.000s) [459.819492] [096/131] (678s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs) [459.919814] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs [459.922215] Starting dynamic subtest: pipe-A-eDP-1 [476.582244] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.366s) [476.591828] Starting dynamic subtest: pipe-B-eDP-1 [493.475976] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.320s) [493.485444] Starting dynamic subtest: pipe-C-eDP-1 [510.448365] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.319s) [510.457636] Starting dynamic subtest: pipe-D-eDP-1 [527.450585] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.244s) [527.453074] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.253s) [528.636691] [097/131] (669s left) kms_psr (fbc-pr-primary-render) [528.723042] Starting subtest: fbc-pr-primary-render [528.728416] Subtest fbc-pr-primary-render: SKIP (0.000s) [528.803245] [098/131] (669s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move) [528.912360] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move [528.917572] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [529.015685] [099/131] (669s left) kms_pm_rpm (cursor-dpms) [530.542235] Starting subtest: cursor-dpms [530.548011] Subtest cursor-dpms: SKIP (0.000s) [531.237767] [100/131] (666s left) kms_color (ctm-0-75) [531.346223] Starting subtest: ctm-0-75 [531.349181] Starting dynamic subtest: pipe-A-eDP-1 [536.000144] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.686s) [536.012014] Starting dynamic subtest: pipe-B-eDP-1 [541.410712] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.432s) [541.420464] Starting dynamic subtest: pipe-C-eDP-1 [546.629330] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.229s) [546.639387] Starting dynamic subtest: pipe-D-eDP-1 [551.914442] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.293s) [551.917307] Subtest ctm-0-75: SUCCESS (20.644s) [552.770463] [101/131] (645s left) kms_rotation_crc (sprite-rotation-90) [552.878297] Starting subtest: sprite-rotation-90 [552.884427] Subtest sprite-rotation-90: SKIP (0.001s) [552.948329] [102/131] (645s left) gem_pxp (hw-rejects-pxp-context) [553.076100] Starting subtest: hw-rejects-pxp-context [553.081203] Subtest hw-rejects-pxp-context: SKIP (0.000s) [553.187216] [103/131] (645s left) sysfs_preempt_timeout (invalid) [553.250819] Starting subtest: invalid [553.253309] Starting dynamic subtest: vecs0 [553.256370] Dynamic subtest vecs0: SUCCESS (0.000s) [553.266318] Starting dynamic subtest: ccs0 [553.269277] Dynamic subtest ccs0: SUCCESS (0.000s) [553.278156] Starting dynamic subtest: vcs0 [553.280904] Dynamic subtest vcs0: SUCCESS (0.000s) [553.290233] Starting dynamic subtest: bcs0 [553.292782] Dynamic subtest bcs0: SUCCESS (0.000s) [553.303296] Starting dynamic subtest: rcs0 [553.305964] Dynamic subtest rcs0: SUCCESS (0.000s) [553.314362] Starting dynamic subtest: vcs1 [553.317136] Dynamic subtest vcs1: SUCCESS (0.000s) [553.319871] Subtest invalid: SUCCESS (0.005s) [553.351791] [104/131] (644s left) vgem_slow (nohang) [553.403381] Starting subtest: nohang [563.595168] Subtest nohang: SUCCESS (10.192s) [563.658513] [105/131] (634s left) syncobj_timeline (device-submit-unordered) [563.713096] Starting subtest: device-submit-unordered [563.716110] Subtest device-submit-unordered: SUCCESS (0.000s) [563.804216] [106/131] (634s left) gem_exec_fence (keep-in-fence) [563.992542] Starting subtest: keep-in-fence [563.995653] Starting dynamic subtest: rcs0 [564.077742] Dynamic subtest rcs0: SUCCESS (0.085s) [564.089299] Starting dynamic subtest: bcs0 [564.136566] Dynamic subtest bcs0: SUCCESS (0.057s) [564.153448] Starting dynamic subtest: vcs0 [565.293622] Dynamic subtest vcs0: SUCCESS (1.153s) [565.307317] Starting dynamic subtest: vcs1 [567.341395] Dynamic subtest vcs1: SUCCESS (2.045s) [567.358745] Starting dynamic subtest: vecs0 [569.325819] Dynamic subtest vecs0: SUCCESS (1.981s) [569.337072] Starting dynamic subtest: ccs0 [569.549857] Dynamic subtest ccs0: SUCCESS (0.223s) [569.553116] Subtest keep-in-fence: SUCCESS (5.555s) [571.435918] [107/131] (626s left) kms_psr (pr-cursor-plane-onoff) [571.532886] Starting subtest: pr-cursor-plane-onoff [571.538074] Subtest pr-cursor-plane-onoff: SKIP (0.000s) [571.603259] [108/131] (626s left) gem_mmap_offset (bad-object) [571.664205] Starting subtest: bad-object [571.667036] Subtest bad-object: SUCCESS (0.001s) [571.766412] [109/131] (626s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu) [571.870728] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu [571.875389] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [571.961149] [110/131] (626s left) gem_softpin (allocator-nopin-reserve) [572.021111] Starting subtest: allocator-nopin-reserve [572.126388] Subtest allocator-nopin-reserve: SUCCESS (0.104s) [572.265581] [111/131] (626s left) gem_ctx_persistence (saturated-hostile) [572.327274] Starting subtest: saturated-hostile [572.329966] Starting dynamic subtest: rcs0 [573.167802] Dynamic subtest rcs0: SUCCESS (0.839s) [573.179715] Starting dynamic subtest: bcs0 [573.967988] Dynamic subtest bcs0: SUCCESS (0.798s) [573.978820] Starting dynamic subtest: vcs0 [574.774515] Dynamic subtest vcs0: SUCCESS (0.804s) [574.784169] Starting dynamic subtest: vcs1 [575.591978] Dynamic subtest vcs1: SUCCESS (0.816s) [575.602378] Starting dynamic subtest: vecs0 [576.404226] Dynamic subtest vecs0: SUCCESS (0.811s) [576.416593] Starting dynamic subtest: ccs0 [577.265169] Dynamic subtest ccs0: SUCCESS (0.859s) [577.268387] Subtest saturated-hostile: SUCCESS (4.938s) [577.342644] [112/131] (621s left) kms_flip (flip-vs-suspend) [577.443397] Starting subtest: flip-vs-suspend [577.446422] Starting dynamic subtest: A-eDP1 [626.338326] Dynamic subtest A-eDP1: SUCCESS (4.515s) [626.354818] Starting dynamic subtest: B-eDP1 [675.341381] Dynamic subtest B-eDP1: SUCCESS (4.291s) [675.357517] Starting dynamic subtest: C-eDP1 [724.352711] Dynamic subtest C-eDP1: SUCCESS (4.327s) [724.363357] Starting dynamic subtest: D-eDP1 [773.325689] Dynamic subtest D-eDP1: SUCCESS (4.340s) [773.328940] Subtest flip-vs-suspend: SUCCESS (17.481s) [774.539469] [113/131] (602s left) kms_atomic_transition (plane-all-modeset-transition) [774.655000] Starting subtest: plane-all-modeset-transition [774.660065] Subtest plane-all-modeset-transition: SKIP (0.000s) [774.724407] [114/131] (602s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip) [774.830413] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip [774.835135] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s) [774.949226] [115/131] (602s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite) [775.055651] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite [779.642881] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.624s) [779.762328] [116/131] (597s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size) [779.888754] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size [810.405940] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (30.563s) [811.189536] [117/131] (565s left) gem_exec_schedule (u-semaphore-resolve) [811.261087] Starting subtest: u-semaphore-resolve [811.289145] Subtest u-semaphore-resolve: SUCCESS (0.033s) [811.640258] [118/131] (565s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled) [811.705113] Starting subtest: multi-wait-all-for-submit-available-signaled [811.708130] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s) [811.810922] [119/131] (565s left) syncobj_wait (multi-wait-all-for-submit-submitted) [811.871763] Starting subtest: multi-wait-all-for-submit-submitted [811.977574] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.106s) [812.051259] [120/131] (565s left) kms_plane_scaling (planes-downscale-factor-0-25-unity-scaling) [812.155701] Starting subtest: planes-downscale-factor-0-25-unity-scaling [812.158068] Starting dynamic subtest: pipe-A [812.174533] Dynamic subtest pipe-A: SKIP (0.011s) [812.185624] Starting dynamic subtest: pipe-B [812.196590] Dynamic subtest pipe-B: SKIP (0.020s) [812.207624] Starting dynamic subtest: pipe-C [812.218305] Dynamic subtest pipe-C: SKIP (0.020s) [812.227489] Starting dynamic subtest: pipe-D [812.236796] Dynamic subtest pipe-D: SKIP (0.020s) [812.241716] Subtest planes-downscale-factor-0-25-unity-scaling: SKIP (0.073s) [812.337039] [121/131] (564s left) kms_big_fb (y-tiled-16bpp-rotate-180) [812.439283] Starting subtest: y-tiled-16bpp-rotate-180 [812.444870] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s) [812.541029] [122/131] (564s left) gem_exec_fence (syncobj-wait) [812.957709] Starting subtest: syncobj-wait [814.807454] Subtest syncobj-wait: SUCCESS (1.849s) [815.153509] [123/131] (562s left) gem_ctx_freq (sysfs) [815.213006] Starting subtest: sysfs [815.215836] Starting dynamic subtest: gt0 [820.727977] Dynamic subtest gt0: SUCCESS (5.517s) [820.737884] Starting dynamic subtest: gt1 [862.772673] Dynamic subtest gt1: SUCCESS (42.062s) [862.775740] Subtest sysfs: SUCCESS (47.582s) [862.845516] [124/131] (514s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-pwrite) [862.960138] Starting subtest: psr-1p-offscren-pri-indfb-draw-pwrite [867.917068] Subtest psr-1p-offscren-pri-indfb-draw-pwrite: SUCCESS (4.964s) [868.048350] [125/131] (509s left) perf (polling-parameterized) [868.151900] Starting subtest: polling-parameterized [888.188000] Subtest polling-parameterized: SUCCESS (20.026s) [888.236750] [126/131] (489s left) gem_eio (context-create) [888.445713] Starting subtest: context-create [888.741783] Subtest context-create: SUCCESS (0.295s) [888.852818] [127/131] (488s left) kms_big_fb (x-tiled-32bpp-rotate-270) [888.954845] Starting subtest: x-tiled-32bpp-rotate-270 [888.973696] Subtest x-tiled-32bpp-rotate-270: SKIP (0.019s) [889.107498] [128/131] (488s left) kms_invalid_mode (overflow-vrefresh) [889.205237] Starting subtest: overflow-vrefresh [889.207688] Starting dynamic subtest: pipe-A-eDP-1 [889.488832] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.281s) [889.499356] Starting dynamic subtest: pipe-B-eDP-1 [889.502089] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [889.511237] Starting dynamic subtest: pipe-C-eDP-1 [889.514104] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [889.523265] Starting dynamic subtest: pipe-D-eDP-1 [889.526472] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [889.529104] Subtest overflow-vrefresh: SUCCESS (0.286s) [890.312295] [129/131] (487s left) kms_frontbuffer_tracking (fbcpsr-tiling-4) [890.410676] Starting subtest: fbcpsr-tiling-4 [895.437916] Subtest fbcpsr-tiling-4: SUCCESS (5.030s) [895.582091] [130/131] (481s left) gem_tiled_partial_pwrite_pread (reads) [895.646740] Subtest reads: SKIP (0.000s) [895.732419] [131/131] (481s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render) [895.831229] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render [900.954860] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (5.129s) [901.071894] Closing watchdogs Done.