[69.945375] Initializing watchdogs
[69.945418]   /dev/watchdog0
[69.958537] [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]
[69.962766] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[69.965059] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[69.968190] [001/133] (960s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[70.088323] Starting subtest: nonblocking-crc-frame-sequence
[70.090475] Starting dynamic subtest: pipe-A-eDP-1
[70.862417] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.772s)
[70.869303] Starting dynamic subtest: pipe-B-eDP-1
[72.251139] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.387s)
[72.260838] Starting dynamic subtest: pipe-C-eDP-1
[73.647614] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.395s)
[73.656666] Starting dynamic subtest: pipe-D-eDP-1
[74.986085] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.338s)
[74.988305] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.896s)
[75.794849] [002/133] (954s left) i915_module_load (reload)
[75.825067] Starting subtest: reload
[79.145071] Subtest reload: SUCCESS (3.322s)
[79.180622] [003/133] (951s left) gem_eio (in-flight-1us)
[80.915846] Starting subtest: in-flight-1us
[88.778029] Subtest in-flight-1us: SUCCESS (7.862s)
[88.907109] [FACT gem_eio (in-flight-1us)] new: kernel.kmod_is_loaded.vgem: true
[88.910286] [004/133] (941s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[89.008967] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[90.053480] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.044s)
[90.207053] [005/133] (940s left) kms_addfb_basic (bad-pitch-1024)
[90.255058] Starting subtest: bad-pitch-1024
[90.256827] Subtest bad-pitch-1024: SUCCESS (0.000s)
[90.415860] [006/133] (940s left) kms_getfb (getfb2-handle-zero)
[90.515220] Starting subtest: getfb2-handle-zero
[90.517211] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[90.638706] [007/133] (940s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[90.688116] Starting subtest: single-wait-all-for-submit-signaled
[90.689781] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[90.820418] [008/133] (939s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[90.878312] Starting subtest: invalid-multi-wait-all-unsubmitted
[90.880370] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[91.002058] [009/133] (939s left) kms_atomic_interruptible (universal-setplane-cursor)
[91.096249] Starting subtest: universal-setplane-cursor
[91.098279] Starting dynamic subtest: pipe-A-eDP-1
[98.498866] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.401s)
[98.501340] Subtest universal-setplane-cursor: SUCCESS (7.402s)
[99.352682] [010/133] (931s left) gem_exec_reloc (basic-wc-cpu)
[99.419893] Subtest basic-wc-cpu: SKIP (0.000s)
[99.498196] [011/133] (931s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[99.603444] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[99.607714] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[99.709327] [012/133] (931s left) gem_pxp (hw-rejects-pxp-buffer)
[99.841692] Starting subtest: hw-rejects-pxp-buffer
[99.846349] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[99.955221] [013/133] (930s left) gem_exec_balancer (invalid-bonds)
[100.018836] Starting subtest: invalid-bonds
[100.023238] Subtest invalid-bonds: SKIP (0.000s)
[100.322238] [014/133] (930s left) gem_exec_whisper (basic-forked-all)
[100.405632] Starting subtest: basic-forked-all
[113.947874] Subtest basic-forked-all: SUCCESS (13.539s)
[114.139242] [015/133] (916s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[114.245664] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[120.789351] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.547s)
[120.933827] [016/133] (910s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[121.024260] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[127.775102] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.752s)
[127.926651] [017/133] (903s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[128.027718] Starting subtest: psr-rgb565-draw-render
[135.067569] Subtest psr-rgb565-draw-render: SUCCESS (7.050s)
[135.212719] [018/133] (895s left) kms_psr (pr-cursor-mmap-cpu)
[135.306079] Starting subtest: pr-cursor-mmap-cpu
[135.310135] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[135.386471] [019/133] (895s left) gem_close_race (basic-process)
[135.453592] Starting subtest: basic-process
[135.515173] Subtest basic-process: SUCCESS (0.061s)
[135.707799] [020/133] (895s left) syncobj_timeline (etime-single-wait-all-submitted)
[135.766192] Starting subtest: etime-single-wait-all-submitted
[135.874082] Subtest etime-single-wait-all-submitted: SUCCESS (0.107s)
[135.961189] [021/133] (895s left) kms_cursor_crc (cursor-random-128x42)
[136.206444] Starting subtest: cursor-random-128x42
[136.250753] Subtest cursor-random-128x42: SKIP (0.043s)
[136.480973] [022/133] (894s left) syncobj_timeline (invalid-wait-bad-flags)
[136.542225] Starting subtest: invalid-wait-bad-flags
[136.544704] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[136.656116] [023/133] (894s left) gem_sync (basic-all)
[136.734304] Starting subtest: basic-all
[139.120207] Subtest basic-all: SUCCESS (2.396s)
[139.318127] [024/133] (892s left) kms_big_fb (linear-16bpp-rotate-90)
[139.435450] Starting subtest: linear-16bpp-rotate-90
[139.454926] Subtest linear-16bpp-rotate-90: SKIP (0.019s)
[139.605351] [025/133] (891s left) gem_flink_basic (bad-flink)
[139.665253] Starting subtest: bad-flink
[139.667362] Subtest bad-flink: SUCCESS (0.000s)
[139.805912] [026/133] (891s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[139.919140] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[139.923099] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[140.040716] [027/133] (891s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[140.434269] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[141.274493] [028/133] (890s left) gem_exec_fence (syncobj-invalid-wait)
[141.692666] Starting subtest: syncobj-invalid-wait
[141.695221] Subtest syncobj-invalid-wait: SUCCESS (0.000s)
[143.043324] [029/133] (888s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[143.152328] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[144.020507] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.870s)
[144.239591] [030/133] (887s left) gem_exec_schedule (implicit-boths)
[144.318180] Starting subtest: implicit-boths
[144.320392] Starting dynamic subtest: rcs0
[144.425722] Dynamic subtest rcs0: SUCCESS (0.114s)
[144.435823] Starting dynamic subtest: vcs0
[144.507618] Dynamic subtest vcs0: SUCCESS (0.081s)
[144.518758] Starting dynamic subtest: vcs1
[144.588404] Dynamic subtest vcs1: SUCCESS (0.081s)
[144.599311] Starting dynamic subtest: vecs0
[144.685667] Dynamic subtest vecs0: SUCCESS (0.096s)
[144.695871] Starting dynamic subtest: ccs0
[144.778626] Dynamic subtest ccs0: SUCCESS (0.092s)
[144.781202] Subtest implicit-boths: SUCCESS (0.467s)
[146.070035] [031/133] (885s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[146.176356] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[147.158396] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (0.982s)
[147.312236] [032/133] (884s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[147.415453] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[147.419876] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[147.547835] [033/133] (884s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[147.660577] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[147.663875] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[147.784650] [034/133] (883s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[147.878931] Starting subtest: fbc-rgb101010-draw-blt
[152.479766] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.603s)
[153.700077] [035/133] (878s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[153.804846] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[153.807281] Starting dynamic subtest: pipe-A
[153.868759] Dynamic subtest pipe-A: SUCCESS (0.066s)
[153.884192] Starting dynamic subtest: pipe-B
[154.996629] Dynamic subtest pipe-B: SUCCESS (1.127s)
[155.007933] Starting dynamic subtest: pipe-C
[156.101475] Dynamic subtest pipe-C: SUCCESS (1.104s)
[156.109911] Starting dynamic subtest: pipe-D
[157.238979] Dynamic subtest pipe-D: SUCCESS (1.137s)
[157.242036] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.437s)
[158.418330] [036/133] (873s left) gem_userptr_blits (probe)
[158.502567] Starting subtest: probe
[158.574819] Subtest probe: SUCCESS (0.072s)
[158.722186] [037/133] (873s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[158.830645] Starting subtest: yf-tiled-8bpp-rotate-270
[158.834860] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[158.941180] [038/133] (872s left) gem_eio (wait-wedge-1us)
[159.189226] Starting subtest: wait-wedge-1us
[160.995701] Subtest wait-wedge-1us: SUCCESS (1.807s)
[161.156710] [039/133] (870s left) syncobj_wait (invalid-signal-one-illegal-handle)
[161.222824] Starting subtest: invalid-signal-one-illegal-handle
[161.225396] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[161.325936] [040/133] (870s left) gem_exec_parallel (basic)
[161.392155] Starting subtest: basic
[161.394575] Starting dynamic subtest: rcs0
[162.846147] Dynamic subtest rcs0: SUCCESS (1.453s)
[162.857868] Starting dynamic subtest: bcs0
[164.300373] Dynamic subtest bcs0: SUCCESS (1.452s)
[164.312319] Starting dynamic subtest: vcs0
[165.878850] Dynamic subtest vcs0: SUCCESS (1.575s)
[165.890454] Starting dynamic subtest: vcs1
[167.894391] Dynamic subtest vcs1: SUCCESS (2.013s)
[167.908935] Starting dynamic subtest: vecs0
[169.878416] Dynamic subtest vecs0: SUCCESS (1.982s)
[169.890424] Starting dynamic subtest: ccs0
[171.398024] Dynamic subtest ccs0: SUCCESS (1.519s)
[171.400705] Subtest basic: SUCCESS (10.005s)
[171.593874] [041/133] (860s left) gem_ccs (ctrl-surf-copy)
[171.653065] Starting subtest: ctrl-surf-copy
[171.657383] Subtest ctrl-surf-copy: SKIP (0.000s)
[171.762074] [042/133] (860s left) gem_exec_fence (basic-busy-all)
[171.827042] Starting subtest: basic-busy-all
[171.942189] Subtest basic-busy-all: SUCCESS (0.116s)
[174.027547] [043/133] (858s left) kms_psr (psr2-primary-blt)
[174.128947] Starting subtest: psr2-primary-blt
[174.131115] Starting dynamic subtest: eDP-1
[175.877907] Dynamic subtest eDP-1: SUCCESS (1.747s)
[175.880229] Subtest psr2-primary-blt: SUCCESS (1.748s)
[176.759803] [044/133] (855s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[176.814936] Starting subtest: single-wait-for-submit-unsubmitted
[176.922383] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.107s)
[177.029048] [045/133] (855s left) kms_flip (flip-vs-rmfb-interruptible)
[177.119102] Starting subtest: flip-vs-rmfb-interruptible
[177.121524] Starting dynamic subtest: A-eDP1
[185.734066] Dynamic subtest A-eDP1: SUCCESS (8.615s)
[185.743903] Starting dynamic subtest: B-eDP1
[194.364067] Dynamic subtest B-eDP1: SUCCESS (8.629s)
[194.373261] Starting dynamic subtest: C-eDP1
[202.977254] Dynamic subtest C-eDP1: SUCCESS (8.612s)
[202.986595] Starting dynamic subtest: D-eDP1
[211.608478] Dynamic subtest D-eDP1: SUCCESS (8.629s)
[211.613057] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.495s)
[212.793347] [046/133] (819s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[212.911446] Starting subtest: cursor-vs-flip-varying-size
[243.597594] Subtest cursor-vs-flip-varying-size: SUCCESS (30.688s)
[244.419449] [047/133] (787s left) i915_query (hwconfig_table)
[244.486593] Starting subtest: hwconfig_table
[244.789074] Subtest hwconfig_table: SUCCESS (0.002s)
[244.828131] [048/133] (787s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[244.948427] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[244.952401] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[245.063843] [049/133] (787s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[245.196469] Starting subtest: cursorB-vs-flipB-atomic
[245.201053] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[245.378865] [050/133] (787s left) gen9_exec_parse (valid-registers)
[245.448826] Subtest valid-registers: SKIP (0.000s)
[245.542729] [051/133] (786s left) kms_addfb_basic (bo-too-small)
[245.645590] Starting subtest: bo-too-small
[245.647462] Subtest bo-too-small: SUCCESS (0.000s)
[245.785202] [052/133] (786s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[245.887143] Starting subtest: y-tiled-8bpp-rotate-0
[245.891069] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[246.014457] [053/133] (786s left) gem_linear_blits (interruptible)
[246.404079] Starting subtest: interruptible
[250.832603] Subtest interruptible: SUCCESS (4.426s)
[251.003469] [054/133] (781s left) gem_create (hog-create)
[251.112335] Starting subtest: hog-create
[251.114277] Starting dynamic subtest: smem0
[284.897638] Dynamic subtest smem0: SUCCESS (33.786s)
[284.900613] Subtest hog-create: SUCCESS (33.788s)
[285.097912] [055/133] (747s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[285.160830] Starting subtest: multi-wait-all-for-submit-submitted
[285.265951] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.103s)
[285.357254] [056/133] (747s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[285.469606] Starting subtest: fbcpsr-rgb565-draw-pwrite
[292.458615] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (6.991s)
[292.592969] [057/133] (740s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[292.692121] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[292.694389] Starting dynamic subtest: pipe-A-eDP-1
[292.755166] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.063s)
[292.768761] Starting dynamic subtest: pipe-B-eDP-1
[292.817165] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.060s)
[292.830700] Starting dynamic subtest: pipe-C-eDP-1
[292.881281] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.064s)
[292.891146] Starting dynamic subtest: pipe-D-eDP-1
[292.950480] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.068s)
[292.952689] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.260s)
[295.277010] [058/133] (737s left) gem_exec_balancer (parallel-ordering)
[295.540192] Starting subtest: parallel-ordering
[296.464821] Subtest parallel-ordering: SUCCESS (0.925s)
[296.609175] [059/133] (736s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[296.713607] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[301.177227] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.468s)
[302.392831] [060/133] (730s left) kms_addfb_basic (basic-x-tiled-legacy)
[302.451071] Starting subtest: basic-x-tiled-legacy
[302.455404] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[302.605743] [061/133] (730s left) perf (polling)
[302.749258] Starting subtest: polling
[302.751480] Starting dynamic subtest: 0-rcs0
[312.783672] Dynamic subtest 0-rcs0: SUCCESS (10.033s)
[312.793534] Starting dynamic subtest: 1-vecs0
[322.857083] Dynamic subtest 1-vecs0: SUCCESS (10.021s)
[322.859586] Subtest polling: SUCCESS (20.056s)
[322.901720] [062/133] (710s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[323.002481] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[323.004695] Starting dynamic subtest: pipe-A-eDP-1
[325.135723] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.135s)
[325.144681] Starting dynamic subtest: pipe-B-eDP-1
[327.442497] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.306s)
[327.453154] Starting dynamic subtest: pipe-C-eDP-1
[329.510669] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.067s)
[329.520511] Starting dynamic subtest: pipe-D-eDP-1
[331.584332] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.073s)
[331.586197] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.585s)
[332.819396] [063/133] (700s left) api_intel_bb (simple-bb-ctx)
[332.870375] Starting subtest: simple-bb-ctx
[332.885431] Subtest simple-bb-ctx: SUCCESS (0.017s)
[333.035868] [064/133] (699s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[333.136179] Starting subtest: plane-primary-overlay-mutable-zpos
[336.538135] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.400s)
[337.747654] [065/133] (695s left) kms_pm_rpm (pm-caching)
[340.078071] Starting subtest: pm-caching
[340.083123] Subtest pm-caching: SKIP (0.000s)
[340.459931] [066/133] (692s left) gem_ctx_persistence (engines-hang)
[340.517065] Starting subtest: engines-hang
[340.519348] Starting dynamic subtest: rcs0
[340.628241] Dynamic subtest rcs0: SUCCESS (0.111s)
[340.643276] Starting dynamic subtest: bcs0
[340.749589] Dynamic subtest bcs0: SUCCESS (0.119s)
[340.760464] Starting dynamic subtest: vcs0
[340.868815] Dynamic subtest vcs0: SUCCESS (0.117s)
[340.881360] Starting dynamic subtest: vcs1
[340.986830] Dynamic subtest vcs1: SUCCESS (0.115s)
[340.998753] Starting dynamic subtest: vecs0
[341.109924] Dynamic subtest vecs0: SUCCESS (0.120s)
[341.121979] Starting dynamic subtest: ccs0
[341.183667] Dynamic subtest ccs0: SUCCESS (0.072s)
[341.186071] Subtest engines-hang: SUCCESS (0.668s)
[341.332177] [067/133] (691s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[341.435266] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[341.437173] Starting dynamic subtest: pipe-A
[341.454282] Dynamic subtest pipe-A: SKIP (0.016s)
[341.463121] Starting dynamic subtest: pipe-B
[341.485768] Dynamic subtest pipe-B: SKIP (0.030s)
[341.494998] Starting dynamic subtest: pipe-C
[341.517057] Dynamic subtest pipe-C: SKIP (0.029s)
[341.526323] Starting dynamic subtest: pipe-D
[341.547088] Dynamic subtest pipe-D: SKIP (0.031s)
[341.550239] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.110s)
[341.665646] [068/133] (691s left) api_intel_allocator (fork-simple-once)
[341.720356] Starting subtest: fork-simple-once
[341.735512] Subtest fork-simple-once: SUCCESS (0.017s)
[341.914660] [069/133] (691s left) gem_pread (self)
[341.979464] Subtest self: SKIP (0.000s)
[342.048505] [070/133] (691s left) gem_exec_schedule (preempt-other-chain)
[342.122747] Starting subtest: preempt-other-chain
[342.124681] Starting dynamic subtest: rcs0
[342.195965] Dynamic subtest rcs0: SUCCESS (0.078s)
[342.209406] Starting dynamic subtest: bcs0
[342.274610] Dynamic subtest bcs0: SUCCESS (0.078s)
[342.284445] Starting dynamic subtest: vcs0
[342.359937] Dynamic subtest vcs0: SUCCESS (0.083s)
[342.373257] Starting dynamic subtest: vcs1
[342.438650] Dynamic subtest vcs1: SUCCESS (0.078s)
[342.451478] Starting dynamic subtest: vecs0
[342.520856] Dynamic subtest vecs0: SUCCESS (0.081s)
[342.534857] Starting dynamic subtest: ccs0
[342.598269] Dynamic subtest ccs0: SUCCESS (0.077s)
[342.601367] Subtest preempt-other-chain: SUCCESS (0.481s)
[344.000222] [071/133] (689s left) gem_ctx_persistence (legacy-engines-mixed)
[344.069270] Starting subtest: legacy-engines-mixed
[344.071609] Starting dynamic subtest: render
[344.209730] Dynamic subtest render: SUCCESS (0.140s)
[344.224965] Starting dynamic subtest: bsd1
[344.290692] Dynamic subtest bsd1: SUCCESS (0.078s)
[344.305627] Starting dynamic subtest: bsd2
[344.366771] Dynamic subtest bsd2: SUCCESS (0.073s)
[344.378307] Starting dynamic subtest: blt
[344.451919] Dynamic subtest blt: SUCCESS (0.083s)
[344.466781] Starting dynamic subtest: vebox
[344.525833] Dynamic subtest vebox: SUCCESS (0.071s)
[344.528613] Subtest legacy-engines-mixed: SUCCESS (0.458s)
[344.617909] [072/133] (688s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[344.727046] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[351.609027] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.885s)
[351.745769] [073/133] (681s left) gem_mmap_gtt (bad-object)
[351.816885] Subtest bad-object: SKIP (0.000s)
[351.888909] [074/133] (681s left) kms_psr (fbc-psr-basic)
[351.977153] Starting subtest: fbc-psr-basic
[351.979275] Starting dynamic subtest: eDP-1
[351.983118] Dynamic subtest eDP-1: SKIP (0.000s)
[351.987119] Subtest fbc-psr-basic: SKIP (0.001s)
[352.061197] [075/133] (681s left) gem_userptr_blits (access-control)
[352.153128] Starting subtest: access-control
[352.157615] Subtest access-control: SKIP (0.000s)
[352.313133] [076/133] (681s left) gem_ctx_param (non-root-set)
[352.359637] Starting subtest: non-root-set
[352.377586] Subtest non-root-set: SUCCESS (0.018s)
[352.478243] [077/133] (681s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[352.582706] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[359.831816] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.251s)
[359.993444] [078/133] (673s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[360.092761] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[360.095065] Starting dynamic subtest: pipe-A-eDP-1
[360.116950] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[360.127579] Starting dynamic subtest: pipe-B-eDP-1
[360.148154] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[360.156743] Starting dynamic subtest: pipe-C-eDP-1
[360.177469] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[360.185979] Starting dynamic subtest: pipe-D-eDP-1
[360.207540] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[360.211876] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[362.297284] [079/133] (671s left) core_setmaster (master-drop-set-user)
[362.399069] Starting subtest: master-drop-set-user
[362.413771] Subtest master-drop-set-user: SUCCESS (0.015s)
[362.454892] [080/133] (671s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[362.543207] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[362.569554] Starting dynamic subtest: pipe-A-plane-0
[362.574136] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[362.585528] Starting dynamic subtest: pipe-A-plane-3
[362.589815] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[362.599026] Starting dynamic subtest: pipe-A-plane-5
[362.603446] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[363.648890] Starting dynamic subtest: pipe-B-plane-0
[363.652820] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[363.661673] Starting dynamic subtest: pipe-B-plane-3
[363.666066] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[363.674620] Starting dynamic subtest: pipe-B-plane-5
[363.678936] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[363.961602] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (1.416s)
[364.836231] [081/133] (668s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[364.936952] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[364.939274] Starting dynamic subtest: pipe-A-default-mode
[367.651370] Dynamic subtest pipe-A-default-mode: SUCCESS (2.713s)
[367.653697] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.715s)
[368.529179] [082/133] (665s left) syncobj_timeline (reset-unsignaled)
[368.596104] Starting subtest: reset-unsignaled
[368.598316] Subtest reset-unsignaled: SUCCESS (0.000s)
[368.726185] [083/133] (665s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[368.781077] Starting subtest: yf-tiled-to-vebox-x-tiled
[368.785326] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[368.988422] [084/133] (664s left) perf_pmu (busy-idle-check-all)
[369.024675] Starting subtest: busy-idle-check-all
[369.026723] Starting dynamic subtest: rcs0
[369.700382] Dynamic subtest rcs0: SUCCESS (0.677s)
[369.713441] Starting dynamic subtest: bcs0
[370.354414] Dynamic subtest bcs0: SUCCESS (0.652s)
[370.366224] Starting dynamic subtest: vcs0
[371.926341] Dynamic subtest vcs0: SUCCESS (1.568s)
[371.939174] Starting dynamic subtest: vcs1
[373.911729] Dynamic subtest vcs1: SUCCESS (1.982s)
[373.924444] Starting dynamic subtest: vecs0
[375.829952] Dynamic subtest vecs0: SUCCESS (1.915s)
[375.841470] Starting dynamic subtest: ccs0
[376.485896] Dynamic subtest ccs0: SUCCESS (0.654s)
[376.488423] Subtest busy-idle-check-all: SUCCESS (7.464s)
[376.619410] [085/133] (657s left) kms_draw_crc (draw-method-mmap-cpu)
[376.718947] Starting subtest: draw-method-mmap-cpu
[376.721219] Starting dynamic subtest: xrgb8888-untiled
[376.950607] Dynamic subtest xrgb8888-untiled: SUCCESS (0.233s)
[376.960357] Starting dynamic subtest: rgb565-untiled
[377.172880] Dynamic subtest rgb565-untiled: SUCCESS (0.222s)
[377.182296] Starting dynamic subtest: xrgb2101010-untiled
[377.372841] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.198s)
[377.382045] Starting dynamic subtest: xbgr16161616f-untiled
[377.572537] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.199s)
[377.581488] Starting dynamic subtest: xrgb8888-xtiled
[377.694662] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[377.703258] Starting dynamic subtest: rgb565-xtiled
[377.827969] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s)
[377.836758] Starting dynamic subtest: xrgb2101010-xtiled
[377.950328] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[377.960253] Starting dynamic subtest: xbgr16161616f-xtiled
[378.072569] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.121s)
[378.081173] Starting dynamic subtest: xrgb8888-4tiled
[378.216818] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[378.225184] Starting dynamic subtest: rgb565-4tiled
[378.350083] Dynamic subtest rgb565-4tiled: SUCCESS (0.133s)
[378.359618] Starting dynamic subtest: xrgb2101010-4tiled
[378.472546] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.122s)
[378.481627] Starting dynamic subtest: xbgr16161616f-4tiled
[378.606062] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[378.608093] Subtest draw-method-mmap-cpu: SUCCESS (1.890s)
[378.722195] [086/133] (655s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[378.825360] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[378.851877] Starting dynamic subtest: pipe-A-plane-0
[379.151611] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s)
[379.160980] Starting dynamic subtest: pipe-A-plane-3
[379.395797] Dynamic subtest pipe-A-plane-3: SUCCESS (0.244s)
[379.404580] Starting dynamic subtest: pipe-A-plane-5
[379.408140] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[380.504843] Starting dynamic subtest: pipe-B-plane-0
[380.804101] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s)
[380.814392] Starting dynamic subtest: pipe-B-plane-3
[381.037408] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[381.046580] Starting dynamic subtest: pipe-B-plane-5
[381.050926] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[381.346980] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.520s)
[382.185449] [087/133] (651s left) kms_joiner (invalid-modeset-force-big-joiner)
[382.291526] Starting subtest: invalid-modeset-force-big-joiner
[382.295587] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[382.383578] [088/133] (651s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[382.480991] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[382.483143] Starting dynamic subtest: pipe-A-default-mode
[383.642273] Dynamic subtest pipe-A-default-mode: SKIP (1.157s)
[383.646635] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.158s)
[383.832153] [089/133] (650s left) gem_ctx_shared (single-timeline)
[383.902023] Starting subtest: single-timeline
[383.920857] Subtest single-timeline: SUCCESS (0.014s)
[384.181810] [090/133] (649s left) vgem_basic (unload)
[384.218121] Starting subtest: unload
[413.425499] Subtest unload: SUCCESS (29.160s)
[413.484577] [091/133] (620s left) gem_spin_batch (legacy-resubmit-new)
[413.564945] Starting subtest: legacy-resubmit-new
[413.567545] Starting dynamic subtest: default
[413.577536] Dynamic subtest default: SUCCESS (0.012s)
[413.588279] Starting dynamic subtest: render
[413.590138] Dynamic subtest render: SUCCESS (0.005s)
[413.599192] Starting dynamic subtest: bsd
[413.601389] Dynamic subtest bsd: SUCCESS (0.007s)
[413.610518] Starting dynamic subtest: bsd1
[413.612683] Dynamic subtest bsd1: SUCCESS (0.008s)
[413.621657] Starting dynamic subtest: bsd2
[413.623530] Dynamic subtest bsd2: SUCCESS (0.004s)
[413.632160] Starting dynamic subtest: blt
[413.634033] Dynamic subtest blt: SUCCESS (0.008s)
[413.642648] Starting dynamic subtest: vebox
[413.644523] Dynamic subtest vebox: SUCCESS (0.006s)
[413.646386] Subtest legacy-resubmit-new: SUCCESS (0.056s)
[414.924406] [092/133] (619s left) kms_psr (fbc-pr-dpms)
[415.023055] Starting subtest: fbc-pr-dpms
[415.027468] Subtest fbc-pr-dpms: SKIP (0.000s)
[415.119366] [093/133] (619s left) kms_cursor_crc (cursor-offscreen-128x128)
[415.358695] Starting subtest: cursor-offscreen-128x128
[415.360840] Starting dynamic subtest: pipe-A-eDP-1
[417.301463] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.939s)
[417.327780] Starting dynamic subtest: pipe-D-eDP-1
[419.909205] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.586s)
[419.911045] Subtest cursor-offscreen-128x128: SUCCESS (4.551s)
[420.778084] [094/133] (613s left) gem_exec_reloc (basic-cpu)
[420.844140] Subtest basic-cpu: SKIP (0.000s)
[420.914240] [095/133] (613s left) syncobj_wait (invalid-wait-illegal-handle)
[420.974960] Starting subtest: invalid-wait-illegal-handle
[420.977294] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[421.106784] [096/133] (613s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[421.207114] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[425.563108] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.359s)
[426.767474] [097/133] (607s left) gem_ctx_param (set-priority-not-supported)
[426.828079] Starting subtest: set-priority-not-supported
[426.832766] Subtest set-priority-not-supported: SKIP (0.000s)
[426.916563] [098/133] (607s left) kms_chamelium_color (ctm-max)
[427.022256] Subtest ctm-max: SKIP (0.000s)
[427.080091] [099/133] (607s left) sriov_basic (enable-vfs-autoprobe-on)
[427.153802] Starting subtest: enable-vfs-autoprobe-on
[427.156163] Starting dynamic subtest: numvfs-1
[427.235758] Dynamic subtest numvfs-1: FAIL (0.030s)
[427.245524] Starting dynamic subtest: numvfs-2
[427.314875] Dynamic subtest numvfs-2: FAIL (0.004s)
[427.324982] Starting dynamic subtest: numvfs-3
[427.393569] Dynamic subtest numvfs-3: FAIL (0.003s)
[427.402707] Starting dynamic subtest: numvfs-4
[427.476541] Dynamic subtest numvfs-4: FAIL (0.003s)
[427.485868] Starting dynamic subtest: numvfs-5
[427.554632] Dynamic subtest numvfs-5: FAIL (0.004s)
[427.563639] Starting dynamic subtest: numvfs-6
[427.632088] Dynamic subtest numvfs-6: FAIL (0.004s)
[427.641781] Starting dynamic subtest: numvfs-7
[427.705320] Dynamic subtest numvfs-7: FAIL (0.003s)
[427.713846] Starting dynamic subtest: numvfs-random
[427.771444] Dynamic subtest numvfs-random: FAIL (0.003s)
[427.781474] Starting dynamic subtest: numvfs-all
[427.840130] Dynamic subtest numvfs-all: FAIL (0.483s)
[427.841829] Subtest enable-vfs-autoprobe-on: FAIL (0.547s)
[427.898289] [100/133] (606s left) kms_frontbuffer_tracking (fbc-tiling-y)
[427.992636] Starting subtest: fbc-tiling-y
[427.996102] Subtest fbc-tiling-y: SKIP (0.000s)
[428.097783] [101/133] (606s left) kms_cursor_edge_walk (128x128-left-edge)
[428.189978] Starting subtest: 128x128-left-edge
[428.191800] Starting dynamic subtest: pipe-A-eDP-1
[431.607596] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.416s)
[431.616838] Starting dynamic subtest: pipe-D-eDP-1
[434.731706] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.122s)
[434.733962] Subtest 128x128-left-edge: SUCCESS (6.541s)
[435.548846] [102/133] (599s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[435.648582] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[440.101223] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.457s)
[441.248956] [103/133] (593s left) kms_debugfs (display-on-read-all)
[441.345230] Starting subtest: display-on-read-all
[441.499088] Subtest display-on-read-all: SUCCESS (0.154s)
[441.635353] [104/133] (593s left) kms_flip (2x-plain-flip-fb-recreate)
[441.725803] Starting subtest: 2x-plain-flip-fb-recreate
[441.734750] Subtest 2x-plain-flip-fb-recreate: SKIP (0.010s)
[441.828834] [105/133] (592s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[441.937655] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[441.941753] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[442.067947] [106/133] (592s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[442.111398] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[442.113650] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[442.236256] [107/133] (592s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[442.331946] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[442.343146] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.010s)
[442.427898] [108/133] (592s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[442.516489] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[442.518103] Starting dynamic subtest: pipe-A-eDP-1
[442.537324] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.019s)
[442.547062] Starting dynamic subtest: pipe-B-eDP-1
[442.563449] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[442.572723] Starting dynamic subtest: pipe-C-eDP-1
[442.589269] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.019s)
[442.598499] Starting dynamic subtest: pipe-D-eDP-1
[442.615502] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.019s)
[442.617369] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.083s)
[444.913519] [109/133] (590s left) kms_lease (invalid-create-leases)
[445.009454] Starting subtest: invalid-create-leases
[445.015604] Subtest invalid-create-leases: SUCCESS (0.006s)
[445.147976] [110/133] (589s left) kms_selftest (drm_dp_mst_helper)
[445.188212] Starting subtest: drm_dp_mst_helper
[445.201038] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[445.344586] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.143s)
[445.353226] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[445.500614] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.156s)
[445.509582] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[445.643832] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.142s)
[445.646189] Subtest drm_dp_mst_helper: SUCCESS (0.456s)
[445.813927] [111/133] (589s left) gen7_exec_parse (oacontrol-tracking)
[445.864157] Subtest oacontrol-tracking: SKIP (0.000s)
[445.956656] [112/133] (589s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[446.047078] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[446.050938] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[446.151813] [113/133] (588s left) gem_exec_schedule (thriceslice)
[446.224961] Starting subtest: thriceslice
[446.227305] Starting dynamic subtest: rcs0
[446.243228] Dynamic subtest rcs0: SUCCESS (0.029s)
[446.255202] Starting dynamic subtest: bcs0
[446.294763] Dynamic subtest bcs0: SUCCESS (0.051s)
[446.306915] Starting dynamic subtest: vcs0
[446.325403] Dynamic subtest vcs0: SUCCESS (0.029s)
[446.334113] Starting dynamic subtest: vcs1
[446.354855] Dynamic subtest vcs1: SUCCESS (0.028s)
[446.363877] Starting dynamic subtest: vecs0
[446.405984] Dynamic subtest vecs0: SUCCESS (0.050s)
[446.418173] Starting dynamic subtest: ccs0
[446.437458] Dynamic subtest ccs0: SUCCESS (0.030s)
[446.439659] Subtest thriceslice: SUCCESS (0.225s)
[446.760102] [114/133] (588s left) syncobj_eventfd (invalid-illegal-eventfd)
[446.826218] Starting subtest: invalid-illegal-eventfd
[446.828280] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[446.940278] [115/133] (588s left) kms_psr (psr-sprite-plane-move)
[447.030175] Starting subtest: psr-sprite-plane-move
[447.032493] Starting dynamic subtest: eDP-1
[448.818592] Dynamic subtest eDP-1: SUCCESS (1.788s)
[448.820523] Subtest psr-sprite-plane-move: SUCCESS (1.789s)
[449.656895] [116/133] (585s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[449.756153] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[449.758271] Starting dynamic subtest: pipe-A-eDP-1
[449.789722] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[449.799715] Starting dynamic subtest: pipe-B-eDP-1
[449.820732] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[449.829510] Starting dynamic subtest: pipe-C-eDP-1
[449.850502] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[449.859128] Starting dynamic subtest: pipe-D-eDP-1
[449.880733] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[449.884827] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[451.935349] [117/133] (583s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[454.064721] Starting subtest: gem-execbuf-stress-pc8
[454.105599] Subtest gem-execbuf-stress-pc8: SKIP (0.040s)
[454.446745] [118/133] (580s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[454.549921] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[454.554991] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[454.667514] [119/133] (580s left) sysfs_timeslice_duration (duration)
[454.727780] Starting subtest: duration
[454.730120] Starting dynamic subtest: vecs0
[468.852147] Dynamic subtest vecs0: SUCCESS (14.121s)
[468.865182] Starting dynamic subtest: ccs0
[482.029916] Dynamic subtest ccs0: SUCCESS (13.177s)
[482.043325] Starting dynamic subtest: vcs0
[495.796253] Dynamic subtest vcs0: SUCCESS (13.761s)
[495.808488] Starting dynamic subtest: bcs0
[508.952569] Dynamic subtest bcs0: SUCCESS (13.147s)
[508.964357] Starting dynamic subtest: rcs0
[522.102219] Dynamic subtest rcs0: SUCCESS (13.156s)
[522.114549] Starting dynamic subtest: vcs1
[535.795711] Dynamic subtest vcs1: SUCCESS (13.690s)
[535.798393] Subtest duration: SUCCESS (81.068s)
[535.886181] [120/133] (499s left) gem_gpgpu_fill (basic)
[535.946787] Starting subtest: basic
[535.949072] Starting dynamic subtest: smem
[535.962680] Dynamic subtest smem: SUCCESS (0.017s)
[535.965070] Subtest basic: SUCCESS (0.019s)
[536.118604] [121/133] (499s left) perf (gen12-group-concurrent-oa-buffer-read)
[536.222989] Starting subtest: gen12-group-concurrent-oa-buffer-read
[546.316477] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.040s)
[546.357133] [122/133] (489s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[546.453769] Starting subtest: fbc-pr-sprite-mmap-cpu
[546.457715] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[546.548305] [123/133] (488s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[546.647529] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[546.649711] Starting dynamic subtest: pipe-A-eDP-1
[546.731522] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[546.742262] Starting dynamic subtest: pipe-B-eDP-1
[547.887539] Dynamic subtest pipe-B-eDP-1: SKIP (1.153s)
[547.892109] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.244s)
[549.086396] [124/133] (486s left) kms_content_protection (dp-mst-type-1)
[549.219743] Starting subtest: dp-mst-type-1
[549.224275] Subtest dp-mst-type-1: SKIP (0.000s)
[549.380017] [125/133] (486s left) kms_pm_lpsp (screens-disabled)
[550.489063] Starting subtest: screens-disabled
[550.493270] Subtest screens-disabled: SKIP (0.000s)
[550.570149] [126/133] (485s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[550.674995] Starting subtest: plane-lut1d-pre-ctm3x4
[550.687803] Starting dynamic subtest: pipe-A-eDP-1
[551.377626] Dynamic subtest pipe-A-eDP-1: FAIL (0.294s)
[552.048085] Starting dynamic subtest: pipe-B-eDP-1
[552.856656] Dynamic subtest pipe-B-eDP-1: FAIL (0.291s)
[553.374649] Starting dynamic subtest: pipe-C-eDP-1
[554.184877] Dynamic subtest pipe-C-eDP-1: FAIL (0.235s)
[554.724788] Starting dynamic subtest: pipe-D-eDP-1
[555.545379] Dynamic subtest pipe-D-eDP-1: FAIL (0.246s)
[555.547435] Subtest plane-lut1d-pre-ctm3x4: FAIL (4.578s)
[556.100318] [127/133] (479s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[556.205085] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area
[556.209141] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[556.288519] [128/133] (479s left) kms_vblank (wait-idle-hang)
[556.390061] Starting subtest: wait-idle-hang
[556.392136] Starting dynamic subtest: pipe-A-eDP-1
[582.670991] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.281s)
[582.684570] Starting dynamic subtest: pipe-D-eDP-1
[607.642052] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.967s)
[607.643962] Subtest wait-idle-hang: SUCCESS (51.253s)
[608.459793] [129/133] (427s left) gem_mmap_gtt (flink-race)
[608.514969] Subtest flink-race: SKIP (0.000s)
[608.568383] [130/133] (427s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[608.668496] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[608.672579] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[608.784917] [131/133] (427s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[609.160702] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[609.954884] [132/133] (425s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[610.049294] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[610.053326] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[610.132408] [133/133] (425s left) kms_addfb_basic (basic)
[610.197727] Starting subtest: basic
[610.200059] Subtest basic: SUCCESS (0.000s)
[610.337540] Closing watchdogs
results: parsing output: 0/ for test: kms_pipe_crc_basic
results: parsing output: 1/ for test: i915_module_load
results: parsing output: 2/ for test: gem_eio
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: kms_addfb_basic
results: parsing output: 5/ for test: kms_getfb
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: syncobj_wait
results: parsing output: 8/ for test: kms_atomic_interruptible
results: parsing output: 9/ for test: gem_exec_reloc
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_pxp
results: parsing output: 12/ for test: gem_exec_balancer
results: parsing output: 13/ for test: gem_exec_whisper
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_psr
results: parsing output: 18/ for test: gem_close_race
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: kms_cursor_crc
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: gem_sync
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: gem_flink_basic
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_chamelium_hpd
results: parsing output: 27/ for test: gem_exec_fence
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: gem_exec_schedule
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_plane_scaling
results: parsing output: 35/ for test: gem_userptr_blits
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: gem_eio
results: parsing output: 38/ for test: syncobj_wait
results: parsing output: 39/ for test: gem_exec_parallel
results: parsing output: 40/ for test: gem_ccs
results: parsing output: 41/ for test: gem_exec_fence
results: parsing output: 42/ for test: kms_psr
results: parsing output: 43/ for test: syncobj_wait
results: parsing output: 44/ for test: kms_flip
results: parsing output: 45/ for test: kms_cursor_legacy
results: parsing output: 46/ for test: i915_query
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_cursor_legacy
results: parsing output: 49/ for test: gen9_exec_parse
results: parsing output: 50/ for test: kms_addfb_basic
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: gem_linear_blits
results: parsing output: 53/ for test: gem_create
results: parsing output: 54/ for test: syncobj_wait
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_ccs
results: parsing output: 57/ for test: gem_exec_balancer
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_addfb_basic
results: parsing output: 60/ for test: perf
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: api_intel_bb
results: parsing output: 63/ for test: kms_atomic
results: parsing output: 64/ for test: kms_pm_rpm
results: parsing output: 65/ for test: gem_ctx_persistence
results: parsing output: 66/ for test: kms_plane_scaling
results: parsing output: 67/ for test: api_intel_allocator
results: parsing output: 68/ for test: gem_pread
results: parsing output: 69/ for test: gem_exec_schedule
results: parsing output: 70/ for test: gem_ctx_persistence
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_mmap_gtt
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: gem_userptr_blits
results: parsing output: 75/ for test: gem_ctx_param
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: core_setmaster
results: parsing output: 79/ for test: kms_plane
results: parsing output: 80/ for test: kms_flip_scaled_crc
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: gem_render_copy
results: parsing output: 83/ for test: perf_pmu
results: parsing output: 84/ for test: kms_draw_crc
results: parsing output: 85/ for test: kms_plane
results: parsing output: 86/ for test: kms_joiner
results: parsing output: 87/ for test: kms_flip_scaled_crc
results: parsing output: 88/ for test: gem_ctx_shared
results: parsing output: 89/ for test: vgem_basic
results: parsing output: 90/ for test: gem_spin_batch
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: kms_cursor_crc
results: parsing output: 93/ for test: gem_exec_reloc
results: parsing output: 94/ for test: syncobj_wait
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_ctx_param
results: parsing output: 97/ for test: kms_chamelium_color
results: parsing output: 98/ for test: sriov_basic
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_cursor_edge_walk
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_debugfs
results: parsing output: 103/ for test: kms_flip
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: syncobj_wait
results: parsing output: 106/ for test: kms_flip
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: kms_lease
results: parsing output: 109/ for test: kms_selftest
results: parsing output: 110/ for test: gen7_exec_parse
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: gem_exec_schedule
results: parsing output: 113/ for test: syncobj_eventfd
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: i915_pm_rpm
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: sysfs_timeslice_duration
results: parsing output: 119/ for test: gem_gpgpu_fill
results: parsing output: 120/ for test: perf
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: kms_psr2_sf
results: parsing output: 123/ for test: kms_content_protection
results: parsing output: 124/ for test: kms_pm_lpsp
results: parsing output: 125/ for test: kms_color_pipeline
results: parsing output: 126/ for test: kms_psr2_sf
results: parsing output: 127/ for test: kms_vblank
results: parsing output: 128/ for test: gem_mmap_gtt
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_chamelium_edid
results: parsing output: 131/ for test: kms_flip_scaled_crc
results: parsing output: 132/ for test: kms_addfb_basic
Done.