[58.936850] Initializing watchdogs [58.936894] /dev/watchdog0 [58.951295] [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.955625] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.957744] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.961578] [001/156] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt) [59.086793] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt [59.091555] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [59.182538] [002/156] (960s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc) [59.291360] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc [59.295720] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [59.405885] [003/156] (960s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions) [59.532773] Starting subtest: cursorB-vs-flipB-atomic-transitions [59.537301] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s) [59.678239] [004/156] (959s left) gem_pread (snoop) [59.736124] Subtest snoop: SKIP (0.000s) [59.789496] [005/156] (959s left) kms_psr (fbc-psr2-primary-page-flip) [59.875411] Starting subtest: fbc-psr2-primary-page-flip [59.877722] Starting dynamic subtest: eDP-1 [59.882120] Dynamic subtest eDP-1: SKIP (0.000s) [59.886342] Subtest fbc-psr2-primary-page-flip: SKIP (0.000s) [59.947678] [006/156] (959s left) kms_busy (extended-modeset-hang-oldfb) [60.040603] Starting subtest: extended-modeset-hang-oldfb [60.042539] Starting dynamic subtest: pipe-A [71.977262] Dynamic subtest pipe-A: SUCCESS (11.936s) [71.984889] Starting dynamic subtest: pipe-D [84.240370] Dynamic subtest pipe-D: SUCCESS (12.260s) [84.242721] Subtest extended-modeset-hang-oldfb: SUCCESS (24.199s) [85.120690] [007/156] (934s left) api_intel_bb (reset-bb) [85.183890] Starting subtest: reset-bb [85.185798] Subtest reset-bb: SUCCESS (0.004s) [85.305355] [008/156] (934s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt) [85.417588] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt [92.861538] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.453s) [92.996595] [009/156] (926s left) kms_flip (2x-flip-vs-suspend) [93.088513] Starting subtest: 2x-flip-vs-suspend [93.093276] Subtest 2x-flip-vs-suspend: SKIP (0.002s) [93.196196] [010/156] (926s left) gem_exec_reloc (basic-cpu-gtt-active) [93.261490] Subtest basic-cpu-gtt-active: SKIP (0.000s) [93.315943] [011/156] (926s left) gem_ctx_isolation (nonpriv) [93.375415] Starting subtest: nonpriv [93.377781] Starting dynamic subtest: rcs0 [93.611698] Dynamic subtest rcs0: SUCCESS (0.236s) [93.622671] Starting dynamic subtest: bcs0 [93.906089] Dynamic subtest bcs0: SUCCESS (0.294s) [93.915717] Starting dynamic subtest: vcs0 [94.145136] Dynamic subtest vcs0: SUCCESS (0.239s) [94.155179] Starting dynamic subtest: vcs1 [95.497101] Dynamic subtest vcs1: SUCCESS (1.351s) [95.507204] Starting dynamic subtest: vecs0 [97.515403] Dynamic subtest vecs0: SUCCESS (2.018s) [97.523427] Starting dynamic subtest: ccs0 [99.515701] Dynamic subtest ccs0: SUCCESS (1.999s) [99.518139] Subtest nonpriv: SUCCESS (6.140s) [99.776238] [012/156] (920s left) i915_pm_rps (fence-order) [99.835723] Starting subtest: fence-order [102.758628] Subtest fence-order: SUCCESS (2.920s) [102.887967] [013/156] (917s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-mmap-gtt) [102.994476] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-mmap-gtt [102.998673] Subtest fbchdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [103.082302] [014/156] (916s left) sysfs_preempt_timeout (invalid) [103.144802] Starting subtest: invalid [103.147193] Starting dynamic subtest: vecs0 [103.149344] Dynamic subtest vecs0: SUCCESS (0.000s) [103.157117] Starting dynamic subtest: ccs0 [103.158966] Dynamic subtest ccs0: SUCCESS (0.000s) [103.166783] Starting dynamic subtest: vcs0 [103.168691] Dynamic subtest vcs0: SUCCESS (0.000s) [103.176437] Starting dynamic subtest: bcs0 [103.178358] Dynamic subtest bcs0: SUCCESS (0.000s) [103.186177] Starting dynamic subtest: rcs0 [103.188054] Dynamic subtest rcs0: SUCCESS (0.000s) [103.196401] Starting dynamic subtest: vcs1 [103.198636] Dynamic subtest vcs1: SUCCESS (0.000s) [103.200850] Subtest invalid: SUCCESS (0.003s) [103.248719] [015/156] (916s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render) [103.341827] Starting subtest: fbc-rgb101010-draw-render [105.889413] Subtest fbc-rgb101010-draw-render: SUCCESS (2.551s) [107.079798] [016/156] (912s left) kms_ccs (crc-primary-basic-y-tiled-ccs) [107.178311] Starting subtest: crc-primary-basic-y-tiled-ccs [107.180732] Starting dynamic subtest: pipe-A-eDP-1 [107.204637] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [107.215552] Starting dynamic subtest: pipe-B-eDP-1 [107.237383] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [107.245817] Starting dynamic subtest: pipe-C-eDP-1 [107.267887] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [107.276157] Starting dynamic subtest: pipe-D-eDP-1 [107.298355] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [107.302821] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.004s) [109.424573] [017/156] (910s left) syncobj_wait (signal) [109.486188] Starting subtest: signal [109.488362] Subtest signal: SUCCESS (0.000s) [109.608727] [018/156] (910s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [109.708238] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip [110.343377] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.637s) [110.490426] [019/156] (909s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt) [110.593978] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt [110.598176] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s) [110.682053] [020/156] (909s left) gem_exec_params (larger-than-life-batch) [110.740131] Starting subtest: larger-than-life-batch [113.018065] Subtest larger-than-life-batch: SUCCESS (2.277s) [113.337706] [021/156] (906s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-indfb-plflip-blt) [113.488851] Starting subtest: psrhdr-1p-primscrn-indfb-plflip-blt [113.493219] Subtest psrhdr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s) [113.588707] [022/156] (906s left) perf (gen12-mi-rpc) [113.737615] Starting subtest: gen12-mi-rpc [113.739488] Starting dynamic subtest: rcs0 [113.755753] Dynamic subtest rcs0: SUCCESS (0.017s) [113.757985] Subtest gen12-mi-rpc: SUCCESS (0.018s) [113.800662] [023/156] (906s left) kms_cursor_crc (cursor-rapid-movement-32x32) [113.961088] Starting subtest: cursor-rapid-movement-32x32 [114.006921] Subtest cursor-rapid-movement-32x32: SKIP (0.041s) [114.293061] [024/156] (906s left) kms_universal_plane (cursor-fb-leak) [114.377057] Starting subtest: cursor-fb-leak [114.378871] Starting dynamic subtest: pipe-A-eDP-1 [114.695738] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.319s) [114.707582] Starting dynamic subtest: pipe-B-eDP-1 [116.023105] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.326s) [116.036439] Starting dynamic subtest: pipe-C-eDP-1 [117.365165] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.340s) [117.377009] Starting dynamic subtest: pipe-D-eDP-1 [118.684226] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.318s) [118.686683] Subtest cursor-fb-leak: SUCCESS (4.308s) [119.867936] [025/156] (900s left) perf (stress-open-close) [119.946628] Starting subtest: stress-open-close [119.949095] Starting dynamic subtest: 0-rcs0 [122.110230] Dynamic subtest 0-rcs0: SUCCESS (2.164s) [122.119098] Starting dynamic subtest: 1-vecs0 [124.275063] Dynamic subtest 1-vecs0: SUCCESS (2.164s) [124.277032] Subtest stress-open-close: SUCCESS (4.329s) [124.316565] [026/156] (896s left) kms_pm_rpm (legacy-planes-dpms) [126.460734] Starting subtest: legacy-planes-dpms [126.462926] Starting dynamic subtest: plane-65 [134.898584] Dynamic subtest plane-65: SUCCESS (8.442s) [134.910151] Starting dynamic subtest: plane-95 [143.228992] Dynamic subtest plane-95: SUCCESS (8.329s) [143.240721] Starting dynamic subtest: plane-125 [151.568430] Dynamic subtest plane-125: SUCCESS (8.337s) [151.580893] Starting dynamic subtest: plane-135 [160.335067] Dynamic subtest plane-135: SUCCESS (8.765s) [160.337890] Subtest legacy-planes-dpms: SUCCESS (33.879s) [160.747912] [027/156] (859s left) gem_watchdog (default-virtual) [160.811640] Starting subtest: default-virtual [167.092745] Subtest default-virtual: SUCCESS (6.287s) [167.180081] [028/156] (853s left) gem_exec_fence (submit3) [167.353585] Starting subtest: submit3 [167.358521] Subtest submit3: SKIP (0.000s) [169.377370] [FACT gem_exec_fence (submit3)] new: kernel.kmod_is_loaded.vgem: true [169.380346] [029/156] (851s left) gem_exec_fence (basic-busy) [169.557291] Starting subtest: basic-busy [169.559922] Starting dynamic subtest: rcs0 [169.652359] Dynamic subtest rcs0: SUCCESS (0.095s) [169.663529] Starting dynamic subtest: bcs0 [169.706060] Dynamic subtest bcs0: SUCCESS (0.053s) [169.716881] Starting dynamic subtest: vcs0 [169.760432] Dynamic subtest vcs0: SUCCESS (0.053s) [169.770968] Starting dynamic subtest: vcs1 [169.815375] Dynamic subtest vcs1: SUCCESS (0.054s) [169.826084] Starting dynamic subtest: vecs0 [169.868491] Dynamic subtest vecs0: SUCCESS (0.052s) [169.879491] Starting dynamic subtest: ccs0 [169.931952] Dynamic subtest ccs0: SUCCESS (0.062s) [169.934758] Subtest basic-busy: SUCCESS (0.375s) [171.346459] [030/156] (849s left) kms_cursor_legacy (cursora-vs-flipa-legacy) [171.462415] Starting subtest: cursorA-vs-flipA-legacy [182.611652] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.147s) [183.470715] [031/156] (837s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt) [183.585409] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt [183.589707] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [183.687718] [032/156] (836s left) kms_addfb_basic (bad-pitch-128) [183.737247] Starting subtest: bad-pitch-128 [183.739439] Subtest bad-pitch-128: SUCCESS (0.000s) [183.878726] [033/156] (836s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation) [183.963867] Starting subtest: plane-scaler-unity-scaling-with-rotation [183.966060] Starting dynamic subtest: pipe-A [184.201473] Dynamic subtest pipe-A: SUCCESS (0.239s) [184.212892] Starting dynamic subtest: pipe-B [185.544177] Dynamic subtest pipe-B: SUCCESS (1.342s) [185.553317] Starting dynamic subtest: pipe-C [186.876736] Dynamic subtest pipe-C: SUCCESS (1.332s) [186.888498] Starting dynamic subtest: pipe-D [188.201954] Dynamic subtest pipe-D: SUCCESS (1.325s) [188.204775] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.240s) [189.388321] [034/156] (831s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-blt) [189.480953] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-blt [189.485307] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s) [189.582574] [035/156] (831s left) kms_chamelium_hpd (dp-hpd-storm) [189.973776] Subtest dp-hpd-storm: SKIP (0.000s) [190.793792] [036/156] (830s left) gem_ctx_persistence (legacy-engines-hostile) [190.860043] Starting subtest: legacy-engines-hostile [190.862424] Starting dynamic subtest: render [190.933825] Dynamic subtest render: SUCCESS (0.073s) [190.946109] Starting dynamic subtest: bsd1 [191.034161] Dynamic subtest bsd1: SUCCESS (0.097s) [191.044734] Starting dynamic subtest: bsd2 [191.130718] Dynamic subtest bsd2: SUCCESS (0.094s) [191.142223] Starting dynamic subtest: blt [191.218786] Dynamic subtest blt: SUCCESS (0.086s) [191.231877] Starting dynamic subtest: vebox [191.310598] Dynamic subtest vebox: SUCCESS (0.090s) [191.313049] Subtest legacy-engines-hostile: SUCCESS (0.452s) [191.389892] [037/156] (829s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-mmap-gtt) [191.493170] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-mmap-gtt [191.497292] Subtest hdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [191.585861] [038/156] (829s left) syncobj_timeline (invalid-multi-wait-unsubmitted) [191.648048] Starting subtest: invalid-multi-wait-unsubmitted [191.650419] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [191.744032] [039/156] (829s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt) [191.833604] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt [191.837195] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [191.953360] [040/156] (829s left) kms_psr (psr-dpms) [192.049785] Starting subtest: psr-dpms [192.051714] Starting dynamic subtest: eDP-1 [195.038404] Dynamic subtest eDP-1: SUCCESS (2.987s) [195.040374] Subtest psr-dpms: SUCCESS (2.988s) [195.896864] [041/156] (825s left) gem_create (hog-create) [195.948944] Starting subtest: hog-create [195.951334] Starting dynamic subtest: smem0 [229.310268] Dynamic subtest smem0: SUCCESS (33.359s) [229.312837] Subtest hog-create: SUCCESS (33.360s) [229.518312] [042/156] (791s left) kms_big_fb (linear-32bpp-rotate-180) [229.625928] Starting subtest: linear-32bpp-rotate-180 [231.131487] Subtest linear-32bpp-rotate-180: SUCCESS (1.502s) [231.283702] [043/156] (789s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move) [231.374315] Starting subtest: psr-1p-primscrn-cur-indfb-move [238.723536] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.354s) [238.858947] [044/156] (782s left) syncobj_wait (wait-for-submit-delayed-submit) [238.911217] Starting subtest: wait-for-submit-delayed-submit [239.013080] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s) [239.101294] [045/156] (782s left) prime_mmap (test_correct) [239.150680] Starting subtest: test_correct [239.152821] Starting dynamic subtest: test_correct-smem [239.182976] Dynamic subtest test_correct-smem: SUCCESS (0.033s) [239.185492] Subtest test_correct: SUCCESS (0.034s) [239.282375] [046/156] (781s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-render) [239.383645] Starting subtest: fbcpsrhdr-rgb565-draw-render [239.387725] Subtest fbcpsrhdr-rgb565-draw-render: SKIP (0.000s) [239.483604] [047/156] (781s left) gem_exec_params (cliprects-invalid) [239.541606] Starting subtest: cliprects-invalid [239.544039] Subtest cliprects-invalid: SUCCESS (0.000s) [239.640291] [048/156] (781s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled) [239.696444] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled [239.698755] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.001s) [239.814327] [049/156] (781s left) i915_fb_tiling (basic-x-tiling) [239.862538] Subtest basic-x-tiling: SKIP (0.000s) [239.917403] [050/156] (781s left) gem_ccs (block-copy-compressed) [239.981178] Starting subtest: block-copy-compressed [239.985567] Subtest block-copy-compressed: SKIP (0.000s) [240.082198] [051/156] (781s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff) [240.181928] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff [240.185504] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [240.283030] [052/156] (781s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-move) [240.375745] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-move [240.379295] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-move: SKIP (0.000s) [240.467179] [053/156] (781s left) gem_userptr_blits (coherency-unsync) [240.524350] Subtest coherency-unsync: SKIP (0.000s) [240.642357] [054/156] (780s left) kms_big_fb (y-tiled-64bpp-rotate-0) [240.735260] Starting subtest: y-tiled-64bpp-rotate-0 [240.738952] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s) [240.848387] [055/156] (780s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-mmap-cpu) [240.954458] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-mmap-cpu [240.958225] Subtest fbchdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [241.066069] [056/156] (780s left) syncobj_timeline (single-wait-available-submitted) [241.123077] Starting subtest: single-wait-available-submitted [241.124735] Subtest single-wait-available-submitted: SUCCESS (0.000s) [241.218484] [057/156] (780s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling) [241.312551] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling [241.314586] Starting dynamic subtest: pipe-A-default-mode [244.035604] Dynamic subtest pipe-A-default-mode: SUCCESS (2.722s) [244.038093] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.724s) [244.895149] [058/156] (776s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu) [245.003067] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu [245.007299] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [245.105177] [059/156] (776s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs) [245.211177] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs [245.213417] Starting dynamic subtest: pipe-A-eDP-1 [245.236363] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [245.247996] Starting dynamic subtest: pipe-B-eDP-1 [245.269300] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [245.278996] Starting dynamic subtest: pipe-C-eDP-1 [245.300119] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [245.309483] Starting dynamic subtest: pipe-D-eDP-1 [245.332434] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [245.336874] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.004s) [247.463724] [060/156] (774s left) kms_cursor_legacy (single-bo) [247.583509] Starting subtest: single-bo [247.585403] Starting dynamic subtest: pipe-A [252.966218] Dynamic subtest pipe-A: SUCCESS (5.379s) [252.976927] Starting dynamic subtest: pipe-B [258.350646] Dynamic subtest pipe-B: SUCCESS (5.381s) [258.362572] Starting dynamic subtest: pipe-C [263.733738] Dynamic subtest pipe-C: SUCCESS (5.380s) [263.745295] Starting dynamic subtest: pipe-D [269.115319] Dynamic subtest pipe-D: SUCCESS (5.379s) [269.126494] Starting dynamic subtest: all-pipes [274.505120] Dynamic subtest all-pipes: SUCCESS (5.387s) [274.507701] Subtest single-bo: SUCCESS (26.920s) [274.652675] [061/156] (747s left) kms_lease (possible-crtcs-filtering) [274.741391] Starting subtest: possible-crtcs-filtering [274.746873] Subtest possible-crtcs-filtering: SUCCESS (0.005s) [274.873374] [062/156] (747s left) perf_pmu (invalid-open) [274.914783] Starting subtest: invalid-open [274.917314] Subtest invalid-open: SUCCESS (0.000s) [275.018240] [063/156] (746s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-indfb-msflip-blt) [275.118071] Starting subtest: fbcpsrhdr-2p-scndscrn-indfb-msflip-blt [275.122084] Subtest fbcpsrhdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [275.200226] [064/156] (746s left) kms_plane_lowres (tiling-none) [275.293727] Starting subtest: tiling-none [275.295962] Starting dynamic subtest: pipe-A-eDP-1 [275.300586] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [275.596641] Starting dynamic subtest: pipe-B-eDP-1 [275.601650] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [275.611317] Starting dynamic subtest: pipe-C-eDP-1 [275.615846] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [275.625684] Starting dynamic subtest: pipe-D-eDP-1 [275.630179] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [275.634477] Subtest tiling-none: SKIP (0.296s) [276.408997] [065/156] (745s left) kms_async_flips (invalid-async-flip) [276.505266] Starting subtest: invalid-async-flip [276.877229] Starting dynamic subtest: pipe-A-eDP-1 [277.723837] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.847s) [278.082139] Starting dynamic subtest: pipe-B-eDP-1 [278.958155] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.885s) [279.323540] Starting dynamic subtest: pipe-C-eDP-1 [280.171632] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.853s) [280.521081] Starting dynamic subtest: pipe-D-eDP-1 [281.306299] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.793s) [281.308685] Subtest invalid-async-flip: SUCCESS (4.805s) [282.452325] [066/156] (739s left) gem_exec_whisper (basic-forked-all) [282.513159] Starting subtest: basic-forked-all [295.481692] Subtest basic-forked-all: SUCCESS (12.964s) [295.668335] [067/156] (726s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible) [295.763703] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible [295.765955] Starting dynamic subtest: A-eDP1 [299.367817] Dynamic subtest A-eDP1: SUCCESS (3.602s) [299.378758] Starting dynamic subtest: B-eDP1 [302.581567] Dynamic subtest B-eDP1: SUCCESS (3.211s) [302.591972] Starting dynamic subtest: C-eDP1 [305.816419] Dynamic subtest C-eDP1: SUCCESS (3.234s) [305.826454] Starting dynamic subtest: D-eDP1 [309.037465] Dynamic subtest D-eDP1: SUCCESS (3.217s) [309.039735] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.273s) [309.839274] [068/156] (712s left) gen7_exec_parse (load-register-reg) [309.895072] Subtest load-register-reg: SKIP (0.000s) [309.973783] [069/156] (712s left) kms_rotation_crc (multiplane-rotation) [310.064661] Starting subtest: multiplane-rotation [327.544524] Subtest multiplane-rotation: SUCCESS (17.482s) [327.684580] [070/156] (694s left) core_hotunplug (unbind-rebind) [327.784597] Starting subtest: unbind-rebind [335.023696] Subtest unbind-rebind: SUCCESS (7.240s) [335.065162] [071/156] (687s left) gem_mmap (basic) [336.288649] Subtest basic: SKIP (0.000s) [336.364341] [072/156] (685s left) gem_mmap_wc (bad-size) [336.426536] Subtest bad-size: SKIP (0.000s) [336.495697] [073/156] (685s left) kms_psr (pr-cursor-plane-move) [336.588157] Starting subtest: pr-cursor-plane-move [336.592600] Subtest pr-cursor-plane-move: SKIP (0.000s) [336.659316] [074/156] (685s left) kms_frontbuffer_tracking (hdr-rgb565-draw-mmap-gtt) [336.760981] Starting subtest: hdr-rgb565-draw-mmap-gtt [336.765153] Subtest hdr-rgb565-draw-mmap-gtt: SKIP (0.000s) [336.850710] [075/156] (685s left) syncobj_timeline (invalid-transfer-illegal-handle) [336.905186] Starting subtest: invalid-transfer-illegal-handle [336.907431] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s) [336.999434] [076/156] (685s left) kms_cursor_crc (cursor-random-128x128) [337.198360] Starting subtest: cursor-random-128x128 [337.212470] Starting dynamic subtest: pipe-A-eDP-1 [340.567490] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.353s) [340.600864] Starting dynamic subtest: pipe-D-eDP-1 [344.629097] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.036s) [344.631395] Subtest cursor-random-128x128: SUCCESS (7.428s) [345.502625] [077/156] (677s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt) [345.595774] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt [345.599940] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [345.716037] [078/156] (676s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf) [345.812433] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf [345.816737] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [345.885106] [079/156] (676s left) kms_pm_rpm (modeset-stress-extra-wait) [347.510710] Starting subtest: modeset-stress-extra-wait [401.865173] Subtest modeset-stress-extra-wait: SUCCESS (54.355s) [401.954046] [080/156] (620s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-blt) [402.068929] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-blt [402.073024] Subtest fbchdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s) [402.185323] [081/156] (620s left) gem_mmap_wc (write-cpu-read-wc-unflushed) [402.246657] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s) [402.314820] [082/156] (620s left) i915_suspend (debugfs-reader) [402.372822] Starting subtest: debugfs-reader [420.149367] Subtest debugfs-reader: SUCCESS (3.997s) [420.245912] [083/156] (602s left) gem_exec_schedule (pi-distinct-iova) [420.433462] Starting subtest: pi-distinct-iova [420.435570] Starting dynamic subtest: rcs0 [420.508541] Dynamic subtest rcs0: SUCCESS (0.078s) [420.520292] Starting dynamic subtest: vcs0 [420.564701] Dynamic subtest vcs0: SUCCESS (0.054s) [420.577066] Starting dynamic subtest: vcs1 [420.619891] Dynamic subtest vcs1: SUCCESS (0.055s) [420.631379] Starting dynamic subtest: vecs0 [420.678182] Dynamic subtest vecs0: SUCCESS (0.057s) [420.691256] Starting dynamic subtest: ccs0 [420.740747] Dynamic subtest ccs0: SUCCESS (0.062s) [420.743106] Subtest pi-distinct-iova: SUCCESS (0.311s) [422.203482] [084/156] (600s left) gem_exec_schedule (submit-early-slice) [422.276960] Starting subtest: submit-early-slice [422.279246] Starting dynamic subtest: rcs0 [422.305316] Dynamic subtest rcs0: SUCCESS (0.036s) [422.317089] Starting dynamic subtest: bcs0 [422.344169] Dynamic subtest bcs0: SUCCESS (0.038s) [422.360213] Starting dynamic subtest: vcs0 [422.382112] Dynamic subtest vcs0: SUCCESS (0.037s) [422.393296] Starting dynamic subtest: vcs1 [422.416923] Dynamic subtest vcs1: SUCCESS (0.034s) [422.427589] Starting dynamic subtest: vecs0 [422.446232] Dynamic subtest vecs0: SUCCESS (0.029s) [422.456933] Starting dynamic subtest: ccs0 [422.481442] Dynamic subtest ccs0: SUCCESS (0.034s) [422.483797] Subtest submit-early-slice: SUCCESS (0.213s) [424.206011] [085/156] (598s left) gem_exec_balancer (full-late) [424.265877] Starting subtest: full-late [428.906922] Subtest full-late: SUCCESS (4.638s) [429.251865] [086/156] (593s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-gtt) [429.348080] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-gtt [429.352645] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [429.450661] [087/156] (593s left) syncobj_wait (reset-signaled) [429.503496] Starting subtest: reset-signaled [429.505385] Subtest reset-signaled: SUCCESS (0.000s) [429.610841] [088/156] (593s left) gem_ctx_param (get-priority-new-ctx) [429.670512] Starting subtest: get-priority-new-ctx [429.673071] Subtest get-priority-new-ctx: SUCCESS (0.001s) [429.776173] [089/156] (593s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render) [429.872751] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render [437.183164] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.313s) [437.340387] [090/156] (585s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-render) [437.445412] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-render [437.449621] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [437.534190] [091/156] (585s left) gem_mmap_gtt (cpuset-big-copy-odd) [437.597107] Subtest cpuset-big-copy-odd: SKIP (0.000s) [437.657188] [092/156] (585s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc) [437.759695] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc [437.761928] Starting dynamic subtest: pipe-A-eDP-1 [437.819245] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [437.831976] Starting dynamic subtest: pipe-B-eDP-1 [437.890106] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [437.902468] Starting dynamic subtest: pipe-C-eDP-1 [437.960095] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [437.972347] Starting dynamic subtest: pipe-D-eDP-1 [438.030470] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [438.034734] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s) [440.043686] [093/156] (583s left) syncobj_wait (multi-wait-all-for-submit-signaled) [440.093362] Starting subtest: multi-wait-all-for-submit-signaled [440.095764] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s) [440.190845] [094/156] (583s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-render) [440.283307] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-render [440.287649] Subtest hdr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [440.372661] [095/156] (583s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-pwrite) [440.473718] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-pwrite [440.477694] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [440.587056] [096/156] (582s left) kms_cursor_crc (cursor-tearing-position-change) [440.689304] Starting subtest: cursor-tearing-position-change [440.691687] Starting dynamic subtest: pipe-A-eDP-1 [441.267477] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.576s) [441.278314] Starting dynamic subtest: pipe-D-eDP-1 [442.462621] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.193s) [442.465008] Subtest cursor-tearing-position-change: SUCCESS (1.772s) [443.296992] [097/156] (580s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal [443.351680] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled [443.459772] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.108s) [443.539228] [098/156] (579s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping) [443.653686] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping [443.680007] Starting dynamic subtest: pipe-A-plane-0 [443.969978] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s) [443.983603] Starting dynamic subtest: pipe-A-plane-3 [444.202975] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s) [445.282313] Starting dynamic subtest: pipe-B-plane-0 [445.561117] Dynamic subtest pipe-B-plane-0: SUCCESS (0.288s) [445.575493] Starting dynamic subtest: pipe-B-plane-3 [445.794614] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s) [446.109114] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.453s) [446.949893] [099/156] (576s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels) [447.045210] Starting subtest: plane-all-modeset-transition-internal-panels [447.047226] Starting dynamic subtest: pipe-A-eDP-1 [448.393875] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.348s) [448.678731] Starting dynamic subtest: pipe-B-eDP-1 [449.708945] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.040s) [449.982061] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.939s) [450.815417] [100/156] (572s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-mmap-gtt) [450.918120] Starting subtest: fbchdr-rgb101010-draw-mmap-gtt [450.922363] Subtest fbchdr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [451.018103] [101/156] (572s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-pwrite) [451.110198] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-pwrite [451.114219] Subtest hdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [451.212569] [102/156] (572s left) kms_plane_scaling (planes-scaler-unity-scaling) [451.294545] Starting subtest: planes-scaler-unity-scaling [451.296836] Starting dynamic subtest: pipe-A [451.355631] Dynamic subtest pipe-A: SUCCESS (0.064s) [451.366431] Starting dynamic subtest: pipe-B [452.540593] Dynamic subtest pipe-B: SUCCESS (1.184s) [452.553605] Starting dynamic subtest: pipe-C [453.661826] Dynamic subtest pipe-C: SUCCESS (1.120s) [453.674253] Starting dynamic subtest: pipe-D [454.794398] Dynamic subtest pipe-D: SUCCESS (1.132s) [454.796841] Subtest planes-scaler-unity-scaling: SUCCESS (3.503s) [455.943137] [103/156] (567s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt) [456.045501] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt [456.049708] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [456.141197] [104/156] (567s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [456.248517] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip [456.253187] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s) [456.362394] [105/156] (567s left) gem_spin_batch (user-each) [456.424925] Starting subtest: user-each [459.785755] Subtest user-each: SUCCESS (3.360s) [460.136185] [106/156] (563s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-render) [460.234288] Starting subtest: fbcpsrhdr-rgb101010-draw-render [460.238744] Subtest fbcpsrhdr-rgb101010-draw-render: SKIP (0.000s) [460.325330] [107/156] (563s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt) [460.430109] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt [460.434115] Subtest psrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [460.535956] [108/156] (563s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [460.621674] Starting subtest: addfb25-yf-tiled-legacy [460.623940] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [460.722163] [109/156] (563s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc) [460.817317] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc [460.821748] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [460.916728] [110/156] (563s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt) [461.011393] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt [461.015771] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [461.108910] [111/156] (562s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb) [461.214690] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb [461.218350] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s) [461.299366] [112/156] (562s left) kms_lease (empty-lease) [461.383148] Starting subtest: empty-lease [461.385045] Starting dynamic subtest: pipe-A-eDP-1 [461.386701] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [461.398707] Starting dynamic subtest: pipe-B-eDP-1 [461.400517] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s) [461.410742] Starting dynamic subtest: pipe-C-eDP-1 [461.412544] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [461.422533] Starting dynamic subtest: pipe-D-eDP-1 [461.424417] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [461.426320] Subtest empty-lease: SUCCESS (0.012s) [461.526044] [113/156] (562s left) gem_close (basic) [461.586441] Starting subtest: basic [461.588562] Subtest basic: SUCCESS (0.000s) [461.701896] [114/156] (562s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip) [461.791119] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip [462.760573] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.968s) [462.873995] [115/156] (561s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-move) [462.971910] Starting subtest: hdr-2p-scndscrn-cur-indfb-move [462.976181] Subtest hdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [463.074781] [116/156] (561s left) syncobj_wait (single-wait-all-for-submit-submitted) [463.119903] Starting subtest: single-wait-all-for-submit-submitted [463.228257] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.106s) [463.322366] [117/156] (561s left) kms_content_protection (dp-mst-lic-type-0) [463.459465] Starting subtest: dp-mst-lic-type-0 [463.464314] Subtest dp-mst-lic-type-0: SKIP (0.000s) [463.598783] [118/156] (560s left) kms_psr (fbc-pr-cursor-mmap-gtt) [463.699383] Starting subtest: fbc-pr-cursor-mmap-gtt [463.703652] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s) [463.784783] [119/156] (560s left) vgem_basic (mmap) [463.838624] Starting subtest: mmap [463.847595] Subtest mmap: SUCCESS (0.014s) [463.907363] [120/156] (560s left) perf (missing-sample-flags) [464.022710] Starting subtest: missing-sample-flags [464.024956] Subtest missing-sample-flags: SUCCESS (0.000s) [464.069386] [121/156] (560s left) core_auth (basic-auth) [464.131023] Starting subtest: basic-auth [464.133308] Subtest basic-auth: SUCCESS (0.001s) [464.248094] [122/156] (560s left) kms_cursor_legacy (flip-vs-cursor-varying-size) [464.364002] Starting subtest: flip-vs-cursor-varying-size [473.336306] Subtest flip-vs-cursor-varying-size: SUCCESS (8.968s) [474.163069] [123/156] (550s left) gem_exec_reloc (basic-range) [474.229704] Subtest basic-range: SKIP (0.000s) [474.300485] [124/156] (550s left) kms_flip (basic-flip-vs-wf_vblank) [474.394093] Starting subtest: basic-flip-vs-wf_vblank [474.396439] Starting dynamic subtest: A-eDP1 [476.310329] Dynamic subtest A-eDP1: SUCCESS (1.917s) [476.325254] Starting dynamic subtest: B-eDP1 [478.239846] Dynamic subtest B-eDP1: SUCCESS (1.928s) [478.251314] Starting dynamic subtest: C-eDP1 [480.167104] Dynamic subtest C-eDP1: SUCCESS (1.926s) [480.178363] Starting dynamic subtest: D-eDP1 [482.102310] Dynamic subtest D-eDP1: SUCCESS (1.932s) [482.104777] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.713s) [483.334165] [125/156] (541s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc) [483.428885] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc [483.431238] Starting dynamic subtest: pipe-A-eDP-1 [483.454557] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [483.467640] Starting dynamic subtest: pipe-B-eDP-1 [483.489555] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [483.500255] Starting dynamic subtest: pipe-C-eDP-1 [483.522660] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [483.532906] Starting dynamic subtest: pipe-D-eDP-1 [483.554880] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [483.559334] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s) [485.715046] [126/156] (539s left) kms_flip (2x-plain-flip-ts-check) [485.809916] Starting subtest: 2x-plain-flip-ts-check [485.818237] Subtest 2x-plain-flip-ts-check: SKIP (0.010s) [485.913357] [127/156] (538s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-blt) [486.019791] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-blt [486.024075] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [486.126049] [128/156] (538s left) gem_fenced_exec_thrash (too-many-fences) [486.180049] Subtest too-many-fences: SKIP (0.000s) [486.246293] [129/156] (538s left) kms_getfb (getfb2-handle-protection) [486.342084] Starting subtest: getfb2-handle-protection [486.367869] Subtest getfb2-handle-protection: SUCCESS (0.027s) [486.494669] [130/156] (538s left) kms_panel_fitting (legacy) [486.583278] Starting subtest: legacy [486.585490] Starting dynamic subtest: pipe-A-eDP-1 [487.077845] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.497s) [487.109559] Starting dynamic subtest: pipe-B-eDP-1 [488.628108] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.530s) [488.656910] Starting dynamic subtest: pipe-C-eDP-1 [490.154127] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.504s) [490.180169] Starting dynamic subtest: pipe-D-eDP-1 [491.661651] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.490s) [491.663971] Subtest legacy: SUCCESS (5.080s) [492.855436] [131/156] (532s left) gem_exec_flush (basic-wb-ro-default) [492.922427] Starting subtest: basic-wb-ro-default [498.381910] Subtest basic-wb-ro-default: SUCCESS (5.459s) [498.570985] [132/156] (526s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs) [498.677582] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs [498.679719] Starting dynamic subtest: pipe-A-eDP-1 [499.397506] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s) [499.409923] Starting dynamic subtest: pipe-B-eDP-1 [501.180793] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.784s) [501.193407] Starting dynamic subtest: pipe-C-eDP-1 [502.998175] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.815s) [503.011844] Starting dynamic subtest: pipe-D-eDP-1 [504.819400] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.820s) [504.821854] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.134s) [505.973130] [133/156] (519s left) kms_color_pipeline (plane-ctm3x4-lut1d) [506.065266] Starting subtest: plane-ctm3x4-lut1d [506.235611] Starting dynamic subtest: pipe-A-plane-0 [506.422148] Dynamic subtest pipe-A-plane-0: SUCCESS (0.189s) [506.434133] Starting dynamic subtest: pipe-A-plane-1 [506.566438] Dynamic subtest pipe-A-plane-1: SUCCESS (0.144s) [506.577397] Starting dynamic subtest: pipe-A-plane-2 [506.699323] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s) [507.856720] Starting dynamic subtest: pipe-B-plane-0 [508.045482] Dynamic subtest pipe-B-plane-0: SUCCESS (0.200s) [508.061591] Starting dynamic subtest: pipe-B-plane-1 [508.235063] Dynamic subtest pipe-B-plane-1: SUCCESS (0.188s) [508.247310] Starting dynamic subtest: pipe-B-plane-2 [508.401729] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s) [509.582187] Starting dynamic subtest: pipe-C-plane-0 [509.706068] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s) [509.717612] Starting dynamic subtest: pipe-C-plane-1 [509.850539] Dynamic subtest pipe-C-plane-1: SUCCESS (0.143s) [509.864386] Starting dynamic subtest: pipe-C-plane-2 [510.028602] Dynamic subtest pipe-C-plane-2: SUCCESS (0.177s) [511.213946] Starting dynamic subtest: pipe-D-plane-0 [511.335835] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s) [511.347639] Starting dynamic subtest: pipe-D-plane-1 [511.480217] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s) [511.492320] Starting dynamic subtest: pipe-D-plane-2 [511.613502] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s) [511.899034] Subtest plane-ctm3x4-lut1d: SUCCESS (5.834s) [512.787969] [134/156] (512s left) kms_force_connector_basic (force-edid) [512.881504] Starting subtest: force-edid [513.252296] Subtest force-edid: SUCCESS (0.373s) [513.401930] [135/156] (511s left) kms_flip (wf_vblank-ts-check) [513.505639] Starting subtest: wf_vblank-ts-check [513.507782] Starting dynamic subtest: A-eDP1 [522.427722] Dynamic subtest A-eDP1: SUCCESS (8.925s) [522.439503] Starting dynamic subtest: B-eDP1 [531.320152] Dynamic subtest B-eDP1: SUCCESS (8.891s) [531.332978] Starting dynamic subtest: C-eDP1 [540.210717] Dynamic subtest C-eDP1: SUCCESS (8.889s) [540.222659] Starting dynamic subtest: D-eDP1 [549.113745] Dynamic subtest D-eDP1: SUCCESS (8.901s) [549.115643] Subtest wf_vblank-ts-check: SUCCESS (35.619s) [550.305822] [136/156] (474s left) kms_chamelium_edid (dp-edid-read) [550.699094] Subtest dp-edid-read: SKIP (0.000s) [551.499685] [137/156] (473s left) gem_lmem_evict (dontneed-evict-race) [551.540579] Subtest dontneed-evict-race: SKIP (0.000s) [551.590318] [138/156] (473s left) kms_big_fb (x-tiled-32bpp-rotate-270) [551.684514] Starting subtest: x-tiled-32bpp-rotate-270 [551.703622] Subtest x-tiled-32bpp-rotate-270: SKIP (0.018s) [551.820452] [139/156] (473s left) gem_ringfill (basic-all) [557.074587] Starting subtest: basic-all [558.241993] Subtest basic-all: SUCCESS (1.166s) [558.366761] [140/156] (466s left) kms_vrr (flip-basic) [558.455614] Starting subtest: flip-basic [558.462339] Subtest flip-basic: SKIP (0.000s) [558.538255] [141/156] (466s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-indfb-pgflip-blt) [558.633582] Starting subtest: fbchdr-1p-primscrn-indfb-pgflip-blt [558.637752] Subtest fbchdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [558.714575] [142/156] (466s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu) [558.810153] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu [558.814184] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [558.908233] [143/156] (466s left) kms_hdmi_inject (inject-4k) [559.252611] Starting subtest: inject-4k [559.598015] Subtest inject-4k: SUCCESS (0.346s) [560.144091] [144/156] (465s left) api_intel_bb (blit-noreloc-keep-cache) [560.200945] Starting subtest: blit-noreloc-keep-cache [560.210101] Subtest blit-noreloc-keep-cache: SUCCESS (0.011s) [560.342401] [145/156] (465s left) kms_dsc (dsc-basic) [560.427611] Starting subtest: dsc-basic [560.440973] Subtest dsc-basic: SKIP (0.000s) [560.513671] [146/156] (465s left) perf_pmu (frequency) [560.557397] Starting subtest: frequency [560.562142] Starting dynamic subtest: gt0 [562.692951] Dynamic subtest gt0: SUCCESS (2.126s) [562.706103] Starting dynamic subtest: idle-gt0 [563.198591] Dynamic subtest idle-gt0: SUCCESS (0.504s) [563.212409] Starting dynamic subtest: gt1 [568.078787] Dynamic subtest gt1: SUCCESS (4.875s) [568.094734] Starting dynamic subtest: idle-gt1 [568.582274] Dynamic subtest idle-gt1: SUCCESS (0.504s) [568.584950] Subtest frequency: SUCCESS (8.027s) [568.692264] [147/156] (456s left) gem_mmap_offset (bad-flags) [568.743257] Starting subtest: bad-flags [568.745600] Subtest bad-flags: SUCCESS (0.000s) [568.866288] [148/156] (456s left) gem_ctx_shared (disjoint-timelines) [568.933658] Starting subtest: disjoint-timelines [568.956887] Subtest disjoint-timelines: SUCCESS (0.023s) [569.216568] [149/156] (456s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier) [569.309781] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier [569.314313] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s) [569.383462] [150/156] (456s left) kms_draw_crc (fill-fb) [569.481992] Starting subtest: fill-fb [569.909872] Subtest fill-fb: SUCCESS (0.430s) [570.003731] [151/156] (455s left) gem_render_copy (x-tiled-to-vebox-y-tiled) [570.063181] Starting subtest: x-tiled-to-vebox-y-tiled [570.067869] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s) [570.249214] [152/156] (455s left) gem_exec_create (forked) [570.314340] Starting subtest: forked [570.316732] Starting dynamic subtest: smem [592.016932] Dynamic subtest smem: SUCCESS (21.699s) [592.020131] Subtest forked: SUCCESS (21.702s) [592.234002] [153/156] (433s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-fullscreen) [592.331243] Starting subtest: psrhdr-1p-primscrn-spr-indfb-fullscreen [592.335625] Subtest psrhdr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [592.424537] [154/156] (433s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled) [592.482074] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled [592.483997] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s) [592.578790] [155/156] (433s left) i915_drm_fdinfo (busy-hang) [592.616991] Starting subtest: busy-hang [592.619108] Starting dynamic subtest: rcs0 [592.638318] Dynamic subtest rcs0: SKIP (0.020s) [592.652340] Starting dynamic subtest: bcs0 [592.656902] Dynamic subtest bcs0: SKIP (0.001s) [592.668467] Starting dynamic subtest: vcs0 [592.672807] Dynamic subtest vcs0: SKIP (0.000s) [592.683824] Starting dynamic subtest: vcs1 [592.688257] Dynamic subtest vcs1: SKIP (0.000s) [592.699121] Starting dynamic subtest: vecs0 [592.703581] Dynamic subtest vecs0: SKIP (0.000s) [592.714589] Starting dynamic subtest: ccs0 [592.718965] Dynamic subtest ccs0: SKIP (0.000s) [592.723314] Subtest busy-hang: SKIP (0.026s) [592.762951] [156/156] (433s left) kms_psr (fbc-psr-cursor-render) [592.865388] Starting subtest: fbc-psr-cursor-render [592.868874] Starting dynamic subtest: eDP-1 [592.873387] Dynamic subtest eDP-1: SKIP (0.000s) [592.877882] Subtest fbc-psr-cursor-render: SKIP (0.001s) [592.943233] Closing watchdogs results: parsing output: 0/ for test: kms_frontbuffer_tracking results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: kms_cursor_legacy results: parsing output: 3/ for test: gem_pread results: parsing output: 4/ for test: kms_psr results: parsing output: 5/ for test: kms_busy results: parsing output: 6/ for test: api_intel_bb results: parsing output: 7/ for test: kms_frontbuffer_tracking results: parsing output: 8/ for test: kms_flip results: parsing output: 9/ for test: gem_exec_reloc results: parsing output: 10/ for test: gem_ctx_isolation results: parsing output: 11/ for test: i915_pm_rps results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: sysfs_preempt_timeout results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: kms_ccs results: parsing output: 16/ for test: syncobj_wait results: parsing output: 17/ for test: kms_big_fb results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: gem_exec_params results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: perf results: parsing output: 22/ for test: kms_cursor_crc results: parsing output: 23/ for test: kms_universal_plane results: parsing output: 24/ for test: perf results: parsing output: 25/ for test: kms_pm_rpm results: parsing output: 26/ for test: gem_watchdog results: parsing output: 27/ for test: gem_exec_fence results: parsing output: 28/ for test: gem_exec_fence results: parsing output: 29/ for test: kms_cursor_legacy results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: kms_addfb_basic results: parsing output: 32/ for test: kms_plane_scaling results: parsing output: 33/ for test: kms_frontbuffer_tracking results: parsing output: 34/ for test: kms_chamelium_hpd results: parsing output: 35/ for test: gem_ctx_persistence results: parsing output: 36/ for test: kms_frontbuffer_tracking results: parsing output: 37/ for test: syncobj_timeline results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: kms_psr results: parsing output: 40/ for test: gem_create results: parsing output: 41/ for test: kms_big_fb results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: syncobj_wait results: parsing output: 44/ for test: prime_mmap results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: gem_exec_params results: parsing output: 47/ for test: syncobj_timeline results: parsing output: 48/ for test: i915_fb_tiling results: parsing output: 49/ for test: gem_ccs results: parsing output: 50/ for test: kms_frontbuffer_tracking results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: gem_userptr_blits results: parsing output: 53/ for test: kms_big_fb results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: syncobj_timeline results: parsing output: 56/ for test: kms_flip_scaled_crc results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: kms_ccs results: parsing output: 59/ for test: kms_cursor_legacy results: parsing output: 60/ for test: kms_lease results: parsing output: 61/ for test: perf_pmu results: parsing output: 62/ for test: kms_frontbuffer_tracking results: parsing output: 63/ for test: kms_plane_lowres results: parsing output: 64/ for test: kms_async_flips results: parsing output: 65/ for test: gem_exec_whisper results: parsing output: 66/ for test: kms_flip results: parsing output: 67/ for test: gen7_exec_parse results: parsing output: 68/ for test: kms_rotation_crc results: parsing output: 69/ for test: core_hotunplug results: parsing output: 70/ for test: gem_mmap results: parsing output: 71/ for test: gem_mmap_wc results: parsing output: 72/ for test: kms_psr results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: syncobj_timeline results: parsing output: 75/ for test: kms_cursor_crc results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: kms_psr2_sf results: parsing output: 78/ for test: kms_pm_rpm results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: gem_mmap_wc results: parsing output: 81/ for test: i915_suspend results: parsing output: 82/ for test: gem_exec_schedule results: parsing output: 83/ for test: gem_exec_schedule results: parsing output: 84/ for test: gem_exec_balancer results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: syncobj_wait results: parsing output: 87/ for test: gem_ctx_param results: parsing output: 88/ for test: kms_frontbuffer_tracking results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: gem_mmap_gtt results: parsing output: 91/ for test: kms_ccs results: parsing output: 92/ for test: syncobj_wait results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: kms_cursor_crc results: parsing output: 96/ for test: syncobj_timeline results: parsing output: 97/ for test: kms_plane results: parsing output: 98/ for test: kms_atomic_transition results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: kms_frontbuffer_tracking results: parsing output: 101/ for test: kms_plane_scaling results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: kms_big_fb results: parsing output: 104/ for test: gem_spin_batch results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: kms_frontbuffer_tracking results: parsing output: 107/ for test: kms_addfb_basic results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: kms_psr2_sf results: parsing output: 111/ for test: kms_lease results: parsing output: 112/ for test: gem_close results: parsing output: 113/ for test: kms_big_fb results: parsing output: 114/ for test: kms_frontbuffer_tracking results: parsing output: 115/ for test: syncobj_wait results: parsing output: 116/ for test: kms_content_protection results: parsing output: 117/ for test: kms_psr results: parsing output: 118/ for test: vgem_basic results: parsing output: 119/ for test: perf results: parsing output: 120/ for test: core_auth results: parsing output: 121/ for test: kms_cursor_legacy results: parsing output: 122/ for test: gem_exec_reloc results: parsing output: 123/ for test: kms_flip results: parsing output: 124/ for test: kms_ccs results: parsing output: 125/ for test: kms_flip results: parsing output: 126/ for test: kms_frontbuffer_tracking results: parsing output: 127/ for test: gem_fenced_exec_thrash results: parsing output: 128/ for test: kms_getfb results: parsing output: 129/ for test: kms_panel_fitting results: parsing output: 130/ for test: gem_exec_flush results: parsing output: 131/ for test: kms_ccs results: parsing output: 132/ for test: kms_color_pipeline results: parsing output: 133/ for test: kms_force_connector_basic results: parsing output: 134/ for test: kms_flip results: parsing output: 135/ for test: kms_chamelium_edid results: parsing output: 136/ for test: gem_lmem_evict results: parsing output: 137/ for test: kms_big_fb results: parsing output: 138/ for test: gem_ringfill results: parsing output: 139/ for test: kms_vrr results: parsing output: 140/ for test: kms_frontbuffer_tracking results: parsing output: 141/ for test: kms_frontbuffer_tracking results: parsing output: 142/ for test: kms_hdmi_inject results: parsing output: 143/ for test: api_intel_bb results: parsing output: 144/ for test: kms_dsc results: parsing output: 145/ for test: perf_pmu results: parsing output: 146/ for test: gem_mmap_offset results: parsing output: 147/ for test: gem_ctx_shared results: parsing output: 148/ for test: kms_plane results: parsing output: 149/ for test: kms_draw_crc results: parsing output: 150/ for test: gem_render_copy results: parsing output: 151/ for test: gem_exec_create results: parsing output: 152/ for test: kms_frontbuffer_tracking results: parsing output: 153/ for test: syncobj_wait results: parsing output: 154/ for test: i915_drm_fdinfo results: parsing output: 155/ for test: kms_psr Done.