[60.662206] Initializing watchdogs [60.662273] /dev/watchdog0 [60.676854] [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] [60.681758] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [60.684008] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [60.685997] [001/133] (960s left) i915_query (engine-info) [60.730181] Starting subtest: engine-info [60.735984] Subtest engine-info: SUCCESS (0.007s) [60.849314] [002/133] (960s left) gem_exec_schedule (semaphore-noskip) [60.921817] Starting subtest: semaphore-noskip [61.421458] Subtest semaphore-noskip: SUCCESS (0.491s) [61.770826] [003/133] (959s left) gem_render_linear_blits (basic) [61.822475] Starting subtest: basic [61.859868] Subtest basic: SUCCESS (0.037s) [61.936624] [004/133] (959s left) gem_ctx_param (invalid-set-ringsize) [61.995670] Starting subtest: invalid-set-ringsize [61.996727] Subtest invalid-set-ringsize: SUCCESS (0.000s) [62.061457] [005/133] (959s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw) [62.178223] Starting subtest: fbc-1p-pri-indfb-multidraw [75.658447] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (13.493s) [77.033084] [006/133] (944s left) kms_big_fb (x-tiled-64bpp-rotate-90) [77.127618] Starting subtest: x-tiled-64bpp-rotate-90 [77.147390] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s) [77.240333] [007/133] (944s left) kms_plane (pixel-format-yf-tiled-modifier) [77.338858] Starting subtest: pixel-format-yf-tiled-modifier [77.340518] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s) [77.405399] [008/133] (943s left) gem_exec_schedule (preempt-contexts) [77.473191] Starting subtest: preempt-contexts [77.474126] Starting dynamic subtest: rcs0 [77.525673] Dynamic subtest rcs0: SUCCESS (0.052s) [77.533187] Starting dynamic subtest: bcs0 [77.577485] Dynamic subtest bcs0: SUCCESS (0.051s) [77.585535] Starting dynamic subtest: vcs0 [77.627560] Dynamic subtest vcs0: SUCCESS (0.049s) [77.634875] Starting dynamic subtest: vcs1 [77.672013] Dynamic subtest vcs1: SUCCESS (0.044s) [77.680971] Starting dynamic subtest: vecs0 [77.718900] Dynamic subtest vecs0: SUCCESS (0.046s) [77.725198] Starting dynamic subtest: ccs0 [77.763342] Dynamic subtest ccs0: SUCCESS (0.044s) [77.764169] Subtest preempt-contexts: SUCCESS (0.290s) [79.013403] [009/133] (942s left) kms_cursor_crc (cursor-sliding-max-size) [79.349533] Starting subtest: cursor-sliding-max-size [79.352517] Subtest cursor-sliding-max-size: SKIP (0.000s) [79.478626] [010/133] (941s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt) [79.593422] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt [79.595414] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [79.668986] [011/133] (941s left) api_intel_bb (object-reloc-keep-cache) [79.721466] Starting subtest: object-reloc-keep-cache [79.726169] Subtest object-reloc-keep-cache: SKIP (0.004s) [79.840068] [012/133] (941s left) kms_cursor_crc (cursor-onscreen-max-size) [80.121889] Starting subtest: cursor-onscreen-max-size [80.124733] Subtest cursor-onscreen-max-size: SKIP (0.000s) [80.248955] [013/133] (941s left) kms_psr (pr-primary-mmap-gtt) [80.335877] Starting subtest: pr-primary-mmap-gtt [80.337659] Subtest pr-primary-mmap-gtt: SKIP (0.000s) [80.400090] [014/133] (941s left) gem_exec_capture (capture) [80.451088] Starting subtest: capture [80.452154] Starting dynamic subtest: rcs0-smem [81.291461] Dynamic subtest rcs0-smem: SUCCESS (0.840s) [81.299247] Starting dynamic subtest: bcs0-smem [82.227517] Dynamic subtest bcs0-smem: SUCCESS (0.935s) [82.233339] Starting dynamic subtest: vcs0-smem [83.054827] Dynamic subtest vcs0-smem: SUCCESS (0.827s) [83.060691] Starting dynamic subtest: vcs1-smem [83.879145] Dynamic subtest vcs1-smem: SUCCESS (0.824s) [83.885271] Starting dynamic subtest: vecs0-smem [85.227611] Dynamic subtest vecs0-smem: FAIL (1.328s) [85.233708] Starting dynamic subtest: ccs0-smem [86.531347] Dynamic subtest ccs0-smem: SUCCESS (1.323s) [86.532295] Subtest capture: FAIL (6.079s) [86.646140] [015/133] (934s left) kms_getfb (getfb-handle-not-fb) [86.740141] Starting subtest: getfb-handle-not-fb [86.741098] Subtest getfb-handle-not-fb: SUCCESS (0.000s) [86.831099] [016/133] (934s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc) [86.923099] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc [86.924175] Starting dynamic subtest: pipe-A-eDP-1 [87.076971] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.150s) [87.085480] Starting dynamic subtest: pipe-B-eDP-1 [87.093808] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s) [87.101451] Starting dynamic subtest: pipe-C-eDP-1 [87.108802] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s) [87.115349] Starting dynamic subtest: pipe-D-eDP-1 [87.122373] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s) [87.123230] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.183s) [89.389544] [017/133] (932s left) gem_exec_params (sol-reset-not-gen7) [89.465189] Starting subtest: sol-reset-not-gen7 [89.467743] Subtest sol-reset-not-gen7: SUCCESS (0.003s) [89.586170] [018/133] (932s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled) [89.648054] Starting subtest: multi-wait-all-for-submit-available-signaled [89.649064] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.001s) [89.754103] [019/133] (931s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled) [89.804939] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled [89.806777] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s) [89.991310] [020/133] (931s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [90.082871] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s) [90.180836] [021/133] (931s left) syncobj_wait (wait-all-snapshot) [90.223455] Starting subtest: wait-all-snapshot [90.305511] Subtest wait-all-snapshot: SUCCESS (0.081s) [90.371352] [022/133] (931s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic) [90.494672] Starting subtest: 2x-long-cursor-vs-flip-atomic [90.497726] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s) [90.631336] [023/133] (931s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted) [90.695848] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted [90.797821] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.101s) [90.864425] [024/133] (931s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt) [90.958297] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt [98.500188] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.543s) [98.621426] [025/133] (923s left) gem_ctx_shared (q-out-order) [98.697104] Starting subtest: Q-out-order [98.698074] Starting dynamic subtest: rcs0 [98.836780] Dynamic subtest rcs0: SUCCESS (0.140s) [98.851753] Starting dynamic subtest: vcs0 [98.910590] Dynamic subtest vcs0: SUCCESS (0.074s) [98.924742] Starting dynamic subtest: vcs1 [98.990854] Dynamic subtest vcs1: SUCCESS (0.080s) [99.005878] Starting dynamic subtest: vecs0 [99.063198] Dynamic subtest vecs0: SUCCESS (0.072s) [99.078406] Starting dynamic subtest: ccs0 [99.147133] Dynamic subtest ccs0: SUCCESS (0.083s) [99.148274] Subtest Q-out-order: SUCCESS (0.451s) [100.002736] [FACT gem_ctx_shared (q-out-order)] new: kernel.kmod_is_loaded.vgem: true [100.004352] [026/133] (921s left) kms_flip (2x-plain-flip-ts-check-interruptible) [100.104236] Starting subtest: 2x-plain-flip-ts-check-interruptible [100.116040] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.011s) [100.198027] [027/133] (921s left) kms_pm_backlight (brightness-with-dpms) [100.299409] Starting subtest: brightness-with-dpms [100.370564] Starting dynamic subtest: eDP-1 [102.784516] Dynamic subtest eDP-1: SUCCESS (2.413s) [102.785687] Subtest brightness-with-dpms: SUCCESS (2.485s) [103.649854] [028/133] (918s left) kms_big_fb (y-tiled-64bpp-rotate-180) [103.736683] Starting subtest: y-tiled-64bpp-rotate-180 [103.738428] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s) [103.822292] [029/133] (918s left) kms_big_fb (4-tiled-64bpp-rotate-180) [103.927515] Starting subtest: 4-tiled-64bpp-rotate-180 [105.460886] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.534s) [105.625593] [030/133] (916s left) gem_exec_reloc (basic-gtt-cpu-active) [105.687128] Subtest basic-gtt-cpu-active: SKIP (0.000s) [105.754984] [031/133] (916s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs) [105.843364] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs [105.844261] Starting dynamic subtest: pipe-A-eDP-1 [105.854138] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [105.861093] Starting dynamic subtest: pipe-B-eDP-1 [105.870426] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [105.876998] Starting dynamic subtest: pipe-C-eDP-1 [105.885638] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [105.892122] Starting dynamic subtest: pipe-D-eDP-1 [105.901376] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [105.902914] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.003s) [108.111498] [032/133] (914s left) kms_flip (2x-flip-vs-dpms-on-nop) [108.194211] Starting subtest: 2x-flip-vs-dpms-on-nop [108.204229] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s) [108.279673] [033/133] (913s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling) [108.357448] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling [108.359589] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s) [108.425738] [034/133] (913s left) kms_display_modes (extended-mode-basic) [108.509496] Starting subtest: extended-mode-basic [108.511387] Subtest extended-mode-basic: SKIP (0.000s) [108.553807] [035/133] (913s left) kms_draw_crc (draw-method-blt) [108.646353] Starting subtest: draw-method-blt [108.647306] Starting dynamic subtest: xrgb8888-untiled [108.946171] Dynamic subtest xrgb8888-untiled: SUCCESS (0.300s) [108.962888] Starting dynamic subtest: rgb565-untiled [109.212921] Dynamic subtest rgb565-untiled: SUCCESS (0.266s) [109.221309] Starting dynamic subtest: xrgb2101010-untiled [109.434986] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s) [109.442862] Starting dynamic subtest: xbgr16161616f-untiled [109.657365] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s) [109.663782] Starting dynamic subtest: xrgb8888-xtiled [109.779671] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s) [109.787143] Starting dynamic subtest: rgb565-xtiled [109.901885] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s) [109.909086] Starting dynamic subtest: xrgb2101010-xtiled [110.012923] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s) [110.019898] Starting dynamic subtest: xbgr16161616f-xtiled [110.124444] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.111s) [110.132559] Starting dynamic subtest: xrgb8888-4tiled [110.246155] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.121s) [110.253380] Starting dynamic subtest: rgb565-4tiled [110.368661] Dynamic subtest rgb565-4tiled: SUCCESS (0.122s) [110.376359] Starting dynamic subtest: xrgb2101010-4tiled [110.479703] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.110s) [110.486730] Starting dynamic subtest: xbgr16161616f-4tiled [110.579892] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.100s) [110.580890] Subtest draw-method-blt: SUCCESS (1.934s) [110.689702] [036/133] (911s left) kms_chamelium_frames (vga-frame-dump) [111.076065] Subtest vga-frame-dump: SKIP (0.000s) [111.928791] [037/133] (910s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render) [112.018147] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render [116.566380] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.547s) [117.753607] [038/133] (904s left) syncobj_wait (invalid-single-wait-all-unsubmitted) [117.799246] Starting subtest: invalid-single-wait-all-unsubmitted [117.800138] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s) [117.901882] [039/133] (904s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render) [117.989915] Starting subtest: fbc-rgb101010-draw-render [122.599681] Subtest fbc-rgb101010-draw-render: SUCCESS (4.610s) [123.755056] [040/133] (898s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt) [123.855094] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt [123.856699] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [123.944197] [041/133] (898s left) kms_content_protection (uevent) [124.070662] Starting subtest: uevent [124.072813] Subtest uevent: SKIP (0.000s) [124.182385] [042/133] (898s left) core_getversion (all-cards) [124.219752] Starting subtest: all-cards [124.229850] Subtest all-cards: SUCCESS (0.011s) [124.269561] [043/133] (898s left) kms_psr (fbc-psr-cursor-plane-onoff) [124.369172] Starting subtest: fbc-psr-cursor-plane-onoff [124.370069] Starting dynamic subtest: eDP-1 [124.371778] Dynamic subtest eDP-1: SKIP (0.000s) [124.373624] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s) [124.440807] [044/133] (898s left) gem_exec_flush (basic-wb-rw-before-default) [124.500195] Starting subtest: basic-wb-rw-before-default [129.953066] Subtest basic-wb-rw-before-default: SUCCESS (5.454s) [130.132965] [045/133] (892s left) gem_close_race (basic-threads) [130.203530] Starting subtest: basic-threads [131.547574] Subtest basic-threads: SUCCESS (1.344s) [131.726710] [046/133] (890s left) gem_exec_params (invalid-ring2) [131.778343] Starting subtest: invalid-ring2 [131.779310] Subtest invalid-ring2: SUCCESS (0.000s) [131.888656] [047/133] (890s left) gem_fence_thrash (bo-write-verify-none) [131.913903] Starting subtest: bo-write-verify-none [131.927878] Subtest bo-write-verify-none: SKIP (0.012s) [131.982685] [048/133] (890s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs) [132.088696] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs [132.089519] Starting dynamic subtest: pipe-A-eDP-1 [132.098326] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [132.105308] Starting dynamic subtest: pipe-B-eDP-1 [132.114272] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [132.120437] Starting dynamic subtest: pipe-C-eDP-1 [132.128939] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [132.135032] Starting dynamic subtest: pipe-D-eDP-1 [132.143808] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [132.145388] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.003s) [134.414785] [049/133] (888s left) i915_pm_rps (engine-order) [134.473201] Starting subtest: engine-order [140.904389] Subtest engine-order: SUCCESS (6.422s) [141.037425] [050/133] (881s left) gem_userptr_blits (relocations) [141.099019] Starting subtest: relocations [141.100910] Subtest relocations: SKIP (0.001s) [141.220350] [051/133] (881s left) kms_invalid_mode (int-max-clock) [141.307952] Starting subtest: int-max-clock [141.310405] Starting dynamic subtest: pipe-A-eDP-1 [141.594948] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s) [141.602716] Starting dynamic subtest: pipe-B-eDP-1 [141.603674] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [141.610338] Starting dynamic subtest: pipe-C-eDP-1 [141.611287] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [141.617989] Starting dynamic subtest: pipe-D-eDP-1 [141.618941] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [141.619865] Subtest int-max-clock: SUCCESS (0.292s) [142.445638] [052/133] (880s left) gem_linear_blits (normal) [142.851694] Starting subtest: normal [146.368534] Subtest normal: SUCCESS (3.509s) [146.530903] [053/133] (876s left) gem_exec_balancer (nop) [146.644656] Starting subtest: nop [193.227438] Subtest nop: SUCCESS (46.580s) [193.542957] [054/133] (829s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [193.640922] Starting subtest: nonblocking-crc-frame-sequence [193.641900] Starting dynamic subtest: pipe-A-eDP-1 [194.391609] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.750s) [194.399649] Starting dynamic subtest: pipe-B-eDP-1 [195.849766] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.458s) [195.858306] Starting dynamic subtest: pipe-C-eDP-1 [197.240922] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.390s) [197.248067] Starting dynamic subtest: pipe-D-eDP-1 [198.565343] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.324s) [198.566224] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.926s) [199.366835] [055/133] (823s left) kms_plane (pixel-format-y-tiled-modifier) [199.448292] Starting subtest: pixel-format-y-tiled-modifier [199.450109] Subtest pixel-format-y-tiled-modifier: SKIP (0.000s) [199.519414] [056/133] (823s left) kms_frontbuffer_tracking (fbcpsr-tiling-y) [199.624469] Starting subtest: fbcpsr-tiling-y [199.626246] Subtest fbcpsr-tiling-y: SKIP (0.000s) [199.744705] [057/133] (823s left) kms_prime (basic-crc-hybrid) [199.835179] Subtest basic-crc-hybrid: SKIP (0.000s) [199.925782] [058/133] (823s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling) [200.008274] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling [200.009157] Starting dynamic subtest: pipe-A-default-mode [201.163230] Dynamic subtest pipe-A-default-mode: SKIP (1.154s) [201.164931] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.155s) [201.295790] [059/133] (821s left) gem_ctx_persistence (process) [201.359555] Starting subtest: process [201.522233] Subtest process: SUCCESS (0.163s) [201.595290] [060/133] (821s left) kms_psr (psr2-cursor-render) [201.691260] Starting subtest: psr2-cursor-render [201.692112] Starting dynamic subtest: eDP-1 [203.373703] Dynamic subtest eDP-1: SUCCESS (1.681s) [203.374689] Subtest psr2-cursor-render: SUCCESS (1.682s) [204.248666] [061/133] (818s left) gem_lmem_swapping (heavy-verify-random-ccs) [204.281224] Subtest heavy-verify-random-ccs: SKIP (0.000s) [204.322574] [062/133] (818s left) gem_exec_fence (syncobj-export) [204.794458] Starting subtest: syncobj-export [204.797484] Subtest syncobj-export: SUCCESS (0.004s) [205.979275] [063/133] (817s left) gem_wait (write-wait) [206.037775] Starting subtest: write-wait [206.038844] Starting dynamic subtest: all-engines [207.127157] Dynamic subtest all-engines: SUCCESS (1.089s) [207.143636] Starting dynamic subtest: rcs0 [208.183630] Dynamic subtest rcs0: SUCCESS (1.055s) [208.200963] Starting dynamic subtest: bcs0 [209.240678] Dynamic subtest bcs0: SUCCESS (1.055s) [209.257597] Starting dynamic subtest: vcs0 [210.297167] Dynamic subtest vcs0: SUCCESS (1.055s) [210.314093] Starting dynamic subtest: vcs1 [211.351094] Dynamic subtest vcs1: SUCCESS (1.052s) [211.368192] Starting dynamic subtest: vecs0 [212.406191] Dynamic subtest vecs0: SUCCESS (1.053s) [212.423575] Starting dynamic subtest: ccs0 [213.462890] Dynamic subtest ccs0: SUCCESS (1.055s) [213.464092] Subtest write-wait: SUCCESS (7.426s) [213.675764] [064/133] (809s left) vgem_basic (create) [213.715438] Starting subtest: create [213.716383] Subtest create: SUCCESS (0.000s) [213.782079] [065/133] (809s left) sw_sync (sync_expired_merge) [213.826309] Starting subtest: sync_expired_merge [214.909944] Subtest sync_expired_merge: SUCCESS (1.074s) [214.958242] [066/133] (808s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area) [215.050598] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area [215.051490] Starting dynamic subtest: pipe-A-eDP-1 [215.173997] Dynamic subtest pipe-A-eDP-1: SKIP (0.122s) [215.181453] Starting dynamic subtest: pipe-B-eDP-1 [216.340656] Dynamic subtest pipe-B-eDP-1: SKIP (1.165s) [216.342454] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.290s) [217.528434] [067/133] (805s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc) [217.620507] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc [217.622133] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [217.704952] [068/133] (805s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [217.817396] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [218.665304] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.848s) [218.823540] [069/133] (804s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu) [218.914361] Starting subtest: psr-rgb101010-draw-mmap-cpu [225.997123] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (7.083s) [226.092633] [070/133] (797s left) kms_big_fb (linear-16bpp-rotate-270) [226.184417] Starting subtest: linear-16bpp-rotate-270 [226.204437] Subtest linear-16bpp-rotate-270: SKIP (0.019s) [226.303726] [071/133] (797s left) gem_pxp (display-protected-crc) [226.423315] Starting subtest: display-protected-crc [228.364517] Subtest display-protected-crc: SUCCESS (1.943s) [228.479921] [072/133] (795s left) kms_vblank (ts-continuation-modeset-hang) [228.585120] Starting subtest: ts-continuation-modeset-hang [228.586197] Starting dynamic subtest: pipe-A-eDP-1 [254.682790] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.097s) [254.692090] Starting dynamic subtest: pipe-D-eDP-1 [279.632598] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.947s) [279.633606] Subtest ts-continuation-modeset-hang: SUCCESS (51.048s) [280.480010] [073/133] (743s left) kms_psr (fbc-psr2-cursor-plane-move) [280.561371] Starting subtest: fbc-psr2-cursor-plane-move [280.562197] Starting dynamic subtest: eDP-1 [280.563795] Dynamic subtest eDP-1: SKIP (0.000s) [280.565507] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s) [280.639958] [074/133] (743s left) api_intel_allocator (execbuf-with-allocator) [280.707852] Starting subtest: execbuf-with-allocator [280.713604] Subtest execbuf-with-allocator: SUCCESS (0.006s) [280.844767] [075/133] (742s left) prime_vgem (fence-flip-hang) [280.905178] Subtest fence-flip-hang: SKIP (0.000s) [281.005946] [076/133] (742s left) gem_mmap_offset (mmap-unmap) [281.050339] Starting subtest: mmap-unmap [281.051223] Starting dynamic subtest: smem0 [306.049083] Dynamic subtest smem0: SUCCESS (24.952s) [306.050406] Subtest mmap-unmap: SUCCESS (24.953s) [306.125362] [077/133] (717s left) kms_big_fb (yf-tiled-8bpp-rotate-270) [306.227543] Starting subtest: yf-tiled-8bpp-rotate-270 [306.229374] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s) [306.321071] [078/133] (717s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc) [306.423344] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc [306.424332] Starting dynamic subtest: pipe-A-eDP-1 [306.431889] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [306.439580] Starting dynamic subtest: pipe-B-eDP-1 [306.447239] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [306.454693] Starting dynamic subtest: pipe-C-eDP-1 [306.462208] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [306.469438] Starting dynamic subtest: pipe-D-eDP-1 [306.476841] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [306.477689] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s) [308.725216] [079/133] (715s left) i915_drm_fdinfo (most-busy-idle-check-all) [308.759387] Starting subtest: most-busy-idle-check-all [308.760250] Starting dynamic subtest: rcs0 [308.763280] Dynamic subtest rcs0: SKIP (0.004s) [308.777928] Starting dynamic subtest: bcs0 [308.779691] Dynamic subtest bcs0: SKIP (0.000s) [308.786869] Starting dynamic subtest: vcs0 [308.788578] Dynamic subtest vcs0: SKIP (0.000s) [308.795798] Starting dynamic subtest: vcs1 [308.797560] Dynamic subtest vcs1: SKIP (0.000s) [308.804690] Starting dynamic subtest: vecs0 [308.806535] Dynamic subtest vecs0: SKIP (0.000s) [308.813747] Starting dynamic subtest: ccs0 [308.815461] Dynamic subtest ccs0: SKIP (0.000s) [308.817131] Subtest most-busy-idle-check-all: SKIP (0.009s) [308.848542] [080/133] (715s left) gem_pxp (protected-raw-src-copy-not-readible) [308.912324] Starting subtest: protected-raw-src-copy-not-readible [308.974419] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.061s) [309.109930] [081/133] (714s left) gem_eio (in-flight-10ms) [309.297542] Starting subtest: in-flight-10ms [317.374764] Subtest in-flight-10ms: SUCCESS (8.077s) [317.491128] [082/133] (706s left) perf_pmu (semaphore-wait) [317.531708] Starting subtest: semaphore-wait [317.532621] Starting dynamic subtest: rcs0 [318.053632] Dynamic subtest rcs0: SUCCESS (0.512s) [318.062364] Starting dynamic subtest: bcs0 [318.558643] Dynamic subtest bcs0: SUCCESS (0.511s) [318.570459] Starting dynamic subtest: vcs0 [319.080871] Dynamic subtest vcs0: SUCCESS (0.510s) [319.091038] Starting dynamic subtest: vcs1 [319.594759] Dynamic subtest vcs1: SUCCESS (0.511s) [319.603584] Starting dynamic subtest: vecs0 [320.109189] Dynamic subtest vecs0: SUCCESS (0.510s) [320.117590] Starting dynamic subtest: ccs0 [320.623815] Dynamic subtest ccs0: SUCCESS (0.512s) [320.625070] Subtest semaphore-wait: SUCCESS (3.084s) [321.005292] [083/133] (702s left) syncobj_wait (wait-any-snapshot) [321.068503] Starting subtest: wait-any-snapshot [321.149934] Subtest wait-any-snapshot: SUCCESS (0.081s) [321.223368] [084/133] (702s left) kms_plane_scaling (planes-upscale-20x20) [321.320158] Starting subtest: planes-upscale-20x20 [321.321142] Starting dynamic subtest: pipe-A [321.380776] Dynamic subtest pipe-A: SUCCESS (0.062s) [321.391452] Starting dynamic subtest: pipe-B [322.557238] Dynamic subtest pipe-B: SUCCESS (1.175s) [322.568471] Starting dynamic subtest: pipe-C [323.666563] Dynamic subtest pipe-C: SUCCESS (1.108s) [323.674306] Starting dynamic subtest: pipe-D [324.805769] Dynamic subtest pipe-D: SUCCESS (1.138s) [324.806667] Subtest planes-upscale-20x20: SUCCESS (3.488s) [325.957398] [085/133] (698s left) gem_exec_reloc (basic-gtt-noreloc) [326.020830] Subtest basic-gtt-noreloc: SKIP (0.000s) [326.072784] [086/133] (697s left) gem_softpin (allocator-nopin) [326.132454] Starting subtest: allocator-nopin [326.221108] Subtest allocator-nopin: SUCCESS (0.089s) [326.355175] [087/133] (697s left) kms_flip (basic-flip-vs-dpms) [326.458241] Starting subtest: basic-flip-vs-dpms [326.460230] Starting dynamic subtest: A-eDP1 [329.038068] Dynamic subtest A-eDP1: SUCCESS (2.577s) [329.046928] Starting dynamic subtest: B-eDP1 [331.210699] Dynamic subtest B-eDP1: SUCCESS (2.170s) [331.220212] Starting dynamic subtest: C-eDP1 [333.375171] Dynamic subtest C-eDP1: SUCCESS (2.162s) [333.384232] Starting dynamic subtest: D-eDP1 [335.541216] Dynamic subtest D-eDP1: SUCCESS (2.164s) [335.545371] Subtest basic-flip-vs-dpms: SUCCESS (9.088s) [336.333441] [088/133] (687s left) kms_color_pipeline (plane-lut1d-post-ctm3x4) [336.429121] Starting subtest: plane-lut1d-post-ctm3x4 [336.577111] Starting dynamic subtest: pipe-A-plane-0 [336.765920] Dynamic subtest pipe-A-plane-0: SUCCESS (0.189s) [336.775271] Starting dynamic subtest: pipe-A-plane-1 [336.966104] Dynamic subtest pipe-A-plane-1: SUCCESS (0.198s) [336.980180] Starting dynamic subtest: pipe-A-plane-2 [337.133565] Dynamic subtest pipe-A-plane-2: SUCCESS (0.165s) [338.350517] Starting dynamic subtest: pipe-B-plane-0 [338.521734] Dynamic subtest pipe-B-plane-0: SUCCESS (0.178s) [338.533486] Starting dynamic subtest: pipe-B-plane-1 [338.687291] Dynamic subtest pipe-B-plane-1: SUCCESS (0.165s) [338.695295] Starting dynamic subtest: pipe-B-plane-2 [338.853971] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s) [340.072673] Starting dynamic subtest: pipe-C-plane-0 [340.220329] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s) [340.228897] Starting dynamic subtest: pipe-C-plane-1 [340.376050] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s) [340.383983] Starting dynamic subtest: pipe-C-plane-2 [340.531442] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s) [341.693433] Starting dynamic subtest: pipe-D-plane-0 [341.841619] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s) [341.849582] Starting dynamic subtest: pipe-D-plane-1 [341.996936] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s) [342.005071] Starting dynamic subtest: pipe-D-plane-2 [342.152892] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s) [342.438120] Subtest plane-lut1d-post-ctm3x4: SUCCESS (6.008s) [343.268513] [089/133] (680s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt) [343.363650] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt [343.365352] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [343.451435] [090/133] (680s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled) [343.502961] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled [343.503976] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s) [343.603419] [091/133] (680s left) kms_addfb_basic (clobberred-modifier) [343.672134] Starting subtest: clobberred-modifier [343.674201] Subtest clobberred-modifier: SKIP (0.000s) [343.790835] [092/133] (680s left) gem_exec_parallel (engines) [343.850319] Starting subtest: engines [343.851268] Starting dynamic subtest: basic [345.891744] Dynamic subtest basic: SUCCESS (2.031s) [345.902463] Starting dynamic subtest: contexts [350.401679] Dynamic subtest contexts: SUCCESS (4.507s) [350.409695] Starting dynamic subtest: fds [354.144246] Dynamic subtest fds: SUCCESS (3.741s) [354.156059] Starting dynamic subtest: userptr [355.950993] Dynamic subtest userptr: SUCCESS (1.806s) [355.951919] Subtest engines: SUCCESS (12.091s) [356.129043] [093/133] (668s left) kms_lease (lease-unleased-crtc) [356.233290] Starting subtest: lease-unleased-crtc [356.234166] Starting dynamic subtest: pipe-A-eDP-1 [356.525207] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s) [356.535720] Starting dynamic subtest: pipe-B-eDP-1 [357.317608] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.790s) [357.328136] Starting dynamic subtest: pipe-C-eDP-1 [357.328941] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.005s) [357.338784] Starting dynamic subtest: pipe-D-eDP-1 [357.339646] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.005s) [357.340659] Subtest lease-unleased-crtc: SUCCESS (1.097s) [357.684666] [094/133] (666s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite) [357.778076] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite [367.689925] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.911s) [367.824326] [095/133] (656s left) kms_plane_multiple (2x-tiling-yf) [367.930653] Starting subtest: 2x-tiling-yf [367.932490] Subtest 2x-tiling-yf: SKIP (0.000s) [367.999090] [096/133] (656s left) kms_flip (flip-vs-wf_vblank-interruptible) [368.090791] Starting subtest: flip-vs-wf_vblank-interruptible [368.093014] Starting dynamic subtest: A-eDP1 [370.003910] Dynamic subtest A-eDP1: SUCCESS (1.911s) [370.015327] Starting dynamic subtest: B-eDP1 [371.931332] Dynamic subtest B-eDP1: SUCCESS (1.924s) [371.942062] Starting dynamic subtest: C-eDP1 [373.850076] Dynamic subtest C-eDP1: SUCCESS (1.915s) [373.862124] Starting dynamic subtest: D-eDP1 [375.791966] Dynamic subtest D-eDP1: SUCCESS (1.937s) [375.795781] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.705s) [377.029531] [097/133] (647s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu) [377.129717] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu [377.131404] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [377.232388] [098/133] (647s left) gem_mmap_gtt (fault-concurrent-x) [377.278052] Subtest fault-concurrent-X: SKIP (0.000s) [377.332715] [099/133] (647s left) gem_create (create-ext-placement-all) [377.500737] Starting subtest: create-ext-placement-all [377.501716] Subtest create-ext-placement-all: SUCCESS (0.000s) [377.602325] [100/133] (646s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc) [377.687264] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc [377.688110] Starting dynamic subtest: pipe-A-eDP-1 [377.696139] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [377.704502] Starting dynamic subtest: pipe-B-eDP-1 [377.711997] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [377.720059] Starting dynamic subtest: pipe-C-eDP-1 [377.727212] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [377.734776] Starting dynamic subtest: pipe-D-eDP-1 [377.742041] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [377.742877] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s) [379.998567] [101/133] (644s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area) [380.086335] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area [380.088205] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s) [380.173050] [102/133] (644s left) kms_scaling_modes (scaling-mode-full) [380.255512] Starting subtest: scaling-mode-full [380.256695] Starting dynamic subtest: pipe-A-eDP-1 [380.348233] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.094s) [380.357883] Starting dynamic subtest: pipe-B-eDP-1 [381.540418] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.190s) [381.551147] Starting dynamic subtest: pipe-C-eDP-1 [382.657274] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.114s) [382.668327] Starting dynamic subtest: pipe-D-eDP-1 [383.800174] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.140s) [383.802062] Subtest scaling-mode-full: SUCCESS (3.548s) [384.977438] [103/133] (639s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area) [385.078031] Starting subtest: psr2-overlay-primary-update-sf-dmg-area [385.078889] Starting dynamic subtest: pipe-A-eDP-1 [390.971727] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.893s) [390.979867] Starting dynamic subtest: pipe-B-eDP-1 [397.661321] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.687s) [397.662417] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.583s) [398.513856] [104/133] (626s left) kms_sequence (get-forked-busy) [398.598621] Starting subtest: get-forked-busy [398.599732] Starting dynamic subtest: pipe-A-eDP-1 [400.545910] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.948s) [400.554707] Starting dynamic subtest: pipe-B-eDP-1 [403.134397] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.587s) [403.143499] Starting dynamic subtest: pipe-C-eDP-1 [405.729587] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.593s) [405.738635] Starting dynamic subtest: pipe-D-eDP-1 [408.273324] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.542s) [408.274223] Subtest get-forked-busy: SUCCESS (9.677s) [409.063969] [105/133] (615s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move) [409.149685] Starting subtest: psr-2p-scndscrn-cur-indfb-move [409.151939] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [409.237044] [106/133] (615s left) syncobj_basic (test-valid-cycle) [409.285773] Starting subtest: test-valid-cycle [409.287027] Subtest test-valid-cycle: SUCCESS (0.000s) [409.393767] [107/133] (615s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render) [409.482189] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render [409.483841] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [409.564739] [108/133] (615s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions) [409.678765] Starting subtest: short-flip-after-cursor-atomic-transitions [410.650081] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.970s) [411.503859] [109/133] (613s left) perf (global-sseu-config) [411.647876] Starting subtest: global-sseu-config [411.649775] Subtest global-sseu-config: SKIP (0.000s) [411.687949] [110/133] (613s left) gen7_exec_parse (oacontrol-tracking) [411.739523] Subtest oacontrol-tracking: SKIP (0.000s) [411.799339] [111/133] (613s left) i915_getparams_basic (basic-eu-total) [411.857216] Starting subtest: basic-eu-total [411.859358] Subtest basic-eu-total: SUCCESS (0.000s) [411.942789] [112/133] (613s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted) [411.992204] Starting subtest: etime-single-wait-for-submit-unsubmitted [412.112086] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.108s) [412.186338] [113/133] (612s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render) [412.285621] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render [416.064030] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.779s) [417.227448] [114/133] (607s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt) [417.332691] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt [417.334551] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [417.420687] [115/133] (607s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render) [417.506596] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render [417.508392] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [417.599451] [116/133] (607s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary) [417.692921] Starting subtest: fbcpsr-shrfb-scaledprimary [423.522351] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.830s) [423.629240] [117/133] (601s left) kms_atomic (plane-overlay-legacy) [423.715539] Starting subtest: plane-overlay-legacy [423.716503] Starting dynamic subtest: pipe-A-eDP-1 [424.126844] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.410s) [424.127966] Subtest plane-overlay-legacy: SUCCESS (0.411s) [424.968950] [118/133] (600s left) kms_addfb_basic (bad-pitch-128) [425.029668] Starting subtest: bad-pitch-128 [425.030581] Subtest bad-pitch-128: SUCCESS (0.000s) [425.157500] [119/133] (600s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc) [425.248702] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc [431.837930] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.590s) [431.955896] [120/133] (593s left) kms_flip (basic-plain-flip) [432.043444] Starting subtest: basic-plain-flip [432.044345] Starting dynamic subtest: A-eDP1 [433.689956] Dynamic subtest A-eDP1: SUCCESS (1.645s) [433.702218] Starting dynamic subtest: B-eDP1 [435.334346] Dynamic subtest B-eDP1: SUCCESS (1.642s) [435.345080] Starting dynamic subtest: C-eDP1 [436.956682] Dynamic subtest C-eDP1: SUCCESS (1.619s) [436.971341] Starting dynamic subtest: D-eDP1 [438.597678] Dynamic subtest D-eDP1: SUCCESS (1.639s) [438.601244] Subtest basic-plain-flip: SUCCESS (6.559s) [439.750669] [121/133] (585s left) perf_pmu (init-busy) [439.782753] Starting subtest: init-busy [439.783702] Starting dynamic subtest: rcs0 [439.784635] Dynamic subtest rcs0: SUCCESS (0.001s) [439.793735] Starting dynamic subtest: bcs0 [439.794632] Dynamic subtest bcs0: SUCCESS (0.000s) [439.804917] Starting dynamic subtest: vcs0 [439.805800] Dynamic subtest vcs0: SUCCESS (0.001s) [439.813355] Starting dynamic subtest: vcs1 [439.814251] Dynamic subtest vcs1: SUCCESS (0.001s) [439.822163] Starting dynamic subtest: vecs0 [439.822976] Dynamic subtest vecs0: SUCCESS (0.001s) [439.830630] Starting dynamic subtest: ccs0 [439.831495] Dynamic subtest ccs0: SUCCESS (0.000s) [439.832379] Subtest init-busy: SUCCESS (0.008s) [439.882632] [122/133] (585s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc) [439.999675] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc [440.000957] Starting dynamic subtest: pipe-A-eDP-1 [457.144466] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.978s) [457.159710] Starting dynamic subtest: pipe-B-eDP-1 [475.120409] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.864s) [475.129314] Starting dynamic subtest: pipe-C-eDP-1 [493.084913] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.740s) [493.096355] Starting dynamic subtest: pipe-D-eDP-1 [511.074705] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.773s) [511.076100] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (10.361s) [517.374847] [123/133] (513s left) gem_exec_params (secure-non-master) [517.446111] Starting subtest: secure-non-master [517.447805] Subtest secure-non-master: SKIP (0.000s) [517.567794] [124/133] (512s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k) [517.940995] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s) [518.723038] [125/133] (511s left) fbdev (eof) [518.758263] Starting subtest: eof [518.759230] Subtest eof: SUCCESS (0.000s) [518.837471] [126/133] (511s left) kms_cursor_crc (cursor-random-128x128) [519.055784] Starting subtest: cursor-random-128x128 [519.057995] Starting dynamic subtest: pipe-A-eDP-1 [522.428523] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.400s) [522.475251] Starting dynamic subtest: pipe-D-eDP-1 [526.395983] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.962s) [526.396833] Subtest cursor-random-128x128: SUCCESS (7.393s) [527.231887] [127/133] (503s left) gem_exec_suspend (basic-s0) [527.284821] Starting subtest: basic-S0 [527.285820] Starting dynamic subtest: smem [547.488099] Dynamic subtest smem: SUCCESS (6.367s) [547.489766] Subtest basic-S0: SUCCESS (6.369s) [553.689020] [128/133] (482s left) gem_sync (basic-store-all) [553.745717] Starting subtest: basic-store-all [557.916396] Subtest basic-store-all: SUCCESS (4.162s) [558.088138] [129/133] (478s left) syncobj_wait (multi-wait-for-submit-unsubmitted) [558.133963] Starting subtest: multi-wait-for-submit-unsubmitted [558.242054] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.107s) [558.320674] [130/133] (478s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt) [558.421980] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt [566.061069] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.645s) [566.185439] [131/133] (470s left) kms_fbcon_fbt (psr) [566.241883] Starting subtest: psr [573.609100] Subtest psr: SUCCESS (7.361s) [573.679155] [132/133] (463s left) syncobj_timeline (wait-all-for-submit-snapshot) [573.727630] Starting subtest: wait-all-for-submit-snapshot [573.811108] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s) [573.896050] [133/133] (462s left) sysfs_heartbeat_interval (precise) [573.951834] Starting subtest: precise [573.952982] Starting dynamic subtest: vecs0 [581.456987] Dynamic subtest vecs0: SUCCESS (7.508s) [581.469445] Starting dynamic subtest: ccs0 [582.626725] Dynamic subtest ccs0: SUCCESS (1.166s) [582.638117] Starting dynamic subtest: vcs0 [589.462033] Dynamic subtest vcs0: SUCCESS (6.864s) [589.473755] Starting dynamic subtest: bcs0 [590.557425] Dynamic subtest bcs0: SUCCESS (1.106s) [590.573675] Starting dynamic subtest: rcs0 [593.419932] Dynamic subtest rcs0: SUCCESS (2.868s) [593.430111] Starting dynamic subtest: vcs1 [601.491364] Dynamic subtest vcs1: SUCCESS (8.088s) [601.492419] Subtest precise: SUCCESS (27.614s) [601.583592] Closing watchdogs results: parsing output: 0/ for test: i915_query results: parsing output: 1/ for test: gem_exec_schedule results: parsing output: 2/ for test: gem_render_linear_blits results: parsing output: 3/ for test: gem_ctx_param results: parsing output: 4/ for test: kms_frontbuffer_tracking results: parsing output: 5/ for test: kms_big_fb results: parsing output: 6/ for test: kms_plane results: parsing output: 7/ for test: gem_exec_schedule results: parsing output: 8/ for test: kms_cursor_crc results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: api_intel_bb results: parsing output: 11/ for test: kms_cursor_crc results: parsing output: 12/ for test: kms_psr results: parsing output: 13/ for test: gem_exec_capture results: parsing output: 14/ for test: kms_getfb results: parsing output: 15/ for test: kms_ccs results: parsing output: 16/ for test: gem_exec_params results: parsing output: 17/ for test: syncobj_timeline results: parsing output: 18/ for test: gem_render_copy results: parsing output: 19/ for test: kms_addfb_basic results: parsing output: 20/ for test: syncobj_wait results: parsing output: 21/ for test: kms_cursor_legacy results: parsing output: 22/ for test: syncobj_timeline results: parsing output: 23/ for test: kms_frontbuffer_tracking results: parsing output: 24/ for test: gem_ctx_shared results: parsing output: 25/ for test: kms_flip results: parsing output: 26/ for test: kms_pm_backlight results: parsing output: 27/ for test: kms_big_fb results: parsing output: 28/ for test: kms_big_fb results: parsing output: 29/ for test: gem_exec_reloc results: parsing output: 30/ for test: kms_ccs results: parsing output: 31/ for test: kms_flip results: parsing output: 32/ for test: kms_flip_scaled_crc results: parsing output: 33/ for test: kms_display_modes results: parsing output: 34/ for test: kms_draw_crc results: parsing output: 35/ for test: kms_chamelium_frames results: parsing output: 36/ for test: kms_frontbuffer_tracking results: parsing output: 37/ for test: syncobj_wait results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: kms_frontbuffer_tracking results: parsing output: 40/ for test: kms_content_protection results: parsing output: 41/ for test: core_getversion results: parsing output: 42/ for test: kms_psr results: parsing output: 43/ for test: gem_exec_flush results: parsing output: 44/ for test: gem_close_race results: parsing output: 45/ for test: gem_exec_params results: parsing output: 46/ for test: gem_fence_thrash results: parsing output: 47/ for test: kms_ccs results: parsing output: 48/ for test: i915_pm_rps results: parsing output: 49/ for test: gem_userptr_blits results: parsing output: 50/ for test: kms_invalid_mode results: parsing output: 51/ for test: gem_linear_blits results: parsing output: 52/ for test: gem_exec_balancer results: parsing output: 53/ for test: kms_pipe_crc_basic results: parsing output: 54/ for test: kms_plane results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: kms_prime results: parsing output: 57/ for test: kms_flip_scaled_crc results: parsing output: 58/ for test: gem_ctx_persistence results: parsing output: 59/ for test: kms_psr results: parsing output: 60/ for test: gem_lmem_swapping results: parsing output: 61/ for test: gem_exec_fence results: parsing output: 62/ for test: gem_wait results: parsing output: 63/ for test: vgem_basic results: parsing output: 64/ for test: sw_sync results: parsing output: 65/ for test: kms_psr2_sf results: parsing output: 66/ for test: kms_frontbuffer_tracking results: parsing output: 67/ for test: kms_big_fb results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: kms_big_fb results: parsing output: 70/ for test: gem_pxp results: parsing output: 71/ for test: kms_vblank results: parsing output: 72/ for test: kms_psr results: parsing output: 73/ for test: api_intel_allocator results: parsing output: 74/ for test: prime_vgem results: parsing output: 75/ for test: gem_mmap_offset results: parsing output: 76/ for test: kms_big_fb results: parsing output: 77/ for test: kms_ccs results: parsing output: 78/ for test: i915_drm_fdinfo results: parsing output: 79/ for test: gem_pxp results: parsing output: 80/ for test: gem_eio results: parsing output: 81/ for test: perf_pmu results: parsing output: 82/ for test: syncobj_wait results: parsing output: 83/ for test: kms_plane_scaling results: parsing output: 84/ for test: gem_exec_reloc results: parsing output: 85/ for test: gem_softpin results: parsing output: 86/ for test: kms_flip results: parsing output: 87/ for test: kms_color_pipeline results: parsing output: 88/ for test: kms_frontbuffer_tracking results: parsing output: 89/ for test: syncobj_timeline results: parsing output: 90/ for test: kms_addfb_basic results: parsing output: 91/ for test: gem_exec_parallel results: parsing output: 92/ for test: kms_lease results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: kms_plane_multiple results: parsing output: 95/ for test: kms_flip results: parsing output: 96/ for test: kms_frontbuffer_tracking results: parsing output: 97/ for test: gem_mmap_gtt results: parsing output: 98/ for test: gem_create results: parsing output: 99/ for test: kms_ccs results: parsing output: 100/ for test: kms_psr2_sf results: parsing output: 101/ for test: kms_scaling_modes results: parsing output: 102/ for test: kms_psr2_sf results: parsing output: 103/ for test: kms_sequence results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: syncobj_basic results: parsing output: 106/ for test: kms_frontbuffer_tracking results: parsing output: 107/ for test: kms_cursor_legacy results: parsing output: 108/ for test: perf results: parsing output: 109/ for test: gen7_exec_parse results: parsing output: 110/ for test: i915_getparams_basic results: parsing output: 111/ for test: syncobj_timeline results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: kms_frontbuffer_tracking results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: kms_atomic results: parsing output: 117/ for test: kms_addfb_basic results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: kms_flip results: parsing output: 120/ for test: perf_pmu results: parsing output: 121/ for test: kms_ccs results: parsing output: 122/ for test: gem_exec_params results: parsing output: 123/ for test: kms_chamelium_edid results: parsing output: 124/ for test: fbdev results: parsing output: 125/ for test: kms_cursor_crc results: parsing output: 126/ for test: gem_exec_suspend results: parsing output: 127/ for test: gem_sync results: parsing output: 128/ for test: syncobj_wait results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: kms_fbcon_fbt results: parsing output: 131/ for test: syncobj_timeline results: parsing output: 132/ for test: sysfs_heartbeat_interval Done.