[58.622161] Initializing watchdogs [58.622207] /dev/watchdog0 [58.636144] [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] [58.640912] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.643470] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.646885] [001/131] (960s left) kms_cursor_legacy (cursorb-vs-flipa-legacy) [58.800841] Starting subtest: cursorB-vs-flipA-legacy [58.805303] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s) [58.952893] [002/131] (960s left) syncobj_timeline (wait-all-for-submit-delayed-submit) [59.013953] Starting subtest: wait-all-for-submit-delayed-submit [59.118494] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s) [59.203355] [003/131] (960s left) core_debugfs (read-all-entries) [59.258935] Starting subtest: read-all-entries [59.340612] Subtest read-all-entries: SUCCESS (0.083s) [59.401989] [004/131] (959s left) kms_big_fb (linear-64bpp-rotate-0) [59.507738] Starting subtest: linear-64bpp-rotate-0 [61.057591] Subtest linear-64bpp-rotate-0: SUCCESS (1.545s) [61.234877] [005/131] (958s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [61.330947] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s) [61.437628] [006/131] (957s left) gem_exec_schedule (submit-golden-slice) [61.515669] Starting subtest: submit-golden-slice [61.517748] Starting dynamic subtest: rcs0 [61.545395] Dynamic subtest rcs0: SUCCESS (0.033s) [61.555838] Starting dynamic subtest: bcs0 [61.579555] Dynamic subtest bcs0: SUCCESS (0.034s) [61.587344] Starting dynamic subtest: vcs0 [61.613249] Dynamic subtest vcs0: SUCCESS (0.033s) [61.621419] Starting dynamic subtest: vcs1 [61.648269] Dynamic subtest vcs1: SUCCESS (0.034s) [61.655947] Starting dynamic subtest: vecs0 [61.677685] Dynamic subtest vecs0: SUCCESS (0.029s) [61.684340] Starting dynamic subtest: ccs0 [61.712777] Dynamic subtest ccs0: SUCCESS (0.035s) [61.714706] Subtest submit-golden-slice: SUCCESS (0.200s) [63.396269] [007/131] (955s left) perf (low-oa-exponent-permissions) [63.528484] Starting subtest: low-oa-exponent-permissions [63.565758] Subtest low-oa-exponent-permissions: SUCCESS (0.038s) [63.609732] [008/131] (955s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area) [63.720133] Starting subtest: psr2-overlay-plane-update-sf-dmg-area [63.722519] Starting dynamic subtest: pipe-A-eDP-1 [69.513811] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.789s) [69.522620] Starting dynamic subtest: pipe-B-eDP-1 [76.197201] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.679s) [76.199593] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.471s) [77.064639] [009/131] (942s left) kms_big_fb (yf-tiled-16bpp-rotate-0) [77.175854] Starting subtest: yf-tiled-16bpp-rotate-0 [77.180409] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s) [77.259287] [010/131] (942s left) kms_cursor_legacy (torture-move) [77.379744] Starting subtest: torture-move [77.381964] Starting dynamic subtest: pipe-A [83.698428] Dynamic subtest pipe-A: SUCCESS (6.313s) [83.708751] Starting dynamic subtest: pipe-B [90.244985] Dynamic subtest pipe-B: SUCCESS (6.543s) [90.254659] Starting dynamic subtest: pipe-C [97.282110] Dynamic subtest pipe-C: SUCCESS (7.036s) [97.290841] Starting dynamic subtest: pipe-D [104.625712] Dynamic subtest pipe-D: SUCCESS (7.342s) [104.635318] Starting dynamic subtest: all-pipes [111.535998] Dynamic subtest all-pipes: SUCCESS (6.909s) [111.538759] Subtest torture-move: SUCCESS (34.148s) [111.705778] [011/131] (907s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite) [111.817516] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite [116.271646] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.458s) [117.472618] [012/131] (902s left) syncobj_wait (reset-unsignaled) [117.524185] Starting subtest: reset-unsignaled [117.526227] Subtest reset-unsignaled: SUCCESS (0.000s) [117.607937] [013/131] (902s left) kms_psr (fbc-psr2-cursor-plane-onoff) [117.708128] Starting subtest: fbc-psr2-cursor-plane-onoff [117.710353] Starting dynamic subtest: eDP-1 [117.714546] Dynamic subtest eDP-1: SKIP (0.000s) [117.718626] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.000s) [117.778629] [014/131] (901s left) kms_cursor_crc (cursor-sliding-64x64) [117.939128] Starting subtest: cursor-sliding-64x64 [117.941500] Starting dynamic subtest: pipe-A-eDP-1 [121.138817] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.196s) [121.170727] Starting dynamic subtest: pipe-D-eDP-1 [125.058574] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.894s) [125.061022] Subtest cursor-sliding-64x64: SUCCESS (7.118s) [125.918540] [015/131] (893s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size) [126.039448] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size [127.028422] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.990s) [127.854502] [016/131] (891s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc) [127.951504] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc [135.049046] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.102s) [135.158517] [017/131] (884s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc) [135.261521] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc [135.265475] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [135.362158] [018/131] (884s left) gem_partial_pwrite_pread (writes-after-reads-snoop) [135.411506] Subtest writes-after-reads-snoop: SKIP (0.000s) [135.473574] [019/131] (884s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs) [135.561754] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs [135.566119] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s) [136.713477] [020/131] (883s left) syncobj_timeline (etime-single-wait-available-unsubmitted) [136.781153] Starting subtest: etime-single-wait-available-unsubmitted [136.890663] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.107s) [136.974989] [021/131] (882s left) gem_reg_read (timestamp-monotonic) [137.025384] Starting subtest: timestamp-monotonic [141.552967] Subtest timestamp-monotonic: SUCCESS (4.528s) [141.622523] [022/131] (878s left) gem_wait (write-busy) [141.680311] Starting subtest: write-busy [141.682277] Starting dynamic subtest: all-engines [142.338219] Dynamic subtest all-engines: SUCCESS (0.660s) [142.354425] Starting dynamic subtest: rcs0 [142.890424] Dynamic subtest rcs0: SUCCESS (0.552s) [142.905279] Starting dynamic subtest: bcs0 [143.440703] Dynamic subtest bcs0: SUCCESS (0.549s) [143.453891] Starting dynamic subtest: vcs0 [145.285232] Dynamic subtest vcs0: SUCCESS (1.842s) [145.299968] Starting dynamic subtest: vcs1 [147.269643] Dynamic subtest vcs1: SUCCESS (1.983s) [147.283690] Starting dynamic subtest: vecs0 [149.317657] Dynamic subtest vecs0: SUCCESS (2.047s) [149.331834] Starting dynamic subtest: ccs0 [149.870383] Dynamic subtest ccs0: SUCCESS (0.552s) [149.873299] Subtest write-busy: SUCCESS (8.193s) [150.065556] [FACT gem_wait (write-busy)] new: kernel.kmod_is_loaded.vgem: true [150.068850] [023/131] (869s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt) [150.174896] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt [150.179105] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [150.264184] [024/131] (869s left) gem_exec_fence (syncobj-import) [150.673699] Starting subtest: syncobj-import [150.678589] Subtest syncobj-import: SUCCESS (0.006s) [152.395857] [025/131] (867s left) gem_exec_schedule (implicit-boths) [152.459455] Starting subtest: implicit-boths [152.461317] Starting dynamic subtest: rcs0 [152.562508] Dynamic subtest rcs0: SUCCESS (0.112s) [152.573783] Starting dynamic subtest: vcs0 [152.653058] Dynamic subtest vcs0: SUCCESS (0.090s) [152.663795] Starting dynamic subtest: vcs1 [152.751857] Dynamic subtest vcs1: SUCCESS (0.098s) [152.763773] Starting dynamic subtest: vecs0 [152.887072] Dynamic subtest vecs0: SUCCESS (0.135s) [152.898929] Starting dynamic subtest: ccs0 [153.006574] Dynamic subtest ccs0: SUCCESS (0.119s) [153.009571] Subtest implicit-boths: SUCCESS (0.556s) [154.368446] [026/131] (865s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt) [154.476190] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt [158.229839] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.757s) [159.395121] [027/131] (860s left) kms_cursor_crc (cursor-rapid-movement-64x21) [159.589982] Starting subtest: cursor-rapid-movement-64x21 [159.634197] Subtest cursor-rapid-movement-64x21: SKIP (0.039s) [159.857252] [028/131] (860s left) gem_mmap_gtt (cpuset-medium-copy) [159.906486] Subtest cpuset-medium-copy: SKIP (0.000s) [159.981289] [029/131] (860s left) kms_dp_link_training (uhbr-sst) [160.067022] Starting subtest: uhbr-sst [160.075461] Subtest uhbr-sst: SKIP (0.000s) [160.148515] [030/131] (860s left) i915_drm_fdinfo (memory-info-purgeable) [160.189536] Starting subtest: memory-info-purgeable [160.192064] Starting dynamic subtest: smem0 [162.866771] Dynamic subtest smem0: SUCCESS (2.678s) [162.869034] Subtest memory-info-purgeable: SUCCESS (2.679s) [162.948459] [031/131] (857s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75) [163.041964] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75 [163.043926] Starting dynamic subtest: pipe-A [163.062120] Dynamic subtest pipe-A: SKIP (0.017s) [163.070022] Starting dynamic subtest: pipe-B [163.092809] Dynamic subtest pipe-B: SKIP (0.030s) [163.099858] Starting dynamic subtest: pipe-C [163.126853] Dynamic subtest pipe-C: SKIP (0.034s) [163.133998] Starting dynamic subtest: pipe-D [163.156982] Dynamic subtest pipe-D: SKIP (0.030s) [163.160065] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.112s) [163.235804] [032/131] (857s left) gem_exec_nop (basic-sequential) [163.309476] Starting subtest: basic-sequential [177.778574] Subtest basic-sequential: SUCCESS (14.474s) [178.000237] [033/131] (842s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs) [178.086798] Starting subtest: crc-primary-rotation-180-y-tiled-ccs [178.089269] Starting dynamic subtest: pipe-A-eDP-1 [178.114682] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [178.124791] Starting dynamic subtest: pipe-B-eDP-1 [178.149228] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [178.156857] Starting dynamic subtest: pipe-C-eDP-1 [178.178043] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [178.185410] Starting dynamic subtest: pipe-D-eDP-1 [178.206274] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [178.210059] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.015s) [180.339942] [034/131] (840s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu) [180.442183] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu [180.446220] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [180.528934] [035/131] (839s left) gem_caching (writes) [180.598772] Subtest writes: SKIP (0.000s) [180.668499] [036/131] (839s left) kms_chamelium_hpd (dp-hpd-storm) [181.046747] Subtest dp-hpd-storm: SKIP (0.000s) [181.842914] [037/131] (838s left) gem_ctx_param (set-priority-not-supported) [181.893853] Starting subtest: set-priority-not-supported [181.898630] Subtest set-priority-not-supported: SKIP (0.000s) [181.964431] [038/131] (838s left) syncobj_wait (invalid-signal-bad-pad) [182.028712] Starting subtest: invalid-signal-bad-pad [182.031226] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [182.118568] [039/131] (838s left) kms_addfb_basic (tile-pitch-mismatch) [182.169973] Starting subtest: tile-pitch-mismatch [182.174236] Subtest tile-pitch-mismatch: SKIP (0.000s) [182.305424] [040/131] (838s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling) [182.390300] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling [182.394856] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s) [182.469155] [041/131] (838s left) gem_ctx_exec (basic-invalid-context) [182.535794] Starting subtest: basic-invalid-context [182.540156] Subtest basic-invalid-context: SUCCESS (0.006s) [182.664042] [042/131] (838s left) api_intel_allocator (two-level-inception-interruptible) [182.716304] Starting subtest: two-level-inception-interruptible [188.123989] Subtest two-level-inception-interruptible: SUCCESS (5.409s) [188.264718] [043/131] (832s left) kms_psr (pr-cursor-render) [188.369850] Starting subtest: pr-cursor-render [188.374202] Subtest pr-cursor-render: SKIP (0.000s) [188.452802] [044/131] (832s left) syncobj_timeline (invalid-signal-bad-pad) [188.521099] Starting subtest: invalid-signal-bad-pad [188.523336] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [188.628290] [045/131] (832s left) gem_ctx_param (basic-default) [188.679597] Starting subtest: basic-default [188.681992] Subtest basic-default: SUCCESS (0.000s) [188.782737] [046/131] (832s left) gem_tiled_swapping (non-threaded) [188.840153] Subtest non-threaded: SKIP (0.000s) [188.909309] [047/131] (832s left) kms_atomic (test-only) [189.016984] Starting subtest: test-only [189.064474] Starting dynamic subtest: pipe-A-eDP-1 [191.583151] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.516s) [191.585556] Subtest test-only: SUCCESS (2.566s) [192.445338] [048/131] (828s left) kms_hdr (invalid-metadata-sizes) [192.546135] Starting subtest: invalid-metadata-sizes [192.552504] Subtest invalid-metadata-sizes: SKIP (0.000s) [192.632346] [049/131] (828s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled) [192.682011] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled [192.684328] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s) [192.787391] [050/131] (828s left) kms_vblank (ts-continuation-modeset-hang) [192.873072] Starting subtest: ts-continuation-modeset-hang [192.875224] Starting dynamic subtest: pipe-A-eDP-1 [219.080614] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.204s) [219.093897] Starting dynamic subtest: pipe-D-eDP-1 [244.029979] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.944s) [244.031886] Subtest ts-continuation-modeset-hang: SUCCESS (51.154s) [244.902867] [051/131] (776s left) kms_psr (psr-primary-mmap-gtt) [244.995081] Starting subtest: psr-primary-mmap-gtt [244.997556] Starting dynamic subtest: eDP-1 [246.407403] Dynamic subtest eDP-1: SKIP (1.409s) [246.412179] Subtest psr-primary-mmap-gtt: SKIP (1.411s) [246.564760] [052/131] (774s left) gem_render_copy (yf-tiled-to-vebox-linear) [246.632736] Starting subtest: yf-tiled-to-vebox-linear [246.637245] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s) [246.812962] [053/131] (774s left) kms_content_protection (dp-mst-type-0-hdcp14) [246.958969] Starting subtest: dp-mst-type-0-hdcp14 [246.963494] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s) [247.086468] [054/131] (774s left) gem_softpin (reverse) [247.151346] Starting subtest: reverse [247.156802] Subtest reverse: SUCCESS (0.006s) [247.290876] [055/131] (774s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling) [247.375950] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling [247.378255] Starting dynamic subtest: pipe-A-default-mode [250.081087] Dynamic subtest pipe-A-default-mode: SUCCESS (2.704s) [250.083055] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.705s) [250.916603] [056/131] (770s left) kms_invalid_mode (bad-vtotal) [251.011253] Starting subtest: bad-vtotal [251.013455] Starting dynamic subtest: pipe-A-eDP-1 [251.298675] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s) [251.307809] Starting dynamic subtest: pipe-B-eDP-1 [251.309898] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [251.317268] Starting dynamic subtest: pipe-C-eDP-1 [251.319865] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [251.327603] Starting dynamic subtest: pipe-D-eDP-1 [251.329613] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [251.332049] Subtest bad-vtotal: SUCCESS (0.292s) [252.141262] [057/131] (769s left) perf_pmu (init-busy) [252.186875] Starting subtest: init-busy [252.189215] Starting dynamic subtest: rcs0 [252.191613] Dynamic subtest rcs0: SUCCESS (0.001s) [252.199689] Starting dynamic subtest: bcs0 [252.201832] Dynamic subtest bcs0: SUCCESS (0.000s) [252.209599] Starting dynamic subtest: vcs0 [252.211737] Dynamic subtest vcs0: SUCCESS (0.001s) [252.219231] Starting dynamic subtest: vcs1 [252.221452] Dynamic subtest vcs1: SUCCESS (0.001s) [252.229049] Starting dynamic subtest: vecs0 [252.230846] Dynamic subtest vecs0: SUCCESS (0.001s) [252.239210] Starting dynamic subtest: ccs0 [252.241438] Dynamic subtest ccs0: SUCCESS (0.000s) [252.243643] Subtest init-busy: SUCCESS (0.007s) [252.296102] [058/131] (769s left) gem_ppgtt (shrink-vs-evict-any) [252.361172] Starting subtest: shrink-vs-evict-any [258.274332] Subtest shrink-vs-evict-any: SUCCESS (5.912s) [258.364154] [059/131] (763s left) gem_softpin (invalid) [258.418560] Starting subtest: invalid [258.428125] Subtest invalid: SUCCESS (0.010s) [258.555361] [060/131] (762s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf) [258.657860] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf [258.662366] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [258.724804] [061/131] (762s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs) [258.813212] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs [258.815426] Starting dynamic subtest: pipe-A-eDP-1 [258.838324] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [258.846766] Starting dynamic subtest: pipe-B-eDP-1 [258.868320] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [258.876076] Starting dynamic subtest: pipe-C-eDP-1 [258.897598] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [258.906549] Starting dynamic subtest: pipe-D-eDP-1 [258.928081] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [258.932139] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.004s) [261.104152] [062/131] (760s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt) [261.218674] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt [261.222717] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [261.326486] [063/131] (760s left) prime_busy (after-wait) [261.386495] Starting subtest: after-wait [261.391406] Starting dynamic subtest: rcs0 [261.422512] Dynamic subtest rcs0: SUCCESS (0.032s) [261.431258] Starting dynamic subtest: bcs0 [261.472196] Dynamic subtest bcs0: SUCCESS (0.047s) [261.481366] Starting dynamic subtest: vcs0 [261.513069] Dynamic subtest vcs0: SUCCESS (0.039s) [261.522059] Starting dynamic subtest: vcs1 [261.554755] Dynamic subtest vcs1: SUCCESS (0.041s) [261.564898] Starting dynamic subtest: vecs0 [261.596860] Dynamic subtest vecs0: SUCCESS (0.041s) [261.605653] Starting dynamic subtest: ccs0 [261.637726] Dynamic subtest ccs0: SUCCESS (0.040s) [261.746783] Subtest after-wait: SUCCESS (0.358s) [261.826469] [064/131] (759s left) perf_pmu (all-busy-check-all) [261.865100] Starting subtest: all-busy-check-all [263.302854] Subtest all-busy-check-all: SUCCESS (1.440s) [263.406959] [065/131] (758s left) gen9_exec_parse (bb-chained) [263.465566] Subtest bb-chained: SKIP (0.000s) [263.543048] [066/131] (758s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy) [263.673566] Starting subtest: flip-vs-cursor-crc-legacy [264.323075] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.651s) [265.142719] [067/131] (756s left) gem_exec_whisper (basic-queues) [265.205772] Starting subtest: basic-queues [270.261248] Subtest basic-queues: SUCCESS (5.053s) [270.450905] [068/131] (751s left) kms_pm_dc (dc5-dpms) [271.548745] Starting subtest: dc5-dpms [273.616247] Subtest dc5-dpms: SUCCESS (2.067s) [273.693537] [069/131] (748s left) gem_exec_flush (basic-uc-pro-default) [273.769654] Starting subtest: basic-uc-pro-default [279.225888] Subtest basic-uc-pro-default: SUCCESS (5.457s) [279.414010] [070/131] (742s left) gem_exec_balancer (bonded-false-hang) [279.669584] Starting subtest: bonded-false-hang [279.674831] Subtest bonded-false-hang: SKIP (0.000s) [279.771950] [071/131] (742s left) i915_suspend (sysfs-reader) [279.829508] Starting subtest: sysfs-reader [298.120121] Subtest sysfs-reader: SUCCESS (3.256s) [298.192716] [072/131] (723s left) syncobj_wait (single-wait-signaled) [298.255968] Starting subtest: single-wait-signaled [298.257830] Subtest single-wait-signaled: SUCCESS (0.000s) [298.358884] [073/131] (723s left) kms_setmode (invalid-clone-single-crtc-stealing) [298.402017] Starting subtest: invalid-clone-single-crtc-stealing [298.407783] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s) [298.496682] [074/131] (723s left) sw_sync (sync_busy) [298.538043] Starting subtest: sync_busy [298.540097] Subtest sync_busy: SUCCESS (0.002s) [298.588654] [075/131] (723s left) gem_ctx_persistence (hang) [298.637231] Starting subtest: hang [298.641530] Subtest hang: SKIP (0.000s) [298.736730] [076/131] (723s left) gem_exec_basic (basic) [298.784711] Starting subtest: basic [298.786754] Starting dynamic subtest: rcs0-smem [298.788625] Dynamic subtest rcs0-smem: SUCCESS (0.004s) [298.801893] Starting dynamic subtest: bcs0-smem [298.803625] Dynamic subtest bcs0-smem: SUCCESS (0.002s) [298.813173] Starting dynamic subtest: vcs0-smem [298.815064] Dynamic subtest vcs0-smem: SUCCESS (0.002s) [298.824748] Starting dynamic subtest: vcs1-smem [298.826593] Dynamic subtest vcs1-smem: SUCCESS (0.002s) [298.835244] Starting dynamic subtest: vecs0-smem [298.837114] Dynamic subtest vecs0-smem: SUCCESS (0.002s) [298.845823] Starting dynamic subtest: ccs0-smem [298.847770] Dynamic subtest ccs0-smem: SUCCESS (0.001s) [298.849608] Subtest basic: SUCCESS (0.016s) [300.404274] [077/131] (721s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt) [300.504916] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt [300.509388] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [300.602328] [078/131] (721s left) gem_lmem_swapping (massive-random) [300.645030] Subtest massive-random: SKIP (0.000s) [300.685522] [079/131] (721s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area) [300.784086] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area [300.788337] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s) [300.868604] [080/131] (721s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu) [300.976834] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu [300.980936] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [301.076541] [081/131] (721s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip) [301.188173] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip [302.186886] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.991s) [302.329664] [082/131] (720s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [302.441551] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip [302.445148] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s) [302.536712] [083/131] (719s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu) [302.639287] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu [309.324204] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.656s) [309.450765] [084/131] (713s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats) [309.547049] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats [309.549393] Starting dynamic subtest: pipe-A [309.667430] Dynamic subtest pipe-A: SKIP (0.118s) [309.676939] Starting dynamic subtest: pipe-B [310.860868] Dynamic subtest pipe-B: SKIP (1.189s) [310.873549] Starting dynamic subtest: pipe-C [312.010696] Dynamic subtest pipe-C: SUCCESS (1.153s) [312.019935] Starting dynamic subtest: pipe-D [313.240708] Dynamic subtest pipe-D: SUCCESS (1.227s) [313.243028] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.689s) [314.445673] [085/131] (708s left) syncobj_wait (multi-wait-for-submit-signaled) [314.497810] Starting subtest: multi-wait-for-submit-signaled [314.499707] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s) [314.582152] [086/131] (708s left) kms_selftest (drm_cmdline_parser) [314.627812] Starting subtest: drm_cmdline_parser [314.658189] Starting dynamic subtest: drm_test_cmdline_force_d_only [314.738526] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.079s) [314.749367] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi [314.833422] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.092s) [314.844691] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi [314.938409] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.104s) [314.948916] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital [315.049321] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.111s) [315.059931] Starting dynamic subtest: drm_test_cmdline_force_e_only [315.158014] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.107s) [315.167479] Starting dynamic subtest: drm_test_cmdline_res [315.262170] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.102s) [315.272737] Starting dynamic subtest: drm_test_cmdline_res_vesa [315.354621] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.091s) [315.365546] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank [315.449829] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.095s) [315.460237] Starting dynamic subtest: drm_test_cmdline_res_rblank [315.533341] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.082s) [315.543557] Starting dynamic subtest: drm_test_cmdline_res_bpp [315.624001] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.092s) [315.632839] Starting dynamic subtest: drm_test_cmdline_res_refresh [315.721415] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.093s) [315.730257] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh [315.810519] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.089s) [315.819167] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced [315.919765] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.109s) [315.928523] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins [316.022070] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.102s) [316.030670] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off [316.116328] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.092s) [316.126550] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on [316.224055] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.108s) [316.232482] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog [316.324933] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.101s) [316.333716] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital [316.416790] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.091s) [316.425777] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on [316.501790] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.081s) [316.522354] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on [316.591613] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.088s) [316.602615] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins [316.684874] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.093s) [316.700861] Starting dynamic subtest: drm_test_cmdline_name [316.776423] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.091s) [316.786157] Starting dynamic subtest: drm_test_cmdline_name_bpp [316.889419] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.111s) [316.900682] Starting dynamic subtest: drm_test_cmdline_name_option [317.001442] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.110s) [317.012434] Starting dynamic subtest: drm_test_cmdline_name_bpp_option [317.107803] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.105s) [317.118474] Starting dynamic subtest: drm_test_cmdline_rotate_0 [317.204419] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.096s) [317.214576] Starting dynamic subtest: drm_test_cmdline_rotate_90 [317.289378] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.083s) [317.300124] Starting dynamic subtest: drm_test_cmdline_rotate_180 [317.385723] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.095s) [317.397263] Starting dynamic subtest: drm_test_cmdline_rotate_270 [317.480331] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.094s) [317.490896] Starting dynamic subtest: drm_test_cmdline_hmirror [317.578808] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.097s) [317.589596] Starting dynamic subtest: drm_test_cmdline_vmirror [317.673975] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.095s) [317.685386] Starting dynamic subtest: drm_test_cmdline_margin_options [317.756421] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.081s) [317.766523] Starting dynamic subtest: drm_test_cmdline_multiple_options [317.862357] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.106s) [317.872721] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option [317.956711] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.094s) [317.966418] Starting dynamic subtest: drm_test_cmdline_extra_and_option [318.068801] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.110s) [318.078582] Starting dynamic subtest: drm_test_cmdline_freestanding_options [318.164649] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.095s) [318.174184] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options [318.259765] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.094s) [318.268776] Starting dynamic subtest: drm_test_cmdline_panel_orientation [318.354761] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.094s) [318.365534] Starting dynamic subtest: drm_test_cmdline_invalid [318.459202] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.105s) [318.468889] Starting dynamic subtest: drm_test_cmdline_tv_options [318.594871] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.132s) [318.596789] Subtest drm_cmdline_parser: SUCCESS (3.962s) [318.763735] [087/131] (703s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt) [318.872374] Starting subtest: psr-rgb565-draw-blt [325.820184] Subtest psr-rgb565-draw-blt: SUCCESS (6.945s) [325.935642] [088/131] (696s left) gem_readwrite (write-bad-handle) [325.997888] Subtest write-bad-handle: SKIP (0.000s) [326.057773] [089/131] (696s left) kms_pipe_crc_basic (disable-crc-after-crtc) [326.158122] Starting subtest: disable-crc-after-crtc [326.160481] Starting dynamic subtest: pipe-A-eDP-1 [327.850027] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.689s) [327.860519] Starting dynamic subtest: pipe-B-eDP-1 [330.104899] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.255s) [330.116599] Starting dynamic subtest: pipe-C-eDP-1 [332.352532] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.245s) [332.362724] Starting dynamic subtest: pipe-D-eDP-1 [334.615232] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.262s) [334.617812] Subtest disable-crc-after-crtc: SUCCESS (8.457s) [335.451846] [090/131] (687s left) kms_cdclk (plane-scaling) [335.559508] Starting subtest: plane-scaling [335.561895] Starting dynamic subtest: pipe-A-eDP-1 [335.853945] Dynamic subtest pipe-A-eDP-1: SKIP (0.292s) [335.864100] Starting dynamic subtest: pipe-B-eDP-1 [335.868791] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [335.878504] Starting dynamic subtest: pipe-C-eDP-1 [335.883224] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [335.892072] Starting dynamic subtest: pipe-D-eDP-1 [335.896559] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [335.900972] Subtest plane-scaling: SKIP (0.299s) [336.674726] [091/131] (686s left) kms_plane_multiple (2x-tiling-x) [336.779771] Starting subtest: 2x-tiling-x [336.784031] Subtest 2x-tiling-x: SKIP (0.000s) [336.849832] [092/131] (686s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt) [336.947675] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt [336.951892] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [337.057653] [093/131] (685s left) kms_psr (psr-cursor-mmap-cpu) [337.147704] Starting subtest: psr-cursor-mmap-cpu [337.149967] Starting dynamic subtest: eDP-1 [338.872843] Dynamic subtest eDP-1: SUCCESS (1.725s) [338.875298] Subtest psr-cursor-mmap-cpu: SUCCESS (1.726s) [339.750631] [094/131] (683s left) gem_mmap_offset (partial-mmap) [339.804444] Starting subtest: partial-mmap [339.806766] Starting dynamic subtest: smem0 [339.809008] Dynamic subtest smem0: SUCCESS (0.004s) [339.810928] Subtest partial-mmap: SUCCESS (0.004s) [339.927449] [095/131] (683s left) i915_hangman (engine-error-state-capture) [339.995943] Starting subtest: engine-error-state-capture [339.998173] Starting dynamic subtest: rcs0 [343.257093] Dynamic subtest rcs0: SUCCESS (3.260s) [343.269436] Starting dynamic subtest: bcs0 [349.272155] Dynamic subtest bcs0: SUCCESS (6.011s) [349.285479] Starting dynamic subtest: vcs0 [355.226016] Dynamic subtest vcs0: SUCCESS (5.949s) [355.242069] Starting dynamic subtest: vcs1 [360.218179] Dynamic subtest vcs1: SUCCESS (4.988s) [360.229477] Starting dynamic subtest: vecs0 [365.272680] Dynamic subtest vecs0: SUCCESS (5.050s) [365.286644] Starting dynamic subtest: ccs0 [371.289204] Dynamic subtest ccs0: SUCCESS (6.011s) [371.292178] Subtest engine-error-state-capture: SUCCESS (31.285s) [371.376481] [096/131] (651s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling) [371.472585] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling [371.476645] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s) [371.553612] [097/131] (651s left) kms_big_fb (x-tiled-32bpp-rotate-180) [371.643902] Starting subtest: x-tiled-32bpp-rotate-180 [372.948334] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.302s) [373.078811] [098/131] (650s left) kms_cursor_crc (cursor-offscreen-64x64) [373.252426] Starting subtest: cursor-offscreen-64x64 [373.256568] Starting dynamic subtest: pipe-A-eDP-1 [375.203511] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.944s) [375.236128] Starting dynamic subtest: pipe-D-eDP-1 [377.786946] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.559s) [377.789127] Subtest cursor-offscreen-64x64: SUCCESS (4.530s) [378.654462] [099/131] (644s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier) [378.747506] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier [378.773368] Starting dynamic subtest: pipe-A-plane-0 [379.064903] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s) [379.074677] Starting dynamic subtest: pipe-A-plane-3 [379.296000] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s) [379.306272] Starting dynamic subtest: pipe-A-plane-5 [379.310563] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [380.442555] Starting dynamic subtest: pipe-B-plane-0 [380.747039] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s) [380.756641] Starting dynamic subtest: pipe-B-plane-3 [380.978587] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s) [380.989527] Starting dynamic subtest: pipe-B-plane-5 [380.994173] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [381.302642] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.553s) [382.131794] [100/131] (641s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0) [382.229117] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0 [382.233763] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s) [382.321909] [101/131] (640s left) kms_flip (2x-modeset-vs-vblank-race-interruptible) [382.414083] Starting subtest: 2x-modeset-vs-vblank-race-interruptible [382.425741] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.010s) [382.519400] [102/131] (640s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt) [382.619442] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt [382.623438] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [382.701576] [103/131] (640s left) gem_render_copy_redux (flink) [382.761760] Starting subtest: flink [383.539540] Subtest flink: SUCCESS (0.778s) [383.649546] [104/131] (639s left) gem_ctx_create (basic) [383.703352] Starting subtest: basic [383.705351] Subtest basic: SUCCESS (0.000s) [383.888199] [105/131] (639s left) i915_pm_rpm (gem-idle) [385.418602] Starting subtest: gem-idle [391.620090] Subtest gem-idle: SUCCESS (6.201s) [391.951296] [106/131] (631s left) gem_ctx_isolation (dirty-create) [393.251540] Starting subtest: dirty-create [393.254038] Starting dynamic subtest: rcs0 [393.440544] Dynamic subtest rcs0: SUCCESS (0.189s) [393.450878] Starting dynamic subtest: bcs0 [393.642176] Dynamic subtest bcs0: SUCCESS (0.201s) [393.654356] Starting dynamic subtest: vcs0 [393.842891] Dynamic subtest vcs0: SUCCESS (0.200s) [393.854845] Starting dynamic subtest: vcs1 [395.513518] Dynamic subtest vcs1: SUCCESS (1.670s) [395.525344] Starting dynamic subtest: vecs0 [397.498152] Dynamic subtest vecs0: SUCCESS (1.984s) [397.509363] Starting dynamic subtest: ccs0 [399.560109] Dynamic subtest ccs0: SUCCESS (2.061s) [399.562628] Subtest dirty-create: SUCCESS (6.311s) [399.812227] [107/131] (623s left) gem_exec_schedule (independent) [399.876580] Starting subtest: independent [399.878626] Starting dynamic subtest: rcs0 [401.338573] Dynamic subtest rcs0: SUCCESS (1.470s) [401.351872] Starting dynamic subtest: vcs0 [403.332249] Dynamic subtest vcs0: SUCCESS (1.991s) [403.345047] Starting dynamic subtest: vcs1 [405.319206] Dynamic subtest vcs1: SUCCESS (1.985s) [405.331548] Starting dynamic subtest: vecs0 [407.362720] Dynamic subtest vecs0: SUCCESS (2.041s) [407.375608] Starting dynamic subtest: ccs0 [409.337360] Dynamic subtest ccs0: SUCCESS (1.973s) [409.340140] Subtest independent: SUCCESS (9.472s) [409.644713] [108/131] (613s left) kms_lease (lease-invalid-plane) [409.739440] Starting subtest: lease-invalid-plane [409.741675] Starting dynamic subtest: pipe-A-eDP-1 [409.743997] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [409.753755] Starting dynamic subtest: pipe-B-eDP-1 [409.756025] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [409.764722] Starting dynamic subtest: pipe-C-eDP-1 [409.767068] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [409.776007] Starting dynamic subtest: pipe-D-eDP-1 [409.778254] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [409.780411] Subtest lease-invalid-plane: SUCCESS (0.004s) [409.817968] [109/131] (613s left) core_setmaster (master-drop-set-user) [409.902394] Starting subtest: master-drop-set-user [409.916609] Subtest master-drop-set-user: SUCCESS (0.016s) [409.959762] [110/131] (613s left) kms_tv_load_detect (load-detect) [410.011510] Subtest load-detect: SKIP (0.000s) [410.066506] [111/131] (613s left) gem_exec_reloc (basic-wc-gtt-noreloc) [410.120040] Subtest basic-wc-gtt-noreloc: SKIP (0.000s) [410.197029] [112/131] (613s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt) [410.295540] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt [417.522493] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.230s) [417.639245] [113/131] (606s left) drm_read (fault-buffer) [417.794114] Starting subtest: fault-buffer [417.796532] Subtest fault-buffer: SUCCESS (0.001s) [417.932488] [114/131] (605s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted) [417.994931] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted [418.102122] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.107s) [418.177561] [115/131] (605s left) syncobj_timeline (wait-any-snapshot) [418.232753] Starting subtest: wait-any-snapshot [418.313712] Subtest wait-any-snapshot: SUCCESS (0.082s) [418.405099] [116/131] (605s left) kms_color (ctm-red-to-blue) [418.495663] Starting subtest: ctm-red-to-blue [418.497904] Starting dynamic subtest: pipe-A-eDP-1 [419.205118] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s) [419.215792] Starting dynamic subtest: pipe-B-eDP-1 [420.581482] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.378s) [420.596901] Starting dynamic subtest: pipe-C-eDP-1 [421.959715] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.377s) [421.970022] Starting dynamic subtest: pipe-D-eDP-1 [423.294328] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.334s) [423.296526] Subtest ctm-red-to-blue: SUCCESS (4.801s) [424.092829] [117/131] (599s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt) [424.190154] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt [424.194238] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s) [424.284946] [118/131] (599s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs) [424.383349] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs [424.385645] Starting dynamic subtest: pipe-A-eDP-1 [424.442342] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [424.451910] Starting dynamic subtest: pipe-B-eDP-1 [424.509643] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [424.520781] Starting dynamic subtest: pipe-C-eDP-1 [424.577824] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [424.588853] Starting dynamic subtest: pipe-D-eDP-1 [424.648100] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [424.652548] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.010s) [426.659924] [119/131] (597s left) kms_pm_rpm (pm-caching) [428.486693] Starting subtest: pm-caching [428.491547] Subtest pm-caching: SKIP (0.000s) [428.918268] [120/131] (595s left) kms_big_fb (y-tiled-8bpp-rotate-0) [429.005518] Starting subtest: y-tiled-8bpp-rotate-0 [429.010131] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s) [429.105520] [121/131] (594s left) gem_exec_reloc (basic-write-gtt) [429.164637] Subtest basic-write-gtt: SKIP (0.000s) [429.235724] [122/131] (594s left) gem_exec_schedule (smoketest-all) [429.309328] Starting subtest: smoketest-all [461.682123] Subtest smoketest-all: SUCCESS (32.315s) [463.457382] [123/131] (560s left) gem_mmap_gtt (big-copy) [463.518954] Subtest big-copy: SKIP (0.000s) [463.583720] [124/131] (560s left) gem_render_copy (linear-to-vebox-y-tiled) [463.639543] Starting subtest: linear-to-vebox-y-tiled [463.643401] Subtest linear-to-vebox-y-tiled: SKIP (0.000s) [463.823384] [125/131] (560s left) kms_chamelium_edid (dp-edid-stress-resolution-4k) [464.218451] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s) [465.017378] [126/131] (559s left) dumb_buffer (map-uaf) [465.072826] Starting subtest: map-uaf [465.074898] Subtest map-uaf: SUCCESS (0.005s) [465.167655] [127/131] (559s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite) [465.272012] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite [472.144651] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.874s) [472.284800] [128/131] (552s left) kms_vrr (seamless-rr-switch-vrr) [472.376565] Starting subtest: seamless-rr-switch-vrr [472.382599] Subtest seamless-rr-switch-vrr: SKIP (0.000s) [472.453838] [129/131] (551s left) gem_shrink (reclaim) [472.516943] Starting subtest: reclaim [474.927944] Subtest reclaim: SUCCESS (2.412s) [475.075427] [130/131] (549s left) kms_psr (fbc-psr-sprite-mmap-cpu) [475.174321] Starting subtest: fbc-psr-sprite-mmap-cpu [475.176657] Starting dynamic subtest: eDP-1 [475.180957] Dynamic subtest eDP-1: SKIP (0.000s) [475.185437] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s) [475.245617] [131/131] (549s left) kms_flip (flip-vs-absolute-wf_vblank) [475.340832] Starting subtest: flip-vs-absolute-wf_vblank [475.343355] Starting dynamic subtest: A-eDP1 [484.272548] Dynamic subtest A-eDP1: SUCCESS (8.932s) [484.284642] Starting dynamic subtest: B-eDP1 [493.199819] Dynamic subtest B-eDP1: SUCCESS (8.922s) [493.211866] Starting dynamic subtest: C-eDP1 [502.129174] Dynamic subtest C-eDP1: SUCCESS (8.922s) [502.140989] Starting dynamic subtest: D-eDP1 [511.064723] Dynamic subtest D-eDP1: SUCCESS (8.927s) [511.067163] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.718s) [512.282657] Closing watchdogs results: parsing output: 0/ for test: kms_cursor_legacy results: parsing output: 1/ for test: syncobj_timeline results: parsing output: 2/ for test: core_debugfs results: parsing output: 3/ for test: kms_big_fb results: parsing output: 4/ for test: kms_addfb_basic results: parsing output: 5/ for test: gem_exec_schedule results: parsing output: 6/ for test: perf results: parsing output: 7/ for test: kms_psr2_sf results: parsing output: 8/ for test: kms_big_fb results: parsing output: 9/ for test: kms_cursor_legacy results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: syncobj_wait results: parsing output: 12/ for test: kms_psr results: parsing output: 13/ for test: kms_cursor_crc results: parsing output: 14/ for test: kms_cursor_legacy results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: kms_frontbuffer_tracking results: parsing output: 17/ for test: gem_partial_pwrite_pread results: parsing output: 18/ for test: kms_ccs results: parsing output: 19/ for test: syncobj_timeline results: parsing output: 20/ for test: gem_reg_read results: parsing output: 21/ for test: gem_wait results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: gem_exec_fence results: parsing output: 24/ for test: gem_exec_schedule results: parsing output: 25/ for test: kms_frontbuffer_tracking results: parsing output: 26/ for test: kms_cursor_crc results: parsing output: 27/ for test: gem_mmap_gtt results: parsing output: 28/ for test: kms_dp_link_training results: parsing output: 29/ for test: i915_drm_fdinfo results: parsing output: 30/ for test: kms_plane_scaling results: parsing output: 31/ for test: gem_exec_nop results: parsing output: 32/ for test: kms_ccs results: parsing output: 33/ for test: kms_frontbuffer_tracking results: parsing output: 34/ for test: gem_caching results: parsing output: 35/ for test: kms_chamelium_hpd results: parsing output: 36/ for test: gem_ctx_param results: parsing output: 37/ for test: syncobj_wait results: parsing output: 38/ for test: kms_addfb_basic results: parsing output: 39/ for test: kms_flip_scaled_crc results: parsing output: 40/ for test: gem_ctx_exec results: parsing output: 41/ for test: api_intel_allocator results: parsing output: 42/ for test: kms_psr results: parsing output: 43/ for test: syncobj_timeline results: parsing output: 44/ for test: gem_ctx_param results: parsing output: 45/ for test: gem_tiled_swapping results: parsing output: 46/ for test: kms_atomic results: parsing output: 47/ for test: kms_hdr results: parsing output: 48/ for test: syncobj_timeline results: parsing output: 49/ for test: kms_vblank results: parsing output: 50/ for test: kms_psr results: parsing output: 51/ for test: gem_render_copy results: parsing output: 52/ for test: kms_content_protection results: parsing output: 53/ for test: gem_softpin results: parsing output: 54/ for test: kms_flip_scaled_crc results: parsing output: 55/ for test: kms_invalid_mode results: parsing output: 56/ for test: perf_pmu results: parsing output: 57/ for test: gem_ppgtt results: parsing output: 58/ for test: gem_softpin results: parsing output: 59/ for test: kms_psr2_sf results: parsing output: 60/ for test: kms_ccs results: parsing output: 61/ for test: kms_frontbuffer_tracking results: parsing output: 62/ for test: prime_busy results: parsing output: 63/ for test: perf_pmu results: parsing output: 64/ for test: gen9_exec_parse results: parsing output: 65/ for test: kms_cursor_legacy results: parsing output: 66/ for test: gem_exec_whisper results: parsing output: 67/ for test: kms_pm_dc results: parsing output: 68/ for test: gem_exec_flush results: parsing output: 69/ for test: gem_exec_balancer results: parsing output: 70/ for test: i915_suspend results: parsing output: 71/ for test: syncobj_wait results: parsing output: 72/ for test: kms_setmode results: parsing output: 73/ for test: sw_sync results: parsing output: 74/ for test: gem_ctx_persistence results: parsing output: 75/ for test: gem_exec_basic results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: gem_lmem_swapping results: parsing output: 78/ for test: kms_psr2_sf results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: kms_big_fb results: parsing output: 81/ for test: kms_big_fb results: parsing output: 82/ for test: kms_frontbuffer_tracking results: parsing output: 83/ for test: kms_plane_scaling results: parsing output: 84/ for test: syncobj_wait results: parsing output: 85/ for test: kms_selftest results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: gem_readwrite results: parsing output: 88/ for test: kms_pipe_crc_basic results: parsing output: 89/ for test: kms_cdclk results: parsing output: 90/ for test: kms_plane_multiple results: parsing output: 91/ for test: kms_frontbuffer_tracking results: parsing output: 92/ for test: kms_psr results: parsing output: 93/ for test: gem_mmap_offset results: parsing output: 94/ for test: i915_hangman results: parsing output: 95/ for test: kms_flip_scaled_crc results: parsing output: 96/ for test: kms_big_fb results: parsing output: 97/ for test: kms_cursor_crc results: parsing output: 98/ for test: kms_plane results: parsing output: 99/ for test: kms_big_fb results: parsing output: 100/ for test: kms_flip results: parsing output: 101/ for test: kms_frontbuffer_tracking results: parsing output: 102/ for test: gem_render_copy_redux results: parsing output: 103/ for test: gem_ctx_create results: parsing output: 104/ for test: i915_pm_rpm results: parsing output: 105/ for test: gem_ctx_isolation results: parsing output: 106/ for test: gem_exec_schedule results: parsing output: 107/ for test: kms_lease results: parsing output: 108/ for test: core_setmaster results: parsing output: 109/ for test: kms_tv_load_detect results: parsing output: 110/ for test: gem_exec_reloc results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: drm_read results: parsing output: 113/ for test: syncobj_timeline results: parsing output: 114/ for test: syncobj_timeline results: parsing output: 115/ for test: kms_color results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: kms_ccs results: parsing output: 118/ for test: kms_pm_rpm results: parsing output: 119/ for test: kms_big_fb results: parsing output: 120/ for test: gem_exec_reloc results: parsing output: 121/ for test: gem_exec_schedule results: parsing output: 122/ for test: gem_mmap_gtt results: parsing output: 123/ for test: gem_render_copy results: parsing output: 124/ for test: kms_chamelium_edid results: parsing output: 125/ for test: dumb_buffer results: parsing output: 126/ for test: kms_frontbuffer_tracking results: parsing output: 127/ for test: kms_vrr results: parsing output: 128/ for test: gem_shrink results: parsing output: 129/ for test: kms_psr results: parsing output: 130/ for test: kms_flip Done.