[64.319418] Initializing watchdogs
[64.319553]   /dev/watchdog0
[64.335635] [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]
[64.340240] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[64.342437] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[64.344246] [001/133] (960s left) kms_plane_multiple (tiling-x)
[64.441395] Starting subtest: tiling-x
[64.442424] Starting dynamic subtest: pipe-A-eDP-1
[68.157830] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.725s)
[68.164136] Starting dynamic subtest: pipe-B-eDP-1
[72.675728] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.525s)
[72.682064] Starting dynamic subtest: pipe-C-eDP-1
[77.006628] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.333s)
[77.013229] Starting dynamic subtest: pipe-D-eDP-1
[81.339432] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.331s)
[81.340415] Subtest tiling-x: SUCCESS (16.918s)
[82.146591] [002/133] (942s left) gem_exec_schedule (out-order)
[82.212158] Starting subtest: out-order
[82.213893] Starting dynamic subtest: rcs0
[82.311693] Dynamic subtest rcs0: SUCCESS (0.099s)
[82.319657] Starting dynamic subtest: vcs0
[82.401791] Dynamic subtest vcs0: SUCCESS (0.091s)
[82.407728] Starting dynamic subtest: vcs1
[82.492107] Dynamic subtest vcs1: SUCCESS (0.090s)
[82.498678] Starting dynamic subtest: vecs0
[82.576812] Dynamic subtest vecs0: SUCCESS (0.083s)
[82.585950] Starting dynamic subtest: ccs0
[82.661667] Dynamic subtest ccs0: SUCCESS (0.085s)
[82.663214] Subtest out-order: SUCCESS (0.450s)
[84.014384] [003/133] (940s left) syncobj_timeline (device-signal-unordered)
[84.059370] Starting subtest: device-signal-unordered
[84.060563] Subtest device-signal-unordered: SUCCESS (0.001s)
[84.145613] [004/133] (940s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[84.232984] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[84.234914] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[84.297228] [005/133] (940s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[84.380063] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[84.381839] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[84.466498] [006/133] (940s left) kms_psr (fbc-psr2-suspend)
[84.556433] Starting subtest: fbc-psr2-suspend
[84.557390] Starting dynamic subtest: eDP-1
[84.559223] Dynamic subtest eDP-1: SKIP (0.000s)
[84.560897] Subtest fbc-psr2-suspend: SKIP (0.000s)
[84.634630] [007/133] (940s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[84.720824] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[84.801336] [008/133] (940s left) kms_prime (basic-modeset-hybrid)
[84.880396] Subtest basic-modeset-hybrid: SKIP (0.000s)
[85.009374] [FACT kms_prime (basic-modeset-hybrid)] new: kernel.kmod_is_loaded.vgem: true
[85.011435] [009/133] (940s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[85.104567] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[85.105406] Starting dynamic subtest: pipe-A-eDP-1
[90.932093] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.826s)
[90.939564] Starting dynamic subtest: pipe-B-eDP-1
[97.581117] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.647s)
[97.582016] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.475s)
[98.447510] [010/133] (926s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[98.540818] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[102.614725] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.073s)
[103.754796] [011/133] (921s left) kms_lease (lease-invalid-crtc)
[103.845181] Starting subtest: lease-invalid-crtc
[103.846103] Starting dynamic subtest: pipe-A-eDP-1
[103.847128] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[103.853436] Starting dynamic subtest: pipe-B-eDP-1
[103.854331] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[103.860424] Starting dynamic subtest: pipe-C-eDP-1
[103.861364] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[103.867155] Starting dynamic subtest: pipe-D-eDP-1
[103.868060] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[103.868917] Subtest lease-invalid-crtc: SUCCESS (0.003s)
[103.929080] [012/133] (921s left) kms_psr (psr-dpms)
[104.034485] Starting subtest: psr-dpms
[104.035514] Starting dynamic subtest: eDP-1
[107.055053] Dynamic subtest eDP-1: SUCCESS (3.020s)
[107.055875] Subtest psr-dpms: SUCCESS (3.021s)
[107.918873] [013/133] (917s left) gem_ctx_persistence (legacy-engines-hostile)
[107.982955] Starting subtest: legacy-engines-hostile
[107.983988] Starting dynamic subtest: render
[108.105708] Dynamic subtest render: SUCCESS (0.122s)
[108.115973] Starting dynamic subtest: bsd1
[108.201957] Dynamic subtest bsd1: SUCCESS (0.094s)
[108.212068] Starting dynamic subtest: bsd2
[108.293741] Dynamic subtest bsd2: SUCCESS (0.090s)
[108.302704] Starting dynamic subtest: blt
[108.382971] Dynamic subtest blt: SUCCESS (0.087s)
[108.393571] Starting dynamic subtest: vebox
[108.474478] Dynamic subtest vebox: SUCCESS (0.090s)
[108.475740] Subtest legacy-engines-hostile: SUCCESS (0.492s)
[108.544995] [014/133] (916s left) gem_exec_suspend (basic-s4-devices)
[108.610435] Starting subtest: basic-S4-devices
[108.611535] Starting dynamic subtest: smem
[119.904456] Dynamic subtest smem: SUCCESS (11.282s)
[119.905634] Subtest basic-S4-devices: SUCCESS (11.283s)
[126.086574] [015/133] (905s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[126.179871] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[126.181460] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[126.255840] [016/133] (905s left) i915_query (query-topology-kernel-writes)
[126.301820] Starting subtest: query-topology-kernel-writes
[126.302659] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[126.420026] [017/133] (904s left) kms_pipe_crc_basic (read-crc)
[126.508419] Starting subtest: read-crc
[126.509369] Starting dynamic subtest: pipe-A-eDP-1
[127.222437] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.713s)
[127.230028] Starting dynamic subtest: pipe-B-eDP-1
[128.607251] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.384s)
[128.615961] Starting dynamic subtest: pipe-C-eDP-1
[129.992134] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.383s)
[129.999851] Starting dynamic subtest: pipe-D-eDP-1
[131.322471] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.329s)
[131.323463] Subtest read-crc: SUCCESS (4.814s)
[132.158317] [018/133] (899s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[132.247361] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[132.248224] Starting dynamic subtest: pipe-A-eDP-1
[132.256812] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[132.264480] Starting dynamic subtest: pipe-B-eDP-1
[132.272992] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[132.279966] Starting dynamic subtest: pipe-C-eDP-1
[132.288514] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[132.295354] Starting dynamic subtest: pipe-D-eDP-1
[132.303712] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[132.305604] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[134.528712] [019/133] (896s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[134.623821] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[141.476359] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.839s)
[141.614746] [020/133] (889s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[141.709654] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[141.711371] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[141.813682] [021/133] (889s left) i915_drm_fdinfo (busy-hang)
[141.853437] Starting subtest: busy-hang
[141.854423] Starting dynamic subtest: rcs0
[141.881040] Dynamic subtest rcs0: SKIP (0.027s)
[141.890189] Starting dynamic subtest: bcs0
[141.891842] Dynamic subtest bcs0: SKIP (0.001s)
[141.898955] Starting dynamic subtest: vcs0
[141.900696] Dynamic subtest vcs0: SKIP (0.000s)
[141.907793] Starting dynamic subtest: vcs1
[141.909683] Dynamic subtest vcs1: SKIP (0.001s)
[141.916433] Starting dynamic subtest: vecs0
[141.918127] Dynamic subtest vecs0: SKIP (0.000s)
[141.924769] Starting dynamic subtest: ccs0
[141.926513] Dynamic subtest ccs0: SKIP (0.000s)
[141.928391] Subtest busy-hang: SKIP (0.032s)
[141.956430] [022/133] (889s left) api_intel_allocator (standalone)
[142.001086] Starting subtest: standalone
[142.016860] Subtest standalone: SUCCESS (0.016s)
[142.133363] [023/133] (889s left) gem_exec_create (madvise)
[142.182671] Starting subtest: madvise
[142.183606] Starting dynamic subtest: smem
[162.980519] Dynamic subtest smem: SUCCESS (20.785s)
[162.981912] Subtest madvise: SUCCESS (20.786s)
[164.140679] [024/133] (867s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[164.268070] Starting subtest: cursorB-vs-flipA-varying-size
[164.269932] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[164.422578] [025/133] (867s left) perf (oa-formats)
[164.544957] Starting subtest: oa-formats
[164.545852] Starting dynamic subtest: 0-rcs0
[164.559528] Dynamic subtest 0-rcs0: SUCCESS (0.015s)
[164.569331] Starting dynamic subtest: 1-vecs0
[164.586255] Dynamic subtest 1-vecs0: SUCCESS (0.026s)
[164.587269] Subtest oa-formats: SUCCESS (0.042s)
[164.633904] [026/133] (867s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[164.729649] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[164.731341] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[165.906803] [027/133] (865s left) gem_mmap_wc (write-prefaulted)
[165.958766] Subtest write-prefaulted: SKIP (0.000s)
[166.020493] [028/133] (865s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[166.069511] Subtest untiled-to-tiled: SKIP (0.000s)
[166.132913] [029/133] (865s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[166.184019] Starting subtest: single-wait-for-submit-unsubmitted
[166.289942] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[166.372289] [030/133] (865s left) gem_ringfill (engines-basic)
[171.937598] Starting subtest: engines-basic
[171.938573] Starting dynamic subtest: rcs0
[171.996346] Dynamic subtest rcs0: SUCCESS (0.067s)
[172.007482] Starting dynamic subtest: bcs0
[172.041691] Dynamic subtest bcs0: SUCCESS (0.044s)
[172.051388] Starting dynamic subtest: vcs0
[172.084541] Dynamic subtest vcs0: SUCCESS (0.041s)
[172.093978] Starting dynamic subtest: vcs1
[172.129401] Dynamic subtest vcs1: SUCCESS (0.043s)
[172.139745] Starting dynamic subtest: vecs0
[172.173788] Dynamic subtest vecs0: SUCCESS (0.043s)
[172.183447] Starting dynamic subtest: ccs0
[172.219821] Dynamic subtest ccs0: SUCCESS (0.044s)
[172.221057] Subtest engines-basic: SUCCESS (0.292s)
[172.304232] [031/133] (859s left) gem_mmap_gtt (basic-small-copy)
[172.362801] Subtest basic-small-copy: SKIP (0.000s)
[172.420949] [032/133] (859s left) gem_exec_store (basic)
[172.476540] Starting subtest: basic
[172.585887] Subtest basic: SUCCESS (0.109s)
[172.767159] [033/133] (859s left) kms_busy (extended-pageflip-hang-newfb)
[172.874792] Starting subtest: extended-pageflip-hang-newfb
[172.875617] Starting dynamic subtest: pipe-A
[199.671462] Dynamic subtest pipe-A: SUCCESS (26.794s)
[199.678932] Starting dynamic subtest: pipe-D
[224.690389] Dynamic subtest pipe-D: SUCCESS (25.016s)
[224.691269] Subtest extended-pageflip-hang-newfb: SUCCESS (51.815s)
[225.565854] [034/133] (806s left) gem_exec_balancer (bonded-dual)
[225.617677] Starting subtest: bonded-dual
[225.619439] Subtest bonded-dual: SKIP (0.000s)
[225.951821] [035/133] (806s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[226.044675] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[226.046790] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[226.131590] [036/133] (805s left) syncobj_timeline (invalid-wait-illegal-handle)
[226.189472] Starting subtest: invalid-wait-illegal-handle
[226.190446] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[226.284097] [037/133] (805s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[226.368206] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[233.440619] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (7.071s)
[233.586643] [038/133] (798s left) i915_pm_sseu (full-enable)
[233.645313] Subtest full-enable: SKIP (0.000s)
[233.738613] [039/133] (798s left) kms_flip (nonblocking-read)
[233.828133] Starting subtest: nonblocking-read
[233.829076] Subtest nonblocking-read: SUCCESS (0.000s)
[233.934793] [040/133] (798s left) kms_addfb_basic (basic)
[233.992363] Starting subtest: basic
[233.993265] Subtest basic: SUCCESS (0.000s)
[234.118605] [041/133] (798s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[234.236741] Starting subtest: flip-vs-cursor-atomic
[241.671075] Subtest flip-vs-cursor-atomic: SUCCESS (7.433s)
[242.532111] [042/133] (789s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[242.929677] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[243.737097] [043/133] (788s left) syncobj_timeline (reset-unsignaled)
[243.804399] Starting subtest: reset-unsignaled
[243.805340] Subtest reset-unsignaled: SUCCESS (0.000s)
[243.892896] [044/133] (788s left) kms_psr (pr-primary-blt)
[243.990351] Starting subtest: pr-primary-blt
[243.992038] Subtest pr-primary-blt: SKIP (0.000s)
[244.057148] [045/133] (788s left) kms_content_protection (atomic-dpms-hdcp14)
[244.190528] Starting subtest: atomic-dpms-hdcp14
[244.192548] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[244.320061] [046/133] (788s left) gen7_exec_parse (basic-allowed)
[244.379536] Subtest basic-allowed: SKIP (0.000s)
[244.437815] [047/133] (787s left) syncobj_timeline (etime-multi-wait-all-submitted)
[244.498811] Starting subtest: etime-multi-wait-all-submitted
[244.602378] Subtest etime-multi-wait-all-submitted: SUCCESS (0.102s)
[244.673794] [048/133] (787s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[244.761111] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[244.762936] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[244.862093] [049/133] (787s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[244.921208] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[244.970870] [050/133] (787s left) kms_flip (nonexisting-fb)
[245.066769] Starting subtest: nonexisting-fb
[245.069739] Starting dynamic subtest: A-eDP1
[246.252799] Dynamic subtest A-eDP1: SUCCESS (1.184s)
[246.261605] Starting dynamic subtest: B-eDP1
[247.384393] Dynamic subtest B-eDP1: SUCCESS (1.130s)
[247.393098] Starting dynamic subtest: C-eDP1
[248.526159] Dynamic subtest C-eDP1: SUCCESS (1.141s)
[248.535062] Starting dynamic subtest: D-eDP1
[249.655297] Dynamic subtest D-eDP1: SUCCESS (1.128s)
[249.659770] Subtest nonexisting-fb: SUCCESS (4.593s)
[250.830815] [051/133] (781s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[250.919348] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[250.920389] Starting dynamic subtest: pipe-A-eDP-1
[250.929164] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[250.936843] Starting dynamic subtest: pipe-B-eDP-1
[250.945481] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[250.953272] Starting dynamic subtest: pipe-C-eDP-1
[250.962524] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[250.970990] Starting dynamic subtest: pipe-D-eDP-1
[250.979486] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[250.981149] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[253.200033] [052/133] (779s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[253.291806] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[254.415354] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.124s)
[254.521990] [053/133] (778s left) kms_chamelium_hpd (vga-hpd)
[254.897105] Subtest vga-hpd: SKIP (0.000s)
[255.706940] [054/133] (776s left) syncobj_wait (single-wait-all-for-submit-submitted)
[255.757307] Starting subtest: single-wait-all-for-submit-submitted
[255.865760] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.108s)
[255.942769] [055/133] (776s left) gem_exec_create (legacy)
[255.997051] Starting subtest: legacy
[255.998136] Starting dynamic subtest: smem
[258.088457] Dynamic subtest smem: SUCCESS (2.091s)
[258.089719] Subtest legacy: SUCCESS (2.092s)
[258.266202] [056/133] (774s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[258.406931] Starting subtest: x-tiled-64bpp-rotate-180
[260.028358] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.623s)
[260.190858] [057/133] (772s left) syncobj_timeline (wait-all-complex)
[260.241380] Starting subtest: wait-all-complex
[260.467705] Subtest wait-all-complex: SUCCESS (0.217s)
[260.543545] [058/133] (772s left) gem_mmap_offset (blt-coherency)
[260.607527] Starting subtest: blt-coherency
[260.613934] Subtest blt-coherency: SUCCESS (0.007s)
[260.731186] [059/133] (772s left) prime_mmap (test_dup)
[260.787509] Starting subtest: test_dup
[260.788681] Starting dynamic subtest: test_dup-smem
[260.838398] Dynamic subtest test_dup-smem: SUCCESS (0.051s)
[260.839715] Subtest test_dup: SUCCESS (0.053s)
[260.907082] [060/133] (771s left) kms_dsc (dsc-with-formats)
[260.997459] Starting subtest: dsc-with-formats
[261.012573] Subtest dsc-with-formats: SKIP (0.001s)
[261.067849] [061/133] (771s left) gem_exec_create (forked)
[261.118915] Starting subtest: forked
[261.120131] Starting dynamic subtest: smem
[282.847048] Dynamic subtest smem: SUCCESS (21.717s)
[282.848474] Subtest forked: SUCCESS (21.719s)
[283.035394] [062/133] (749s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[283.134559] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[283.136362] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[283.220141] [063/133] (749s left) gem_ctx_param (invalid-get-engines)
[283.268591] Starting subtest: invalid-get-engines
[283.269651] Subtest invalid-get-engines: SUCCESS (0.001s)
[283.377589] [064/133] (749s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[283.471493] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[290.920869] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.450s)
[291.076336] [065/133] (741s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[291.171416] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[291.172393] Starting dynamic subtest: pipe-A-eDP-1
[291.175870] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[291.183450] Starting dynamic subtest: pipe-B-eDP-1
[291.186828] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[291.194391] Starting dynamic subtest: pipe-C-eDP-1
[291.197970] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[291.207390] Starting dynamic subtest: pipe-D-eDP-1
[291.211040] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[291.212705] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s)
[293.316849] [066/133] (739s left) perf (rc6-disable)
[293.413129] Starting subtest: rc6-disable
[293.592384] Subtest rc6-disable: SUCCESS (0.180s)
[293.629945] [067/133] (739s left) gem_create (create-ext-placement-all)
[293.793916] Starting subtest: create-ext-placement-all
[293.795317] Subtest create-ext-placement-all: SUCCESS (0.000s)
[293.907991] [068/133] (739s left) perf_pmu (render-node-busy-idle)
[293.980882] Starting subtest: render-node-busy-idle
[293.982090] Starting dynamic subtest: rcs0
[294.673391] Dynamic subtest rcs0: SUCCESS (0.692s)
[294.686160] Starting dynamic subtest: bcs0
[295.337880] Dynamic subtest bcs0: SUCCESS (0.662s)
[295.349444] Starting dynamic subtest: vcs0
[296.928071] Dynamic subtest vcs0: SUCCESS (1.578s)
[296.941994] Starting dynamic subtest: vcs1
[298.911076] Dynamic subtest vcs1: SUCCESS (1.980s)
[298.921501] Starting dynamic subtest: vecs0
[300.895673] Dynamic subtest vecs0: SUCCESS (1.981s)
[300.906409] Starting dynamic subtest: ccs0
[301.558750] Dynamic subtest ccs0: SUCCESS (0.670s)
[301.560375] Subtest render-node-busy-idle: SUCCESS (7.579s)
[301.628413] [069/133] (731s left) kms_cursor_edge_walk (256x256-top-bottom)
[301.717094] Starting subtest: 256x256-top-bottom
[301.717935] Starting dynamic subtest: pipe-A-eDP-1
[305.174243] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.456s)
[305.183038] Starting dynamic subtest: pipe-D-eDP-1
[308.293517] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.116s)
[308.294494] Subtest 256x256-top-bottom: SUCCESS (6.575s)
[309.103163] [070/133] (724s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[309.196796] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[309.197647] Starting dynamic subtest: pipe-A-default-mode
[311.956695] Dynamic subtest pipe-A-default-mode: SUCCESS (2.759s)
[311.957696] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.760s)
[312.794863] [071/133] (720s left) i915_fb_tiling (basic-x-tiling)
[312.843897] Subtest basic-x-tiling: SKIP (0.000s)
[312.906632] [072/133] (720s left) gem_exec_reloc (basic-active)
[312.963488] Subtest basic-active: SKIP (0.000s)
[313.030869] [073/133] (720s left) gem_exec_reloc (basic-softpin)
[313.081997] Subtest basic-softpin: SKIP (0.000s)
[313.144821] [074/133] (720s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[313.268460] Starting subtest: short-flip-after-cursor-atomic-transitions
[314.207839] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.938s)
[315.025138] [075/133] (718s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[315.116458] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[315.118208] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[315.199101] [076/133] (718s left) api_intel_bb (intel-bb-blit-none)
[315.251813] Starting subtest: intel-bb-blit-none
[319.196511] Subtest intel-bb-blit-none: SUCCESS (3.936s)
[319.306580] [077/133] (714s left) gem_exercise_blt (fast-copy-emit)
[319.368732] Starting subtest: fast-copy-emit
[319.369656] Starting dynamic subtest: linear-smem-smem-emit
[319.392242] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.025s)
[319.402474] Starting dynamic subtest: xmajor-smem-smem-emit
[319.412021] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.019s)
[319.419367] Starting dynamic subtest: tile4-smem-smem-emit
[319.430906] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.018s)
[319.438238] Starting dynamic subtest: tile64-smem-smem-emit
[319.450107] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.019s)
[319.451029] Subtest fast-copy-emit: SUCCESS (0.084s)
[319.573241] [078/133] (713s left) kms_color (legacy-gamma-reset)
[319.660354] Starting subtest: legacy-gamma-reset
[319.661364] Starting dynamic subtest: pipe-A-eDP-1
[320.049553] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.389s)
[320.061842] Starting dynamic subtest: pipe-B-eDP-1
[320.068464] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.018s)
[320.076554] Starting dynamic subtest: pipe-C-eDP-1
[320.100522] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.031s)
[320.110096] Starting dynamic subtest: pipe-D-eDP-1
[320.124764] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[320.125522] Subtest legacy-gamma-reset: SUCCESS (0.465s)
[320.847592] [079/133] (712s left) kms_draw_crc (fill-fb)
[320.952844] Starting subtest: fill-fb
[321.495846] Subtest fill-fb: SUCCESS (0.542s)
[321.586783] [080/133] (712s left) gem_pxp (reject-modify-context-protection-off-1)
[321.700087] Starting subtest: reject-modify-context-protection-off-1
[321.701506] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[321.814278] [081/133] (711s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[324.144464] Starting subtest: dpms-mode-unset-lpsp
[328.201454] Subtest dpms-mode-unset-lpsp: SUCCESS (4.068s)
[328.573749] [082/133] (705s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[328.634886] Starting subtest: invalid-multi-wait-all-unsubmitted
[328.636028] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[328.738897] [083/133] (704s left) gem_exec_capture (userptr)
[328.788884] Starting subtest: userptr
[329.615346] Subtest userptr: SUCCESS (0.828s)
[329.716933] [084/133] (704s left) kms_vblank (query-forked)
[329.801223] Starting subtest: query-forked
[329.802024] Starting dynamic subtest: pipe-A-eDP-1
[331.638381] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.835s)
[331.653484] Starting dynamic subtest: pipe-D-eDP-1
[334.192921] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.553s)
[334.193760] Subtest query-forked: SUCCESS (4.392s)
[335.033177] [085/133] (698s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[335.146935] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[335.928345] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.781s)
[336.095092] [086/133] (697s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[336.187484] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[343.348729] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.162s)
[343.459288] [087/133] (690s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[343.553562] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[347.765065] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (4.212s)
[348.898337] [088/133] (684s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[348.987436] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[349.016419] Starting dynamic subtest: pipe-A-plane-0
[349.303519] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[349.313113] Starting dynamic subtest: pipe-A-plane-3
[349.536972] Dynamic subtest pipe-A-plane-3: SUCCESS (0.231s)
[349.545288] Starting dynamic subtest: pipe-A-plane-5
[349.546830] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[350.662275] Starting dynamic subtest: pipe-B-plane-0
[350.965708] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s)
[350.974702] Starting dynamic subtest: pipe-B-plane-3
[351.198936] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s)
[351.208401] Starting dynamic subtest: pipe-B-plane-5
[351.210264] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[351.510013] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.523s)
[352.326329] [089/133] (681s left) kms_psr (fbc-pr-primary-mmap-gtt)
[352.407975] Starting subtest: fbc-pr-primary-mmap-gtt
[352.409774] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[352.489409] [090/133] (681s left) gem_lmem_swapping (random)
[352.532682] Subtest random: SKIP (0.000s)
[352.572268] [091/133] (681s left) device_reset (unbind-reset-rebind)
[352.614645] Starting subtest: unbind-reset-rebind
[356.511624] Subtest unbind-reset-rebind: SUCCESS (3.893s)
[356.550647] [092/133] (677s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[356.634673] Starting subtest: addfb25-y-tiled-legacy
[356.635521] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[356.731330] [093/133] (677s left) gem_busy (busy)
[356.790392] Starting subtest: busy
[356.791388] Starting dynamic subtest: all-engines
[356.823376] Dynamic subtest all-engines: SUCCESS (0.033s)
[356.834376] Starting dynamic subtest: rcs0
[357.923251] Dynamic subtest rcs0: SUCCESS (1.092s)
[357.933355] Starting dynamic subtest: bcs0
[357.966753] Dynamic subtest bcs0: SUCCESS (0.049s)
[357.976550] Starting dynamic subtest: vcs0
[358.007557] Dynamic subtest vcs0: SUCCESS (0.039s)
[358.017047] Starting dynamic subtest: vcs1
[359.906464] Dynamic subtest vcs1: SUCCESS (1.887s)
[359.916611] Starting dynamic subtest: vecs0
[361.891046] Dynamic subtest vecs0: SUCCESS (1.983s)
[361.901458] Starting dynamic subtest: ccs0
[363.938337] Dynamic subtest ccs0: SUCCESS (2.047s)
[363.939391] Subtest busy: SUCCESS (7.139s)
[364.276595] [094/133] (669s left) kms_psr (psr2-cursor-plane-move)
[364.383700] Starting subtest: psr2-cursor-plane-move
[364.384737] Starting dynamic subtest: eDP-1
[366.060900] Dynamic subtest eDP-1: SUCCESS (1.677s)
[366.061719] Subtest psr2-cursor-plane-move: SUCCESS (1.679s)
[366.922488] [095/133] (667s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[367.013976] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[367.015562] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[367.079366] [096/133] (667s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[367.184524] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[367.186203] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[367.286482] [097/133] (666s left) gen9_exec_parse (basic-rejected-ctx-param)
[367.345980] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[367.401336] [098/133] (666s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[367.639301] Starting subtest: cursor-rapid-movement-512x512
[367.641201] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[367.795337] [099/133] (666s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[367.889812] Starting subtest: psr-dirtyfb-ioctl
[367.890800] Starting dynamic subtest: A-eDP-1
[371.826303] Dynamic subtest A-eDP-1: SUCCESS (3.934s)
[371.827158] Subtest psr-dirtyfb-ioctl: SUCCESS (3.937s)
[372.700080] [100/133] (661s left) gen3_render_tiledy_blits
[372.804441] [101/133] (661s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[372.903466] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[372.905087] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[372.993624] [102/133] (661s left) prime_mmap (test_correct_cpu_write)
[373.051498] Starting subtest: test_correct_cpu_write
[373.052631] Starting dynamic subtest: test_correct_cpu_write-smem
[373.053628] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[373.054533] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[373.139062] [103/133] (661s left) kms_invalid_mode (overflow-vrefresh)
[373.219548] Starting subtest: overflow-vrefresh
[373.220572] Starting dynamic subtest: pipe-A-eDP-1
[373.518203] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.297s)
[373.526875] Starting dynamic subtest: pipe-B-eDP-1
[373.527758] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[373.536107] Starting dynamic subtest: pipe-C-eDP-1
[373.536988] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[373.545355] Starting dynamic subtest: pipe-D-eDP-1
[373.546201] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[373.546996] Subtest overflow-vrefresh: SUCCESS (0.303s)
[374.348785] [104/133] (660s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[374.461511] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[406.500976] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (32.037s)
[407.368614] [105/133] (627s left) perf_pmu (busy-accuracy-50)
[407.418473] Starting subtest: busy-accuracy-50
[407.419506] Starting dynamic subtest: rcs0
[408.957368] Dynamic subtest rcs0: SUCCESS (1.534s)
[408.968582] Starting dynamic subtest: bcs0
[410.500578] Dynamic subtest bcs0: SUCCESS (1.540s)
[410.511910] Starting dynamic subtest: vcs0
[412.047455] Dynamic subtest vcs0: SUCCESS (1.544s)
[412.059117] Starting dynamic subtest: vcs1
[413.591583] Dynamic subtest vcs1: SUCCESS (1.541s)
[413.602218] Starting dynamic subtest: vecs0
[415.128722] Dynamic subtest vecs0: SUCCESS (1.535s)
[415.139535] Starting dynamic subtest: ccs0
[416.677380] Dynamic subtest ccs0: SUCCESS (1.546s)
[416.678474] Subtest busy-accuracy-50: SUCCESS (9.255s)
[416.793933] [106/133] (617s left) gem_exec_schedule (u-submit-early-slice)
[416.858944] Starting subtest: u-submit-early-slice
[416.859977] Starting dynamic subtest: rcs0
[416.926071] Dynamic subtest rcs0: SUCCESS (0.061s)
[416.937817] Starting dynamic subtest: bcs0
[416.972950] Dynamic subtest bcs0: SUCCESS (0.052s)
[416.983770] Starting dynamic subtest: vcs0
[417.020581] Dynamic subtest vcs0: SUCCESS (0.046s)
[417.030059] Starting dynamic subtest: vcs1
[417.078817] Dynamic subtest vcs1: SUCCESS (0.058s)
[417.092572] Starting dynamic subtest: vecs0
[417.126493] Dynamic subtest vecs0: SUCCESS (0.046s)
[417.136851] Starting dynamic subtest: ccs0
[417.176073] Dynamic subtest ccs0: SUCCESS (0.049s)
[417.177552] Subtest u-submit-early-slice: SUCCESS (0.317s)
[418.977184] [107/133] (615s left) prime_vgem (basic-blt)
[419.038495] Starting subtest: basic-blt
[419.077639] Subtest basic-blt: SUCCESS (0.039s)
[419.213363] [108/133] (615s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[419.305045] Starting subtest: psr-rgb101010-draw-mmap-gtt
[419.306928] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[419.398913] [109/133] (615s left) gem_ctx_sseu (mmap-args)
[419.456766] Subtest mmap-args: SKIP (0.000s)
[419.527996] [110/133] (615s left) prime_mmap (test_aperture_limit)
[419.586062] Starting subtest: test_aperture_limit
[419.586983] Starting dynamic subtest: test_aperture_limit-smem
[419.594522] Dynamic subtest test_aperture_limit-smem: SKIP (0.008s)
[419.596289] Subtest test_aperture_limit: SKIP (0.009s)
[419.689827] [111/133] (614s left) kms_cursor_crc (cursor-onscreen-32x10)
[419.830481] Starting subtest: cursor-onscreen-32x10
[419.882055] Subtest cursor-onscreen-32x10: SKIP (0.049s)
[420.144268] [112/133] (614s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[420.244416] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[420.256471] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.011s)
[420.330777] [113/133] (614s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[420.420306] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[420.421249] Starting dynamic subtest: pipe-A
[420.441550] Dynamic subtest pipe-A: SKIP (0.019s)
[420.450448] Starting dynamic subtest: pipe-B
[420.478927] Dynamic subtest pipe-B: SKIP (0.037s)
[420.487599] Starting dynamic subtest: pipe-C
[420.518549] Dynamic subtest pipe-C: SKIP (0.037s)
[420.527997] Starting dynamic subtest: pipe-D
[420.555844] Dynamic subtest pipe-D: SKIP (0.038s)
[420.557519] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.134s)
[420.663332] [114/133] (614s left) sysfs_preempt_timeout (timeout)
[420.716549] Starting subtest: timeout
[420.717644] Starting dynamic subtest: vecs0
[429.914491] Dynamic subtest vecs0: SUCCESS (9.188s)
[429.926459] Starting dynamic subtest: ccs0
[431.227505] Dynamic subtest ccs0: SUCCESS (1.319s)
[431.239618] Starting dynamic subtest: vcs0
[440.918040] Dynamic subtest vcs0: SUCCESS (9.679s)
[440.929600] Starting dynamic subtest: bcs0
[442.189565] Dynamic subtest bcs0: SUCCESS (1.278s)
[442.199591] Starting dynamic subtest: rcs0
[443.452804] Dynamic subtest rcs0: SUCCESS (1.260s)
[443.464032] Starting dynamic subtest: vcs1
[452.886771] Dynamic subtest vcs1: SUCCESS (9.423s)
[452.887916] Subtest timeout: SUCCESS (32.160s)
[452.950202] [115/133] (581s left) i915_pm_rpm (gem-evict-pwrite)
[455.089828] Starting subtest: gem-evict-pwrite
[455.092540] Subtest gem-evict-pwrite: SKIP (0.000s)
[455.456307] [116/133] (579s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[455.560567] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[455.562370] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[455.655834] [117/133] (579s left) kms_async_flips (test-time-stamp-atomic)
[455.748901] Starting subtest: test-time-stamp-atomic
[456.122938] Starting dynamic subtest: pipe-A-eDP-1
[456.949023] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.825s)
[457.332848] Starting dynamic subtest: pipe-B-eDP-1
[458.084202] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.758s)
[458.474190] Starting dynamic subtest: pipe-C-eDP-1
[459.223287] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.756s)
[459.605515] Starting dynamic subtest: pipe-D-eDP-1
[460.362531] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.763s)
[460.363533] Subtest test-time-stamp-atomic: SUCCESS (4.615s)
[461.528865] [118/133] (573s left) gem_spin_batch (legacy)
[461.581121] Starting subtest: legacy
[461.581904] Starting dynamic subtest: default
[464.829618] Dynamic subtest default: SUCCESS (3.236s)
[464.840016] Starting dynamic subtest: render
[468.102777] Dynamic subtest render: SUCCESS (3.233s)
[468.113608] Starting dynamic subtest: bsd
[471.342301] Dynamic subtest bsd: SUCCESS (3.236s)
[471.354933] Starting dynamic subtest: bsd1
[474.575794] Dynamic subtest bsd1: SUCCESS (3.230s)
[474.588489] Starting dynamic subtest: bsd2
[477.815948] Dynamic subtest bsd2: SUCCESS (3.237s)
[477.826605] Starting dynamic subtest: blt
[481.053264] Dynamic subtest blt: SUCCESS (3.234s)
[481.064195] Starting dynamic subtest: vebox
[484.291588] Dynamic subtest vebox: SUCCESS (3.235s)
[484.292879] Subtest legacy: SUCCESS (22.663s)
[484.968779] [119/133] (549s left) kms_vblank (invalid)
[485.078308] Starting subtest: invalid
[485.080585] Starting dynamic subtest: pipe-A-eDP-1
[485.499858] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.420s)
[485.500709] Subtest invalid: SUCCESS (0.422s)
[486.358037] [120/133] (548s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[486.459382] Starting subtest: y-tiled-32bpp-rotate-0
[486.461250] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[486.550324] [121/133] (548s left) gem_userptr_blits (process-exit)
[486.610984] Starting subtest: process-exit
[486.618651] Subtest process-exit: SUCCESS (0.008s)
[486.738440] [122/133] (548s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[486.822913] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[486.824871] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[486.920112] [123/133] (548s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[487.012267] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[487.013180] Starting dynamic subtest: pipe-A-eDP-1
[487.090056] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s)
[487.100348] Starting dynamic subtest: pipe-B-eDP-1
[488.242911] Dynamic subtest pipe-B-eDP-1: SKIP (1.151s)
[488.244622] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.232s)
[489.423459] [124/133] (545s left) gem_render_copy (y-tiled)
[489.476890] Starting subtest: y-tiled
[489.478338] Subtest y-tiled: SKIP (0.000s)
[489.655208] [125/133] (545s left) kms_addfb_basic (unused-handle)
[489.710868] Starting subtest: unused-handle
[489.711784] Subtest unused-handle: SUCCESS (0.000s)
[489.841767] [126/133] (545s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[489.942951] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[489.944951] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[490.038908] [127/133] (545s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[490.147683] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[491.107045] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.958s)
[491.955336] [128/133] (543s left) gem_mmap_gtt (hang)
[492.013433] Subtest hang: SKIP (0.000s)
[492.078959] [129/133] (543s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[492.166132] Starting subtest: fbcpsr-rgb565-draw-blt
[499.254433] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.088s)
[499.387709] [130/133] (535s left) gem_exec_fence (long-history)
[499.842207] Starting subtest: long-history
[506.691704] Subtest long-history: SUCCESS (6.840s)
[507.126059] [131/133] (528s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[507.212820] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[507.213648] Starting dynamic subtest: pipe-A-eDP-1
[507.221175] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[507.230041] Starting dynamic subtest: pipe-B-eDP-1
[507.237797] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[507.246714] Starting dynamic subtest: pipe-C-eDP-1
[507.254222] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[507.262615] Starting dynamic subtest: pipe-D-eDP-1
[507.270492] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[507.272038] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.005s)
[509.470134] [132/133] (525s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[509.568476] Starting subtest: fbc-rgb101010-draw-pwrite
[515.071256] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.503s)
[516.182816] [133/133] (519s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[516.274901] Starting subtest: yf-tiled-32bpp-rotate-0
[516.276730] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[516.375329] Closing watchdogs
results: parsing output: 0/ for test: kms_plane_multiple
results: parsing output: 1/ for test: gem_exec_schedule
results: parsing output: 2/ for test: syncobj_timeline
results: parsing output: 3/ for test: kms_plane
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_psr
results: parsing output: 6/ for test: kms_addfb_basic
results: parsing output: 7/ for test: kms_prime
results: parsing output: 8/ for test: kms_psr2_sf
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_lease
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: gem_ctx_persistence
results: parsing output: 13/ for test: gem_exec_suspend
results: parsing output: 14/ for test: kms_psr2_sf
results: parsing output: 15/ for test: i915_query
results: parsing output: 16/ for test: kms_pipe_crc_basic
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: i915_drm_fdinfo
results: parsing output: 21/ for test: api_intel_allocator
results: parsing output: 22/ for test: gem_exec_create
results: parsing output: 23/ for test: kms_cursor_legacy
results: parsing output: 24/ for test: perf
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: gem_mmap_wc
results: parsing output: 27/ for test: gem_set_tiling_vs_blt
results: parsing output: 28/ for test: syncobj_wait
results: parsing output: 29/ for test: gem_ringfill
results: parsing output: 30/ for test: gem_mmap_gtt
results: parsing output: 31/ for test: gem_exec_store
results: parsing output: 32/ for test: kms_busy
results: parsing output: 33/ for test: gem_exec_balancer
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: syncobj_timeline
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: i915_pm_sseu
results: parsing output: 38/ for test: kms_flip
results: parsing output: 39/ for test: kms_addfb_basic
results: parsing output: 40/ for test: kms_cursor_legacy
results: parsing output: 41/ for test: kms_chamelium_edid
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: kms_psr
results: parsing output: 44/ for test: kms_content_protection
results: parsing output: 45/ for test: gen7_exec_parse
results: parsing output: 46/ for test: syncobj_timeline
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_pipe_b_c_ivb
results: parsing output: 49/ for test: kms_flip
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: kms_chamelium_hpd
results: parsing output: 53/ for test: syncobj_wait
results: parsing output: 54/ for test: gem_exec_create
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: syncobj_timeline
results: parsing output: 57/ for test: gem_mmap_offset
results: parsing output: 58/ for test: prime_mmap
results: parsing output: 59/ for test: kms_dsc
results: parsing output: 60/ for test: gem_exec_create
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: gem_ctx_param
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: perf
results: parsing output: 66/ for test: gem_create
results: parsing output: 67/ for test: perf_pmu
results: parsing output: 68/ for test: kms_cursor_edge_walk
results: parsing output: 69/ for test: kms_flip_scaled_crc
results: parsing output: 70/ for test: i915_fb_tiling
results: parsing output: 71/ for test: gem_exec_reloc
results: parsing output: 72/ for test: gem_exec_reloc
results: parsing output: 73/ for test: kms_cursor_legacy
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: api_intel_bb
results: parsing output: 76/ for test: gem_exercise_blt
results: parsing output: 77/ for test: kms_color
results: parsing output: 78/ for test: kms_draw_crc
results: parsing output: 79/ for test: gem_pxp
results: parsing output: 80/ for test: kms_pm_rpm
results: parsing output: 81/ for test: syncobj_wait
results: parsing output: 82/ for test: gem_exec_capture
results: parsing output: 83/ for test: kms_vblank
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_plane
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: gem_lmem_swapping
results: parsing output: 90/ for test: device_reset
results: parsing output: 91/ for test: kms_addfb_basic
results: parsing output: 92/ for test: gem_busy
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: kms_flip_scaled_crc
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gen9_exec_parse
results: parsing output: 97/ for test: kms_cursor_crc
results: parsing output: 98/ for test: kms_dirtyfb
results: parsing output: 99/ for test: gen3_render_tiledy_blits
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: prime_mmap
results: parsing output: 102/ for test: kms_invalid_mode
results: parsing output: 103/ for test: kms_cursor_legacy
results: parsing output: 104/ for test: perf_pmu
results: parsing output: 105/ for test: gem_exec_schedule
results: parsing output: 106/ for test: prime_vgem
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_ctx_sseu
results: parsing output: 109/ for test: prime_mmap
results: parsing output: 110/ for test: kms_cursor_crc
results: parsing output: 111/ for test: kms_flip
results: parsing output: 112/ for test: kms_plane_scaling
results: parsing output: 113/ for test: sysfs_preempt_timeout
results: parsing output: 114/ for test: i915_pm_rpm
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_async_flips
results: parsing output: 117/ for test: gem_spin_batch
results: parsing output: 118/ for test: kms_vblank
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: gem_userptr_blits
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_psr2_sf
results: parsing output: 123/ for test: gem_render_copy
results: parsing output: 124/ for test: kms_addfb_basic
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_cursor_legacy
results: parsing output: 127/ for test: gem_mmap_gtt
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_exec_fence
results: parsing output: 130/ for test: kms_ccs
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_big_fb
Done.