[56.876949] Initializing watchdogs
[56.876994]   /dev/watchdog0
[56.892005] [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.896520] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.898875] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.902421] [001/156] (960s left) gem_ctx_engines (invalid-engines)
[56.992751] Starting subtest: invalid-engines
[57.004894] Subtest invalid-engines: SUCCESS (0.014s)
[57.252847] [002/156] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[57.360373] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[57.364968] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[57.449091] [003/156] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[57.546501] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[57.550847] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[57.646817] [004/156] (959s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[57.740278] Starting subtest: extended-modeset-hang-oldfb-with-reset
[57.742450] Starting dynamic subtest: pipe-A
[69.514116] Dynamic subtest pipe-A: SUCCESS (11.857s)
[69.523845] Starting dynamic subtest: pipe-D
[82.271998] Dynamic subtest pipe-D: SUCCESS (12.773s)
[82.274244] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.634s)
[83.152140] [005/156] (934s left) syncobj_timeline (device-signal-unordered)
[83.222195] Starting subtest: device-signal-unordered
[83.225054] Subtest device-signal-unordered: SUCCESS (0.001s)
[83.327760] [006/156] (934s left) kms_hdr (invalid-hdr)
[83.427628] Starting subtest: invalid-hdr
[83.429899] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[88.063095] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SUCCESS (4.633s)
[88.081512] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[91.818448] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SUCCESS (3.739s)
[91.828433] Subtest invalid-hdr: SUCCESS (8.402s)
[91.930128] [007/156] (925s left) api_intel_allocator (fork-simple-stress-signal)
[91.981834] Starting subtest: fork-simple-stress-signal
[97.386860] Subtest fork-simple-stress-signal: SUCCESS (5.404s)
[97.514217] [008/156] (920s left) i915_query (query-topology-coherent-slice-mask)
[97.573035] Starting subtest: query-topology-coherent-slice-mask
[97.577407] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[97.696216] [009/156] (920s left) gem_eio (execbuf)
[97.888338] Starting subtest: execbuf
[98.141754] Subtest execbuf: SUCCESS (0.253s)
[98.258923] [010/156] (919s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[98.357761] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[98.359739] Starting dynamic subtest: pipe-A-eDP-1
[100.383313] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.018s)
[100.393423] Starting dynamic subtest: pipe-B-eDP-1
[102.429542] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.045s)
[102.438971] Starting dynamic subtest: pipe-C-eDP-1
[104.464283] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.035s)
[104.473948] Starting dynamic subtest: pipe-D-eDP-1
[106.505768] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.041s)
[106.507984] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (8.141s)
[107.662331] [011/156] (910s left) kms_psr (fbc-psr2-cursor-render)
[107.763832] Starting subtest: fbc-psr2-cursor-render
[107.766260] Starting dynamic subtest: eDP-1
[107.770550] Dynamic subtest eDP-1: SKIP (0.000s)
[107.774898] Subtest fbc-psr2-cursor-render: SKIP (0.000s)
[107.838057] [012/156] (909s left) gem_ctx_create (basic-files)
[107.895864] Starting subtest: basic-files
[109.903899] Subtest basic-files: SUCCESS (2.008s)
[111.427455] [013/156] (906s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[111.815166] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[112.696113] [014/156] (905s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-move)
[112.792276] Starting subtest: fbchdr-2p-primscrn-spr-indfb-move
[112.796686] Subtest fbchdr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[112.883717] [015/156] (905s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[112.980615] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[112.982780] Starting dynamic subtest: pipe-A-eDP-1
[113.414848] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.435s)
[113.425978] Starting dynamic subtest: pipe-B-eDP-1
[113.450568] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[113.459689] Starting dynamic subtest: pipe-C-eDP-1
[113.478206] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[113.486059] Starting dynamic subtest: pipe-D-eDP-1
[113.504672] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[113.506547] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.448s)
[115.762712] [016/156] (902s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-render)
[115.869980] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-render
[115.874286] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[115.949936] [017/156] (902s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[116.014784] Starting subtest: y-tiled-to-vebox-x-tiled
[116.019350] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[116.196308] [018/156] (901s left) gem_ctx_persistence (legacy-engines-queued)
[116.243656] Starting subtest: legacy-engines-queued
[116.245984] Starting dynamic subtest: render
[116.307544] Dynamic subtest render: SUCCESS (0.064s)
[116.319824] Starting dynamic subtest: bsd1
[118.270348] Dynamic subtest bsd1: SUCCESS (1.959s)
[118.282050] Starting dynamic subtest: bsd2
[120.315484] Dynamic subtest bsd2: SUCCESS (2.043s)
[120.326266] Starting dynamic subtest: blt
[120.366921] Dynamic subtest blt: SUCCESS (0.051s)
[120.378187] Starting dynamic subtest: vebox
[122.302090] Dynamic subtest vebox: SUCCESS (1.931s)
[122.305045] Subtest legacy-engines-queued: SUCCESS (6.057s)
[122.382175] [019/156] (895s left) kms_invalid_mode (bad-vsync-start)
[122.491846] Starting subtest: bad-vsync-start
[122.494177] Starting dynamic subtest: pipe-A-eDP-1
[122.778947] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[122.787891] Starting dynamic subtest: pipe-B-eDP-1
[122.790469] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[122.798894] Starting dynamic subtest: pipe-C-eDP-1
[122.801329] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[122.809495] Starting dynamic subtest: pipe-D-eDP-1
[122.811762] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[122.814039] Subtest bad-vsync-start: SUCCESS (0.290s)
[123.607824] [020/156] (894s left) gem_ctx_sseu (invalid-sseu)
[123.671791] Subtest invalid-sseu: SKIP (0.000s)
[123.725095] [021/156] (894s left) gen7_exec_parse (chained-batch)
[123.778644] Subtest chained-batch: SKIP (0.000s)
[123.853139] [022/156] (894s left) gem_render_copy_redux (flink-interruptible)
[123.908750] Starting subtest: flink-interruptible
[124.744543] Subtest flink-interruptible: SUCCESS (0.836s)
[124.864812] [023/156] (893s left) kms_frontbuffer_tracking (hdr-modesetfrombusy)
[124.959940] Starting subtest: hdr-modesetfrombusy
[124.963785] Subtest hdr-modesetfrombusy: SKIP (0.000s)
[125.054965] [024/156] (893s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[125.150638] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt
[125.154185] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[125.229809] [025/156] (893s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[125.331835] Starting subtest: 4-tiled-16bpp-rotate-180
[126.689385] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.358s)
[126.806645] [026/156] (891s left) gem_exec_params (no-vebox)
[126.860994] Starting subtest: no-vebox
[126.864619] Subtest no-vebox: SUCCESS (0.002s)
[128.407995] [027/156] (890s left) gem_exec_suspend (basic-s3)
[128.468385] Starting subtest: basic-S3
[128.470814] Starting dynamic subtest: smem
[149.547120] Dynamic subtest smem: SUCCESS (6.860s)
[149.550490] Subtest basic-S3: SUCCESS (6.862s)
[155.747050] [028/156] (868s left) syncobj_timeline (signal)
[155.806564] Starting subtest: signal
[155.808763] Subtest signal: SUCCESS (0.000s)
[155.911805] [029/156] (868s left) kms_frontbuffer_tracking (fbchdr-2p-shrfb-fliptrack-mmap-gtt)
[156.007500] Starting subtest: fbchdr-2p-shrfb-fliptrack-mmap-gtt
[156.011646] Subtest fbchdr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[156.090732] [030/156] (868s left) gem_exec_params (invalid-ring2)
[156.158290] Starting subtest: invalid-ring2
[156.160651] Subtest invalid-ring2: SUCCESS (0.000s)
[156.259327] [031/156] (868s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[156.363208] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[156.367330] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[156.459738] [032/156] (868s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[156.553880] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[156.557999] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[156.646639] [033/156] (868s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-pwrite)
[156.752941] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-pwrite
[156.756769] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[156.854329] [034/156] (867s left) gem_exec_balancer (parallel-contexts)
[157.101186] Starting subtest: parallel-contexts
[159.864918] Subtest parallel-contexts: SUCCESS (2.797s)
[160.668343] [035/156] (864s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-blt)
[160.778172] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-blt
[160.782753] Subtest hdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[160.884356] [036/156] (863s left) gem_spin_batch (engines)
[160.942023] Starting subtest: engines
[160.944413] Starting dynamic subtest: rcs0
[164.181502] Dynamic subtest rcs0: SUCCESS (3.274s)
[164.193936] Starting dynamic subtest: bcs0
[167.418415] Dynamic subtest bcs0: SUCCESS (3.261s)
[167.430197] Starting dynamic subtest: vcs0
[170.652548] Dynamic subtest vcs0: SUCCESS (3.250s)
[170.664081] Starting dynamic subtest: vcs1
[173.888062] Dynamic subtest vcs1: SUCCESS (3.246s)
[173.899570] Starting dynamic subtest: vecs0
[177.124759] Dynamic subtest vecs0: SUCCESS (3.244s)
[177.136621] Starting dynamic subtest: ccs0
[180.362257] Dynamic subtest ccs0: SUCCESS (3.241s)
[180.364570] Subtest engines: SUCCESS (19.525s)
[180.586435] [037/156] (844s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[180.698085] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[180.702089] Subtest hdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[180.804976] [038/156] (844s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[180.924427] Starting subtest: cursorA-vs-flipA-varying-size
[192.072403] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.148s)
[192.871985] [039/156] (832s left) syncobj_timeline (wait-all-for-submit-snapshot)
[192.933285] Starting subtest: wait-all-for-submit-snapshot
[193.014650] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[193.091816] [040/156] (831s left) vgem_basic (setversion)
[193.222657] Starting subtest: setversion
[193.226826] Subtest setversion: SUCCESS (0.000s)
[193.276242] [FACT vgem_basic (setversion)] new: kernel.kmod_is_loaded.vgem: true
[193.279609] [041/156] (831s left) i915_hangman (detector)
[193.335620] Starting subtest: detector
[193.337918] Starting dynamic subtest: rcs0
[204.489902] Dynamic subtest rcs0: SUCCESS (11.153s)
[204.503197] Starting dynamic subtest: bcs0
[216.520651] Dynamic subtest bcs0: SUCCESS (12.031s)
[216.533141] Starting dynamic subtest: vcs0
[228.491725] Dynamic subtest vcs0: SUCCESS (11.972s)
[228.503453] Starting dynamic subtest: vcs1
[240.457369] Dynamic subtest vcs1: SUCCESS (11.968s)
[240.469839] Starting dynamic subtest: vecs0
[251.529891] Dynamic subtest vecs0: SUCCESS (11.073s)
[251.543172] Starting dynamic subtest: ccs0
[263.497105] Dynamic subtest ccs0: SUCCESS (11.959s)
[263.500144] Subtest detector: SUCCESS (70.168s)
[263.580443] [042/156] (761s left) gem_ctx_isolation (nonpriv)
[263.642066] Starting subtest: nonpriv
[263.644427] Starting dynamic subtest: rcs0
[263.941323] Dynamic subtest rcs0: SUCCESS (0.299s)
[263.953298] Starting dynamic subtest: bcs0
[264.269808] Dynamic subtest bcs0: SUCCESS (0.328s)
[264.279278] Starting dynamic subtest: vcs0
[264.544281] Dynamic subtest vcs0: SUCCESS (0.274s)
[264.553576] Starting dynamic subtest: vcs1
[265.788364] Dynamic subtest vcs1: SUCCESS (1.242s)
[265.798765] Starting dynamic subtest: vecs0
[267.805962] Dynamic subtest vecs0: SUCCESS (2.017s)
[267.816286] Starting dynamic subtest: ccs0
[269.808864] Dynamic subtest ccs0: SUCCESS (2.002s)
[269.811318] Subtest nonpriv: SUCCESS (6.166s)
[270.063343] [043/156] (755s left) gem_mmap_offset (bad-flags)
[270.118881] Starting subtest: bad-flags
[270.121341] Subtest bad-flags: SUCCESS (0.000s)
[270.239617] [044/156] (754s left) kms_color (ctm-negative)
[270.331234] Starting subtest: ctm-negative
[270.333090] Starting dynamic subtest: pipe-A-eDP-1
[271.041209] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s)
[271.052232] Starting dynamic subtest: pipe-B-eDP-1
[272.470394] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.427s)
[272.480865] Starting dynamic subtest: pipe-C-eDP-1
[273.843241] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.375s)
[273.854340] Starting dynamic subtest: pipe-D-eDP-1
[275.181997] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.339s)
[275.184256] Subtest ctm-negative: SUCCESS (4.852s)
[275.994149] [045/156] (749s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[276.096539] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[283.655388] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.565s)
[283.781235] [046/156] (741s left) api_intel_bb (lot-of-buffers)
[283.836003] Starting subtest: lot-of-buffers
[284.888602] Subtest lot-of-buffers: SUCCESS (1.054s)
[285.439947] [047/156] (739s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[285.543179] Starting subtest: fbcpsr-indfb-scaledprimary
[291.288583] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.750s)
[291.438693] [048/156] (733s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[291.558228] Starting subtest: verify-pxp-stale-buf-optout-execution
[292.619400] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.062s)
[292.738020] [049/156] (732s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[292.830976] Starting subtest: fbc-pr-cursor-mmap-gtt
[292.835031] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[292.907044] [050/156] (732s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[292.999034] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[293.003489] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[293.089490] [051/156] (732s left) i915_suspend (fence-restore-untiled)
[293.144685] Starting subtest: fence-restore-untiled
[293.149100] Subtest fence-restore-untiled: SKIP (0.000s)
[293.240752] [052/156] (732s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[293.341367] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[294.376617] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.034s)
[294.498997] [053/156] (731s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[294.603208] Starting subtest: fbc-rgb101010-draw-render
[297.165589] Subtest fbc-rgb101010-draw-render: SUCCESS (2.567s)
[298.356736] [054/156] (727s left) sw_sync (sync_merge_same)
[298.391925] Starting subtest: sync_merge_same
[298.394412] Subtest sync_merge_same: SUCCESS (0.000s)
[298.442698] [055/156] (727s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-plflip-blt)
[298.534128] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-plflip-blt
[298.538269] Subtest fbcpsrhdr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[298.643634] [056/156] (727s left) kms_flip (flip-vs-panning)
[298.740347] Starting subtest: flip-vs-panning
[298.742640] Starting dynamic subtest: A-eDP1
[307.460928] Dynamic subtest A-eDP1: SUCCESS (8.720s)
[307.471667] Starting dynamic subtest: B-eDP1
[316.186991] Dynamic subtest B-eDP1: SUCCESS (8.727s)
[316.203981] Starting dynamic subtest: C-eDP1
[324.902804] Dynamic subtest C-eDP1: SUCCESS (8.715s)
[324.912651] Starting dynamic subtest: D-eDP1
[333.634284] Dynamic subtest D-eDP1: SUCCESS (8.731s)
[333.636444] Subtest flip-vs-panning: SUCCESS (34.903s)
[334.805025] [057/156] (690s left) gem_lmem_swapping (parallel-random-verify)
[334.851347] Subtest parallel-random-verify: SKIP (0.000s)
[334.893227] [058/156] (690s left) kms_psr (pr-dpms)
[334.992742] Starting subtest: pr-dpms
[334.996724] Subtest pr-dpms: SKIP (0.000s)
[335.063884] [059/156] (690s left) gem_mmap_gtt (big-copy-odd)
[335.124320] Subtest big-copy-odd: SKIP (0.000s)
[335.190522] [060/156] (690s left) syncobj_eventfd (binary-wait-signaled)
[335.233964] Starting subtest: binary-wait-signaled
[335.235920] Subtest binary-wait-signaled: SUCCESS (0.000s)
[335.350551] [061/156] (690s left) kms_cursor_crc (cursor-onscreen-256x85)
[335.610192] Starting subtest: cursor-onscreen-256x85
[335.662464] Subtest cursor-onscreen-256x85: SKIP (0.046s)
[335.841668] [062/156] (690s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[335.936159] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[335.937944] Starting dynamic subtest: pipe-A-eDP-1
[336.012608] Dynamic subtest pipe-A-eDP-1: SKIP (0.079s)
[336.022406] Starting dynamic subtest: pipe-B-eDP-1
[337.179783] Dynamic subtest pipe-B-eDP-1: SKIP (1.164s)
[337.184574] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.246s)
[338.368527] [063/156] (687s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-pwrite)
[338.467268] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-pwrite
[338.471704] Subtest fbchdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[338.580081] [064/156] (687s left) perf_pmu (most-busy-idle-check-all)
[338.615192] Starting subtest: most-busy-idle-check-all
[338.617569] Starting dynamic subtest: rcs0
[340.522130] Dynamic subtest rcs0: SUCCESS (1.906s)
[340.536382] Starting dynamic subtest: bcs0
[342.570779] Dynamic subtest bcs0: SUCCESS (2.046s)
[342.583854] Starting dynamic subtest: vcs0
[344.554662] Dynamic subtest vcs0: SUCCESS (1.981s)
[344.566304] Starting dynamic subtest: vcs1
[346.539367] Dynamic subtest vcs1: SUCCESS (1.982s)
[346.553469] Starting dynamic subtest: vecs0
[348.523200] Dynamic subtest vecs0: SUCCESS (1.981s)
[348.542386] Starting dynamic subtest: ccs0
[350.571184] Dynamic subtest ccs0: SUCCESS (2.046s)
[350.574249] Subtest most-busy-idle-check-all: SUCCESS (11.959s)
[350.687898] [065/156] (675s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[350.738912] Starting subtest: etime-single-wait-available-unsubmitted
[350.846830] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.107s)
[350.928487] [066/156] (675s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[351.057148] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[352.027555] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.969s)
[352.889349] [067/156] (673s left) dumb_buffer (create-clear)
[352.948034] Starting subtest: create-clear
[387.397553] Subtest create-clear: SUCCESS (34.449s)
[387.496254] [068/156] (638s left) gem_exec_whisper (basic-fds-priority)
[387.558062] Starting subtest: basic-fds-priority
[410.839009] Subtest basic-fds-priority: SUCCESS (23.272s)
[411.024971] [069/156] (615s left) gem_userptr_blits (unsync-unmap-cycles)
[411.088279] Subtest unsync-unmap-cycles: SKIP (0.000s)
[411.221168] [070/156] (615s left) kms_psr (psr-sprite-blt)
[411.307276] Starting subtest: psr-sprite-blt
[411.309486] Starting dynamic subtest: eDP-1
[413.106866] Dynamic subtest eDP-1: SUCCESS (1.797s)
[413.109163] Subtest psr-sprite-blt: SUCCESS (1.798s)
[413.951424] [071/156] (612s left) kms_cursor_edge_walk (256x256-left-edge)
[414.037195] Starting subtest: 256x256-left-edge
[414.039333] Starting dynamic subtest: pipe-A-eDP-1
[417.521079] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.483s)
[417.532172] Starting dynamic subtest: pipe-D-eDP-1
[420.654838] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.132s)
[420.657079] Subtest 256x256-left-edge: SUCCESS (6.618s)
[421.475212] [072/156] (604s left) kms_content_protection (atomic)
[421.628429] Starting subtest: atomic
[421.632900] Subtest atomic: SKIP (0.000s)
[421.758979] [073/156] (604s left) gen9_exec_parse (valid-registers)
[421.827440] Subtest valid-registers: SKIP (0.000s)
[421.895057] [074/156] (604s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[421.949427] Starting subtest: invalid-smem-bo-on-discrete
[421.954554] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[422.113603] [075/156] (604s left) gem_render_copy (linear)
[422.175992] Starting subtest: linear
[422.178199] Starting dynamic subtest: smem
[422.217030] Dynamic subtest smem: SUCCESS (0.041s)
[422.219483] Subtest linear: SUCCESS (0.042s)
[422.402301] [076/156] (604s left) kms_psr (psr2-sprite-mmap-gtt)
[422.494053] Starting subtest: psr2-sprite-mmap-gtt
[422.496426] Starting dynamic subtest: eDP-1
[423.963821] Dynamic subtest eDP-1: SKIP (1.465s)
[423.969146] Subtest psr2-sprite-mmap-gtt: SKIP (1.467s)
[424.120903] [077/156] (602s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite)
[424.219047] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite
[424.223039] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[424.327381] [078/156] (602s left) gem_exec_fence (concurrent)
[424.508537] Starting subtest: concurrent
[424.513792] Subtest concurrent: SKIP (0.000s)
[426.620487] [079/156] (600s left) kms_pm_rpm (modeset-lpsp)
[428.655128] Starting subtest: modeset-lpsp
[430.144878] Subtest modeset-lpsp: SUCCESS (1.490s)
[430.282575] [080/156] (596s left) kms_lease (lease-invalid-connector)
[430.367313] Starting subtest: lease-invalid-connector
[430.369593] Starting dynamic subtest: pipe-A-eDP-1
[430.371946] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[430.385491] Starting dynamic subtest: pipe-B-eDP-1
[430.387425] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[430.398090] Starting dynamic subtest: pipe-C-eDP-1
[430.400225] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[430.410466] Starting dynamic subtest: pipe-D-eDP-1
[430.412684] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[430.414877] Subtest lease-invalid-connector: SUCCESS (0.004s)
[430.459677] [081/156] (596s left) gem_mmap_wc (bad-object)
[430.515074] Subtest bad-object: SKIP (0.000s)
[430.571440] [082/156] (596s left) kms_frontbuffer_tracking (fbchdr-1p-indfb-fliptrack-mmap-gtt)
[430.674185] Starting subtest: fbchdr-1p-indfb-fliptrack-mmap-gtt
[430.678179] Subtest fbchdr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[430.771785] [083/156] (596s left) gem_exec_schedule (preempt)
[430.845271] Starting subtest: preempt
[430.847529] Starting dynamic subtest: rcs0
[430.862652] Dynamic subtest rcs0: SUCCESS (0.026s)
[430.873755] Starting dynamic subtest: bcs0
[430.882565] Dynamic subtest bcs0: SUCCESS (0.019s)
[430.892912] Starting dynamic subtest: vcs0
[430.901885] Dynamic subtest vcs0: SUCCESS (0.019s)
[430.912901] Starting dynamic subtest: vcs1
[430.921836] Dynamic subtest vcs1: SUCCESS (0.019s)
[430.934441] Starting dynamic subtest: vecs0
[430.946423] Dynamic subtest vecs0: SUCCESS (0.024s)
[430.957419] Starting dynamic subtest: ccs0
[430.969141] Dynamic subtest ccs0: SUCCESS (0.022s)
[430.971376] Subtest preempt: SUCCESS (0.133s)
[432.652011] [084/156] (594s left) kms_frontbuffer_tracking (hdr-2p-primscrn-shrfb-plflip-blt)
[432.749824] Starting subtest: hdr-2p-primscrn-shrfb-plflip-blt
[432.754147] Subtest hdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[432.850387] [085/156] (594s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[432.951718] Starting subtest: 4-tiled-32bpp-rotate-180
[434.364905] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.414s)
[434.514950] [086/156] (592s left) gem_lmem_swapping (random-engines)
[434.554016] Subtest random-engines: SKIP (0.000s)
[434.597288] [087/156] (592s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[434.694214] Starting subtest: psr2-cursor-plane-move-continuous-sf
[434.696228] Starting dynamic subtest: pipe-A-eDP-1
[445.057316] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.365s)
[445.068640] Starting dynamic subtest: pipe-B-eDP-1
[456.174576] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.113s)
[456.176930] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (21.482s)
[457.083045] [088/156] (569s left) kms_psr (fbc-psr-sprite-plane-move)
[457.185240] Starting subtest: fbc-psr-sprite-plane-move
[457.187498] Starting dynamic subtest: eDP-1
[457.191591] Dynamic subtest eDP-1: SKIP (0.000s)
[457.195805] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[457.264026] [089/156] (569s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[457.360322] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-mmap-cpu
[457.364533] Subtest hdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[457.447660] [090/156] (569s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[457.550993] Starting subtest: primary-y-tiled-reflect-x-0
[457.611271] Subtest primary-y-tiled-reflect-x-0: SKIP (0.059s)
[457.716937] [091/156] (569s left) gem_exec_params (dr1-dirt)
[457.781646] Starting subtest: DR1-dirt
[457.784053] Subtest DR1-dirt: SUCCESS (0.000s)
[457.898602] [092/156] (569s left) i915_pm_rpm (gem-idle)
[459.731699] Starting subtest: gem-idle
[465.932104] Subtest gem-idle: SUCCESS (6.204s)
[466.307089] [093/156] (560s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[467.580189] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu
[467.584226] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[467.686835] [094/156] (559s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[467.780897] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[467.785234] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[467.872748] [095/156] (559s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[467.955433] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[467.959717] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[469.107885] [096/156] (558s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[469.210592] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[469.214580] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[469.311877] [097/156] (558s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[469.424165] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[469.428265] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[469.533489] [098/156] (557s left) kms_chamelium_hpd (dp-hpd)
[469.917427] Subtest dp-hpd: SKIP (0.000s)
[470.717747] [099/156] (556s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[470.806586] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[470.808928] Starting dynamic subtest: pipe-A
[470.831295] Dynamic subtest pipe-A: SKIP (0.021s)
[470.842463] Starting dynamic subtest: pipe-B
[470.865506] Dynamic subtest pipe-B: SKIP (0.033s)
[470.876418] Starting dynamic subtest: pipe-C
[470.898705] Dynamic subtest pipe-C: SKIP (0.034s)
[470.909526] Starting dynamic subtest: pipe-D
[470.932898] Dynamic subtest pipe-D: SKIP (0.034s)
[470.936603] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.124s)
[471.039748] [100/156] (556s left) prime_self_import (basic-with_one_bo)
[471.077589] Starting subtest: basic-with_one_bo
[471.096283] Subtest basic-with_one_bo: SUCCESS (0.020s)
[471.221924] [101/156] (556s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[471.327587] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[471.331804] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[471.433801] [102/156] (556s left) gem_wait (await)
[471.499611] Starting subtest: await
[471.501934] Starting dynamic subtest: all-engines
[472.611940] Dynamic subtest all-engines: SUCCESS (1.111s)
[472.632441] Starting dynamic subtest: rcs0
[473.668342] Dynamic subtest rcs0: SUCCESS (1.055s)
[473.687964] Starting dynamic subtest: bcs0
[474.727408] Dynamic subtest bcs0: SUCCESS (1.056s)
[474.747195] Starting dynamic subtest: vcs0
[475.781050] Dynamic subtest vcs0: SUCCESS (1.052s)
[475.800129] Starting dynamic subtest: vcs1
[476.835431] Dynamic subtest vcs1: SUCCESS (1.052s)
[476.853752] Starting dynamic subtest: vecs0
[477.889010] Dynamic subtest vecs0: SUCCESS (1.051s)
[477.908341] Starting dynamic subtest: ccs0
[478.946098] Dynamic subtest ccs0: SUCCESS (1.055s)
[478.948740] Subtest await: SUCCESS (7.448s)
[479.147256] [103/156] (548s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[479.253361] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[479.257572] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[479.353246] [104/156] (548s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[479.457944] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[479.462188] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[479.561586] [105/156] (548s left) gem_mmap_wc (set-cache-level)
[479.611292] Subtest set-cache-level: SKIP (0.000s)
[479.669959] [106/156] (548s left) gem_pipe_control_store_loop (fresh-buffer)
[479.721756] Starting subtest: fresh-buffer
[481.877462] Subtest fresh-buffer: SUCCESS (2.154s)
[481.985878] [107/156] (545s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-fullscreen)
[482.086600] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-fullscreen
[482.090775] Subtest psrhdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[482.190291] [108/156] (545s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-mmap-wc)
[482.296803] Starting subtest: fbchdr-rgb101010-draw-mmap-wc
[482.301209] Subtest fbchdr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[482.390560] [109/156] (545s left) syncobj_wait (single-wait-all-signaled)
[482.434268] Starting subtest: single-wait-all-signaled
[482.436483] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[482.541560] [110/156] (545s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[482.626079] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[482.630349] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[482.700091] [111/156] (545s left) kms_big_fb (linear-32bpp-rotate-180)
[482.805627] Starting subtest: linear-32bpp-rotate-180
[484.305593] Subtest linear-32bpp-rotate-180: SUCCESS (1.500s)
[484.477373] [112/156] (543s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[484.568200] Starting subtest: plane-downscale-factor-0-75-with-rotation
[484.570163] Starting dynamic subtest: pipe-A
[484.799012] Dynamic subtest pipe-A: SUCCESS (0.235s)
[484.809658] Starting dynamic subtest: pipe-B
[486.119563] Dynamic subtest pipe-B: SUCCESS (1.319s)
[486.136988] Starting dynamic subtest: pipe-C
[487.450408] Dynamic subtest pipe-C: SUCCESS (1.330s)
[487.461089] Starting dynamic subtest: pipe-D
[488.786146] Dynamic subtest pipe-D: SUCCESS (1.335s)
[488.788421] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.223s)
[489.955584] [113/156] (538s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-blt)
[490.053801] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-blt
[490.057992] Subtest hdr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[490.169056] [114/156] (538s left) gem_exec_schedule (thriceslice)
[490.238834] Starting subtest: thriceslice
[490.240882] Starting dynamic subtest: rcs0
[490.255557] Dynamic subtest rcs0: SUCCESS (0.030s)
[490.267889] Starting dynamic subtest: bcs0
[490.284639] Dynamic subtest bcs0: SUCCESS (0.028s)
[490.295244] Starting dynamic subtest: vcs0
[490.335675] Dynamic subtest vcs0: SUCCESS (0.050s)
[490.351205] Starting dynamic subtest: vcs1
[490.366379] Dynamic subtest vcs1: SUCCESS (0.029s)
[490.377064] Starting dynamic subtest: vecs0
[490.396749] Dynamic subtest vecs0: SUCCESS (0.029s)
[490.408871] Starting dynamic subtest: ccs0
[490.427672] Dynamic subtest ccs0: SUCCESS (0.030s)
[490.429996] Subtest thriceslice: SUCCESS (0.203s)
[490.729919] [115/156] (537s left) gem_mmap_gtt (medium-copy)
[490.786370] Subtest medium-copy: SKIP (0.000s)
[490.854383] [116/156] (537s left) kms_addfb_basic (bad-pitch-32)
[490.906059] Starting subtest: bad-pitch-32
[490.908186] Subtest bad-pitch-32: SUCCESS (0.000s)
[491.043629] [117/156] (537s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[491.135375] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs
[491.138381] Starting dynamic subtest: pipe-A-eDP-1
[491.160189] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[491.171297] Starting dynamic subtest: pipe-B-eDP-1
[491.191641] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[491.201845] Starting dynamic subtest: pipe-C-eDP-1
[491.222413] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[491.232294] Starting dynamic subtest: pipe-D-eDP-1
[491.253919] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[491.258295] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[493.401985] [118/156] (534s left) kms_addfb_basic (unused-offsets)
[493.466664] Starting subtest: unused-offsets
[493.468886] Subtest unused-offsets: SUCCESS (0.000s)
[493.603846] [119/156] (534s left) kms_vblank (query-busy-hang)
[493.697500] Starting subtest: query-busy-hang
[493.699838] Starting dynamic subtest: pipe-A-eDP-1
[520.303281] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.605s)
[520.321766] Starting dynamic subtest: pipe-D-eDP-1
[545.333205] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.034s)
[545.335588] Subtest query-busy-hang: SUCCESS (51.644s)
[546.165066] [120/156] (482s left) kms_pm_lpsp (kms-lpsp)
[547.274612] Starting subtest: kms-lpsp
[547.276912] Starting dynamic subtest: pipe-A-eDP-1
[547.410498] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.139s)
[547.706568] Subtest kms-lpsp: SUCCESS (0.434s)
[548.594673] [121/156] (479s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[548.695089] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[548.697250] Starting dynamic subtest: pipe-A-eDP-1
[548.755277] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[548.767576] Starting dynamic subtest: pipe-B-eDP-1
[548.826202] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[548.838605] Starting dynamic subtest: pipe-C-eDP-1
[548.895544] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[548.906470] Starting dynamic subtest: pipe-D-eDP-1
[548.962769] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[548.966873] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[550.973480] [122/156] (477s left) gem_exec_gttfill (multigpu-basic)
[551.137717] Starting subtest: multigpu-basic
[562.652627] Subtest multigpu-basic: SUCCESS (11.517s)
[562.706956] [123/156] (465s left) gem_ctx_create (basic)
[562.818197] Starting subtest: basic
[562.820498] Subtest basic: SUCCESS (0.000s)
[563.010906] [124/156] (465s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[563.120111] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-mmap-cpu
[563.124578] Subtest fbchdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[563.204229] [125/156] (465s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[563.300569] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[563.304754] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[563.393788] [126/156] (465s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[563.639570] Starting subtest: cursor-rapid-movement-256x256
[563.644344] Starting dynamic subtest: pipe-A-eDP-1
[564.213589] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.570s)
[564.245720] Starting dynamic subtest: pipe-D-eDP-1
[565.481794] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.244s)
[565.483664] Subtest cursor-rapid-movement-256x256: SUCCESS (1.840s)
[566.318630] [127/156] (462s left) syncobj_basic (create-signaled)
[566.377983] Starting subtest: create-signaled
[566.380112] Subtest create-signaled: SUCCESS (0.000s)
[566.474220] [128/156] (462s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-mmap-wc)
[566.576721] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-mmap-wc
[566.581199] Subtest psrhdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[566.669176] [129/156] (462s left) kms_dsc (dsc-with-bpc)
[566.765476] Starting subtest: dsc-with-bpc
[566.798201] Subtest dsc-with-bpc: SKIP (0.001s)
[566.846452] [130/156] (462s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[566.941148] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[568.154745] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.213s)
[568.267141] [131/156] (460s left) fbdev (write)
[568.303709] Starting subtest: write
[568.668234] Subtest write: SUCCESS (0.362s)
[568.733995] [132/156] (460s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[568.831027] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[568.835200] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[568.934019] [133/156] (460s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[569.020973] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[569.025089] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[569.097258] [134/156] (459s left) kms_plane_multiple (tiling-4)
[569.182554] Starting subtest: tiling-4
[569.184903] Starting dynamic subtest: pipe-A-eDP-1
[572.981376] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.798s)
[572.992818] Starting dynamic subtest: pipe-B-eDP-1
[577.443920] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.461s)
[577.455819] Starting dynamic subtest: pipe-C-eDP-1
[581.991016] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.550s)
[582.004185] Starting dynamic subtest: pipe-D-eDP-1
[586.446247] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.452s)
[586.448650] Subtest tiling-4: SUCCESS (17.267s)
[587.274925] [135/156] (441s left) kms_vblank (wait-forked)
[587.379738] Starting subtest: wait-forked
[587.381650] Starting dynamic subtest: pipe-A-eDP-1
[589.198700] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.818s)
[589.216840] Starting dynamic subtest: pipe-D-eDP-1
[591.676267] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.478s)
[591.678635] Subtest wait-forked: SUCCESS (4.299s)
[592.535322] [136/156] (436s left) perf_pmu (rc6)
[592.578026] Starting subtest: rc6
[592.579910] Starting dynamic subtest: gt0
[598.940899] Dynamic subtest gt0: SUCCESS (6.364s)
[598.955287] Starting dynamic subtest: runtime-pm-gt0
[606.713562] Dynamic subtest runtime-pm-gt0: SUCCESS (7.772s)
[606.729171] Starting dynamic subtest: runtime-pm-long-gt0
[619.177921] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.463s)
[619.191375] Starting dynamic subtest: other-idle-gt0
[625.520329] Dynamic subtest other-idle-gt0: SUCCESS (6.341s)
[625.534466] Starting dynamic subtest: gt1
[631.864148] Dynamic subtest gt1: SUCCESS (6.342s)
[631.878451] Starting dynamic subtest: runtime-pm-gt1
[639.367367] Dynamic subtest runtime-pm-gt1: SUCCESS (7.496s)
[639.381481] Starting dynamic subtest: runtime-pm-long-gt1
[651.863824] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.485s)
[651.878213] Starting dynamic subtest: other-idle-gt1
[658.210300] Dynamic subtest other-idle-gt1: SUCCESS (6.340s)
[658.213173] Subtest rc6: SUCCESS (65.624s)
[659.403832] [137/156] (369s left) kms_plane_cursor (overlay)
[659.508679] Starting subtest: overlay
[659.512876] Starting dynamic subtest: pipe-A-eDP-1-size-64
[662.084182] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.574s)
[662.147410] Starting dynamic subtest: pipe-A-eDP-1-size-128
[664.697658] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.562s)
[664.757941] Starting dynamic subtest: pipe-A-eDP-1-size-256
[667.320883] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.572s)
[667.687268] Starting dynamic subtest: pipe-B-eDP-1-size-64
[671.022663] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.346s)
[671.085990] Starting dynamic subtest: pipe-B-eDP-1-size-128
[673.669690] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.594s)
[673.732490] Starting dynamic subtest: pipe-B-eDP-1-size-256
[676.304814] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.582s)
[676.655154] Starting dynamic subtest: pipe-C-eDP-1-size-64
[679.584899] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.942s)
[679.627018] Starting dynamic subtest: pipe-C-eDP-1-size-128
[681.874719] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.258s)
[681.915482] Starting dynamic subtest: pipe-C-eDP-1-size-256
[684.120232] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.214s)
[684.465550] Starting dynamic subtest: pipe-D-eDP-1-size-64
[687.436882] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.984s)
[687.477218] Starting dynamic subtest: pipe-D-eDP-1-size-128
[689.703918] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.236s)
[689.744770] Starting dynamic subtest: pipe-D-eDP-1-size-256
[691.916004] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.181s)
[692.244813] Subtest overlay: SUCCESS (32.721s)
[693.044303] [138/156] (336s left) kms_flip (2x-blocking-absolute-wf_vblank)
[693.145676] Starting subtest: 2x-blocking-absolute-wf_vblank
[693.154721] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.011s)
[693.212716] [139/156] (336s left) gem_mmap_wc (write-read)
[693.275029] Subtest write-read: SKIP (0.000s)
[693.343261] [140/156] (335s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[693.452446] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[700.083362] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.633s)
[700.191929] [141/156] (329s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[700.292351] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[707.632872] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.345s)
[707.749734] [142/156] (321s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[708.313585] Starting subtest: syncobj-timeline-invalid-wait
[708.316294] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s)
[709.751865] [143/156] (319s left) gem_ctx_exec (basic)
[709.862884] Starting subtest: basic
[709.870020] Subtest basic: SUCCESS (0.007s)
[710.039231] [144/156] (319s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-onoff)
[710.153765] Starting subtest: psrhdr-2p-primscrn-spr-indfb-onoff
[710.157820] Subtest psrhdr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[710.236001] [145/156] (319s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[710.331802] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[710.336160] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[710.409420] [146/156] (319s left) perf (oa-exponents)
[710.527492] Starting subtest: oa-exponents
[710.529418] Starting dynamic subtest: 0-rcs0
[712.284571] Dynamic subtest 0-rcs0: SUCCESS (1.756s)
[712.297894] Starting dynamic subtest: 1-vcs1
[714.088330] Dynamic subtest 1-vcs1: SUCCESS (1.802s)
[714.091058] Subtest oa-exponents: SUCCESS (3.560s)
[714.144384] [147/156] (315s left) perf_pmu (busy-double-start)
[714.186190] Starting subtest: busy-double-start
[714.188055] Starting dynamic subtest: rcs0
[717.827834] Dynamic subtest rcs0: FAIL (3.585s)
[717.841515] Starting dynamic subtest: bcs0
[721.338955] Dynamic subtest bcs0: SUCCESS (3.566s)
[721.350946] Starting dynamic subtest: vcs0
[725.053218] Dynamic subtest vcs0: SUCCESS (3.712s)
[725.067277] Starting dynamic subtest: vcs1
[729.096442] Dynamic subtest vcs1: SUCCESS (4.040s)
[729.111178] Starting dynamic subtest: vecs0
[733.041101] Dynamic subtest vecs0: SUCCESS (3.938s)
[733.055750] Starting dynamic subtest: ccs0
[736.672443] Dynamic subtest ccs0: FAIL (3.566s)
[736.674735] Subtest busy-double-start: FAIL (22.418s)
[736.720901] [148/156] (292s left) syncobj_timeline (invalid-query-zero-handles)
[736.775164] Starting subtest: invalid-query-zero-handles
[736.777401] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[736.862891] [149/156] (292s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[736.997892] Starting subtest: flip-vs-cursor-busy-crc-legacy
[737.729052] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.731s)
[738.529494] [150/156] (291s left) syncobj_wait (wait-zero-handles)
[738.586559] Starting subtest: wait-zero-handles
[738.588794] Subtest wait-zero-handles: SUCCESS (0.000s)
[738.663877] [151/156] (291s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-blt)
[738.763717] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-blt
[738.767712] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[738.849774] [152/156] (291s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[738.954990] Starting subtest: basic-busy-flip-before-cursor-legacy
[738.959534] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[739.080182] [153/156] (290s left) gem_mmap_gtt (medium-copy-odd)
[739.134801] Subtest medium-copy-odd: SKIP (0.000s)
[739.194957] [154/156] (290s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[739.312757] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[739.317195] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[739.439398] [155/156] (290s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping)
[739.532650] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping
[739.536124] Subtest pixel-format-yf-tiled-modifier-source-clamping: SKIP (0.000s)
[739.585034] [156/156] (290s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[739.684527] Starting subtest: y-tiled-32bpp-rotate-270
[739.688167] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[739.768862] Closing watchdogs
results: parsing output: 0/ for test: gem_ctx_engines
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_busy
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: kms_hdr
results: parsing output: 6/ for test: api_intel_allocator
results: parsing output: 7/ for test: i915_query
results: parsing output: 8/ for test: gem_eio
results: parsing output: 9/ for test: kms_ccs
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: gem_ctx_create
results: parsing output: 12/ for test: kms_chamelium_edid
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: gem_render_copy
results: parsing output: 17/ for test: gem_ctx_persistence
results: parsing output: 18/ for test: kms_invalid_mode
results: parsing output: 19/ for test: gem_ctx_sseu
results: parsing output: 20/ for test: gen7_exec_parse
results: parsing output: 21/ for test: gem_render_copy_redux
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: gem_exec_params
results: parsing output: 26/ for test: gem_exec_suspend
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: gem_exec_params
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: gem_exec_balancer
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_spin_batch
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_cursor_legacy
results: parsing output: 38/ for test: syncobj_timeline
results: parsing output: 39/ for test: vgem_basic
results: parsing output: 40/ for test: i915_hangman
results: parsing output: 41/ for test: gem_ctx_isolation
results: parsing output: 42/ for test: gem_mmap_offset
results: parsing output: 43/ for test: kms_color
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: api_intel_bb
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: gem_pxp
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: i915_suspend
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: sw_sync
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: gem_lmem_swapping
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: gem_mmap_gtt
results: parsing output: 59/ for test: syncobj_eventfd
results: parsing output: 60/ for test: kms_cursor_crc
results: parsing output: 61/ for test: kms_psr2_sf
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: perf_pmu
results: parsing output: 64/ for test: syncobj_timeline
results: parsing output: 65/ for test: kms_cursor_legacy
results: parsing output: 66/ for test: dumb_buffer
results: parsing output: 67/ for test: gem_exec_whisper
results: parsing output: 68/ for test: gem_userptr_blits
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: kms_cursor_edge_walk
results: parsing output: 71/ for test: kms_content_protection
results: parsing output: 72/ for test: gen9_exec_parse
results: parsing output: 73/ for test: kms_addfb_basic
results: parsing output: 74/ for test: gem_render_copy
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_exec_fence
results: parsing output: 78/ for test: kms_pm_rpm
results: parsing output: 79/ for test: kms_lease
results: parsing output: 80/ for test: gem_mmap_wc
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_exec_schedule
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: gem_lmem_swapping
results: parsing output: 86/ for test: kms_psr2_sf
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_rotation_crc
results: parsing output: 90/ for test: gem_exec_params
results: parsing output: 91/ for test: i915_pm_rpm
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_ccs
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_chamelium_hpd
results: parsing output: 98/ for test: kms_plane_scaling
results: parsing output: 99/ for test: prime_self_import
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_wait
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_mmap_wc
results: parsing output: 105/ for test: gem_pipe_control_store_loop
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: syncobj_wait
results: parsing output: 109/ for test: kms_flip_scaled_crc
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: kms_plane_scaling
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_exec_schedule
results: parsing output: 114/ for test: gem_mmap_gtt
results: parsing output: 115/ for test: kms_addfb_basic
results: parsing output: 116/ for test: kms_ccs
results: parsing output: 117/ for test: kms_addfb_basic
results: parsing output: 118/ for test: kms_vblank
results: parsing output: 119/ for test: kms_pm_lpsp
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: gem_exec_gttfill
results: parsing output: 122/ for test: gem_ctx_create
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_cursor_crc
results: parsing output: 126/ for test: syncobj_basic
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_dsc
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: fbdev
results: parsing output: 131/ for test: kms_big_fb
results: parsing output: 132/ for test: kms_flip_scaled_crc
results: parsing output: 133/ for test: kms_plane_multiple
results: parsing output: 134/ for test: kms_vblank
results: parsing output: 135/ for test: perf_pmu
results: parsing output: 136/ for test: kms_plane_cursor
results: parsing output: 137/ for test: kms_flip
results: parsing output: 138/ for test: gem_mmap_wc
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: gem_exec_fence
results: parsing output: 142/ for test: gem_ctx_exec
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: perf
results: parsing output: 146/ for test: perf_pmu
results: parsing output: 147/ for test: syncobj_timeline
results: parsing output: 148/ for test: kms_cursor_legacy
results: parsing output: 149/ for test: syncobj_wait
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: kms_cursor_legacy
results: parsing output: 152/ for test: gem_mmap_gtt
results: parsing output: 153/ for test: kms_cursor_legacy
results: parsing output: 154/ for test: kms_plane
results: parsing output: 155/ for test: kms_big_fb
Done.