[55.808279] Initializing watchdogs [55.808327] /dev/watchdog0 [55.822840] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics] [55.826608] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [55.828717] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [55.831935] [001/155] (960s left) kms_flip (flip-vs-suspend) [55.940479] Starting subtest: flip-vs-suspend [55.942827] Starting dynamic subtest: A-eDP1 [200.782629] Dynamic subtest A-eDP1: SUCCESS (11.614s) [200.784999] Subtest flip-vs-suspend: SUCCESS (11.616s) [200.936972] [002/155] (815s left) gem_exec_whisper (basic-contexts-priority) [201.005146] Starting subtest: basic-contexts-priority [225.733724] Subtest basic-contexts-priority: SUCCESS (24.724s) [225.917308] [003/155] (790s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi [225.976798] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted [226.083365] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.107s) [226.156837] [004/155] (790s left) kms_pm_rpm (dpms-non-lpsp) [230.972769] Starting subtest: dpms-non-lpsp [230.978269] Subtest dpms-non-lpsp: SKIP (0.001s) [231.694476] [005/155] (784s left) sw_sync (sync_multi_consumer_producer) [231.728459] Starting subtest: sync_multi_consumer_producer [232.049721] Subtest sync_multi_consumer_producer: SUCCESS (0.320s) [232.107775] [006/155] (784s left) gem_ctx_persistence (legacy-engines-cleanup) [232.165315] Starting subtest: legacy-engines-cleanup [232.167396] Starting dynamic subtest: render [232.250476] Dynamic subtest render: SUCCESS (0.087s) [232.260837] Starting dynamic subtest: bsd1 [232.301451] Dynamic subtest bsd1: SUCCESS (0.049s) [232.311648] Starting dynamic subtest: bsd2 [232.348283] Dynamic subtest bsd2: SUCCESS (0.045s) [232.358521] Starting dynamic subtest: blt [232.390118] Dynamic subtest blt: SUCCESS (0.040s) [232.400121] Starting dynamic subtest: vebox [232.426965] Dynamic subtest vebox: SUCCESS (0.036s) [232.429118] Subtest legacy-engines-cleanup: SUCCESS (0.265s) [232.502129] [007/155] (784s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff) [232.577706] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff [232.581952] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [232.672586] [008/155] (783s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc) [232.759865] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc [232.762163] Starting dynamic subtest: pipe-A-eDP-1 [232.784958] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [232.796967] Starting dynamic subtest: pipe-B-eDP-1 [232.819258] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [232.828122] Starting dynamic subtest: pipe-C-eDP-1 [232.849329] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [232.857894] Starting dynamic subtest: pipe-D-eDP-1 [232.880124] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [232.884231] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.002s) [235.059112] [009/155] (781s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats) [235.439372] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s) [236.268312] [010/155] (780s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes) [236.319370] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s) [236.368975] [011/155] (780s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt) [236.445867] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt [236.450296] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [236.547081] [012/155] (780s left) gem_softpin (safe-alignment) [236.610304] Starting subtest: safe-alignment [236.630773] Subtest safe-alignment: SUCCESS (0.023s) [238.499406] [013/155] (778s left) kms_cursor_crc (cursor-onscreen-128x128) [238.690612] Starting subtest: cursor-onscreen-128x128 [238.692945] Starting dynamic subtest: pipe-A-eDP-1 [240.787137] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.094s) [240.817872] Starting dynamic subtest: pipe-D-eDP-1 [243.556420] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.746s) [243.558669] Subtest cursor-onscreen-128x128: SUCCESS (4.866s) [244.442080] [014/155] (772s left) kms_dp_linktrain_fallback (dp-fallback) [244.511599] Starting subtest: dp-fallback [244.518225] Subtest dp-fallback: SKIP (0.000s) [244.590875] [015/155] (772s left) gem_ctx_shared (exec-shared-gtt) [244.637718] Starting subtest: exec-shared-gtt [244.639874] Starting dynamic subtest: rcs0 [244.644575] Dynamic subtest rcs0: SUCCESS (0.006s) [244.658155] Starting dynamic subtest: bcs0 [244.660091] Dynamic subtest bcs0: SUCCESS (0.005s) [244.669725] Starting dynamic subtest: vcs0 [244.672046] Dynamic subtest vcs0: SUCCESS (0.006s) [244.682550] Starting dynamic subtest: vcs1 [244.684781] Dynamic subtest vcs1: SUCCESS (0.007s) [244.694018] Starting dynamic subtest: vecs0 [244.696279] Dynamic subtest vecs0: SUCCESS (0.007s) [244.705351] Starting dynamic subtest: ccs0 [244.707514] Dynamic subtest ccs0: SUCCESS (0.008s) [244.709759] Subtest exec-shared-gtt: SUCCESS (0.041s) [244.860000] [016/155] (772s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy) [244.961340] Starting subtest: flip-vs-cursor-crc-legacy [245.683091] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.723s) [246.572434] [017/155] (770s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip) [246.660809] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip [247.764891] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: FAIL (0.908s) [247.802573] [018/155] (769s left) syncobj_basic (illegal-fd-to-handle) [247.847493] Starting subtest: illegal-fd-to-handle [247.849447] Subtest illegal-fd-to-handle: SUCCESS (0.000s) [247.934736] [019/155] (769s left) kms_flip (nonexisting-fb) [248.010646] Starting subtest: nonexisting-fb [248.012579] Starting dynamic subtest: A-eDP1 [249.163196] Dynamic subtest A-eDP1: SUCCESS (1.151s) [249.177510] Starting dynamic subtest: B-eDP1 [250.301752] Dynamic subtest B-eDP1: SUCCESS (1.137s) [250.312036] Starting dynamic subtest: C-eDP1 [251.435326] Dynamic subtest C-eDP1: SUCCESS (1.133s) [251.444842] Starting dynamic subtest: D-eDP1 [252.556536] Dynamic subtest D-eDP1: SUCCESS (1.120s) [252.558925] Subtest nonexisting-fb: SUCCESS (4.549s) [253.735017] [020/155] (763s left) gem_pxp (regular-baseline-src-copy-readible) [253.857343] Starting subtest: regular-baseline-src-copy-readible [253.913635] Subtest regular-baseline-src-copy-readible: SUCCESS (0.059s) [254.038769] [021/155] (763s left) kms_vrr (seamless-rr-switch-drrs) [254.119343] Starting subtest: seamless-rr-switch-drrs [254.125798] Subtest seamless-rr-switch-drrs: SKIP (0.000s) [254.187044] [022/155] (762s left) kms_flip (2x-plain-flip) [254.271022] Starting subtest: 2x-plain-flip [254.277736] Subtest 2x-plain-flip: SKIP (0.007s) [254.364441] [023/155] (762s left) kms_fence_pin_leak [254.537291] [024/155] (762s left) kms_fb_coherency (memset-crc) [254.607936] Starting subtest: memset-crc [254.610275] Starting dynamic subtest: mmap-offset-wc [254.980979] Dynamic subtest mmap-offset-wc: SUCCESS (0.374s) [255.290407] Starting dynamic subtest: mmap-offset-uc [261.191970] Dynamic subtest mmap-offset-uc: SUCCESS (5.911s) [261.482355] Subtest memset-crc: SUCCESS (6.874s) [262.322535] [025/155] (754s left) kms_ccs (bad-rotation-90-yf-tiled-ccs) [262.403959] Starting subtest: bad-rotation-90-yf-tiled-ccs [262.406213] Starting dynamic subtest: pipe-A-eDP-1 [262.429090] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [262.441717] Starting dynamic subtest: pipe-B-eDP-1 [262.464817] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [262.474523] Starting dynamic subtest: pipe-C-eDP-1 [262.496387] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [262.508043] Starting dynamic subtest: pipe-D-eDP-1 [262.531435] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [262.535716] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.003s) [264.702276] [026/155] (752s left) gen7_exec_parse (bitmasks) [264.753623] Subtest bitmasks: SKIP (0.000s) [264.823248] [027/155] (752s left) syncobj_wait (multi-wait-all-signaled) [264.880506] Starting subtest: multi-wait-all-signaled [264.882709] Subtest multi-wait-all-signaled: SUCCESS (0.000s) [264.983303] [028/155] (752s left) kms_getfb (getfb-handle-valid) [265.061959] Starting subtest: getfb-handle-valid [265.064126] Subtest getfb-handle-valid: SUCCESS (0.000s) [265.181482] [029/155] (752s left) perf (oa-exponents) [265.303454] Starting subtest: oa-exponents [265.305747] Starting dynamic subtest: 0-rcs0 [267.089272] Dynamic subtest 0-rcs0: SUCCESS (1.785s) [267.099487] Starting dynamic subtest: 1-vecs0 [268.892781] Dynamic subtest 1-vecs0: SUCCESS (1.803s) [268.895397] Subtest oa-exponents: SUCCESS (3.588s) [268.938963] [030/155] (748s left) gem_exec_fence (concurrent) [269.117051] Starting subtest: concurrent [269.121830] Subtest concurrent: SKIP (0.000s) [270.533185] [FACT gem_exec_fence (concurrent)] new: kernel.kmod_is_loaded.vgem: true [270.537479] [031/155] (746s left) gem_exec_params (rel-constants-invalid-ring) [270.595188] Starting subtest: rel-constants-invalid-ring [270.597584] Subtest rel-constants-invalid-ring: SUCCESS (0.000s) [270.711336] [032/155] (746s left) kms_plane (pixel-format-x-tiled-modifier) [270.785861] Starting subtest: pixel-format-x-tiled-modifier [270.813209] Starting dynamic subtest: pipe-A-plane-0 [271.202343] Dynamic subtest pipe-A-plane-0: SUCCESS (0.389s) [271.212430] Starting dynamic subtest: pipe-A-plane-3 [271.524733] Dynamic subtest pipe-A-plane-3: SUCCESS (0.322s) [271.534024] Starting dynamic subtest: pipe-A-plane-5 [271.537851] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [272.680510] Starting dynamic subtest: pipe-B-plane-0 [273.071877] Dynamic subtest pipe-B-plane-0: SUCCESS (0.400s) [273.081328] Starting dynamic subtest: pipe-B-plane-3 [273.372197] Dynamic subtest pipe-B-plane-3: SUCCESS (0.300s) [273.383017] Starting dynamic subtest: pipe-B-plane-5 [273.387548] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [273.686989] Subtest pixel-format-x-tiled-modifier: SUCCESS (2.899s) [274.555968] [033/155] (743s left) gem_ctx_persistence (engines-queued) [274.607988] Starting subtest: engines-queued [274.610413] Starting dynamic subtest: rcs0 [274.679592] Dynamic subtest rcs0: SUCCESS (0.071s) [274.690338] Starting dynamic subtest: bcs0 [274.703041] Dynamic subtest bcs0: SUCCESS (0.022s) [274.712445] Starting dynamic subtest: vcs0 [276.431241] Dynamic subtest vcs0: SUCCESS (1.725s) [276.443448] Starting dynamic subtest: vcs1 [278.414117] Dynamic subtest vcs1: SUCCESS (1.981s) [278.428002] Starting dynamic subtest: vecs0 [280.397229] Dynamic subtest vecs0: SUCCESS (1.981s) [280.408864] Starting dynamic subtest: ccs0 [280.579542] Dynamic subtest ccs0: SUCCESS (0.182s) [280.582023] Subtest engines-queued: SUCCESS (5.972s) [280.698041] [034/155] (736s left) i915_drm_fdinfo (context-close-stress) [280.745014] Starting subtest: context-close-stress [291.490942] Subtest context-close-stress: SUCCESS (10.745s) [291.635994] [035/155] (726s left) kms_psr (psr-cursor-plane-onoff) [291.857889] Starting subtest: psr-cursor-plane-onoff [291.860142] Starting dynamic subtest: eDP-1 [293.554426] Dynamic subtest eDP-1: SUCCESS (1.695s) [293.556997] Subtest psr-cursor-plane-onoff: SUCCESS (1.696s) [294.422005] [036/155] (723s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs) [294.491560] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs [294.493928] Starting dynamic subtest: pipe-A-eDP-1 [294.516393] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [294.533757] Starting dynamic subtest: pipe-B-eDP-1 [294.555796] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [294.566666] Starting dynamic subtest: pipe-C-eDP-1 [294.587921] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [294.597245] Starting dynamic subtest: pipe-D-eDP-1 [294.619056] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [294.623403] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.005s) [296.769338] [037/155] (720s left) syncobj_timeline (single-wait-for-submit-available-signaled) [296.821210] Starting subtest: single-wait-for-submit-available-signaled [296.823178] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s) [296.938870] [038/155] (720s left) gem_exec_balancer (full) [297.000367] Starting subtest: full [301.306308] Subtest full: SUCCESS (4.299s) [301.626626] [039/155] (716s left) kms_psr (psr2-cursor-plane-onoff) [301.697841] Starting subtest: psr2-cursor-plane-onoff [301.700111] Starting dynamic subtest: eDP-1 [303.448100] Dynamic subtest eDP-1: SUCCESS (1.747s) [303.450285] Subtest psr2-cursor-plane-onoff: SUCCESS (1.747s) [304.333053] [040/155] (713s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling) [304.402748] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling [304.405002] Starting dynamic subtest: pipe-A-default-mode [305.595882] Dynamic subtest pipe-A-default-mode: SKIP (1.188s) [305.600397] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.190s) [305.729489] [041/155] (712s left) gem_exec_fence (basic-wait-all) [305.794070] Starting subtest: basic-wait-all [305.882590] Subtest basic-wait-all: SUCCESS (0.089s) [307.527519] [042/155] (710s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-indfb-pgflip-blt) [307.616516] Starting subtest: fbchdr-1p-primscrn-indfb-pgflip-blt [307.620674] Subtest fbchdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [307.713672] [043/155] (710s left) gem_wait (wait) [307.777077] Starting subtest: wait [307.779350] Starting dynamic subtest: all-engines [309.488738] Dynamic subtest all-engines: SUCCESS (1.709s) [309.502770] Starting dynamic subtest: rcs0 [310.534817] Dynamic subtest rcs0: SUCCESS (1.045s) [310.547477] Starting dynamic subtest: bcs0 [311.582189] Dynamic subtest bcs0: SUCCESS (1.045s) [311.594483] Starting dynamic subtest: vcs0 [312.625944] Dynamic subtest vcs0: SUCCESS (1.042s) [312.638114] Starting dynamic subtest: vcs1 [313.671471] Dynamic subtest vcs1: SUCCESS (1.043s) [313.683583] Starting dynamic subtest: vecs0 [314.714986] Dynamic subtest vecs0: SUCCESS (1.042s) [314.726993] Starting dynamic subtest: ccs0 [315.762044] Dynamic subtest ccs0: SUCCESS (1.045s) [315.764515] Subtest wait: SUCCESS (7.983s) [315.973030] [044/155] (702s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt) [316.060540] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt [316.064526] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [316.167948] [045/155] (701s left) kms_frontbuffer_tracking (fbcpsr-tiling-y) [316.241274] Starting subtest: fbcpsr-tiling-y [316.245587] Subtest fbcpsr-tiling-y: SKIP (0.000s) [316.325142] [046/155] (701s left) gem_readwrite (read-bad-handle) [316.374946] Subtest read-bad-handle: SKIP (0.000s) [316.432425] [047/155] (701s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [316.527342] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [316.531892] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [316.644278] [048/155] (701s left) kms_universal_plane (cursor-fb-leak) [316.720952] Starting subtest: cursor-fb-leak [316.723237] Starting dynamic subtest: pipe-A-eDP-1 [317.041672] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.322s) [317.056220] Starting dynamic subtest: pipe-B-eDP-1 [318.361509] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.316s) [318.373855] Starting dynamic subtest: pipe-C-eDP-1 [319.681423] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.317s) [319.695366] Starting dynamic subtest: pipe-D-eDP-1 [321.017264] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.332s) [321.019728] Subtest cursor-fb-leak: SUCCESS (4.298s) [322.207149] [049/155] (696s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-render) [322.289281] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-render [322.293523] Subtest hdr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s) [322.371017] [050/155] (695s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render) [322.445437] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render [322.449606] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [322.567104] [051/155] (695s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt) [322.644421] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt [322.648384] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [322.731537] [052/155] (695s left) i915_pm_rps (reset) [322.781440] Starting subtest: reset [331.188937] Subtest reset: SUCCESS (8.406s) [331.301505] [053/155] (687s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt) [331.380933] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt [331.385322] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [331.486007] [054/155] (687s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-render) [331.572863] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-render [331.576830] Subtest hdr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [331.674345] [055/155] (686s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-wc) [331.761304] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-wc [331.765613] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [331.884483] [056/155] (686s left) kms_flip (bo-too-big) [331.953248] Starting subtest: bo-too-big [331.955490] Starting dynamic subtest: A-eDP1 [333.234572] Dynamic subtest A-eDP1: SUCCESS (1.282s) [333.246247] Starting dynamic subtest: B-eDP1 [334.564744] Dynamic subtest B-eDP1: SUCCESS (1.329s) [334.577519] Starting dynamic subtest: C-eDP1 [335.904035] Dynamic subtest C-eDP1: SUCCESS (1.338s) [335.916822] Starting dynamic subtest: D-eDP1 [337.246229] Dynamic subtest D-eDP1: SUCCESS (1.339s) [337.248740] Subtest bo-too-big: SUCCESS (5.296s) [338.457025] [057/155] (680s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy) [338.559317] Starting subtest: 2x-flip-vs-cursor-legacy [338.563713] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s) [338.716501] [058/155] (679s left) api_intel_allocator (default-alignment) [338.771650] Starting subtest: default-alignment [338.773935] Subtest default-alignment: SUCCESS (0.003s) [338.897446] [059/155] (679s left) gem_mmap_gtt (medium-copy) [338.950825] Subtest medium-copy: SKIP (0.000s) [339.015858] [060/155] (679s left) kms_plane_scaling (2x-scaler-multi-pipe) [339.094482] Starting subtest: 2x-scaler-multi-pipe [339.098823] Subtest 2x-scaler-multi-pipe: SKIP (0.001s) [339.205022] [061/155] (679s left) gem_lmem_swapping (heavy-verify-random-ccs) [339.244761] Subtest heavy-verify-random-ccs: SKIP (0.000s) [339.290509] [062/155] (679s left) syncobj_timeline (invalid-query-illegal-handle) [339.348720] Starting subtest: invalid-query-illegal-handle [339.350936] Subtest invalid-query-illegal-handle: SUCCESS (0.000s) [339.460066] [063/155] (679s left) kms_psr (fbc-psr2-primary-mmap-gtt) [339.535913] Starting subtest: fbc-psr2-primary-mmap-gtt [339.537863] Starting dynamic subtest: eDP-1 [339.541533] Dynamic subtest eDP-1: SKIP (0.000s) [339.545125] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s) [339.609119] [064/155] (679s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc) [339.687567] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc [339.691137] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [339.792459] [065/155] (679s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted) [339.857034] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted [339.989439] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.132s) [340.099484] [066/155] (678s left) perf (invalid-remove-userspace-config) [340.177190] Starting subtest: invalid-remove-userspace-config [340.184451] Subtest invalid-remove-userspace-config: SUCCESS (0.007s) [340.229709] [067/155] (678s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff) [340.304053] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff [340.307590] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [340.404948] [068/155] (678s left) kms_flip (flip-vs-fences-interruptible) [340.486093] Starting subtest: flip-vs-fences-interruptible [340.489718] Subtest flip-vs-fences-interruptible: SKIP (0.000s) [340.589434] [069/155] (678s left) syncobj_timeline (single-wait-all-available-signaled) [340.641601] Starting subtest: single-wait-all-available-signaled [340.643555] Subtest single-wait-all-available-signaled: SUCCESS (0.000s) [340.755930] [070/155] (678s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu) [340.834878] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu [348.136029] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.306s) [348.249018] [071/155] (670s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing) [348.326746] Starting subtest: plane-all-transition-nonblocking-fencing [348.329061] Starting dynamic subtest: pipe-A-eDP-1 [350.821198] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s) [351.129639] Starting dynamic subtest: pipe-B-eDP-1 [354.336976] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.218s) [354.651779] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.324s) [355.467357] [072/155] (663s left) api_intel_bb (offset-control) [355.513725] Starting subtest: offset-control [355.518370] Subtest offset-control: SUCCESS (0.007s) [355.600017] [073/155] (663s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs) [355.680178] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs [355.682744] Starting dynamic subtest: pipe-A-eDP-1 [355.740112] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.060s) [355.750339] Starting dynamic subtest: pipe-B-eDP-1 [355.800198] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.060s) [355.810601] Starting dynamic subtest: pipe-C-eDP-1 [355.859120] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.059s) [355.869535] Starting dynamic subtest: pipe-D-eDP-1 [355.920281] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.060s) [355.922581] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.244s) [358.221361] [074/155] (661s left) kms_chamelium_color (ctm-limited-range) [358.288615] Subtest ctm-limited-range: SKIP (0.000s) [358.334465] [075/155] (661s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions) [358.426777] Starting subtest: cursorA-vs-flipA-atomic-transitions [369.608918] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.182s) [370.469031] [076/155] (648s left) syncobj_wait (multi-wait-all-submitted-signaled) [370.531362] Starting subtest: multi-wait-all-submitted-signaled [370.634363] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.104s) [370.710258] [077/155] (648s left) syncobj_eventfd (invalid-bad-pad) [370.766309] Starting subtest: invalid-bad-pad [370.768538] Subtest invalid-bad-pad: SUCCESS (0.000s) [370.879579] [078/155] (648s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-render) [370.948771] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-render [370.952749] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [371.029040] [079/155] (648s left) kms_content_protection (atomic-hdcp14) [371.152218] Starting subtest: atomic-hdcp14 [371.156492] Subtest atomic-hdcp14: SKIP (0.000s) [371.267721] [080/155] (648s left) kms_chamelium_hpd (vga-hpd-for-each-pipe) [371.627377] Subtest vga-hpd-for-each-pipe: SKIP (0.000s) [372.460392] [081/155] (647s left) gem_media_vme [372.593725] [082/155] (647s left) perf (polling-parameterized) [372.680134] Starting subtest: polling-parameterized [392.698111] Subtest polling-parameterized: SUCCESS (20.016s) [392.748733] [083/155] (626s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [392.831187] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc [392.835562] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [392.930823] [084/155] (626s left) kms_force_connector_basic (force-edid) [392.984741] Subtest force-edid: SKIP (0.000s) [393.046039] [085/155] (626s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render) [393.133834] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render [393.137968] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [393.241618] [086/155] (626s left) kms_plane_multiple (2x-tiling-yf) [393.314084] Starting subtest: 2x-tiling-yf [393.318678] Subtest 2x-tiling-yf: SKIP (0.000s) [393.389106] [087/155] (626s left) kms_color (ctm-signed) [393.457753] Starting subtest: ctm-signed [393.460017] Starting dynamic subtest: pipe-A-eDP-1 [395.568258] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.111s) [395.581302] Starting dynamic subtest: pipe-B-eDP-1 [398.430790] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.862s) [398.440837] Starting dynamic subtest: pipe-C-eDP-1 [401.150245] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.716s) [401.163653] Starting dynamic subtest: pipe-D-eDP-1 [403.825975] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.678s) [403.828289] Subtest ctm-signed: SUCCESS (10.371s) [404.646371] [088/155] (615s left) kms_psr (fbc-psr-sprite-plane-move) [404.717786] Starting subtest: fbc-psr-sprite-plane-move [404.720115] Starting dynamic subtest: eDP-1 [404.724604] Dynamic subtest eDP-1: SKIP (0.000s) [404.729030] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s) [404.809370] [089/155] (615s left) kms_flip (busy-flip) [404.886226] Starting subtest: busy-flip [404.888663] Starting dynamic subtest: A-eDP1 [406.564899] Dynamic subtest A-eDP1: SUCCESS (1.676s) [406.575306] Starting dynamic subtest: B-eDP1 [408.295453] Dynamic subtest B-eDP1: SUCCESS (1.731s) [408.308550] Starting dynamic subtest: C-eDP1 [410.021132] Dynamic subtest C-eDP1: SUCCESS (1.723s) [410.034752] Starting dynamic subtest: D-eDP1 [411.668170] Dynamic subtest D-eDP1: SUCCESS (1.645s) [411.670565] Subtest busy-flip: SUCCESS (6.786s) [412.826255] [090/155] (607s left) gem_exec_params (rsvd2-dirt) [412.890911] Starting subtest: rsvd2-dirt [412.895170] Subtest rsvd2-dirt: SKIP (0.000s) [413.012850] [091/155] (607s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-mmap-wc) [413.093777] Starting subtest: fbcpsrhdr-rgb101010-draw-mmap-wc [413.097930] Subtest fbcpsrhdr-rgb101010-draw-mmap-wc: SKIP (0.000s) [413.202377] [092/155] (606s left) i915_pciid [413.369826] [093/155] (606s left) kms_invalid_mode (bad-vsync-start) [413.439491] Starting subtest: bad-vsync-start [413.441753] Starting dynamic subtest: pipe-A-eDP-1 [413.721554] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s) [413.732196] Starting dynamic subtest: pipe-B-eDP-1 [413.734127] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [413.744651] Starting dynamic subtest: pipe-C-eDP-1 [413.747065] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [413.758944] Starting dynamic subtest: pipe-D-eDP-1 [413.761303] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [413.763675] Subtest bad-vsync-start: SUCCESS (0.288s) [414.562209] [094/155] (605s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-pwrite) [414.644377] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-pwrite [414.648350] Subtest psrhdr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [414.754255] [095/155] (605s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [414.829873] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt [414.834072] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [414.927001] [096/155] (605s left) sw_sync (sync_busy_fork_unixsocket) [414.963453] Starting subtest: sync_busy_fork_unixsocket [414.968191] Subtest sync_busy_fork_unixsocket: SUCCESS (0.007s) [415.019526] [097/155] (605s left) gem_sync (basic-all) [415.097540] Starting subtest: basic-all [417.453580] Subtest basic-all: SUCCESS (2.367s) [417.641774] [098/155] (602s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-blt) [417.731908] Starting subtest: fbchdr-rgb565-draw-blt [417.735866] Subtest fbchdr-rgb565-draw-blt: SKIP (0.000s) [417.834872] [099/155] (602s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-mmap-wc) [417.912840] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-mmap-wc [417.916934] Subtest hdr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [418.013899] [100/155] (602s left) gem_fenced_exec_thrash (no-spare-fences) [418.072106] Subtest no-spare-fences: SKIP (0.000s) [418.143805] [101/155] (602s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-blt) [418.222309] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-blt [418.226349] Subtest fbchdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [418.327161] [102/155] (602s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-render) [418.425123] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-render [418.429154] Subtest hdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [418.526332] [103/155] (601s left) kms_big_fb (4-tiled-32bpp-rotate-90) [418.599379] Starting subtest: 4-tiled-32bpp-rotate-90 [418.620431] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s) [418.721759] [104/155] (601s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite) [418.801414] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite [418.804920] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [418.922529] [105/155] (601s left) gem_exec_schedule (preempt-other-chain) [418.986983] Starting subtest: preempt-other-chain [418.988788] Starting dynamic subtest: rcs0 [419.061566] Dynamic subtest rcs0: SUCCESS (0.080s) [419.072546] Starting dynamic subtest: bcs0 [419.138510] Dynamic subtest bcs0: SUCCESS (0.075s) [419.150253] Starting dynamic subtest: vcs0 [419.215376] Dynamic subtest vcs0: SUCCESS (0.076s) [419.226701] Starting dynamic subtest: vcs1 [419.292719] Dynamic subtest vcs1: SUCCESS (0.077s) [419.303405] Starting dynamic subtest: vecs0 [419.371334] Dynamic subtest vecs0: SUCCESS (0.077s) [419.383211] Starting dynamic subtest: ccs0 [419.451501] Dynamic subtest ccs0: SUCCESS (0.080s) [419.453289] Subtest preempt-other-chain: SUCCESS (0.471s) [420.542129] [106/155] (600s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation) [420.625975] Starting subtest: plane-downscale-factor-0-75-with-rotation [420.628370] Starting dynamic subtest: pipe-A [420.854912] Dynamic subtest pipe-A: SUCCESS (0.230s) [420.866468] Starting dynamic subtest: pipe-B [422.143338] Dynamic subtest pipe-B: SUCCESS (1.288s) [422.153206] Starting dynamic subtest: pipe-C [423.475838] Dynamic subtest pipe-C: SUCCESS (1.332s) [423.485947] Starting dynamic subtest: pipe-D [424.816251] Dynamic subtest pipe-D: SUCCESS (1.340s) [424.818637] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.192s) [425.988620] [107/155] (594s left) gem_partial_pwrite_pread (reads-snoop) [426.048861] Subtest reads-snoop: SKIP (0.000s) [426.117316] [108/155] (594s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-mmap-cpu) [426.198945] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-mmap-cpu [426.203320] Subtest fbchdr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [426.282981] [109/155] (594s left) sysfs_heartbeat_interval (idempotent) [426.327170] Starting subtest: idempotent [426.329617] Starting dynamic subtest: vecs0 [426.332032] Dynamic subtest vecs0: SUCCESS (0.001s) [426.343520] Starting dynamic subtest: ccs0 [426.345462] Dynamic subtest ccs0: SUCCESS (0.001s) [426.354615] Starting dynamic subtest: vcs0 [426.356546] Dynamic subtest vcs0: SUCCESS (0.000s) [426.365729] Starting dynamic subtest: bcs0 [426.367682] Dynamic subtest bcs0: SUCCESS (0.001s) [426.376804] Starting dynamic subtest: rcs0 [426.378764] Dynamic subtest rcs0: SUCCESS (0.000s) [426.388258] Starting dynamic subtest: vcs1 [426.390464] Dynamic subtest vcs1: SUCCESS (0.000s) [426.392680] Subtest idempotent: SUCCESS (0.008s) [426.444119] [110/155] (594s left) kms_plane_scaling (planes-upscale-factor-0-25) [426.522381] Starting subtest: planes-upscale-factor-0-25 [426.524696] Starting dynamic subtest: pipe-A [426.583164] Dynamic subtest pipe-A: SUCCESS (0.062s) [426.594615] Starting dynamic subtest: pipe-B [427.717549] Dynamic subtest pipe-B: SUCCESS (1.134s) [427.731109] Starting dynamic subtest: pipe-C [428.827022] Dynamic subtest pipe-C: SUCCESS (1.108s) [428.837617] Starting dynamic subtest: pipe-D [429.961999] Dynamic subtest pipe-D: SUCCESS (1.134s) [429.964337] Subtest planes-upscale-factor-0-25: SUCCESS (3.442s) [431.128194] [111/155] (589s left) kms_multipipe_modeset (basic-max-pipe-crc-check) [431.198572] Starting subtest: basic-max-pipe-crc-check [431.203172] Subtest basic-max-pipe-crc-check: SKIP (0.000s) [431.245496] [112/155] (589s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-pwrite) [431.317469] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-pwrite [431.321894] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [431.444017] [113/155] (589s left) gem_exec_reloc (basic-gtt-cpu) [431.499256] Subtest basic-gtt-cpu: SKIP (0.000s) [431.574099] [114/155] (589s left) gem_exec_fence (syncobj-timeline-chain-engines) [432.119916] Starting subtest: syncobj-timeline-chain-engines [432.241642] Subtest syncobj-timeline-chain-engines: SUCCESS (0.122s) [433.574389] [115/155] (587s left) dmabuf_sync_file (export-before-signal) [433.612336] Starting subtest: export-before-signal [433.614306] Subtest export-before-signal: SUCCESS (0.001s) [433.666994] [116/155] (587s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-shrfb-msflip-blt) [433.752593] Starting subtest: fbcpsrhdr-2p-primscrn-shrfb-msflip-blt [433.756993] Subtest fbcpsrhdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [433.833562] [117/155] (587s left) kms_hdr (static-toggle-dpms) [433.901558] Starting subtest: static-toggle-dpms [433.903755] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010 [433.908025] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s) [433.918242] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F [433.922322] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s) [433.926392] Subtest static-toggle-dpms: SKIP (0.003s) [433.975013] [118/155] (587s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt) [434.053913] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt [434.057944] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [434.142422] [119/155] (587s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu) [434.218364] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu [434.222359] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [434.324751] [120/155] (586s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt) [434.403157] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt [434.407569] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [434.504011] [121/155] (586s left) gem_exec_schedule (timeslicing) [434.566026] Starting subtest: timeslicing [434.567718] Starting dynamic subtest: rcs0 [434.578947] Dynamic subtest rcs0: SUCCESS (0.021s) [434.590601] Starting dynamic subtest: bcs0 [434.599224] Dynamic subtest bcs0: SUCCESS (0.020s) [434.608592] Starting dynamic subtest: vcs0 [434.619880] Dynamic subtest vcs0: SUCCESS (0.020s) [434.629630] Starting dynamic subtest: vcs1 [434.640345] Dynamic subtest vcs1: SUCCESS (0.020s) [434.649809] Starting dynamic subtest: vecs0 [434.666807] Dynamic subtest vecs0: SUCCESS (0.025s) [434.676576] Starting dynamic subtest: ccs0 [434.689190] Dynamic subtest ccs0: SUCCESS (0.022s) [434.691103] Subtest timeslicing: SUCCESS (0.133s) [436.512423] [122/155] (584s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu) [436.587128] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu [436.591238] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [436.681144] [123/155] (584s left) gem_mmap_offset (bad-extensions) [436.730559] Starting subtest: bad-extensions [436.732976] Subtest bad-extensions: SUCCESS (0.000s) [436.822581] [124/155] (584s left) kms_psr (fbc-pr-basic) [436.895639] Starting subtest: fbc-pr-basic [436.899783] Subtest fbc-pr-basic: SKIP (0.000s) [436.983797] [125/155] (584s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-shrfb-plflip-blt) [437.065676] Starting subtest: fbchdr-2p-primscrn-shrfb-plflip-blt [437.069791] Subtest fbchdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [437.183992] [126/155] (584s left) kms_pm_rpm (system-suspend-idle) [438.685285] Starting subtest: system-suspend-idle [458.006409] Subtest system-suspend-idle: SUCCESS (4.335s) [458.391709] [127/155] (563s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area) [458.478743] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area [458.481451] Starting dynamic subtest: pipe-A-eDP-1 [458.607967] Dynamic subtest pipe-A-eDP-1: SKIP (0.133s) [458.619311] Starting dynamic subtest: pipe-B-eDP-1 [459.759987] Dynamic subtest pipe-B-eDP-1: SKIP (1.147s) [459.765397] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.283s) [460.958098] [128/155] (560s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render) [461.041601] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render [467.949737] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.906s) [468.078629] [129/155] (553s left) kms_cursor_crc (cursor-suspend) [468.194628] Starting subtest: cursor-suspend [468.196830] Starting dynamic subtest: pipe-A-eDP-1 [501.254976] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.211s) [501.265585] Starting dynamic subtest: pipe-D-eDP-1 [535.201959] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.780s) [535.203885] Subtest cursor-suspend: SUCCESS (6.993s) [536.071087] [130/155] (485s left) kms_plane_lowres (tiling-4) [536.145746] Starting subtest: tiling-4 [536.147998] Starting dynamic subtest: pipe-A-eDP-1 [536.152506] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [536.445102] Starting dynamic subtest: pipe-B-eDP-1 [536.449470] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [536.460293] Starting dynamic subtest: pipe-C-eDP-1 [536.464915] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [536.480125] Starting dynamic subtest: pipe-D-eDP-1 [536.484421] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [536.488919] Subtest tiling-4: SKIP (0.295s) [537.305157] [131/155] (484s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-render) [537.384593] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-render [537.388857] Subtest hdr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [537.478534] [132/155] (484s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted) [537.524622] Starting subtest: etime-single-wait-all-for-submit-submitted [537.631056] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.104s) [537.710734] [133/155] (484s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc) [537.787410] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc [537.789791] Starting dynamic subtest: pipe-A-eDP-1 [553.952443] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.367s) [553.963773] Starting dynamic subtest: pipe-B-eDP-1 [570.974011] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.465s) [570.986022] Starting dynamic subtest: pipe-C-eDP-1 [587.925195] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.436s) [587.936256] Starting dynamic subtest: pipe-D-eDP-1 [604.938303] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.394s) [604.940595] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (8.667s) [606.170746] [134/155] (415s left) kms_vblank (ts-continuation-modeset) [606.255482] Starting subtest: ts-continuation-modeset [606.257728] Starting dynamic subtest: pipe-A-eDP-1 [607.735233] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.477s) [607.750408] Starting dynamic subtest: pipe-D-eDP-1 [609.926366] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.184s) [609.928580] Subtest ts-continuation-modeset: SUCCESS (3.664s) [610.742622] [135/155] (411s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [610.823208] Starting subtest: addfb25-yf-tiled-legacy [610.825521] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [610.941016] [136/155] (410s left) kms_big_fb (x-tiled-8bpp-rotate-270) [611.030354] Starting subtest: x-tiled-8bpp-rotate-270 [611.056913] Subtest x-tiled-8bpp-rotate-270: SKIP (0.023s) [611.168232] [137/155] (410s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip) [611.253735] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip [611.258161] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [611.351928] [138/155] (410s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt) [611.438058] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt [611.442185] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [611.533242] [139/155] (410s left) kms_scaling_modes (scaling-mode-full-aspect) [611.602462] Starting subtest: scaling-mode-full-aspect [611.604650] Starting dynamic subtest: pipe-A-eDP-1 [611.695336] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.094s) [611.708251] Starting dynamic subtest: pipe-B-eDP-1 [612.869618] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.170s) [612.880866] Starting dynamic subtest: pipe-C-eDP-1 [613.970870] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.098s) [613.981789] Starting dynamic subtest: pipe-D-eDP-1 [615.103231] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.130s) [615.105586] Subtest scaling-mode-full-aspect: SUCCESS (3.498s) [616.275863] [140/155] (405s left) gem_eio (wait-1us) [616.505805] Starting subtest: wait-1us [616.861005] Subtest wait-1us: SUCCESS (0.356s) [616.993530] [141/155] (405s left) i915_pm_sseu (full-enable) [617.051119] Subtest full-enable: SKIP (0.000s) [617.151915] [142/155] (405s left) syncobj_basic (bad-pad-fd-to-handle) [617.196531] Starting subtest: bad-pad-fd-to-handle [617.198172] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [617.283963] [143/155] (404s left) gem_flink_basic (basic) [617.335456] Starting subtest: basic [617.337046] Subtest basic: SUCCESS (0.000s) [617.441024] [144/155] (404s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled) [617.495617] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled [617.499190] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s) [617.689845] [145/155] (404s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt) [617.769680] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt [624.547751] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.779s) [624.686320] [146/155] (397s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-pwrite) [624.775353] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-pwrite [624.779700] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [624.880561] [147/155] (397s left) kms_big_fb (yf-tiled-32bpp-rotate-0) [624.978321] Starting subtest: yf-tiled-32bpp-rotate-0 [624.982815] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s) [625.079872] [148/155] (397s left) drm_read (short-buffer-nonblock) [625.209494] Starting subtest: short-buffer-nonblock [625.211924] Subtest short-buffer-nonblock: SUCCESS (0.000s) [625.324924] [149/155] (397s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf) [625.407988] Starting subtest: fbc-pr-cursor-plane-update-sf [625.412446] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s) [625.473796] [150/155] (397s left) gem_mmap_gtt (basic-write) [625.534440] Subtest basic-write: SKIP (0.000s) [625.596638] [151/155] (396s left) kms_cursor_crc (cursor-rapid-movement-512x170) [625.866773] Starting subtest: cursor-rapid-movement-512x170 [625.870118] Subtest cursor-rapid-movement-512x170: SKIP (0.001s) [626.016696] [152/155] (396s left) gem_create (create-ext-cpu-access-sanity-check) [626.175148] Starting subtest: create-ext-cpu-access-sanity-check [626.179870] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s) [626.269544] [153/155] (396s left) kms_atomic_transition (modeset-transition-nonblocking) [626.334537] Starting subtest: modeset-transition-nonblocking [626.336802] Starting dynamic subtest: 1x-outputs [637.434285] Dynamic subtest 1x-outputs: SUCCESS (11.095s) [637.436899] Subtest modeset-transition-nonblocking: SUCCESS (11.097s) [638.299651] [154/155] (384s left) gem_bad_reloc (negative-reloc-lut) [638.352453] Subtest negative-reloc-lut: SKIP (0.000s) [638.421870] [155/155] (384s left) gem_exec_gttfill (engines) [638.478726] Starting subtest: engines [638.481040] Starting dynamic subtest: rcs0 [661.439162] Dynamic subtest rcs0: SUCCESS (22.959s) [661.451736] Starting dynamic subtest: bcs0 [684.744710] Dynamic subtest bcs0: SUCCESS (23.296s) [684.757109] Starting dynamic subtest: vcs0 [708.059522] Dynamic subtest vcs0: SUCCESS (23.309s) [708.070873] Starting dynamic subtest: vcs1 [731.354336] Dynamic subtest vcs1: SUCCESS (23.293s) [731.365863] Starting dynamic subtest: vecs0 [754.675122] Dynamic subtest vecs0: SUCCESS (23.315s) [754.686941] Starting dynamic subtest: ccs0 [778.043552] Dynamic subtest ccs0: SUCCESS (23.361s) [778.045968] Subtest engines: SUCCESS (139.547s) [778.234882] Closing watchdogs results: parsing output: 0/ for test: kms_flip results: parsing output: 1/ for test: gem_exec_whisper results: parsing output: 2/ for test: syncobj_timeline results: parsing output: 3/ for test: kms_pm_rpm results: parsing output: 4/ for test: sw_sync results: parsing output: 5/ for test: gem_ctx_persistence results: parsing output: 6/ for test: kms_frontbuffer_tracking results: parsing output: 7/ for test: kms_ccs results: parsing output: 8/ for test: kms_chamelium_frames results: parsing output: 9/ for test: kms_pipe_b_c_ivb results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: gem_softpin results: parsing output: 12/ for test: kms_cursor_crc results: parsing output: 13/ for test: kms_dp_linktrain_fallback results: parsing output: 14/ for test: gem_ctx_shared results: parsing output: 15/ for test: kms_cursor_legacy results: parsing output: 16/ for test: kms_big_fb results: parsing output: 17/ for test: syncobj_basic results: parsing output: 18/ for test: kms_flip results: parsing output: 19/ for test: gem_pxp results: parsing output: 20/ for test: kms_vrr results: parsing output: 21/ for test: kms_flip results: parsing output: 22/ for test: kms_fence_pin_leak results: parsing output: 23/ for test: kms_fb_coherency results: parsing output: 24/ for test: kms_ccs results: parsing output: 25/ for test: gen7_exec_parse results: parsing output: 26/ for test: syncobj_wait results: parsing output: 27/ for test: kms_getfb results: parsing output: 28/ for test: perf results: parsing output: 29/ for test: gem_exec_fence results: parsing output: 30/ for test: gem_exec_params results: parsing output: 31/ for test: kms_plane results: parsing output: 32/ for test: gem_ctx_persistence results: parsing output: 33/ for test: i915_drm_fdinfo results: parsing output: 34/ for test: kms_psr results: parsing output: 35/ for test: kms_ccs results: parsing output: 36/ for test: syncobj_timeline results: parsing output: 37/ for test: gem_exec_balancer results: parsing output: 38/ for test: kms_psr results: parsing output: 39/ for test: kms_flip_scaled_crc results: parsing output: 40/ for test: gem_exec_fence results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: gem_wait results: parsing output: 43/ for test: kms_frontbuffer_tracking results: parsing output: 44/ for test: kms_frontbuffer_tracking results: parsing output: 45/ for test: gem_readwrite results: parsing output: 46/ for test: kms_big_fb results: parsing output: 47/ for test: kms_universal_plane results: parsing output: 48/ for test: kms_frontbuffer_tracking results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: kms_frontbuffer_tracking results: parsing output: 51/ for test: i915_pm_rps results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: kms_flip results: parsing output: 56/ for test: kms_cursor_legacy results: parsing output: 57/ for test: api_intel_allocator results: parsing output: 58/ for test: gem_mmap_gtt results: parsing output: 59/ for test: kms_plane_scaling results: parsing output: 60/ for test: gem_lmem_swapping results: parsing output: 61/ for test: syncobj_timeline results: parsing output: 62/ for test: kms_psr results: parsing output: 63/ for test: kms_frontbuffer_tracking results: parsing output: 64/ for test: gem_pxp results: parsing output: 65/ for test: perf results: parsing output: 66/ for test: kms_frontbuffer_tracking results: parsing output: 67/ for test: kms_flip results: parsing output: 68/ for test: syncobj_timeline results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: kms_atomic_transition results: parsing output: 71/ for test: api_intel_bb results: parsing output: 72/ for test: kms_ccs results: parsing output: 73/ for test: kms_chamelium_color results: parsing output: 74/ for test: kms_cursor_legacy results: parsing output: 75/ for test: syncobj_wait results: parsing output: 76/ for test: syncobj_eventfd results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: kms_content_protection results: parsing output: 79/ for test: kms_chamelium_hpd results: parsing output: 80/ for test: gem_media_vme results: parsing output: 81/ for test: perf results: parsing output: 82/ for test: kms_frontbuffer_tracking results: parsing output: 83/ for test: kms_force_connector_basic results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: kms_plane_multiple results: parsing output: 86/ for test: kms_color results: parsing output: 87/ for test: kms_psr results: parsing output: 88/ for test: kms_flip results: parsing output: 89/ for test: gem_exec_params results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: i915_pciid results: parsing output: 92/ for test: kms_invalid_mode results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: sw_sync results: parsing output: 96/ for test: gem_sync results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: gem_fenced_exec_thrash 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_big_fb results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: gem_exec_schedule results: parsing output: 105/ for test: kms_plane_scaling results: parsing output: 106/ for test: gem_partial_pwrite_pread results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: sysfs_heartbeat_interval results: parsing output: 109/ for test: kms_plane_scaling results: parsing output: 110/ for test: kms_multipipe_modeset results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: gem_exec_reloc results: parsing output: 113/ for test: gem_exec_fence results: parsing output: 114/ for test: dmabuf_sync_file results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: kms_hdr results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: kms_frontbuffer_tracking results: parsing output: 120/ for test: gem_exec_schedule results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: gem_mmap_offset results: parsing output: 123/ for test: kms_psr results: parsing output: 124/ for test: kms_frontbuffer_tracking results: parsing output: 125/ for test: kms_pm_rpm results: parsing output: 126/ for test: kms_psr2_sf results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: kms_cursor_crc results: parsing output: 129/ for test: kms_plane_lowres results: parsing output: 130/ for test: kms_frontbuffer_tracking results: parsing output: 131/ for test: syncobj_timeline results: parsing output: 132/ for test: kms_ccs results: parsing output: 133/ for test: kms_vblank results: parsing output: 134/ for test: kms_addfb_basic results: parsing output: 135/ for test: kms_big_fb results: parsing output: 136/ for test: kms_big_fb results: parsing output: 137/ for test: kms_frontbuffer_tracking results: parsing output: 138/ for test: kms_scaling_modes results: parsing output: 139/ for test: gem_eio results: parsing output: 140/ for test: i915_pm_sseu results: parsing output: 141/ for test: syncobj_basic results: parsing output: 142/ for test: gem_flink_basic results: parsing output: 143/ for test: gem_render_copy results: parsing output: 144/ for test: kms_frontbuffer_tracking results: parsing output: 145/ for test: kms_frontbuffer_tracking results: parsing output: 146/ for test: kms_big_fb results: parsing output: 147/ for test: drm_read results: parsing output: 148/ for test: kms_psr2_sf results: parsing output: 149/ for test: gem_mmap_gtt results: parsing output: 150/ for test: kms_cursor_crc results: parsing output: 151/ for test: gem_create results: parsing output: 152/ for test: kms_atomic_transition results: parsing output: 153/ for test: gem_bad_reloc results: parsing output: 154/ for test: gem_exec_gttfill Done.