[63.396385] Initializing watchdogs
[63.396430]   /dev/watchdog0
[63.409653] [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]
[63.414516] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[63.417059] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.420733] [001/131] (960s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[63.551791] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[63.556437] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[64.703035] [002/131] (959s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[64.797370] Starting subtest: primary-y-tiled-reflect-x-180
[64.859305] Subtest primary-y-tiled-reflect-x-180: SKIP (0.060s)
[64.980378] [003/131] (959s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[65.097737] Starting subtest: extended-modeset-hang-oldfb-with-reset
[65.099735] Starting dynamic subtest: pipe-A
[76.781922] Dynamic subtest pipe-A: SUCCESS (11.666s)
[76.792432] Starting dynamic subtest: pipe-D
[89.066276] Dynamic subtest pipe-D: SUCCESS (12.273s)
[89.068579] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.943s)
[89.877761] [004/131] (934s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[89.948292] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[90.051394] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.101s)
[90.142864] [005/131] (933s left) api_intel_allocator (reopen)
[90.201053] Starting subtest: reopen
[90.205655] Subtest reopen: SUCCESS (0.005s)
[90.377996] [006/131] (933s left) syncobj_timeline (invalid-query-one-illegal-handle)
[90.432269] Starting subtest: invalid-query-one-illegal-handle
[90.434651] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[90.577153] [007/131] (933s left) gem_lmem_swapping (verify-random-ccs)
[90.614761] Subtest verify-random-ccs: SKIP (0.000s)
[90.658188] [008/131] (933s left) prime_busy (before-wait)
[90.722060] Starting subtest: before-wait
[90.724468] Starting dynamic subtest: rcs0
[90.769699] Dynamic subtest rcs0: SUCCESS (0.046s)
[90.779267] Starting dynamic subtest: bcs0
[90.831959] Dynamic subtest bcs0: SUCCESS (0.062s)
[90.839552] Starting dynamic subtest: vcs0
[90.871164] Dynamic subtest vcs0: SUCCESS (0.039s)
[90.878296] Starting dynamic subtest: vcs1
[90.911063] Dynamic subtest vcs1: SUCCESS (0.039s)
[90.918317] Starting dynamic subtest: vecs0
[90.950193] Dynamic subtest vecs0: SUCCESS (0.039s)
[90.957312] Starting dynamic subtest: ccs0
[90.988367] Dynamic subtest ccs0: SUCCESS (0.038s)
[91.097432] Subtest before-wait: SUCCESS (0.374s)
[91.188835] [009/131] (933s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[91.298508] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[91.302832] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[91.434176] [010/131] (932s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[91.533760] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[91.536100] Starting dynamic subtest: pipe-A-eDP-1
[91.556782] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[91.568325] Starting dynamic subtest: pipe-B-eDP-1
[91.589294] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[91.596567] Starting dynamic subtest: pipe-C-eDP-1
[91.616577] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[91.624031] Starting dynamic subtest: pipe-D-eDP-1
[91.643630] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[91.645841] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.004s)
[93.763117] [011/131] (930s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[93.874181] Starting subtest: psr-rgb565-draw-blt
[100.872152] Subtest psr-rgb565-draw-blt: SUCCESS (6.998s)
[101.048050] [012/131] (923s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[101.457388] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[102.263068] [013/131] (922s left) gem_exec_fence (basic-wait)
[102.459181] Starting subtest: basic-wait
[102.461413] Starting dynamic subtest: rcs0
[102.533521] Dynamic subtest rcs0: SUCCESS (0.074s)
[102.543589] Starting dynamic subtest: bcs0
[102.596379] Dynamic subtest bcs0: SUCCESS (0.062s)
[102.606360] Starting dynamic subtest: vcs0
[102.657063] Dynamic subtest vcs0: SUCCESS (0.059s)
[102.666793] Starting dynamic subtest: vcs1
[102.719080] Dynamic subtest vcs1: SUCCESS (0.061s)
[102.728188] Starting dynamic subtest: vecs0
[102.775840] Dynamic subtest vecs0: SUCCESS (0.056s)
[102.784263] Starting dynamic subtest: ccs0
[102.841120] Dynamic subtest ccs0: SUCCESS (0.065s)
[102.843477] Subtest basic-wait: SUCCESS (0.383s)
[105.047042] [FACT gem_exec_fence (basic-wait)] new: kernel.kmod_is_loaded.vgem: true
[105.050119] [014/131] (919s left) gen9_exec_parse (bb-start-param)
[105.119531] Subtest bb-start-param: SKIP (0.000s)
[105.198070] [015/131] (919s left) api_intel_bb (render)
[105.253832] Starting subtest: render
[105.255694] Starting dynamic subtest: render-none-512
[105.356721] Dynamic subtest render-none-512: SUCCESS (0.103s)
[105.365519] Starting dynamic subtest: render-none-1024
[105.985034] Dynamic subtest render-none-1024: SUCCESS (0.627s)
[105.995869] Starting dynamic subtest: render-x-512
[106.068189] Dynamic subtest render-x-512: SUCCESS (0.084s)
[106.079018] Starting dynamic subtest: render-x-1024
[106.670474] Dynamic subtest render-x-1024: SUCCESS (0.600s)
[106.681527] Starting dynamic subtest: render-y-512
[106.755987] Dynamic subtest render-y-512: SUCCESS (0.087s)
[106.766068] Starting dynamic subtest: render-y-1024
[107.355044] Dynamic subtest render-y-1024: SUCCESS (0.597s)
[107.357643] Subtest render: SUCCESS (2.101s)
[107.510274] [016/131] (916s left) kms_lease (lease-invalid-connector)
[107.612780] Starting subtest: lease-invalid-connector
[107.615119] Starting dynamic subtest: pipe-A-eDP-1
[107.617411] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[107.624649] Starting dynamic subtest: pipe-B-eDP-1
[107.626629] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[107.634226] Starting dynamic subtest: pipe-C-eDP-1
[107.636438] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[107.644131] Starting dynamic subtest: pipe-D-eDP-1
[107.646090] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[107.648064] Subtest lease-invalid-connector: SUCCESS (0.002s)
[107.708721] [017/131] (916s left) kms_fbcon_fbt (psr-suspend)
[107.780175] Starting subtest: psr-suspend
[157.050653] Subtest psr-suspend: SUCCESS (23.229s)
[157.141918] [018/131] (867s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[157.270068] Starting subtest: basic-flip-after-cursor-legacy
[158.211962] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.924s)
[159.104458] [019/131] (865s left) gem_exec_fence (keep-in-fence)
[159.293942] Starting subtest: keep-in-fence
[159.297125] Starting dynamic subtest: rcs0
[159.367399] Dynamic subtest rcs0: SUCCESS (0.072s)
[159.379356] Starting dynamic subtest: bcs0
[159.420409] Dynamic subtest bcs0: SUCCESS (0.051s)
[159.432250] Starting dynamic subtest: vcs0
[160.598077] Dynamic subtest vcs0: SUCCESS (1.158s)
[160.610104] Starting dynamic subtest: vcs1
[162.581291] Dynamic subtest vcs1: SUCCESS (1.958s)
[162.593965] Starting dynamic subtest: vecs0
[164.565927] Dynamic subtest vecs0: SUCCESS (1.964s)
[164.575909] Starting dynamic subtest: ccs0
[164.812096] Dynamic subtest ccs0: SUCCESS (0.244s)
[164.815125] Subtest keep-in-fence: SUCCESS (5.454s)
[166.649913] [020/131] (858s left) kms_flip (2x-plain-flip)
[166.764011] Starting subtest: 2x-plain-flip
[166.774945] Subtest 2x-plain-flip: SKIP (0.010s)
[166.879134] [021/131] (857s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[166.984346] Starting subtest: yf-tiled-8bpp-rotate-0
[166.989199] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[167.134132] [022/131] (857s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[167.233943] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[167.239502] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[167.369282] [023/131] (857s left) kms_cursor_crc (cursor-onscreen-256x85)
[167.632069] Starting subtest: cursor-onscreen-256x85
[167.675895] Subtest cursor-onscreen-256x85: SKIP (0.040s)
[167.889015] [024/131] (856s left) gem_ccs (ctrl-surf-copy)
[167.958483] Starting subtest: ctrl-surf-copy
[167.962820] Subtest ctrl-surf-copy: SKIP (0.000s)
[168.097277] [025/131] (856s left) gem_exec_alignment (many)
[168.157543] Starting subtest: many
[189.988864] Subtest many: SUCCESS (21.787s)
[192.480253] [026/131] (832s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[192.636266] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[192.644629] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.010s)
[192.787592] [027/131] (832s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[192.863616] Subtest writes-after-reads-snoop: SKIP (0.000s)
[192.948965] [028/131] (832s left) gem_exec_reloc (basic-gtt-read-noreloc)
[193.022851] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[193.090426] [029/131] (831s left) i915_selftest (mock)
[195.158298] Starting subtest: mock
[195.163075] Starting dynamic subtest: sanitycheck
[197.234846] Dynamic subtest sanitycheck: SUCCESS (2.075s)
[197.244914] Starting dynamic subtest: shmem
[199.203294] Dynamic subtest shmem: SUCCESS (1.967s)
[199.217967] Starting dynamic subtest: fence
[208.761828] Dynamic subtest fence: SUCCESS (9.554s)
[208.770075] Starting dynamic subtest: scatterlist
[211.791107] Dynamic subtest scatterlist: SUCCESS (3.027s)
[211.800654] Starting dynamic subtest: syncmap
[216.397758] Dynamic subtest syncmap: SUCCESS (4.603s)
[216.407725] Starting dynamic subtest: uncore
[218.395335] Dynamic subtest uncore: SUCCESS (1.996s)
[218.405212] Starting dynamic subtest: ring
[220.408415] Dynamic subtest ring: SUCCESS (2.011s)
[220.417727] Starting dynamic subtest: engine
[222.393221] Dynamic subtest engine: SUCCESS (1.983s)
[222.403261] Starting dynamic subtest: timelines
[227.751721] Dynamic subtest timelines: SUCCESS (5.355s)
[227.761597] Starting dynamic subtest: requests
[232.679907] Dynamic subtest requests: SUCCESS (4.925s)
[232.689653] Starting dynamic subtest: objects
[234.822875] Dynamic subtest objects: SUCCESS (2.141s)
[234.832371] Starting dynamic subtest: phys
[237.059484] Dynamic subtest phys: SUCCESS (2.234s)
[237.069333] Starting dynamic subtest: dmabuf
[239.156045] Dynamic subtest dmabuf: SUCCESS (2.094s)
[239.165962] Starting dynamic subtest: vma
[245.965726] Dynamic subtest vma: SUCCESS (6.805s)
[245.975877] Starting dynamic subtest: evict
[248.688463] Dynamic subtest evict: SUCCESS (2.720s)
[248.698487] Starting dynamic subtest: gtt
[253.233404] Dynamic subtest gtt: SUCCESS (4.546s)
[253.242113] Starting dynamic subtest: hugepages
[255.558886] Dynamic subtest hugepages: SUCCESS (2.325s)
[255.567969] Starting dynamic subtest: memory_region
[259.575683] Dynamic subtest memory_region: SUCCESS (4.016s)
[259.578739] Subtest mock: SUCCESS (64.401s)
[259.608543] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[259.609254] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[259.612625] [030/131] (765s left) i915_drm_fdinfo (isolation)
[262.504682] Starting subtest: isolation
[262.507421] Starting dynamic subtest: rcs0
[262.542303] Dynamic subtest rcs0: SKIP (0.036s)
[262.551900] Starting dynamic subtest: bcs0
[262.556964] Dynamic subtest bcs0: SKIP (0.005s)
[262.565971] Starting dynamic subtest: vcs0
[262.571072] Dynamic subtest vcs0: SKIP (0.000s)
[262.579211] Starting dynamic subtest: vcs1
[262.584634] Dynamic subtest vcs1: SKIP (0.000s)
[262.592881] Starting dynamic subtest: vecs0
[262.597538] Dynamic subtest vecs0: SKIP (0.000s)
[262.605510] Starting dynamic subtest: ccs0
[262.610107] Dynamic subtest ccs0: SKIP (0.000s)
[262.614861] Subtest isolation: SKIP (0.044s)
[262.646001] [FACT i915_drm_fdinfo (isolation)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[262.647188] [FACT i915_drm_fdinfo (isolation)] new: kernel.kmod_is_loaded.i915: true
[262.650891] [031/131] (762s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[262.768896] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[262.774479] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[262.907850] [032/131] (762s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[263.000508] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[263.003104] Starting dynamic subtest: pipe-A-eDP-1
[263.032854] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[263.045729] Starting dynamic subtest: pipe-B-eDP-1
[263.070993] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[263.080049] Starting dynamic subtest: pipe-C-eDP-1
[263.109750] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[263.119096] Starting dynamic subtest: pipe-D-eDP-1
[263.147863] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[263.152890] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[265.454578] [033/131] (759s left) kms_psr (psr-cursor-blt)
[265.551012] Starting subtest: psr-cursor-blt
[265.553859] Starting dynamic subtest: eDP-1
[267.235512] Dynamic subtest eDP-1: SUCCESS (1.687s)
[267.237968] Subtest psr-cursor-blt: SUCCESS (1.688s)
[268.123257] [034/131] (757s left) kms_flip (blocking-absolute-wf_vblank)
[268.223382] Starting subtest: blocking-absolute-wf_vblank
[268.225906] Starting dynamic subtest: A-eDP1
[276.952319] Dynamic subtest A-eDP1: SUCCESS (8.730s)
[276.961111] Starting dynamic subtest: B-eDP1
[285.676664] Dynamic subtest B-eDP1: SUCCESS (8.723s)
[285.687384] Starting dynamic subtest: C-eDP1
[294.401919] Dynamic subtest C-eDP1: SUCCESS (8.722s)
[294.412075] Starting dynamic subtest: D-eDP1
[303.136514] Dynamic subtest D-eDP1: SUCCESS (8.731s)
[303.143348] Subtest blocking-absolute-wf_vblank: SUCCESS (34.918s)
[304.367584] [035/131] (720s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[304.471069] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[311.003883] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.535s)
[311.159625] [036/131] (714s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[311.282721] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[311.326100] [037/131] (714s left) gem_exec_flush (basic-uc-prw-default)
[311.391849] Starting subtest: basic-uc-prw-default
[316.866396] Subtest basic-uc-prw-default: SUCCESS (5.475s)
[317.073815] [038/131] (708s left) kms_atomic (test-only)
[317.169893] Starting subtest: test-only
[317.222762] Starting dynamic subtest: pipe-A-eDP-1
[319.786318] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.563s)
[319.788716] Subtest test-only: SUCCESS (2.616s)
[320.669084] [039/131] (704s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[320.791275] Starting subtest: cursor-vs-flip-atomic
[350.080086] Subtest cursor-vs-flip-atomic: SUCCESS (29.280s)
[350.914901] [040/131] (674s left) kms_addfb_basic (invalid-get-prop)
[350.981663] Starting subtest: invalid-get-prop
[350.984329] Subtest invalid-get-prop: SUCCESS (0.000s)
[351.141723] [041/131] (674s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[351.245548] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[351.247979] Starting dynamic subtest: pipe-A-eDP-1
[351.317055] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[351.326707] Starting dynamic subtest: pipe-B-eDP-1
[351.395041] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[351.405512] Starting dynamic subtest: pipe-C-eDP-1
[351.472683] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[351.482071] Starting dynamic subtest: pipe-D-eDP-1
[351.549534] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[351.555083] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.008s)
[353.491912] [042/131] (672s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[353.594089] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[353.596480] Starting dynamic subtest: pipe-A-default-mode
[353.886070] Dynamic subtest pipe-A-default-mode: SKIP (0.287s)
[353.891755] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.288s)
[354.724379] [043/131] (670s left) gem_pwrite (basic-exhaustion)
[354.792003] Subtest basic-exhaustion: SKIP (0.000s)
[354.855291] [044/131] (670s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[354.953621] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[354.955961] Starting dynamic subtest: pipe-A-eDP-1
[354.984760] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[354.999522] Starting dynamic subtest: pipe-B-eDP-1
[355.027775] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[355.036760] Starting dynamic subtest: pipe-C-eDP-1
[355.065914] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[355.074257] Starting dynamic subtest: pipe-D-eDP-1
[355.099546] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[355.104011] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[357.179457] [045/131] (668s left) kms_color (ctm-green-to-red)
[357.285060] Starting subtest: ctm-green-to-red
[357.287313] Starting dynamic subtest: pipe-A-eDP-1
[357.969048] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.684s)
[357.980862] Starting dynamic subtest: pipe-B-eDP-1
[359.310859] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.342s)
[359.321047] Starting dynamic subtest: pipe-C-eDP-1
[360.587993] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.276s)
[360.597094] Starting dynamic subtest: pipe-D-eDP-1
[361.912990] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.324s)
[361.915971] Subtest ctm-green-to-red: SUCCESS (4.628s)
[362.790321] [046/131] (662s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[363.012941] Starting subtest: cursor-rapid-movement-128x42
[363.062712] Subtest cursor-rapid-movement-128x42: SKIP (0.042s)
[363.325450] [047/131] (662s left) gem_exec_balancer (hog)
[363.391666] Starting subtest: hog
[363.396826] Subtest hog: SKIP (0.000s)
[363.712476] [048/131] (662s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[363.816873] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[370.663803] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.848s)
[370.837312] [049/131] (655s left) gem_softpin (evict-active-interruptible)
[370.886505] Starting subtest: evict-active-interruptible
[370.892506] Subtest evict-active-interruptible: SUCCESS (0.006s)
[371.055405] [050/131] (654s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[371.162880] Starting subtest: x-tiled-64bpp-rotate-0
[372.709923] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.545s)
[372.888442] [051/131] (653s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[372.984839] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[372.987061] Starting dynamic subtest: pipe-A
[373.004964] Dynamic subtest pipe-A: SKIP (0.017s)
[373.014552] Starting dynamic subtest: pipe-B
[373.037071] Dynamic subtest pipe-B: SKIP (0.030s)
[373.046164] Starting dynamic subtest: pipe-C
[373.066648] Dynamic subtest pipe-C: SKIP (0.030s)
[373.075294] Starting dynamic subtest: pipe-D
[373.096523] Dynamic subtest pipe-D: SKIP (0.030s)
[373.100041] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.109s)
[373.219207] [052/131] (652s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[373.270595] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[373.274865] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[373.482527] [053/131] (652s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[373.572745] Starting subtest: stress-xrgb8888-ytiled
[373.577928] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[373.654362] [054/131] (652s left) perf_pmu (faulting-read)
[373.698919] Starting subtest: faulting-read
[373.701878] Starting dynamic subtest: wb
[373.705064] Dynamic subtest wb: SUCCESS (0.001s)
[373.720050] Starting dynamic subtest: wc
[373.722855] Dynamic subtest wc: SUCCESS (0.000s)
[373.736996] Starting dynamic subtest: uc
[373.739914] Dynamic subtest uc: SUCCESS (0.000s)
[373.742852] Subtest faulting-read: SUCCESS (0.003s)
[373.832538] [055/131] (652s left) kms_prop_blob (blob-prop-core)
[373.897514] Starting subtest: blob-prop-core
[373.900046] Subtest blob-prop-core: SUCCESS (0.000s)
[374.021773] [056/131] (652s left) gem_render_copy (x-tiled)
[374.085658] Starting subtest: x-tiled
[374.088587] Starting dynamic subtest: smem
[374.125706] Dynamic subtest smem: SUCCESS (0.040s)
[374.128354] Subtest x-tiled: SUCCESS (0.041s)
[374.395419] [057/131] (651s left) kms_cursor_edge_walk (256x256-top-bottom)
[374.505575] Starting subtest: 256x256-top-bottom
[374.507969] Starting dynamic subtest: pipe-A-eDP-1
[377.949970] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.444s)
[377.964686] Starting dynamic subtest: pipe-D-eDP-1
[381.082893] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.132s)
[381.085832] Subtest 256x256-top-bottom: SUCCESS (6.579s)
[381.910288] [058/131] (644s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[382.018098] Starting subtest: plane-all-transition-nonblocking-fencing
[382.020746] Starting dynamic subtest: pipe-A-eDP-1
[384.511371] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[384.835285] Starting dynamic subtest: pipe-B-eDP-1
[388.036477] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.212s)
[388.335891] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.319s)
[389.177998] [059/131] (637s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[389.568387] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[390.358543] [060/131] (636s left) syncobj_timeline (wait-all-snapshot)
[390.418962] Starting subtest: wait-all-snapshot
[390.498817] Subtest wait-all-snapshot: SUCCESS (0.082s)
[390.598007] [061/131] (635s left) gem_eio (in-flight-internal-10ms)
[390.825049] Starting subtest: in-flight-internal-10ms
[392.667859] Subtest in-flight-internal-10ms: SUCCESS (1.842s)
[392.850722] [062/131] (633s left) gem_lmem_swapping (massive)
[392.905449] Subtest massive: SKIP (0.000s)
[392.955355] [063/131] (633s left) gem_ctx_param (invalid-param-get)
[393.026888] Starting subtest: invalid-param-get
[393.029875] Subtest invalid-param-get: SUCCESS (0.001s)
[393.169498] [064/131] (633s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[393.275875] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[393.943951] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.670s)
[394.155802] [065/131] (632s left) gem_ctx_param (invalid-get-engines)
[394.211875] Starting subtest: invalid-get-engines
[394.214838] Subtest invalid-get-engines: SUCCESS (0.001s)
[394.354709] [066/131] (632s left) vgem_basic (bad-fence)
[394.393905] Starting subtest: bad-fence
[394.396520] Subtest bad-fence: SUCCESS (0.000s)
[394.479195] [067/131] (632s left) kms_psr (fbc-psr2-sprite-render)
[394.592065] Starting subtest: fbc-psr2-sprite-render
[394.594737] Starting dynamic subtest: eDP-1
[394.599836] Dynamic subtest eDP-1: SKIP (0.000s)
[394.605901] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[394.691312] [068/131] (632s left) gem_pwrite_snooped
[394.842174] [069/131] (631s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[394.939620] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[394.941597] Starting dynamic subtest: pipe-A
[395.061798] Dynamic subtest pipe-A: SKIP (0.119s)
[395.071733] Starting dynamic subtest: pipe-B
[396.245130] Dynamic subtest pipe-B: SKIP (1.180s)
[396.255394] Starting dynamic subtest: pipe-C
[397.400950] Dynamic subtest pipe-C: SUCCESS (1.162s)
[397.412354] Starting dynamic subtest: pipe-D
[398.630501] Dynamic subtest pipe-D: SUCCESS (1.228s)
[398.633335] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.694s)
[399.854929] [070/131] (626s left) gem_exec_schedule (submit-early-slice)
[399.947884] Starting subtest: submit-early-slice
[399.950838] Starting dynamic subtest: rcs0
[399.986846] Dynamic subtest rcs0: SUCCESS (0.049s)
[400.004356] Starting dynamic subtest: bcs0
[400.038351] Dynamic subtest bcs0: SUCCESS (0.051s)
[400.049946] Starting dynamic subtest: vcs0
[400.087419] Dynamic subtest vcs0: SUCCESS (0.048s)
[400.100047] Starting dynamic subtest: vcs1
[400.128248] Dynamic subtest vcs1: SUCCESS (0.040s)
[400.139806] Starting dynamic subtest: vecs0
[400.163074] Dynamic subtest vecs0: SUCCESS (0.034s)
[400.172716] Starting dynamic subtest: ccs0
[400.205317] Dynamic subtest ccs0: SUCCESS (0.041s)
[400.207897] Subtest submit-early-slice: SUCCESS (0.269s)
[401.692449] [071/131] (625s left) kms_psr (pr-dpms)
[401.788863] Starting subtest: pr-dpms
[401.794141] Subtest pr-dpms: SKIP (0.000s)
[401.885099] [072/131] (625s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[401.989481] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[406.450049] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.466s)
[407.651482] [073/131] (619s left) syncobj_timeline (multi-wait-signaled)
[407.715335] Starting subtest: multi-wait-signaled
[407.717786] Subtest multi-wait-signaled: SUCCESS (0.000s)
[407.849074] [074/131] (619s left) gem_softpin (safe-alignment)
[407.916284] Starting subtest: safe-alignment
[407.939552] Subtest safe-alignment: SUCCESS (0.023s)
[409.620102] [075/131] (617s left) kms_setmode (basic-clone-single-crtc)
[409.682155] Starting subtest: basic-clone-single-crtc
[409.690376] Subtest basic-clone-single-crtc: SKIP (0.000s)
[409.798756] [076/131] (617s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[409.899270] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[409.901646] Starting dynamic subtest: pipe-A-default-mode
[410.195786] Dynamic subtest pipe-A-default-mode: SKIP (0.293s)
[410.200375] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.295s)
[411.064397] [077/131] (616s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[411.171586] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[411.174060] Starting dynamic subtest: pipe-A-default-mode
[411.475225] Dynamic subtest pipe-A-default-mode: SKIP (0.302s)
[411.480943] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.304s)
[412.297206] [078/131] (614s left) kms_psr (psr-sprite-plane-move)
[412.391977] Starting subtest: psr-sprite-plane-move
[412.394918] Starting dynamic subtest: eDP-1
[414.113423] Dynamic subtest eDP-1: SUCCESS (1.721s)
[414.115847] Subtest psr-sprite-plane-move: SUCCESS (1.723s)
[414.966615] [079/131] (612s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[415.059549] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[419.051458] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (3.998s)
[420.252421] [080/131] (606s left) perf_pmu (frequency)
[420.300056] Starting subtest: frequency
[420.302960] Starting dynamic subtest: gt0
[422.462054] Dynamic subtest gt0: SUCCESS (2.154s)
[422.478870] Starting dynamic subtest: idle-gt0
[423.005052] Dynamic subtest idle-gt0: SUCCESS (0.542s)
[423.018696] Starting dynamic subtest: gt1
[427.564868] Dynamic subtest gt1: SUCCESS (4.554s)
[427.577252] Starting dynamic subtest: idle-gt1
[428.068239] Dynamic subtest idle-gt1: SUCCESS (0.504s)
[428.070868] Subtest frequency: SUCCESS (7.772s)
[428.209227] [081/131] (599s left) gem_exec_params (rel-constants-invalid-ring)
[428.277701] Starting subtest: rel-constants-invalid-ring
[428.280444] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[428.420691] [082/131] (598s left) kms_cursor_edge_walk (64x64-left-edge)
[428.522780] Starting subtest: 64x64-left-edge
[428.525347] Starting dynamic subtest: pipe-A-eDP-1
[431.987740] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.464s)
[432.001297] Starting dynamic subtest: pipe-D-eDP-1
[435.087660] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.099s)
[435.090054] Subtest 64x64-left-edge: SUCCESS (6.566s)
[435.929077] [083/131] (591s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[436.000198] Starting subtest: map-fixed-invalidate-overlap
[436.005209] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[436.168375] [084/131] (591s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[436.266095] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[436.268727] Starting dynamic subtest: A-eDP1
[439.816400] Dynamic subtest A-eDP1: SUCCESS (3.552s)
[439.827865] Starting dynamic subtest: B-eDP1
[443.008880] Dynamic subtest B-eDP1: SUCCESS (3.190s)
[443.021448] Starting dynamic subtest: C-eDP1
[446.077384] Dynamic subtest C-eDP1: SUCCESS (3.067s)
[446.087855] Starting dynamic subtest: D-eDP1
[449.181840] Dynamic subtest D-eDP1: SUCCESS (3.101s)
[449.184515] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (12.918s)
[450.000097] [085/131] (577s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[450.112924] Starting subtest: fbcpsr-rgb101010-draw-render
[456.821915] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.711s)
[456.961528] [086/131] (570s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[457.063646] Starting subtest: addfb25-yf-tiled-legacy
[457.065924] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[457.206827] [087/131] (570s left) dumb_buffer (create-valid-dumb)
[457.271694] Starting subtest: create-valid-dumb
[457.274344] Subtest create-valid-dumb: SUCCESS (0.000s)
[457.408435] [088/131] (570s left) kms_rotation_crc (exhaust-fences)
[457.505816] Starting subtest: exhaust-fences
[457.510894] Subtest exhaust-fences: SKIP (0.000s)
[457.600652] [089/131] (570s left) kms_plane_lowres (tiling-x)
[457.700866] Starting subtest: tiling-x
[457.703477] Starting dynamic subtest: pipe-A-eDP-1
[457.708603] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[457.998689] Starting dynamic subtest: pipe-B-eDP-1
[458.004068] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[458.014459] Starting dynamic subtest: pipe-C-eDP-1
[458.019700] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[458.029976] Starting dynamic subtest: pipe-D-eDP-1
[458.035137] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[458.040362] Subtest tiling-x: SKIP (0.294s)
[458.843188] [090/131] (568s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[463.819050] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[463.821920] Starting dynamic subtest: pipe-A-eDP-1
[475.873534] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.052s)
[475.885153] Starting dynamic subtest: pipe-B-eDP-1
[487.910826] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.033s)
[487.913701] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (24.088s)
[488.760562] [091/131] (538s left) gen7_exec_parse (basic-allowed)
[488.827919] Subtest basic-allowed: SKIP (0.000s)
[488.915930] [092/131] (538s left) kms_invalid_mode (int-max-clock)
[489.021763] Starting subtest: int-max-clock
[489.024335] Starting dynamic subtest: pipe-A-eDP-1
[489.303188] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[489.314322] Starting dynamic subtest: pipe-B-eDP-1
[489.316898] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[489.326898] Starting dynamic subtest: pipe-C-eDP-1
[489.329655] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[489.339097] Starting dynamic subtest: pipe-D-eDP-1
[489.341735] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[489.344313] Subtest int-max-clock: SUCCESS (0.289s)
[490.191862] [093/131] (537s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[490.314080] Starting subtest: y-tiled-32bpp-rotate-270
[490.319088] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[490.452506] [094/131] (537s left) kms_dsc (dsc-with-formats)
[490.551906] Starting subtest: dsc-with-formats
[490.599585] Subtest dsc-with-formats: SKIP (0.001s)
[490.649940] [095/131] (537s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[490.748317] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[490.752707] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[490.886056] [096/131] (537s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[490.993830] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[490.998866] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[491.115228] [097/131] (536s left) kms_frontbuffer_tracking (psr-2p-rte)
[491.222261] Starting subtest: psr-2p-rte
[491.225742] Subtest psr-2p-rte: SKIP (0.000s)
[491.352268] [098/131] (536s left) syncobj_wait (single-wait-all-for-submit-submitted)
[491.409055] Starting subtest: single-wait-all-for-submit-submitted
[491.512833] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.102s)
[491.616003] [099/131] (536s left) kms_prop_blob (invalid-get-prop-any)
[491.677784] Starting subtest: invalid-get-prop-any
[491.680337] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[491.802690] [100/131] (536s left) gem_exec_fence (syncobj-timeline-signal)
[492.368690] Starting subtest: syncobj-timeline-signal
[492.378314] Subtest syncobj-timeline-signal: SUCCESS (0.010s)
[493.655892] [101/131] (534s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[493.711517] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[493.816068] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.106s)
[493.924320] [102/131] (534s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[494.034907] Starting subtest: fbc-2p-pri-indfb-multidraw
[494.040051] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[494.171510] [103/131] (534s left) kms_vblank (wait-idle-hang)
[494.288915] Starting subtest: wait-idle-hang
[494.291881] Starting dynamic subtest: pipe-A-eDP-1
[520.351071] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.054s)
[520.376698] Starting dynamic subtest: pipe-D-eDP-1
[535.333101] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.974s)
[535.335941] Subtest wait-idle-hang: SUCCESS (41.038s)
[536.161383] [104/131] (492s left) kms_pm_dc (dc5-dpms-negative)
[537.261007] Starting subtest: dc5-dpms-negative
[537.265809] Subtest dc5-dpms-negative: SKIP (0.000s)
[537.358447] [105/131] (490s left) perf (global-sseu-config)
[537.526499] Starting subtest: global-sseu-config
[537.531070] Subtest global-sseu-config: SKIP (0.000s)
[537.574975] [106/131] (490s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[537.641068] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[537.647080] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[537.851476] [107/131] (490s left) gem_exec_params (cliprects_ptr-dirt)
[537.920262] Starting subtest: cliprects_ptr-dirt
[537.922278] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[538.040629] [108/131] (490s left) gem_mmap_gtt (basic-write-read)
[538.101538] Subtest basic-write-read: SKIP (0.000s)
[538.179536] [109/131] (490s left) i915_pm_rpm (gem-evict-pwrite)
[539.812668] Starting subtest: gem-evict-pwrite
[539.817605] Subtest gem-evict-pwrite: SKIP (0.000s)
[540.490860] [110/131] (488s left) gem_eio (wait-wedge-immediate)
[540.671715] Starting subtest: wait-wedge-immediate
[542.621976] Subtest wait-wedge-immediate: SUCCESS (1.949s)
[542.795538] [111/131] (485s left) gem_exec_schedule (preempt-queue-chain)
[542.868085] Subtest preempt-queue-chain: SKIP (0.000s)
[543.177464] [112/131] (485s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[543.268326] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[543.279102] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.010s)
[543.384307] [113/131] (485s left) kms_psr2_su (page_flip-p010)
[543.450891] Subtest page_flip-P010: SKIP (0.000s)
[543.520011] [114/131] (485s left) gem_ctx_persistence (engines-queued)
[543.579789] Starting subtest: engines-queued
[543.582820] Starting dynamic subtest: rcs0
[543.649569] Dynamic subtest rcs0: SUCCESS (0.070s)
[543.663376] Starting dynamic subtest: bcs0
[543.706885] Dynamic subtest bcs0: SUCCESS (0.055s)
[543.719627] Starting dynamic subtest: vcs0
[545.524244] Dynamic subtest vcs0: SUCCESS (1.813s)
[545.539237] Starting dynamic subtest: vcs1
[547.506886] Dynamic subtest vcs1: SUCCESS (1.979s)
[547.520313] Starting dynamic subtest: vecs0
[549.554042] Dynamic subtest vecs0: SUCCESS (2.043s)
[549.566668] Starting dynamic subtest: ccs0
[549.714930] Dynamic subtest ccs0: SUCCESS (0.159s)
[549.717648] Subtest engines-queued: SUCCESS (6.134s)
[549.873045] [115/131] (478s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[550.011879] Starting subtest: flip-vs-cursor-busy-crc-legacy
[550.848323] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.837s)
[551.723294] [116/131] (477s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[551.817230] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[559.261910] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.446s)
[559.402334] [117/131] (469s left) gem_exec_whisper (basic-fds-all)
[559.472927] Starting subtest: basic-fds-all
[571.508376] Subtest basic-fds-all: SUCCESS (12.033s)
[571.720435] [118/131] (457s left) gem_cs_tlb (engines)
[571.789626] Starting subtest: engines
[571.792111] Starting dynamic subtest: rcs0
[573.949375] Dynamic subtest rcs0: SUCCESS (2.155s)
[573.961670] Starting dynamic subtest: bcs0
[576.107760] Dynamic subtest bcs0: SUCCESS (2.156s)
[576.120504] Starting dynamic subtest: vcs0
[578.261064] Dynamic subtest vcs0: SUCCESS (2.153s)
[578.272823] Starting dynamic subtest: vcs1
[580.417309] Dynamic subtest vcs1: SUCCESS (2.154s)
[580.430353] Starting dynamic subtest: vecs0
[582.570895] Dynamic subtest vecs0: SUCCESS (2.152s)
[582.584067] Starting dynamic subtest: ccs0
[584.726285] Dynamic subtest ccs0: SUCCESS (2.154s)
[584.729051] Subtest engines: SUCCESS (12.929s)
[584.875908] [119/131] (444s left) gem_exec_nop (basic-sequential)
[584.945720] Starting subtest: basic-sequential
[600.123948] Subtest basic-sequential: SUCCESS (15.186s)
[600.380357] [120/131] (428s left) gem_ctx_bad_destroy (invalid-ctx)
[600.434612] Starting subtest: invalid-ctx
[600.437139] Subtest invalid-ctx: SUCCESS (0.000s)
[600.535840] [121/131] (428s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[600.640877] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[601.664749] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.024s)
[601.813560] [122/131] (427s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[601.923627] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[608.790785] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.867s)
[608.988124] [123/131] (420s left) kms_addfb_basic (bad-pitch-128)
[609.046810] Starting subtest: bad-pitch-128
[609.049526] Subtest bad-pitch-128: SUCCESS (0.000s)
[609.220519] [124/131] (419s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[609.352752] Starting subtest: cursorA-vs-flipA-atomic-transitions
[620.522084] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.168s)
[621.354527] [125/131] (407s left) gem_caching (writes)
[621.419431] Subtest writes: SKIP (0.000s)
[621.503351] [126/131] (407s left) gem_mmap_offset (mmap-unmap)
[621.564521] Starting subtest: mmap-unmap
[621.566680] Starting dynamic subtest: smem0
[644.240716] Dynamic subtest smem0: SUCCESS (22.682s)
[644.243670] Subtest mmap-unmap: SUCCESS (22.683s)
[644.412555] [127/131] (384s left) i915_hangman (hangcheck-unterminated)
[644.472076] Starting subtest: hangcheck-unterminated
[655.540522] Subtest hangcheck-unterminated: SUCCESS (11.074s)
[655.677975] [128/131] (373s left) gen3_mixed_blits
[655.809924] [129/131] (373s left) syncobj_wait (reset-during-wait-for-submit)
[655.855923] Starting subtest: reset-during-wait-for-submit
[655.960735] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[656.072913] [130/131] (373s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[656.178449] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[657.058042] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.881s)
[657.268384] [131/131] (372s left) kms_psr (pr-basic)
[657.370613] Starting subtest: pr-basic
[657.375862] Subtest pr-basic: SKIP (0.000s)
[657.476835] 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.