[56.602590] Initializing watchdogs
[56.602636]   /dev/watchdog0
[56.617422] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.621698] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.623994] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.627266] [001/133] (960s left) perf_pmu (busy-start)
[56.695587] Starting subtest: busy-start
[56.697411] Starting dynamic subtest: rcs0
[59.273647] Dynamic subtest rcs0: SUCCESS (2.560s)
[59.283068] Starting dynamic subtest: bcs0
[61.822384] Dynamic subtest bcs0: SUCCESS (2.549s)
[61.831737] Starting dynamic subtest: vcs0
[64.917154] Dynamic subtest vcs0: SUCCESS (3.112s)
[64.926666] Starting dynamic subtest: vcs1
[68.883979] Dynamic subtest vcs1: SUCCESS (3.966s)
[68.893966] Starting dynamic subtest: vecs0
[72.916632] Dynamic subtest vecs0: SUCCESS (4.031s)
[72.925815] Starting dynamic subtest: ccs0
[75.488751] Dynamic subtest ccs0: SUCCESS (2.553s)
[75.491277] Subtest busy-start: SUCCESS (18.776s)
[75.597906] [002/133] (941s left) gem_exec_flush (basic-wb-rw-before-default)
[75.678043] Starting subtest: basic-wb-rw-before-default
[81.167886] Subtest basic-wb-rw-before-default: SUCCESS (5.460s)
[81.332084] [003/133] (935s left) kms_lease (lessee-list)
[81.446251] Starting subtest: lessee-list
[81.448645] Starting dynamic subtest: pipe-A-eDP-1
[81.451489] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[81.461864] Starting dynamic subtest: pipe-B-eDP-1
[81.463787] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[81.470546] Starting dynamic subtest: pipe-C-eDP-1
[81.472549] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[81.479276] Starting dynamic subtest: pipe-D-eDP-1
[81.481216] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[81.483073] Subtest lessee-list: SUCCESS (0.010s)
[81.574155] [004/133] (935s left) i915_drm_fdinfo (virtual-busy-hang-all)
[81.621783] Starting subtest: virtual-busy-hang-all
[81.626172] Subtest virtual-busy-hang-all: SKIP (0.000s)
[81.693774] [005/133] (935s left) kms_atomic_interruptible (legacy-setmode)
[81.798772] Starting subtest: legacy-setmode
[81.801102] Starting dynamic subtest: pipe-A-eDP-1
[88.699776] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.898s)
[88.702250] Subtest legacy-setmode: SUCCESS (6.899s)
[89.573700] [006/133] (927s left) kms_color (ctm-max)
[89.687344] Starting subtest: ctm-max
[89.689289] Starting dynamic subtest: pipe-A-eDP-1
[90.411943] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.725s)
[90.420605] Starting dynamic subtest: pipe-B-eDP-1
[91.806786] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.393s)
[91.817736] Starting dynamic subtest: pipe-C-eDP-1
[93.164360] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.358s)
[93.172634] Starting dynamic subtest: pipe-D-eDP-1
[94.489666] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.325s)
[94.492037] Subtest ctm-max: SUCCESS (4.803s)
[95.304355] [007/133] (922s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[95.413241] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[99.678407] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.270s)
[100.813334] [008/133] (916s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[100.916933] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[100.921337] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[101.060164] [009/133] (916s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[101.164042] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[101.166259] Starting dynamic subtest: pipe-A
[101.185417] Dynamic subtest pipe-A: SKIP (0.018s)
[101.192880] Starting dynamic subtest: pipe-B
[101.217113] Dynamic subtest pipe-B: SKIP (0.031s)
[101.226341] Starting dynamic subtest: pipe-C
[101.248889] Dynamic subtest pipe-C: SKIP (0.031s)
[101.256662] Starting dynamic subtest: pipe-D
[101.280957] Dynamic subtest pipe-D: SKIP (0.031s)
[101.284718] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.113s)
[101.384006] [010/133] (916s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[101.482076] Starting subtest: y-tiled-64bpp-rotate-180
[101.486189] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[101.617158] [011/133] (915s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[101.724705] Starting subtest: primary-x-tiled-reflect-x-180
[108.801076] Subtest primary-x-tiled-reflect-x-180: SUCCESS (7.077s)
[109.974847] [012/133] (907s left) kms_flip (2x-flip-vs-expired-vblank)
[110.070851] Starting subtest: 2x-flip-vs-expired-vblank
[110.079594] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[110.190288] [013/133] (907s left) api_intel_allocator (fork-simple-stress)
[110.245928] Starting subtest: fork-simple-stress
[115.695721] Subtest fork-simple-stress: SUCCESS (5.397s)
[115.779256] [014/133] (901s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[115.906746] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[122.472021] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.570s)
[122.632270] [015/133] (895s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[122.732852] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[122.737425] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[122.843072] [016/133] (894s left) gem_mmap (bad-size)
[122.905041] Subtest bad-size: SKIP (0.000s)
[122.965495] [017/133] (894s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[123.031084] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[123.035428] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[123.223321] [018/133] (894s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[123.320770] Starting subtest: psr-2p-primscrn-cur-indfb-move
[123.325342] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[123.468558] [019/133] (894s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[123.570839] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[130.121103] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.554s)
[130.255986] [020/133] (887s left) syncobj_timeline (wait-all-snapshot)
[130.329205] Starting subtest: wait-all-snapshot
[130.409198] Subtest wait-all-snapshot: SUCCESS (0.082s)
[130.512433] [021/133] (887s left) gem_partial_pwrite_pread (reads)
[130.589047] Subtest reads: SKIP (0.000s)
[130.675027] [022/133] (887s left) syncobj_basic (create-signaled)
[130.753454] Starting subtest: create-signaled
[130.755843] Subtest create-signaled: SUCCESS (0.000s)
[130.883549] [023/133] (887s left) kms_chamelium_frames (dp-crc-multiple)
[131.289876] Subtest dp-crc-multiple: SKIP (0.000s)
[132.104220] [024/133] (885s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[132.236702] Starting subtest: cursorA-vs-flipA-varying-size
[143.410997] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.172s)
[144.280549] [025/133] (873s left) gem_ctx_persistence (hang)
[144.347243] Starting subtest: hang
[144.351752] Subtest hang: SKIP (0.000s)
[144.465202] [026/133] (873s left) kms_psr (pr-primary-page-flip)
[144.565785] Starting subtest: pr-primary-page-flip
[144.569776] Subtest pr-primary-page-flip: SKIP (0.000s)
[144.646303] [027/133] (873s left) gem_lmem_swapping (heavy-random)
[144.688606] Subtest heavy-random: SKIP (0.000s)
[144.732945] [028/133] (873s left) kms_addfb_basic (master-rmfb)
[144.793987] Starting subtest: master-rmfb
[144.796031] Subtest master-rmfb: SUCCESS (0.001s)
[144.954345] [029/133] (873s left) kms_addfb_basic (invalid-get-prop-any)
[145.018253] Starting subtest: invalid-get-prop-any
[145.020490] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[145.154845] [030/133] (873s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[145.250238] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[145.252148] Starting dynamic subtest: pipe-A-eDP-1
[145.272592] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[145.281434] Starting dynamic subtest: pipe-B-eDP-1
[145.300329] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[145.307223] Starting dynamic subtest: pipe-C-eDP-1
[145.327210] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[145.333860] Starting dynamic subtest: pipe-D-eDP-1
[145.353809] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[145.357436] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.007s)
[147.533398] [031/133] (870s left) gem_exec_basic (basic)
[147.592334] Starting subtest: basic
[147.594588] Starting dynamic subtest: rcs0-smem
[147.596902] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[147.605793] Starting dynamic subtest: bcs0-smem
[147.607610] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[147.614600] Starting dynamic subtest: vcs0-smem
[147.616454] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[147.623379] Starting dynamic subtest: vcs1-smem
[147.625228] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[147.631961] Starting dynamic subtest: vecs0-smem
[147.633831] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[147.640551] Starting dynamic subtest: ccs0-smem
[147.642443] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[147.644326] Subtest basic: SUCCESS (0.012s)
[148.936514] [032/133] (869s left) gem_mmap_offset (oob-read)
[149.000175] Starting subtest: oob-read
[149.002743] Subtest oob-read: SUCCESS (0.000s)
[149.126979] [033/133] (869s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[149.227162] Starting subtest: bad-pixel-format-yf-tiled-ccs
[149.229393] Starting dynamic subtest: pipe-A-eDP-1
[149.251645] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[149.259589] Starting dynamic subtest: pipe-B-eDP-1
[149.280150] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[149.287818] Starting dynamic subtest: pipe-C-eDP-1
[149.308853] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[149.316061] Starting dynamic subtest: pipe-D-eDP-1
[149.338076] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[149.342070] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.004s)
[151.492157] [034/133] (866s left) kms_cursor_crc (cursor-random-64x21)
[151.670875] Starting subtest: cursor-random-64x21
[151.723750] Subtest cursor-random-64x21: SKIP (0.047s)
[151.982177] [035/133] (866s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[152.096457] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[152.100811] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[152.216402] [036/133] (866s left) kms_plane_alpha_blend (constant-alpha-max)
[152.313839] Starting subtest: constant-alpha-max
[152.605663] Starting dynamic subtest: pipe-A-eDP-1
[153.673354] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.066s)
[153.681429] Starting dynamic subtest: pipe-D-eDP-1
[155.339362] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.663s)
[155.341695] Subtest constant-alpha-max: SUCCESS (3.025s)
[156.152986] [037/133] (862s left) gem_exec_fence (keep-in-fence)
[156.338120] Starting subtest: keep-in-fence
[156.340658] Starting dynamic subtest: rcs0
[156.412379] Dynamic subtest rcs0: SUCCESS (0.073s)
[156.422955] Starting dynamic subtest: bcs0
[156.465285] Dynamic subtest bcs0: SUCCESS (0.051s)
[156.478189] Starting dynamic subtest: vcs0
[157.908953] Dynamic subtest vcs0: SUCCESS (1.439s)
[157.919729] Starting dynamic subtest: vcs1
[159.893869] Dynamic subtest vcs1: SUCCESS (1.982s)
[159.904995] Starting dynamic subtest: vecs0
[161.876601] Dynamic subtest vecs0: SUCCESS (1.981s)
[161.886552] Starting dynamic subtest: ccs0
[162.106954] Dynamic subtest ccs0: SUCCESS (0.229s)
[162.109525] Subtest keep-in-fence: SUCCESS (5.770s)
[164.047060] [FACT gem_exec_fence (keep-in-fence)] new: kernel.kmod_is_loaded.vgem: true
[164.050404] [038/133] (854s left) i915_pm_rps (min-max-config-idle)
[164.111156] Starting subtest: min-max-config-idle
[164.115735] Subtest min-max-config-idle: SKIP (0.002s)
[164.205035] [039/133] (854s left) dumb_buffer (map-invalid-size)
[164.269308] Starting subtest: map-invalid-size
[164.271229] Subtest map-invalid-size: SUCCESS (0.000s)
[164.405349] [040/133] (854s left) gem_mmap_gtt (basic-write-gtt)
[164.463604] Subtest basic-write-gtt: SKIP (0.000s)
[164.531686] [041/133] (854s left) gem_userptr_blits (set-cache-level)
[164.593614] Starting subtest: set-cache-level
[164.597947] Subtest set-cache-level: SKIP (0.000s)
[164.744260] [042/133] (853s left) kms_psr (psr-primary-render)
[164.833031] Starting subtest: psr-primary-render
[164.835320] Starting dynamic subtest: eDP-1
[166.549366] Dynamic subtest eDP-1: SUCCESS (1.716s)
[166.551721] Subtest psr-primary-render: SUCCESS (1.717s)
[167.440974] [043/133] (851s left) gem_create (create-ext-placement-sanity-check)
[167.614811] Starting subtest: create-ext-placement-sanity-check
[167.617263] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s)
[167.738901] [044/133] (851s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[167.830372] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[167.841752] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[167.964041] [045/133] (850s left) gem_exec_schedule (u-lateslice)
[168.041121] Starting subtest: u-lateslice
[168.043279] Starting dynamic subtest: rcs0
[168.053516] Dynamic subtest rcs0: SUCCESS (0.021s)
[168.061975] Starting dynamic subtest: bcs0
[168.071196] Dynamic subtest bcs0: SUCCESS (0.017s)
[168.079141] Starting dynamic subtest: vcs0
[168.087910] Dynamic subtest vcs0: SUCCESS (0.016s)
[168.096443] Starting dynamic subtest: vcs1
[168.105818] Dynamic subtest vcs1: SUCCESS (0.017s)
[168.113417] Starting dynamic subtest: vecs0
[168.124034] Dynamic subtest vecs0: SUCCESS (0.018s)
[168.131632] Starting dynamic subtest: ccs0
[168.140760] Dynamic subtest ccs0: SUCCESS (0.016s)
[168.143119] Subtest u-lateslice: SUCCESS (0.109s)
[169.992269] [046/133] (848s left) kms_flip (dpms-off-confusion-interruptible)
[170.082418] Starting subtest: dpms-off-confusion-interruptible
[170.084823] Starting dynamic subtest: A-eDP1
[178.756644] Dynamic subtest A-eDP1: SUCCESS (8.639s)
[178.767073] Starting dynamic subtest: B-eDP1
[187.390934] Dynamic subtest B-eDP1: SUCCESS (8.633s)
[187.401683] Starting dynamic subtest: C-eDP1
[196.030698] Dynamic subtest C-eDP1: SUCCESS (8.628s)
[196.041665] Starting dynamic subtest: D-eDP1
[204.671576] Dynamic subtest D-eDP1: SUCCESS (8.637s)
[204.673926] Subtest dpms-off-confusion-interruptible: SUCCESS (34.544s)
[205.800137] [047/133] (813s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[205.895883] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[212.768230] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.874s)
[212.960147] [048/133] (805s left) kms_plane (plane-position-hole)
[213.058204] Starting subtest: plane-position-hole
[213.570598] Starting dynamic subtest: pipe-A-plane-1
[214.867650] Dynamic subtest pipe-A-plane-1: SUCCESS (1.298s)
[214.877610] Starting dynamic subtest: pipe-A-plane-2
[216.118824] Dynamic subtest pipe-A-plane-2: SUCCESS (1.249s)
[216.126766] Starting dynamic subtest: pipe-A-plane-3
[217.369510] Dynamic subtest pipe-A-plane-3: SUCCESS (1.249s)
[217.377585] Starting dynamic subtest: pipe-A-plane-4
[218.603984] Dynamic subtest pipe-A-plane-4: SUCCESS (1.234s)
[218.612711] Starting dynamic subtest: pipe-A-plane-5
[218.630054] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[219.761375] Starting dynamic subtest: pipe-B-plane-1
[221.074988] Dynamic subtest pipe-B-plane-1: SUCCESS (1.321s)
[221.083858] Starting dynamic subtest: pipe-B-plane-2
[222.379629] Dynamic subtest pipe-B-plane-2: SUCCESS (1.304s)
[222.389402] Starting dynamic subtest: pipe-B-plane-3
[223.599066] Dynamic subtest pipe-B-plane-3: SUCCESS (1.217s)
[223.609782] Starting dynamic subtest: pipe-B-plane-4
[224.847997] Dynamic subtest pipe-B-plane-4: SUCCESS (1.250s)
[224.857667] Starting dynamic subtest: pipe-B-plane-5
[224.873468] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s)
[224.875739] Subtest plane-position-hole: SUCCESS (11.816s)
[225.655619] [049/133] (793s left) kms_draw_crc (draw-method-mmap-cpu)
[225.758059] Starting subtest: draw-method-mmap-cpu
[225.759950] Starting dynamic subtest: xrgb8888-untiled
[225.978815] Dynamic subtest xrgb8888-untiled: SUCCESS (0.222s)
[225.987032] Starting dynamic subtest: rgb565-untiled
[226.178687] Dynamic subtest rgb565-untiled: SUCCESS (0.199s)
[226.187179] Starting dynamic subtest: xrgb2101010-untiled
[226.378617] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.199s)
[226.386925] Starting dynamic subtest: xbgr16161616f-untiled
[226.613627] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.232s)
[226.621559] Starting dynamic subtest: xrgb8888-xtiled
[226.757861] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.141s)
[226.772992] Starting dynamic subtest: rgb565-xtiled
[226.889356] Dynamic subtest rgb565-xtiled: SUCCESS (0.132s)
[226.897072] Starting dynamic subtest: xrgb2101010-xtiled
[227.011551] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s)
[227.019579] Starting dynamic subtest: xbgr16161616f-xtiled
[227.144999] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[227.152879] Starting dynamic subtest: xrgb8888-4tiled
[227.278223] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.132s)
[227.285858] Starting dynamic subtest: rgb565-4tiled
[227.411685] Dynamic subtest rgb565-4tiled: SUCCESS (0.133s)
[227.419512] Starting dynamic subtest: xrgb2101010-4tiled
[227.544902] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.132s)
[227.556764] Starting dynamic subtest: xbgr16161616f-4tiled
[227.689728] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.144s)
[227.691750] Subtest draw-method-mmap-cpu: SUCCESS (1.934s)
[227.782077] [050/133] (791s left) gem_mmap_gtt (medium-copy-xy)
[227.838485] Subtest medium-copy-XY: SKIP (0.000s)
[227.908409] [051/133] (791s left) vgem_basic (bad-flag)
[227.940986] Starting subtest: bad-flag
[227.942951] Subtest bad-flag: SUCCESS (0.000s)
[228.012867] [052/133] (791s left) gem_ctx_persistence (engines-hostile-preempt)
[228.086038] Starting subtest: engines-hostile-preempt
[228.088074] Starting dynamic subtest: rcs0
[228.204293] Dynamic subtest rcs0: SUCCESS (0.118s)
[228.214831] Starting dynamic subtest: bcs0
[228.278812] Dynamic subtest bcs0: SUCCESS (0.072s)
[228.289439] Starting dynamic subtest: vcs0
[229.891843] Dynamic subtest vcs0: SUCCESS (1.609s)
[229.902823] Starting dynamic subtest: vcs1
[231.920458] Dynamic subtest vcs1: SUCCESS (2.026s)
[231.930774] Starting dynamic subtest: vecs0
[233.920445] Dynamic subtest vecs0: SUCCESS (1.998s)
[233.930883] Starting dynamic subtest: ccs0
[234.042038] Dynamic subtest ccs0: SUCCESS (0.120s)
[234.044843] Subtest engines-hostile-preempt: SUCCESS (5.956s)
[234.138921] [053/133] (785s left) kms_sequence (queue-idle)
[234.235025] Starting subtest: queue-idle
[234.237323] Starting dynamic subtest: pipe-A-eDP-1
[236.051286] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.813s)
[236.061635] Starting dynamic subtest: pipe-B-eDP-1
[238.526228] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.474s)
[238.534724] Starting dynamic subtest: pipe-C-eDP-1
[240.957661] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.431s)
[240.966354] Starting dynamic subtest: pipe-D-eDP-1
[243.385155] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.425s)
[243.387301] Subtest queue-idle: SUCCESS (9.149s)
[244.199062] [054/133] (774s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[244.305761] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[244.308036] Starting dynamic subtest: pipe-A-eDP-1
[244.378577] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[244.388327] Starting dynamic subtest: pipe-B-eDP-1
[245.470592] Dynamic subtest pipe-B-eDP-1: SKIP (1.089s)
[245.475047] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.169s)
[246.669208] [055/133] (772s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[246.766202] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[246.770722] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[246.880630] [056/133] (772s left) kms_atomic (atomic-plane-damage)
[246.982945] Starting subtest: atomic-plane-damage
[247.034157] Starting dynamic subtest: pipe-A-eDP-1
[247.569501] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.536s)
[247.571786] Subtest atomic-plane-damage: SUCCESS (0.587s)
[248.392130] [057/133] (770s left) kms_big_fb (linear-16bpp-rotate-90)
[248.497978] Starting subtest: linear-16bpp-rotate-90
[248.517662] Subtest linear-16bpp-rotate-90: SKIP (0.019s)
[248.678563] [058/133] (770s left) perf (stress-open-close)
[248.808832] Starting subtest: stress-open-close
[248.810962] Starting dynamic subtest: 0-rcs0
[250.976455] Dynamic subtest 0-rcs0: SUCCESS (2.169s)
[250.986924] Starting dynamic subtest: 1-vcs1
[253.145492] Dynamic subtest 1-vcs1: SUCCESS (2.168s)
[253.147493] Subtest stress-open-close: SUCCESS (4.340s)
[253.193473] [059/133] (766s left) gem_workarounds (basic-read-fd)
[253.265557] Starting subtest: basic-read-fd
[253.282382] Subtest basic-read-fd: SUCCESS (0.017s)
[253.441919] [060/133] (765s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[253.551784] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[254.687919] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.135s)
[254.841965] [061/133] (764s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[254.951473] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[254.954749] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[255.069130] [062/133] (764s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[255.175298] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[255.178756] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[255.294374] [063/133] (764s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[255.405469] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[255.409112] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[255.523980] [064/133] (764s left) kms_cursor_crc (cursor-offscreen-32x10)
[255.671554] Starting subtest: cursor-offscreen-32x10
[255.717901] Subtest cursor-offscreen-32x10: SKIP (0.042s)
[255.989127] [065/133] (763s left) kms_psr (psr2-primary-render)
[256.089105] Starting subtest: psr2-primary-render
[256.090967] Starting dynamic subtest: eDP-1
[257.786060] Dynamic subtest eDP-1: SUCCESS (1.694s)
[257.788168] Subtest psr2-primary-render: SUCCESS (1.695s)
[258.661556] [066/133] (761s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[258.768675] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[258.772893] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[258.902415] [067/133] (760s left) gem_exec_schedule (noreorder-priority)
[259.092239] Starting subtest: noreorder-priority
[259.094778] Starting dynamic subtest: rcs0
[260.234655] Dynamic subtest rcs0: SUCCESS (1.143s)
[260.248592] Starting dynamic subtest: vcs0
[261.934675] Dynamic subtest vcs0: SUCCESS (1.696s)
[261.951512] Starting dynamic subtest: vcs1
[263.876435] Dynamic subtest vcs1: SUCCESS (1.938s)
[263.887629] Starting dynamic subtest: vecs0
[265.858217] Dynamic subtest vecs0: SUCCESS (1.979s)
[265.872905] Starting dynamic subtest: ccs0
[267.017818] Dynamic subtest ccs0: SUCCESS (1.159s)
[267.020347] Subtest noreorder-priority: SUCCESS (7.928s)
[267.216708] [068/133] (752s left) gem_softpin (allocator-evict)
[267.284052] Starting subtest: allocator-evict
[267.286243] Starting dynamic subtest: rcs0
[291.346065] Dynamic subtest rcs0: SUCCESS (24.059s)
[291.357299] Starting dynamic subtest: bcs0
[314.916061] Dynamic subtest bcs0: SUCCESS (23.566s)
[314.929117] Starting dynamic subtest: vcs0
[338.450683] Dynamic subtest vcs0: SUCCESS (23.532s)
[338.459818] Starting dynamic subtest: vcs1
[362.126748] Dynamic subtest vcs1: SUCCESS (23.674s)
[362.135912] Starting dynamic subtest: vecs0
[385.976636] Dynamic subtest vecs0: SUCCESS (23.848s)
[385.985082] Starting dynamic subtest: ccs0
[409.709283] Dynamic subtest ccs0: SUCCESS (23.731s)
[409.711424] Subtest allocator-evict: SUCCESS (142.418s)
[409.809253] [069/133] (609s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[409.975293] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[414.878961] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.907s)
[416.048645] [070/133] (603s left) gem_exec_reloc (basic-cpu-gtt-active)
[416.114923] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[416.197824] [071/133] (603s left) gem_ctx_shared (single-timeline)
[416.263577] Starting subtest: single-timeline
[416.284811] Subtest single-timeline: SUCCESS (0.015s)
[416.542826] [072/133] (603s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[416.618594] Starting subtest: etime-multi-wait-all-for-submit-submitted
[416.721944] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.102s)
[416.802035] [073/133] (603s left) syncobj_timeline (etime-single-wait-all-submitted)
[416.859059] Starting subtest: etime-single-wait-all-submitted
[416.969356] Subtest etime-single-wait-all-submitted: SUCCESS (0.108s)
[417.057643] [074/133] (602s left) kms_chamelium_hpd (dp-hpd-storm)
[417.449523] Subtest dp-hpd-storm: SKIP (0.000s)
[418.227195] [075/133] (601s left) kms_flip (2x-flip-vs-suspend)
[418.331292] Starting subtest: 2x-flip-vs-suspend
[418.340527] Subtest 2x-flip-vs-suspend: SKIP (0.011s)
[418.434239] [076/133] (601s left) kms_psr (fbc-psr2-sprite-plane-move)
[418.531276] Starting subtest: fbc-psr2-sprite-plane-move
[418.533515] Starting dynamic subtest: eDP-1
[418.537681] Dynamic subtest eDP-1: SKIP (0.000s)
[418.541837] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[418.638990] [077/133] (601s left) gem_exec_params (mmapped)
[418.698254] Starting subtest: mmapped
[418.703469] Subtest mmapped: SUCCESS (0.003s)
[418.856993] [078/133] (601s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[418.957628] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[418.961621] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[419.077166] [079/133] (601s left) sw_sync (sync_merge_invalid)
[419.111261] Starting subtest: sync_merge_invalid
[419.140390] Subtest sync_merge_invalid: SUCCESS (0.030s)
[419.234783] [080/133] (601s left) perf_pmu (busy)
[419.270375] Starting subtest: busy
[419.272476] Starting dynamic subtest: rcs0
[419.866805] Dynamic subtest rcs0: SUCCESS (0.595s)
[419.878303] Starting dynamic subtest: bcs0
[420.440724] Dynamic subtest bcs0: SUCCESS (0.572s)
[420.451684] Starting dynamic subtest: vcs0
[421.909508] Dynamic subtest vcs0: SUCCESS (1.465s)
[421.921503] Starting dynamic subtest: vcs1
[423.894607] Dynamic subtest vcs1: SUCCESS (1.982s)
[423.906900] Starting dynamic subtest: vecs0
[425.941385] Dynamic subtest vecs0: SUCCESS (2.044s)
[425.953410] Starting dynamic subtest: ccs0
[426.516087] Dynamic subtest ccs0: SUCCESS (0.573s)
[426.519088] Subtest busy: SUCCESS (7.246s)
[426.665302] [081/133] (593s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[426.725727] Starting subtest: multi-wait-for-submit-submitted-signaled
[426.728217] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[426.856027] [082/133] (593s left) gem_mmap_wc (write-wc-read-gtt)
[426.920886] Subtest write-wc-read-gtt: SKIP (0.000s)
[426.990482] [083/133] (593s left) kms_hdmi_inject (inject-audio)
[427.347597] Starting subtest: inject-audio
[427.623620] Subtest inject-audio: SUCCESS (0.277s)
[428.224452] [084/133] (592s left) kms_flip (2x-blocking-wf_vblank)
[428.332747] Starting subtest: 2x-blocking-wf_vblank
[428.356358] Subtest 2x-blocking-wf_vblank: SKIP (0.023s)
[428.461697] [085/133] (592s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[428.565075] Starting subtest: plane-all-transition-nonblocking-fencing
[428.567325] Starting dynamic subtest: pipe-A-eDP-1
[431.062559] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.499s)
[431.367942] Starting dynamic subtest: pipe-B-eDP-1
[434.581593] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.222s)
[434.890100] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.327s)
[435.707506] [086/133] (584s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[435.837059] Starting subtest: flip-vs-cursor-crc-legacy
[436.539424] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.702s)
[437.408454] [087/133] (583s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[437.509107] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[437.513502] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[437.589529] [088/133] (583s left) gem_exec_params (invalid-ring2)
[437.645909] Starting subtest: invalid-ring2
[437.647763] Subtest invalid-ring2: SUCCESS (0.000s)
[437.781622] [089/133] (582s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[437.892170] Starting subtest: fbcpsr-slowdraw
[463.165068] Subtest fbcpsr-slowdraw: SUCCESS (25.274s)
[463.321964] [090/133] (557s left) kms_joiner (basic-force-ultra-joiner)
[463.446681] Starting subtest: basic-force-ultra-joiner
[463.451092] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[463.538938] [091/133] (557s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[463.636096] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[463.662026] Starting dynamic subtest: pipe-A-plane-0
[463.950886] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[463.959234] Starting dynamic subtest: pipe-A-plane-3
[464.183638] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[465.332940] Starting dynamic subtest: pipe-B-plane-0
[465.637164] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s)
[465.645812] Starting dynamic subtest: pipe-B-plane-3
[465.870598] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[466.178045] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.544s)
[466.985474] [092/133] (553s left) kms_vblank (query-forked-busy-hang)
[467.089065] Starting subtest: query-forked-busy-hang
[467.091319] Starting dynamic subtest: pipe-A-eDP-1
[493.653193] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.561s)
[493.667822] Starting dynamic subtest: pipe-D-eDP-1
[518.669997] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.014s)
[518.672011] Subtest query-forked-busy-hang: SUCCESS (51.580s)
[519.476950] [093/133] (501s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[519.579433] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[519.583586] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[519.709443] [094/133] (501s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[519.814478] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[520.427925] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.615s)
[520.627637] [095/133] (500s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[520.725866] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[520.728181] Starting dynamic subtest: pipe-A-default-mode
[523.485408] Dynamic subtest pipe-A-default-mode: SUCCESS (2.759s)
[523.487736] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.761s)
[524.300176] [096/133] (496s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[524.358689] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[524.465303] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.106s)
[524.553129] [097/133] (496s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[524.658256] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[524.662287] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[524.783613] [098/133] (496s left) gem_exec_whisper (basic-fds-forked)
[524.846888] Starting subtest: basic-fds-forked
[548.000047] Subtest basic-fds-forked: SUCCESS (23.149s)
[548.198249] [099/133] (472s left) kms_addfb_basic (bad-pitch-999)
[548.253709] Starting subtest: bad-pitch-999
[548.255943] Subtest bad-pitch-999: SUCCESS (0.000s)
[548.425529] [100/133] (472s left) kms_prop_blob (basic)
[548.490469] Starting subtest: basic
[548.492664] Subtest basic: SUCCESS (0.000s)
[548.625176] [101/133] (472s left) syncobj_basic (bad-pad-fd-to-handle)
[548.685184] Starting subtest: bad-pad-fd-to-handle
[548.687199] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[548.801101] [102/133] (472s left) kms_cursor_crc (cursor-sliding-256x256)
[549.035739] Starting subtest: cursor-sliding-256x256
[549.040648] Starting dynamic subtest: pipe-A-eDP-1
[552.324906] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.282s)
[552.351914] Starting dynamic subtest: pipe-D-eDP-1
[556.230897] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.885s)
[556.233226] Subtest cursor-sliding-256x256: SUCCESS (7.193s)
[557.080362] [103/133] (464s left) gem_busy (busy)
[557.157584] Starting subtest: busy
[557.159961] Starting dynamic subtest: all-engines
[557.231671] Dynamic subtest all-engines: SUCCESS (0.074s)
[557.241162] Starting dynamic subtest: rcs0
[558.876068] Dynamic subtest rcs0: SUCCESS (1.642s)
[558.887453] Starting dynamic subtest: bcs0
[558.929074] Dynamic subtest bcs0: SUCCESS (0.049s)
[558.943697] Starting dynamic subtest: vcs0
[558.968341] Dynamic subtest vcs0: SUCCESS (0.039s)
[558.976548] Starting dynamic subtest: vcs1
[560.922107] Dynamic subtest vcs1: SUCCESS (1.950s)
[560.930996] Starting dynamic subtest: vecs0
[562.907621] Dynamic subtest vecs0: SUCCESS (1.984s)
[562.919297] Starting dynamic subtest: ccs0
[564.891066] Dynamic subtest ccs0: SUCCESS (1.983s)
[564.893484] Subtest busy: SUCCESS (7.731s)
[565.262847] [104/133] (456s left) i915_pm_rps (thresholds)
[565.329428] Starting subtest: thresholds
[565.334054] Subtest thresholds: SKIP (0.001s)
[565.474407] [105/133] (455s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc)
[565.580388] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc
[565.582686] Starting dynamic subtest: pipe-A-eDP-1
[565.605634] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[565.615217] Starting dynamic subtest: pipe-B-eDP-1
[565.636850] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[565.645174] Starting dynamic subtest: pipe-C-eDP-1
[565.666934] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[565.675624] Starting dynamic subtest: pipe-D-eDP-1
[565.697499] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[565.701571] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[567.879428] [106/133] (453s left) gem_softpin (evict-snoop-interruptible)
[567.947764] Starting subtest: evict-snoop-interruptible
[567.952384] Subtest evict-snoop-interruptible: SKIP (0.000s)
[568.075113] [107/133] (453s left) gem_mmap_gtt (big-bo)
[568.135232] Subtest big-bo: SKIP (0.000s)
[568.201562] [108/133] (453s left) gem_partial_pwrite_pread (write-display)
[568.262472] Subtest write-display: SKIP (0.000s)
[568.340965] [109/133] (453s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[568.434570] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[568.436896] Starting dynamic subtest: pipe-A-eDP-1
[568.459602] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[568.469777] Starting dynamic subtest: pipe-B-eDP-1
[568.491448] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[568.502190] Starting dynamic subtest: pipe-C-eDP-1
[568.523473] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[568.532295] Starting dynamic subtest: pipe-D-eDP-1
[568.553960] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[568.557923] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[570.668452] [110/133] (450s left) kms_psr (fbc-pr-cursor-blt)
[570.758042] Starting subtest: fbc-pr-cursor-blt
[570.762443] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[570.849380] [111/133] (450s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[570.909471] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[570.911690] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[571.045757] [112/133] (450s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[571.101605] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[571.106069] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[571.293843] [113/133] (450s left) gem_mmap (basic)
[571.361014] Subtest basic: SKIP (0.000s)
[571.462802] [114/133] (450s left) gem_exec_gttfill (basic)
[571.543885] Starting subtest: basic
[573.976810] Subtest basic: SUCCESS (2.431s)
[574.186966] [115/133] (447s left) kms_addfb_basic (size-max)
[574.339312] Starting subtest: size-max
[574.341151] Subtest size-max: SUCCESS (0.000s)
[574.486182] [116/133] (447s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[574.572099] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[574.574369] Starting dynamic subtest: pipe-A-eDP-1
[574.597161] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[574.610612] Starting dynamic subtest: pipe-B-eDP-1
[574.632516] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[574.643067] Starting dynamic subtest: pipe-C-eDP-1
[574.664252] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[574.672744] Starting dynamic subtest: pipe-D-eDP-1
[574.694964] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[574.699295] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[576.785986] [117/133] (445s left) api_intel_bb (purge-bb)
[576.847928] Starting subtest: purge-bb
[576.850368] Subtest purge-bb: SUCCESS (0.004s)
[576.991827] [118/133] (444s left) kms_cursor_legacy (forked-move)
[577.136335] Starting subtest: forked-move
[577.138476] Starting dynamic subtest: pipe-A
[582.635077] Dynamic subtest pipe-A: SUCCESS (5.495s)
[582.647397] Starting dynamic subtest: pipe-B
[588.112045] Dynamic subtest pipe-B: SUCCESS (5.475s)
[588.124843] Starting dynamic subtest: pipe-C
[593.637571] Dynamic subtest pipe-C: SUCCESS (5.470s)
[593.646888] Starting dynamic subtest: pipe-D
[599.103760] Dynamic subtest pipe-D: SUCCESS (5.463s)
[599.120068] Starting dynamic subtest: all-pipes
[604.605885] Dynamic subtest all-pipes: SUCCESS (5.500s)
[604.608066] Subtest forked-move: SUCCESS (27.415s)
[604.707742] [119/133] (417s left) gen9_exec_parse (bb-chained)
[604.777018] Subtest bb-chained: SKIP (0.000s)
[604.854305] [120/133] (417s left) kms_concurrent (multi-plane-atomic-lowres)
[604.959262] Starting subtest: multi-plane-atomic-lowres
[604.961550] Starting dynamic subtest: pipe-A-eDP-1
[605.473661] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.513s)
[605.475928] Subtest multi-plane-atomic-lowres: SUCCESS (0.514s)
[606.280278] [121/133] (415s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[606.352879] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[606.442078] [122/133] (415s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[606.512972] Starting subtest: multi-wait-available-unsubmitted-submitted
[606.515271] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[606.638533] [123/133] (415s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[606.743840] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[611.148416] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.408s)
[612.304429] [124/133] (409s left) kms_pm_dc (dc3co-vpb-simulation)
[613.412982] Starting subtest: dc3co-vpb-simulation
[622.597968] Subtest dc3co-vpb-simulation: SKIP (9.128s)
[622.697907] [125/133] (399s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[622.805464] Starting subtest: x-tiled-8bpp-rotate-90
[622.826551] Subtest x-tiled-8bpp-rotate-90: SKIP (0.020s)
[622.963209] [126/133] (399s left) kms_plane_multiple (2x-tiling-none)
[623.056203] Starting subtest: 2x-tiling-none
[623.060322] Subtest 2x-tiling-none: SKIP (0.000s)
[623.151414] [127/133] (399s left) gem_exec_balancer (bonded-false-hang)
[623.412572] Starting subtest: bonded-false-hang
[623.417314] Subtest bonded-false-hang: SKIP (0.000s)
[623.515966] [128/133] (398s left) i915_drm_fdinfo (idle)
[623.554084] Starting subtest: idle
[623.555961] Starting dynamic subtest: rcs0
[624.130765] Dynamic subtest rcs0: SUCCESS (0.577s)
[624.141516] Starting dynamic subtest: bcs0
[624.637382] Dynamic subtest bcs0: SUCCESS (0.503s)
[624.648205] Starting dynamic subtest: vcs0
[625.144178] Dynamic subtest vcs0: SUCCESS (0.504s)
[625.153969] Starting dynamic subtest: vcs1
[625.649220] Dynamic subtest vcs1: SUCCESS (0.503s)
[625.661749] Starting dynamic subtest: vecs0
[626.155971] Dynamic subtest vecs0: SUCCESS (0.503s)
[626.166187] Starting dynamic subtest: ccs0
[626.661804] Dynamic subtest ccs0: SUCCESS (0.503s)
[626.664532] Subtest idle: SUCCESS (3.109s)
[626.751607] [129/133] (395s left) kms_getfb (getfb2-handle-closed)
[626.845782] Starting subtest: getfb2-handle-closed
[626.847988] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[626.983686] [130/133] (395s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[627.046106] Starting subtest: invalid-bsd1-flag-on-vebox
[627.048514] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[627.183050] [131/133] (395s left) kms_psr (fbc-pr-suspend)
[627.276148] Starting subtest: fbc-pr-suspend
[627.280103] Subtest fbc-pr-suspend: SKIP (0.000s)
[627.363366] [132/133] (395s left) gem_softpin (overlap)
[627.438309] Starting subtest: overlap
[628.356246] Subtest overlap: SUCCESS (0.918s)
[628.517758] [133/133] (394s left) gem_madvise (dontneed-before-mmap)
[628.559353] Starting subtest: dontneed-before-mmap
[628.585418] Subtest dontneed-before-mmap: SUCCESS (0.027s)
[628.701414] Closing watchdogs
results: parsing output: 0/ for test: perf_pmu
results: parsing output: 1/ for test: gem_exec_flush
results: parsing output: 2/ for test: kms_lease
results: parsing output: 3/ for test: i915_drm_fdinfo
results: parsing output: 4/ for test: kms_atomic_interruptible
results: parsing output: 5/ for test: kms_color
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_plane_scaling
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: kms_rotation_crc
results: parsing output: 11/ for test: kms_flip
results: parsing output: 12/ for test: api_intel_allocator
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_mmap
results: parsing output: 16/ for test: gem_render_copy
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: gem_partial_pwrite_pread
results: parsing output: 21/ for test: syncobj_basic
results: parsing output: 22/ for test: kms_chamelium_frames
results: parsing output: 23/ for test: kms_cursor_legacy
results: parsing output: 24/ for test: gem_ctx_persistence
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: gem_lmem_swapping
results: parsing output: 27/ for test: kms_addfb_basic
results: parsing output: 28/ for test: kms_addfb_basic
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: gem_exec_basic
results: parsing output: 31/ for test: gem_mmap_offset
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: kms_cursor_crc
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_plane_alpha_blend
results: parsing output: 36/ for test: gem_exec_fence
results: parsing output: 37/ for test: i915_pm_rps
results: parsing output: 38/ for test: dumb_buffer
results: parsing output: 39/ for test: gem_mmap_gtt
results: parsing output: 40/ for test: gem_userptr_blits
results: parsing output: 41/ for test: kms_psr
results: parsing output: 42/ for test: gem_create
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: gem_exec_schedule
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_plane
results: parsing output: 48/ for test: kms_draw_crc
results: parsing output: 49/ for test: gem_mmap_gtt
results: parsing output: 50/ for test: vgem_basic
results: parsing output: 51/ for test: gem_ctx_persistence
results: parsing output: 52/ for test: kms_sequence
results: parsing output: 53/ for test: kms_psr2_sf
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_atomic
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: perf
results: parsing output: 58/ for test: gem_workarounds
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_cursor_crc
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_exec_schedule
results: parsing output: 67/ for test: gem_softpin
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_exec_reloc
results: parsing output: 70/ for test: gem_ctx_shared
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: kms_chamelium_hpd
results: parsing output: 74/ for test: kms_flip
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: gem_exec_params
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: sw_sync
results: parsing output: 79/ for test: perf_pmu
results: parsing output: 80/ for test: syncobj_wait
results: parsing output: 81/ for test: gem_mmap_wc
results: parsing output: 82/ for test: kms_hdmi_inject
results: parsing output: 83/ for test: kms_flip
results: parsing output: 84/ for test: kms_atomic_transition
results: parsing output: 85/ for test: kms_cursor_legacy
results: parsing output: 86/ for test: kms_psr2_sf
results: parsing output: 87/ for test: gem_exec_params
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_joiner
results: parsing output: 90/ for test: kms_plane
results: parsing output: 91/ for test: kms_vblank
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_flip_scaled_crc
results: parsing output: 95/ for test: syncobj_wait
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: gem_exec_whisper
results: parsing output: 98/ for test: kms_addfb_basic
results: parsing output: 99/ for test: kms_prop_blob
results: parsing output: 100/ for test: syncobj_basic
results: parsing output: 101/ for test: kms_cursor_crc
results: parsing output: 102/ for test: gem_busy
results: parsing output: 103/ for test: i915_pm_rps
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: gem_softpin
results: parsing output: 106/ for test: gem_mmap_gtt
results: parsing output: 107/ for test: gem_partial_pwrite_pread
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: gem_render_copy
results: parsing output: 112/ for test: gem_mmap
results: parsing output: 113/ for test: gem_exec_gttfill
results: parsing output: 114/ for test: kms_addfb_basic
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: api_intel_bb
results: parsing output: 117/ for test: kms_cursor_legacy
results: parsing output: 118/ for test: gen9_exec_parse
results: parsing output: 119/ for test: kms_concurrent
results: parsing output: 120/ for test: gem_exec_reloc
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_pm_dc
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: kms_plane_multiple
results: parsing output: 126/ for test: gem_exec_balancer
results: parsing output: 127/ for test: i915_drm_fdinfo
results: parsing output: 128/ for test: kms_getfb
results: parsing output: 129/ for test: gem_exec_params
results: parsing output: 130/ for test: kms_psr
results: parsing output: 131/ for test: gem_softpin
results: parsing output: 132/ for test: gem_madvise
Done.