[57.137997] Initializing watchdogs [57.138060] /dev/watchdog0 [57.153563] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [57.158193] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.161403] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.164733] [001/133] (960s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode) [57.578770] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s) [58.359968] [002/133] (959s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area) [58.471913] Starting subtest: psr2-overlay-primary-update-sf-dmg-area [58.474238] Starting dynamic subtest: pipe-A-eDP-1 [64.331632] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.817s) [64.341567] Starting dynamic subtest: pipe-B-eDP-1 [71.018270] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.661s) [71.020623] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.480s) [71.907834] [003/133] (945s left) fbdev (eof) [71.948765] Starting subtest: eof [71.951070] Subtest eof: SUCCESS (0.000s) [72.047315] [004/133] (945s left) kms_psr (psr2-primary-page-flip) [72.140220] Starting subtest: psr2-primary-page-flip [72.142505] Starting dynamic subtest: eDP-1 [73.908466] Dynamic subtest eDP-1: SUCCESS (1.766s) [73.910724] Subtest psr2-primary-page-flip: SUCCESS (1.767s) [74.774149] [005/133] (943s left) kms_flip (2x-flip-vs-panning-vs-hang) [74.867526] Starting subtest: 2x-flip-vs-panning-vs-hang [74.873632] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.002s) [75.006748] [006/133] (942s left) i915_pm_rpm (sysfs-read) [76.561758] Starting subtest: sysfs-read [77.731904] Subtest sysfs-read: SUCCESS (1.169s) [78.107304] [007/133] (939s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render) [78.197546] Starting subtest: psr-rgb101010-draw-render [85.589811] Subtest psr-rgb101010-draw-render: SUCCESS (7.391s) [85.698898] [008/133] (932s left) kms_big_fb (4-tiled-64bpp-rotate-180) [85.803141] Starting subtest: 4-tiled-64bpp-rotate-180 [87.372631] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.570s) [87.584337] [009/133] (930s left) gem_exec_reloc (basic-wc-gtt-active) [87.653067] Subtest basic-wc-gtt-active: SKIP (0.000s) [87.724563] [010/133] (930s left) kms_big_fb (yf-tiled-addfb) [87.835160] Starting subtest: yf-tiled-addfb [87.839332] Subtest yf-tiled-addfb: SKIP (0.000s) [87.928585] [011/133] (930s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers) [88.022863] Starting subtest: plane-upscale-20x20-with-modifiers [88.025190] Starting dynamic subtest: pipe-A [88.359097] Dynamic subtest pipe-A: SUCCESS (0.338s) [88.367618] Starting dynamic subtest: pipe-B [89.733091] Dynamic subtest pipe-B: SUCCESS (1.372s) [89.741589] Starting dynamic subtest: pipe-C [91.171594] Dynamic subtest pipe-C: SUCCESS (1.437s) [91.181488] Starting dynamic subtest: pipe-D [92.603483] Dynamic subtest pipe-D: SUCCESS (1.431s) [92.605815] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.581s) [93.785882] [012/133] (924s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu) [93.897012] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu [97.478528] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.585s) [98.677014] [013/133] (919s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render) [98.773017] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render [105.586885] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.815s) [105.757784] [014/133] (912s left) perf (sysctl-defaults) [105.830249] Starting subtest: sysctl-defaults [105.832635] Subtest sysctl-defaults: SUCCESS (0.000s) [105.929757] [015/133] (912s left) gem_exec_balancer (fairslice) [105.987979] Starting subtest: fairslice [108.893230] Subtest fairslice: SUCCESS (2.902s) [109.197801] [016/133] (909s left) kms_flip (wf_vblank-ts-check-interruptible) [109.286961] Starting subtest: wf_vblank-ts-check-interruptible [109.289188] Starting dynamic subtest: A-eDP1 [118.268094] Dynamic subtest A-eDP1: SUCCESS (8.945s) [118.280084] Starting dynamic subtest: B-eDP1 [127.204869] Dynamic subtest B-eDP1: SUCCESS (8.937s) [127.216025] Starting dynamic subtest: C-eDP1 [136.130864] Dynamic subtest C-eDP1: SUCCESS (8.910s) [136.143028] Starting dynamic subtest: D-eDP1 [145.064650] Dynamic subtest D-eDP1: SUCCESS (8.929s) [145.067163] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.734s) [146.250305] [017/133] (872s left) kms_big_fb (x-tiled-32bpp-rotate-90) [146.345507] Starting subtest: x-tiled-32bpp-rotate-90 [146.365721] Subtest x-tiled-32bpp-rotate-90: SKIP (0.019s) [146.467609] [018/133] (871s left) gem_mmap_gtt (hang-user) [146.514045] Subtest hang-user: SKIP (0.000s) [146.568241] [019/133] (871s left) kms_cursor_crc (cursor-onscreen-64x21) [146.758881] Starting subtest: cursor-onscreen-64x21 [146.824940] Subtest cursor-onscreen-64x21: SKIP (0.063s) [147.068562] [020/133] (871s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180) [147.164068] Starting subtest: primary-yf-tiled-reflect-x-180 [147.223097] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.059s) [147.322273] [021/133] (871s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [147.414794] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip [148.172330] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.759s) [148.325796] [022/133] (870s left) kms_async_flips (alternate-sync-async-flip) [148.423611] Starting subtest: alternate-sync-async-flip [148.806446] Starting dynamic subtest: pipe-A-eDP-1 [151.558967] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.754s) [151.950371] Starting dynamic subtest: pipe-B-eDP-1 [154.697093] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.755s) [155.078066] Starting dynamic subtest: pipe-C-eDP-1 [157.819151] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.749s) [158.185552] Starting dynamic subtest: pipe-D-eDP-1 [160.947120] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.768s) [160.949203] Subtest alternate-sync-async-flip: SUCCESS (12.528s) [162.111278] [023/133] (856s left) i915_hangman (engine-error-state-capture) [162.179294] Starting subtest: engine-error-state-capture [162.181592] Starting dynamic subtest: rcs0 [165.319515] Dynamic subtest rcs0: SUCCESS (3.139s) [165.331033] Starting dynamic subtest: bcs0 [171.332947] Dynamic subtest bcs0: SUCCESS (6.012s) [171.343573] Starting dynamic subtest: vcs0 [177.284403] Dynamic subtest vcs0: SUCCESS (5.948s) [177.295137] Starting dynamic subtest: vcs1 [183.300527] Dynamic subtest vcs1: SUCCESS (6.013s) [183.311860] Starting dynamic subtest: vecs0 [189.318531] Dynamic subtest vecs0: SUCCESS (6.015s) [189.329862] Starting dynamic subtest: ccs0 [195.333072] Dynamic subtest ccs0: SUCCESS (6.012s) [195.336025] Subtest engine-error-state-capture: SUCCESS (33.155s) [195.450975] [024/133] (823s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render) [195.575496] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render [195.579905] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [195.662088] [025/133] (822s left) prime_self_import (basic-with_two_bos) [195.706325] Starting subtest: basic-with_two_bos [195.718949] Subtest basic-with_two_bos: SUCCESS (0.014s) [195.814223] [026/133] (822s left) kms_psr (fbc-psr2-cursor-blt) [195.898299] Starting subtest: fbc-psr2-cursor-blt [195.900495] Starting dynamic subtest: eDP-1 [195.904582] Dynamic subtest eDP-1: SKIP (0.000s) [195.908693] Subtest fbc-psr2-cursor-blt: SKIP (0.001s) [195.972547] [027/133] (822s left) kms_big_fb (y-tiled-16bpp-rotate-90) [196.080305] Starting subtest: y-tiled-16bpp-rotate-90 [196.084843] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s) [196.167904] [028/133] (822s left) kms_plane_cursor (viewport) [196.268269] Starting subtest: viewport [196.272664] Starting dynamic subtest: pipe-A-eDP-1-size-64 [198.820552] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.553s) [198.878956] Starting dynamic subtest: pipe-A-eDP-1-size-128 [201.366125] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.494s) [201.425269] Starting dynamic subtest: pipe-A-eDP-1-size-256 [203.947209] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.527s) [204.303089] Starting dynamic subtest: pipe-B-eDP-1-size-64 [207.517794] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.224s) [207.576968] Starting dynamic subtest: pipe-B-eDP-1-size-128 [210.041058] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.472s) [210.100867] Starting dynamic subtest: pipe-B-eDP-1-size-256 [212.553962] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.460s) [212.904874] Starting dynamic subtest: pipe-C-eDP-1-size-64 [215.819168] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.923s) [215.855382] Starting dynamic subtest: pipe-C-eDP-1-size-128 [217.986295] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.136s) [218.022288] Starting dynamic subtest: pipe-C-eDP-1-size-256 [220.208242] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.192s) [220.537260] Starting dynamic subtest: pipe-D-eDP-1-size-64 [223.438937] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.911s) [223.476254] Starting dynamic subtest: pipe-D-eDP-1-size-128 [225.685966] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.216s) [225.721300] Starting dynamic subtest: pipe-D-eDP-1-size-256 [227.974140] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.260s) [228.301230] Subtest viewport: SUCCESS (32.033s) [229.135121] [029/133] (789s left) kms_busy (basic) [229.234487] Starting subtest: basic [229.236836] Starting dynamic subtest: flip [229.821759] Dynamic subtest flip: SUCCESS (0.586s) [229.830556] Starting dynamic subtest: modeset [233.271693] Dynamic subtest modeset: SUCCESS (3.450s) [233.274067] Subtest basic: SUCCESS (4.038s) [234.072328] [030/133] (784s left) gem_exec_fence (syncobj-timeline-signal) [234.671524] Starting subtest: syncobj-timeline-signal [234.677764] Subtest syncobj-timeline-signal: SUCCESS (0.008s) [236.401852] [FACT gem_exec_fence (syncobj-timeline-signal)] new: kernel.kmod_is_loaded.vgem: true [236.405225] [031/133] (782s left) kms_properties (crtc-properties-atomic) [236.499161] Starting subtest: crtc-properties-atomic [236.501446] Starting dynamic subtest: pipe-A-eDP-1 [236.939690] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.438s) [236.949412] Starting dynamic subtest: pipe-B-eDP-1 [238.145127] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.206s) [238.153960] Starting dynamic subtest: pipe-C-eDP-1 [239.271394] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.123s) [239.280172] Starting dynamic subtest: pipe-D-eDP-1 [240.421475] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.151s) [240.423827] Subtest crtc-properties-atomic: SUCCESS (3.926s) [241.214454] [032/133] (777s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf) [241.328779] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf [241.331068] Starting dynamic subtest: pipe-A-eDP-1 [241.425452] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s) [241.434150] Starting dynamic subtest: pipe-B-eDP-1 [242.581797] Dynamic subtest pipe-B-eDP-1: SKIP (1.153s) [242.586305] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.256s) [243.768941] [033/133] (775s left) kms_hdr (bpc-switch-dpms) [243.865066] Starting subtest: bpc-switch-dpms [244.945362] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010 [249.372443] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SUCCESS (4.427s) [250.414024] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F [254.845718] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SUCCESS (4.438s) [254.848058] Subtest bpc-switch-dpms: SUCCESS (10.983s) [254.970965] [034/133] (764s left) kms_cursor_crc (cursor-random-32x10) [255.143737] Starting subtest: cursor-random-32x10 [255.196260] Subtest cursor-random-32x10: SKIP (0.050s) [255.458948] [035/133] (763s left) kms_cursor_legacy (cursora-vs-flipa-atomic) [255.570204] Starting subtest: cursorA-vs-flipA-atomic [266.706063] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.134s) [267.527121] [036/133] (751s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs) [267.594022] Starting subtest: mixed-tiled-to-y-tiled-ccs [267.598078] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s) [267.774865] [037/133] (751s left) core_getversion (basic) [267.814336] Starting subtest: basic [267.818784] Subtest basic: SUCCESS (0.000s) [267.871469] [038/133] (751s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render) [267.969237] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render [267.973418] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [268.059610] [039/133] (751s left) gem_exec_gttfill (basic) [268.121796] Starting subtest: basic [270.817613] Subtest basic: SUCCESS (2.695s) [271.010621] [040/133] (748s left) gem_mmap (basic-small-bo) [271.107601] Subtest basic-small-bo: SKIP (0.000s) [271.168774] [041/133] (748s left) gem_mmap_gtt (basic-small-copy) [271.223620] Subtest basic-small-copy: SKIP (0.000s) [271.284872] [042/133] (748s left) gen9_exec_parse (valid-registers) [271.347185] Subtest valid-registers: SKIP (0.000s) [271.423025] [043/133] (747s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [271.547717] Starting subtest: basic-flip-before-cursor-legacy [272.494397] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.947s) [273.384277] [044/133] (746s left) gem_ctx_persistence (saturated-hostile) [273.456689] Starting subtest: saturated-hostile [273.459127] Starting dynamic subtest: rcs0 [274.284440] Dynamic subtest rcs0: SUCCESS (0.827s) [274.297730] Starting dynamic subtest: bcs0 [275.070341] Dynamic subtest bcs0: SUCCESS (0.784s) [275.081510] Starting dynamic subtest: vcs0 [275.866837] Dynamic subtest vcs0: SUCCESS (0.794s) [275.877838] Starting dynamic subtest: vcs1 [276.665760] Dynamic subtest vcs1: SUCCESS (0.797s) [276.676894] Starting dynamic subtest: vecs0 [277.461058] Dynamic subtest vecs0: SUCCESS (0.794s) [277.472147] Starting dynamic subtest: ccs0 [278.311080] Dynamic subtest ccs0: SUCCESS (0.843s) [278.313758] Subtest saturated-hostile: SUCCESS (4.850s) [278.434060] [045/133] (741s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs) [278.540950] Starting subtest: missing-ccs-buffer-y-tiled-ccs [278.543210] Starting dynamic subtest: pipe-A-eDP-1 [278.565643] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [278.574996] Starting dynamic subtest: pipe-B-eDP-1 [278.595965] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [278.603761] Starting dynamic subtest: pipe-C-eDP-1 [278.626400] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [278.636519] Starting dynamic subtest: pipe-D-eDP-1 [278.658324] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [278.662820] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.005s) [280.826265] [046/133] (738s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt) [280.922626] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt [280.927133] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [281.016848] [047/133] (738s left) kms_flip (2x-wf_vblank-ts-check) [281.114219] Starting subtest: 2x-wf_vblank-ts-check [281.123319] Subtest 2x-wf_vblank-ts-check: SKIP (0.011s) [281.203782] [048/133] (738s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move) [281.302466] Starting subtest: psr-2p-primscrn-spr-indfb-move [281.306515] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [281.393945] [049/133] (738s left) gem_exec_capture (capture) [281.447796] Starting subtest: capture [281.449951] Starting dynamic subtest: rcs0-smem [282.271411] Dynamic subtest rcs0-smem: SUCCESS (0.820s) [282.281662] Starting dynamic subtest: bcs0-smem [283.090749] Dynamic subtest bcs0-smem: SUCCESS (0.818s) [283.100271] Starting dynamic subtest: vcs0-smem [283.897474] Dynamic subtest vcs0-smem: SUCCESS (0.806s) [283.906408] Starting dynamic subtest: vcs1-smem [285.211620] Dynamic subtest vcs1-smem: SUCCESS (1.313s) [285.221311] Starting dynamic subtest: vecs0-smem [286.100231] Dynamic subtest vecs0-smem: FAIL (0.830s) [286.109079] Starting dynamic subtest: ccs0-smem [287.357430] Dynamic subtest ccs0-smem: SUCCESS (1.315s) [287.359831] Subtest capture: FAIL (5.908s) [287.481444] [050/133] (732s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc) [287.574229] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc [287.578093] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [287.670221] [051/133] (732s left) kms_pm_rpm (legacy-planes) [289.493198] Starting subtest: legacy-planes [289.496070] Starting dynamic subtest: plane-65 [297.909463] Dynamic subtest plane-65: SUCCESS (8.415s) [297.921060] Starting dynamic subtest: plane-95 [306.196724] Dynamic subtest plane-95: SUCCESS (8.284s) [306.208163] Starting dynamic subtest: plane-125 [314.499132] Dynamic subtest plane-125: SUCCESS (8.300s) [314.508896] Starting dynamic subtest: plane-135 [322.798994] Dynamic subtest plane-135: SUCCESS (8.297s) [322.801704] Subtest legacy-planes: SUCCESS (33.306s) [323.166835] [052/133] (696s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc) [323.273339] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc [323.275298] Starting dynamic subtest: pipe-A-eDP-1 [324.163475] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.884s) [324.172318] Starting dynamic subtest: pipe-B-eDP-1 [325.791944] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.625s) [325.801450] Starting dynamic subtest: pipe-C-eDP-1 [327.288565] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.496s) [327.298340] Starting dynamic subtest: pipe-D-eDP-1 [328.853558] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.565s) [328.855832] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.575s) [330.099193] [053/133] (689s left) kms_chamelium_frames (dp-crc-fast) [330.482707] Subtest dp-crc-fast: SKIP (0.000s) [331.300104] [054/133] (688s left) gem_mmap (big-bo) [331.348739] Subtest big-bo: SKIP (0.000s) [331.401658] [055/133] (688s left) syncobj_timeline (invalid-query-one-illegal-handle) [331.468097] Starting subtest: invalid-query-one-illegal-handle [331.470494] Subtest invalid-query-one-illegal-handle: SUCCESS (0.001s) [331.548101] [056/133] (688s left) kms_getfb (getfb-handle-valid) [331.642189] Starting subtest: getfb-handle-valid [331.644391] Subtest getfb-handle-valid: SUCCESS (0.000s) [331.748366] [057/133] (688s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf) [331.844388] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf [331.846704] Starting dynamic subtest: pipe-A-eDP-1 [331.921020] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s) [331.931776] Starting dynamic subtest: pipe-B-eDP-1 [333.087291] Dynamic subtest pipe-B-eDP-1: SKIP (1.164s) [333.092517] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.245s) [334.282875] [058/133] (685s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling) [334.386799] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling [334.391179] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s) [334.464689] [059/133] (685s left) kms_pm_rpm (dpms-lpsp) [336.495764] Starting subtest: dpms-lpsp [336.794435] Subtest dpms-lpsp: SUCCESS (0.302s) [336.892586] [060/133] (683s left) kms_psr (fbc-psr2-sprite-plane-onoff) [336.987069] Starting subtest: fbc-psr2-sprite-plane-onoff [336.989311] Starting dynamic subtest: eDP-1 [336.993565] Dynamic subtest eDP-1: SKIP (0.000s) [336.997834] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s) [337.075187] [061/133] (683s left) gem_partial_pwrite_pread (write-snoop) [337.137426] Subtest write-snoop: SKIP (0.000s) [337.203602] [062/133] (682s left) gem_exec_alignment (single) [337.255138] Starting subtest: single [337.259825] Subtest single: SUCCESS (0.003s) [337.381181] [063/133] (682s left) kms_pipe_crc_basic (disable-crc-after-crtc) [337.474502] Starting subtest: disable-crc-after-crtc [337.476934] Starting dynamic subtest: pipe-A-eDP-1 [339.096934] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.622s) [339.108649] Starting dynamic subtest: pipe-B-eDP-1 [341.388229] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.291s) [341.397452] Starting dynamic subtest: pipe-C-eDP-1 [343.647724] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.259s) [343.657083] Starting dynamic subtest: pipe-D-eDP-1 [345.914297] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.264s) [345.916519] Subtest disable-crc-after-crtc: SUCCESS (8.442s) [346.747746] [064/133] (673s left) gem_userptr_blits (nohangcheck) [346.828612] Starting subtest: nohangcheck [347.083751] Subtest nohangcheck: SUCCESS (0.251s) [347.194630] [065/133] (673s left) kms_sequence (get-forked-busy) [347.278991] Starting subtest: get-forked-busy [347.281269] Starting dynamic subtest: pipe-A-eDP-1 [349.216179] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.935s) [349.226064] Starting dynamic subtest: pipe-B-eDP-1 [351.842240] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.624s) [351.851775] Starting dynamic subtest: pipe-C-eDP-1 [354.440462] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.599s) [354.450106] Starting dynamic subtest: pipe-D-eDP-1 [356.992812] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.549s) [356.995173] Subtest get-forked-busy: SUCCESS (9.713s) [357.874344] [066/133] (662s left) gem_exec_store (basic) [357.949084] Starting subtest: basic [358.051775] Subtest basic: SUCCESS (0.103s) [358.233096] [067/133] (662s left) gem_pxp (create-regular-context-1) [358.363070] Starting subtest: create-regular-context-1 [358.365704] Subtest create-regular-context-1: SUCCESS (0.002s) [358.481900] [068/133] (661s left) syncobj_timeline (etime-single-wait-available-unsubmitted) [358.540574] Starting subtest: etime-single-wait-available-unsubmitted [358.641750] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.102s) [358.722574] [069/133] (661s left) kms_cursor_legacy (single-move) [358.848471] Starting subtest: single-move [358.850819] Starting dynamic subtest: pipe-A [364.292562] Dynamic subtest pipe-A: SUCCESS (5.379s) [364.302649] Starting dynamic subtest: pipe-B [369.665493] Dynamic subtest pipe-B: SUCCESS (5.379s) [369.676502] Starting dynamic subtest: pipe-C [375.047773] Dynamic subtest pipe-C: SUCCESS (5.379s) [375.058153] Starting dynamic subtest: pipe-D [380.430861] Dynamic subtest pipe-D: SUCCESS (5.379s) [380.441331] Starting dynamic subtest: all-pipes [385.769690] Dynamic subtest all-pipes: SUCCESS (5.387s) [385.772268] Subtest single-move: SUCCESS (26.917s) [385.923640] [070/133] (634s left) kms_addfb_basic (bad-pitch-128) [385.975976] Starting subtest: bad-pitch-128 [385.978203] Subtest bad-pitch-128: SUCCESS (0.000s) [386.107000] [071/133] (634s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt) [386.211192] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt [386.215325] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [386.313101] [072/133] (634s left) perf (invalid-oa-format-id) [386.439481] Starting subtest: invalid-oa-format-id [386.451360] Subtest invalid-oa-format-id: SUCCESS (0.010s) [386.493301] [073/133] (634s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [386.580133] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt [386.584627] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [386.676160] [074/133] (633s left) kms_psr (pr-primary-page-flip) [386.773060] Starting subtest: pr-primary-page-flip [386.776973] Subtest pr-primary-page-flip: SKIP (0.000s) [386.843431] [075/133] (633s left) kms_joiner (basic-max-non-joiner) [386.941882] Starting subtest: basic-max-non-joiner [386.945486] Subtest basic-max-non-joiner: SKIP (0.000s) [387.008132] [076/133] (633s left) kms_color (invalid-degamma-lut-sizes) [387.113656] Starting subtest: invalid-degamma-lut-sizes [387.115658] Starting dynamic subtest: pipe-A [387.400465] Dynamic subtest pipe-A: SUCCESS (0.288s) [387.410612] Starting dynamic subtest: pipe-B [387.413045] Dynamic subtest pipe-B: SUCCESS (0.000s) [387.421800] Starting dynamic subtest: pipe-C [387.424166] Dynamic subtest pipe-C: SUCCESS (0.000s) [387.432559] Starting dynamic subtest: pipe-D [387.434953] Dynamic subtest pipe-D: SUCCESS (0.000s) [387.437165] Subtest invalid-degamma-lut-sizes: SUCCESS (0.291s) [388.200077] [077/133] (632s left) gem_ctx_param (invalid-get-engines) [388.254193] Starting subtest: invalid-get-engines [388.256771] Subtest invalid-get-engines: SUCCESS (0.001s) [388.353550] [078/133] (632s left) syncobj_eventfd (invalid-illegal-handle) [388.407962] Starting subtest: invalid-illegal-handle [388.410233] Subtest invalid-illegal-handle: SUCCESS (0.000s) [388.507687] [079/133] (632s left) syncobj_wait (wait-all-for-submit-snapshot) [388.563132] Starting subtest: wait-all-for-submit-snapshot [388.643647] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s) [388.732692] [080/133] (632s left) kms_cursor_edge_walk (64x64-left-edge) [388.829074] Starting subtest: 64x64-left-edge [388.831377] Starting dynamic subtest: pipe-A-eDP-1 [392.252897] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.425s) [392.262863] Starting dynamic subtest: pipe-D-eDP-1 [395.378937] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.123s) [395.381335] Subtest 64x64-left-edge: SUCCESS (6.551s) [396.197489] [081/133] (624s left) perf_pmu (most-busy-idle-check-all) [396.248969] Starting subtest: most-busy-idle-check-all [396.251269] Starting dynamic subtest: rcs0 [397.351113] Dynamic subtest rcs0: SUCCESS (1.102s) [397.364054] Starting dynamic subtest: bcs0 [399.336081] Dynamic subtest bcs0: SUCCESS (1.981s) [399.349371] Starting dynamic subtest: vcs0 [401.319202] Dynamic subtest vcs0: SUCCESS (1.980s) [401.331686] Starting dynamic subtest: vcs1 [403.367617] Dynamic subtest vcs1: SUCCESS (2.045s) [403.379998] Starting dynamic subtest: vecs0 [405.352093] Dynamic subtest vecs0: SUCCESS (1.981s) [405.364642] Starting dynamic subtest: ccs0 [407.335416] Dynamic subtest ccs0: SUCCESS (1.981s) [407.338504] Subtest most-busy-idle-check-all: SUCCESS (11.089s) [407.449486] [082/133] (613s left) kms_frontbuffer_tracking (fbc-tiling-linear) [407.542737] Starting subtest: fbc-tiling-linear [411.271507] Subtest fbc-tiling-linear: SUCCESS (3.732s) [412.404715] [083/133] (608s left) gem_exec_schedule (submit-late-slice) [412.474521] Starting subtest: submit-late-slice [412.476734] Starting dynamic subtest: rcs0 [412.505446] Dynamic subtest rcs0: SUCCESS (0.036s) [412.514642] Starting dynamic subtest: bcs0 [412.537985] Dynamic subtest bcs0: SUCCESS (0.032s) [412.552552] Starting dynamic subtest: vcs0 [412.579591] Dynamic subtest vcs0: SUCCESS (0.040s) [412.591883] Starting dynamic subtest: vcs1 [412.605901] Dynamic subtest vcs1: SUCCESS (0.026s) [412.615401] Starting dynamic subtest: vecs0 [412.634809] Dynamic subtest vecs0: SUCCESS (0.028s) [412.648328] Starting dynamic subtest: ccs0 [412.666091] Dynamic subtest ccs0: SUCCESS (0.030s) [412.668489] Subtest submit-late-slice: SUCCESS (0.197s) [414.404434] [084/133] (606s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted) [414.458105] Starting subtest: multi-wait-available-unsubmitted-submitted [414.460478] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.001s) [414.572988] [085/133] (606s left) gem_userptr_blits (stress-mm) [414.636309] Starting subtest: stress-mm [420.061703] Subtest stress-mm: SUCCESS (5.369s) [420.119574] [086/133] (601s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt) [420.220208] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt [424.837957] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.621s) [426.014457] [087/133] (595s left) kms_plane (pixel-format-y-tiled-ccs-modifier) [426.112255] Starting subtest: pixel-format-y-tiled-ccs-modifier [426.116406] Subtest pixel-format-y-tiled-ccs-modifier: SKIP (0.000s) [426.201193] [088/133] (595s left) kms_psr (psr-sprite-render) [426.291232] Starting subtest: psr-sprite-render [426.293568] Starting dynamic subtest: eDP-1 [428.017053] Dynamic subtest eDP-1: SUCCESS (1.724s) [428.019467] Subtest psr-sprite-render: SUCCESS (1.725s) [428.891770] [089/133] (592s left) kms_vrr (lobf) [428.986228] Starting subtest: lobf [428.990296] Subtest lobf: SKIP (0.000s) [429.068317] [090/133] (592s left) kms_dsc (dsc-fractional-bpp) [429.158197] Starting subtest: dsc-fractional-bpp [429.171585] Subtest dsc-fractional-bpp: SKIP (0.000s) [429.232493] [091/133] (592s left) kms_vblank (query-idle-hang) [429.335325] Starting subtest: query-idle-hang [429.337579] Starting dynamic subtest: pipe-A-eDP-1 [456.104939] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.766s) [456.119914] Starting dynamic subtest: pipe-D-eDP-1 [481.143236] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.035s) [481.145622] Subtest query-idle-hang: SUCCESS (51.807s) [481.951930] [092/133] (539s left) api_intel_bb (object-reloc-purge-cache) [482.012413] Starting subtest: object-reloc-purge-cache [482.017408] Subtest object-reloc-purge-cache: SKIP (0.003s) [482.125898] [093/133] (539s left) syncobj_wait (multi-wait-signaled) [482.176755] Starting subtest: multi-wait-signaled [482.179146] Subtest multi-wait-signaled: SUCCESS (0.000s) [482.272261] [094/133] (539s left) kms_cursor_legacy (cursora-vs-flipb-atomic) [482.379813] Starting subtest: cursorA-vs-flipB-atomic [482.384469] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s) [482.525589] [095/133] (539s left) kms_atomic_transition (plane-use-after-nonblocking-unbind) [482.617183] Starting subtest: plane-use-after-nonblocking-unbind [482.619540] Starting dynamic subtest: pipe-A-eDP-1 [482.677825] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s) [482.971700] Starting dynamic subtest: pipe-B-eDP-1 [483.743855] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.778s) [484.031405] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.412s) [484.909624] [096/133] (536s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format) [485.019940] Starting subtest: plane-scaler-unity-scaling-with-pixel-format [485.022638] Starting dynamic subtest: pipe-A [486.235283] Dynamic subtest pipe-A: SUCCESS (1.218s) [486.246955] Starting dynamic subtest: pipe-B [488.481108] Dynamic subtest pipe-B: SUCCESS (2.243s) [488.490170] Starting dynamic subtest: pipe-C [489.702167] Dynamic subtest pipe-C: SUCCESS (1.219s) [489.711711] Starting dynamic subtest: pipe-D [490.878728] Dynamic subtest pipe-D: SUCCESS (1.175s) [490.881204] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.861s) [492.053163] [097/133] (529s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling) [492.161448] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling [492.165746] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s) [492.233583] [098/133] (529s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt) [492.327245] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt [492.331283] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [492.416361] [099/133] (529s left) kms_frontbuffer_tracking (fbcpsr-1p-rte) [492.524687] Starting subtest: fbcpsr-1p-rte [499.558031] Subtest fbcpsr-1p-rte: SUCCESS (7.038s) [499.695352] [100/133] (522s left) api_intel_allocator (reserve-simple) [499.751363] Starting subtest: reserve-simple [499.753726] Subtest reserve-simple: SUCCESS (0.003s) [499.873301] [101/133] (521s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling) [499.968150] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling [499.970437] Starting dynamic subtest: pipe-A-default-mode [502.701700] Dynamic subtest pipe-A-default-mode: SUCCESS (2.734s) [502.704090] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.735s) [503.575919] [102/133] (518s left) gem_softpin (32b-excludes-last-page) [503.645223] Starting subtest: 32b-excludes-last-page [503.647493] Subtest 32b-excludes-last-page: SUCCESS (0.003s) [503.794232] [103/133] (518s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs) [503.892249] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs [503.894451] Starting dynamic subtest: pipe-A-eDP-1 [503.917107] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [503.928056] Starting dynamic subtest: pipe-B-eDP-1 [503.949386] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [503.958632] Starting dynamic subtest: pipe-C-eDP-1 [503.980406] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [503.991358] Starting dynamic subtest: pipe-D-eDP-1 [504.013313] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [504.017744] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.005s) [506.140873] [104/133] (515s left) gem_exec_alignment (many) [506.213109] Starting subtest: many [529.490260] Subtest many: SUCCESS (23.223s) [531.417427] [105/133] (490s left) i915_pm_rps (thresholds-idle) [531.515762] Starting subtest: thresholds-idle [531.520578] Subtest thresholds-idle: SKIP (0.001s) [531.593266] [106/133] (490s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic) [531.724607] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic [531.729175] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s) [531.871936] [107/133] (490s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled) [531.934666] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled [531.937037] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s) [532.034886] [108/133] (490s left) gem_ccs (large-ctrl-surf-copy) [532.093429] Starting subtest: large-ctrl-surf-copy [532.097840] Subtest large-ctrl-surf-copy: SKIP (0.000s) [532.206913] [109/133] (489s left) kms_addfb_basic (too-wide) [532.293181] Starting subtest: too-wide [532.295484] Subtest too-wide: SUCCESS (0.000s) [532.403757] [110/133] (489s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all) [532.457819] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all [532.526373] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.026s) [532.585903] [111/133] (489s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [532.685342] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip [533.533577] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.849s) [533.690133] [112/133] (488s left) gem_spin_batch (spin-all-new) [533.749459] Starting subtest: spin-all-new [533.764250] Subtest spin-all-new: SUCCESS (0.014s) [535.400492] [113/133] (486s left) gem_mmap_gtt (cpuset-big-copy) [535.473593] Subtest cpuset-big-copy: SKIP (0.000s) [535.541997] [114/133] (486s left) kms_chamelium_audio (dp-audio) [535.930163] Subtest dp-audio: SKIP (0.000s) [536.747572] [115/133] (485s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs) [536.848245] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs [536.850499] Starting dynamic subtest: pipe-A-eDP-1 [536.874364] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.026s) [536.884897] Starting dynamic subtest: pipe-B-eDP-1 [536.904445] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.025s) [536.914850] Starting dynamic subtest: pipe-C-eDP-1 [536.934161] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s) [536.943623] Starting dynamic subtest: pipe-D-eDP-1 [536.963278] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.023s) [536.965522] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.101s) [539.234126] [116/133] (483s left) kms_content_protection (atomic) [539.375939] Starting subtest: atomic [539.380517] Subtest atomic: SKIP (0.000s) [539.515714] [117/133] (483s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible) [539.582164] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s) [539.652828] [118/133] (482s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt) [539.757933] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt [539.762311] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [539.842742] [119/133] (482s left) sw_sync (sync_multi_consumer_producer) [539.881248] Starting subtest: sync_multi_consumer_producer [540.189765] Subtest sync_multi_consumer_producer: SUCCESS (0.312s) [540.254772] [120/133] (482s left) kms_async_flips (invalid-async-flip) [540.344399] Starting subtest: invalid-async-flip [540.719975] Starting dynamic subtest: pipe-A-eDP-1 [541.565886] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.846s) [541.926262] Starting dynamic subtest: pipe-B-eDP-1 [542.791859] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.875s) [543.158463] Starting dynamic subtest: pipe-C-eDP-1 [543.993474] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.848s) [544.351409] Starting dynamic subtest: pipe-D-eDP-1 [545.126096] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.782s) [545.128296] Subtest invalid-async-flip: SUCCESS (4.785s) [546.284817] [121/133] (476s left) core_setmaster_vs_auth [546.462712] [122/133] (476s left) gem_exec_params (invalid-bsd2-flag-on-vebox) [546.515820] Starting subtest: invalid-bsd2-flag-on-vebox [546.518078] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s) [546.612525] [123/133] (476s left) gem_exec_fence (syncobj-timeline-invalid-wait) [547.196651] Starting subtest: syncobj-timeline-invalid-wait [547.202416] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s) [548.424611] [124/133] (474s left) syncobj_timeline (wait-all-interrupted) [548.483554] Starting subtest: wait-all-interrupted [548.587094] Subtest wait-all-interrupted: SUCCESS (0.104s) [548.683240] [125/133] (474s left) gen7_exec_parse (bitmasks) [548.745307] Subtest bitmasks: SKIP (0.000s) [548.816404] [126/133] (474s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [548.915186] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt [548.919178] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [549.013119] [127/133] (473s left) gem_exec_whisper (basic-queues-priority) [549.075424] Starting subtest: basic-queues-priority [573.415322] Subtest basic-queues-priority: SUCCESS (24.283s) [573.552462] [128/133] (449s left) gem_exec_schedule (manyslice) [573.630406] Starting subtest: manyslice [573.632472] Starting dynamic subtest: rcs0 [580.362697] Dynamic subtest rcs0: SUCCESS (6.684s) [580.379418] Starting dynamic subtest: bcs0 [587.522132] Dynamic subtest bcs0: SUCCESS (7.157s) [587.537447] Starting dynamic subtest: vcs0 [593.611754] Dynamic subtest vcs0: SUCCESS (6.089s) [593.622766] Starting dynamic subtest: vcs1 [599.192575] Dynamic subtest vcs1: SUCCESS (5.578s) [599.205527] Starting dynamic subtest: vecs0 [605.216776] Dynamic subtest vecs0: SUCCESS (6.074s) [605.229522] Starting dynamic subtest: ccs0 [611.403090] Dynamic subtest ccs0: SUCCESS (6.184s) [611.405462] Subtest manyslice: SUCCESS (37.777s) [611.724304] [129/133] (411s left) syncobj_wait (invalid-reset-one-illegal-handle) [611.774988] Starting subtest: invalid-reset-one-illegal-handle [611.777377] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s) [611.868260] [130/133] (411s left) kms_lease (lease-unleased-connector) [611.979916] Starting subtest: lease-unleased-connector [611.982273] Starting dynamic subtest: pipe-A-eDP-1 [611.987362] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s) [611.998064] Starting dynamic subtest: pipe-B-eDP-1 [612.000301] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s) [612.010764] Starting dynamic subtest: pipe-C-eDP-1 [612.012987] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s) [612.022394] Starting dynamic subtest: pipe-D-eDP-1 [612.024585] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.006s) [612.026770] Subtest lease-unleased-connector: SUCCESS (0.030s) [612.119701] [131/133] (411s left) syncobj_wait (invalid-wait-illegal-handle) [612.189661] Starting subtest: invalid-wait-illegal-handle [612.192066] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s) [612.306044] [132/133] (410s left) sysfs_heartbeat_interval (nopreempt) [612.369811] Starting subtest: nopreempt [612.372094] Starting dynamic subtest: vecs0 [622.303141] Dynamic subtest vecs0: SUCCESS (9.932s) [622.317818] Starting dynamic subtest: ccs0 [626.268028] Dynamic subtest ccs0: SUCCESS (3.962s) [626.280468] Starting dynamic subtest: vcs0 [636.319833] Dynamic subtest vcs0: SUCCESS (10.048s) [636.332703] Starting dynamic subtest: bcs0 [640.250676] Dynamic subtest bcs0: SUCCESS (3.930s) [640.263206] Starting dynamic subtest: rcs0 [644.347761] Dynamic subtest rcs0: SUCCESS (4.096s) [644.360467] Starting dynamic subtest: vcs1 [654.307325] Dynamic subtest vcs1: SUCCESS (9.955s) [654.309684] Subtest nopreempt: SUCCESS (41.935s) [654.385413] [133/133] (368s left) gem_create (create-valid-nonaligned) [654.447781] Starting subtest: create-valid-nonaligned [654.449914] Subtest create-valid-nonaligned: SUCCESS (0.000s) [654.635410] Closing watchdogs results: parsing output: 0/ for test: kms_chamelium_hpd results: parsing output: 1/ for test: kms_psr2_sf results: parsing output: 2/ for test: fbdev results: parsing output: 3/ for test: kms_psr results: parsing output: 4/ for test: kms_flip results: parsing output: 5/ for test: i915_pm_rpm results: parsing output: 6/ for test: kms_frontbuffer_tracking results: parsing output: 7/ for test: kms_big_fb results: parsing output: 8/ for test: gem_exec_reloc results: parsing output: 9/ for test: kms_big_fb results: parsing output: 10/ for test: kms_plane_scaling results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: perf results: parsing output: 14/ for test: gem_exec_balancer results: parsing output: 15/ for test: kms_flip results: parsing output: 16/ for test: kms_big_fb results: parsing output: 17/ for test: gem_mmap_gtt results: parsing output: 18/ for test: kms_cursor_crc results: parsing output: 19/ for test: kms_rotation_crc results: parsing output: 20/ for test: kms_big_fb results: parsing output: 21/ for test: kms_async_flips results: parsing output: 22/ for test: i915_hangman results: parsing output: 23/ for test: kms_frontbuffer_tracking results: parsing output: 24/ for test: prime_self_import results: parsing output: 25/ for test: kms_psr results: parsing output: 26/ for test: kms_big_fb results: parsing output: 27/ for test: kms_plane_cursor results: parsing output: 28/ for test: kms_busy results: parsing output: 29/ for test: gem_exec_fence results: parsing output: 30/ for test: kms_properties results: parsing output: 31/ for test: kms_psr2_sf results: parsing output: 32/ for test: kms_hdr results: parsing output: 33/ for test: kms_cursor_crc results: parsing output: 34/ for test: kms_cursor_legacy results: parsing output: 35/ for test: gem_render_copy results: parsing output: 36/ for test: core_getversion results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: gem_exec_gttfill results: parsing output: 39/ for test: gem_mmap results: parsing output: 40/ for test: gem_mmap_gtt results: parsing output: 41/ for test: gen9_exec_parse results: parsing output: 42/ for test: kms_cursor_legacy results: parsing output: 43/ for test: gem_ctx_persistence results: parsing output: 44/ for test: kms_ccs results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: kms_flip results: parsing output: 47/ for test: kms_frontbuffer_tracking results: parsing output: 48/ for test: gem_exec_capture results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: kms_pm_rpm results: parsing output: 51/ for test: kms_ccs results: parsing output: 52/ for test: kms_chamelium_frames results: parsing output: 53/ for test: gem_mmap results: parsing output: 54/ for test: syncobj_timeline results: parsing output: 55/ for test: kms_getfb results: parsing output: 56/ for test: kms_psr2_sf results: parsing output: 57/ for test: kms_flip_scaled_crc results: parsing output: 58/ for test: kms_pm_rpm results: parsing output: 59/ for test: kms_psr results: parsing output: 60/ for test: gem_partial_pwrite_pread results: parsing output: 61/ for test: gem_exec_alignment results: parsing output: 62/ for test: kms_pipe_crc_basic results: parsing output: 63/ for test: gem_userptr_blits results: parsing output: 64/ for test: kms_sequence results: parsing output: 65/ for test: gem_exec_store results: parsing output: 66/ for test: gem_pxp results: parsing output: 67/ for test: syncobj_timeline results: parsing output: 68/ for test: kms_cursor_legacy results: parsing output: 69/ for test: kms_addfb_basic results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: perf results: parsing output: 72/ for test: kms_frontbuffer_tracking results: parsing output: 73/ for test: kms_psr results: parsing output: 74/ for test: kms_joiner results: parsing output: 75/ for test: kms_color results: parsing output: 76/ for test: gem_ctx_param results: parsing output: 77/ for test: syncobj_eventfd results: parsing output: 78/ for test: syncobj_wait results: parsing output: 79/ for test: kms_cursor_edge_walk results: parsing output: 80/ for test: perf_pmu results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: gem_exec_schedule results: parsing output: 83/ for test: syncobj_timeline results: parsing output: 84/ for test: gem_userptr_blits results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: kms_plane results: parsing output: 87/ for test: kms_psr results: parsing output: 88/ for test: kms_vrr results: parsing output: 89/ for test: kms_dsc results: parsing output: 90/ for test: kms_vblank results: parsing output: 91/ for test: api_intel_bb results: parsing output: 92/ for test: syncobj_wait results: parsing output: 93/ for test: kms_cursor_legacy results: parsing output: 94/ for test: kms_atomic_transition results: parsing output: 95/ for test: kms_plane_scaling results: parsing output: 96/ for test: kms_flip_scaled_crc results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: api_intel_allocator results: parsing output: 100/ for test: kms_flip_scaled_crc results: parsing output: 101/ for test: gem_softpin results: parsing output: 102/ for test: kms_ccs results: parsing output: 103/ for test: gem_exec_alignment results: parsing output: 104/ for test: i915_pm_rps results: parsing output: 105/ for test: kms_cursor_legacy results: parsing output: 106/ for test: syncobj_wait results: parsing output: 107/ for test: gem_ccs results: parsing output: 108/ for test: kms_addfb_basic results: parsing output: 109/ for test: sriov_basic results: parsing output: 110/ for test: kms_big_fb results: parsing output: 111/ for test: gem_spin_batch results: parsing output: 112/ for test: gem_mmap_gtt results: parsing output: 113/ for test: kms_chamelium_audio results: parsing output: 114/ for test: kms_ccs results: parsing output: 115/ for test: kms_content_protection results: parsing output: 116/ for test: gem_fenced_exec_thrash results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: sw_sync results: parsing output: 119/ for test: kms_async_flips results: parsing output: 120/ for test: core_setmaster_vs_auth results: parsing output: 121/ for test: gem_exec_params results: parsing output: 122/ for test: gem_exec_fence results: parsing output: 123/ for test: syncobj_timeline results: parsing output: 124/ for test: gen7_exec_parse results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: gem_exec_whisper results: parsing output: 127/ for test: gem_exec_schedule results: parsing output: 128/ for test: syncobj_wait results: parsing output: 129/ for test: kms_lease results: parsing output: 130/ for test: syncobj_wait results: parsing output: 131/ for test: sysfs_heartbeat_interval results: parsing output: 132/ for test: gem_create Done.