[59.287366] Initializing watchdogs [59.287412] /dev/watchdog0 [59.300940] [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] [59.305444] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.309373] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.312453] [001/133] (960s left) kms_feature_discovery (display-2x) [59.436611] Starting subtest: display-2x [59.441195] Subtest display-2x: SKIP (0.000s) [59.505021] [002/133] (960s left) perf (polling) [59.620709] Starting subtest: polling [59.623199] Starting dynamic subtest: 0-rcs0 [69.631734] Dynamic subtest 0-rcs0: SUCCESS (9.987s) [69.638907] Starting dynamic subtest: 1-vcs0 [79.658035] Dynamic subtest 1-vcs0: SUCCESS (10.020s) [79.661078] Subtest polling: SUCCESS (20.008s) [79.701958] [003/133] (940s left) kms_content_protection (lic-type-1) [79.859019] Starting subtest: lic-type-1 [79.863772] Subtest lic-type-1: SKIP (0.000s) [79.982092] [004/133] (939s left) kms_flip (flip-vs-panning-vs-hang) [80.086588] Starting subtest: flip-vs-panning-vs-hang [80.088848] Starting dynamic subtest: A-eDP1 [131.392944] Dynamic subtest A-eDP1: SUCCESS (51.302s) [131.403427] Starting dynamic subtest: D-eDP1 [181.376036] Dynamic subtest D-eDP1: SUCCESS (49.980s) [181.381548] Subtest flip-vs-panning-vs-hang: SUCCESS (101.288s) [182.524592] [005/133] (837s left) gem_ctx_persistence (legacy-engines-queued) [182.584807] Starting subtest: legacy-engines-queued [182.587234] Starting dynamic subtest: render [182.648763] Dynamic subtest render: SUCCESS (0.064s) [182.658833] Starting dynamic subtest: bsd1 [183.862476] Dynamic subtest bsd1: SUCCESS (1.210s) [183.871120] Starting dynamic subtest: bsd2 [185.844685] Dynamic subtest bsd2: SUCCESS (1.979s) [185.853019] Starting dynamic subtest: blt [185.906584] Dynamic subtest blt: SUCCESS (0.061s) [185.916583] Starting dynamic subtest: vebox [187.945444] Dynamic subtest vebox: SUCCESS (1.983s) [187.947917] Subtest legacy-engines-queued: SUCCESS (5.307s) [188.019694] [006/133] (831s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [188.124809] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu [188.129458] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [188.228881] [007/133] (831s left) gem_pxp (verify-pxp-stale-buf-optout-execution) [188.367629] Starting subtest: verify-pxp-stale-buf-optout-execution [189.426470] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.059s) [189.556938] [008/133] (830s left) gem_softpin (allocator-nopin) [189.618079] Starting subtest: allocator-nopin [189.716555] Subtest allocator-nopin: SUCCESS (0.098s) [189.836632] [009/133] (830s left) gem_ccs (suspend-resume) [189.888892] Starting subtest: suspend-resume [189.892998] Subtest suspend-resume: SKIP (0.000s) [189.996455] [010/133] (830s left) sysfs_timeslice_duration (duration) [190.055100] Starting subtest: duration [190.057445] Starting dynamic subtest: vecs0 [203.830220] Dynamic subtest vecs0: SUCCESS (13.773s) [203.840325] Starting dynamic subtest: ccs0 [216.970937] Dynamic subtest ccs0: SUCCESS (13.140s) [216.981915] Starting dynamic subtest: vcs0 [231.796984] Dynamic subtest vcs0: SUCCESS (14.822s) [231.807106] Starting dynamic subtest: bcs0 [244.955427] Dynamic subtest bcs0: SUCCESS (13.148s) [244.964911] Starting dynamic subtest: rcs0 [258.104304] Dynamic subtest rcs0: SUCCESS (13.156s) [258.118855] Starting dynamic subtest: vcs1 [271.794286] Dynamic subtest vcs1: SUCCESS (13.687s) [271.796850] Subtest duration: SUCCESS (81.735s) [271.876973] [011/133] (748s left) kms_psr (fbc-psr-cursor-mmap-gtt) [271.975898] Starting subtest: fbc-psr-cursor-mmap-gtt [271.978218] Starting dynamic subtest: eDP-1 [271.982346] Dynamic subtest eDP-1: SKIP (0.000s) [271.986523] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.000s) [272.048378] [012/133] (748s left) kms_busy (extended-pageflip-hang-oldfb) [272.148037] Starting subtest: extended-pageflip-hang-oldfb [272.150312] Starting dynamic subtest: pipe-A [272.582966] Dynamic subtest pipe-A: SUCCESS (0.435s) [272.590563] Starting dynamic subtest: pipe-D [273.739542] Dynamic subtest pipe-D: SUCCESS (1.155s) [273.741888] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.594s) [274.575462] [013/133] (745s left) gem_exec_fence (submit67) [274.747250] Starting subtest: submit67 [274.751802] Subtest submit67: SKIP (0.000s) [276.936651] [FACT gem_exec_fence (submit67)] new: kernel.kmod_is_loaded.vgem: true [276.940316] [014/133] (743s left) kms_big_fb (4-tiled-16bpp-rotate-0) [277.037939] Starting subtest: 4-tiled-16bpp-rotate-0 [278.360653] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.323s) [278.485837] [015/133] (741s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [278.588450] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu [278.592148] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [278.672618] [016/133] (741s left) gem_exec_reloc (basic-gtt-wc-noreloc) [278.739031] Subtest basic-gtt-wc-noreloc: SKIP (0.000s) [278.811798] [017/133] (741s left) syncobj_timeline (signal-point-0) [278.860050] Starting subtest: signal-point-0 [278.861838] Subtest signal-point-0: SUCCESS (0.000s) [278.951766] [018/133] (741s left) kms_cursor_legacy (cursor-vs-flip-legacy) [279.072199] Starting subtest: cursor-vs-flip-legacy [308.430216] Subtest cursor-vs-flip-legacy: SUCCESS (29.355s) [309.316660] [019/133] (711s left) kms_chamelium_hpd (dp-hpd-for-each-pipe) [309.711299] Subtest dp-hpd-for-each-pipe: SKIP (0.000s) [310.522121] [020/133] (710s left) gem_workarounds (basic-read) [310.584560] Starting subtest: basic-read [310.594785] Subtest basic-read: SUCCESS (0.010s) [310.722961] [021/133] (709s left) perf (oa-formats) [310.832519] Starting subtest: oa-formats [310.834949] Starting dynamic subtest: 0-rcs0 [310.845325] Dynamic subtest 0-rcs0: SUCCESS (0.013s) [310.854284] Starting dynamic subtest: 1-vcs0 [310.867089] Dynamic subtest 1-vcs0: SUCCESS (0.021s) [310.869365] Subtest oa-formats: SUCCESS (0.035s) [310.907725] [022/133] (709s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25) [310.999058] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25 [311.001430] Starting dynamic subtest: pipe-A [311.063625] Dynamic subtest pipe-A: SUCCESS (0.064s) [311.072597] Starting dynamic subtest: pipe-B [312.176650] Dynamic subtest pipe-B: SUCCESS (1.112s) [312.186658] Starting dynamic subtest: pipe-C [313.282722] Dynamic subtest pipe-C: SUCCESS (1.106s) [313.291942] Starting dynamic subtest: pipe-D [314.409573] Dynamic subtest pipe-D: SUCCESS (1.126s) [314.412094] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.410s) [315.574050] [023/133] (705s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite) [315.666581] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite [322.501779] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.839s) [322.614317] [024/133] (698s left) syncobj_timeline (invalid-transfer-non-existent-point) [322.673534] Starting subtest: invalid-transfer-non-existent-point [322.675884] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s) [322.788456] [025/133] (697s left) syncobj_wait (wait-for-submit-complex) [322.851270] Starting subtest: wait-for-submit-complex [322.912272] Subtest wait-for-submit-complex: SUCCESS (0.062s) [323.005112] [026/133] (697s left) syncobj_timeline (multi-wait-available-submitted-signaled) [323.065084] Starting subtest: multi-wait-available-submitted-signaled [323.067416] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s) [323.161623] [027/133] (697s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4) [323.266552] Starting subtest: plane-lut1d-pre-ctm3x4 [323.417827] Starting dynamic subtest: pipe-A-plane-0 [323.721508] Dynamic subtest pipe-A-plane-0: FAIL (0.158s) [323.730616] Starting dynamic subtest: pipe-A-plane-1 [323.919066] Dynamic subtest pipe-A-plane-1: FAIL (0.171s) [323.925885] Starting dynamic subtest: pipe-A-plane-2 [324.128765] Dynamic subtest pipe-A-plane-2: FAIL (0.178s) [325.099402] Starting dynamic subtest: pipe-B-plane-0 [325.524596] Dynamic subtest pipe-B-plane-0: FAIL (0.156s) [325.532674] Starting dynamic subtest: pipe-B-plane-1 [325.834622] Dynamic subtest pipe-B-plane-1: FAIL (0.162s) [325.843620] Starting dynamic subtest: pipe-B-plane-2 [326.134624] Dynamic subtest pipe-B-plane-2: FAIL (0.166s) [326.804079] Starting dynamic subtest: pipe-C-plane-0 [327.306211] Dynamic subtest pipe-C-plane-0: FAIL (0.151s) [327.314396] Starting dynamic subtest: pipe-C-plane-1 [327.703734] Dynamic subtest pipe-C-plane-1: FAIL (0.598s) [327.711305] Starting dynamic subtest: pipe-C-plane-2 [328.086224] Dynamic subtest pipe-C-plane-2: FAIL (0.188s) [328.967274] Starting dynamic subtest: pipe-D-plane-0 [329.569021] Dynamic subtest pipe-D-plane-0: FAIL (0.162s) [329.577333] Starting dynamic subtest: pipe-D-plane-1 [330.026832] Dynamic subtest pipe-D-plane-1: FAIL (0.619s) [330.035798] Starting dynamic subtest: pipe-D-plane-2 [330.481054] Dynamic subtest pipe-D-plane-2: FAIL (0.555s) [330.600950] Subtest plane-lut1d-pre-ctm3x4: FAIL (7.334s) [331.411341] [028/133] (689s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt) [331.514403] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt [336.004780] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.494s) [337.220786] [029/133] (683s left) gem_mmap (big-bo) [337.276647] Subtest big-bo: SKIP (0.000s) [337.333174] [030/133] (683s left) syncobj_eventfd (invalid-bad-pad) [337.392822] Starting subtest: invalid-bad-pad [337.395161] Subtest invalid-bad-pad: SUCCESS (0.000s) [337.508591] [031/133] (683s left) kms_lease (lease-unleased-crtc) [337.603204] Starting subtest: lease-unleased-crtc [337.605471] Starting dynamic subtest: pipe-A-eDP-1 [337.897095] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s) [337.905876] Starting dynamic subtest: pipe-B-eDP-1 [338.654728] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.755s) [338.663528] Starting dynamic subtest: pipe-C-eDP-1 [338.665912] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s) [338.673283] Starting dynamic subtest: pipe-D-eDP-1 [338.675433] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s) [338.677664] Subtest lease-unleased-crtc: SUCCESS (1.061s) [339.049115] [032/133] (681s left) i915_pm_rpm (gem-execbuf) [341.075061] Starting subtest: gem-execbuf [341.077340] Starting dynamic subtest: smem0 [342.792788] Dynamic subtest smem0: SUCCESS (1.720s) [342.795042] Subtest gem-execbuf: SUCCESS (1.720s) [342.900893] [033/133] (678s left) kms_cursor_crc (cursor-rapid-movement-max-size) [343.221740] Starting subtest: cursor-rapid-movement-max-size [343.228291] Subtest cursor-rapid-movement-max-size: SKIP (0.000s) [343.353201] [034/133] (677s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats) [343.458117] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats [343.460378] Starting dynamic subtest: pipe-A [343.591015] Dynamic subtest pipe-A: SKIP (0.129s) [343.599339] Starting dynamic subtest: pipe-B [344.814641] Dynamic subtest pipe-B: SKIP (1.223s) [344.822854] Starting dynamic subtest: pipe-C [346.040152] Dynamic subtest pipe-C: SUCCESS (1.231s) [346.048421] Starting dynamic subtest: pipe-D [347.275285] Dynamic subtest pipe-D: SUCCESS (1.234s) [347.277472] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.820s) [348.473703] [035/133] (672s left) kms_vrr (max-min) [348.566774] Starting subtest: max-min [348.573513] Subtest max-min: SKIP (0.000s) [348.652220] [036/133] (672s left) gem_userptr_blits (vma-merge) [348.725479] Starting subtest: vma-merge [348.762736] Subtest vma-merge: SUCCESS (0.037s) [348.904213] [037/133] (672s left) syncobj_timeline (host-signal-ordered) [348.958143] Starting subtest: host-signal-ordered [348.960623] Subtest host-signal-ordered: SUCCESS (0.000s) [349.084171] [038/133] (672s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt) [349.197823] Starting subtest: psr-rgb565-draw-blt [356.206039] Subtest psr-rgb565-draw-blt: SUCCESS (7.011s) [356.339900] [039/133] (665s left) gen9_exec_parse (bb-start-param) [356.409364] Subtest bb-start-param: SKIP (0.000s) [356.472982] [040/133] (664s left) kms_psr (psr2-cursor-mmap-cpu) [356.558592] Starting subtest: psr2-cursor-mmap-cpu [356.560881] Starting dynamic subtest: eDP-1 [358.290264] Dynamic subtest eDP-1: SUCCESS (1.731s) [358.292587] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.733s) [359.093962] [041/133] (662s left) core_setmaster (master-drop-set-user) [359.188464] Starting subtest: master-drop-set-user [359.200677] Subtest master-drop-set-user: SUCCESS (0.015s) [359.237270] [042/133] (662s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf) [359.323576] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf [359.325836] Starting dynamic subtest: pipe-A-eDP-1 [359.421968] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s) [359.432645] Starting dynamic subtest: pipe-B-eDP-1 [360.570431] Dynamic subtest pipe-B-eDP-1: SKIP (1.145s) [360.574872] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.247s) [361.853017] [043/133] (659s left) gem_mmap_gtt (basic-copy) [361.900741] Subtest basic-copy: SKIP (0.000s) [361.968841] [044/133] (659s left) kms_vrr (flip-dpms) [362.053712] Starting subtest: flip-dpms [362.060139] Subtest flip-dpms: SKIP (0.000s) [362.124397] [045/133] (659s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle) [362.232067] Starting subtest: short-busy-flip-before-cursor-toggle [362.236470] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s) [362.374918] [046/133] (659s left) kms_flip (2x-wf_vblank-ts-check-interruptible) [362.469766] Starting subtest: 2x-wf_vblank-ts-check-interruptible [362.480837] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.010s) [362.557943] [047/133] (659s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping) [362.641269] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping [362.645239] Subtest pixel-format-yf-tiled-modifier-source-clamping: SKIP (0.000s) [362.723100] [048/133] (658s left) i915_module_load (reload-no-display) [362.761427] Starting subtest: reload-no-display [368.511051] Subtest reload-no-display: SUCCESS (5.752s) [368.542565] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [368.543285] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true [368.546737] [049/133] (653s left) i915_pm_rps (thresholds-park) [370.092824] Starting subtest: thresholds-park [370.097850] Subtest thresholds-park: SKIP (0.002s) [370.139132] [FACT i915_pm_rps (thresholds-park)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [370.140508] [FACT i915_pm_rps (thresholds-park)] new: kernel.kmod_is_loaded.i915: true [370.144716] [050/133] (651s left) kms_psr_stress_test (flip-primary-invalidate-overlay) [370.243585] Starting subtest: flip-primary-invalidate-overlay [381.839078] Subtest flip-primary-invalidate-overlay: SUCCESS (11.597s) [381.967102] [051/133] (639s left) kms_big_fb (4-tiled-8bpp-rotate-270) [382.075736] Starting subtest: 4-tiled-8bpp-rotate-270 [382.096489] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.020s) [382.201656] [052/133] (639s left) gem_gpgpu_fill (basic) [382.254527] Starting subtest: basic [382.256491] Starting dynamic subtest: smem [382.258332] Dynamic subtest smem: SUCCESS (0.006s) [382.260456] Subtest basic: SUCCESS (0.007s) [382.393633] [053/133] (639s left) kms_sequence (queue-busy) [382.483199] Starting subtest: queue-busy [382.485401] Starting dynamic subtest: pipe-A-eDP-1 [384.424337] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.940s) [384.431993] Starting dynamic subtest: pipe-B-eDP-1 [387.015404] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.592s) [387.023771] Starting dynamic subtest: pipe-C-eDP-1 [389.637291] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.618s) [389.645706] Starting dynamic subtest: pipe-D-eDP-1 [392.254822] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.617s) [392.257068] Subtest queue-busy: SUCCESS (9.773s) [393.052067] [054/133] (628s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt) [393.158497] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt [393.162580] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [393.254170] [055/133] (628s left) syncobj_wait (invalid-signal-illegal-handle) [393.318623] Starting subtest: invalid-signal-illegal-handle [393.320963] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [393.424346] [056/133] (628s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt) [393.536604] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt [393.540882] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [393.624416] [057/133] (628s left) gem_mmap_wc (read-write-distinct) [393.682577] Subtest read-write-distinct: SKIP (0.000s) [393.750595] [058/133] (628s left) prime_vgem (shrink) [393.828931] Starting subtest: shrink [393.853252] Subtest shrink: SUCCESS (0.021s) [393.960410] [059/133] (628s left) api_intel_bb (blit-noreloc-keep-cache) [394.019500] Starting subtest: blit-noreloc-keep-cache [394.029533] Subtest blit-noreloc-keep-cache: SUCCESS (0.012s) [394.146449] [060/133] (628s left) vgem_basic (mmap) [394.181197] Starting subtest: mmap [394.203929] Subtest mmap: SUCCESS (0.026s) [394.255143] [061/133] (627s left) perf (invalid-oa-metric-set-id) [394.365615] Starting subtest: invalid-oa-metric-set-id [394.377891] Subtest invalid-oa-metric-set-id: SUCCESS (0.012s) [394.421580] [062/133] (627s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs) [394.505039] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs [394.506978] Starting dynamic subtest: pipe-A-eDP-1 [394.527556] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [394.537136] Starting dynamic subtest: pipe-B-eDP-1 [394.555066] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [394.561737] Starting dynamic subtest: pipe-C-eDP-1 [394.579637] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [394.586294] Starting dynamic subtest: pipe-D-eDP-1 [394.604337] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [394.607861] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.007s) [396.807298] [063/133] (625s left) kms_big_fb (linear-16bpp-rotate-270) [396.908245] Starting subtest: linear-16bpp-rotate-270 [396.932679] Subtest linear-16bpp-rotate-270: SKIP (0.021s) [397.045378] [064/133] (625s left) kms_flip (2x-absolute-wf_vblank) [397.140469] Starting subtest: 2x-absolute-wf_vblank [397.149685] Subtest 2x-absolute-wf_vblank: SKIP (0.010s) [397.228420] [065/133] (625s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu) [397.317276] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu [401.560940] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.246s) [402.709015] [066/133] (619s left) gem_exec_whisper (basic-forked) [402.772959] Starting subtest: basic-forked [410.198805] Subtest basic-forked: SUCCESS (7.425s) [410.392634] [067/133] (612s left) kms_chamelium_audio (dp-audio-edid) [410.773408] Subtest dp-audio-edid: SKIP (0.000s) [411.586635] [068/133] (610s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling) [411.676613] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling [411.678866] Starting dynamic subtest: pipe-A-default-mode [414.468758] Dynamic subtest pipe-A-default-mode: SUCCESS (2.793s) [414.471116] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.795s) [415.294329] [069/133] (607s left) kms_plane_cursor (primary) [415.400069] Starting subtest: primary [415.404257] Starting dynamic subtest: pipe-A-eDP-1-size-64 [417.965527] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.566s) [417.988146] Starting dynamic subtest: pipe-A-eDP-1-size-128 [420.557468] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.573s) [420.578210] Starting dynamic subtest: pipe-A-eDP-1-size-256 [423.132971] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.560s) [423.448899] Starting dynamic subtest: pipe-B-eDP-1-size-64 [426.682549] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.244s) [426.712452] Starting dynamic subtest: pipe-B-eDP-1-size-128 [429.317377] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.616s) [429.341753] Starting dynamic subtest: pipe-B-eDP-1-size-256 [431.885405] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.549s) [432.202076] Starting dynamic subtest: pipe-C-eDP-1-size-64 [435.160045] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.968s) [435.186236] Starting dynamic subtest: pipe-C-eDP-1-size-128 [437.360188] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.180s) [437.385870] Starting dynamic subtest: pipe-C-eDP-1-size-256 [439.660132] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.280s) [439.980840] Starting dynamic subtest: pipe-D-eDP-1-size-64 [442.882171] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.912s) [442.908875] Starting dynamic subtest: pipe-D-eDP-1-size-128 [445.115665] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.214s) [445.140196] Starting dynamic subtest: pipe-D-eDP-1-size-256 [447.337225] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.202s) [447.649213] Subtest primary: SUCCESS (32.249s) [448.458752] [070/133] (574s left) gen9_exec_parse (shadow-peek) [448.527945] Subtest shadow-peek: SKIP (0.000s) [448.590463] [071/133] (574s left) gem_mmap_gtt (close-race) [448.641486] Subtest close-race: SKIP (0.000s) [448.699601] [072/133] (573s left) gem_workarounds (reset-fd) [448.764853] Starting subtest: reset-fd [448.944677] Subtest reset-fd: SUCCESS (0.179s) [449.055112] [073/133] (573s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait) [449.142707] Starting subtest: plane-primary-toggle-with-vblank-wait [449.144987] Starting dynamic subtest: pipe-A-eDP-1 [449.315607] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.173s) [449.626240] Starting dynamic subtest: pipe-B-eDP-1 [450.546910] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.927s) [450.847392] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.705s) [451.702264] [074/133] (571s left) kms_fbcon_fbt (psr) [451.768153] Starting subtest: psr [459.097626] Subtest psr: SUCCESS (7.326s) [459.171970] [075/133] (563s left) kms_psr (fbc-pr-basic) [459.267230] Starting subtest: fbc-pr-basic [459.271251] Subtest fbc-pr-basic: SKIP (0.000s) [459.352301] [076/133] (563s left) kms_psr (pr-primary-blt) [459.458421] Starting subtest: pr-primary-blt [459.462461] Subtest pr-primary-blt: SKIP (0.000s) [459.543468] [077/133] (563s left) gem_exec_balancer (full-pulse) [459.609789] Starting subtest: full-pulse [464.748078] Subtest full-pulse: SUCCESS (5.137s) [465.059600] [078/133] (557s left) gem_exec_schedule (implicit-write-read) [465.130083] Starting subtest: implicit-write-read [465.132085] Starting dynamic subtest: rcs0 [465.300605] Dynamic subtest rcs0: SUCCESS (0.179s) [465.315357] Starting dynamic subtest: vcs0 [465.416521] Dynamic subtest vcs0: SUCCESS (0.114s) [465.428080] Starting dynamic subtest: vcs1 [465.536118] Dynamic subtest vcs1: SUCCESS (0.118s) [465.547813] Starting dynamic subtest: vecs0 [465.637878] Dynamic subtest vecs0: SUCCESS (0.101s) [465.649026] Starting dynamic subtest: ccs0 [465.775342] Dynamic subtest ccs0: SUCCESS (0.135s) [465.778055] Subtest implicit-write-read: SUCCESS (0.655s) [466.992581] [079/133] (555s left) kms_rotation_crc (sprite-rotation-90) [467.085791] Starting subtest: sprite-rotation-90 [467.090128] Subtest sprite-rotation-90: SKIP (0.001s) [467.167902] [080/133] (555s left) kms_feature_discovery (psr2) [467.260306] Starting subtest: psr2 [467.262201] Subtest psr2: SUCCESS (0.000s) [467.344872] [081/133] (555s left) gem_softpin (overlap) [467.404759] Starting subtest: overlap [468.304321] Subtest overlap: SUCCESS (0.899s) [468.413603] [082/133] (554s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [468.515094] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip [468.519557] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s) [468.613407] [083/133] (554s left) perf_pmu (event-wait) [468.652081] Starting subtest: event-wait [468.654417] Starting dynamic subtest: rcs0 [468.658776] Dynamic subtest rcs0: SKIP (0.000s) [468.662746] Subtest event-wait: SKIP (0.001s) [468.756604] [084/133] (554s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite) [468.858398] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite [468.862756] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [468.960464] [085/133] (554s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt) [469.057683] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt [469.061778] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [469.153732] [086/133] (554s left) kms_flip (2x-plain-flip-interruptible) [469.238440] Starting subtest: 2x-plain-flip-interruptible [469.249646] Subtest 2x-plain-flip-interruptible: SKIP (0.010s) [469.322638] [087/133] (553s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [469.407328] Starting subtest: addfb25-yf-tiled-legacy [469.409361] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [469.491765] [088/133] (553s left) api_intel_bb (reset-flags) [469.550851] Starting subtest: reset-flags [469.556466] Subtest reset-flags: SUCCESS (0.008s) [469.687873] [089/133] (553s left) gem_sync (basic-many-each) [469.753376] Starting subtest: basic-many-each [472.054412] Subtest basic-many-each: SUCCESS (2.308s) [472.240541] [090/133] (551s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area) [472.340925] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area [472.345311] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s) [472.410517] [091/133] (551s left) gem_exec_schedule (preempt-user) [472.501162] Starting subtest: preempt-user [472.503390] Starting dynamic subtest: rcs0 [472.519111] Dynamic subtest rcs0: SUCCESS (0.023s) [472.530500] Starting dynamic subtest: bcs0 [472.540830] Dynamic subtest bcs0: SUCCESS (0.021s) [472.550051] Starting dynamic subtest: vcs0 [472.563848] Dynamic subtest vcs0: SUCCESS (0.022s) [472.572417] Starting dynamic subtest: vcs1 [472.584384] Dynamic subtest vcs1: SUCCESS (0.020s) [472.592864] Starting dynamic subtest: vecs0 [472.604801] Dynamic subtest vecs0: SUCCESS (0.019s) [472.613443] Starting dynamic subtest: ccs0 [472.629229] Dynamic subtest ccs0: SUCCESS (0.023s) [472.631717] Subtest preempt-user: SUCCESS (0.134s) [473.971122] [092/133] (549s left) gem_busy (semaphore) [474.155195] Subtest semaphore: SKIP (0.000s) [474.379682] [093/133] (549s left) kms_pm_rpm (legacy-planes-dpms) [476.097961] Starting subtest: legacy-planes-dpms [476.100523] Starting dynamic subtest: plane-64 [484.420554] Dynamic subtest plane-64: SUCCESS (8.321s) [484.434399] Starting dynamic subtest: plane-94 [492.770834] Dynamic subtest plane-94: SUCCESS (8.345s) [492.784541] Starting dynamic subtest: plane-124 [501.076046] Dynamic subtest plane-124: SUCCESS (8.303s) [501.086650] Starting dynamic subtest: plane-134 [509.806201] Dynamic subtest plane-134: SUCCESS (8.726s) [509.809049] Subtest legacy-planes-dpms: SUCCESS (33.708s) [510.188899] [094/133] (513s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling) [510.280773] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling [510.285083] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s) [510.356036] [095/133] (513s left) kms_rotation_crc (primary-x-tiled-reflect-x-0) [510.438277] Starting subtest: primary-x-tiled-reflect-x-0 [517.507818] Subtest primary-x-tiled-reflect-x-0: SUCCESS (7.070s) [518.748702] [096/133] (504s left) kms_hdr (bpc-switch-dpms) [518.844134] Starting subtest: bpc-switch-dpms [519.918117] Starting dynamic subtest: pipe-A-eDP-1 [524.436148] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.517s) [524.438451] Subtest bpc-switch-dpms: SUCCESS (5.594s) [524.537414] [097/133] (499s left) gem_mmap_wc (bad-object) [524.598373] Subtest bad-object: SKIP (0.000s) [524.656293] [098/133] (499s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs) [524.738455] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs [524.740729] Starting dynamic subtest: pipe-A-eDP-1 [524.762944] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [524.772312] Starting dynamic subtest: pipe-B-eDP-1 [524.794038] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [524.802275] Starting dynamic subtest: pipe-C-eDP-1 [524.823627] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [524.831619] Starting dynamic subtest: pipe-D-eDP-1 [524.856083] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [524.860101] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.006s) [527.050883] [099/133] (496s left) prime_mmap (test_forked) [527.104435] Starting subtest: test_forked [527.106721] Starting dynamic subtest: test_forked-smem [527.139519] Dynamic subtest test_forked-smem: SUCCESS (0.037s) [527.141984] Subtest test_forked: SUCCESS (0.038s) [527.240216] [100/133] (496s left) kms_cursor_legacy (cursorb-vs-flipa-legacy) [527.347039] Starting subtest: cursorB-vs-flipA-legacy [527.351352] Subtest cursorB-vs-flipA-legacy: SKIP (0.003s) [527.494353] [101/133] (496s left) kms_joiner (basic-big-joiner) [527.599690] Starting subtest: basic-big-joiner [527.603919] Subtest basic-big-joiner: SKIP (0.000s) [527.668459] [102/133] (496s left) syncobj_basic (test-valid-cycle) [527.718062] Starting subtest: test-valid-cycle [527.720478] Subtest test-valid-cycle: SUCCESS (0.000s) [527.820445] [103/133] (496s left) kms_force_connector_basic (force-edid) [527.892192] Starting subtest: force-edid [528.258955] Subtest force-edid: SUCCESS (0.367s) [528.410302] [104/133] (495s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs) [528.506997] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs [528.508826] Starting dynamic subtest: pipe-A-eDP-1 [528.527017] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [528.535592] Starting dynamic subtest: pipe-B-eDP-1 [528.552546] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [528.560511] Starting dynamic subtest: pipe-C-eDP-1 [528.577480] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [528.585313] Starting dynamic subtest: pipe-D-eDP-1 [528.602494] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [528.605909] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.006s) [530.786513] [105/133] (493s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs) [530.870418] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs [530.872771] Starting dynamic subtest: pipe-A-eDP-1 [530.893050] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [530.902196] Starting dynamic subtest: pipe-B-eDP-1 [530.921606] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [530.930203] Starting dynamic subtest: pipe-C-eDP-1 [530.949465] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [530.957701] Starting dynamic subtest: pipe-D-eDP-1 [530.979193] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [530.981534] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.005s) [533.072111] [106/133] (490s left) kms_cursor_crc (cursor-offscreen-64x64) [533.241048] Starting subtest: cursor-offscreen-64x64 [533.245975] Starting dynamic subtest: pipe-A-eDP-1 [535.190877] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.946s) [535.220442] Starting dynamic subtest: pipe-D-eDP-1 [537.755058] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.540s) [537.757088] Subtest cursor-offscreen-64x64: SUCCESS (4.511s) [538.573605] [107/133] (485s left) kms_big_fb (y-tiled-16bpp-rotate-180) [538.674735] Starting subtest: y-tiled-16bpp-rotate-180 [538.679149] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s) [538.790987] [108/133] (485s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt) [538.891505] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt [538.895888] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [538.987798] [109/133] (485s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu) [539.078436] Starting subtest: fbc-rgb101010-draw-mmap-cpu [543.622966] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.544s) [544.792538] [110/133] (479s left) perf (short-reads) [544.888402] Starting subtest: short-reads [544.900620] Subtest short-reads: SUCCESS (0.015s) [544.954626] [111/133] (479s left) kms_cursor_crc (cursor-tearing-framebuffer-change) [545.064362] Starting subtest: cursor-tearing-framebuffer-change [545.066641] Starting dynamic subtest: pipe-A-eDP-1 [545.622412] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.556s) [545.632613] Starting dynamic subtest: pipe-D-eDP-1 [546.860356] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.234s) [546.862336] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.793s) [547.664610] [112/133] (476s left) gem_exec_reloc (basic-wc-gtt-active) [547.738307] Subtest basic-wc-gtt-active: SKIP (0.000s) [547.815332] [113/133] (476s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled) [547.862244] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled [547.866300] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s) [548.062310] [114/133] (476s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180) [548.161406] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180 [549.161585] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.000s) [549.288584] [115/133] (475s left) kms_plane_alpha_blend (constant-alpha-max) [549.375351] Starting subtest: constant-alpha-max [549.658071] Starting dynamic subtest: pipe-A-eDP-1 [550.721164] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.062s) [550.731059] Starting dynamic subtest: pipe-D-eDP-1 [552.337638] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.615s) [552.339987] Subtest constant-alpha-max: SUCCESS (2.964s) [553.206030] [116/133] (471s left) kms_psr (fbc-psr2-cursor-render) [553.302672] Starting subtest: fbc-psr2-cursor-render [553.305038] Starting dynamic subtest: eDP-1 [553.309628] Dynamic subtest eDP-1: SKIP (0.000s) [553.314254] Subtest fbc-psr2-cursor-render: SKIP (0.001s) [553.390183] [117/133] (471s left) kms_chamelium_edid (dp-edid-resolution-list) [553.776200] Subtest dp-edid-resolution-list: SKIP (0.000s) [554.559658] [118/133] (469s left) gem_eio (wait-wedge-1us) [554.807276] Starting subtest: wait-wedge-1us [555.935391] Subtest wait-wedge-1us: SUCCESS (1.127s) [556.100279] [119/133] (468s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic) [556.216519] Starting subtest: flip-vs-cursor-busy-crc-atomic [557.045923] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.831s) [557.892289] [120/133] (466s left) gem_ctx_shared (q-promotion) [557.958407] Starting subtest: Q-promotion [557.960899] Starting dynamic subtest: rcs0 [558.088096] Dynamic subtest rcs0: SUCCESS (0.127s) [558.100297] Starting dynamic subtest: vcs0 [558.186183] Dynamic subtest vcs0: SUCCESS (0.099s) [558.204908] Starting dynamic subtest: vcs1 [558.277070] Dynamic subtest vcs1: SUCCESS (0.089s) [558.289480] Starting dynamic subtest: vecs0 [558.369528] Dynamic subtest vecs0: SUCCESS (0.090s) [558.389759] Starting dynamic subtest: ccs0 [558.469718] Dynamic subtest ccs0: SUCCESS (0.096s) [558.472871] Subtest Q-promotion: SUCCESS (0.510s) [559.997241] [121/133] (464s left) kms_pm_lpsp (kms-lpsp) [561.115073] Starting subtest: kms-lpsp [561.117370] Starting dynamic subtest: pipe-A-eDP-1 [561.260616] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.148s) [561.562060] Subtest kms-lpsp: SUCCESS (0.450s) [562.377892] [122/133] (462s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt) [562.472701] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt [569.092074] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.622s) [569.250953] [123/133] (455s left) gem_exec_fence (basic-wait) [569.423181] Starting subtest: basic-wait [569.425631] Starting dynamic subtest: rcs0 [569.500345] Dynamic subtest rcs0: SUCCESS (0.077s) [569.511660] Starting dynamic subtest: bcs0 [569.559610] Dynamic subtest bcs0: SUCCESS (0.057s) [569.571944] Starting dynamic subtest: vcs0 [569.616460] Dynamic subtest vcs0: SUCCESS (0.055s) [569.632511] Starting dynamic subtest: vcs1 [569.684283] Dynamic subtest vcs1: SUCCESS (0.066s) [569.696461] Starting dynamic subtest: vecs0 [569.736565] Dynamic subtest vecs0: SUCCESS (0.050s) [569.747782] Starting dynamic subtest: ccs0 [569.788697] Dynamic subtest ccs0: SUCCESS (0.050s) [569.791254] Subtest basic-wait: SUCCESS (0.367s) [572.023271] [124/133] (452s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt) [572.123679] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt [572.128153] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [572.243585] [125/133] (452s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt) [572.339687] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt [572.343984] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [572.439979] [126/133] (452s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt) [572.535264] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt [572.539166] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [572.643380] [127/133] (452s left) gem_workarounds (suspend-resume) [572.719374] Starting subtest: suspend-resume [588.953557] Subtest suspend-resume: SUCCESS (2.086s) [590.083684] [128/133] (435s left) gem_ctx_isolation (preservation-s3) [590.151593] Starting subtest: preservation-S3 [590.154084] Starting dynamic subtest: rcs0 [606.005810] Dynamic subtest rcs0: SUCCESS (1.283s) [606.016516] Starting dynamic subtest: bcs0 [622.012350] Dynamic subtest bcs0: SUCCESS (1.350s) [622.028068] Starting dynamic subtest: vcs0 [638.014513] Dynamic subtest vcs0: SUCCESS (2.290s) [638.024891] Starting dynamic subtest: vcs1 [656.009659] Dynamic subtest vcs1: SUCCESS (4.901s) [656.019998] Starting dynamic subtest: vecs0 [673.991842] Dynamic subtest vecs0: SUCCESS (4.911s) [674.003750] Starting dynamic subtest: ccs0 [692.006632] Dynamic subtest ccs0: SUCCESS (3.136s) [692.008966] Subtest preservation-S3: SUCCESS (17.877s) [692.258247] [129/133] (333s left) kms_flip (nonexisting-fb-interruptible) [692.356360] Starting subtest: nonexisting-fb-interruptible [692.358553] Starting dynamic subtest: A-eDP1 [693.572071] Dynamic subtest A-eDP1: SUCCESS (1.188s) [693.585640] Starting dynamic subtest: B-eDP1 [694.697056] Dynamic subtest B-eDP1: SUCCESS (1.101s) [694.707560] Starting dynamic subtest: C-eDP1 [695.822826] Dynamic subtest C-eDP1: SUCCESS (1.107s) [695.836101] Starting dynamic subtest: D-eDP1 [696.931876] Dynamic subtest D-eDP1: SUCCESS (1.091s) [696.937921] Subtest nonexisting-fb-interruptible: SUCCESS (4.499s) [698.094568] [130/133] (328s left) gem_mmap_offset (close-race) [698.157064] Starting subtest: close-race [718.318884] Subtest close-race: SUCCESS (20.024s) [718.399408] [131/133] (307s left) gem_exec_fence (syncobj-timeline-wait) [718.987888] Starting subtest: syncobj-timeline-wait [720.726473] Subtest syncobj-timeline-wait: SUCCESS (1.737s) [722.762984] [132/133] (303s left) kms_big_fb (x-tiled-addfb) [722.868372] Starting subtest: x-tiled-addfb [722.870694] Subtest x-tiled-addfb: SUCCESS (0.000s) [722.969470] [133/133] (303s left) kms_addfb_basic (unused-offsets) [723.034389] Starting subtest: unused-offsets [723.036323] Subtest unused-offsets: SUCCESS (0.000s) [723.166259] Closing watchdogs results: parsing output: 0/ for test: kms_feature_discovery results: parsing output: 1/ for test: perf results: parsing output: 2/ for test: kms_content_protection results: parsing output: 3/ for test: kms_flip results: parsing output: 4/ for test: gem_ctx_persistence results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: gem_pxp results: parsing output: 7/ for test: gem_softpin results: parsing output: 8/ for test: gem_ccs results: parsing output: 9/ for test: sysfs_timeslice_duration results: parsing output: 10/ for test: kms_psr results: parsing output: 11/ for test: kms_busy results: parsing output: 12/ for test: gem_exec_fence results: parsing output: 13/ for test: kms_big_fb results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: gem_exec_reloc results: parsing output: 16/ for test: syncobj_timeline results: parsing output: 17/ for test: kms_cursor_legacy results: parsing output: 18/ for test: kms_chamelium_hpd results: parsing output: 19/ for test: gem_workarounds results: parsing output: 20/ for test: perf results: parsing output: 21/ for test: kms_plane_scaling results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: syncobj_timeline results: parsing output: 24/ for test: syncobj_wait results: parsing output: 25/ for test: syncobj_timeline results: parsing output: 26/ for test: kms_color_pipeline results: parsing output: 27/ for test: kms_frontbuffer_tracking results: parsing output: 28/ for test: gem_mmap results: parsing output: 29/ for test: syncobj_eventfd results: parsing output: 30/ for test: kms_lease results: parsing output: 31/ for test: i915_pm_rpm results: parsing output: 32/ for test: kms_cursor_crc results: parsing output: 33/ for test: kms_plane_scaling results: parsing output: 34/ for test: kms_vrr results: parsing output: 35/ for test: gem_userptr_blits results: parsing output: 36/ for test: syncobj_timeline results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: gen9_exec_parse results: parsing output: 39/ for test: kms_psr results: parsing output: 40/ for test: core_setmaster results: parsing output: 41/ for test: kms_psr2_sf results: parsing output: 42/ for test: gem_mmap_gtt results: parsing output: 43/ for test: kms_vrr results: parsing output: 44/ for test: kms_cursor_legacy results: parsing output: 45/ for test: kms_flip results: parsing output: 46/ for test: kms_plane results: parsing output: 47/ for test: i915_module_load results: parsing output: 48/ for test: i915_pm_rps results: parsing output: 49/ for test: kms_psr_stress_test results: parsing output: 50/ for test: kms_big_fb results: parsing output: 51/ for test: gem_gpgpu_fill results: parsing output: 52/ for test: kms_sequence results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: syncobj_wait results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: gem_mmap_wc results: parsing output: 57/ for test: prime_vgem results: parsing output: 58/ for test: api_intel_bb results: parsing output: 59/ for test: vgem_basic results: parsing output: 60/ for test: perf results: parsing output: 61/ for test: kms_ccs results: parsing output: 62/ for test: kms_big_fb results: parsing output: 63/ for test: kms_flip results: parsing output: 64/ for test: kms_frontbuffer_tracking results: parsing output: 65/ for test: gem_exec_whisper results: parsing output: 66/ for test: kms_chamelium_audio results: parsing output: 67/ for test: kms_flip_scaled_crc results: parsing output: 68/ for test: kms_plane_cursor results: parsing output: 69/ for test: gen9_exec_parse results: parsing output: 70/ for test: gem_mmap_gtt results: parsing output: 71/ for test: gem_workarounds results: parsing output: 72/ for test: kms_atomic_transition results: parsing output: 73/ for test: kms_fbcon_fbt results: parsing output: 74/ for test: kms_psr results: parsing output: 75/ for test: kms_psr results: parsing output: 76/ for test: gem_exec_balancer results: parsing output: 77/ for test: gem_exec_schedule results: parsing output: 78/ for test: kms_rotation_crc results: parsing output: 79/ for test: kms_feature_discovery results: parsing output: 80/ for test: gem_softpin results: parsing output: 81/ for test: kms_big_fb results: parsing output: 82/ for test: perf_pmu results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: kms_flip results: parsing output: 86/ for test: kms_addfb_basic results: parsing output: 87/ for test: api_intel_bb results: parsing output: 88/ for test: gem_sync results: parsing output: 89/ for test: kms_psr2_sf results: parsing output: 90/ for test: gem_exec_schedule results: parsing output: 91/ for test: gem_busy results: parsing output: 92/ for test: kms_pm_rpm results: parsing output: 93/ for test: kms_flip_scaled_crc results: parsing output: 94/ for test: kms_rotation_crc results: parsing output: 95/ for test: kms_hdr results: parsing output: 96/ for test: gem_mmap_wc results: parsing output: 97/ for test: kms_ccs results: parsing output: 98/ for test: prime_mmap results: parsing output: 99/ for test: kms_cursor_legacy results: parsing output: 100/ for test: kms_joiner results: parsing output: 101/ for test: syncobj_basic results: parsing output: 102/ for test: kms_force_connector_basic results: parsing output: 103/ for test: kms_ccs results: parsing output: 104/ for test: kms_ccs results: parsing output: 105/ for test: kms_cursor_crc results: parsing output: 106/ for test: kms_big_fb results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: perf results: parsing output: 110/ for test: kms_cursor_crc results: parsing output: 111/ for test: gem_exec_reloc results: parsing output: 112/ for test: gem_render_copy results: parsing output: 113/ for test: kms_big_fb results: parsing output: 114/ for test: kms_plane_alpha_blend results: parsing output: 115/ for test: kms_psr results: parsing output: 116/ for test: kms_chamelium_edid results: parsing output: 117/ for test: gem_eio results: parsing output: 118/ for test: kms_cursor_legacy results: parsing output: 119/ for test: gem_ctx_shared results: parsing output: 120/ for test: kms_pm_lpsp results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: gem_exec_fence results: parsing output: 123/ for test: kms_frontbuffer_tracking results: parsing output: 124/ for test: kms_frontbuffer_tracking results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: gem_workarounds results: parsing output: 127/ for test: gem_ctx_isolation results: parsing output: 128/ for test: kms_flip results: parsing output: 129/ for test: gem_mmap_offset results: parsing output: 130/ for test: gem_exec_fence results: parsing output: 131/ for test: kms_big_fb results: parsing output: 132/ for test: kms_addfb_basic Done.