[57.618636] Initializing watchdogs [57.618684] /dev/watchdog0 [57.631829] [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.635762] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.637848] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.641319] [001/130] (960s left) kms_pm_rpm (i2c) [59.263322] Starting subtest: i2c [64.613775] Subtest i2c: SUCCESS (5.371s) [64.704453] [002/130] (953s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu) [64.813343] Starting subtest: fbc-rgb565-draw-mmap-cpu [67.864645] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (3.062s) [67.980670] [003/130] (950s left) gem_ctx_engines (execute-allforone) [68.047603] Starting subtest: execute-allforone [68.060618] Subtest execute-allforone: SUCCESS (0.013s) [70.009160] [004/130] (948s left) gen9_exec_parse (unaligned-jump) [70.061112] Subtest unaligned-jump: SKIP (0.000s) [70.134432] [005/130] (948s left) gem_close (many-handles-one-vma) [70.192777] Starting subtest: many-handles-one-vma [70.216426] Subtest many-handles-one-vma: SUCCESS (0.024s) [70.346967] [006/130] (947s left) kms_flip (2x-nonexisting-fb-interruptible) [70.433508] Starting subtest: 2x-nonexisting-fb-interruptible [70.445436] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.010s) [70.511768] [007/130] (947s left) syncobj_eventfd (timeline-wait) [70.570478] Starting subtest: timeline-wait [70.578635] Subtest timeline-wait: SUCCESS (0.010s) [70.642880] [008/130] (947s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling) [70.737291] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling [70.739880] Starting dynamic subtest: pipe-A-default-mode [71.047970] Dynamic subtest pipe-A-default-mode: SKIP (0.308s) [71.052736] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.309s) [71.992812] [009/130] (946s left) kms_scaling_modes (scaling-mode-full) [72.092102] Starting subtest: scaling-mode-full [72.094331] Starting dynamic subtest: pipe-A-eDP-1 [72.203059] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.110s) [72.214812] Starting dynamic subtest: pipe-B-eDP-1 [73.420239] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.217s) [73.427865] Starting dynamic subtest: pipe-C-eDP-1 [74.515725] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.096s) [74.522947] Starting dynamic subtest: pipe-D-eDP-1 [75.635583] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.118s) [75.638343] Subtest scaling-mode-full: SUCCESS (3.545s) [76.778953] [010/130] (941s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf) [81.827437] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf [81.831878] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.002s) [82.671675] [011/130] (935s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render) [82.782967] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render [82.787068] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [82.878443] [012/130] (935s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [82.976128] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [82.978773] Starting dynamic subtest: pipe-A-default-mode [83.262693] Dynamic subtest pipe-A-default-mode: SKIP (0.283s) [83.267394] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.284s) [84.102720] [013/130] (934s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-blt) [84.216130] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-blt [89.053915] Subtest fbcpsr-1p-offscren-pri-indfb-draw-blt: SUCCESS (4.843s) [89.190663] [014/130] (929s left) gem_eio (banned) [89.397763] Starting subtest: banned [89.931834] Subtest banned: SUCCESS (0.533s) [90.114899] [015/130] (928s left) gem_exec_fence (invalid-timeline-fence-array) [90.646336] Starting subtest: invalid-timeline-fence-array [90.649094] Subtest invalid-timeline-fence-array: SUCCESS (0.005s) [92.034742] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true [92.038177] [016/130] (926s left) gem_pwrite (basic-exhaustion) [92.099396] Subtest basic-exhaustion: SKIP (0.000s) [92.146769] [017/130] (926s left) gem_exec_whisper (basic-fds-forked) [92.215550] Starting subtest: basic-fds-forked [117.183664] Subtest basic-fds-forked: SUCCESS (24.965s) [117.364222] [018/130] (901s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area) [122.393245] Starting subtest: psr2-overlay-plane-update-sf-dmg-area [122.395760] Starting dynamic subtest: pipe-A-eDP-1 [128.907664] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.513s) [128.917840] Starting dynamic subtest: pipe-B-eDP-1 [135.439303] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.529s) [135.441454] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (13.046s) [136.307908] [019/130] (882s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs) [136.382697] Starting subtest: mixed-tiled-to-y-tiled-ccs [136.387312] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s) [136.556624] [020/130] (882s left) prime_vgem (basic-fence-flip) [136.658819] Starting subtest: basic-fence-flip [136.993489] Subtest basic-fence-flip: SUCCESS (0.335s) [137.106772] [021/130] (881s left) kms_chamelium_frames (hdmi-cmp-planar-formats) [137.486506] Subtest hdmi-cmp-planar-formats: SKIP (0.000s) [138.311239] [022/130] (880s left) kms_plane_alpha_blend (constant-alpha-max) [138.416678] Starting subtest: constant-alpha-max [138.830320] Starting dynamic subtest: pipe-A-eDP-1 [139.752528] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.921s) [139.760485] Starting dynamic subtest: pipe-D-eDP-1 [141.350202] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.596s) [141.352149] Subtest constant-alpha-max: SUCCESS (2.931s) [142.189724] [023/130] (876s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20) [142.293052] Starting subtest: planes-downscale-factor-0-75-upscale-20x20 [142.295312] Starting dynamic subtest: pipe-A [142.367280] Dynamic subtest pipe-A: SUCCESS (0.074s) [142.379422] Starting dynamic subtest: pipe-B [143.529875] Dynamic subtest pipe-B: SUCCESS (1.150s) [143.549902] Starting dynamic subtest: pipe-C [144.629660] Dynamic subtest pipe-C: SUCCESS (1.099s) [144.649219] Starting dynamic subtest: pipe-D [145.761502] Dynamic subtest pipe-D: SUCCESS (1.129s) [145.772090] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.455s) [146.899898] [024/130] (871s left) kms_psr (fbc-psr-sprite-mmap-gtt) [146.992318] Starting subtest: fbc-psr-sprite-mmap-gtt [146.994839] Starting dynamic subtest: eDP-1 [146.999154] Dynamic subtest eDP-1: SKIP (0.000s) [147.003399] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s) [147.059916] [025/130] (871s left) gem_flink_basic (basic) [147.128352] Starting subtest: basic [147.130366] Subtest basic: SUCCESS (0.000s) [147.236326] [026/130] (871s left) i915_pm_rps (min-max-config-loaded) [147.300067] Starting subtest: min-max-config-loaded [147.304414] Subtest min-max-config-loaded: SKIP (0.000s) [147.372994] [027/130] (871s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render) [147.475479] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render [147.479987] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [147.554663] [028/130] (871s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [147.648470] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s) [147.746722] [029/130] (871s left) gem_ctx_persistence (engines-hostile-preempt) [147.813462] Starting subtest: engines-hostile-preempt [147.815934] Starting dynamic subtest: rcs0 [147.930727] Dynamic subtest rcs0: SUCCESS (0.117s) [147.940584] Starting dynamic subtest: bcs0 [148.014763] Dynamic subtest bcs0: SUCCESS (0.082s) [148.023419] Starting dynamic subtest: vcs0 [149.955622] Dynamic subtest vcs0: SUCCESS (1.937s) [149.966198] Starting dynamic subtest: vcs1 [151.898051] Dynamic subtest vcs1: SUCCESS (1.940s) [151.907359] Starting dynamic subtest: vecs0 [153.881980] Dynamic subtest vecs0: SUCCESS (1.982s) [153.891651] Starting dynamic subtest: ccs0 [153.976077] Dynamic subtest ccs0: SUCCESS (0.094s) [153.978814] Subtest engines-hostile-preempt: SUCCESS (6.161s) [154.052199] [030/130] (864s left) kms_properties (crtc-properties-legacy) [154.158038] Starting subtest: crtc-properties-legacy [154.160298] Starting dynamic subtest: pipe-A-eDP-1 [154.607826] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.448s) [154.616786] Starting dynamic subtest: pipe-B-eDP-1 [155.750521] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.142s) [155.759059] Starting dynamic subtest: pipe-C-eDP-1 [156.867864] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.116s) [156.876818] Starting dynamic subtest: pipe-D-eDP-1 [158.002313] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.131s) [158.004622] Subtest crtc-properties-legacy: SUCCESS (3.841s) [158.810605] [031/130] (860s left) gen7_exec_parse (chained-batch) [158.865697] Subtest chained-batch: SKIP (0.000s) [158.922125] [032/130] (860s left) drm_fdinfo (most-busy-idle-check-all) [158.958662] Starting subtest: most-busy-idle-check-all [158.961138] Starting dynamic subtest: rcs0 [158.965899] Dynamic subtest rcs0: SKIP (0.004s) [158.975035] Starting dynamic subtest: bcs0 [158.979668] Dynamic subtest bcs0: SKIP (0.000s) [158.987087] Starting dynamic subtest: vcs0 [158.991566] Dynamic subtest vcs0: SKIP (0.000s) [158.998525] Starting dynamic subtest: vcs1 [159.002723] Dynamic subtest vcs1: SKIP (0.000s) [159.010336] Starting dynamic subtest: vecs0 [159.014525] Dynamic subtest vecs0: SKIP (0.000s) [159.021151] Starting dynamic subtest: ccs0 [159.025112] Dynamic subtest ccs0: SKIP (0.000s) [159.028987] Subtest most-busy-idle-check-all: SKIP (0.007s) [159.056591] [033/130] (860s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode) [159.460346] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s) [160.220474] [034/130] (858s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted) [160.277366] Starting subtest: etime-single-wait-for-submit-available-unsubmitted [160.383580] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.106s) [160.453204] [035/130] (858s left) kms_atomic_interruptible (legacy-cursor) [160.558844] Starting subtest: legacy-cursor [160.561181] Starting dynamic subtest: pipe-A-eDP-1 [167.958776] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.398s) [167.961077] Subtest legacy-cursor: SUCCESS (7.399s) [168.792707] [036/130] (850s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt) [168.905457] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt [174.246717] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (5.344s) [174.398271] [037/130] (844s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt) [174.522485] Starting subtest: psr-rgb101010-draw-mmap-gtt [174.526893] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [174.617667] [038/130] (844s left) gem_userptr_blits (process-exit) [174.682394] Starting subtest: process-exit [174.692328] Subtest process-exit: SUCCESS (0.012s) [174.813544] [039/130] (844s left) kms_cursor_legacy (single-bo) [174.931559] Starting subtest: single-bo [174.933571] Starting dynamic subtest: pipe-A [180.316270] Dynamic subtest pipe-A: SUCCESS (5.381s) [180.326367] Starting dynamic subtest: pipe-B [185.700976] Dynamic subtest pipe-B: SUCCESS (5.382s) [185.710919] Starting dynamic subtest: pipe-C [191.084807] Dynamic subtest pipe-C: SUCCESS (5.381s) [191.094987] Starting dynamic subtest: pipe-D [196.470909] Dynamic subtest pipe-D: SUCCESS (5.382s) [196.479793] Starting dynamic subtest: all-pipes [201.862058] Dynamic subtest all-pipes: SUCCESS (5.391s) [201.864684] Subtest single-bo: SUCCESS (26.927s) [201.985110] [040/130] (817s left) kms_big_fb (yf-tiled-16bpp-rotate-270) [202.090889] Starting subtest: yf-tiled-16bpp-rotate-270 [202.095439] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s) [202.172141] [041/130] (817s left) kms_psr (pr-primary-render) [202.262305] Starting subtest: pr-primary-render [202.266861] Subtest pr-primary-render: SKIP (0.000s) [202.329900] [042/130] (817s left) kms_big_fb (y-tiled-8bpp-rotate-0) [202.431878] Starting subtest: y-tiled-8bpp-rotate-0 [202.436325] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s) [202.506855] [043/130] (816s left) kms_psr (fbc-pr-cursor-plane-move) [202.604033] Starting subtest: fbc-pr-cursor-plane-move [202.608154] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s) [202.668291] [044/130] (816s left) kms_hdr (bpc-switch-suspend) [202.766058] Starting subtest: bpc-switch-suspend [203.813102] Starting dynamic subtest: pipe-A-eDP-1 [223.661620] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.485s) [223.664326] Subtest bpc-switch-suspend: SUCCESS (5.532s) [223.778304] [045/130] (811s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling) [223.869322] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling [223.872019] Starting dynamic subtest: pipe-A-default-mode [224.162445] Dynamic subtest pipe-A-default-mode: SKIP (0.293s) [224.168218] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.294s) [224.935311] [046/130] (809s left) kms_writeback (writeback-check-output) [225.027511] Subtest writeback-check-output: SKIP (0.000s) [225.067567] [047/130] (809s left) kms_flip (2x-flip-vs-modeset-vs-hang) [225.157503] Starting subtest: 2x-flip-vs-modeset-vs-hang [225.168420] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.011s) [225.241814] [048/130] (809s left) syncobj_wait (single-wait-all-for-submit-submitted) [225.303433] Starting subtest: single-wait-all-for-submit-submitted [225.407797] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.107s) [225.477051] [049/130] (809s left) gem_exec_schedule (u-independent) [225.554355] Starting subtest: u-independent [225.556956] Starting dynamic subtest: rcs0 [227.324035] Dynamic subtest rcs0: SUCCESS (1.800s) [227.333231] Starting dynamic subtest: vcs0 [229.317316] Dynamic subtest vcs0: SUCCESS (2.010s) [229.328917] Starting dynamic subtest: vcs1 [231.332849] Dynamic subtest vcs1: SUCCESS (2.030s) [231.344419] Starting dynamic subtest: vecs0 [233.310922] Dynamic subtest vecs0: SUCCESS (1.988s) [233.321914] Starting dynamic subtest: ccs0 [235.324356] Dynamic subtest ccs0: SUCCESS (2.021s) [235.327524] Subtest u-independent: SUCCESS (9.856s) [235.626371] [050/130] (799s left) kms_flip (basic-plain-flip) [235.729391] Starting subtest: basic-plain-flip [235.732146] Starting dynamic subtest: A-eDP1 [237.454519] Dynamic subtest A-eDP1: SUCCESS (1.730s) [237.465502] Starting dynamic subtest: B-eDP1 [239.181199] Dynamic subtest B-eDP1: SUCCESS (1.731s) [239.190034] Starting dynamic subtest: C-eDP1 [240.889202] Dynamic subtest C-eDP1: SUCCESS (1.710s) [240.899305] Starting dynamic subtest: D-eDP1 [242.611877] Dynamic subtest D-eDP1: SUCCESS (1.725s) [242.614526] Subtest basic-plain-flip: SUCCESS (6.905s) [243.853029] [051/130] (791s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-blt) [243.970137] Starting subtest: psr-1p-offscren-pri-indfb-draw-blt [248.777880] Subtest psr-1p-offscren-pri-indfb-draw-blt: SUCCESS (4.818s) [248.932609] [052/130] (786s left) kms_plane_multiple (tiling-yf) [249.031916] Starting subtest: tiling-yf [249.036589] Subtest tiling-yf: SKIP (0.000s) [249.100620] [053/130] (785s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled) [249.166557] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled [249.169030] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s) [249.258518] [054/130] (785s left) api_intel_bb (intel-bb-blit-y) [249.324085] Starting subtest: intel-bb-blit-y [252.882846] Subtest intel-bb-blit-y: SUCCESS (3.563s) [253.019000] [055/130] (782s left) kms_joiner (basic-max-non-joiner) [253.118308] Starting subtest: basic-max-non-joiner [253.122340] Subtest basic-max-non-joiner: SKIP (0.000s) [253.176210] [056/130] (781s left) kms_psr (fbc-psr2-sprite-mmap-gtt) [253.279325] Starting subtest: fbc-psr2-sprite-mmap-gtt [253.282077] Starting dynamic subtest: eDP-1 [253.287327] Dynamic subtest eDP-1: SKIP (0.000s) [253.292301] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s) [253.346446] [057/130] (781s left) gem_spin_batch (resubmit-all) [253.414571] Starting subtest: resubmit-all [253.417269] Starting dynamic subtest: rcs0 [253.424627] Dynamic subtest rcs0: SUCCESS (0.010s) [253.434449] Starting dynamic subtest: bcs0 [253.437054] Dynamic subtest bcs0: SUCCESS (0.002s) [253.446558] Starting dynamic subtest: vcs0 [253.449301] Dynamic subtest vcs0: SUCCESS (0.002s) [253.457613] Starting dynamic subtest: vcs1 [253.460359] Dynamic subtest vcs1: SUCCESS (0.002s) [253.468501] Starting dynamic subtest: vecs0 [253.471326] Dynamic subtest vecs0: SUCCESS (0.002s) [253.479547] Starting dynamic subtest: ccs0 [253.482427] Dynamic subtest ccs0: SUCCESS (0.002s) [253.485254] Subtest resubmit-all: SUCCESS (0.023s) [255.325896] [058/130] (779s left) kms_vblank (ts-continuation-modeset) [255.410690] Starting subtest: ts-continuation-modeset [255.413291] Starting dynamic subtest: pipe-A-eDP-1 [256.840670] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.424s) [256.856460] Starting dynamic subtest: pipe-D-eDP-1 [258.991046] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.145s) [258.994015] Subtest ts-continuation-modeset: SUCCESS (3.572s) [259.783629] [059/130] (775s left) syncobj_wait (wait-all-complex) [259.845366] Starting subtest: wait-all-complex [260.059372] Subtest wait-all-complex: SUCCESS (0.215s) [260.144135] [060/130] (775s left) perf (invalid-open-flags) [260.265363] Starting subtest: invalid-open-flags [260.267831] Subtest invalid-open-flags: SUCCESS (0.000s) [260.302273] [061/130] (775s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt) [260.409539] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt [260.414971] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [260.514233] [062/130] (774s left) syncobj_timeline (wait-any-snapshot) [260.573417] Starting subtest: wait-any-snapshot [260.653579] Subtest wait-any-snapshot: SUCCESS (0.082s) [260.727239] [063/130] (774s left) kms_chamelium_audio (hdmi-audio) [261.101431] Subtest hdmi-audio: SKIP (0.000s) [261.895428] [064/130] (773s left) kms_big_fb (linear-32bpp-rotate-180) [262.001339] Starting subtest: linear-32bpp-rotate-180 [263.945630] Subtest linear-32bpp-rotate-180: SUCCESS (1.945s) [264.133680] [065/130] (771s left) kms_cursor_crc (cursor-alpha-opaque) [264.225538] Starting subtest: cursor-alpha-opaque [264.228419] Starting dynamic subtest: pipe-A-eDP-1 [264.871407] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.642s) [264.879992] Starting dynamic subtest: pipe-D-eDP-1 [266.117145] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.241s) [266.119985] Subtest cursor-alpha-opaque: SUCCESS (1.886s) [266.976227] [066/130] (768s left) syncobj_timeline (etime-multi-wait-submitted) [267.037723] Starting subtest: etime-multi-wait-submitted [267.143867] Subtest etime-multi-wait-submitted: SUCCESS (0.105s) [267.218400] [067/130] (768s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt) [267.325404] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt [267.331165] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [267.417863] [068/130] (768s left) gem_mmap_offset (partial-mmap) [267.479281] Starting subtest: partial-mmap [267.482250] Starting dynamic subtest: smem0 [267.485300] Dynamic subtest smem0: SUCCESS (0.005s) [267.488322] Subtest partial-mmap: SUCCESS (0.006s) [267.607391] [069/130] (768s left) dmabuf (all-tests) [267.641351] Starting subtest: all-tests [267.643751] Starting dynamic subtest: sanitycheck [267.819880] Dynamic subtest sanitycheck: SUCCESS (0.177s) [267.832457] Starting dynamic subtest: dma_fence [268.094902] Dynamic subtest dma_fence: SUCCESS (0.274s) [268.106419] Starting dynamic subtest: dma_fence_chain [276.513105] Dynamic subtest dma_fence_chain: SUCCESS (8.413s) [276.525605] Starting dynamic subtest: dma_fence_unwrap [276.651354] Dynamic subtest dma_fence_unwrap: SUCCESS (0.136s) [276.663708] Starting dynamic subtest: dma_resv [276.794424] Dynamic subtest dma_resv: SUCCESS (0.141s) [276.797993] Subtest all-tests: SUCCESS (9.149s) [276.852347] [070/130] (758s left) perf (buffer-fill) [276.934412] Starting subtest: buffer-fill [276.937284] Starting dynamic subtest: 0-rcs0 [279.225819] Dynamic subtest 0-rcs0: SUCCESS (2.290s) [279.237765] Starting dynamic subtest: 1-vecs0 [283.643197] Dynamic subtest 1-vecs0: SUCCESS (4.416s) [283.645797] Subtest buffer-fill: SUCCESS (6.707s) [283.689227] [071/130] (751s left) kms_big_fb (4-tiled-64bpp-rotate-90) [283.802238] Starting subtest: 4-tiled-64bpp-rotate-90 [283.821705] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.019s) [283.951592] [072/130] (751s left) drm_read (empty-block) [284.116749] Starting subtest: empty-block [285.119102] Subtest empty-block: SUCCESS (1.002s) [285.268344] [073/130] (750s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt) [285.371276] Starting subtest: fbc-rgb565-draw-blt [288.624121] Subtest fbc-rgb565-draw-blt: SUCCESS (3.258s) [288.789745] [074/130] (746s left) gem_exec_params (rel-constants-invalid-ring) [288.852767] Starting subtest: rel-constants-invalid-ring [288.855020] Subtest rel-constants-invalid-ring: SUCCESS (0.000s) [288.960683] [075/130] (746s left) gem_readwrite (new-obj) [289.013501] Subtest new-obj: SKIP (0.000s) [289.068162] [076/130] (746s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt) [289.172852] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt [294.271348] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (5.101s) [294.402839] [077/130] (741s left) kms_dp_linktrain_fallback (dsc-fallback) [294.495108] Starting subtest: dsc-fallback [294.502994] Subtest dsc-fallback: SKIP (0.000s) [294.567724] [078/130] (741s left) gem_exec_fence (syncobj-timeline-repeat) [295.088863] Starting subtest: syncobj-timeline-repeat [295.306693] Subtest syncobj-timeline-repeat: SUCCESS (0.218s) [296.404751] [079/130] (739s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff) [296.505398] Starting subtest: psr-2p-primscrn-cur-indfb-onoff [296.510320] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [296.608006] [080/130] (739s left) gem_tiled_wb [296.722419] [081/130] (739s left) gem_ctx_param (invalid-size-get) [296.775163] Starting subtest: invalid-size-get [296.778401] Subtest invalid-size-get: SUCCESS (0.001s) [296.888545] [082/130] (739s left) perf_pmu (busy-accuracy-50) [296.931529] Starting subtest: busy-accuracy-50 [296.934179] Starting dynamic subtest: rcs0 [298.468712] Dynamic subtest rcs0: SUCCESS (1.535s) [298.477508] Starting dynamic subtest: bcs0 [300.018777] Dynamic subtest bcs0: SUCCESS (1.548s) [300.030000] Starting dynamic subtest: vcs0 [301.563902] Dynamic subtest vcs0: SUCCESS (1.543s) [301.575705] Starting dynamic subtest: vcs1 [303.106649] Dynamic subtest vcs1: SUCCESS (1.541s) [303.119116] Starting dynamic subtest: vecs0 [304.653339] Dynamic subtest vecs0: SUCCESS (1.545s) [304.664957] Starting dynamic subtest: ccs0 [306.202949] Dynamic subtest ccs0: SUCCESS (1.547s) [306.205538] Subtest busy-accuracy-50: SUCCESS (9.272s) [306.315380] [083/130] (729s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt) [306.426297] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt [306.431349] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [306.530362] [084/130] (729s left) kms_big_fb (y-tiled-addfb-size-overflow) [306.642469] Starting subtest: y-tiled-addfb-size-overflow [306.648238] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s) [306.746704] [085/130] (729s left) gem_exec_reloc (basic-wc-noreloc) [306.807657] Subtest basic-wc-noreloc: SKIP (0.000s) [306.870733] [086/130] (729s left) gem_exec_reloc (basic-cpu-noreloc) [306.942435] Subtest basic-cpu-noreloc: SKIP (0.000s) [306.999061] [087/130] (729s left) kms_chamelium_frames (dp-frame-dump) [307.377034] Subtest dp-frame-dump: SKIP (0.000s) [308.156781] [088/130] (728s left) gem_ccs (block-multicopy-inplace) [308.215203] Starting subtest: block-multicopy-inplace [308.220329] Subtest block-multicopy-inplace: SKIP (0.000s) [308.317594] [089/130] (728s left) gem_exercise_blt (fast-copy-emit) [308.368001] Starting subtest: fast-copy-emit [308.370558] Starting dynamic subtest: linear-smem-smem-emit [308.391105] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.022s) [308.405091] Starting dynamic subtest: xmajor-smem-smem-emit [308.411086] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.017s) [308.421319] Starting dynamic subtest: tile4-smem-smem-emit [308.427045] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.017s) [308.434889] Starting dynamic subtest: tile64-smem-smem-emit [308.442181] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.016s) [308.444679] Subtest fast-copy-emit: SUCCESS (0.074s) [308.563434] [090/130] (727s left) kms_flip (plain-flip-fb-recreate-interruptible) [308.672051] Starting subtest: plain-flip-fb-recreate-interruptible [308.674493] Starting dynamic subtest: A-eDP1 [317.575532] Dynamic subtest A-eDP1: SUCCESS (8.904s) [317.585911] Starting dynamic subtest: B-eDP1 [326.401198] Dynamic subtest B-eDP1: SUCCESS (8.822s) [326.411332] Starting dynamic subtest: C-eDP1 [335.221462] Dynamic subtest C-eDP1: SUCCESS (8.817s) [335.230759] Starting dynamic subtest: D-eDP1 [344.041148] Dynamic subtest D-eDP1: SUCCESS (8.818s) [344.045848] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.369s) [345.206923] [091/130] (691s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc) [345.300157] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc [345.302755] Starting dynamic subtest: pipe-A-eDP-1 [345.376124] Dynamic subtest pipe-A-eDP-1: SKIP (0.002s) [345.391203] Starting dynamic subtest: pipe-B-eDP-1 [345.459379] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [345.474172] Starting dynamic subtest: pipe-C-eDP-1 [345.534735] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [345.546137] Starting dynamic subtest: pipe-D-eDP-1 [345.611952] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [345.617058] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.008s) [347.457035] [092/130] (688s left) gem_eio (create-ext) [347.655275] Starting subtest: create-ext [347.921309] Subtest create-ext: SUCCESS (0.266s) [348.076645] [093/130] (688s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic) [348.194921] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic [348.199499] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s) [348.302877] [094/130] (688s left) kms_plane_scaling (planes-upscale-factor-0-25) [348.410811] Starting subtest: planes-upscale-factor-0-25 [348.412955] Starting dynamic subtest: pipe-A [348.475212] Dynamic subtest pipe-A: SUCCESS (0.064s) [348.484702] Starting dynamic subtest: pipe-B [349.582294] Dynamic subtest pipe-B: SUCCESS (1.106s) [349.593825] Starting dynamic subtest: pipe-C [350.703395] Dynamic subtest pipe-C: SUCCESS (1.121s) [350.718533] Starting dynamic subtest: pipe-D [351.816517] Dynamic subtest pipe-D: SUCCESS (1.112s) [351.819423] Subtest planes-upscale-factor-0-25: SUCCESS (3.405s) [352.961381] [095/130] (683s left) kms_addfb_basic (unused-pitches) [353.027058] Starting subtest: unused-pitches [353.029812] Subtest unused-pitches: SUCCESS (0.000s) [353.172765] [096/130] (683s left) kms_cursor_legacy (cursora-vs-flipa-toggle) [353.301321] Starting subtest: cursorA-vs-flipA-toggle [364.455199] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.151s) [365.285321] [097/130] (671s left) kms_prop_blob (basic) [365.347504] Starting subtest: basic [365.350063] Subtest basic: SUCCESS (0.000s) [365.447786] [098/130] (671s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt) [365.558705] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt [369.084773] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (3.532s) [369.228442] [099/130] (667s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render) [369.337384] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render [373.938099] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (4.603s) [374.080890] [100/130] (662s left) gem_exec_schedule (smoketest-all) [374.146353] Starting subtest: smoketest-all [406.546330] Subtest smoketest-all: SUCCESS (32.355s) [407.433790] [101/130] (629s left) kms_cursor_crc (cursor-rapid-movement-128x128) [407.641170] Starting subtest: cursor-rapid-movement-128x128 [407.643945] Starting dynamic subtest: pipe-A-eDP-1 [408.196857] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.550s) [408.218501] Starting dynamic subtest: pipe-D-eDP-1 [409.365827] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.153s) [409.368204] Subtest cursor-rapid-movement-128x128: SUCCESS (1.724s) [410.205242] [102/130] (626s left) gem_userptr_blits (sync-overlap) [410.289244] Starting subtest: sync-overlap [410.291681] Subtest sync-overlap: SUCCESS (0.000s) [410.425349] [103/130] (626s left) kms_big_fb (linear-64bpp-rotate-180) [410.527460] Starting subtest: linear-64bpp-rotate-180 [412.838131] Subtest linear-64bpp-rotate-180: SUCCESS (2.312s) [413.067819] [104/130] (623s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff) [413.179977] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff [413.185390] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [413.261495] [105/130] (623s left) kms_lease (lease-invalid-connector) [413.358269] Starting subtest: lease-invalid-connector [413.360888] Starting dynamic subtest: pipe-A-eDP-1 [413.363336] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [413.373313] Starting dynamic subtest: pipe-B-eDP-1 [413.376045] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [413.385311] Starting dynamic subtest: pipe-C-eDP-1 [413.388359] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [413.398274] Starting dynamic subtest: pipe-D-eDP-1 [413.401144] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [413.403522] Subtest lease-invalid-connector: SUCCESS (0.004s) [413.435978] [106/130] (623s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc) [413.537934] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc [413.540287] Starting dynamic subtest: pipe-A-eDP-1 [413.549397] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [413.557889] Starting dynamic subtest: pipe-B-eDP-1 [413.566655] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [413.575380] Starting dynamic subtest: pipe-C-eDP-1 [413.584129] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [413.591808] Starting dynamic subtest: pipe-D-eDP-1 [413.601228] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [413.605687] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s) [415.659446] [107/130] (621s left) gem_mmap_gtt (cpuset-big-copy-odd) [415.726798] Subtest cpuset-big-copy-odd: SKIP (0.000s) [415.800425] [108/130] (621s left) kms_draw_crc (fill-fb) [415.897212] Starting subtest: fill-fb [416.332257] Subtest fill-fb: SUCCESS (0.438s) [416.420548] [109/130] (620s left) kms_rotation_crc (primary-x-tiled-reflect-x-0) [416.515164] Starting subtest: primary-x-tiled-reflect-x-0 [423.872775] Subtest primary-x-tiled-reflect-x-0: SUCCESS (7.357s) [425.102306] [110/130] (611s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions) [425.231437] Starting subtest: cursor-vs-flip-atomic-transitions [455.046032] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (29.818s) [455.919054] [111/130] (581s left) kms_cursor_crc (cursor-random-32x32) [456.046142] Starting subtest: cursor-random-32x32 [456.088807] Subtest cursor-random-32x32: SKIP (0.036s) [456.381324] [112/130] (580s left) kms_big_fb (x-tiled-8bpp-rotate-90) [456.480585] Starting subtest: x-tiled-8bpp-rotate-90 [456.501458] Subtest x-tiled-8bpp-rotate-90: SKIP (0.021s) [456.631557] [113/130] (580s left) gem_exec_balancer (individual) [456.690160] Starting subtest: individual [458.275250] Subtest individual: SUCCESS (1.583s) [458.585407] [114/130] (578s left) perf (invalid-create-userspace-config) [458.658546] Starting subtest: invalid-create-userspace-config [458.661436] Subtest invalid-create-userspace-config: SUCCESS (0.001s) [458.694876] [115/130] (578s left) gem_exec_params (mmapped) [458.766657] Starting subtest: mmapped [458.772902] Subtest mmapped: SUCCESS (0.004s) [458.914151] [116/130] (578s left) kms_psr (psr-sprite-blt) [459.016261] Starting subtest: psr-sprite-blt [459.018971] Starting dynamic subtest: eDP-1 [460.741413] Dynamic subtest eDP-1: SUCCESS (1.725s) [460.743725] Subtest psr-sprite-blt: SUCCESS (1.726s) [461.574269] [117/130] (575s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs) [461.675194] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs [461.677700] Starting dynamic subtest: pipe-A-eDP-1 [461.701103] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [461.710500] Starting dynamic subtest: pipe-B-eDP-1 [461.735128] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [461.744341] Starting dynamic subtest: pipe-C-eDP-1 [461.769514] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [461.778436] Starting dynamic subtest: pipe-D-eDP-1 [461.804424] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [461.810006] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.004s) [463.830293] [118/130] (573s left) gem_partial_pwrite_pread (reads-uncached) [463.885815] Subtest reads-uncached: SKIP (0.000s) [463.958312] [119/130] (573s left) api_intel_bb (simple-bb-ctx) [464.009047] Starting subtest: simple-bb-ctx [464.015543] Subtest simple-bb-ctx: SUCCESS (0.009s) [464.093972] [120/130] (573s left) gem_softpin (allocator-nopin-reserve) [464.165529] Starting subtest: allocator-nopin-reserve [464.248425] Subtest allocator-nopin-reserve: SUCCESS (0.083s) [464.363976] [121/130] (573s left) i915_pm_rpm (gem-evict-pwrite) [466.418303] Starting subtest: gem-evict-pwrite [466.423725] Subtest gem-evict-pwrite: SKIP (0.000s) [466.781040] [122/130] (570s left) kms_async_flips (test-time-stamp) [466.882163] Starting subtest: test-time-stamp [467.241506] Starting dynamic subtest: pipe-A-eDP-1 [468.069325] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.824s) [468.432332] Starting dynamic subtest: pipe-B-eDP-1 [469.193877] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.766s) [469.566503] Starting dynamic subtest: pipe-C-eDP-1 [470.323087] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.761s) [470.683500] Starting dynamic subtest: pipe-D-eDP-1 [471.451428] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.774s) [471.454469] Subtest test-time-stamp: SUCCESS (4.568s) [472.605710] [123/130] (564s left) prime_busy (before) [472.670402] Starting subtest: before [472.676230] Starting dynamic subtest: rcs0 [472.717453] Dynamic subtest rcs0: SUCCESS (0.042s) [472.728595] Starting dynamic subtest: bcs0 [472.757158] Dynamic subtest bcs0: SUCCESS (0.039s) [472.766033] Starting dynamic subtest: vcs0 [472.797570] Dynamic subtest vcs0: SUCCESS (0.040s) [472.806539] Starting dynamic subtest: vcs1 [472.840414] Dynamic subtest vcs1: SUCCESS (0.042s) [472.849774] Starting dynamic subtest: vecs0 [472.882467] Dynamic subtest vecs0: SUCCESS (0.042s) [472.891551] Starting dynamic subtest: ccs0 [472.925448] Dynamic subtest ccs0: SUCCESS (0.042s) [473.035177] Subtest before: SUCCESS (0.363s) [473.105438] [124/130] (564s left) gem_ctx_shared (q-in-order) [473.171279] Starting subtest: Q-in-order [473.174105] Starting dynamic subtest: rcs0 [473.290523] Dynamic subtest rcs0: SUCCESS (0.117s) [473.299761] Starting dynamic subtest: vcs0 [473.370840] Dynamic subtest vcs0: SUCCESS (0.081s) [473.381044] Starting dynamic subtest: vcs1 [473.459208] Dynamic subtest vcs1: SUCCESS (0.087s) [473.475067] Starting dynamic subtest: vecs0 [473.533372] Dynamic subtest vecs0: SUCCESS (0.073s) [473.549576] Starting dynamic subtest: ccs0 [473.628964] Dynamic subtest ccs0: SUCCESS (0.095s) [473.632012] Subtest Q-in-order: SUCCESS (0.457s) [475.424992] [125/130] (562s left) gem_tiled_partial_pwrite_pread (writes) [475.486334] Subtest writes: SKIP (0.000s) [475.563585] [126/130] (562s left) gem_exec_params (invalid-flag) [475.627329] Starting subtest: invalid-flag [475.630054] Subtest invalid-flag: SUCCESS (0.000s) [475.737910] [127/130] (561s left) syncobj_timeline (single-wait-all-for-submit-available-submitted) [475.803536] Starting subtest: single-wait-all-for-submit-available-submitted [475.806547] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s) [475.910826] [128/130] (561s left) gem_exec_schedule (semaphore-codependency) [475.989508] Starting subtest: semaphore-codependency [476.007449] Subtest semaphore-codependency: SUCCESS (0.025s) [476.347261] [129/130] (561s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs) [476.440054] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs [476.442498] Starting dynamic subtest: pipe-A-eDP-1 [476.465424] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [476.475549] Starting dynamic subtest: pipe-B-eDP-1 [476.497862] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [476.506355] Starting dynamic subtest: pipe-C-eDP-1 [476.529239] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [476.537513] Starting dynamic subtest: pipe-D-eDP-1 [476.561332] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [476.563409] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.006s) [478.557403] [130/130] (559s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt) [478.666361] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt [478.671648] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [478.753874] Closing watchdogs Done.