[56.527131] Initializing watchdogs
[56.527176]   /dev/watchdog0
[56.540838] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.544966] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.547423] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.550557] [001/131] (960s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[56.663540] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[56.668069] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[57.821044] [002/131] (959s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[57.919026] Starting subtest: primary-y-tiled-reflect-x-180
[57.979502] Subtest primary-y-tiled-reflect-x-180: SKIP (0.059s)
[58.097455] [003/131] (959s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[58.191073] Starting subtest: extended-modeset-hang-oldfb-with-reset
[58.193549] Starting dynamic subtest: pipe-A
[70.043544] Dynamic subtest pipe-A: SUCCESS (11.881s)
[70.053242] Starting dynamic subtest: pipe-D
[82.418680] Dynamic subtest pipe-D: SUCCESS (12.380s)
[82.421264] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.265s)
[83.234671] [004/131] (933s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[83.313158] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[83.416018] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.104s)
[83.519118] [005/131] (933s left) api_intel_allocator (reopen)
[83.592937] Starting subtest: reopen
[83.597532] Subtest reopen: SUCCESS (0.004s)
[83.740217] [006/131] (933s left) syncobj_timeline (invalid-query-one-illegal-handle)
[83.803065] Starting subtest: invalid-query-one-illegal-handle
[83.805492] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[83.926856] [007/131] (933s left) gem_lmem_swapping (verify-random-ccs)
[83.970933] Subtest verify-random-ccs: SKIP (0.000s)
[84.007805] [008/131] (933s left) prime_busy (before-wait)
[84.072532] Starting subtest: before-wait
[84.077076] Starting dynamic subtest: rcs0
[84.128345] Dynamic subtest rcs0: SUCCESS (0.054s)
[84.138462] Starting dynamic subtest: bcs0
[84.181041] Dynamic subtest bcs0: SUCCESS (0.052s)
[84.190472] Starting dynamic subtest: vcs0
[84.221825] Dynamic subtest vcs0: SUCCESS (0.040s)
[84.230178] Starting dynamic subtest: vcs1
[84.262694] Dynamic subtest vcs1: SUCCESS (0.041s)
[84.271454] Starting dynamic subtest: vecs0
[84.304690] Dynamic subtest vecs0: SUCCESS (0.042s)
[84.312576] Starting dynamic subtest: ccs0
[84.344961] Dynamic subtest ccs0: SUCCESS (0.040s)
[84.454780] Subtest before-wait: SUCCESS (0.381s)
[84.548354] [009/131] (932s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[84.650815] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[84.655136] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[84.802784] [010/131] (932s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[84.898983] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[84.901671] Starting dynamic subtest: pipe-A-eDP-1
[84.922686] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[84.933519] Starting dynamic subtest: pipe-B-eDP-1
[84.952101] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[84.960092] Starting dynamic subtest: pipe-C-eDP-1
[84.979875] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[84.988806] Starting dynamic subtest: pipe-D-eDP-1
[85.008356] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[85.010588] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.004s)
[87.217189] [011/131] (930s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[87.329286] Starting subtest: psr-rgb565-draw-blt
[94.328903] Subtest psr-rgb565-draw-blt: SUCCESS (7.003s)
[94.495866] [012/131] (922s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[94.893183] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[95.725312] [013/131] (921s left) gem_exec_fence (basic-wait)
[95.909651] Starting subtest: basic-wait
[95.911902] Starting dynamic subtest: rcs0
[95.994934] Dynamic subtest rcs0: SUCCESS (0.084s)
[96.004577] Starting dynamic subtest: bcs0
[96.048758] Dynamic subtest bcs0: SUCCESS (0.053s)
[96.057082] Starting dynamic subtest: vcs0
[96.108590] Dynamic subtest vcs0: SUCCESS (0.060s)
[96.117189] Starting dynamic subtest: vcs1
[96.171892] Dynamic subtest vcs1: SUCCESS (0.062s)
[96.182091] Starting dynamic subtest: vecs0
[96.226109] Dynamic subtest vecs0: SUCCESS (0.053s)
[96.235954] Starting dynamic subtest: ccs0
[96.292186] Dynamic subtest ccs0: SUCCESS (0.065s)
[96.294496] Subtest basic-wait: SUCCESS (0.383s)
[98.027379] [FACT gem_exec_fence (basic-wait)] new: kernel.kmod_is_loaded.vgem: true
[98.030505] [014/131] (919s left) gen9_exec_parse (bb-start-param)
[98.102628] Subtest bb-start-param: SKIP (0.000s)
[98.191551] [015/131] (919s left) api_intel_bb (render)
[98.254062] Starting subtest: render
[98.256083] Starting dynamic subtest: render-none-512
[98.355430] Dynamic subtest render-none-512: SUCCESS (0.103s)
[98.365748] Starting dynamic subtest: render-none-1024
[98.726645] Dynamic subtest render-none-1024: SUCCESS (0.369s)
[98.737018] Starting dynamic subtest: render-x-512
[98.810629] Dynamic subtest render-x-512: SUCCESS (0.085s)
[98.821204] Starting dynamic subtest: render-x-1024
[99.144321] Dynamic subtest render-x-1024: SUCCESS (0.332s)
[99.154121] Starting dynamic subtest: render-y-512
[99.228904] Dynamic subtest render-y-512: SUCCESS (0.085s)
[99.239226] Starting dynamic subtest: render-y-1024
[99.562835] Dynamic subtest render-y-1024: SUCCESS (0.332s)
[99.565474] Subtest render: SUCCESS (1.310s)
[99.680961] [016/131] (917s left) kms_lease (lease-invalid-connector)
[99.786094] Starting subtest: lease-invalid-connector
[99.788469] Starting dynamic subtest: pipe-A-eDP-1
[99.790498] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[99.800347] Starting dynamic subtest: pipe-B-eDP-1
[99.802550] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[99.810181] Starting dynamic subtest: pipe-C-eDP-1
[99.812447] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[99.819505] Starting dynamic subtest: pipe-D-eDP-1
[99.821362] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[99.823243] Subtest lease-invalid-connector: SUCCESS (0.002s)
[99.876883] [017/131] (917s left) kms_fbcon_fbt (psr-suspend)
[99.936995] Starting subtest: psr-suspend
[149.978927] Subtest psr-suspend: SUCCESS (23.370s)
[150.017955] [018/131] (867s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[150.146160] Starting subtest: basic-flip-after-cursor-legacy
[151.071846] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.924s)
[151.935988] [019/131] (865s left) gem_exec_fence (keep-in-fence)
[152.120716] Starting subtest: keep-in-fence
[152.123338] Starting dynamic subtest: rcs0
[152.194401] Dynamic subtest rcs0: SUCCESS (0.074s)
[152.206074] Starting dynamic subtest: bcs0
[152.248145] Dynamic subtest bcs0: SUCCESS (0.053s)
[152.258820] Starting dynamic subtest: vcs0
[153.553093] Dynamic subtest vcs0: SUCCESS (1.302s)
[153.564993] Starting dynamic subtest: vcs1
[155.536951] Dynamic subtest vcs1: SUCCESS (1.987s)
[155.551562] Starting dynamic subtest: vecs0
[157.572013] Dynamic subtest vecs0: SUCCESS (2.024s)
[157.592222] Starting dynamic subtest: ccs0
[157.761390] Dynamic subtest ccs0: SUCCESS (0.245s)
[157.764245] Subtest keep-in-fence: SUCCESS (5.692s)
[159.591918] [020/131] (858s left) kms_flip (2x-plain-flip)
[159.692885] Starting subtest: 2x-plain-flip
[159.701782] Subtest 2x-plain-flip: SKIP (0.011s)
[159.804847] [021/131] (858s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[159.900668] Starting subtest: yf-tiled-8bpp-rotate-0
[159.904809] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[160.019351] [022/131] (857s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[160.120081] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[160.124441] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[160.238749] [023/131] (857s left) kms_cursor_crc (cursor-onscreen-256x85)
[160.496855] Starting subtest: cursor-onscreen-256x85
[160.540658] Subtest cursor-onscreen-256x85: SKIP (0.041s)
[160.760437] [024/131] (857s left) gem_ccs (ctrl-surf-copy)
[160.832479] Starting subtest: ctrl-surf-copy
[160.836262] Subtest ctrl-surf-copy: SKIP (0.000s)
[160.957197] [025/131] (857s left) gem_exec_alignment (many)
[161.009089] Starting subtest: many
[182.150801] Subtest many: SUCCESS (21.229s)
[184.205434] [026/131] (833s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[184.345395] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[184.355140] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.010s)
[184.472617] [027/131] (833s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[184.541995] Subtest writes-after-reads-snoop: SKIP (0.000s)
[184.619872] [028/131] (833s left) gem_exec_reloc (basic-gtt-read-noreloc)
[184.686167] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[184.763375] [029/131] (833s left) i915_selftest (mock)
[188.439263] Starting subtest: mock
[188.441818] Starting dynamic subtest: sanitycheck
[189.142069] Dynamic subtest sanitycheck: SUCCESS (0.701s)
[189.151350] Starting dynamic subtest: shmem
[189.842985] Dynamic subtest shmem: SUCCESS (0.699s)
[189.853045] Starting dynamic subtest: fence
[197.655985] Dynamic subtest fence: SUCCESS (7.806s)
[197.665982] Starting dynamic subtest: scatterlist
[199.370371] Dynamic subtest scatterlist: SUCCESS (1.713s)
[199.380550] Starting dynamic subtest: syncmap
[203.337012] Dynamic subtest syncmap: SUCCESS (3.964s)
[203.348629] Starting dynamic subtest: uncore
[204.062874] Dynamic subtest uncore: SUCCESS (0.725s)
[204.072730] Starting dynamic subtest: ring
[204.823061] Dynamic subtest ring: SUCCESS (0.759s)
[204.832962] Starting dynamic subtest: engine
[205.575846] Dynamic subtest engine: SUCCESS (0.752s)
[205.585706] Starting dynamic subtest: timelines
[209.418038] Dynamic subtest timelines: SUCCESS (3.840s)
[209.432652] Starting dynamic subtest: requests
[212.881791] Dynamic subtest requests: SUCCESS (3.463s)
[212.891246] Starting dynamic subtest: objects
[213.727333] Dynamic subtest objects: SUCCESS (0.844s)
[213.735419] Starting dynamic subtest: phys
[214.555326] Dynamic subtest phys: SUCCESS (0.827s)
[214.565039] Starting dynamic subtest: dmabuf
[215.416325] Dynamic subtest dmabuf: SUCCESS (0.860s)
[215.426059] Starting dynamic subtest: vma
[220.694844] Dynamic subtest vma: SUCCESS (5.277s)
[220.704584] Starting dynamic subtest: evict
[222.143375] Dynamic subtest evict: SUCCESS (1.448s)
[222.153030] Starting dynamic subtest: gtt
[225.426256] Dynamic subtest gtt: SUCCESS (3.282s)
[225.435670] Starting dynamic subtest: hugepages
[226.359411] Dynamic subtest hugepages: SUCCESS (0.933s)
[226.368590] Starting dynamic subtest: memory_region
[228.882844] Dynamic subtest memory_region: SUCCESS (2.522s)
[228.885741] Subtest mock: SUCCESS (40.437s)
[228.917078] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[228.917797] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[228.921200] [030/131] (789s left) i915_drm_fdinfo (isolation)
[230.431054] Starting subtest: isolation
[230.433465] Starting dynamic subtest: rcs0
[230.486159] Dynamic subtest rcs0: SKIP (0.052s)
[230.499874] Starting dynamic subtest: bcs0
[230.504225] Dynamic subtest bcs0: SKIP (0.005s)
[230.516550] Starting dynamic subtest: vcs0
[230.520824] Dynamic subtest vcs0: SKIP (0.000s)
[230.529389] Starting dynamic subtest: vcs1
[230.533476] Dynamic subtest vcs1: SKIP (0.000s)
[230.541287] Starting dynamic subtest: vecs0
[230.545609] Dynamic subtest vecs0: SKIP (0.000s)
[230.553456] Starting dynamic subtest: ccs0
[230.557706] Dynamic subtest ccs0: SKIP (0.000s)
[230.561912] Subtest isolation: SKIP (0.063s)
[230.592116] [FACT i915_drm_fdinfo (isolation)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[230.593414] [FACT i915_drm_fdinfo (isolation)] new: kernel.kmod_is_loaded.i915: true
[230.596830] [031/131] (787s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[230.696278] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[230.700746] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[230.808133] [032/131] (787s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[230.909933] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[230.912219] Starting dynamic subtest: pipe-A-eDP-1
[230.936709] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[230.948234] Starting dynamic subtest: pipe-B-eDP-1
[230.971507] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[230.979440] Starting dynamic subtest: pipe-C-eDP-1
[231.002849] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[231.010903] Starting dynamic subtest: pipe-D-eDP-1
[231.035488] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[231.039499] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[233.176179] [033/131] (785s left) kms_psr (psr-cursor-blt)
[233.278861] Starting subtest: psr-cursor-blt
[233.281099] Starting dynamic subtest: eDP-1
[235.037055] Dynamic subtest eDP-1: SUCCESS (1.760s)
[235.039384] Subtest psr-cursor-blt: SUCCESS (1.761s)
[235.924444] [034/131] (782s left) kms_flip (blocking-absolute-wf_vblank)
[236.024020] Starting subtest: blocking-absolute-wf_vblank
[236.026451] Starting dynamic subtest: A-eDP1
[244.796886] Dynamic subtest A-eDP1: SUCCESS (8.740s)
[244.806956] Starting dynamic subtest: B-eDP1
[253.525157] Dynamic subtest B-eDP1: SUCCESS (8.729s)
[253.536283] Starting dynamic subtest: C-eDP1
[262.254629] Dynamic subtest C-eDP1: SUCCESS (8.716s)
[262.266830] Starting dynamic subtest: D-eDP1
[270.997813] Dynamic subtest D-eDP1: SUCCESS (8.737s)
[270.999876] Subtest blocking-absolute-wf_vblank: SUCCESS (34.931s)
[272.194503] [035/131] (746s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[272.291268] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[278.825865] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.537s)
[278.977054] [036/131] (739s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[279.095089] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[279.176978] [037/131] (739s left) gem_exec_flush (basic-uc-prw-default)
[279.251557] Starting subtest: basic-uc-prw-default
[284.740093] Subtest basic-uc-prw-default: SUCCESS (5.453s)
[284.908692] [038/131] (733s left) kms_atomic (test-only)
[285.021677] Starting subtest: test-only
[285.070775] Starting dynamic subtest: pipe-A-eDP-1
[287.589415] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.518s)
[287.591441] Subtest test-only: SUCCESS (2.567s)
[288.408120] [039/131] (730s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[288.528311] Starting subtest: cursor-vs-flip-atomic
[317.781085] Subtest cursor-vs-flip-atomic: SUCCESS (29.254s)
[318.630195] [040/131] (700s left) kms_addfb_basic (invalid-get-prop)
[318.700104] Starting subtest: invalid-get-prop
[318.702416] Subtest invalid-get-prop: SUCCESS (0.000s)
[318.873220] [041/131] (699s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[318.975088] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[318.977289] Starting dynamic subtest: pipe-A-eDP-1
[319.034310] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[319.044421] Starting dynamic subtest: pipe-B-eDP-1
[319.100989] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[319.111742] Starting dynamic subtest: pipe-C-eDP-1
[319.168327] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[319.177951] Starting dynamic subtest: pipe-D-eDP-1
[319.236189] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[319.240407] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.008s)
[321.307794] [042/131] (697s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[321.400989] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[321.403118] Starting dynamic subtest: pipe-A-default-mode
[321.691243] Dynamic subtest pipe-A-default-mode: SKIP (0.286s)
[321.695642] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.288s)
[322.531631] [043/131] (696s left) gem_pwrite (basic-exhaustion)
[322.598185] Subtest basic-exhaustion: SKIP (0.000s)
[322.665611] [044/131] (696s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[322.762524] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[322.764816] Starting dynamic subtest: pipe-A-eDP-1
[322.788244] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[322.797026] Starting dynamic subtest: pipe-B-eDP-1
[322.819541] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[322.827809] Starting dynamic subtest: pipe-C-eDP-1
[322.850403] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[322.858495] Starting dynamic subtest: pipe-D-eDP-1
[322.881434] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[322.885333] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[324.996609] [045/131] (693s left) kms_color (ctm-green-to-red)
[325.100042] Starting subtest: ctm-green-to-red
[325.101890] Starting dynamic subtest: pipe-A-eDP-1
[325.774102] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.673s)
[325.783713] Starting dynamic subtest: pipe-B-eDP-1
[327.174740] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.401s)
[327.183993] Starting dynamic subtest: pipe-C-eDP-1
[328.563240] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.390s)
[328.572197] Starting dynamic subtest: pipe-D-eDP-1
[329.876242] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.312s)
[329.878701] Subtest ctm-green-to-red: SUCCESS (4.778s)
[330.724926] [046/131] (688s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[330.941831] Starting subtest: cursor-rapid-movement-128x42
[330.991023] Subtest cursor-rapid-movement-128x42: SKIP (0.043s)
[331.238394] [047/131] (687s left) gem_exec_balancer (hog)
[331.299602] Starting subtest: hog
[331.303702] Subtest hog: SKIP (0.000s)
[331.619796] [048/131] (687s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[331.717360] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[338.485095] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.770s)
[338.670323] [049/131] (680s left) gem_softpin (evict-active-interruptible)
[338.737619] Starting subtest: evict-active-interruptible
[338.746586] Subtest evict-active-interruptible: SUCCESS (0.009s)
[338.894296] [050/131] (680s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[338.990981] Starting subtest: x-tiled-64bpp-rotate-0
[340.600345] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.612s)
[340.814415] [051/131] (678s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[340.918004] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[340.931752] Starting dynamic subtest: pipe-A
[340.940458] Dynamic subtest pipe-A: SKIP (0.017s)
[340.950619] Starting dynamic subtest: pipe-B
[340.971532] Dynamic subtest pipe-B: SKIP (0.031s)
[340.980716] Starting dynamic subtest: pipe-C
[341.003185] Dynamic subtest pipe-C: SKIP (0.030s)
[341.012204] Starting dynamic subtest: pipe-D
[341.033824] Dynamic subtest pipe-D: SKIP (0.031s)
[341.037603] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.113s)
[341.160887] [052/131] (677s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[341.228349] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[341.233012] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[341.429451] [053/131] (677s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[341.525502] Starting subtest: stress-xrgb8888-ytiled
[341.530342] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[341.603688] [054/131] (677s left) perf_pmu (faulting-read)
[341.641643] Starting subtest: faulting-read
[341.644014] Starting dynamic subtest: wb
[341.646240] Dynamic subtest wb: SUCCESS (0.001s)
[341.656810] Starting dynamic subtest: wc
[341.658892] Dynamic subtest wc: SUCCESS (0.000s)
[341.667440] Starting dynamic subtest: uc
[341.669532] Dynamic subtest uc: SUCCESS (0.000s)
[341.671639] Subtest faulting-read: SUCCESS (0.003s)
[341.777929] [055/131] (677s left) kms_prop_blob (blob-prop-core)
[341.831733] Starting subtest: blob-prop-core
[341.833434] Subtest blob-prop-core: SUCCESS (0.000s)
[341.964224] [056/131] (677s left) gem_render_copy (x-tiled)
[342.020257] Starting subtest: x-tiled
[342.022184] Starting dynamic subtest: smem
[342.060707] Dynamic subtest smem: SUCCESS (0.040s)
[342.062853] Subtest x-tiled: SUCCESS (0.041s)
[342.332493] [057/131] (677s left) kms_cursor_edge_walk (256x256-top-bottom)
[342.428848] Starting subtest: 256x256-top-bottom
[342.431067] Starting dynamic subtest: pipe-A-eDP-1
[345.881355] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.451s)
[345.899379] Starting dynamic subtest: pipe-D-eDP-1
[349.002341] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.122s)
[349.004443] Subtest 256x256-top-bottom: SUCCESS (6.576s)
[349.840006] [058/131] (669s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[349.941902] Starting subtest: plane-all-transition-nonblocking-fencing
[349.944087] Starting dynamic subtest: pipe-A-eDP-1
[352.445623] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.506s)
[352.753987] Starting dynamic subtest: pipe-B-eDP-1
[355.948871] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.206s)
[356.245626] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.307s)
[357.114597] [059/131] (662s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[357.522079] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[358.292360] [060/131] (661s left) syncobj_timeline (wait-all-snapshot)
[358.347925] Starting subtest: wait-all-snapshot
[358.428460] Subtest wait-all-snapshot: SUCCESS (0.081s)
[358.529900] [061/131] (660s left) gem_eio (in-flight-internal-10ms)
[358.766652] Starting subtest: in-flight-internal-10ms
[360.589934] Subtest in-flight-internal-10ms: SUCCESS (1.824s)
[360.780052] [062/131] (658s left) gem_lmem_swapping (massive)
[360.844075] Subtest massive: SKIP (0.000s)
[360.895899] [063/131] (658s left) gem_ctx_param (invalid-param-get)
[360.960368] Starting subtest: invalid-param-get
[360.962673] Subtest invalid-param-get: SUCCESS (0.001s)
[361.093208] [064/131] (658s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[361.211320] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[361.846233] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.637s)
[362.054499] [065/131] (657s left) gem_ctx_param (invalid-get-engines)
[362.111303] Starting subtest: invalid-get-engines
[362.113730] Subtest invalid-get-engines: SUCCESS (0.001s)
[362.266167] [066/131] (657s left) vgem_basic (bad-fence)
[362.311836] Starting subtest: bad-fence
[362.314021] Subtest bad-fence: SUCCESS (0.000s)
[362.394166] [067/131] (657s left) kms_psr (fbc-psr2-sprite-render)
[362.495324] Starting subtest: fbc-psr2-sprite-render
[362.497631] Starting dynamic subtest: eDP-1
[362.502228] Dynamic subtest eDP-1: SKIP (0.000s)
[362.506773] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[362.607284] [068/131] (657s left) gem_pwrite_snooped
[362.756199] [069/131] (657s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[362.849387] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[362.851301] Starting dynamic subtest: pipe-A
[362.959832] Dynamic subtest pipe-A: SKIP (0.107s)
[362.975646] Starting dynamic subtest: pipe-B
[364.168451] Dynamic subtest pipe-B: SKIP (1.207s)
[364.179230] Starting dynamic subtest: pipe-C
[365.303336] Dynamic subtest pipe-C: SUCCESS (1.140s)
[365.314100] Starting dynamic subtest: pipe-D
[366.455752] Dynamic subtest pipe-D: SUCCESS (1.152s)
[366.458245] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.610s)
[367.668308] [070/131] (652s left) gem_exec_schedule (submit-early-slice)
[367.742869] Starting subtest: submit-early-slice
[367.745172] Starting dynamic subtest: rcs0
[367.777291] Dynamic subtest rcs0: SUCCESS (0.042s)
[367.790362] Starting dynamic subtest: bcs0
[367.817486] Dynamic subtest bcs0: SUCCESS (0.040s)
[367.827952] Starting dynamic subtest: vcs0
[367.879391] Dynamic subtest vcs0: SUCCESS (0.061s)
[367.891336] Starting dynamic subtest: vcs1
[367.916455] Dynamic subtest vcs1: SUCCESS (0.037s)
[367.926193] Starting dynamic subtest: vecs0
[367.957170] Dynamic subtest vecs0: SUCCESS (0.040s)
[367.967544] Starting dynamic subtest: ccs0
[367.997794] Dynamic subtest ccs0: SUCCESS (0.040s)
[368.000124] Subtest submit-early-slice: SUCCESS (0.264s)
[369.693936] [071/131] (650s left) kms_psr (pr-dpms)
[369.791661] Starting subtest: pr-dpms
[369.795552] Subtest pr-dpms: SKIP (0.000s)
[369.886915] [072/131] (650s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[369.984882] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[374.401590] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.421s)
[375.562257] [073/131] (644s left) syncobj_timeline (multi-wait-signaled)
[375.621525] Starting subtest: multi-wait-signaled
[375.623434] Subtest multi-wait-signaled: SUCCESS (0.000s)
[375.768166] [074/131] (644s left) gem_softpin (safe-alignment)
[375.824320] Starting subtest: safe-alignment
[375.844318] Subtest safe-alignment: SUCCESS (0.020s)
[377.615446] [075/131] (642s left) kms_setmode (basic-clone-single-crtc)
[377.668313] Starting subtest: basic-clone-single-crtc
[377.674814] Subtest basic-clone-single-crtc: SKIP (0.000s)
[377.785313] [076/131] (642s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[377.873106] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[377.875376] Starting dynamic subtest: pipe-A-default-mode
[378.161015] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[378.165565] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.286s)
[378.981352] [077/131] (641s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[379.078816] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[379.081050] Starting dynamic subtest: pipe-A-default-mode
[379.379630] Dynamic subtest pipe-A-default-mode: SKIP (0.300s)
[379.383901] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.302s)
[380.213429] [078/131] (640s left) kms_psr (psr-sprite-plane-move)
[380.311078] Starting subtest: psr-sprite-plane-move
[380.313372] Starting dynamic subtest: eDP-1
[382.039404] Dynamic subtest eDP-1: SUCCESS (1.727s)
[382.041676] Subtest psr-sprite-plane-move: SUCCESS (1.728s)
[382.884638] [079/131] (637s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[382.987590] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[386.978877] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (3.993s)
[388.202186] [080/131] (632s left) perf_pmu (frequency)
[388.241108] Starting subtest: frequency
[388.246483] Starting dynamic subtest: gt0
[390.420702] Dynamic subtest gt0: SUCCESS (2.171s)
[390.433194] Starting dynamic subtest: idle-gt0
[390.926843] Dynamic subtest idle-gt0: SUCCESS (0.504s)
[390.937597] Starting dynamic subtest: gt1
[395.562598] Dynamic subtest gt1: SUCCESS (4.629s)
[395.572542] Starting dynamic subtest: idle-gt1
[396.067805] Dynamic subtest idle-gt1: SUCCESS (0.504s)
[396.070298] Subtest frequency: SUCCESS (7.828s)
[396.218583] [081/131] (624s left) gem_exec_params (rel-constants-invalid-ring)
[396.288482] Starting subtest: rel-constants-invalid-ring
[396.290704] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[396.428729] [082/131] (624s left) kms_cursor_edge_walk (64x64-left-edge)
[396.522607] Starting subtest: 64x64-left-edge
[396.524903] Starting dynamic subtest: pipe-A-eDP-1
[399.937698] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.414s)
[399.950718] Starting dynamic subtest: pipe-D-eDP-1
[403.050188] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.106s)
[403.052040] Subtest 64x64-left-edge: SUCCESS (6.526s)
[403.888783] [083/131] (616s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[403.950224] Starting subtest: map-fixed-invalidate-overlap
[403.954581] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[404.114159] [084/131] (616s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[404.214185] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[404.216420] Starting dynamic subtest: A-eDP1
[407.798462] Dynamic subtest A-eDP1: SUCCESS (3.581s)
[407.813515] Starting dynamic subtest: B-eDP1
[410.998378] Dynamic subtest B-eDP1: SUCCESS (3.202s)
[411.014410] Starting dynamic subtest: C-eDP1
[414.114165] Dynamic subtest C-eDP1: SUCCESS (3.111s)
[414.126048] Starting dynamic subtest: D-eDP1
[417.247530] Dynamic subtest D-eDP1: SUCCESS (3.134s)
[417.249940] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.035s)
[418.072793] [085/131] (602s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[418.182469] Starting subtest: fbcpsr-rgb101010-draw-render
[424.916086] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.735s)
[425.076559] [086/131] (595s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[425.192838] Starting subtest: addfb25-yf-tiled-legacy
[425.195061] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[425.309680] [087/131] (595s left) dumb_buffer (create-valid-dumb)
[425.364313] Starting subtest: create-valid-dumb
[425.366274] Subtest create-valid-dumb: SUCCESS (0.000s)
[425.484467] [088/131] (595s left) kms_rotation_crc (exhaust-fences)
[425.582392] Starting subtest: exhaust-fences
[425.586812] Subtest exhaust-fences: SKIP (0.000s)
[425.676744] [089/131] (595s left) kms_plane_lowres (tiling-x)
[425.777022] Starting subtest: tiling-x
[425.779684] Starting dynamic subtest: pipe-A-eDP-1
[425.784744] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[426.070055] Starting dynamic subtest: pipe-B-eDP-1
[426.074544] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[426.086126] Starting dynamic subtest: pipe-C-eDP-1
[426.090808] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[426.102819] Starting dynamic subtest: pipe-D-eDP-1
[426.106935] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[426.110884] Subtest tiling-x: SKIP (0.292s)
[426.925769] [090/131] (593s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[431.973330] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[431.975478] Starting dynamic subtest: pipe-A-eDP-1
[443.999212] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.026s)
[444.010059] Starting dynamic subtest: pipe-B-eDP-1
[456.029032] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.025s)
[456.031212] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (24.055s)
[456.906919] [091/131] (563s left) gen7_exec_parse (basic-allowed)
[456.973490] Subtest basic-allowed: SKIP (0.000s)
[457.043200] [092/131] (563s left) kms_invalid_mode (int-max-clock)
[457.138922] Starting subtest: int-max-clock
[457.141128] Starting dynamic subtest: pipe-A-eDP-1
[457.424903] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[457.435839] Starting dynamic subtest: pipe-B-eDP-1
[457.437962] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[457.447732] Starting dynamic subtest: pipe-C-eDP-1
[457.450195] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[457.460254] Starting dynamic subtest: pipe-D-eDP-1
[457.462692] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[457.465094] Subtest int-max-clock: SUCCESS (0.293s)
[458.255062] [093/131] (562s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[458.349598] Starting subtest: y-tiled-32bpp-rotate-270
[458.353976] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[458.469052] [094/131] (562s left) kms_dsc (dsc-with-formats)
[458.570952] Starting subtest: dsc-with-formats
[458.608544] Subtest dsc-with-formats: SKIP (0.001s)
[458.663749] [095/131] (562s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[458.763002] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[458.766840] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[458.876498] [096/131] (562s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[458.965180] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[458.969156] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[459.079673] [097/131] (561s left) kms_frontbuffer_tracking (psr-2p-rte)
[459.163212] Starting subtest: psr-2p-rte
[459.166830] Subtest psr-2p-rte: SKIP (0.000s)
[459.291318] [098/131] (561s left) syncobj_wait (single-wait-all-for-submit-submitted)
[459.344646] Starting subtest: single-wait-all-for-submit-submitted
[459.453302] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.107s)
[459.553049] [099/131] (561s left) kms_prop_blob (invalid-get-prop-any)
[459.615899] Starting subtest: invalid-get-prop-any
[459.618235] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[459.756264] [100/131] (561s left) gem_exec_fence (syncobj-timeline-signal)
[460.310167] Starting subtest: syncobj-timeline-signal
[460.316873] Subtest syncobj-timeline-signal: SUCCESS (0.008s)
[461.639037] [101/131] (559s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[461.708216] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[461.812575] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[461.919166] [102/131] (559s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[462.022585] Starting subtest: fbc-2p-pri-indfb-multidraw
[462.026634] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[462.159593] [103/131] (559s left) kms_vblank (wait-idle-hang)
[462.255157] Starting subtest: wait-idle-hang
[462.257375] Starting dynamic subtest: pipe-A-eDP-1
[488.340725] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.083s)
[488.357155] Starting dynamic subtest: pipe-D-eDP-1
[503.315525] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.976s)
[503.317858] Subtest wait-idle-hang: SUCCESS (41.064s)
[504.190765] [104/131] (517s left) kms_pm_dc (dc5-dpms-negative)
[505.295116] Starting subtest: dc5-dpms-negative
[505.299531] Subtest dc5-dpms-negative: SKIP (0.000s)
[505.395008] [105/131] (515s left) perf (global-sseu-config)
[505.551448] Starting subtest: global-sseu-config
[505.555990] Subtest global-sseu-config: SKIP (0.000s)
[505.598974] [106/131] (515s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[505.651748] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[505.656157] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[505.874712] [107/131] (515s left) gem_exec_params (cliprects_ptr-dirt)
[505.923657] Starting subtest: cliprects_ptr-dirt
[505.925869] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[506.069098] [108/131] (515s left) gem_mmap_gtt (basic-write-read)
[506.120428] Subtest basic-write-read: SKIP (0.000s)
[506.193225] [109/131] (515s left) i915_pm_rpm (gem-evict-pwrite)
[507.721002] Starting subtest: gem-evict-pwrite
[507.726098] Subtest gem-evict-pwrite: SKIP (0.000s)
[508.532127] [110/131] (513s left) gem_eio (wait-wedge-immediate)
[508.720673] Starting subtest: wait-wedge-immediate
[510.545107] Subtest wait-wedge-immediate: SUCCESS (1.825s)
[510.720304] [111/131] (510s left) gem_exec_schedule (preempt-queue-chain)
[510.798107] Subtest preempt-queue-chain: SKIP (0.000s)
[511.112926] [112/131] (510s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[511.225019] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[511.233818] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[511.380035] [113/131] (510s left) kms_psr2_su (page_flip-p010)
[511.440207] Subtest page_flip-P010: SKIP (0.000s)
[511.508431] [114/131] (510s left) gem_ctx_persistence (engines-queued)
[511.555261] Starting subtest: engines-queued
[511.557487] Starting dynamic subtest: rcs0
[511.665663] Dynamic subtest rcs0: SUCCESS (0.110s)
[511.679490] Starting dynamic subtest: bcs0
[511.692280] Dynamic subtest bcs0: SUCCESS (0.025s)
[511.702462] Starting dynamic subtest: vcs0
[513.519971] Dynamic subtest vcs0: SUCCESS (1.825s)
[513.533541] Starting dynamic subtest: vcs1
[515.503068] Dynamic subtest vcs1: SUCCESS (1.980s)
[515.514807] Starting dynamic subtest: vecs0
[517.486247] Dynamic subtest vecs0: SUCCESS (1.981s)
[517.496956] Starting dynamic subtest: ccs0
[517.645256] Dynamic subtest ccs0: SUCCESS (0.158s)
[517.647666] Subtest engines-queued: SUCCESS (6.091s)
[517.808745] [115/131] (504s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[517.929555] Starting subtest: flip-vs-cursor-busy-crc-legacy
[518.751807] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.821s)
[519.642948] [116/131] (502s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[519.747079] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[527.215966] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.471s)
[527.356848] [117/131] (494s left) gem_exec_whisper (basic-fds-all)
[527.429420] Starting subtest: basic-fds-all
[539.504828] Subtest basic-fds-all: SUCCESS (12.072s)
[539.711304] [118/131] (482s left) gem_cs_tlb (engines)
[539.784917] Starting subtest: engines
[539.787174] Starting dynamic subtest: rcs0
[541.996638] Dynamic subtest rcs0: SUCCESS (2.155s)
[542.013527] Starting dynamic subtest: bcs0
[544.149218] Dynamic subtest bcs0: SUCCESS (2.154s)
[544.161918] Starting dynamic subtest: vcs0
[546.302979] Dynamic subtest vcs0: SUCCESS (2.152s)
[546.315624] Starting dynamic subtest: vcs1
[548.457068] Dynamic subtest vcs1: SUCCESS (2.153s)
[548.470286] Starting dynamic subtest: vecs0
[550.608477] Dynamic subtest vecs0: SUCCESS (2.152s)
[550.618908] Starting dynamic subtest: ccs0
[552.713289] Dynamic subtest ccs0: SUCCESS (2.155s)
[552.715261] Subtest engines: SUCCESS (12.927s)
[552.878810] [119/131] (469s left) gem_exec_nop (basic-sequential)
[552.960357] Starting subtest: basic-sequential
[568.066305] Subtest basic-sequential: SUCCESS (15.090s)
[568.307585] [120/131] (453s left) gem_ctx_bad_destroy (invalid-ctx)
[568.369861] Starting subtest: invalid-ctx
[568.372196] Subtest invalid-ctx: SUCCESS (0.000s)
[568.473685] [121/131] (453s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[568.579918] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[569.592306] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.012s)
[569.746558] [122/131] (452s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[569.856147] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[576.732730] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.878s)
[576.929230] [123/131] (445s left) kms_addfb_basic (bad-pitch-128)
[576.990723] Starting subtest: bad-pitch-128
[576.992589] Subtest bad-pitch-128: SUCCESS (0.000s)
[577.156495] [124/131] (445s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[577.281351] Starting subtest: cursorA-vs-flipA-atomic-transitions
[588.442371] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.163s)
[589.265711] [125/131] (432s left) gem_caching (writes)
[589.327989] Subtest writes: SKIP (0.000s)
[589.405378] [126/131] (432s left) gem_mmap_offset (mmap-unmap)
[589.458360] Starting subtest: mmap-unmap
[589.460345] Starting dynamic subtest: smem0
[611.592711] Dynamic subtest smem0: SUCCESS (22.087s)
[611.595615] Subtest mmap-unmap: SUCCESS (22.088s)
[611.703447] [127/131] (410s left) i915_hangman (hangcheck-unterminated)
[611.777894] Starting subtest: hangcheck-unterminated
[623.471111] Subtest hangcheck-unterminated: SUCCESS (11.694s)
[623.637202] [128/131] (398s left) gen3_mixed_blits
[623.774398] [129/131] (398s left) syncobj_wait (reset-during-wait-for-submit)
[623.840400] Starting subtest: reset-during-wait-for-submit
[623.941843] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[624.038089] [130/131] (398s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[624.140515] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[624.932330] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.792s)
[625.106694] [131/131] (397s left) kms_psr (pr-basic)
[625.211008] Starting subtest: pr-basic
[625.215326] Subtest pr-basic: SKIP (0.000s)
[625.306950] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: kms_rotation_crc
results: parsing output: 2/ for test: kms_busy
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: api_intel_allocator
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: gem_lmem_swapping
results: parsing output: 7/ for test: prime_busy
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_ccs
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_chamelium_hpd
results: parsing output: 12/ for test: gem_exec_fence
results: parsing output: 13/ for test: gen9_exec_parse
results: parsing output: 14/ for test: api_intel_bb
results: parsing output: 15/ for test: kms_lease
results: parsing output: 16/ for test: kms_fbcon_fbt
results: parsing output: 17/ for test: kms_cursor_legacy
results: parsing output: 18/ for test: gem_exec_fence
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_cursor_crc
results: parsing output: 23/ for test: gem_ccs
results: parsing output: 24/ for test: gem_exec_alignment
results: parsing output: 25/ for test: kms_flip
results: parsing output: 26/ for test: gem_partial_pwrite_pread
results: parsing output: 27/ for test: gem_exec_reloc
results: parsing output: 28/ for test: i915_selftest
results: parsing output: 29/ for test: i915_drm_fdinfo
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_ccs
results: parsing output: 32/ for test: kms_psr
results: parsing output: 33/ for test: kms_flip
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_tiled_display
results: parsing output: 36/ for test: gem_exec_flush
results: parsing output: 37/ for test: kms_atomic
results: parsing output: 38/ for test: kms_cursor_legacy
results: parsing output: 39/ for test: kms_addfb_basic
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: kms_flip_scaled_crc
results: parsing output: 42/ for test: gem_pwrite
results: parsing output: 43/ for test: kms_ccs
results: parsing output: 44/ for test: kms_color
results: parsing output: 45/ for test: kms_cursor_crc
results: parsing output: 46/ for test: gem_exec_balancer
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_softpin
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: kms_plane_scaling
results: parsing output: 51/ for test: gem_render_copy
results: parsing output: 52/ for test: kms_pipe_stress
results: parsing output: 53/ for test: perf_pmu
results: parsing output: 54/ for test: kms_prop_blob
results: parsing output: 55/ for test: gem_render_copy
results: parsing output: 56/ for test: kms_cursor_edge_walk
results: parsing output: 57/ for test: kms_atomic_transition
results: parsing output: 58/ for test: kms_chamelium_hpd
results: parsing output: 59/ for test: syncobj_timeline
results: parsing output: 60/ for test: gem_eio
results: parsing output: 61/ for test: gem_lmem_swapping
results: parsing output: 62/ for test: gem_ctx_param
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: gem_ctx_param
results: parsing output: 65/ for test: vgem_basic
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: gem_pwrite_snooped
results: parsing output: 68/ for test: kms_plane_scaling
results: parsing output: 69/ for test: gem_exec_schedule
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: gem_softpin
results: parsing output: 74/ for test: kms_setmode
results: parsing output: 75/ for test: kms_flip_scaled_crc
results: parsing output: 76/ for test: kms_flip_scaled_crc
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: perf_pmu
results: parsing output: 80/ for test: gem_exec_params
results: parsing output: 81/ for test: kms_cursor_edge_walk
results: parsing output: 82/ for test: gem_userptr_blits
results: parsing output: 83/ for test: kms_flip
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_addfb_basic
results: parsing output: 86/ for test: dumb_buffer
results: parsing output: 87/ for test: kms_rotation_crc
results: parsing output: 88/ for test: kms_plane_lowres
results: parsing output: 89/ for test: kms_psr2_sf
results: parsing output: 90/ for test: gen7_exec_parse
results: parsing output: 91/ for test: kms_invalid_mode
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: kms_dsc
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: syncobj_wait
results: parsing output: 98/ for test: kms_prop_blob
results: parsing output: 99/ for test: gem_exec_fence
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_vblank
results: parsing output: 103/ for test: kms_pm_dc
results: parsing output: 104/ for test: perf
results: parsing output: 105/ for test: gem_render_copy
results: parsing output: 106/ for test: gem_exec_params
results: parsing output: 107/ for test: gem_mmap_gtt
results: parsing output: 108/ for test: i915_pm_rpm
results: parsing output: 109/ for test: gem_eio
results: parsing output: 110/ for test: gem_exec_schedule
results: parsing output: 111/ for test: kms_flip
results: parsing output: 112/ for test: kms_psr2_su
results: parsing output: 113/ for test: gem_ctx_persistence
results: parsing output: 114/ for test: kms_cursor_legacy
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: gem_exec_whisper
results: parsing output: 117/ for test: gem_cs_tlb
results: parsing output: 118/ for test: gem_exec_nop
results: parsing output: 119/ for test: gem_ctx_bad_destroy
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_addfb_basic
results: parsing output: 123/ for test: kms_cursor_legacy
results: parsing output: 124/ for test: gem_caching
results: parsing output: 125/ for test: gem_mmap_offset
results: parsing output: 126/ for test: i915_hangman
results: parsing output: 127/ for test: gen3_mixed_blits
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: kms_psr
Done.