[57.417061] Initializing watchdogs
[57.417124]   /dev/watchdog0
[57.432767] [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]
[57.437833] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.440165] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.443870] [001/133] (960s left) i915_query (hwconfig_table)
[57.519881] Starting subtest: hwconfig_table
[57.823722] Subtest hwconfig_table: SUCCESS (0.001s)
[57.859740] [002/133] (960s left) gem_exec_fence (basic-wait)
[58.057460] Starting subtest: basic-wait
[58.059788] Starting dynamic subtest: rcs0
[58.140755] Dynamic subtest rcs0: SUCCESS (0.086s)
[58.149550] Starting dynamic subtest: bcs0
[58.199237] Dynamic subtest bcs0: SUCCESS (0.057s)
[58.208595] Starting dynamic subtest: vcs0
[58.258637] Dynamic subtest vcs0: SUCCESS (0.058s)
[58.267877] Starting dynamic subtest: vcs1
[58.317961] Dynamic subtest vcs1: SUCCESS (0.058s)
[58.328641] Starting dynamic subtest: vecs0
[58.375113] Dynamic subtest vecs0: SUCCESS (0.057s)
[58.385513] Starting dynamic subtest: ccs0
[58.442558] Dynamic subtest ccs0: SUCCESS (0.066s)
[58.445112] Subtest basic-wait: SUCCESS (0.385s)
[60.390636] [FACT gem_exec_fence (basic-wait)] new: kernel.kmod_is_loaded.vgem: true
[60.394514] [003/133] (957s left) kms_content_protection (dp-mst-lic-type-1)
[60.546606] Starting subtest: dp-mst-lic-type-1
[60.551080] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[60.660293] [004/133] (957s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[60.718664] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[60.722913] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[60.898575] [005/133] (957s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[60.996289] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[67.833834] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.817s)
[67.947908] [006/133] (950s left) gem_exec_suspend (basic-s4-devices)
[68.007865] Starting subtest: basic-S4-devices
[68.010276] Starting dynamic subtest: smem
[80.267905] Dynamic subtest smem: SUCCESS (12.246s)
[80.270896] Subtest basic-S4-devices: SUCCESS (12.248s)
[87.462961] [007/133] (937s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[87.581046] Starting subtest: disable-crc-after-crtc
[87.582959] Starting dynamic subtest: pipe-A-eDP-1
[89.280918] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.699s)
[89.290833] Starting dynamic subtest: pipe-B-eDP-1
[91.624624] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.341s)
[91.635851] Starting dynamic subtest: pipe-C-eDP-1
[93.894984] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.268s)
[93.905663] Starting dynamic subtest: pipe-D-eDP-1
[96.156693] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.258s)
[96.158982] Subtest disable-crc-after-crtc: SUCCESS (8.571s)
[97.003971] [008/133] (928s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[97.113114] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[97.191753] [009/133] (928s left) gen9_exec_parse (basic-rejected)
[97.252256] Subtest basic-rejected: SKIP (0.000s)
[97.327801] [010/133] (927s left) kms_psr (pr-cursor-plane-move)
[97.418693] Starting subtest: pr-cursor-plane-move
[97.423045] Subtest pr-cursor-plane-move: SKIP (0.000s)
[97.494539] [011/133] (927s left) gem_create (create-ext-set-pat)
[97.666755] Starting subtest: create-ext-set-pat
[97.669389] Subtest create-ext-set-pat: SUCCESS (0.001s)
[97.761444] [012/133] (927s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[97.826695] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[97.887215] [013/133] (927s left) syncobj_eventfd (invalid-bad-pad)
[97.944575] Starting subtest: invalid-bad-pad
[97.946755] Subtest invalid-bad-pad: SUCCESS (0.000s)
[98.060216] [014/133] (927s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[98.165555] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[98.167951] Starting dynamic subtest: pipe-A-eDP-1
[98.194576] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[98.203681] Starting dynamic subtest: pipe-B-eDP-1
[98.225207] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[98.233360] Starting dynamic subtest: pipe-C-eDP-1
[98.254338] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[98.262702] Starting dynamic subtest: pipe-D-eDP-1
[98.284086] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[98.288171] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[100.461263] [015/133] (925s left) kms_pm_rpm (cursor-dpms)
[102.422205] Starting subtest: cursor-dpms
[102.427790] Subtest cursor-dpms: SKIP (0.000s)
[102.809934] [016/133] (922s left) kms_vrr (flip-dpms)
[102.894458] Starting subtest: flip-dpms
[102.901130] Subtest flip-dpms: SKIP (0.000s)
[102.977733] [017/133] (922s left) gem_tiled_wb
[103.118031] [018/133] (922s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[103.226934] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[110.936279] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.714s)
[111.046917] [019/133] (914s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[111.151173] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[111.155156] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[111.244160] [020/133] (914s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[111.375308] Starting subtest: cursor-tearing-framebuffer-change
[111.377382] Starting dynamic subtest: pipe-A-eDP-1
[111.973274] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.595s)
[111.983666] Starting dynamic subtest: pipe-D-eDP-1
[113.176385] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.201s)
[113.178720] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.800s)
[114.012248] [021/133] (911s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[114.117660] Starting subtest: x-tiled-addfb-size-offset-overflow
[114.119763] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[114.220972] [022/133] (911s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[114.338510] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[114.342719] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[114.434944] [023/133] (911s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[114.551285] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[114.555269] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[114.657995] [024/133] (911s left) gem_eio (wait-wedge-immediate)
[114.891687] Starting subtest: wait-wedge-immediate
[116.378724] Subtest wait-wedge-immediate: SUCCESS (1.487s)
[116.511388] [025/133] (909s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[116.605282] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[116.607728] Starting dynamic subtest: pipe-A-eDP-1
[118.743083] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.137s)
[118.752648] Starting dynamic subtest: pipe-B-eDP-1
[121.140841] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.396s)
[121.150186] Starting dynamic subtest: pipe-C-eDP-1
[123.376257] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.234s)
[123.392171] Starting dynamic subtest: pipe-D-eDP-1
[125.444443] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.067s)
[125.446396] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.839s)
[126.628867] [026/133] (899s left) kms_async_flips (invalid-async-flip-atomic)
[126.744304] Starting subtest: invalid-async-flip-atomic
[127.125505] Starting dynamic subtest: pipe-A-eDP-1
[127.953826] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.828s)
[128.311439] Starting dynamic subtest: pipe-B-eDP-1
[129.085225] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.782s)
[129.458545] Starting dynamic subtest: pipe-C-eDP-1
[130.228232] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.778s)
[130.582316] Starting dynamic subtest: pipe-D-eDP-1
[131.358913] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.784s)
[131.361244] Subtest invalid-async-flip-atomic: SUCCESS (4.616s)
[132.509830] [027/133] (893s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[132.561606] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[132.563974] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.001s)
[132.664055] [028/133] (893s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[133.232763] Starting subtest: syncobj-timeline-invalid-flags
[133.235470] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[134.373323] [029/133] (891s left) gem_exec_parallel (contexts)
[134.446323] Starting subtest: contexts
[134.448573] Starting dynamic subtest: rcs0
[138.680506] Dynamic subtest rcs0: SUCCESS (4.234s)
[138.693217] Starting dynamic subtest: bcs0
[143.125335] Dynamic subtest bcs0: SUCCESS (4.442s)
[143.138026] Starting dynamic subtest: vcs0
[148.700426] Dynamic subtest vcs0: SUCCESS (5.574s)
[148.710830] Starting dynamic subtest: vcs1
[152.865600] Dynamic subtest vcs1: SUCCESS (4.163s)
[152.875089] Starting dynamic subtest: vecs0
[158.711796] Dynamic subtest vecs0: SUCCESS (5.845s)
[158.721588] Starting dynamic subtest: ccs0
[162.829891] Dynamic subtest ccs0: SUCCESS (4.115s)
[162.832976] Subtest contexts: SUCCESS (28.383s)
[163.020643] [030/133] (863s left) kms_cursor_crc (cursor-random-32x32)
[163.161742] Starting subtest: cursor-random-32x32
[163.208171] Subtest cursor-random-32x32: SKIP (0.042s)
[163.532204] [031/133] (862s left) syncobj_wait (reset-unsignaled)
[163.600181] Starting subtest: reset-unsignaled
[163.602374] Subtest reset-unsignaled: SUCCESS (0.000s)
[163.697535] [032/133] (862s left) gem_pxp (hw-rejects-pxp-context)
[163.815817] Starting subtest: hw-rejects-pxp-context
[163.820666] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[163.919424] [033/133] (862s left) kms_chamelium_hpd (hdmi-hpd-fast)
[164.306060] Subtest hdmi-hpd-fast: SKIP (0.000s)
[165.126395] [034/133] (861s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[165.228134] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[165.230307] Starting dynamic subtest: pipe-A-eDP-1
[165.291357] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[165.300935] Starting dynamic subtest: pipe-B-eDP-1
[165.358943] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[165.369751] Starting dynamic subtest: pipe-C-eDP-1
[165.428065] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[165.438408] Starting dynamic subtest: pipe-D-eDP-1
[165.495137] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[165.499562] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[167.492258] [035/133] (858s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[167.586929] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[174.667923] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.085s)
[174.792986] [036/133] (851s left) api_intel_bb (bb-with-allocator)
[174.850207] Starting subtest: bb-with-allocator
[174.856696] Subtest bb-with-allocator: SUCCESS (0.006s)
[174.978615] [037/133] (851s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[175.078026] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[179.089061] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (4.017s)
[180.212159] [038/133] (846s left) gem_mmap_gtt (basic-write-read)
[180.273794] Subtest basic-write-read: SKIP (0.000s)
[180.333313] [039/133] (846s left) gem_exec_schedule (u-submit-golden-slice)
[180.406572] Starting subtest: u-submit-golden-slice
[180.408503] Starting dynamic subtest: rcs0
[180.437064] Dynamic subtest rcs0: SUCCESS (0.039s)
[180.448804] Starting dynamic subtest: bcs0
[180.476625] Dynamic subtest bcs0: SUCCESS (0.039s)
[180.486426] Starting dynamic subtest: vcs0
[180.510290] Dynamic subtest vcs0: SUCCESS (0.033s)
[180.520063] Starting dynamic subtest: vcs1
[180.548569] Dynamic subtest vcs1: SUCCESS (0.038s)
[180.558934] Starting dynamic subtest: vecs0
[180.580571] Dynamic subtest vecs0: SUCCESS (0.031s)
[180.590650] Starting dynamic subtest: ccs0
[180.615419] Dynamic subtest ccs0: SUCCESS (0.034s)
[180.617694] Subtest u-submit-golden-slice: SUCCESS (0.218s)
[182.363717] [040/133] (844s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[182.467342] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[182.471794] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s)
[182.541686] [041/133] (844s left) kms_psr (fbc-psr2-sprite-render)
[182.642526] Starting subtest: fbc-psr2-sprite-render
[182.644774] Starting dynamic subtest: eDP-1
[182.648855] Dynamic subtest eDP-1: SKIP (0.000s)
[182.653122] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[182.717895] [042/133] (843s left) kms_plane_scaling (planes-upscale-factor-0-25)
[182.813089] Starting subtest: planes-upscale-factor-0-25
[182.815240] Starting dynamic subtest: pipe-A
[182.873299] Dynamic subtest pipe-A: SUCCESS (0.062s)
[182.884291] Starting dynamic subtest: pipe-B
[184.023392] Dynamic subtest pipe-B: SUCCESS (1.149s)
[184.035077] Starting dynamic subtest: pipe-C
[185.135232] Dynamic subtest pipe-C: SUCCESS (1.110s)
[185.145645] Starting dynamic subtest: pipe-D
[186.282856] Dynamic subtest pipe-D: SUCCESS (1.146s)
[186.285437] Subtest planes-upscale-factor-0-25: SUCCESS (3.472s)
[187.448535] [043/133] (839s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[187.554413] Starting subtest: random-ccs-data-yf-tiled-ccs
[187.556662] Starting dynamic subtest: pipe-A-eDP-1
[187.581525] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[187.592632] Starting dynamic subtest: pipe-B-eDP-1
[187.616196] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[187.625247] Starting dynamic subtest: pipe-C-eDP-1
[187.648297] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[187.657273] Starting dynamic subtest: pipe-D-eDP-1
[187.681296] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[187.685587] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.005s)
[189.815739] [044/133] (836s left) kms_hdr (bpc-switch-suspend)
[189.908638] Starting subtest: bpc-switch-suspend
[190.978857] Starting dynamic subtest: pipe-A-eDP-1
[210.483849] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.525s)
[210.486467] Subtest bpc-switch-suspend: SUCCESS (5.595s)
[210.614361] [045/133] (816s left) gem_ctx_bad_destroy (invalid-default-ctx)
[210.684632] Starting subtest: invalid-default-ctx
[210.687382] Subtest invalid-default-ctx: SUCCESS (0.000s)
[210.763174] [046/133] (816s left) intel_hwmon (hwmon-write)
[210.816537] Subtest hwmon-write: SKIP (0.000s)
[210.879000] [047/133] (815s left) i915_pm_rpm (gem-pread)
[212.403392] Starting subtest: gem-pread
[214.796088] Subtest gem-pread: SUCCESS (2.373s)
[214.920079] [048/133] (811s left) drm_read (empty-nonblock)
[215.074519] Starting subtest: empty-nonblock
[215.076986] Subtest empty-nonblock: SUCCESS (0.000s)
[215.189385] [049/133] (811s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[215.293374] Starting subtest: x-tiled-8bpp-rotate-0
[216.505846] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.204s)
[216.617812] [050/133] (810s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[216.719937] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[216.723371] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[216.807007] [051/133] (810s left) prime_mmap_coherency (write)
[216.862633] Starting subtest: write
[222.267621] Subtest write: SUCCESS (5.378s)
[222.407230] [052/133] (804s left) i915_hangman (gt-engine-error)
[222.475734] Starting subtest: gt-engine-error
[222.478097] Starting dynamic subtest: rcs0
[224.230085] Dynamic subtest rcs0: SUCCESS (1.747s)
[224.243344] Starting dynamic subtest: bcs0
[226.277175] Dynamic subtest bcs0: SUCCESS (2.039s)
[226.290423] Starting dynamic subtest: vcs0
[228.261087] Dynamic subtest vcs0: SUCCESS (1.977s)
[228.274683] Starting dynamic subtest: vcs1
[230.243944] Dynamic subtest vcs1: SUCCESS (1.977s)
[230.256754] Starting dynamic subtest: vecs0
[232.228171] Dynamic subtest vecs0: SUCCESS (1.979s)
[232.241023] Starting dynamic subtest: ccs0
[234.213126] Dynamic subtest ccs0: SUCCESS (1.980s)
[234.216382] Subtest gt-engine-error: SUCCESS (11.715s)
[234.297894] [053/133] (792s left) kms_big_fb (linear-8bpp-rotate-90)
[234.420133] Starting subtest: linear-8bpp-rotate-90
[234.440767] Subtest linear-8bpp-rotate-90: SKIP (0.020s)
[234.552621] [054/133] (792s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[234.665159] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[234.668131] Starting dynamic subtest: pipe-A-eDP-1
[241.405907] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.742s)
[241.416868] Starting dynamic subtest: pipe-B-eDP-1
[248.406149] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.997s)
[248.408108] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.742s)
[249.273751] [055/133] (777s left) kms_invalid_mode (bad-vsync-end)
[249.378682] Starting subtest: bad-vsync-end
[249.380950] Starting dynamic subtest: pipe-A-eDP-1
[249.667702] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.291s)
[249.678070] Starting dynamic subtest: pipe-B-eDP-1
[249.680037] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[249.689869] Starting dynamic subtest: pipe-C-eDP-1
[249.692149] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[249.701357] Starting dynamic subtest: pipe-D-eDP-1
[249.703684] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[249.705928] Subtest bad-vsync-end: SUCCESS (0.297s)
[250.498161] [056/133] (776s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[250.610232] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[250.614560] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[250.717812] [057/133] (776s left) gem_spin_batch (legacy-resubmit-new)
[250.787938] Starting subtest: legacy-resubmit-new
[250.790209] Starting dynamic subtest: default
[250.795791] Dynamic subtest default: SUCCESS (0.007s)
[250.809480] Starting dynamic subtest: render
[250.811759] Dynamic subtest render: SUCCESS (0.003s)
[250.821643] Starting dynamic subtest: bsd
[250.823856] Dynamic subtest bsd: SUCCESS (0.004s)
[250.834811] Starting dynamic subtest: bsd1
[250.836882] Dynamic subtest bsd1: SUCCESS (0.003s)
[250.846288] Starting dynamic subtest: bsd2
[250.848388] Dynamic subtest bsd2: SUCCESS (0.004s)
[250.858250] Starting dynamic subtest: blt
[250.860367] Dynamic subtest blt: SUCCESS (0.004s)
[250.870021] Starting dynamic subtest: vebox
[250.872203] Dynamic subtest vebox: SUCCESS (0.004s)
[250.874366] Subtest legacy-resubmit-new: SUCCESS (0.035s)
[252.339613] [058/133] (774s left) kms_cursor_legacy (single-bo)
[252.454747] Starting subtest: single-bo
[252.457215] Starting dynamic subtest: pipe-A
[257.843434] Dynamic subtest pipe-A: SUCCESS (5.384s)
[257.861978] Starting dynamic subtest: pipe-B
[263.226561] Dynamic subtest pipe-B: SUCCESS (5.380s)
[263.238349] Starting dynamic subtest: pipe-C
[268.609854] Dynamic subtest pipe-C: SUCCESS (5.379s)
[268.622076] Starting dynamic subtest: pipe-D
[273.994553] Dynamic subtest pipe-D: SUCCESS (5.380s)
[274.005984] Starting dynamic subtest: all-pipes
[279.385662] Dynamic subtest all-pipes: SUCCESS (5.387s)
[279.388164] Subtest single-bo: SUCCESS (26.923s)
[279.531171] [059/133] (747s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[279.599524] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[279.706582] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.105s)
[279.786902] [060/133] (747s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[279.911637] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[279.915728] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[279.978856] [061/133] (747s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[280.091585] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[280.108388] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.015s)
[280.187479] [062/133] (747s left) gem_exec_reloc (basic-gtt-cpu-active)
[280.245246] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[280.315534] [063/133] (747s left) perf_pmu (busy)
[280.359835] Starting subtest: busy
[280.362034] Starting dynamic subtest: rcs0
[280.950360] Dynamic subtest rcs0: SUCCESS (0.590s)
[280.964290] Starting dynamic subtest: bcs0
[281.515386] Dynamic subtest bcs0: SUCCESS (0.563s)
[281.528382] Starting dynamic subtest: vcs0
[283.271303] Dynamic subtest vcs0: SUCCESS (1.751s)
[283.283899] Starting dynamic subtest: vcs1
[285.254781] Dynamic subtest vcs1: SUCCESS (1.979s)
[285.266490] Starting dynamic subtest: vecs0
[287.302048] Dynamic subtest vecs0: SUCCESS (2.043s)
[287.316722] Starting dynamic subtest: ccs0
[287.869157] Dynamic subtest ccs0: SUCCESS (0.564s)
[287.871800] Subtest busy: SUCCESS (7.508s)
[287.971938] [064/133] (739s left) kms_cursor_crc (cursor-offscreen-256x85)
[288.225724] Starting subtest: cursor-offscreen-256x85
[288.275438] Subtest cursor-offscreen-256x85: SKIP (0.046s)
[288.457756] [065/133] (739s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[288.544761] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[288.547056] Starting dynamic subtest: pipe-A-default-mode
[291.238233] Dynamic subtest pipe-A-default-mode: SUCCESS (2.691s)
[291.240342] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.693s)
[292.111941] [066/133] (735s left) kms_lease (cursor-implicit-plane)
[292.213768] Starting subtest: cursor-implicit-plane
[292.216118] Starting dynamic subtest: pipe-A-eDP-1
[292.669328] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.456s)
[292.680594] Starting dynamic subtest: pipe-B-eDP-1
[293.826183] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.153s)
[293.836503] Starting dynamic subtest: pipe-C-eDP-1
[294.943293] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.114s)
[294.955113] Starting dynamic subtest: pipe-D-eDP-1
[296.074983] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.132s)
[296.077283] Subtest cursor-implicit-plane: SUCCESS (3.861s)
[296.945899] [067/133] (730s left) syncobj_timeline (single-wait-all-available-submitted)
[297.003531] Starting subtest: single-wait-all-available-submitted
[297.005796] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[297.103919] [068/133] (730s left) kms_psr (fbc-pr-sprite-blt)
[297.199875] Starting subtest: fbc-pr-sprite-blt
[297.204350] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[297.276383] [069/133] (730s left) gem_ctx_param (set-priority-range)
[297.335594] Starting subtest: set-priority-range
[297.351247] Subtest set-priority-range: SUCCESS (0.018s)
[297.472117] [070/133] (730s left) prime_busy (hang-wait)
[297.524669] Starting subtest: hang-wait
[297.529561] Starting dynamic subtest: rcs0
[323.747657] Dynamic subtest rcs0: SUCCESS (26.220s)
[323.757613] Starting dynamic subtest: bcs0
[330.906556] Dynamic subtest bcs0: SUCCESS (7.156s)
[330.916599] Starting dynamic subtest: vcs0
[337.877217] Dynamic subtest vcs0: SUCCESS (6.971s)
[337.888630] Starting dynamic subtest: vcs1
[344.851811] Dynamic subtest vcs1: SUCCESS (6.974s)
[344.863503] Starting dynamic subtest: vecs0
[351.895856] Dynamic subtest vecs0: SUCCESS (7.038s)
[351.905890] Starting dynamic subtest: ccs0
[365.729322] Dynamic subtest ccs0: SUCCESS (13.831s)
[365.731844] Subtest hang-wait: SUCCESS (68.203s)
[365.865006] [071/133] (662s left) gem_flink_basic (basic)
[365.920622] Starting subtest: basic
[365.922816] Subtest basic: SUCCESS (0.000s)
[366.027537] [072/133] (661s left) gem_exec_schedule (semaphore-noskip)
[366.104215] Starting subtest: semaphore-noskip
[366.598179] Subtest semaphore-noskip: SUCCESS (0.499s)
[366.943765] [073/133] (661s left) kms_flip (bo-too-big)
[367.041016] Starting subtest: bo-too-big
[367.043236] Starting dynamic subtest: A-eDP1
[368.394618] Dynamic subtest A-eDP1: SUCCESS (1.355s)
[368.406267] Starting dynamic subtest: B-eDP1
[369.710667] Dynamic subtest B-eDP1: SUCCESS (1.315s)
[369.722532] Starting dynamic subtest: C-eDP1
[371.057728] Dynamic subtest C-eDP1: SUCCESS (1.346s)
[371.070663] Starting dynamic subtest: D-eDP1
[372.389510] Dynamic subtest D-eDP1: SUCCESS (1.331s)
[372.391768] Subtest bo-too-big: SUCCESS (5.354s)
[373.588986] [074/133] (654s left) syncobj_timeline (invalid-signal-zero-handles)
[373.643621] Starting subtest: invalid-signal-zero-handles
[373.645835] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[373.743847] [075/133] (654s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[373.836709] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[380.703656] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.868s)
[380.843495] [076/133] (647s left) gem_mmap_offset (perf)
[380.896821] Starting subtest: perf
[380.898753] Starting dynamic subtest: smem0
[381.290501] Dynamic subtest smem0: SUCCESS (0.392s)
[381.293055] Subtest perf: SUCCESS (0.393s)
[381.419186] [077/133] (646s left) prime_mmap (test_errors)
[381.477472] Starting subtest: test_errors
[381.479630] Starting dynamic subtest: test_errors-smem
[381.572706] Dynamic subtest test_errors-smem: SUCCESS (0.097s)
[381.575061] Subtest test_errors: SUCCESS (0.098s)
[381.672120] [078/133] (646s left) gem_ctx_isolation (nonpriv)
[381.725900] Starting subtest: nonpriv
[381.728190] Starting dynamic subtest: rcs0
[381.970960] Dynamic subtest rcs0: SUCCESS (0.245s)
[381.982040] Starting dynamic subtest: bcs0
[382.221916] Dynamic subtest bcs0: SUCCESS (0.250s)
[382.234627] Starting dynamic subtest: vcs0
[382.459237] Dynamic subtest vcs0: SUCCESS (0.236s)
[382.471883] Starting dynamic subtest: vcs1
[384.522513] Dynamic subtest vcs1: SUCCESS (2.061s)
[384.532746] Starting dynamic subtest: vecs0
[386.553057] Dynamic subtest vecs0: SUCCESS (2.030s)
[386.565171] Starting dynamic subtest: ccs0
[388.558885] Dynamic subtest ccs0: SUCCESS (2.004s)
[388.561327] Subtest nonpriv: SUCCESS (6.832s)
[388.808946] [079/133] (639s left) gem_exec_params (dr4-dirt)
[388.857959] Starting subtest: DR4-dirt
[388.860340] Subtest DR4-dirt: SUCCESS (0.000s)
[388.962460] [080/133] (639s left) gen3_render_tiledy_blits
[389.081325] [081/133] (639s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[389.179731] Starting subtest: crc-primary-suspend-y-tiled-ccs
[389.181966] Starting dynamic subtest: pipe-A-eDP-1
[389.190632] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[389.201376] Starting dynamic subtest: pipe-B-eDP-1
[389.209912] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[389.220273] Starting dynamic subtest: pipe-C-eDP-1
[389.228639] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[389.238448] Starting dynamic subtest: pipe-D-eDP-1
[389.246781] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[389.250945] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.005s)
[391.400638] [082/133] (636s left) kms_psr (psr-basic)
[391.490467] Starting subtest: psr-basic
[391.492749] Starting dynamic subtest: eDP-1
[393.075994] Dynamic subtest eDP-1: SUCCESS (1.584s)
[393.078282] Subtest psr-basic: SUCCESS (1.585s)
[393.967686] [083/133] (634s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[394.027395] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[394.088140] [084/133] (634s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[394.191659] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[394.195494] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[394.289916] [085/133] (634s left) kms_prop_blob (basic)
[394.353163] Starting subtest: basic
[394.355458] Subtest basic: SUCCESS (0.000s)
[394.461611] [086/133] (634s left) gem_basic (create-close)
[394.523935] Starting subtest: create-close
[394.528391] Subtest create-close: SUCCESS (0.000s)
[394.633989] [087/133] (633s left) gem_madvise (dontneed-after-mmap)
[394.667408] Starting subtest: dontneed-after-mmap
[394.697166] Subtest dontneed-after-mmap: SUCCESS (0.030s)
[394.800032] [088/133] (633s left) kms_chamelium_edid (dp-edid-read)
[395.182211] Subtest dp-edid-read: SKIP (0.000s)
[395.972056] [089/133] (632s left) gem_partial_pwrite_pread (reads)
[396.043130] Subtest reads: SKIP (0.000s)
[396.122810] [090/133] (632s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[396.219337] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[396.223220] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[396.292887] [091/133] (632s left) kms_selftest (drm_plane_helper)
[396.336083] Starting subtest: drm_plane_helper
[396.387850] Starting dynamic subtest: drm_test_check_plane_state
[396.508283] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.119s)
[396.518286] Starting dynamic subtest: drm_test_check_invalid_plane_state
[396.607650] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.100s)
[396.609871] Subtest drm_plane_helper: SUCCESS (0.271s)
[396.764856] [092/133] (632s left) api_intel_bb (reset-bb)
[396.821176] Starting subtest: reset-bb
[396.826134] Subtest reset-bb: SUCCESS (0.007s)
[396.944949] [093/133] (631s left) gem_softpin (overlap)
[396.995851] Starting subtest: overlap
[397.938044] Subtest overlap: SUCCESS (0.941s)
[398.046332] [094/133] (630s left) kms_plane_lowres (tiling-yf)
[398.141900] Starting subtest: tiling-yf
[398.145899] Subtest tiling-yf: SKIP (0.000s)
[398.226457] [095/133] (630s left) gem_userptr_blits (stress-purge)
[398.292390] Starting subtest: stress-purge
[403.700036] Subtest stress-purge: SUCCESS (5.406s)
[403.826889] [096/133] (625s left) sysfs_heartbeat_interval (mixed)
[403.919046] Starting subtest: mixed
[403.920884] Starting dynamic subtest: vecs0
[409.137369] Dynamic subtest vecs0: SUCCESS (5.218s)
[409.157339] Starting dynamic subtest: ccs0
[414.336472] Dynamic subtest ccs0: SUCCESS (5.195s)
[414.349590] Starting dynamic subtest: vcs0
[419.526917] Dynamic subtest vcs0: SUCCESS (5.188s)
[419.540625] Starting dynamic subtest: bcs0
[424.714779] Dynamic subtest bcs0: SUCCESS (5.184s)
[424.727902] Starting dynamic subtest: rcs0
[429.902254] Dynamic subtest rcs0: SUCCESS (5.184s)
[429.915433] Starting dynamic subtest: vcs1
[435.138081] Dynamic subtest vcs1: SUCCESS (5.233s)
[435.141375] Subtest mixed: SUCCESS (31.215s)
[435.216628] [097/133] (593s left) i915_drm_fdinfo (most-busy-idle-check-all)
[435.262619] Starting subtest: most-busy-idle-check-all
[435.265049] Starting dynamic subtest: rcs0
[435.269699] Dynamic subtest rcs0: SKIP (0.003s)
[435.281188] Starting dynamic subtest: bcs0
[435.285678] Dynamic subtest bcs0: SKIP (0.000s)
[435.296618] Starting dynamic subtest: vcs0
[435.301001] Dynamic subtest vcs0: SKIP (0.000s)
[435.311663] Starting dynamic subtest: vcs1
[435.316124] Dynamic subtest vcs1: SKIP (0.000s)
[435.328443] Starting dynamic subtest: vecs0
[435.332664] Dynamic subtest vecs0: SKIP (0.000s)
[435.343093] Starting dynamic subtest: ccs0
[435.347263] Dynamic subtest ccs0: SKIP (0.000s)
[435.351384] Subtest most-busy-idle-check-all: SKIP (0.009s)
[435.390826] [098/133] (593s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[435.538350] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[435.542355] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[435.643078] [099/133] (593s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[435.743327] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[435.747756] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[435.846677] [100/133] (593s left) gem_exec_balancer (hang)
[436.121024] Starting subtest: hang
[437.796114] Subtest hang: SUCCESS (1.680s)
[437.914757] [101/133] (591s left) gem_exec_whisper (basic-queues-forked-all)
[437.975967] Starting subtest: basic-queues-forked-all
[457.693471] Subtest basic-queues-forked-all: SUCCESS (19.708s)
[457.882426] [102/133] (571s left) gem_ctx_persistence (heartbeat-many)
[457.937380] Starting subtest: heartbeat-many
[457.942293] Subtest heartbeat-many: SKIP (0.000s)
[458.044891] [103/133] (571s left) gem_pxp (create-regular-context-2)
[458.148421] Starting subtest: create-regular-context-2
[458.150732] Subtest create-regular-context-2: SUCCESS (0.002s)
[458.267772] [104/133] (571s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[458.326355] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[458.328718] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[458.465760] [105/133] (570s left) gem_mmap_wc (set-cache-level)
[458.528855] Subtest set-cache-level: SKIP (0.000s)
[458.589807] [106/133] (570s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[458.714894] Starting subtest: 2x-long-flip-vs-cursor-legacy
[458.719239] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s)
[458.880753] [107/133] (570s left) kms_frontbuffer_tracking (fbc-1p-rte)
[458.971946] Starting subtest: fbc-1p-rte
[464.482564] Subtest fbc-1p-rte: SUCCESS (5.512s)
[465.703627] [108/133] (563s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[465.803826] Starting subtest: y-tiled-8bpp-rotate-90
[465.807726] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[465.907986] [109/133] (563s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[466.012705] Starting subtest: primary-4-tiled-reflect-x-0
[472.989036] Subtest primary-4-tiled-reflect-x-0: SUCCESS (6.977s)
[474.153213] [110/133] (555s left) gem_softpin (noreloc)
[474.223452] Starting subtest: noreloc
[479.647321] Subtest noreloc: SUCCESS (5.421s)
[479.776201] [111/133] (549s left) kms_flip (flip-vs-panning)
[479.876251] Starting subtest: flip-vs-panning
[479.879644] Starting dynamic subtest: A-eDP1
[488.663204] Dynamic subtest A-eDP1: SUCCESS (8.782s)
[488.675949] Starting dynamic subtest: B-eDP1
[497.390950] Dynamic subtest B-eDP1: SUCCESS (8.723s)
[497.403936] Starting dynamic subtest: C-eDP1
[506.117454] Dynamic subtest C-eDP1: SUCCESS (8.723s)
[506.128524] Starting dynamic subtest: D-eDP1
[514.856752] Dynamic subtest D-eDP1: SUCCESS (8.736s)
[514.861010] Subtest flip-vs-panning: SUCCESS (34.976s)
[516.026462] [112/133] (513s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[516.147212] Starting subtest: basic-flip-after-cursor-varying-size
[517.085163] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.937s)
[517.969036] [113/133] (511s left) gem_ctx_shared (single-timeline)
[518.037340] Starting subtest: single-timeline
[518.054778] Subtest single-timeline: SUCCESS (0.014s)
[518.278716] [114/133] (511s left) gem_busy (busy)
[518.352368] Starting subtest: busy
[518.354758] Starting dynamic subtest: all-engines
[518.417575] Dynamic subtest all-engines: SUCCESS (0.065s)
[518.431245] Starting dynamic subtest: rcs0
[520.270154] Dynamic subtest rcs0: SUCCESS (1.849s)
[520.284197] Starting dynamic subtest: bcs0
[520.327263] Dynamic subtest bcs0: SUCCESS (0.054s)
[520.338636] Starting dynamic subtest: vcs0
[520.369458] Dynamic subtest vcs0: SUCCESS (0.039s)
[520.380215] Starting dynamic subtest: vcs1
[522.252470] Dynamic subtest vcs1: SUCCESS (1.878s)
[522.264611] Starting dynamic subtest: vecs0
[524.300324] Dynamic subtest vecs0: SUCCESS (2.045s)
[524.312610] Starting dynamic subtest: ccs0
[526.284074] Dynamic subtest ccs0: SUCCESS (1.983s)
[526.286118] Subtest busy: SUCCESS (7.926s)
[526.654715] [115/133] (503s left) kms_color_pipeline (plane-lut1d-lut1d)
[526.782820] Starting subtest: plane-lut1d-lut1d
[526.906802] Starting dynamic subtest: pipe-A-plane-0
[527.052381] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[527.065774] Starting dynamic subtest: pipe-A-plane-1
[527.206891] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s)
[527.218276] Starting dynamic subtest: pipe-A-plane-2
[527.373328] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[528.557813] Starting dynamic subtest: pipe-B-plane-0
[528.704308] Dynamic subtest pipe-B-plane-0: SUCCESS (0.155s)
[528.715364] Starting dynamic subtest: pipe-B-plane-1
[528.848767] Dynamic subtest pipe-B-plane-1: SUCCESS (0.144s)
[528.860046] Starting dynamic subtest: pipe-B-plane-2
[528.981981] Dynamic subtest pipe-B-plane-2: SUCCESS (0.132s)
[530.188245] Starting dynamic subtest: pipe-C-plane-0
[530.334362] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s)
[530.347746] Starting dynamic subtest: pipe-C-plane-1
[530.467870] Dynamic subtest pipe-C-plane-1: SUCCESS (0.133s)
[530.479179] Starting dynamic subtest: pipe-C-plane-2
[530.601555] Dynamic subtest pipe-C-plane-2: SUCCESS (0.133s)
[531.847752] Starting dynamic subtest: pipe-D-plane-0
[531.982557] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[531.997209] Starting dynamic subtest: pipe-D-plane-1
[532.149647] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[532.164867] Starting dynamic subtest: pipe-D-plane-2
[532.305076] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[532.595842] Subtest plane-lut1d-lut1d: SUCCESS (5.813s)
[533.397768] [116/133] (496s left) kms_draw_crc (draw-method-pwrite)
[533.498808] Starting subtest: draw-method-pwrite
[533.501029] Starting dynamic subtest: xrgb8888-untiled
[534.074753] Dynamic subtest xrgb8888-untiled: SUCCESS (0.578s)
[534.086920] Starting dynamic subtest: rgb565-untiled
[534.507993] Dynamic subtest rgb565-untiled: SUCCESS (0.432s)
[534.519913] Starting dynamic subtest: xrgb2101010-untiled
[535.054028] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.544s)
[535.065791] Starting dynamic subtest: xbgr16161616f-untiled
[535.830793] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.775s)
[535.842439] Starting dynamic subtest: xrgb8888-xtiled
[537.609005] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.777s)
[537.621026] Starting dynamic subtest: rgb565-xtiled
[538.742407] Dynamic subtest rgb565-xtiled: SUCCESS (1.133s)
[538.753458] Starting dynamic subtest: xrgb2101010-xtiled
[540.554528] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.810s)
[540.567254] Starting dynamic subtest: xbgr16161616f-xtiled
[543.877813] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.320s)
[543.889385] Starting dynamic subtest: xrgb8888-4tiled
[544.989519] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.110s)
[545.002742] Starting dynamic subtest: rgb565-4tiled
[545.555667] Dynamic subtest rgb565-4tiled: SUCCESS (0.566s)
[545.569932] Starting dynamic subtest: xrgb2101010-4tiled
[546.634214] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.076s)
[546.646088] Starting dynamic subtest: xbgr16161616f-4tiled
[549.668587] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.032s)
[549.671009] Subtest draw-method-pwrite: SUCCESS (16.168s)
[549.762592] [117/133] (480s left) vgem_basic (unload)
[549.798106] Starting subtest: unload
[578.861448] Subtest unload: SUCCESS (29.054s)
[578.962986] [118/133] (451s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[579.065656] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[579.070074] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[579.164684] [119/133] (450s left) gem_exec_schedule (fairslice-all)
[579.238440] Starting subtest: fairslice-all
[581.293641] Subtest fairslice-all: SUCCESS (2.060s)
[581.605472] [120/133] (448s left) gem_exec_schedule (noreorder-priority)
[581.782487] Starting subtest: noreorder-priority
[581.784436] Starting dynamic subtest: rcs0
[582.940906] Dynamic subtest rcs0: SUCCESS (1.159s)
[582.955325] Starting dynamic subtest: vcs0
[584.236526] Dynamic subtest vcs0: SUCCESS (1.292s)
[584.250600] Starting dynamic subtest: vcs1
[586.306657] Dynamic subtest vcs1: SUCCESS (2.067s)
[586.320613] Starting dynamic subtest: vecs0
[588.287845] Dynamic subtest vecs0: SUCCESS (1.978s)
[588.302230] Starting dynamic subtest: ccs0
[589.429948] Dynamic subtest ccs0: SUCCESS (1.140s)
[589.432940] Subtest noreorder-priority: SUCCESS (7.648s)
[589.622422] [121/133] (440s left) gem_ppgtt (blt-vs-render-ctx0)
[589.678994] Starting subtest: blt-vs-render-ctx0
[622.537193] Subtest blt-vs-render-ctx0: SUCCESS (32.848s)
[622.675217] [122/133] (407s left) perf_pmu (most-busy-idle-check-all)
[622.743275] Starting subtest: most-busy-idle-check-all
[622.745615] Starting dynamic subtest: rcs0
[624.262532] Dynamic subtest rcs0: SUCCESS (1.518s)
[624.275228] Starting dynamic subtest: bcs0
[626.246168] Dynamic subtest bcs0: SUCCESS (1.981s)
[626.262165] Starting dynamic subtest: vcs0
[628.295096] Dynamic subtest vcs0: SUCCESS (2.045s)
[628.309318] Starting dynamic subtest: vcs1
[630.279093] Dynamic subtest vcs1: SUCCESS (1.980s)
[630.293139] Starting dynamic subtest: vecs0
[632.263090] Dynamic subtest vecs0: SUCCESS (1.981s)
[632.277823] Starting dynamic subtest: ccs0
[634.310633] Dynamic subtest ccs0: SUCCESS (2.044s)
[634.313495] Subtest most-busy-idle-check-all: SUCCESS (11.565s)
[634.426301] [123/133] (395s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[634.495885] Starting subtest: etime-multi-wait-available-unsubmitted
[634.602248] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.105s)
[634.684122] [124/133] (395s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[634.798122] Starting subtest: fbcpsr-rgb565-draw-pwrite
[641.865206] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (7.066s)
[642.022274] [125/133] (388s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[642.128598] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[642.133015] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[642.223943] [126/133] (388s left) gem_eio (in-flight-contexts-1us)
[642.429605] Starting subtest: in-flight-contexts-1us
[654.306631] Subtest in-flight-contexts-1us: SUCCESS (11.873s)
[654.479819] [127/133] (375s left) gem_lmem_swapping (smem-oom)
[654.528731] Subtest smem-oom: SKIP (0.000s)
[654.575555] [128/133] (375s left) dmabuf_sync_file (import-multiple-read-only)
[654.629750] Starting subtest: import-multiple-read-only
[654.634467] Subtest import-multiple-read-only: SUCCESS (0.006s)
[654.689041] [129/133] (375s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[654.796218] Starting subtest: yf-tiled-8bpp-rotate-180
[654.800655] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[654.886638] [130/133] (375s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[654.982642] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[654.985021] Starting dynamic subtest: pipe-A-eDP-1
[655.070162] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[655.084160] Starting dynamic subtest: pipe-B-eDP-1
[656.238883] Dynamic subtest pipe-B-eDP-1: SKIP (1.167s)
[656.243409] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.258s)
[657.422347] [131/133] (373s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[657.528786] Starting subtest: fbc-1p-pri-indfb-multidraw
[670.453394] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (12.923s)
[671.840116] [132/133] (358s left) kms_big_fb (4-tiled-addfb-size-overflow)
[671.945563] Starting subtest: 4-tiled-addfb-size-overflow
[671.947852] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[672.047406] [133/133] (358s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[672.145231] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[672.148134] Starting dynamic subtest: pipe-A
[672.165863] Dynamic subtest pipe-A: SKIP (0.017s)
[672.178173] Starting dynamic subtest: pipe-B
[672.195827] Dynamic subtest pipe-B: SKIP (0.030s)
[672.207750] Starting dynamic subtest: pipe-C
[672.225375] Dynamic subtest pipe-C: SKIP (0.030s)
[672.236714] Starting dynamic subtest: pipe-D
[672.257911] Dynamic subtest pipe-D: SKIP (0.030s)
[672.262268] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.110s)
[672.345249] Closing watchdogs
results: parsing output: 0/ for test: i915_query
results: parsing output: 1/ for test: gem_exec_fence
results: parsing output: 2/ for test: kms_content_protection
results: parsing output: 3/ for test: gem_render_copy
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: gem_exec_suspend
results: parsing output: 6/ for test: kms_pipe_crc_basic
results: parsing output: 7/ for test: kms_addfb_basic
results: parsing output: 8/ for test: gen9_exec_parse
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: gem_create
results: parsing output: 11/ for test: gem_exec_reloc
results: parsing output: 12/ for test: syncobj_eventfd
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: kms_pm_rpm
results: parsing output: 15/ for test: kms_vrr
results: parsing output: 16/ for test: gem_tiled_wb
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_cursor_crc
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_eio
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: kms_async_flips
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: gem_exec_fence
results: parsing output: 28/ for test: gem_exec_parallel
results: parsing output: 29/ for test: kms_cursor_crc
results: parsing output: 30/ for test: syncobj_wait
results: parsing output: 31/ for test: gem_pxp
results: parsing output: 32/ for test: kms_chamelium_hpd
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: api_intel_bb
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_mmap_gtt
results: parsing output: 38/ for test: gem_exec_schedule
results: parsing output: 39/ for test: kms_flip_scaled_crc
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: kms_plane_scaling
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: kms_hdr
results: parsing output: 44/ for test: gem_ctx_bad_destroy
results: parsing output: 45/ for test: intel_hwmon
results: parsing output: 46/ for test: i915_pm_rpm
results: parsing output: 47/ for test: drm_read
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: prime_mmap_coherency
results: parsing output: 51/ for test: i915_hangman
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: kms_psr2_sf
results: parsing output: 54/ for test: kms_invalid_mode
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_spin_batch
results: parsing output: 57/ for test: kms_cursor_legacy
results: parsing output: 58/ for test: syncobj_wait
results: parsing output: 59/ for test: kms_psr2_sf
results: parsing output: 60/ for test: kms_flip
results: parsing output: 61/ for test: gem_exec_reloc
results: parsing output: 62/ for test: perf_pmu
results: parsing output: 63/ for test: kms_cursor_crc
results: parsing output: 64/ for test: kms_flip_scaled_crc
results: parsing output: 65/ for test: kms_lease
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: gem_ctx_param
results: parsing output: 69/ for test: prime_busy
results: parsing output: 70/ for test: gem_flink_basic
results: parsing output: 71/ for test: gem_exec_schedule
results: parsing output: 72/ for test: kms_flip
results: parsing output: 73/ for test: syncobj_timeline
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gem_mmap_offset
results: parsing output: 76/ for test: prime_mmap
results: parsing output: 77/ for test: gem_ctx_isolation
results: parsing output: 78/ for test: gem_exec_params
results: parsing output: 79/ for test: gen3_render_tiledy_blits
results: parsing output: 80/ for test: kms_ccs
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: kms_pipe_b_c_ivb
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_prop_blob
results: parsing output: 85/ for test: gem_basic
results: parsing output: 86/ for test: gem_madvise
results: parsing output: 87/ for test: kms_chamelium_edid
results: parsing output: 88/ for test: gem_partial_pwrite_pread
results: parsing output: 89/ for test: kms_plane
results: parsing output: 90/ for test: kms_selftest
results: parsing output: 91/ for test: api_intel_bb
results: parsing output: 92/ for test: gem_softpin
results: parsing output: 93/ for test: kms_plane_lowres
results: parsing output: 94/ for test: gem_userptr_blits
results: parsing output: 95/ for test: sysfs_heartbeat_interval
results: parsing output: 96/ for test: i915_drm_fdinfo
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_exec_balancer
results: parsing output: 100/ for test: gem_exec_whisper
results: parsing output: 101/ for test: gem_ctx_persistence
results: parsing output: 102/ for test: gem_pxp
results: parsing output: 103/ for test: syncobj_wait
results: parsing output: 104/ for test: gem_mmap_wc
results: parsing output: 105/ for test: kms_cursor_legacy
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: kms_rotation_crc
results: parsing output: 109/ for test: gem_softpin
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: kms_cursor_legacy
results: parsing output: 112/ for test: gem_ctx_shared
results: parsing output: 113/ for test: gem_busy
results: parsing output: 114/ for test: kms_color_pipeline
results: parsing output: 115/ for test: kms_draw_crc
results: parsing output: 116/ for test: vgem_basic
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: gem_exec_schedule
results: parsing output: 119/ for test: gem_exec_schedule
results: parsing output: 120/ for test: gem_ppgtt
results: parsing output: 121/ for test: perf_pmu
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_eio
results: parsing output: 126/ for test: gem_lmem_swapping
results: parsing output: 127/ for test: dmabuf_sync_file
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: kms_psr2_sf
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_big_fb
results: parsing output: 132/ for test: kms_plane_scaling
Done.