[56.925702] Initializing watchdogs [56.925747] /dev/watchdog0 [56.942217] [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] [56.946552] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [56.948841] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [56.952214] [001/133] (960s left) i915_pm_rpm (sysfs-read) [59.044078] Starting subtest: sysfs-read [60.200330] Subtest sysfs-read: SUCCESS (1.159s) [60.567343] [002/133] (956s left) gem_softpin (noreloc-s3) [60.637655] Starting subtest: noreloc-S3 [80.039991] Subtest noreloc-S3: SUCCESS (5.387s) [80.151984] [003/133] (937s left) gen7_exec_parse (chained-batch) [80.233907] Subtest chained-batch: SKIP (0.000s) [80.290358] [004/133] (937s left) gem_ctx_persistence (legacy-engines-persistence) [80.353063] Starting subtest: legacy-engines-persistence [80.355068] Starting dynamic subtest: render [81.317297] Dynamic subtest render: SUCCESS (0.983s) [81.328717] Starting dynamic subtest: bsd1 [82.225116] Dynamic subtest bsd1: SUCCESS (0.920s) [82.236009] Starting dynamic subtest: bsd2 [82.972311] Dynamic subtest bsd2: SUCCESS (0.757s) [82.983139] Starting dynamic subtest: blt [83.743019] Dynamic subtest blt: SUCCESS (0.780s) [83.752533] Starting dynamic subtest: vebox [84.508931] Dynamic subtest vebox: SUCCESS (0.774s) [84.511391] Subtest legacy-engines-persistence: SUCCESS (4.224s) [84.584673] [005/133] (933s left) syncobj_timeline (etime-multi-wait-for-submit-submitted) [84.632926] Starting subtest: etime-multi-wait-for-submit-submitted [84.741178] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.109s) [84.813407] [006/133] (932s left) gem_eio (banned) [85.012141] Starting subtest: banned [85.550883] Subtest banned: SUCCESS (0.545s) [85.718816] [007/133] (931s left) syncobj_basic (bad-destroy-pad) [85.772789] Starting subtest: bad-destroy-pad [85.774696] Subtest bad-destroy-pad: SUCCESS (0.000s) [85.878767] [008/133] (931s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic) [86.007294] Starting subtest: flip-vs-cursor-busy-crc-atomic [86.839408] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.841s) [87.648649] [009/133] (930s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [87.743657] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s) [87.841538] [010/133] (929s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu) [87.937331] Starting subtest: psr-rgb101010-draw-mmap-cpu [94.965674] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (7.067s) [95.092036] [011/133] (922s left) gem_create (create-massive) [95.150310] Starting subtest: create-massive [95.152284] Subtest create-massive: SUCCESS (0.000s) [95.342652] [012/133] (922s left) gem_exec_fence (syncobj-timeline-signal) [95.942175] Starting subtest: syncobj-timeline-signal [95.949068] Subtest syncobj-timeline-signal: SUCCESS (0.009s) [97.042736] [FACT gem_exec_fence (syncobj-timeline-signal)] new: kernel.kmod_is_loaded.vgem: true [97.045795] [013/133] (920s left) kms_cursor_legacy (flip-vs-cursor-toggle) [97.163393] Starting subtest: flip-vs-cursor-toggle [106.081137] Subtest flip-vs-cursor-toggle: SUCCESS (8.934s) [106.935384] [014/133] (911s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt) [107.046086] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt [107.050215] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [107.141388] [015/133] (910s left) kms_psr (fbc-psr-primary-mmap-cpu) [107.229580] Starting subtest: fbc-psr-primary-mmap-cpu [107.231589] Starting dynamic subtest: eDP-1 [107.235772] Dynamic subtest eDP-1: SKIP (0.000s) [107.240117] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.000s) [107.299493] [016/133] (910s left) gen3_render_tiledy_blits [107.423530] [017/133] (910s left) gem_madvise (dontneed-before-mmap) [107.466366] Starting subtest: dontneed-before-mmap [107.490946] Subtest dontneed-before-mmap: SUCCESS (0.024s) [107.602147] [018/133] (910s left) gem_userptr_blits (unsync-overlap) [107.667024] Subtest unsync-overlap: SKIP (0.000s) [107.785620] [019/133] (910s left) syncobj_timeline (wait-for-submit-complex) [107.843630] Starting subtest: wait-for-submit-complex [107.903860] Subtest wait-for-submit-complex: SUCCESS (0.062s) [107.974634] [020/133] (910s left) kms_force_connector_basic (force-edid) [108.040272] Starting subtest: force-edid [108.409772] Subtest force-edid: SUCCESS (0.370s) [108.547297] [021/133] (909s left) kms_addfb_basic (size-max) [108.636941] Starting subtest: size-max [108.638867] Subtest size-max: SUCCESS (0.000s) [108.726992] [022/133] (909s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb) [108.820797] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb [108.822650] Starting dynamic subtest: pipe-A-eDP-1 [115.458295] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.637s) [115.470550] Starting dynamic subtest: pipe-B-eDP-1 [122.361351] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.898s) [122.363276] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.537s) [123.152561] [023/133] (895s left) kms_atomic_transition (plane-toggle-modeset-transition) [123.256237] Starting subtest: plane-toggle-modeset-transition [123.258422] Starting dynamic subtest: pipe-A-eDP-1 [136.278905] Dynamic subtest pipe-A-eDP-1: SUCCESS (13.025s) [136.290042] Starting dynamic subtest: pipe-B-eDP-1 [149.156321] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.878s) [149.159192] Subtest plane-toggle-modeset-transition: SUCCESS (25.907s) [149.974350] [024/133] (868s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy) [150.100684] Starting subtest: flip-vs-cursor-crc-legacy [150.770570] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.671s) [151.662842] [025/133] (866s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs) [151.755686] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs [151.757985] Starting dynamic subtest: pipe-A-eDP-1 [151.777669] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.022s) [151.786624] Starting dynamic subtest: pipe-B-eDP-1 [151.805812] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.019s) [151.814404] Starting dynamic subtest: pipe-C-eDP-1 [151.833528] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.019s) [151.842071] Starting dynamic subtest: pipe-D-eDP-1 [151.864240] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.019s) [151.866567] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.084s) [154.048693] [026/133] (864s left) i915_drm_fdinfo (busy-check-all) [154.089782] Starting subtest: busy-check-all [154.091997] Starting dynamic subtest: rcs0 [154.096574] Dynamic subtest rcs0: SKIP (0.004s) [154.105324] Starting dynamic subtest: bcs0 [154.109361] Dynamic subtest bcs0: SKIP (0.000s) [154.117889] Starting dynamic subtest: vcs0 [154.122391] Dynamic subtest vcs0: SKIP (0.000s) [154.132153] Starting dynamic subtest: vcs1 [154.136570] Dynamic subtest vcs1: SKIP (0.000s) [154.144614] Starting dynamic subtest: vecs0 [154.148923] Dynamic subtest vecs0: SKIP (0.000s) [154.157081] Starting dynamic subtest: ccs0 [154.161450] Dynamic subtest ccs0: SKIP (0.000s) [154.165764] Subtest busy-check-all: SKIP (0.007s) [154.202355] [027/133] (864s left) syncobj_basic (create-signaled) [154.280597] Starting subtest: create-signaled [154.283042] Subtest create-signaled: SUCCESS (0.000s) [154.386530] [028/133] (864s left) kms_getfb (getfb-handle-protection) [154.486727] Starting subtest: getfb-handle-protection [154.506979] Subtest getfb-handle-protection: SUCCESS (0.021s) [154.616501] [029/133] (863s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs) [154.711169] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs [154.713435] Starting dynamic subtest: pipe-A-eDP-1 [156.843562] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.135s) [156.852661] Starting dynamic subtest: pipe-B-eDP-1 [159.073485] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.229s) [159.082187] Starting dynamic subtest: pipe-C-eDP-1 [161.128061] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.053s) [161.137445] Starting dynamic subtest: pipe-D-eDP-1 [163.154384] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.026s) [163.156756] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.447s) [164.348339] [030/133] (854s left) kms_feature_discovery (dp-mst) [164.446419] Starting subtest: dp-mst [164.450865] Subtest dp-mst: SKIP (0.000s) [164.519664] [031/133] (854s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt) [164.612796] Starting subtest: fbc-rgb565-draw-mmap-gtt [164.617135] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s) [164.713921] [032/133] (853s left) core_setmaster (master-drop-set-user) [164.805355] Starting subtest: master-drop-set-user [164.827485] Subtest master-drop-set-user: SUCCESS (0.025s) [164.869575] [033/133] (853s left) gem_exec_suspend (basic-s0) [164.927569] Starting subtest: basic-S0 [164.929866] Starting dynamic subtest: smem [185.812867] Dynamic subtest smem: SUCCESS (7.049s) [185.815472] Subtest basic-S0: SUCCESS (7.051s) [185.996950] [034/133] (832s left) drm_read (short-buffer-nonblock) [186.146313] Starting subtest: short-buffer-nonblock [186.148658] Subtest short-buffer-nonblock: SUCCESS (0.000s) [186.258288] [035/133] (832s left) gem_exec_schedule (u-submit-early-slice) [186.335712] Starting subtest: u-submit-early-slice [186.337634] Starting dynamic subtest: rcs0 [186.372635] Dynamic subtest rcs0: SUCCESS (0.048s) [186.384520] Starting dynamic subtest: bcs0 [186.403683] Dynamic subtest bcs0: SUCCESS (0.031s) [186.411861] Starting dynamic subtest: vcs0 [186.439651] Dynamic subtest vcs0: SUCCESS (0.036s) [186.449028] Starting dynamic subtest: vcs1 [186.475746] Dynamic subtest vcs1: SUCCESS (0.036s) [186.484252] Starting dynamic subtest: vecs0 [186.510007] Dynamic subtest vecs0: SUCCESS (0.034s) [186.522627] Starting dynamic subtest: ccs0 [186.548149] Dynamic subtest ccs0: SUCCESS (0.038s) [186.550419] Subtest u-submit-early-slice: SUCCESS (0.229s) [187.934673] [036/133] (830s left) gem_ctx_shared (single-timeline) [187.993031] Starting subtest: single-timeline [188.014659] Subtest single-timeline: SUCCESS (0.017s) [188.241168] [037/133] (830s left) kms_cursor_crc (cursor-random-128x42) [188.453414] Starting subtest: cursor-random-128x42 [188.508535] Subtest cursor-random-128x42: SKIP (0.052s) [188.691901] [038/133] (830s left) gem_exec_fence (syncobj-import) [189.155298] Starting subtest: syncobj-import [189.161144] Subtest syncobj-import: SUCCESS (0.005s) [190.946385] [039/133] (828s left) gem_lmem_swapping (parallel-random) [190.990685] Subtest parallel-random: SKIP (0.000s) [191.037971] [040/133] (827s left) kms_big_fb (yf-tiled-16bpp-rotate-0) [191.142585] Starting subtest: yf-tiled-16bpp-rotate-0 [191.146479] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s) [191.247137] [041/133] (827s left) gem_workarounds (suspend-resume) [191.304412] Starting subtest: suspend-resume [207.931134] Subtest suspend-resume: SUCCESS (1.147s) [208.089470] [042/133] (811s left) gem_userptr_blits (process-exit) [208.169507] Starting subtest: process-exit [208.174095] Subtest process-exit: SUCCESS (0.008s) [208.303850] [043/133] (810s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt) [208.412408] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt [215.585879] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.313s) [215.710074] [044/133] (803s left) kms_flip (dpms-vs-vblank-race-interruptible) [215.803622] Starting subtest: dpms-vs-vblank-race-interruptible [215.805834] Starting dynamic subtest: A-eDP1 [220.743781] Dynamic subtest A-eDP1: SUCCESS (4.978s) [220.753458] Starting dynamic subtest: B-eDP1 [224.241263] Dynamic subtest B-eDP1: SUCCESS (3.512s) [224.250694] Starting dynamic subtest: C-eDP1 [227.718318] Dynamic subtest C-eDP1: SUCCESS (3.488s) [227.732368] Starting dynamic subtest: D-eDP1 [231.207456] Dynamic subtest D-eDP1: SUCCESS (3.491s) [231.209757] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (15.484s) [232.040928] [045/133] (787s left) kms_cursor_legacy (cursor-vs-flip-atomic) [232.165300] Starting subtest: cursor-vs-flip-atomic [261.824401] Subtest cursor-vs-flip-atomic: SUCCESS (29.657s) [262.647965] [046/133] (756s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [262.751755] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc [262.756122] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [262.844357] [047/133] (756s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [262.938943] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip [263.707474] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.770s) [263.870207] [048/133] (755s left) gem_workarounds (reset-context) [263.934403] Starting subtest: reset-context [264.117623] Subtest reset-context: SUCCESS (0.182s) [264.262089] [049/133] (755s left) kms_plane (plane-position-hole-dpms) [264.353652] Starting subtest: plane-position-hole-dpms [264.854963] Starting dynamic subtest: pipe-A-plane-1 [267.187984] Dynamic subtest pipe-A-plane-1: SUCCESS (2.335s) [267.198042] Starting dynamic subtest: pipe-A-plane-2 [269.573235] Dynamic subtest pipe-A-plane-2: SUCCESS (2.386s) [269.582783] Starting dynamic subtest: pipe-A-plane-3 [271.983201] Dynamic subtest pipe-A-plane-3: SUCCESS (2.409s) [271.993635] Starting dynamic subtest: pipe-A-plane-4 [274.377370] Dynamic subtest pipe-A-plane-4: SUCCESS (2.391s) [274.386537] Starting dynamic subtest: pipe-A-plane-5 [274.400069] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s) [275.604518] Starting dynamic subtest: pipe-B-plane-1 [277.974685] Dynamic subtest pipe-B-plane-1: SUCCESS (2.386s) [277.985269] Starting dynamic subtest: pipe-B-plane-2 [280.340721] Dynamic subtest pipe-B-plane-2: SUCCESS (2.366s) [280.350643] Starting dynamic subtest: pipe-B-plane-3 [282.671776] Dynamic subtest pipe-B-plane-3: SUCCESS (2.331s) [282.681358] Starting dynamic subtest: pipe-B-plane-4 [285.066175] Dynamic subtest pipe-B-plane-4: SUCCESS (2.392s) [285.075301] Starting dynamic subtest: pipe-B-plane-5 [285.089762] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s) [285.091980] Subtest plane-position-hole-dpms: SUCCESS (20.741s) [285.936875] [050/133] (733s left) kms_flip (plain-flip-ts-check-interruptible) [286.055091] Starting subtest: plain-flip-ts-check-interruptible [286.057427] Starting dynamic subtest: A-eDP1 [294.911268] Dynamic subtest A-eDP1: SUCCESS (8.856s) [294.925647] Starting dynamic subtest: B-eDP1 [303.807750] Dynamic subtest B-eDP1: SUCCESS (8.896s) [303.819934] Starting dynamic subtest: C-eDP1 [312.684487] Dynamic subtest C-eDP1: SUCCESS (8.870s) [312.694032] Starting dynamic subtest: D-eDP1 [321.484701] Dynamic subtest D-eDP1: SUCCESS (8.797s) [321.489942] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.434s) [322.654321] [051/133] (696s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [322.748997] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu [329.721112] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (6.974s) [329.843866] [052/133] (689s left) api_intel_allocator (reserve-simple) [329.912207] Starting subtest: reserve-simple [329.914562] Subtest reserve-simple: SUCCESS (0.004s) [330.045135] [053/133] (689s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc) [330.151618] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc [330.153737] Starting dynamic subtest: pipe-A-eDP-1 [330.176228] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [330.187112] Starting dynamic subtest: pipe-B-eDP-1 [330.208722] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [330.217698] Starting dynamic subtest: pipe-C-eDP-1 [330.239171] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [330.250017] Starting dynamic subtest: pipe-D-eDP-1 [330.271881] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [330.275944] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s) [332.431906] [054/133] (687s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling) [332.528480] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling [332.532913] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s) [332.601281] [055/133] (687s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k) [332.976922] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s) [333.811738] [056/133] (685s left) kms_vblank (wait-forked-busy-hang) [333.911664] Starting subtest: wait-forked-busy-hang [333.913560] Starting dynamic subtest: pipe-A-eDP-1 [361.106596] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.196s) [361.119206] Starting dynamic subtest: pipe-D-eDP-1 [386.147879] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.042s) [386.150177] Subtest wait-forked-busy-hang: SUCCESS (52.243s) [387.024733] [057/133] (632s left) i915_selftest (mock) [390.312116] Starting subtest: mock [390.315114] Starting dynamic subtest: sanitycheck [390.967792] Dynamic subtest sanitycheck: SUCCESS (0.656s) [390.977706] Starting dynamic subtest: shmem [391.633781] Dynamic subtest shmem: SUCCESS (0.664s) [391.643696] Starting dynamic subtest: fence [399.517067] Dynamic subtest fence: SUCCESS (7.882s) [399.525795] Starting dynamic subtest: scatterlist [401.163446] Dynamic subtest scatterlist: SUCCESS (1.645s) [401.173284] Starting dynamic subtest: syncmap [404.358483] Dynamic subtest syncmap: SUCCESS (3.193s) [404.368116] Starting dynamic subtest: uncore [405.021158] Dynamic subtest uncore: SUCCESS (0.661s) [405.030899] Starting dynamic subtest: ring [405.683720] Dynamic subtest ring: SUCCESS (0.661s) [405.693682] Starting dynamic subtest: engine [406.346661] Dynamic subtest engine: SUCCESS (0.661s) [406.356326] Starting dynamic subtest: timelines [410.226923] Dynamic subtest timelines: SUCCESS (3.878s) [410.236777] Starting dynamic subtest: requests [413.765063] Dynamic subtest requests: SUCCESS (3.538s) [413.774638] Starting dynamic subtest: objects [414.520776] Dynamic subtest objects: SUCCESS (0.755s) [414.530373] Starting dynamic subtest: phys [415.234428] Dynamic subtest phys: SUCCESS (0.712s) [415.244034] Starting dynamic subtest: dmabuf [415.959566] Dynamic subtest dmabuf: SUCCESS (0.724s) [415.969329] Starting dynamic subtest: vma [421.562298] Dynamic subtest vma: SUCCESS (5.602s) [421.572076] Starting dynamic subtest: evict [422.938784] Dynamic subtest evict: SUCCESS (1.376s) [422.948087] Starting dynamic subtest: gtt [426.174835] Dynamic subtest gtt: SUCCESS (3.235s) [426.184314] Starting dynamic subtest: hugepages [427.022558] Dynamic subtest hugepages: SUCCESS (0.847s) [427.032490] Starting dynamic subtest: memory_region [429.461166] Dynamic subtest memory_region: SUCCESS (2.437s) [429.463750] Subtest mock: SUCCESS (39.158s) [429.491024] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [429.491826] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true [429.495397] [058/133] (590s left) kms_addfb_basic (bad-pitch-999) [430.958187] Starting subtest: bad-pitch-999 [430.960721] Subtest bad-pitch-999: SUCCESS (0.000s) [431.100111] [FACT kms_addfb_basic (bad-pitch-999)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [431.101302] [FACT kms_addfb_basic (bad-pitch-999)] new: kernel.kmod_is_loaded.i915: true [431.104940] [059/133] (588s left) kms_lease (multimaster-lease) [431.190102] Starting subtest: multimaster-lease [431.192436] Subtest multimaster-lease: SUCCESS (0.004s) [431.293889] [060/133] (588s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc) [431.388562] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc [431.390875] Starting dynamic subtest: pipe-A-eDP-1 [432.266973] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.871s) [432.276158] Starting dynamic subtest: pipe-B-eDP-1 [433.880179] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.611s) [433.888309] Starting dynamic subtest: pipe-C-eDP-1 [435.405074] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.522s) [435.413795] Starting dynamic subtest: pipe-D-eDP-1 [436.950799] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.544s) [436.952732] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.553s) [438.131912] [061/133] (581s left) syncobj_timeline (multi-wait-submitted-signaled) [438.190289] Starting subtest: multi-wait-submitted-signaled [438.192697] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s) [438.292745] [062/133] (581s left) kms_big_fb (yf-tiled-8bpp-rotate-180) [438.388105] Starting subtest: yf-tiled-8bpp-rotate-180 [438.392392] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s) [438.489578] [063/133] (581s left) gem_lmem_swapping (parallel-random-verify-ccs) [438.532666] Subtest parallel-random-verify-ccs: SKIP (0.000s) [438.576316] [064/133] (581s left) kms_cursor_crc (cursor-onscreen-64x64) [438.755541] Starting subtest: cursor-onscreen-64x64 [438.760670] Starting dynamic subtest: pipe-A-eDP-1 [440.883479] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.123s) [440.912854] Starting dynamic subtest: pipe-D-eDP-1 [443.698083] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.791s) [443.700337] Subtest cursor-onscreen-64x64: SUCCESS (4.940s) [444.504579] [065/133] (575s left) gem_pxp (hw-rejects-pxp-buffer) [444.638889] Starting subtest: hw-rejects-pxp-buffer [444.643748] Subtest hw-rejects-pxp-buffer: SKIP (0.000s) [444.748263] [066/133] (575s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c) [444.819101] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s) [444.890693] [067/133] (575s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt) [444.989177] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt [444.993402] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [445.083020] [068/133] (575s left) perf (mi-rpc) [445.207105] Starting subtest: mi-rpc [445.211389] Subtest mi-rpc: SKIP (0.000s) [445.246529] [069/133] (574s left) syncobj_timeline (invalid-signal-bad-pad) [445.301870] Starting subtest: invalid-signal-bad-pad [445.304161] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [445.417838] [070/133] (574s left) syncobj_wait (wait-for-submit-snapshot) [445.460191] Starting subtest: wait-for-submit-snapshot [445.540556] Subtest wait-for-submit-snapshot: SUCCESS (0.081s) [445.615665] [071/133] (574s left) gem_pwrite (basic-random) [445.666629] Subtest basic-random: SKIP (0.000s) [445.725248] [072/133] (574s left) gem_userptr_blits (map-fixed-invalidate-overlap) [445.794318] Starting subtest: map-fixed-invalidate-overlap [445.798052] Subtest map-fixed-invalidate-overlap: SKIP (0.000s) [445.919613] [073/133] (574s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc) [446.014441] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc [450.235095] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.221s) [451.413577] [074/133] (568s left) dumb_buffer (map-valid) [451.477664] Starting subtest: map-valid [451.479565] Subtest map-valid: SUCCESS (0.000s) [451.563319] [075/133] (568s left) kms_async_flips (invalid-async-flip) [451.647771] Starting subtest: invalid-async-flip [452.026714] Starting dynamic subtest: pipe-A-eDP-1 [452.815612] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.790s) [453.186295] Starting dynamic subtest: pipe-B-eDP-1 [453.965403] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.785s) [454.337470] Starting dynamic subtest: pipe-C-eDP-1 [455.105585] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.776s) [455.464292] Starting dynamic subtest: pipe-D-eDP-1 [456.259863] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.804s) [456.262229] Subtest invalid-async-flip: SUCCESS (4.614s) [457.497692] [076/133] (562s left) kms_big_fb (4-tiled-8bpp-rotate-90) [457.591993] Starting subtest: 4-tiled-8bpp-rotate-90 [457.613232] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.020s) [457.724992] [077/133] (562s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs) [457.791429] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs [457.796421] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s) [457.976269] [078/133] (562s left) gem_fence_thrash (bo-write-verify-none) [458.013732] Starting subtest: bo-write-verify-none [458.027670] Subtest bo-write-verify-none: SKIP (0.012s) [458.085213] [079/133] (562s left) kms_pm_dc (dc5-dpms) [459.178860] Starting subtest: dc5-dpms [461.278366] Subtest dc5-dpms: SUCCESS (2.100s) [461.353441] [080/133] (559s left) core_debugfs (read-all-entries) [461.418153] Starting subtest: read-all-entries [461.528549] Subtest read-all-entries: SUCCESS (0.111s) [461.606893] [081/133] (559s left) kms_color (ctm-green-to-red) [461.699667] Starting subtest: ctm-green-to-red [461.701813] Starting dynamic subtest: pipe-A-eDP-1 [462.396797] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.699s) [462.406397] Starting dynamic subtest: pipe-B-eDP-1 [463.810872] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.413s) [463.819734] Starting dynamic subtest: pipe-C-eDP-1 [465.114997] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.299s) [465.124380] Starting dynamic subtest: pipe-D-eDP-1 [466.426479] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.312s) [466.428678] Subtest ctm-green-to-red: SUCCESS (4.726s) [467.276297] [082/133] (553s left) gem_ctx_isolation (preservation) [467.336789] Starting subtest: preservation [467.339032] Starting dynamic subtest: rcs0 [467.490223] Dynamic subtest rcs0: SUCCESS (0.156s) [467.502263] Starting dynamic subtest: bcs0 [467.634370] Dynamic subtest bcs0: SUCCESS (0.143s) [467.646090] Starting dynamic subtest: vcs0 [467.777013] Dynamic subtest vcs0: SUCCESS (0.141s) [467.785823] Starting dynamic subtest: vcs1 [469.444017] Dynamic subtest vcs1: SUCCESS (1.666s) [469.453584] Starting dynamic subtest: vecs0 [471.507843] Dynamic subtest vecs0: SUCCESS (2.062s) [471.521260] Starting dynamic subtest: ccs0 [473.510361] Dynamic subtest ccs0: SUCCESS (2.001s) [473.513173] Subtest preservation: SUCCESS (6.176s) [473.758924] [083/133] (546s left) kms_cursor_edge_walk (256x256-right-edge) [473.864553] Starting subtest: 256x256-right-edge [473.866834] Starting dynamic subtest: pipe-A-eDP-1 [477.338198] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.472s) [477.350350] Starting dynamic subtest: pipe-D-eDP-1 [480.475030] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.135s) [480.477173] Subtest 256x256-right-edge: SUCCESS (6.610s) [481.277385] [084/133] (539s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt) [481.375231] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt [481.379526] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [481.469788] [085/133] (539s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0) [481.563774] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0 [481.567601] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s) [481.653988] [086/133] (539s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc) [481.748743] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc [488.461721] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.714s) [488.584476] [087/133] (532s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf) [488.689797] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf [488.694305] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [488.759025] [088/133] (532s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf) [488.846301] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf [488.850466] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [488.932126] [089/133] (532s left) gem_exec_reloc (basic-range) [488.986941] Subtest basic-range: SKIP (0.000s) [489.047958] [090/133] (531s left) kms_plane_multiple (tiling-y) [489.130799] Starting subtest: tiling-y [489.135371] Subtest tiling-y: SKIP (0.000s) [489.209691] [091/133] (531s left) kms_psr (pr-cursor-mmap-gtt) [489.301629] Starting subtest: pr-cursor-mmap-gtt [489.305822] Subtest pr-cursor-mmap-gtt: SKIP (0.000s) [489.376240] [092/133] (531s left) i915_hangman (engine-error-state-capture) [489.438405] Starting subtest: engine-error-state-capture [489.440413] Starting dynamic subtest: rcs0 [493.304104] Dynamic subtest rcs0: SUCCESS (3.864s) [493.316808] Starting dynamic subtest: bcs0 [499.319907] Dynamic subtest bcs0: SUCCESS (6.012s) [499.331205] Starting dynamic subtest: vcs0 [505.271567] Dynamic subtest vcs0: SUCCESS (5.950s) [505.283554] Starting dynamic subtest: vcs1 [510.264202] Dynamic subtest vcs1: SUCCESS (4.989s) [510.275714] Starting dynamic subtest: vecs0 [515.255310] Dynamic subtest vecs0: SUCCESS (4.989s) [515.267909] Starting dynamic subtest: ccs0 [520.310999] Dynamic subtest ccs0: SUCCESS (5.053s) [520.313671] Subtest engine-error-state-capture: SUCCESS (30.873s) [520.430825] [093/133] (500s left) gem_userptr_blits (create-destroy-unsync) [520.504375] Subtest create-destroy-unsync: SKIP (0.000s) [520.648197] [094/133] (500s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling) [520.740128] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling [520.742246] Starting dynamic subtest: pipe-A-default-mode [521.929746] Dynamic subtest pipe-A-default-mode: SKIP (1.188s) [521.934068] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.190s) [522.052166] [095/133] (499s left) prime_vgem (sync) [522.132027] Starting subtest: sync [522.134420] Starting dynamic subtest: rcs0 [522.183540] Dynamic subtest rcs0: SUCCESS (0.051s) [522.192160] Starting dynamic subtest: bcs0 [522.245250] Dynamic subtest bcs0: SUCCESS (0.060s) [522.254136] Starting dynamic subtest: vcs0 [522.292566] Dynamic subtest vcs0: SUCCESS (0.046s) [522.300975] Starting dynamic subtest: vcs1 [522.336876] Dynamic subtest vcs1: SUCCESS (0.043s) [522.345226] Starting dynamic subtest: vecs0 [522.384677] Dynamic subtest vecs0: SUCCESS (0.047s) [522.393205] Starting dynamic subtest: ccs0 [522.432142] Dynamic subtest ccs0: SUCCESS (0.047s) [522.434480] Subtest sync: SUCCESS (0.301s) [522.546750] [096/133] (498s left) gem_exec_schedule (pi-distinct-iova) [522.733583] Starting subtest: pi-distinct-iova [522.735558] Starting dynamic subtest: rcs0 [522.811571] Dynamic subtest rcs0: SUCCESS (0.080s) [522.821915] Starting dynamic subtest: vcs0 [522.872845] Dynamic subtest vcs0: SUCCESS (0.061s) [522.881988] Starting dynamic subtest: vcs1 [522.933158] Dynamic subtest vcs1: SUCCESS (0.058s) [522.942341] Starting dynamic subtest: vecs0 [522.997037] Dynamic subtest vecs0: SUCCESS (0.064s) [523.005553] Starting dynamic subtest: ccs0 [523.066047] Dynamic subtest ccs0: SUCCESS (0.067s) [523.068545] Subtest pi-distinct-iova: SUCCESS (0.335s) [524.474791] [097/133] (496s left) kms_content_protection (content-type-change) [524.615206] Starting subtest: content-type-change [524.619784] Subtest content-type-change: SKIP (0.000s) [524.725382] [098/133] (496s left) kms_busy (basic-hang) [524.830988] Starting subtest: basic-hang [524.833303] Starting dynamic subtest: flip-pipe-A [525.440770] Dynamic subtest flip-pipe-A: SUCCESS (0.605s) [525.452446] Starting dynamic subtest: modeset-pipe-A [528.848519] Dynamic subtest modeset-pipe-A: SUCCESS (3.404s) [528.867347] Starting dynamic subtest: flip-pipe-D [530.051734] Dynamic subtest flip-pipe-D: SUCCESS (1.203s) [530.061570] Starting dynamic subtest: modeset-pipe-D [533.484941] Dynamic subtest modeset-pipe-D: SUCCESS (3.433s) [533.487311] Subtest basic-hang: SUCCESS (8.654s) [534.298141] [099/133] (487s left) gem_sync (basic-many-each) [534.379459] Starting subtest: basic-many-each [536.659351] Subtest basic-many-each: SUCCESS (2.291s) [536.837392] [100/133] (484s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt) [536.935754] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt [541.542326] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.610s) [542.714682] [101/133] (478s left) kms_chamelium_hpd (dp-hpd-storm-disable) [543.100026] Subtest dp-hpd-storm-disable: SKIP (0.000s) [543.913314] [102/133] (477s left) kms_rotation_crc (primary-4-tiled-reflect-x-0) [544.007474] Starting subtest: primary-4-tiled-reflect-x-0 [551.005266] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.001s) [552.200212] [103/133] (469s left) kms_cdclk (plane-scaling) [552.305378] Starting subtest: plane-scaling [552.307610] Starting dynamic subtest: pipe-A-eDP-1 [552.603579] Dynamic subtest pipe-A-eDP-1: SKIP (0.293s) [552.612710] Starting dynamic subtest: pipe-B-eDP-1 [552.617694] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [552.626819] Starting dynamic subtest: pipe-C-eDP-1 [552.631457] Dynamic subtest pipe-C-eDP-1: SKIP (0.002s) [552.640436] Starting dynamic subtest: pipe-D-eDP-1 [552.644581] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [552.648664] Subtest plane-scaling: SKIP (0.302s) [553.418418] [104/133] (468s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt) [553.511168] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt [560.812618] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.306s) [560.960314] [105/133] (460s left) kms_force_connector_basic (prune-stale-modes) [561.043512] Starting subtest: prune-stale-modes [561.501986] Subtest prune-stale-modes: SUCCESS (0.461s) [561.654177] [106/133] (460s left) gem_exec_reloc (basic-gtt-noreloc) [561.706996] Subtest basic-gtt-noreloc: SKIP (0.000s) [561.778923] [107/133] (459s left) kms_joiner (basic-ultra-joiner) [561.873253] Starting subtest: basic-ultra-joiner [561.876836] Subtest basic-ultra-joiner: SKIP (0.000s) [561.952199] [108/133] (459s left) gem_exec_balancer (persistence) [562.215653] Starting subtest: persistence [563.107124] Subtest persistence: SUCCESS (0.890s) [563.229157] [109/133] (458s left) gem_mmap_offset (bad-extensions) [563.286172] Starting subtest: bad-extensions [563.288433] Subtest bad-extensions: SUCCESS (0.000s) [563.384235] [110/133] (458s left) syncobj_timeline (single-wait-signaled) [563.439266] Starting subtest: single-wait-signaled [563.441417] Subtest single-wait-signaled: SUCCESS (0.000s) [563.532597] [111/133] (458s left) kms_psr (fbc-psr2-cursor-plane-onoff) [563.627594] Starting subtest: fbc-psr2-cursor-plane-onoff [563.629863] Starting dynamic subtest: eDP-1 [563.634209] Dynamic subtest eDP-1: SKIP (0.000s) [563.638885] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s) [563.704213] [112/133] (458s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled) [563.761459] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled [563.869556] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.107s) [563.958039] [113/133] (458s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping) [564.046677] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping [564.051091] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s) [564.122078] [114/133] (457s left) kms_psr (psr-cursor-plane-move) [564.221273] Starting subtest: psr-cursor-plane-move [564.224195] Starting dynamic subtest: eDP-1 [565.912095] Dynamic subtest eDP-1: SUCCESS (1.692s) [565.914624] Subtest psr-cursor-plane-move: SUCCESS (1.693s) [566.743580] [115/133] (455s left) gem_exec_flush (basic-batch-kernel-default-wb) [566.813738] Starting subtest: basic-batch-kernel-default-wb [574.270976] Subtest basic-batch-kernel-default-wb: SUCCESS (7.461s) [574.473257] [116/133] (447s left) kms_pipe_crc_basic (nonblocking-crc) [574.568742] Starting subtest: nonblocking-crc [574.571263] Starting dynamic subtest: pipe-A-eDP-1 [575.306021] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.738s) [575.315128] Starting dynamic subtest: pipe-B-eDP-1 [576.710383] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.401s) [576.719749] Starting dynamic subtest: pipe-C-eDP-1 [578.072312] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.360s) [578.081463] Starting dynamic subtest: pipe-D-eDP-1 [579.452656] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.381s) [579.455126] Subtest nonblocking-crc: SUCCESS (4.886s) [580.250626] [117/133] (441s left) gem_mmap_wc (write-cpu-read-wc-unflushed) [580.315662] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s) [580.390592] [118/133] (441s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling) [580.480685] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling [580.485123] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s) [580.553948] [119/133] (441s left) gem_vm_create (invalid-create) [580.600787] Starting subtest: invalid-create [580.603135] Subtest invalid-create: SUCCESS (0.002s) [580.695545] [120/133] (441s left) kms_flip (2x-plain-flip-ts-check) [580.782779] Starting subtest: 2x-plain-flip-ts-check [580.793641] Subtest 2x-plain-flip-ts-check: SKIP (0.010s) [580.887942] [121/133] (441s left) kms_big_fb (x-tiled-8bpp-rotate-180) [580.989312] Starting subtest: x-tiled-8bpp-rotate-180 [582.171227] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.182s) [582.302425] [122/133] (440s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt) [582.405285] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt [589.759124] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.356s) [589.895019] [123/133] (432s left) kms_debugfs (display-on-read-all) [589.993713] Starting subtest: display-on-read-all [590.160412] Subtest display-on-read-all: SUCCESS (0.167s) [590.267608] [124/133] (432s left) gem_softpin (allocator-fork) [590.334255] Starting subtest: allocator-fork [592.544444] Subtest allocator-fork: SUCCESS (2.209s) [592.676845] [125/133] (429s left) gem_exec_balancer (full-pulse) [592.743526] Starting subtest: full-pulse [597.222415] Subtest full-pulse: SUCCESS (4.479s) [597.568654] [126/133] (424s left) kms_sequence (queue-busy) [597.676342] Starting subtest: queue-busy [597.678565] Starting dynamic subtest: pipe-A-eDP-1 [599.615475] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.937s) [599.625810] Starting dynamic subtest: pipe-B-eDP-1 [602.205399] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.589s) [602.215589] Starting dynamic subtest: pipe-C-eDP-1 [604.782944] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.578s) [604.792205] Starting dynamic subtest: pipe-D-eDP-1 [607.369725] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.585s) [607.371837] Subtest queue-busy: SUCCESS (9.696s) [608.236903] [127/133] (414s left) kms_rotation_crc (bad-pixel-format) [608.331526] Starting subtest: bad-pixel-format [608.335653] Subtest bad-pixel-format: SKIP (0.001s) [608.419915] [128/133] (414s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt) [608.513741] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt [608.517953] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [608.611576] [129/133] (414s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format) [608.704466] Starting subtest: plane-upscale-20x20-with-pixel-format [608.706890] Starting dynamic subtest: pipe-A [609.751538] Dynamic subtest pipe-A: SUCCESS (1.050s) [609.760189] Starting dynamic subtest: pipe-B [611.907637] Dynamic subtest pipe-B: SUCCESS (2.156s) [611.916345] Starting dynamic subtest: pipe-C [613.072985] Dynamic subtest pipe-C: SUCCESS (1.164s) [613.083184] Starting dynamic subtest: pipe-D [614.273892] Dynamic subtest pipe-D: SUCCESS (1.200s) [614.276221] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.573s) [615.433646] [130/133] (407s left) kms_pm_rpm (modeset-lpsp-stress-no-wait) [617.562425] Starting subtest: modeset-lpsp-stress-no-wait [627.779233] Subtest modeset-lpsp-stress-no-wait: SUCCESS (10.219s) [627.857353] [131/133] (394s left) perf_pmu (busy-check-all) [627.903394] Starting subtest: busy-check-all [627.905825] Starting dynamic subtest: rcs0 [628.450971] Dynamic subtest rcs0: SUCCESS (0.550s) [628.464668] Starting dynamic subtest: bcs0 [629.001399] Dynamic subtest bcs0: SUCCESS (0.548s) [629.013923] Starting dynamic subtest: vcs0 [630.360238] Dynamic subtest vcs0: SUCCESS (1.356s) [630.372480] Starting dynamic subtest: vcs1 [632.346003] Dynamic subtest vcs1: SUCCESS (1.982s) [632.357912] Starting dynamic subtest: vecs0 [634.394161] Dynamic subtest vecs0: SUCCESS (2.045s) [634.407364] Starting dynamic subtest: ccs0 [634.958082] Dynamic subtest ccs0: SUCCESS (0.562s) [634.960894] Subtest busy-check-all: SUCCESS (7.060s) [635.066088] [132/133] (387s left) perf_pmu (init-sema) [635.125227] Starting subtest: init-sema [635.127638] Starting dynamic subtest: rcs0 [635.129967] Dynamic subtest rcs0: SUCCESS (0.003s) [635.143456] Starting dynamic subtest: bcs0 [635.145708] Dynamic subtest bcs0: SUCCESS (0.001s) [635.154630] Starting dynamic subtest: vcs0 [635.156819] Dynamic subtest vcs0: SUCCESS (0.001s) [635.165861] Starting dynamic subtest: vcs1 [635.167774] Dynamic subtest vcs1: SUCCESS (0.001s) [635.176995] Starting dynamic subtest: vecs0 [635.179243] Dynamic subtest vecs0: SUCCESS (0.001s) [635.188439] Starting dynamic subtest: ccs0 [635.190411] Dynamic subtest ccs0: SUCCESS (0.000s) [635.192357] Subtest init-sema: SUCCESS (0.013s) [635.232529] [133/133] (387s left) i915_query (query-topology-matches-eu-total) [635.294860] Starting subtest: query-topology-matches-eu-total [635.297227] Subtest query-topology-matches-eu-total: SUCCESS (0.000s) [635.399127] Closing watchdogs results: parsing output: 0/ for test: i915_pm_rpm results: parsing output: 1/ for test: gem_softpin results: parsing output: 2/ for test: gen7_exec_parse results: parsing output: 3/ for test: gem_ctx_persistence results: parsing output: 4/ for test: syncobj_timeline results: parsing output: 5/ for test: gem_eio results: parsing output: 6/ for test: syncobj_basic results: parsing output: 7/ for test: kms_cursor_legacy results: parsing output: 8/ for test: kms_addfb_basic results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: gem_create results: parsing output: 11/ for test: gem_exec_fence results: parsing output: 12/ for test: kms_cursor_legacy results: parsing output: 13/ for test: kms_frontbuffer_tracking results: parsing output: 14/ for test: kms_psr results: parsing output: 15/ for test: gen3_render_tiledy_blits results: parsing output: 16/ for test: gem_madvise results: parsing output: 17/ for test: gem_userptr_blits results: parsing output: 18/ for test: syncobj_timeline results: parsing output: 19/ for test: kms_force_connector_basic results: parsing output: 20/ for test: kms_addfb_basic results: parsing output: 21/ for test: kms_psr2_sf results: parsing output: 22/ for test: kms_atomic_transition results: parsing output: 23/ for test: kms_cursor_legacy results: parsing output: 24/ for test: kms_ccs results: parsing output: 25/ for test: i915_drm_fdinfo results: parsing output: 26/ for test: syncobj_basic results: parsing output: 27/ for test: kms_getfb results: parsing output: 28/ for test: kms_ccs results: parsing output: 29/ for test: kms_feature_discovery results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: core_setmaster results: parsing output: 32/ for test: gem_exec_suspend results: parsing output: 33/ for test: drm_read results: parsing output: 34/ for test: gem_exec_schedule results: parsing output: 35/ for test: gem_ctx_shared results: parsing output: 36/ for test: kms_cursor_crc results: parsing output: 37/ for test: gem_exec_fence results: parsing output: 38/ for test: gem_lmem_swapping results: parsing output: 39/ for test: kms_big_fb results: parsing output: 40/ for test: gem_workarounds results: parsing output: 41/ for test: gem_userptr_blits results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: kms_flip results: parsing output: 44/ for test: kms_cursor_legacy results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: kms_big_fb results: parsing output: 47/ for test: gem_workarounds results: parsing output: 48/ for test: kms_plane results: parsing output: 49/ for test: kms_flip results: parsing output: 50/ for test: kms_frontbuffer_tracking results: parsing output: 51/ for test: api_intel_allocator results: parsing output: 52/ for test: kms_ccs results: parsing output: 53/ for test: kms_flip_scaled_crc results: parsing output: 54/ for test: kms_chamelium_edid results: parsing output: 55/ for test: kms_vblank results: parsing output: 56/ for test: i915_selftest results: parsing output: 57/ for test: kms_addfb_basic results: parsing output: 58/ for test: kms_lease results: parsing output: 59/ for test: kms_ccs results: parsing output: 60/ for test: syncobj_timeline results: parsing output: 61/ for test: kms_big_fb results: parsing output: 62/ for test: gem_lmem_swapping results: parsing output: 63/ for test: kms_cursor_crc results: parsing output: 64/ for test: gem_pxp results: parsing output: 65/ for test: kms_pipe_b_c_ivb results: parsing output: 66/ for test: kms_frontbuffer_tracking results: parsing output: 67/ for test: perf results: parsing output: 68/ for test: syncobj_timeline results: parsing output: 69/ for test: syncobj_wait results: parsing output: 70/ for test: gem_pwrite results: parsing output: 71/ for test: gem_userptr_blits results: parsing output: 72/ for test: kms_frontbuffer_tracking results: parsing output: 73/ for test: dumb_buffer results: parsing output: 74/ for test: kms_async_flips results: parsing output: 75/ for test: kms_big_fb results: parsing output: 76/ for test: gem_render_copy results: parsing output: 77/ for test: gem_fence_thrash results: parsing output: 78/ for test: kms_pm_dc results: parsing output: 79/ for test: core_debugfs results: parsing output: 80/ for test: kms_color results: parsing output: 81/ for test: gem_ctx_isolation results: parsing output: 82/ for test: kms_cursor_edge_walk results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: kms_big_fb results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: kms_psr2_sf results: parsing output: 87/ for test: kms_psr2_sf results: parsing output: 88/ for test: gem_exec_reloc results: parsing output: 89/ for test: kms_plane_multiple results: parsing output: 90/ for test: kms_psr results: parsing output: 91/ for test: i915_hangman results: parsing output: 92/ for test: gem_userptr_blits results: parsing output: 93/ for test: kms_flip_scaled_crc results: parsing output: 94/ for test: prime_vgem results: parsing output: 95/ for test: gem_exec_schedule results: parsing output: 96/ for test: kms_content_protection results: parsing output: 97/ for test: kms_busy results: parsing output: 98/ for test: gem_sync results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: kms_chamelium_hpd results: parsing output: 101/ for test: kms_rotation_crc results: parsing output: 102/ for test: kms_cdclk results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: kms_force_connector_basic results: parsing output: 105/ for test: gem_exec_reloc results: parsing output: 106/ for test: kms_joiner results: parsing output: 107/ for test: gem_exec_balancer results: parsing output: 108/ for test: gem_mmap_offset results: parsing output: 109/ for test: syncobj_timeline results: parsing output: 110/ for test: kms_psr results: parsing output: 111/ for test: syncobj_timeline results: parsing output: 112/ for test: kms_plane results: parsing output: 113/ for test: kms_psr results: parsing output: 114/ for test: gem_exec_flush results: parsing output: 115/ for test: kms_pipe_crc_basic results: parsing output: 116/ for test: gem_mmap_wc results: parsing output: 117/ for test: kms_flip_scaled_crc results: parsing output: 118/ for test: gem_vm_create results: parsing output: 119/ for test: kms_flip results: parsing output: 120/ for test: kms_big_fb results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: kms_debugfs results: parsing output: 123/ for test: gem_softpin results: parsing output: 124/ for test: gem_exec_balancer results: parsing output: 125/ for test: kms_sequence results: parsing output: 126/ for test: kms_rotation_crc results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: kms_plane_scaling results: parsing output: 129/ for test: kms_pm_rpm results: parsing output: 130/ for test: perf_pmu results: parsing output: 131/ for test: perf_pmu results: parsing output: 132/ for test: i915_query Done.