[57.274172] Initializing watchdogs [57.274221] /dev/watchdog0 [57.288928] [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.293618] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.296180] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.299534] [001/155] (960s left) i915_pm_rpm (gem-pread) [59.488826] Starting subtest: gem-pread [61.233557] Subtest gem-pread: SUCCESS (1.752s) [61.339736] [002/155] (956s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen) [61.445221] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen [61.449447] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [61.546178] [003/155] (956s left) kms_cursor_crc (cursor-suspend) [61.674369] Starting subtest: cursor-suspend [61.676521] Starting dynamic subtest: pipe-A-eDP-1 [94.599459] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.352s) [94.608649] Starting dynamic subtest: pipe-D-eDP-1 [128.570227] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.762s) [128.572713] Subtest cursor-suspend: SUCCESS (7.116s) [129.385615] [004/155] (888s left) gem_lmem_swapping (parallel-random) [129.437249] Subtest parallel-random: SKIP (0.000s) [129.495283] [005/155] (888s left) kms_psr (fbc-pr-sprite-render) [129.585809] Starting subtest: fbc-pr-sprite-render [129.591425] Subtest fbc-pr-sprite-render: SKIP (0.000s) [129.652690] [006/155] (888s left) gem_exec_schedule (u-lateslice) [129.731522] Starting subtest: u-lateslice [129.734132] Starting dynamic subtest: rcs0 [129.747985] Dynamic subtest rcs0: SUCCESS (0.027s) [129.757779] Starting dynamic subtest: bcs0 [129.765817] Dynamic subtest bcs0: SUCCESS (0.018s) [129.774975] Starting dynamic subtest: vcs0 [129.789714] Dynamic subtest vcs0: SUCCESS (0.023s) [129.798007] Starting dynamic subtest: vcs1 [129.807885] Dynamic subtest vcs1: SUCCESS (0.018s) [129.816558] Starting dynamic subtest: vecs0 [129.824716] Dynamic subtest vecs0: SUCCESS (0.016s) [129.833733] Starting dynamic subtest: ccs0 [129.841979] Dynamic subtest ccs0: SUCCESS (0.017s) [129.844783] Subtest u-lateslice: SUCCESS (0.122s) [131.181027] [007/155] (886s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [131.284326] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip [132.016595] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.737s) [132.259169] [008/155] (885s left) kms_flip (2x-flip-vs-suspend-interruptible) [132.416965] Starting subtest: 2x-flip-vs-suspend-interruptible [132.423224] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.002s) [132.607099] [009/155] (885s left) kms_cursor_legacy (torture-bo) [132.884857] Starting subtest: torture-bo [132.887733] Starting dynamic subtest: pipe-A [138.668003] Dynamic subtest pipe-A: SUCCESS (5.796s) [138.683618] Starting dynamic subtest: pipe-B [145.484269] Dynamic subtest pipe-B: SUCCESS (6.825s) [145.500123] Starting dynamic subtest: pipe-C [151.992738] Dynamic subtest pipe-C: SUCCESS (6.512s) [152.012303] Starting dynamic subtest: pipe-D [157.965382] Dynamic subtest pipe-D: SUCCESS (5.977s) [157.974975] Starting dynamic subtest: all-pipes [164.546386] Dynamic subtest all-pipes: SUCCESS (6.579s) [164.551002] Subtest torture-bo: SUCCESS (31.696s) [164.717024] [010/155] (853s left) gem_exec_fence (concurrent) [164.898929] Starting subtest: concurrent [164.904442] Subtest concurrent: SKIP (0.000s) [167.163331] [FACT gem_exec_fence (concurrent)] new: kernel.kmod_is_loaded.vgem: true [167.166605] [011/155] (851s left) kms_frontbuffer_tracking (hdr-1p-primscrn-shrfb-msflip-blt) [167.273567] Starting subtest: hdr-1p-primscrn-shrfb-msflip-blt [167.278924] Subtest hdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [167.376654] [012/155] (850s left) gem_ppgtt (shrink-vs-evict-pinned) [167.448233] Starting subtest: shrink-vs-evict-pinned [175.065927] Subtest shrink-vs-evict-pinned: SUCCESS (7.620s) [175.151426] [013/155] (843s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt) [175.252770] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt [175.257528] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [175.344137] [014/155] (843s left) perf_pmu (semaphore-busy) [175.385186] Starting subtest: semaphore-busy [175.387785] Starting dynamic subtest: rcs0 [177.014401] Dynamic subtest rcs0: SUCCESS (1.625s) [177.025807] Starting dynamic subtest: bcs0 [178.644546] Dynamic subtest bcs0: SUCCESS (1.629s) [178.656660] Starting dynamic subtest: vcs0 [182.625927] Dynamic subtest vcs0: SUCCESS (3.980s) [182.638965] Starting dynamic subtest: vcs1 [188.577274] Dynamic subtest vcs1: SUCCESS (5.951s) [188.594432] Starting dynamic subtest: vecs0 [194.590884] Dynamic subtest vecs0: SUCCESS (6.016s) [194.604092] Starting dynamic subtest: ccs0 [197.731794] Dynamic subtest ccs0: SUCCESS (3.140s) [197.734235] Subtest semaphore-busy: SUCCESS (22.350s) [197.847123] [015/155] (820s left) kms_dsc (dsc-with-output-formats-with-bpc) [197.945772] Starting subtest: dsc-with-output-formats-with-bpc [198.012767] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s) [198.052430] [016/155] (820s left) kms_cdclk (mode-transition) [198.146631] Starting subtest: mode-transition [198.149071] Starting dynamic subtest: pipe-A-eDP-1 [198.454411] Dynamic subtest pipe-A-eDP-1: SKIP (0.303s) [198.463285] Starting dynamic subtest: pipe-B-eDP-1 [198.468375] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [198.480672] Starting dynamic subtest: pipe-C-eDP-1 [198.485646] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [198.494941] Starting dynamic subtest: pipe-D-eDP-1 [198.499784] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [198.504686] Subtest mode-transition: SKIP (0.310s) [199.258485] [017/155] (819s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu) [199.352959] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu [199.357641] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [199.450229] [018/155] (819s left) gem_pxp (hw-rejects-pxp-context) [199.572525] Starting subtest: hw-rejects-pxp-context [199.578503] Subtest hw-rejects-pxp-context: SKIP (0.000s) [199.682847] [019/155] (818s left) kms_big_fb (y-tiled-16bpp-rotate-180) [199.778477] Starting subtest: y-tiled-16bpp-rotate-180 [199.783760] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s) [199.873954] [020/155] (818s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible) [199.968981] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible [199.980764] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.011s) [200.055932] [021/155] (818s left) syncobj_timeline (reset-signaled) [200.109856] Starting subtest: reset-signaled [200.112762] Subtest reset-signaled: SUCCESS (0.000s) [200.213220] [022/155] (818s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-blt) [200.306540] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-blt [200.310634] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [200.398333] [023/155] (818s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-mmap-cpu) [200.510825] Starting subtest: fbchdr-rgb565-draw-mmap-cpu [200.515420] Subtest fbchdr-rgb565-draw-mmap-cpu: SKIP (0.000s) [200.594808] [024/155] (818s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [200.714379] Starting subtest: basic-flip-after-cursor-atomic [201.631601] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.915s) [202.481225] [025/155] (816s left) syncobj_timeline (invalid-signal-zero-handles) [202.528746] Starting subtest: invalid-signal-zero-handles [202.531339] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [202.624840] [026/155] (816s left) syncobj_basic (bad-create-flags) [202.673792] Starting subtest: bad-create-flags [202.676335] Subtest bad-create-flags: SUCCESS (0.000s) [202.766409] [027/155] (816s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt) [202.876400] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt [207.468875] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.603s) [208.684840] [028/155] (810s left) kms_psr (psr-cursor-mmap-gtt) [208.774648] Starting subtest: psr-cursor-mmap-gtt [208.777315] Starting dynamic subtest: eDP-1 [210.473664] Dynamic subtest eDP-1: SUCCESS (1.698s) [210.475737] Subtest psr-cursor-mmap-gtt: SUCCESS (1.698s) [211.331303] [029/155] (807s left) gem_softpin (noreloc-s3) [211.387442] Starting subtest: noreloc-S3 [232.176202] Subtest noreloc-S3: SUCCESS (5.390s) [232.300275] [030/155] (786s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt) [232.422038] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt [232.426249] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [232.530030] [031/155] (786s left) perf (gen12-invalid-class-instance) [232.659303] Starting subtest: gen12-invalid-class-instance [232.669625] Subtest gen12-invalid-class-instance: SUCCESS (0.011s) [232.715272] [032/155] (786s left) kms_async_flips (async-flip-dpms) [232.804535] Starting subtest: async-flip-dpms [233.178445] Starting dynamic subtest: pipe-A-eDP-1 [237.121912] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.954s) [237.493724] Starting dynamic subtest: pipe-B-eDP-1 [240.372574] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.891s) [240.749351] Starting dynamic subtest: pipe-C-eDP-1 [243.621440] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.884s) [244.001089] Starting dynamic subtest: pipe-D-eDP-1 [246.874638] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.884s) [246.877647] Subtest async-flip-dpms: SUCCESS (14.102s) [248.065829] [033/155] (771s left) kms_pipe_stress (stress-xrgb8888-ytiled) [248.170008] Starting subtest: stress-xrgb8888-ytiled [248.174156] Subtest stress-xrgb8888-ytiled: SKIP (0.000s) [248.249191] [034/155] (770s left) gem_mmap_gtt (basic-write-cpu-read-gtt) [248.302519] Subtest basic-write-cpu-read-gtt: SKIP (0.000s) [248.364620] [035/155] (770s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs) [248.429299] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs [248.433833] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s) [248.618057] [036/155] (770s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt) [248.707776] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt [248.712102] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [248.809055] [037/155] (770s left) syncobj_eventfd (timeline-wait-signaled) [248.867087] Starting subtest: timeline-wait-signaled [248.869554] Subtest timeline-wait-signaled: SUCCESS (0.000s) [248.967887] [038/155] (770s left) gem_userptr_blits (huge-split) [249.041614] Starting subtest: huge-split [249.047615] Subtest huge-split: SUCCESS (0.008s) [249.172257] [039/155] (770s left) kms_psr (fbc-pr-primary-mmap-cpu) [249.267657] Starting subtest: fbc-pr-primary-mmap-cpu [249.272434] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s) [249.357975] [040/155] (770s left) sw_sync (timeline_closed) [249.388675] Starting subtest: timeline_closed [249.390957] Subtest timeline_closed: SUCCESS (0.000s) [249.448718] [041/155] (770s left) kms_big_fb (x-tiled-32bpp-rotate-0) [249.546324] Starting subtest: x-tiled-32bpp-rotate-0 [250.958968] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.414s) [251.078942] [042/155] (768s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt) [251.186775] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt [251.190316] Subtest psrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [251.272801] [043/155] (768s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier) [251.354394] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier [251.380901] Starting dynamic subtest: pipe-A-plane-0 [251.669286] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s) [251.678766] Starting dynamic subtest: pipe-A-plane-3 [251.904390] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s) [251.913475] Starting dynamic subtest: pipe-A-plane-5 [251.917153] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [253.058190] Starting dynamic subtest: pipe-B-plane-0 [253.348935] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s) [253.358337] Starting dynamic subtest: pipe-B-plane-3 [253.582068] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s) [253.591876] Starting dynamic subtest: pipe-B-plane-5 [253.596156] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [253.895017] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.541s) [254.732303] [044/155] (764s left) kms_ccs (crc-primary-suspend-y-tiled-ccs) [254.828068] Starting subtest: crc-primary-suspend-y-tiled-ccs [254.830436] Starting dynamic subtest: pipe-A-eDP-1 [254.839596] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [254.852194] Starting dynamic subtest: pipe-B-eDP-1 [254.861355] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [254.871047] Starting dynamic subtest: pipe-C-eDP-1 [254.879849] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [254.889532] Starting dynamic subtest: pipe-D-eDP-1 [254.898284] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [254.902669] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.004s) [257.103580] [045/155] (762s left) fbdev (nullptr) [257.142406] Starting subtest: nullptr [257.144743] Subtest nullptr: SUCCESS (0.000s) [257.200746] [046/155] (762s left) kms_frontbuffer_tracking (fbchdr-2p-shrfb-fliptrack-mmap-gtt) [257.294923] Starting subtest: fbchdr-2p-shrfb-fliptrack-mmap-gtt [257.299064] Subtest fbchdr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [257.381305] [047/155] (762s left) syncobj_wait (reset-unsignaled) [257.428557] Starting subtest: reset-unsignaled [257.430669] Subtest reset-unsignaled: SUCCESS (0.000s) [257.520018] [048/155] (762s left) sw_sync (alloc_fence_invalid_timeline) [257.550790] Starting subtest: alloc_fence_invalid_timeline [257.553102] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s) [257.619762] [049/155] (762s left) kms_cursor_crc (cursor-onscreen-512x512) [257.894441] Starting subtest: cursor-onscreen-512x512 [257.898076] Subtest cursor-onscreen-512x512: SKIP (0.001s) [258.074184] [050/155] (761s left) gem_unfence_active_buffers [258.213943] [051/155] (761s left) kms_pm_dc (dc6-dpms) [259.304652] Starting subtest: dc6-dpms [261.379912] Subtest dc6-dpms: SUCCESS (2.076s) [261.471157] [052/155] (758s left) syncobj_wait (wait-zero-handles) [261.524517] Starting subtest: wait-zero-handles [261.526643] Subtest wait-zero-handles: SUCCESS (0.000s) [261.632176] [053/155] (758s left) gem_exec_reloc (basic-gtt-cpu-noreloc) [261.679656] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s) [261.745383] [054/155] (758s left) kms_content_protection (legacy-hdcp14) [261.882161] Starting subtest: legacy-hdcp14 [261.886947] Subtest legacy-hdcp14: SKIP (0.000s) [262.026824] [055/155] (758s left) gem_exec_whisper (basic-fds-forked) [262.083883] Starting subtest: basic-fds-forked [286.047100] Subtest basic-fds-forked: SUCCESS (23.952s) [286.228156] [056/155] (733s left) gem_mmap_wc (write-cpu-read-wc) [286.298343] Subtest write-cpu-read-wc: SKIP (0.000s) [286.361553] [057/155] (733s left) kms_big_fb (linear-64bpp-rotate-180) [286.453269] Starting subtest: linear-64bpp-rotate-180 [288.120314] Subtest linear-64bpp-rotate-180: SUCCESS (1.668s) [288.290139] [058/155] (731s left) kms_scaling_modes (scaling-mode-full) [288.377585] Starting subtest: scaling-mode-full [288.379172] Starting dynamic subtest: pipe-A-eDP-1 [288.476307] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.100s) [288.487195] Starting dynamic subtest: pipe-B-eDP-1 [289.661481] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.183s) [289.672608] Starting dynamic subtest: pipe-C-eDP-1 [290.783199] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.121s) [290.793744] Starting dynamic subtest: pipe-D-eDP-1 [291.920431] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.136s) [291.922719] Subtest scaling-mode-full: SUCCESS (3.546s) [293.101822] [059/155] (727s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb) [293.199770] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb [293.204115] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s) [293.281303] [060/155] (727s left) gen9_exec_parse (bb-start-out) [293.358120] Subtest bb-start-out: SKIP (0.000s) [293.443637] [061/155] (726s left) gem_spin_batch (spin-all) [293.500484] Starting subtest: spin-all [293.514579] Subtest spin-all: SUCCESS (0.012s) [295.571145] [062/155] (724s left) gem_ctx_isolation (dirty-create) [295.642627] Starting subtest: dirty-create [295.644996] Starting dynamic subtest: rcs0 [295.840538] Dynamic subtest rcs0: SUCCESS (0.198s) [295.852932] Starting dynamic subtest: bcs0 [296.099036] Dynamic subtest bcs0: SUCCESS (0.258s) [296.109519] Starting dynamic subtest: vcs0 [296.361147] Dynamic subtest vcs0: SUCCESS (0.261s) [296.372839] Starting dynamic subtest: vcs1 [297.718953] Dynamic subtest vcs1: SUCCESS (1.358s) [297.731418] Starting dynamic subtest: vecs0 [299.773181] Dynamic subtest vecs0: SUCCESS (2.054s) [299.785991] Starting dynamic subtest: ccs0 [301.759304] Dynamic subtest ccs0: SUCCESS (1.986s) [301.761587] Subtest dirty-create: SUCCESS (6.119s) [302.003416] [063/155] (718s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [302.105149] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [302.109272] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [302.197248] [064/155] (718s left) gem_mmap_offset (partial-mmap) [302.258144] Starting subtest: partial-mmap [302.260421] Starting dynamic subtest: smem0 [302.263111] Dynamic subtest smem0: SUCCESS (0.005s) [302.265718] Subtest partial-mmap: SUCCESS (0.006s) [302.400075] [065/155] (718s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs) [302.508504] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs [302.513348] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s) [303.609218] [066/155] (716s left) vgem_basic (create) [303.652569] Starting subtest: create [303.654802] Subtest create: SUCCESS (0.000s) [303.731498] [067/155] (716s left) gem_caching (reads) [303.798065] Subtest reads: SKIP (0.000s) [303.865978] [068/155] (716s left) syncobj_wait (wait-any-interrupted) [303.917322] Starting subtest: wait-any-interrupted [304.020845] Subtest wait-any-interrupted: SUCCESS (0.103s) [304.113270] [069/155] (716s left) kms_flip (flip-vs-expired-vblank) [304.200313] Starting subtest: flip-vs-expired-vblank [304.202505] Starting dynamic subtest: A-eDP1 [312.921038] Dynamic subtest A-eDP1: SUCCESS (8.722s) [312.934272] Starting dynamic subtest: B-eDP1 [321.655947] Dynamic subtest B-eDP1: SUCCESS (8.735s) [321.666927] Starting dynamic subtest: C-eDP1 [330.369473] Dynamic subtest C-eDP1: SUCCESS (8.710s) [330.379557] Starting dynamic subtest: D-eDP1 [339.006916] Dynamic subtest D-eDP1: SUCCESS (8.636s) [339.009285] Subtest flip-vs-expired-vblank: SUCCESS (34.812s) [340.181538] [070/155] (680s left) gem_exec_reloc (basic-cpu-wc) [340.234133] Subtest basic-cpu-wc: SKIP (0.000s) [340.310219] [071/155] (680s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite) [340.415320] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite [344.787410] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.378s) [345.989673] [072/155] (674s left) syncobj_timeline (etime-single-wait-for-submit-submitted) [346.050970] Starting subtest: etime-single-wait-for-submit-submitted [346.157835] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.107s) [346.235677] [073/155] (674s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [346.340624] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc [346.345111] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [346.455246] [074/155] (674s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite) [346.552835] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite [346.556988] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [346.654249] [075/155] (674s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling) [346.748981] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling [346.753437] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s) [346.824626] [076/155] (674s left) gem_exec_balancer (bonded-pair) [346.880656] Starting subtest: bonded-pair [346.885185] Subtest bonded-pair: SKIP (0.000s) [347.197139] [077/155] (673s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0) [347.307617] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0 [347.312086] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s) [347.391828] [078/155] (673s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt) [347.487695] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt [347.492160] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [347.584327] [079/155] (673s left) kms_invalid_mode (bad-vsync-start) [347.681455] Starting subtest: bad-vsync-start [347.683694] Starting dynamic subtest: pipe-A-eDP-1 [347.964539] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s) [347.974569] Starting dynamic subtest: pipe-B-eDP-1 [347.976610] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [347.986322] Starting dynamic subtest: pipe-C-eDP-1 [347.988160] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [347.997749] Starting dynamic subtest: pipe-D-eDP-1 [348.000114] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [348.002420] Subtest bad-vsync-start: SUCCESS (0.291s) [348.807231] [080/155] (672s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [348.911438] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-mmap-gtt [348.915785] Subtest hdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [349.018252] [081/155] (672s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc) [349.122100] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc [353.849424] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (4.735s) [353.975076] [082/155] (667s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping) [354.074689] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping [354.078583] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s) [354.145121] [083/155] (667s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu) [354.245043] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu [358.529629] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.291s) [359.725445] [084/155] (661s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc) [359.809744] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc [359.812195] Starting dynamic subtest: pipe-A-eDP-1 [359.835907] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [359.847365] Starting dynamic subtest: pipe-B-eDP-1 [359.869323] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [359.879096] Starting dynamic subtest: pipe-C-eDP-1 [359.900891] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [359.910176] Starting dynamic subtest: pipe-D-eDP-1 [359.932117] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [359.936521] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [362.077588] [085/155] (659s left) i915_hangman (detector) [362.141350] Starting subtest: detector [362.143655] Starting dynamic subtest: rcs0 [373.503546] Dynamic subtest rcs0: SUCCESS (11.363s) [373.517439] Starting dynamic subtest: bcs0 [384.512727] Dynamic subtest bcs0: SUCCESS (11.007s) [384.525946] Starting dynamic subtest: vcs0 [396.415148] Dynamic subtest vcs0: SUCCESS (11.902s) [396.426883] Starting dynamic subtest: vcs1 [406.463095] Dynamic subtest vcs1: SUCCESS (10.047s) [406.475115] Starting dynamic subtest: vecs0 [418.494525] Dynamic subtest vecs0: SUCCESS (12.031s) [418.507167] Starting dynamic subtest: ccs0 [430.527305] Dynamic subtest ccs0: SUCCESS (12.033s) [430.530380] Subtest detector: SUCCESS (68.400s) [430.612929] [086/155] (590s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [430.708927] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [430.713263] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s) [430.820283] [087/155] (590s left) kms_prime (basic-crc-hybrid) [430.903444] Subtest basic-crc-hybrid: SKIP (0.000s) [431.011289] [088/155] (590s left) kms_color_pipeline (plane-lut1d-lut1d) [431.112438] Starting subtest: plane-lut1d-lut1d [431.247181] Starting dynamic subtest: pipe-A-plane-0 [431.424961] Dynamic subtest pipe-A-plane-0: SUCCESS (0.177s) [431.437953] Starting dynamic subtest: pipe-A-plane-1 [431.613102] Dynamic subtest pipe-A-plane-1: SUCCESS (0.188s) [431.626032] Starting dynamic subtest: pipe-A-plane-2 [431.779518] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s) [432.995326] Starting dynamic subtest: pipe-B-plane-0 [433.165389] Dynamic subtest pipe-B-plane-0: SUCCESS (0.177s) [433.177583] Starting dynamic subtest: pipe-B-plane-1 [433.354057] Dynamic subtest pipe-B-plane-1: SUCCESS (0.188s) [433.364512] Starting dynamic subtest: pipe-B-plane-2 [433.509069] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s) [434.710466] Starting dynamic subtest: pipe-C-plane-0 [434.856627] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s) [434.867979] Starting dynamic subtest: pipe-C-plane-1 [435.012094] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s) [435.022454] Starting dynamic subtest: pipe-C-plane-2 [435.178934] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s) [436.437447] Starting dynamic subtest: pipe-D-plane-0 [436.569889] Dynamic subtest pipe-D-plane-0: SUCCESS (0.143s) [436.580330] Starting dynamic subtest: pipe-D-plane-1 [436.725230] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s) [436.736076] Starting dynamic subtest: pipe-D-plane-2 [436.869760] Dynamic subtest pipe-D-plane-2: SUCCESS (0.143s) [437.155228] Subtest plane-lut1d-lut1d: SUCCESS (6.046s) [437.993037] [089/155] (583s left) kms_frontbuffer_tracking (psrhdr-1p-pri-indfb-multidraw) [438.090461] Starting subtest: psrhdr-1p-pri-indfb-multidraw [438.094969] Subtest psrhdr-1p-pri-indfb-multidraw: SKIP (0.000s) [438.192024] [090/155] (583s left) kms_psr (fbc-psr2-suspend) [438.286603] Starting subtest: fbc-psr2-suspend [438.288873] Starting dynamic subtest: eDP-1 [438.293056] Dynamic subtest eDP-1: SKIP (0.000s) [438.296999] Subtest fbc-psr2-suspend: SKIP (0.001s) [438.364350] [091/155] (583s left) kms_lease (lease-uevent) [438.457967] Starting subtest: lease-uevent [439.474892] Subtest lease-uevent: SUCCESS (1.018s) [439.596541] [092/155] (582s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-indfb-pgflip-blt) [439.693886] Starting subtest: psrhdr-2p-scndscrn-indfb-pgflip-blt [439.698322] Subtest psrhdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [439.797704] [093/155] (581s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt) [439.895175] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt [439.899208] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [440.005242] [094/155] (581s left) gem_partial_pwrite_pread (write-snoop) [440.056600] Subtest write-snoop: SKIP (0.000s) [440.120046] [095/155] (581s left) gem_create (create-ext-cpu-access-sanity-check) [440.289938] Starting subtest: create-ext-cpu-access-sanity-check [440.294661] Subtest create-ext-cpu-access-sanity-check: SKIP (0.000s) [440.379997] [096/155] (581s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-blt) [440.477475] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-blt [440.481607] Subtest hdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [440.577295] [097/155] (581s left) kms_selftest (drm_plane_helper) [440.614704] Starting subtest: drm_plane_helper [440.659440] Starting dynamic subtest: drm_test_check_plane_state [440.753781] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.094s) [440.764512] Starting dynamic subtest: drm_test_check_invalid_plane_state [440.853447] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.095s) [440.855718] Subtest drm_plane_helper: SUCCESS (0.238s) [441.004060] [098/155] (580s left) i915_query (engine-info-invalid) [441.058902] Starting subtest: engine-info-invalid [441.061230] Subtest engine-info-invalid: SUCCESS (0.000s) [441.166772] [099/155] (580s left) kms_frontbuffer_tracking (hdr-rgb565-draw-mmap-wc) [441.269161] Starting subtest: hdr-rgb565-draw-mmap-wc [441.273268] Subtest hdr-rgb565-draw-mmap-wc: SKIP (0.000s) [441.371013] [100/155] (580s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-pwrite) [441.476270] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-pwrite [441.479726] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [441.579693] [101/155] (580s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen) [441.682807] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen [441.686498] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [441.789905] [102/155] (580s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt) [441.888810] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt [441.892505] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [441.992133] [103/155] (580s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions) [442.106144] Starting subtest: cursorB-vs-flipB-atomic-transitions [442.109935] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s) [442.266786] [104/155] (579s left) kms_chamelium_hpd (hdmi-hpd-storm-disable) [442.648932] Subtest hdmi-hpd-storm-disable: SKIP (0.000s) [443.498133] [105/155] (578s left) i915_query (query-topology-known-pci-ids) [443.560842] Starting subtest: query-topology-known-pci-ids [443.565294] Subtest query-topology-known-pci-ids: SKIP (0.000s) [443.655914] [106/155] (578s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-pwrite) [443.753926] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-pwrite [443.757917] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [443.875644] [107/155] (578s left) kms_vblank (ts-continuation-dpms-rpm) [443.964805] Starting subtest: ts-continuation-dpms-rpm [443.967112] Starting dynamic subtest: pipe-A-eDP-1 [446.512721] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.546s) [446.530069] Starting dynamic subtest: pipe-D-eDP-1 [448.752940] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.239s) [448.755299] Subtest ts-continuation-dpms-rpm: SUCCESS (4.789s) [449.646618] [108/155] (572s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-pwrite) [449.745757] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-pwrite [449.749947] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s) [449.843283] [109/155] (572s left) syncobj_timeline (wait-all-for-submit-complex) [449.909481] Starting subtest: wait-all-for-submit-complex [450.123899] Subtest wait-all-for-submit-complex: SUCCESS (0.214s) [450.216182] [110/155] (572s left) gem_exec_schedule (in-order) [450.285367] Starting subtest: in-order [450.287328] Starting dynamic subtest: rcs0 [450.391187] Dynamic subtest rcs0: SUCCESS (0.112s) [450.406130] Starting dynamic subtest: vcs0 [450.477810] Dynamic subtest vcs0: SUCCESS (0.085s) [450.489470] Starting dynamic subtest: vcs1 [450.567223] Dynamic subtest vcs1: SUCCESS (0.088s) [450.582644] Starting dynamic subtest: vecs0 [450.650012] Dynamic subtest vecs0: SUCCESS (0.082s) [450.662376] Starting dynamic subtest: ccs0 [450.752392] Dynamic subtest ccs0: SUCCESS (0.099s) [450.754330] Subtest in-order: SUCCESS (0.473s) [451.657214] [111/155] (570s left) kms_big_fb (4-tiled-8bpp-rotate-270) [451.753948] Starting subtest: 4-tiled-8bpp-rotate-270 [451.775577] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.021s) [451.891296] [112/155] (570s left) gem_mmap_gtt (basic-small-copy-odd) [451.951048] Subtest basic-small-copy-odd: SKIP (0.000s) [452.012215] [113/155] (570s left) gem_sync (basic-many-each) [452.093430] Starting subtest: basic-many-each [454.372046] Subtest basic-many-each: SUCCESS (2.288s) [454.558189] [114/155] (568s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt) [454.655076] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt [454.659502] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [454.748227] [115/155] (567s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-mmap-cpu) [454.850039] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-mmap-cpu [454.854021] Subtest fbchdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [454.938663] [116/155] (567s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary) [455.033642] Starting subtest: fbc-indfb-scaledprimary [457.902781] Subtest fbc-indfb-scaledprimary: SUCCESS (2.873s) [459.032802] [117/155] (563s left) gem_ctx_create (basic-files) [459.095568] Starting subtest: basic-files [461.102709] Subtest basic-files: SUCCESS (2.007s) [462.543844] [118/155] (560s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt) [462.646122] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt [469.953039] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.310s) [470.073799] [119/155] (552s left) kms_chamelium_frames (hdmi-frame-dump) [470.459252] Subtest hdmi-frame-dump: SKIP (0.000s) [471.265350] [120/155] (551s left) gem_lmem_swapping (verify-ccs) [471.310190] Subtest verify-ccs: SKIP (0.000s) [471.355899] [121/155] (551s left) kms_psr (pr-cursor-blt) [471.445950] Starting subtest: pr-cursor-blt [471.450352] Subtest pr-cursor-blt: SKIP (0.000s) [471.522591] [122/155] (551s left) gem_exec_fence (syncobj-timeline-signal) [472.074799] Starting subtest: syncobj-timeline-signal [472.081082] Subtest syncobj-timeline-signal: SUCCESS (0.008s) [473.588231] [123/155] (549s left) i915_drm_fdinfo (virtual-busy-hang-all) [473.630344] Starting subtest: virtual-busy-hang-all [473.634483] Subtest virtual-busy-hang-all: SKIP (0.000s) [473.721165] [124/155] (549s left) kms_pm_backlight (fade) [473.811672] Starting subtest: fade [473.864879] Starting dynamic subtest: eDP-1 [476.868753] Dynamic subtest eDP-1: SUCCESS (3.003s) [476.871192] Subtest fade: SUCCESS (3.058s) [477.717955] [125/155] (545s left) gem_ctx_shared (q-in-order) [477.768786] Starting subtest: Q-in-order [477.771108] Starting dynamic subtest: rcs0 [477.874378] Dynamic subtest rcs0: SUCCESS (0.104s) [477.891742] Starting dynamic subtest: vcs0 [477.953534] Dynamic subtest vcs0: SUCCESS (0.079s) [477.972337] Starting dynamic subtest: vcs1 [478.028812] Dynamic subtest vcs1: SUCCESS (0.075s) [478.046619] Starting dynamic subtest: vecs0 [478.113107] Dynamic subtest vecs0: SUCCESS (0.084s) [478.128653] Starting dynamic subtest: ccs0 [478.207407] Dynamic subtest ccs0: SUCCESS (0.092s) [478.210082] Subtest Q-in-order: SUCCESS (0.438s) [479.631629] [126/155] (543s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf) [479.735706] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf [479.740158] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [479.821877] [127/155] (543s left) kms_atomic (plane-immutable-zpos) [479.918762] Starting subtest: plane-immutable-zpos [479.921023] Starting dynamic subtest: pipe-A-eDP-1 [480.578947] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.660s) [480.581101] Subtest plane-immutable-zpos: SUCCESS (0.662s) [481.449776] [128/155] (541s left) kms_flip (busy-flip) [481.546300] Starting subtest: busy-flip [481.548659] Starting dynamic subtest: A-eDP1 [483.249886] Dynamic subtest A-eDP1: SUCCESS (1.702s) [483.263058] Starting dynamic subtest: B-eDP1 [484.983394] Dynamic subtest B-eDP1: SUCCESS (1.730s) [484.996960] Starting dynamic subtest: C-eDP1 [486.712147] Dynamic subtest C-eDP1: SUCCESS (1.727s) [486.724957] Starting dynamic subtest: D-eDP1 [488.357568] Dynamic subtest D-eDP1: SUCCESS (1.644s) [488.359947] Subtest busy-flip: SUCCESS (6.814s) [489.534593] [129/155] (533s left) syncobj_wait (wait-all-for-submit-complex) [489.591336] Starting subtest: wait-all-for-submit-complex [489.804774] Subtest wait-all-for-submit-complex: SUCCESS (0.214s) [489.899944] [130/155] (533s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-4) [490.007742] Starting subtest: fbcpsrhdr-tiling-4 [490.011933] Subtest fbcpsrhdr-tiling-4: SKIP (0.000s) [490.105503] [131/155] (533s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite) [490.208150] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite [497.118172] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.917s) [497.237148] [132/155] (526s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt) [497.341153] Starting subtest: psr-farfromfence-mmap-gtt [497.345030] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s) [497.463695] [133/155] (525s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25) [497.550109] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25 [497.552380] Starting dynamic subtest: pipe-A [497.570220] Dynamic subtest pipe-A: SKIP (0.018s) [497.581438] Starting dynamic subtest: pipe-B [497.602270] Dynamic subtest pipe-B: SKIP (0.031s) [497.615679] Starting dynamic subtest: pipe-C [497.636413] Dynamic subtest pipe-C: SKIP (0.031s) [497.646743] Starting dynamic subtest: pipe-D [497.667114] Dynamic subtest pipe-D: SKIP (0.031s) [497.671155] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.115s) [497.775260] [134/155] (525s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-render) [497.880920] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-render [497.885010] Subtest fbchdr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [497.985295] [135/155] (525s left) api_intel_bb (blit-reloc-keep-cache) [498.037497] Starting subtest: blit-reloc-keep-cache [498.042152] Subtest blit-reloc-keep-cache: SKIP (0.001s) [498.169156] [136/155] (525s left) prime_vgem (wait) [498.241154] Starting subtest: wait [498.243008] Starting dynamic subtest: rcs0 [498.285638] Dynamic subtest rcs0: SUCCESS (0.044s) [498.296146] Starting dynamic subtest: bcs0 [498.331744] Dynamic subtest bcs0: SUCCESS (0.045s) [498.341671] Starting dynamic subtest: vcs0 [498.376676] Dynamic subtest vcs0: SUCCESS (0.044s) [498.386267] Starting dynamic subtest: vcs1 [498.421927] Dynamic subtest vcs1: SUCCESS (0.044s) [498.431774] Starting dynamic subtest: vecs0 [498.466837] Dynamic subtest vecs0: SUCCESS (0.044s) [498.476540] Starting dynamic subtest: ccs0 [498.513293] Dynamic subtest ccs0: SUCCESS (0.046s) [498.515206] Subtest wait: SUCCESS (0.272s) [498.642169] [137/155] (524s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-mmap-wc) [498.738164] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-mmap-wc [498.741673] Subtest hdr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [498.837082] [138/155] (524s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes) [498.891791] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s) [498.957982] [139/155] (524s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-blt) [499.054400] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-blt [499.057724] Subtest fbchdr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [499.161708] [140/155] (524s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs) [499.245384] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs [499.247367] Starting dynamic subtest: pipe-A-eDP-1 [499.269308] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [499.283187] Starting dynamic subtest: pipe-B-eDP-1 [499.303184] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [499.312812] Starting dynamic subtest: pipe-C-eDP-1 [499.332534] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [499.342167] Starting dynamic subtest: pipe-D-eDP-1 [499.362079] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [499.365699] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.005s) [501.567352] [141/155] (522s left) prime_mmap (test_aperture_limit) [501.615138] Starting subtest: test_aperture_limit [501.616974] Starting dynamic subtest: test_aperture_limit-smem [501.624964] Dynamic subtest test_aperture_limit-smem: SKIP (0.008s) [501.629268] Subtest test_aperture_limit: SKIP (0.009s) [501.731752] [142/155] (522s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt) [501.827697] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt [509.125884] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.303s) [509.254295] [143/155] (514s left) gem_exec_gttfill (basic) [509.318000] Starting subtest: basic [512.040462] Subtest basic: SUCCESS (2.721s) [512.227906] [144/155] (511s left) gem_exec_schedule (deep) [512.471789] Starting subtest: deep [512.474159] Starting dynamic subtest: rcs0 [519.124753] Dynamic subtest rcs0: SKIP (6.648s) [519.140153] Starting dynamic subtest: vcs0 [530.029629] Dynamic subtest vcs0: SUCCESS (10.904s) [530.045815] Starting dynamic subtest: vcs1 [542.540801] Dynamic subtest vcs1: SUCCESS (12.510s) [542.554694] Starting dynamic subtest: vecs0 [554.696761] Dynamic subtest vecs0: SUCCESS (12.155s) [554.708655] Starting dynamic subtest: ccs0 [567.502385] Dynamic subtest ccs0: SUCCESS (12.805s) [567.505265] Subtest deep: SUCCESS (55.030s) [568.500321] [145/155] (455s left) syncobj_wait (single-wait-for-submit-signaled) [568.557037] Starting subtest: single-wait-for-submit-signaled [568.559348] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s) [568.655917] [146/155] (455s left) gem_flink_race (flink_name) [568.693379] Starting subtest: flink_name [574.102329] Subtest flink_name: SUCCESS (5.411s) [574.211182] [147/155] (449s left) api_intel_bb (intel-bb-blit-none) [574.270486] Starting subtest: intel-bb-blit-none [578.383542] Subtest intel-bb-blit-none: SUCCESS (4.113s) [578.523380] [148/155] (445s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip) [578.631244] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip [578.635309] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s) [578.723449] [149/155] (445s left) gem_exec_reloc (basic-write-read-noreloc) [578.783348] Subtest basic-write-read-noreloc: SKIP (0.000s) [578.862303] [150/155] (445s left) dmabuf_sync_file (export-before-signal) [578.903283] Starting subtest: export-before-signal [578.905232] Subtest export-before-signal: SUCCESS (0.001s) [578.974001] [151/155] (445s left) kms_hdr (invalid-metadata-sizes) [579.065346] Starting subtest: invalid-metadata-sizes [579.067693] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010 [579.072043] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s) [579.083384] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F [579.087553] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s) [579.091824] Subtest invalid-metadata-sizes: SKIP (0.003s) [579.139687] [152/155] (445s left) gem_ctx_persistence (heartbeat-hostile) [579.205922] Starting subtest: heartbeat-hostile [579.210336] Subtest heartbeat-hostile: SKIP (0.000s) [579.324037] [153/155] (444s left) gem_eio (wait-wedge-10ms) [579.573419] Starting subtest: wait-wedge-10ms [580.591402] Subtest wait-wedge-10ms: SUCCESS (1.018s) [580.763059] [154/155] (443s left) kms_cursor_crc (cursor-random-256x256) [581.014995] Starting subtest: cursor-random-256x256 [581.020584] Starting dynamic subtest: pipe-A-eDP-1 [584.446574] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.427s) [584.477640] Starting dynamic subtest: pipe-D-eDP-1 [588.513414] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.043s) [588.516001] Subtest cursor-random-256x256: SUCCESS (7.498s) [589.335435] [155/155] (435s left) prime_mmap_coherency (ioctl-errors) [589.400310] Starting subtest: ioctl-errors [605.427381] Subtest ioctl-errors: SUCCESS (16.030s) [605.593660] Closing watchdogs results: parsing output: 0/ for test: i915_pm_rpm results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: kms_cursor_crc results: parsing output: 3/ for test: gem_lmem_swapping results: parsing output: 4/ for test: kms_psr results: parsing output: 5/ for test: gem_exec_schedule results: parsing output: 6/ for test: kms_big_fb results: parsing output: 7/ for test: kms_flip results: parsing output: 8/ for test: kms_cursor_legacy results: parsing output: 9/ for test: gem_exec_fence results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: gem_ppgtt results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: perf_pmu results: parsing output: 14/ for test: kms_dsc results: parsing output: 15/ for test: kms_cdclk results: parsing output: 16/ for test: kms_frontbuffer_tracking results: parsing output: 17/ for test: gem_pxp results: parsing output: 18/ for test: kms_big_fb results: parsing output: 19/ for test: kms_flip results: parsing output: 20/ for test: syncobj_timeline results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: kms_cursor_legacy results: parsing output: 24/ for test: syncobj_timeline results: parsing output: 25/ for test: syncobj_basic results: parsing output: 26/ for test: kms_frontbuffer_tracking results: parsing output: 27/ for test: kms_psr results: parsing output: 28/ for test: gem_softpin results: parsing output: 29/ for test: kms_frontbuffer_tracking results: parsing output: 30/ for test: perf results: parsing output: 31/ for test: kms_async_flips results: parsing output: 32/ for test: kms_pipe_stress results: parsing output: 33/ for test: gem_mmap_gtt results: parsing output: 34/ for test: gem_render_copy results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: syncobj_eventfd results: parsing output: 37/ for test: gem_userptr_blits results: parsing output: 38/ for test: kms_psr results: parsing output: 39/ for test: sw_sync results: parsing output: 40/ for test: kms_big_fb results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: kms_plane results: parsing output: 43/ for test: kms_ccs results: parsing output: 44/ for test: fbdev results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: syncobj_wait results: parsing output: 47/ for test: sw_sync results: parsing output: 48/ for test: kms_cursor_crc results: parsing output: 49/ for test: gem_unfence_active_buffers results: parsing output: 50/ for test: kms_pm_dc results: parsing output: 51/ for test: syncobj_wait results: parsing output: 52/ for test: gem_exec_reloc results: parsing output: 53/ for test: kms_content_protection results: parsing output: 54/ for test: gem_exec_whisper results: parsing output: 55/ for test: gem_mmap_wc results: parsing output: 56/ for test: kms_big_fb results: parsing output: 57/ for test: kms_scaling_modes results: parsing output: 58/ for test: kms_psr2_sf results: parsing output: 59/ for test: gen9_exec_parse results: parsing output: 60/ for test: gem_spin_batch results: parsing output: 61/ for test: gem_ctx_isolation results: parsing output: 62/ for test: kms_frontbuffer_tracking results: parsing output: 63/ for test: gem_mmap_offset results: parsing output: 64/ for test: kms_ccs results: parsing output: 65/ for test: vgem_basic results: parsing output: 66/ for test: gem_caching results: parsing output: 67/ for test: syncobj_wait results: parsing output: 68/ for test: kms_flip results: parsing output: 69/ for test: gem_exec_reloc results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: syncobj_timeline results: parsing output: 72/ for test: kms_frontbuffer_tracking results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: kms_flip_scaled_crc results: parsing output: 75/ for test: gem_exec_balancer results: parsing output: 76/ for test: kms_big_fb results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: kms_invalid_mode results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: kms_plane results: parsing output: 82/ for test: kms_frontbuffer_tracking results: parsing output: 83/ for test: kms_ccs results: parsing output: 84/ for test: i915_hangman results: parsing output: 85/ for test: kms_flip_scaled_crc results: parsing output: 86/ for test: kms_prime results: parsing output: 87/ for test: kms_color_pipeline results: parsing output: 88/ for test: kms_frontbuffer_tracking results: parsing output: 89/ for test: kms_psr results: parsing output: 90/ for test: kms_lease results: parsing output: 91/ for test: kms_frontbuffer_tracking results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: gem_partial_pwrite_pread results: parsing output: 94/ for test: gem_create results: parsing output: 95/ for test: kms_frontbuffer_tracking results: parsing output: 96/ for test: kms_selftest results: parsing output: 97/ for test: i915_query results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: kms_frontbuffer_tracking results: parsing output: 101/ for test: kms_frontbuffer_tracking results: parsing output: 102/ for test: kms_cursor_legacy results: parsing output: 103/ for test: kms_chamelium_hpd results: parsing output: 104/ for test: i915_query results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: kms_vblank results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: syncobj_timeline results: parsing output: 109/ for test: gem_exec_schedule results: parsing output: 110/ for test: kms_big_fb results: parsing output: 111/ for test: gem_mmap_gtt results: parsing output: 112/ for test: gem_sync results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: kms_frontbuffer_tracking results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: gem_ctx_create results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: kms_chamelium_frames results: parsing output: 119/ for test: gem_lmem_swapping results: parsing output: 120/ for test: kms_psr results: parsing output: 121/ for test: gem_exec_fence results: parsing output: 122/ for test: i915_drm_fdinfo results: parsing output: 123/ for test: kms_pm_backlight results: parsing output: 124/ for test: gem_ctx_shared results: parsing output: 125/ for test: kms_psr2_sf results: parsing output: 126/ for test: kms_atomic results: parsing output: 127/ for test: kms_flip results: parsing output: 128/ for test: syncobj_wait results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: kms_frontbuffer_tracking results: parsing output: 131/ for test: kms_frontbuffer_tracking results: parsing output: 132/ for test: kms_plane_scaling results: parsing output: 133/ for test: kms_frontbuffer_tracking results: parsing output: 134/ for test: api_intel_bb results: parsing output: 135/ for test: prime_vgem results: parsing output: 136/ for test: kms_frontbuffer_tracking results: parsing output: 137/ for test: kms_pipe_b_c_ivb results: parsing output: 138/ for test: kms_frontbuffer_tracking results: parsing output: 139/ for test: kms_ccs results: parsing output: 140/ for test: prime_mmap results: parsing output: 141/ for test: kms_frontbuffer_tracking results: parsing output: 142/ for test: gem_exec_gttfill results: parsing output: 143/ for test: gem_exec_schedule results: parsing output: 144/ for test: syncobj_wait results: parsing output: 145/ for test: gem_flink_race results: parsing output: 146/ for test: api_intel_bb results: parsing output: 147/ for test: kms_big_fb results: parsing output: 148/ for test: gem_exec_reloc results: parsing output: 149/ for test: dmabuf_sync_file results: parsing output: 150/ for test: kms_hdr results: parsing output: 151/ for test: gem_ctx_persistence results: parsing output: 152/ for test: gem_eio results: parsing output: 153/ for test: kms_cursor_crc results: parsing output: 154/ for test: prime_mmap_coherency Done.