[56.610764] Initializing watchdogs
[56.610855]   /dev/watchdog0
[56.624370] [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.628555] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.630877] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.634220] [001/131] (960s left) kms_psr (pr-primary-mmap-gtt)
[56.797890] Starting subtest: pr-primary-mmap-gtt
[56.802387] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[56.864860] [002/131] (960s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[56.986825] Starting subtest: 2x-cursor-vs-flip-legacy
[56.991257] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.002s)
[57.079077] [003/131] (960s left) kms_properties (invalid-properties-legacy)
[57.167609] Starting subtest: invalid-properties-legacy
[57.272571] Subtest invalid-properties-legacy: SUCCESS (0.103s)
[57.338038] [004/131] (959s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-wc)
[57.445066] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-wc
[60.507031] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-wc: SUCCESS (3.066s)
[60.626751] [005/131] (956s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[60.732305] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[60.736734] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[60.812823] [006/131] (956s left) kms_chamelium_hpd (common-hpd-after-suspend)
[61.201773] Subtest common-hpd-after-suspend: SKIP (0.000s)
[61.990169] [007/131] (955s left) kms_big_fb (4-tiled-addfb)
[62.095568] Starting subtest: 4-tiled-addfb
[62.097518] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[62.206622] [008/131] (955s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[62.326765] Starting subtest: 2x-long-flip-vs-cursor-atomic
[62.331101] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[62.419587] [009/131] (954s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[62.526676] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[66.817180] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (4.294s)
[66.918976] [010/131] (950s left) kms_psr (psr2-primary-mmap-gtt)
[67.008103] Starting subtest: psr2-primary-mmap-gtt
[67.010461] Starting dynamic subtest: eDP-1
[68.452362] Dynamic subtest eDP-1: SKIP (1.439s)
[68.457377] Subtest psr2-primary-mmap-gtt: SKIP (1.440s)
[68.604198] [011/131] (948s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[68.697879] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[68.700032] Starting dynamic subtest: pipe-A-default-mode
[68.996416] Dynamic subtest pipe-A-default-mode: SKIP (0.293s)
[69.001188] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.294s)
[69.812254] [012/131] (947s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[69.916548] Starting subtest: fbc-2p-pri-indfb-multidraw
[69.920893] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[70.005587] [013/131] (947s left) gem_ppgtt (blt-vs-render-ctxn)
[70.069099] Starting subtest: blt-vs-render-ctxN
[103.147493] Subtest blt-vs-render-ctxN: SUCCESS (33.075s)
[103.264598] [014/131] (914s left) kms_flip (2x-flip-vs-fences-interruptible)
[103.413510] Starting subtest: 2x-flip-vs-fences-interruptible
[103.417781] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[103.528983] [015/131] (914s left) gem_wait (busy)
[103.588624] Starting subtest: busy
[103.591080] Starting dynamic subtest: all-engines
[104.941231] Dynamic subtest all-engines: SUCCESS (1.350s)
[104.951868] Starting dynamic subtest: rcs0
[105.480530] Dynamic subtest rcs0: SUCCESS (0.541s)
[105.490164] Starting dynamic subtest: bcs0
[106.019272] Dynamic subtest bcs0: SUCCESS (0.539s)
[106.028711] Starting dynamic subtest: vcs0
[107.946727] Dynamic subtest vcs0: SUCCESS (1.926s)
[107.955712] Starting dynamic subtest: vcs1
[109.930969] Dynamic subtest vcs1: SUCCESS (1.984s)
[109.941294] Starting dynamic subtest: vecs0
[111.915045] Dynamic subtest vecs0: SUCCESS (1.984s)
[111.924577] Starting dynamic subtest: ccs0
[112.455661] Dynamic subtest ccs0: SUCCESS (0.542s)
[112.458253] Subtest busy: SUCCESS (8.866s)
[112.649119] [016/131] (904s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[112.715363] Starting subtest: single-wait-for-submit-available-signaled
[112.717709] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[112.782987] [017/131] (904s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[112.833277] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[112.894724] [018/131] (904s left) i915_pm_freq_api (freq-reset-multiple)
[112.954430] Starting subtest: freq-reset-multiple
[112.957055] Starting dynamic subtest: gt0
[121.785707] Dynamic subtest gt0: SUCCESS (8.831s)
[121.794744] Starting dynamic subtest: gt1
[129.243785] Dynamic subtest gt1: SUCCESS (7.456s)
[129.246304] Subtest freq-reset-multiple: SUCCESS (16.287s)
[129.313414] [019/131] (888s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[129.417640] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[130.687067] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (1.271s)
[130.893384] [020/131] (886s left) gem_fence_thrash (bo-write-verify-none)
[130.928721] Starting subtest: bo-write-verify-none
[130.959272] Subtest bo-write-verify-none: SKIP (0.026s)
[131.016183] [021/131] (886s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[131.112191] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[131.116562] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[131.227395] [022/131] (886s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[131.284891] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[131.363359] [023/131] (886s left) api_intel_bb (lot-of-buffers)
[131.419933] Starting subtest: lot-of-buffers
[132.375856] Subtest lot-of-buffers: SUCCESS (0.956s)
[132.622203] [024/131] (885s left) kms_cursor_crc (cursor-random-512x512)
[132.876155] Starting subtest: cursor-random-512x512
[132.880851] Subtest cursor-random-512x512: SKIP (0.001s)
[133.046857] [025/131] (884s left) api_intel_allocator (alloc-simple)
[133.108754] Starting subtest: alloc-simple
[133.113332] Subtest alloc-simple: SUCCESS (0.004s)
[133.217246] [026/131] (884s left) kms_writeback (writeback-check-output-xrgb2101010)
[133.307106] Subtest writeback-check-output-XRGB2101010: SKIP (0.000s)
[133.344465] [027/131] (884s left) gem_exec_create (legacy)
[133.400924] Starting subtest: legacy
[133.403104] Starting dynamic subtest: smem
[135.915541] Dynamic subtest smem: SUCCESS (2.513s)
[135.917909] Subtest legacy: SUCCESS (2.513s)
[136.092606] [028/131] (881s left) perf (invalid-oa-exponent)
[136.204884] Starting subtest: invalid-oa-exponent
[136.223954] Subtest invalid-oa-exponent: SUCCESS (0.019s)
[136.256734] [029/131] (881s left) kms_cursor_crc (cursor-offscreen-32x32)
[136.385319] Starting subtest: cursor-offscreen-32x32
[136.428990] Subtest cursor-offscreen-32x32: SKIP (0.038s)
[136.706475] [030/131] (881s left) gem_exec_balancer (parallel-bb-first)
[136.948380] Starting subtest: parallel-bb-first
[137.731957] Subtest parallel-bb-first: SUCCESS (0.784s)
[138.958272] [031/131] (879s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-render)
[139.069715] Starting subtest: psr-1p-offscren-pri-shrfb-draw-render
[143.790574] Subtest psr-1p-offscren-pri-shrfb-draw-render: SUCCESS (4.723s)
[143.922607] [032/131] (874s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[143.982984] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[143.985356] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[144.084705] [033/131] (874s left) i915_query (query-topology-known-pci-ids)
[144.137083] Starting subtest: query-topology-known-pci-ids
[144.141861] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[144.245508] [034/131] (873s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[144.354422] Starting subtest: psr-rgb565-draw-mmap-cpu
[148.904941] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (4.552s)
[149.008888] [035/131] (869s left) kms_flip (2x-nonexisting-fb-interruptible)
[149.111776] Starting subtest: 2x-nonexisting-fb-interruptible
[149.124597] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.011s)
[149.193247] [036/131] (869s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[149.280881] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[149.283708] Starting dynamic subtest: pipe-A-eDP-1
[149.705595] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.394s)
[149.713362] Starting dynamic subtest: pipe-B-eDP-1
[151.104844] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.399s)
[151.114601] Starting dynamic subtest: pipe-C-eDP-1
[152.521872] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.417s)
[152.529092] Starting dynamic subtest: pipe-D-eDP-1
[153.835871] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.313s)
[153.838131] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.525s)
[155.021270] [037/131] (863s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[155.126719] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[160.341076] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (5.217s)
[160.481420] [038/131] (857s left) kms_dsc (dsc-fractional-bpp)
[160.570998] Starting subtest: dsc-fractional-bpp
[160.583885] Subtest dsc-fractional-bpp: SKIP (0.000s)
[160.634840] [039/131] (857s left) kms_rotation_crc (cursor-rotation-180)
[160.732039] Starting subtest: cursor-rotation-180
[162.236046] Subtest cursor-rotation-180: SUCCESS (1.503s)
[163.422112] [040/131] (854s left) prime_self_import (basic-llseek-bad)
[163.464744] Starting subtest: basic-llseek-bad
[163.484481] Subtest basic-llseek-bad: SUCCESS (0.018s)
[163.575622] [041/131] (854s left) gem_ctx_persistence (legacy-engines-hostile)
[163.625227] Starting subtest: legacy-engines-hostile
[163.627626] Starting dynamic subtest: render
[163.699395] Dynamic subtest render: SUCCESS (0.073s)
[163.713252] Starting dynamic subtest: bsd1
[163.802316] Dynamic subtest bsd1: SUCCESS (0.102s)
[163.812166] Starting dynamic subtest: bsd2
[163.893636] Dynamic subtest bsd2: SUCCESS (0.089s)
[163.901690] Starting dynamic subtest: blt
[163.998878] Dynamic subtest blt: SUCCESS (0.103s)
[164.009098] Starting dynamic subtest: vebox
[164.095944] Dynamic subtest vebox: SUCCESS (0.095s)
[164.098615] Subtest legacy-engines-hostile: SUCCESS (0.470s)
[164.168543] [042/131] (854s left) kms_chamelium_color (ctm-max)
[164.274302] Subtest ctm-max: SKIP (0.000s)
[164.310655] [043/131] (854s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[164.426417] Starting subtest: flip-vs-cursor-varying-size
[172.065551] Subtest flip-vs-cursor-varying-size: SUCCESS (7.638s)
[172.944928] [044/131] (845s left) gem_exec_flush (basic-wb-prw-default)
[173.017997] Starting subtest: basic-wb-prw-default
[178.513963] Subtest basic-wb-prw-default: SUCCESS (5.496s)
[178.695218] [045/131] (839s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[178.807399] Starting subtest: compare-crc-sanitycheck-xr24
[178.809830] Starting dynamic subtest: pipe-A-eDP-1
[179.434265] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.625s)
[179.444132] Starting dynamic subtest: pipe-B-eDP-1
[180.685976] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.250s)
[180.695567] Starting dynamic subtest: pipe-C-eDP-1
[181.864035] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.177s)
[181.872630] Starting dynamic subtest: pipe-D-eDP-1
[183.087068] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.220s)
[183.089370] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.277s)
[183.930184] [046/131] (834s left) syncobj_timeline (device-signal-unordered)
[183.982337] Starting subtest: device-signal-unordered
[183.984741] Subtest device-signal-unordered: SUCCESS (0.001s)
[184.090970] [047/131] (834s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[184.176182] Starting subtest: fbc-psr2-primary-mmap-cpu
[184.178424] Starting dynamic subtest: eDP-1
[184.182466] Dynamic subtest eDP-1: SKIP (0.000s)
[184.186614] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[184.240945] [048/131] (834s left) kms_cursor_edge_walk (128x128-top-bottom)
[184.345063] Starting subtest: 128x128-top-bottom
[184.347474] Starting dynamic subtest: pipe-A-eDP-1
[187.793716] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.445s)
[187.800791] Starting dynamic subtest: pipe-D-eDP-1
[190.898168] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.101s)
[190.900182] Subtest 128x128-top-bottom: SUCCESS (6.549s)
[191.713200] [049/131] (826s left) kms_sequence (queue-idle)
[191.804170] Starting subtest: queue-idle
[191.806542] Starting dynamic subtest: pipe-A-eDP-1
[193.616023] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.810s)
[193.623920] Starting dynamic subtest: pipe-B-eDP-1
[196.054749] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.438s)
[196.063277] Starting dynamic subtest: pipe-C-eDP-1
[198.498305] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.443s)
[198.505668] Starting dynamic subtest: pipe-D-eDP-1
[200.904858] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.403s)
[200.907468] Subtest queue-idle: SUCCESS (9.098s)
[201.704423] [050/131] (816s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[201.810188] Starting subtest: y-tiled-addfb-size-offset-overflow
[201.814224] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[201.893361] [051/131] (816s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[201.995436] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[201.999799] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[202.100357] [052/131] (816s left) drm_fdinfo (busy-idle)
[202.143748] Starting subtest: busy-idle
[202.146226] Starting dynamic subtest: rcs0
[202.190828] Dynamic subtest rcs0: SKIP (0.045s)
[202.200771] Starting dynamic subtest: bcs0
[202.205111] Dynamic subtest bcs0: SKIP (0.001s)
[202.212741] Starting dynamic subtest: vcs0
[202.217275] Dynamic subtest vcs0: SKIP (0.000s)
[202.224402] Starting dynamic subtest: vcs1
[202.228478] Dynamic subtest vcs1: SKIP (0.000s)
[202.235157] Starting dynamic subtest: vecs0
[202.239402] Dynamic subtest vecs0: SKIP (0.000s)
[202.246106] Starting dynamic subtest: ccs0
[202.250239] Dynamic subtest ccs0: SKIP (0.000s)
[202.254365] Subtest busy-idle: SKIP (0.051s)
[202.284168] [053/131] (816s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[202.384079] Starting subtest: y-tiled-64bpp-rotate-180
[202.388573] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[202.489510] [054/131] (816s left) kms_vblank (query-forked)
[202.588082] Starting subtest: query-forked
[202.590339] Starting dynamic subtest: pipe-A-eDP-1
[204.442655] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.846s)
[204.456928] Starting dynamic subtest: pipe-D-eDP-1
[206.950995] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.512s)
[206.953079] Subtest query-forked: SUCCESS (4.361s)
[207.750507] [055/131] (811s left) gem_softpin (reverse)
[207.822971] Starting subtest: reverse
[207.828743] Subtest reverse: SUCCESS (0.006s)
[207.959891] [056/131] (810s left) gem_pxp (reject-modify-context-protection-off-3)
[208.071310] Starting subtest: reject-modify-context-protection-off-3
[208.073767] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[208.186620] [057/131] (810s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[208.292995] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[208.297125] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[208.400952] [058/131] (810s left) gem_userptr_blits (process-exit-busy)
[208.475933] Starting subtest: process-exit-busy
[208.486665] Subtest process-exit-busy: SUCCESS (0.013s)
[208.629538] [059/131] (810s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[208.720754] Starting subtest: crc-primary-basic-yf-tiled-ccs
[208.722803] Starting dynamic subtest: pipe-A-eDP-1
[208.742634] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[208.751894] Starting dynamic subtest: pipe-B-eDP-1
[208.770026] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[208.777232] Starting dynamic subtest: pipe-C-eDP-1
[208.795302] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[208.802919] Starting dynamic subtest: pipe-D-eDP-1
[208.821373] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[208.824917] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.004s)
[210.893679] [060/131] (808s left) prime_busy (before-wait)
[210.959316] Starting subtest: before-wait
[210.964111] Starting dynamic subtest: rcs0
[210.995147] Dynamic subtest rcs0: SUCCESS (0.032s)
[211.003932] Starting dynamic subtest: bcs0
[211.061976] Dynamic subtest bcs0: SUCCESS (0.066s)
[211.071049] Starting dynamic subtest: vcs0
[211.102336] Dynamic subtest vcs0: SUCCESS (0.040s)
[211.110546] Starting dynamic subtest: vcs1
[211.141968] Dynamic subtest vcs1: SUCCESS (0.039s)
[211.149618] Starting dynamic subtest: vecs0
[211.182669] Dynamic subtest vecs0: SUCCESS (0.040s)
[211.190604] Starting dynamic subtest: ccs0
[211.223071] Dynamic subtest ccs0: SUCCESS (0.040s)
[211.332951] Subtest before-wait: SUCCESS (0.372s)
[211.402418] [061/131] (807s left) gem_mmap_gtt (cpuset-big-copy-odd)
[211.459908] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[211.503436] [062/131] (807s left) perf_pmu (semaphore-wait-idle)
[211.547478] Starting subtest: semaphore-wait-idle
[211.549467] Starting dynamic subtest: rcs0
[212.060057] Dynamic subtest rcs0: SUCCESS (0.513s)
[212.071297] Starting dynamic subtest: bcs0
[212.573527] Dynamic subtest bcs0: SUCCESS (0.512s)
[212.584954] Starting dynamic subtest: vcs0
[213.086845] Dynamic subtest vcs0: SUCCESS (0.511s)
[213.095709] Starting dynamic subtest: vcs1
[213.601072] Dynamic subtest vcs1: SUCCESS (0.511s)
[213.611980] Starting dynamic subtest: vecs0
[214.115710] Dynamic subtest vecs0: SUCCESS (0.513s)
[214.126951] Starting dynamic subtest: ccs0
[214.630492] Dynamic subtest ccs0: SUCCESS (0.513s)
[214.633815] Subtest semaphore-wait-idle: SUCCESS (3.085s)
[215.980398] [063/131] (803s left) kms_psr2_su (page_flip-p010)
[216.052106] Subtest page_flip-P010: SKIP (0.000s)
[216.111448] [064/131] (803s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[216.215692] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[216.219868] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[216.354908] [065/131] (802s left) kms_cdclk (mode-transition)
[216.448069] Starting subtest: mode-transition
[216.450379] Starting dynamic subtest: pipe-A-eDP-1
[216.737220] Dynamic subtest pipe-A-eDP-1: SKIP (0.286s)
[216.747343] Starting dynamic subtest: pipe-B-eDP-1
[216.751806] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[216.759519] Starting dynamic subtest: pipe-C-eDP-1
[216.764046] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[216.771823] Starting dynamic subtest: pipe-D-eDP-1
[216.776216] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[216.780575] Subtest mode-transition: SKIP (0.293s)
[217.519920] [066/131] (801s left) gen9_exec_parse (unaligned-jump)
[217.587489] Subtest unaligned-jump: SKIP (0.000s)
[217.658049] [067/131] (801s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[217.765129] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[217.767439] Starting dynamic subtest: pipe-A-default-mode
[218.874311] Dynamic subtest pipe-A-default-mode: SKIP (1.107s)
[218.878866] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.109s)
[219.009084] [068/131] (800s left) drm_fdinfo (memory-info-resident)
[219.045730] Starting subtest: memory-info-resident
[219.048353] Starting dynamic subtest: smem0
[222.029688] Dynamic subtest smem0: SUCCESS (2.983s)
[222.032491] Subtest memory-info-resident: SUCCESS (2.983s)
[222.093843] [069/131] (797s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[222.231801] Starting subtest: short-flip-after-cursor-toggle
[223.140890] Subtest short-flip-after-cursor-toggle: SUCCESS (0.908s)
[223.978104] [070/131] (795s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[224.037709] Starting subtest: multi-wait-available-submitted-signaled
[224.040231] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s)
[224.111240] [071/131] (795s left) gem_mmap_offset (mmap-unmap)
[224.169595] Starting subtest: mmap-unmap
[224.172028] Starting dynamic subtest: smem0
[248.734226] Dynamic subtest smem0: SUCCESS (24.566s)
[248.736681] Subtest mmap-unmap: SUCCESS (24.567s)
[248.815432] [072/131] (770s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[248.913701] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[248.916174] Starting dynamic subtest: pipe-A
[249.431193] Dynamic subtest pipe-A: SUCCESS (0.517s)
[249.444240] Starting dynamic subtest: pipe-B
[251.027313] Dynamic subtest pipe-B: SUCCESS (1.596s)
[251.036223] Starting dynamic subtest: pipe-C
[252.547596] Dynamic subtest pipe-C: SUCCESS (1.520s)
[252.555651] Starting dynamic subtest: pipe-D
[254.068322] Dynamic subtest pipe-D: SUCCESS (1.520s)
[254.070686] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (5.155s)
[255.266287] [073/131] (764s left) sw_sync (alloc_fence_invalid_timeline)
[255.305083] Starting subtest: alloc_fence_invalid_timeline
[255.307313] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[255.354873] [074/131] (764s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[255.456083] Starting subtest: 4-tiled-addfb-size-offset-overflow
[255.458212] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[255.535700] [075/131] (763s left) gem_tiled_swapping (non-threaded)
[255.595293] Subtest non-threaded: SKIP (0.000s)
[255.653086] [076/131] (763s left) gem_exec_schedule (pi-userfault)
[255.840658] Starting subtest: pi-userfault
[255.842833] Starting dynamic subtest: rcs0
[255.848444] Dynamic subtest rcs0: SUCCESS (0.010s)
[255.858718] Starting dynamic subtest: bcs0
[255.861237] Dynamic subtest bcs0: SUCCESS (0.006s)
[255.872895] Starting dynamic subtest: vcs0
[255.874838] Dynamic subtest vcs0: SUCCESS (0.006s)
[255.882692] Starting dynamic subtest: vcs1
[255.884768] Dynamic subtest vcs1: SUCCESS (0.008s)
[255.892382] Starting dynamic subtest: vecs0
[255.894248] Dynamic subtest vecs0: SUCCESS (0.008s)
[255.901274] Starting dynamic subtest: ccs0
[255.903164] Dynamic subtest ccs0: SUCCESS (0.009s)
[255.904942] Subtest pi-userfault: SUCCESS (0.050s)
[256.059670] [077/131] (763s left) kms_addfb_basic (no-handle)
[256.118266] Starting subtest: no-handle
[256.120297] Subtest no-handle: SUCCESS (0.000s)
[256.249730] [078/131] (763s left) kms_invalid_mode (bad-hsync-end)
[256.356056] Starting subtest: bad-hsync-end
[256.358319] Starting dynamic subtest: pipe-A-eDP-1
[256.649789] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.293s)
[256.658978] Starting dynamic subtest: pipe-B-eDP-1
[256.661223] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[256.668693] Starting dynamic subtest: pipe-C-eDP-1
[256.670683] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[256.678503] Starting dynamic subtest: pipe-D-eDP-1
[256.680802] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[256.683170] Subtest bad-hsync-end: SUCCESS (0.298s)
[257.494792] [079/131] (762s left) syncobj_wait (wait-for-submit-delayed-submit)
[257.557298] Starting subtest: wait-for-submit-delayed-submit
[257.661492] Subtest wait-for-submit-delayed-submit: SUCCESS (0.105s)
[257.729642] [080/131] (761s left) kms_pm_rpm (modeset-non-lpsp-stress)
[259.266850] Starting subtest: modeset-non-lpsp-stress
[260.423760] Subtest modeset-non-lpsp-stress: SKIP (1.155s)
[260.771804] [081/131] (758s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[260.889355] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[272.094423] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.206s)
[272.876738] [082/131] (746s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[272.982227] Starting subtest: bad-aux-stride-y-tiled-ccs
[272.984630] Starting dynamic subtest: pipe-A-eDP-1
[273.009058] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[273.017947] Starting dynamic subtest: pipe-B-eDP-1
[273.038195] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[273.045306] Starting dynamic subtest: pipe-C-eDP-1
[273.066739] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[273.075687] Starting dynamic subtest: pipe-D-eDP-1
[273.098502] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[273.103119] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s)
[275.130099] [083/131] (744s left) gem_exec_schedule (semaphore-user)
[275.217224] Starting subtest: semaphore-user
[275.269259] Subtest semaphore-user: SUCCESS (0.057s)
[276.938698] [084/131] (742s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[277.069498] Starting subtest: 2x-long-flip-vs-cursor-legacy
[277.073719] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s)
[277.194591] [085/131] (742s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[277.316021] Starting subtest: basic-flip-after-cursor-varying-size
[278.239584] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.920s)
[279.056511] [086/131] (740s left) kms_plane_lowres (tiling-y)
[279.149087] Starting subtest: tiling-y
[279.153748] Subtest tiling-y: SKIP (0.000s)
[279.212931] [087/131] (740s left) gem_caching (writes)
[279.281092] Subtest writes: SKIP (0.000s)
[279.344975] [088/131] (740s left) kms_addfb_basic (basic-y-tiled-legacy)
[279.400759] Starting subtest: basic-y-tiled-legacy
[279.405196] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[279.558229] [089/131] (740s left) gem_exec_reloc (basic-gtt-read)
[279.620771] Subtest basic-gtt-read: SKIP (0.000s)
[279.701316] [090/131] (740s left) kms_plane_scaling (invalid-num-scalers)
[279.796262] Starting subtest: invalid-num-scalers
[279.798694] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[279.813562] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.014s)
[279.822078] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[279.840891] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.026s)
[279.851099] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[279.870091] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.029s)
[279.879694] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[279.897809] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.027s)
[279.900064] Subtest invalid-num-scalers: SUCCESS (0.101s)
[280.015469] [091/131] (740s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[280.084695] Starting subtest: invalid-multi-wait-unsubmitted
[280.086713] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[280.170511] [092/131] (739s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[280.269556] Starting subtest: x-tiled-64bpp-rotate-270
[280.288488] Subtest x-tiled-64bpp-rotate-270: SKIP (0.019s)
[280.403949] [093/131] (739s left) kms_hdr (static-swap)
[280.502740] Starting subtest: static-swap
[280.508410] Subtest static-swap: SKIP (0.000s)
[280.567560] [094/131] (739s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[280.620698] Starting subtest: y-tiled-to-vebox-y-tiled
[280.624477] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[280.800489] [095/131] (739s left) kms_pm_rpm (pm-tiling)
[283.144489] Starting subtest: pm-tiling
[283.149892] Subtest pm-tiling: SKIP (0.000s)
[283.483119] [096/131] (736s left) core_getclient
[283.638965] [097/131] (736s left) gem_ctx_isolation (clean)
[283.696874] Starting subtest: clean
[283.699290] Starting dynamic subtest: rcs0
[283.778659] Dynamic subtest rcs0: SUCCESS (0.081s)
[283.789334] Starting dynamic subtest: bcs0
[283.862599] Dynamic subtest bcs0: SUCCESS (0.083s)
[283.870546] Starting dynamic subtest: vcs0
[283.956131] Dynamic subtest vcs0: SUCCESS (0.093s)
[283.966172] Starting dynamic subtest: vcs1
[285.949331] Dynamic subtest vcs1: SUCCESS (1.992s)
[285.957629] Starting dynamic subtest: vecs0
[287.972602] Dynamic subtest vecs0: SUCCESS (2.023s)
[287.980797] Starting dynamic subtest: ccs0
[290.043652] Dynamic subtest ccs0: SUCCESS (2.069s)
[290.046831] Subtest clean: SUCCESS (6.346s)
[290.223572] [098/131] (730s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[295.222699] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[295.225029] Starting dynamic subtest: pipe-A-eDP-1
[296.027577] Dynamic subtest pipe-A-eDP-1: SKIP (0.800s)
[296.035981] Starting dynamic subtest: pipe-B-eDP-1
[297.149127] Dynamic subtest pipe-B-eDP-1: SKIP (1.120s)
[297.153266] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.923s)
[298.319916] [099/131] (722s left) gem_ctx_persistence (engines-hang)
[298.394100] Starting subtest: engines-hang
[298.396429] Starting dynamic subtest: rcs0
[298.563772] Dynamic subtest rcs0: SUCCESS (0.169s)
[298.574670] Starting dynamic subtest: bcs0
[298.671760] Dynamic subtest bcs0: SUCCESS (0.106s)
[298.681639] Starting dynamic subtest: vcs0
[298.782901] Dynamic subtest vcs0: SUCCESS (0.109s)
[298.794513] Starting dynamic subtest: vcs1
[298.882757] Dynamic subtest vcs1: SUCCESS (0.098s)
[298.894233] Starting dynamic subtest: vecs0
[298.972579] Dynamic subtest vecs0: SUCCESS (0.088s)
[298.983598] Starting dynamic subtest: ccs0
[299.094942] Dynamic subtest ccs0: SUCCESS (0.120s)
[299.097702] Subtest engines-hang: SUCCESS (0.701s)
[299.166627] [100/131] (721s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[299.338774] Starting subtest: cursor-rapid-movement-64x21
[299.378899] Subtest cursor-rapid-movement-64x21: SKIP (0.035s)
[299.603013] [101/131] (720s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[301.135676] Starting subtest: gem-execbuf-stress-pc8
[301.178577] Subtest gem-execbuf-stress-pc8: SKIP (0.040s)
[301.848472] [102/131] (718s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[301.943553] Starting subtest: yf-tiled-addfb-size-offset-overflow
[301.948061] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[302.037679] [103/131] (718s left) gem_close_race (basic-process)
[302.106323] Starting subtest: basic-process
[302.180442] Subtest basic-process: SUCCESS (0.073s)
[302.359544] [104/131] (718s left) sysfs_preempt_timeout (timeout)
[302.417658] Starting subtest: timeout
[302.420154] Starting dynamic subtest: vecs0
[311.933382] Dynamic subtest vecs0: SUCCESS (9.512s)
[311.944191] Starting dynamic subtest: ccs0
[313.411810] Dynamic subtest ccs0: SUCCESS (1.476s)
[313.422543] Starting dynamic subtest: vcs0
[322.925158] Dynamic subtest vcs0: SUCCESS (9.510s)
[322.936348] Starting dynamic subtest: bcs0
[324.223790] Dynamic subtest bcs0: SUCCESS (1.300s)
[324.235711] Starting dynamic subtest: rcs0
[325.606526] Dynamic subtest rcs0: SUCCESS (1.379s)
[325.616239] Starting dynamic subtest: vcs1
[334.959921] Dynamic subtest vcs1: SUCCESS (9.353s)
[334.962518] Subtest timeout: SUCCESS (32.541s)
[335.033705] [105/131] (685s left) kms_getfb (getfb-reject-ccs)
[335.095976] Starting subtest: getfb-reject-ccs
[335.098228] Subtest getfb-reject-ccs: SUCCESS (0.001s)
[335.191444] [106/131] (685s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[335.286843] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[335.289207] Starting dynamic subtest: pipe-A-eDP-1
[335.309848] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[335.320108] Starting dynamic subtest: pipe-B-eDP-1
[335.339209] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[335.346599] Starting dynamic subtest: pipe-C-eDP-1
[335.365160] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[335.372561] Starting dynamic subtest: pipe-D-eDP-1
[335.391753] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[335.393908] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[337.388510] [107/131] (683s left) gem_exec_fence (syncobj-signal)
[337.853275] Starting subtest: syncobj-signal
[337.859509] Subtest syncobj-signal: SUCCESS (0.005s)
[339.025654] [FACT gem_exec_fence (syncobj-signal)] new: kernel.kmod_is_loaded.vgem: true
[339.028962] [108/131] (681s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[339.135678] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[339.140162] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[339.233516] [109/131] (681s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[339.339547] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[339.344153] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[339.449471] [110/131] (681s left) gem_exec_params (invalid-bsd-ring)
[339.515515] Starting subtest: invalid-bsd-ring
[339.518032] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[339.617105] [111/131] (681s left) kms_pm_dc (dc6-dpms)
[340.722382] Starting subtest: dc6-dpms
[347.727226] Subtest dc6-dpms: FAIL (6.663s)
[347.763776] [112/131] (672s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[347.861234] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[347.957752] [113/131] (672s left) gem_lmem_swapping (parallel-random-verify-ccs)
[348.001309] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[348.033503] [114/131] (672s left) gem_blits (basic)
[348.090879] Starting subtest: basic
[349.588669] Subtest basic: SUCCESS (1.497s)
[349.696684] [115/131] (671s left) perf_pmu (interrupts-sync)
[349.739950] Starting subtest: interrupts-sync
[350.818623] Subtest interrupts-sync: SUCCESS (1.079s)
[350.923348] [116/131] (669s left) perf_pmu (event-wait)
[350.964353] Starting subtest: event-wait
[350.966730] Starting dynamic subtest: rcs0
[350.971272] Dynamic subtest rcs0: SKIP (0.000s)
[350.975506] Subtest event-wait: SKIP (0.001s)
[351.077134] [117/131] (669s left) gem_ctx_shared (q-smoketest)
[351.134953] Starting subtest: Q-smoketest
[351.137575] Starting dynamic subtest: rcs0
[356.723731] Dynamic subtest rcs0: SUCCESS (5.542s)
[356.738078] Starting dynamic subtest: bcs0
[362.267267] Dynamic subtest bcs0: SUCCESS (5.539s)
[362.276406] Starting dynamic subtest: vcs0
[367.774631] Dynamic subtest vcs0: SUCCESS (5.506s)
[367.788900] Starting dynamic subtest: vcs1
[373.279773] Dynamic subtest vcs1: SUCCESS (5.502s)
[373.293936] Starting dynamic subtest: vecs0
[378.776689] Dynamic subtest vecs0: SUCCESS (5.499s)
[378.791214] Starting dynamic subtest: ccs0
[384.308857] Dynamic subtest ccs0: SUCCESS (5.530s)
[384.311299] Subtest Q-smoketest: SUCCESS (33.125s)
[384.442095] [118/131] (636s left) kms_chamelium_hpd (vga-hpd-fast)
[384.841412] Subtest vga-hpd-fast: SKIP (0.000s)
[385.679645] [119/131] (635s left) gem_exec_whisper (basic-contexts-forked-all)
[385.748334] Starting subtest: basic-contexts-forked-all
[405.843150] Subtest basic-contexts-forked-all: SUCCESS (20.090s)
[406.024623] [120/131] (615s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[406.146334] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[406.150266] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[406.262378] [121/131] (614s left) gem_mmap_gtt (fault-concurrent)
[406.326848] Subtest fault-concurrent: SKIP (0.000s)
[406.391646] [122/131] (614s left) kms_rotation_crc (sprite-rotation-180)
[406.486852] Starting subtest: sprite-rotation-180
[411.572067] Subtest sprite-rotation-180: SUCCESS (5.085s)
[412.744286] [123/131] (608s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[412.798753] Starting subtest: etime-single-wait-for-submit-submitted
[412.905032] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.104s)
[412.975054] [124/131] (608s left) core_auth (getclient-simple)
[413.009264] Starting subtest: getclient-simple
[413.038544] Subtest getclient-simple: SUCCESS (0.030s)
[413.146082] [125/131] (608s left) syncobj_wait (multi-wait-submitted)
[413.204909] Starting subtest: multi-wait-submitted
[413.312199] Subtest multi-wait-submitted: SUCCESS (0.106s)
[413.381719] [126/131] (607s left) gem_exec_params (readonly)
[413.445277] Starting subtest: readonly
[413.451432] Subtest readonly: SUCCESS (0.003s)
[413.552950] [127/131] (607s left) kms_feature_discovery (psr1)
[413.657131] Starting subtest: psr1
[413.659318] Subtest psr1: SUCCESS (0.000s)
[413.721216] [128/131] (607s left) kms_psr (psr-primary-render)
[413.827030] Starting subtest: psr-primary-render
[413.829246] Starting dynamic subtest: eDP-1
[415.645697] Dynamic subtest eDP-1: SUCCESS (1.820s)
[415.648166] Subtest psr-primary-render: SUCCESS (1.821s)
[416.493655] [129/131] (604s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[416.594756] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[416.598905] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[416.708850] [130/131] (604s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[416.769923] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[416.774452] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[416.946693] [131/131] (604s left) kms_psr (fbc-pr-sprite-plane-onoff)
[417.055300] Starting subtest: fbc-pr-sprite-plane-onoff
[417.059650] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[417.116879] Closing watchdogs
Done.