[56.726818] Initializing watchdogs
[56.727000]   /dev/watchdog0
[56.741915] [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.746222] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.748567] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.751922] [001/131] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[56.882690] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[56.887185] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[56.991628] [002/131] (960s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-cpu)
[57.101796] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-cpu
[61.104171] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (3.956s)
[62.317601] [003/131] (955s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[62.423246] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[62.427753] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[62.524518] [004/131] (954s left) gem_ctx_param (set-priority-range)
[62.581527] Starting subtest: set-priority-range
[62.597003] Subtest set-priority-range: SUCCESS (0.015s)
[62.697077] [005/131] (954s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[62.794989] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[62.797478] Starting dynamic subtest: A-eDP1
[66.459576] Dynamic subtest A-eDP1: SUCCESS (3.640s)
[66.469315] Starting dynamic subtest: B-eDP1
[69.665440] Dynamic subtest B-eDP1: SUCCESS (3.193s)
[69.673989] Starting dynamic subtest: C-eDP1
[72.764643] Dynamic subtest C-eDP1: SUCCESS (3.089s)
[72.773868] Starting dynamic subtest: D-eDP1
[75.881766] Dynamic subtest D-eDP1: SUCCESS (3.113s)
[75.884150] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.041s)
[76.681801] [006/131] (940s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[76.779980] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[76.784252] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[76.878185] [007/131] (940s left) i915_suspend (fence-restore-tiled2untiled)
[76.930863] Starting subtest: fence-restore-tiled2untiled
[76.934983] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[77.030535] [008/131] (940s left) gem_madvise (dontneed-before-mmap)
[77.063089] Starting subtest: dontneed-before-mmap
[77.092305] Subtest dontneed-before-mmap: SUCCESS (0.030s)
[77.190554] [009/131] (940s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[82.170714] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[82.175101] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.002s)
[83.015626] [010/131] (934s left) gem_exec_whisper (basic-fds)
[83.083626] Starting subtest: basic-fds
[88.949093] Subtest basic-fds: SUCCESS (5.859s)
[89.130169] [011/131] (928s left) prime_mmap_coherency (ioctl-errors)
[89.201736] Starting subtest: ioctl-errors
[104.101517] Subtest ioctl-errors: SUCCESS (14.897s)
[104.250452] [012/131] (913s left) syncobj_timeline (signal-point-0)
[104.354208] Starting subtest: signal-point-0
[104.356288] Subtest signal-point-0: SUCCESS (0.000s)
[104.454406] [013/131] (913s left) i915_pm_rc6_residency (rc6-idle)
[104.510982] Starting subtest: rc6-idle
[104.568155] Starting dynamic subtest: gt0-rcs0
[128.841689] Dynamic subtest gt0-rcs0: SUCCESS (24.269s)
[128.850079] Starting dynamic subtest: gt0-bcs0
[153.171107] Dynamic subtest gt0-bcs0: SUCCESS (24.327s)
[153.179182] Starting dynamic subtest: gt0-ccs0
[177.450048] Dynamic subtest gt0-ccs0: SUCCESS (24.277s)
[177.458096] Starting dynamic subtest: gt1-vcs0
[183.623192] Dynamic subtest gt1-vcs0: SUCCESS (6.170s)
[183.633857] Starting dynamic subtest: gt1-vecs0
[189.794596] Dynamic subtest gt1-vecs0: SUCCESS (6.170s)
[189.797692] Subtest rc6-idle: SUCCESS (85.278s)
[189.876283] [014/131] (827s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[189.991838] Starting subtest: x-tiled-8bpp-rotate-90
[190.012795] Subtest x-tiled-8bpp-rotate-90: SKIP (0.021s)
[190.134147] [015/131] (827s left) kms_rotation_crc (multiplane-rotation)
[190.230118] Starting subtest: multiplane-rotation
[197.490072] Subtest multiplane-rotation: SUCCESS (7.260s)
[197.626023] [016/131] (820s left) gen3_render_tiledx_blits
[197.736796] [017/131] (820s left) gem_exec_balancer (parallel)
[197.987462] Starting subtest: parallel
[198.909334] Subtest parallel: SUCCESS (0.922s)
[199.926641] [018/131] (817s left) i915_query (hwconfig_table)
[199.993455] Starting subtest: hwconfig_table
[200.299735] Subtest hwconfig_table: SUCCESS (0.001s)
[200.337115] [019/131] (817s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[200.441193] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[200.443529] Starting dynamic subtest: pipe-A-eDP-1
[200.466274] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.024s)
[200.474884] Starting dynamic subtest: pipe-B-eDP-1
[200.495157] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[200.503587] Starting dynamic subtest: pipe-C-eDP-1
[200.523178] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s)
[200.531605] Starting dynamic subtest: pipe-D-eDP-1
[200.551670] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[200.554036] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.093s)
[202.685926] [020/131] (815s left) kms_pm_rpm (system-suspend-modeset)
[204.235425] Starting subtest: system-suspend-modeset
[224.170229] Subtest system-suspend-modeset: SUCCESS (4.727s)
[224.557008] [021/131] (793s left) gem_softpin (allocator-nopin)
[224.637566] Starting subtest: allocator-nopin
[224.751881] Subtest allocator-nopin: SUCCESS (0.111s)
[224.897536] [022/131] (793s left) gem_exec_parallel (engines)
[224.961703] Starting subtest: engines
[224.964277] Starting dynamic subtest: basic
[227.083208] Dynamic subtest basic: SUCCESS (2.089s)
[227.095366] Starting dynamic subtest: contexts
[231.338842] Dynamic subtest contexts: SUCCESS (4.210s)
[231.347970] Starting dynamic subtest: fds
[235.165361] Dynamic subtest fds: SUCCESS (3.801s)
[235.177973] Starting dynamic subtest: userptr
[237.069835] Dynamic subtest userptr: SUCCESS (1.895s)
[237.072547] Subtest engines: SUCCESS (12.001s)
[237.256247] [023/131] (780s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[237.365595] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[237.369805] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[237.483388] [024/131] (780s left) gem_userptr_blits (dmabuf-unsync)
[237.557782] Subtest dmabuf-unsync: SKIP (0.000s)
[237.713067] [025/131] (780s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[237.823412] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[237.827806] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[237.935443] [026/131] (780s left) kms_pipe_crc_basic (bad-source)
[238.039335] Starting subtest: bad-source
[238.041946] Subtest bad-source: SUCCESS (0.000s)
[238.114693] [027/131] (780s left) perf_pmu (render-node-busy-idle)
[238.224626] Starting subtest: render-node-busy-idle
[238.226755] Starting dynamic subtest: rcs0
[238.922158] Dynamic subtest rcs0: SUCCESS (0.694s)
[238.934165] Starting dynamic subtest: bcs0
[239.593828] Dynamic subtest bcs0: SUCCESS (0.669s)
[239.605613] Starting dynamic subtest: vcs0
[241.101639] Dynamic subtest vcs0: SUCCESS (1.500s)
[241.114034] Starting dynamic subtest: vcs1
[243.085479] Dynamic subtest vcs1: SUCCESS (1.977s)
[243.098015] Starting dynamic subtest: vecs0
[245.069518] Dynamic subtest vecs0: SUCCESS (1.978s)
[245.079933] Starting dynamic subtest: ccs0
[245.739882] Dynamic subtest ccs0: SUCCESS (0.669s)
[245.742584] Subtest render-node-busy-idle: SUCCESS (7.498s)
[245.818749] [028/131] (772s left) kms_big_fb (linear-8bpp-rotate-90)
[245.917094] Starting subtest: linear-8bpp-rotate-90
[245.938225] Subtest linear-8bpp-rotate-90: SKIP (0.021s)
[246.060339] [029/131] (772s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[246.159197] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[246.161464] Starting dynamic subtest: pipe-A-eDP-1
[246.186184] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[246.196073] Starting dynamic subtest: pipe-B-eDP-1
[246.218796] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[246.227521] Starting dynamic subtest: pipe-C-eDP-1
[246.251412] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[246.262167] Starting dynamic subtest: pipe-D-eDP-1
[246.287355] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[246.291906] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[248.363464] [030/131] (769s left) prime_vgem (fence-wait)
[248.532912] Starting subtest: fence-wait
[248.535104] Starting dynamic subtest: rcs0
[249.576478] Dynamic subtest rcs0: SUCCESS (1.041s)
[249.587233] Starting dynamic subtest: bcs0
[250.641740] Dynamic subtest bcs0: SUCCESS (1.062s)
[250.653795] Starting dynamic subtest: vcs0
[251.684984] Dynamic subtest vcs0: SUCCESS (1.041s)
[251.696421] Starting dynamic subtest: vcs1
[252.727909] Dynamic subtest vcs1: SUCCESS (1.041s)
[252.740051] Starting dynamic subtest: vecs0
[254.081653] Dynamic subtest vecs0: SUCCESS (1.352s)
[254.093861] Starting dynamic subtest: ccs0
[256.064236] Dynamic subtest ccs0: SUCCESS (1.980s)
[256.066957] Subtest fence-wait: SUCCESS (7.527s)
[256.210547] [FACT prime_vgem (fence-wait)] new: kernel.kmod_is_loaded.vgem: true
[256.214606] [031/131] (762s left) gem_ccs (block-multicopy-inplace)
[256.281851] Starting subtest: block-multicopy-inplace
[256.286469] Subtest block-multicopy-inplace: SKIP (0.000s)
[256.391003] [032/131] (762s left) gem_exec_reloc (basic-cpu-gtt-active)
[256.459229] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[256.523665] [033/131] (761s left) api_intel_allocator (fork-simple-once)
[256.582846] Starting subtest: fork-simple-once
[256.595569] Subtest fork-simple-once: SUCCESS (0.016s)
[256.729973] [034/131] (761s left) kms_flip (absolute-wf_vblank)
[256.833212] Starting subtest: absolute-wf_vblank
[256.835490] Starting dynamic subtest: A-eDP1
[265.630907] Dynamic subtest A-eDP1: SUCCESS (8.797s)
[265.642195] Starting dynamic subtest: B-eDP1
[274.377306] Dynamic subtest B-eDP1: SUCCESS (8.743s)
[274.386723] Starting dynamic subtest: C-eDP1
[283.102517] Dynamic subtest C-eDP1: SUCCESS (8.719s)
[283.114016] Starting dynamic subtest: D-eDP1
[291.841552] Dynamic subtest D-eDP1: SUCCESS (8.736s)
[291.843933] Subtest absolute-wf_vblank: SUCCESS (35.004s)
[293.051144] [035/131] (725s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[293.150274] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[293.154827] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[294.276589] [036/131] (724s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[294.385150] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[294.389756] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[294.496585] [037/131] (724s left) kms_psr (fbc-psr2-cursor-blt)
[294.597353] Starting subtest: fbc-psr2-cursor-blt
[294.599639] Starting dynamic subtest: eDP-1
[294.603821] Dynamic subtest eDP-1: SKIP (0.000s)
[294.608093] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[294.672131] [038/131] (723s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[294.772994] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[294.775372] Starting dynamic subtest: pipe-A-eDP-1
[294.798492] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[294.809300] Starting dynamic subtest: pipe-B-eDP-1
[294.830885] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[294.839769] Starting dynamic subtest: pipe-C-eDP-1
[294.861898] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[294.872016] Starting dynamic subtest: pipe-D-eDP-1
[294.894958] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[294.899471] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.004s)
[296.959741] [039/131] (721s left) kms_plane (plane-position-hole)
[297.054015] Starting subtest: plane-position-hole
[297.545530] Starting dynamic subtest: pipe-A-plane-1
[298.812349] Dynamic subtest pipe-A-plane-1: SUCCESS (1.264s)
[298.823988] Starting dynamic subtest: pipe-A-plane-2
[300.052090] Dynamic subtest pipe-A-plane-2: SUCCESS (1.241s)
[300.061798] Starting dynamic subtest: pipe-A-plane-3
[301.302005] Dynamic subtest pipe-A-plane-3: SUCCESS (1.248s)
[301.312679] Starting dynamic subtest: pipe-A-plane-4
[302.555423] Dynamic subtest pipe-A-plane-4: SUCCESS (1.253s)
[302.565626] Starting dynamic subtest: pipe-A-plane-5
[302.581897] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[303.778690] Starting dynamic subtest: pipe-B-plane-1
[305.038355] Dynamic subtest pipe-B-plane-1: SUCCESS (1.268s)
[305.049756] Starting dynamic subtest: pipe-B-plane-2
[306.328172] Dynamic subtest pipe-B-plane-2: SUCCESS (1.288s)
[306.338627] Starting dynamic subtest: pipe-B-plane-3
[307.546249] Dynamic subtest pipe-B-plane-3: SUCCESS (1.217s)
[307.557167] Starting dynamic subtest: pipe-B-plane-4
[308.767766] Dynamic subtest pipe-B-plane-4: SUCCESS (1.220s)
[308.778060] Starting dynamic subtest: pipe-B-plane-5
[308.795896] Dynamic subtest pipe-B-plane-5: SUCCESS (0.026s)
[308.798270] Subtest plane-position-hole: SUCCESS (11.735s)
[309.581178] [040/131] (709s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[309.644512] Starting subtest: yf-tiled-to-vebox-x-tiled
[309.648882] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[309.826893] [041/131] (708s left) gem_exec_params (invalid-ring)
[309.893607] Starting subtest: invalid-ring
[309.895942] Subtest invalid-ring: SUCCESS (0.000s)
[310.011916] [042/131] (708s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[310.078105] Starting subtest: basic-batch-kernel-default-cmd
[310.082283] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[310.263343] [043/131] (708s left) gem_exec_fence (long-history)
[310.680462] Starting subtest: long-history
[317.799790] Subtest long-history: SUCCESS (7.118s)
[318.316776] [044/131] (700s left) gem_mmap (short-mmap)
[318.370978] Subtest short-mmap: SKIP (0.000s)
[318.439551] [045/131] (700s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[318.534315] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[318.536519] Starting dynamic subtest: pipe-A-default-mode
[318.830671] Dynamic subtest pipe-A-default-mode: SKIP (0.291s)
[318.835108] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.292s)
[319.626188] [046/131] (699s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[319.730659] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[325.001558] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.277s)
[326.134630] [047/131] (692s left) kms_psr (pr-cursor-mmap-cpu)
[326.237188] Starting subtest: pr-cursor-mmap-cpu
[326.241705] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[326.307301] [048/131] (692s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[326.425654] Starting subtest: cursorA-vs-flipA-legacy
[337.536543] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.114s)
[338.355016] [049/131] (680s left) kms_plane_scaling (planes-scaler-unity-scaling)
[338.457284] Starting subtest: planes-scaler-unity-scaling
[338.459567] Starting dynamic subtest: pipe-A
[338.526579] Dynamic subtest pipe-A: SUCCESS (0.069s)
[338.535843] Starting dynamic subtest: pipe-B
[339.679830] Dynamic subtest pipe-B: SUCCESS (1.152s)
[339.692291] Starting dynamic subtest: pipe-C
[340.796364] Dynamic subtest pipe-C: SUCCESS (1.116s)
[340.806208] Starting dynamic subtest: pipe-D
[341.920473] Dynamic subtest pipe-D: SUCCESS (1.123s)
[341.922869] Subtest planes-scaler-unity-scaling: SUCCESS (3.464s)
[343.082048] [050/131] (676s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[343.184759] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[343.188918] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[343.296277] [051/131] (675s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[343.347576] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[343.457566] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.109s)
[343.532575] [052/131] (675s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[343.636137] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[343.640611] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[343.724790] [053/131] (675s left) gem_mmap_offset (bad-extensions)
[343.789016] Starting subtest: bad-extensions
[343.791356] Subtest bad-extensions: SUCCESS (0.000s)
[343.895990] [054/131] (675s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[344.004222] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[344.008537] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[344.095286] [055/131] (675s left) gem_bad_reloc (negative-reloc)
[344.166238] Subtest negative-reloc: SKIP (0.000s)
[344.250986] [056/131] (675s left) perf (non-sampling-read-error)
[344.375314] Starting subtest: non-sampling-read-error
[344.386316] Subtest non-sampling-read-error: SUCCESS (0.011s)
[344.429586] [057/131] (674s left) syncobj_timeline (device-submit-unordered)
[344.495865] Starting subtest: device-submit-unordered
[344.497637] Subtest device-submit-unordered: SUCCESS (0.000s)
[344.608580] [058/131] (674s left) gem_exec_schedule (u-semaphore-resolve)
[344.680329] Starting subtest: u-semaphore-resolve
[344.714592] Subtest u-semaphore-resolve: SUCCESS (0.038s)
[345.063749] [059/131] (674s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[345.117537] Starting subtest: saturated-hostile-nopreempt
[345.119892] Starting dynamic subtest: rcs0
[345.222926] Dynamic subtest rcs0: SKIP (0.102s)
[345.232445] Starting dynamic subtest: bcs0
[345.250739] Dynamic subtest bcs0: SKIP (0.027s)
[345.259755] Starting dynamic subtest: vcs0
[345.268659] Dynamic subtest vcs0: SKIP (0.017s)
[345.277371] Starting dynamic subtest: vcs1
[345.290829] Dynamic subtest vcs1: SKIP (0.021s)
[345.300007] Starting dynamic subtest: vecs0
[345.313618] Dynamic subtest vecs0: SKIP (0.022s)
[345.322304] Starting dynamic subtest: ccs0
[345.340527] Dynamic subtest ccs0: SKIP (0.025s)
[345.345203] Subtest saturated-hostile-nopreempt: SKIP (0.220s)
[345.415497] [060/131] (674s left) syncobj_timeline (wait-any-interrupted)
[345.467700] Starting subtest: wait-any-interrupted
[345.571555] Subtest wait-any-interrupted: SUCCESS (0.103s)
[345.647376] [061/131] (673s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[345.748853] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[345.753326] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[345.858047] [062/131] (673s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[345.956894] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[345.960981] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[346.080807] [063/131] (673s left) prime_mmap_coherency (read)
[346.138603] Starting subtest: read
[351.513207] Subtest read: SUCCESS (5.373s)
[351.645472] [064/131] (668s left) kms_pm_rpm (drm-resources-equal)
[353.168761] Starting subtest: drm-resources-equal
[358.583162] Subtest drm-resources-equal: SUCCESS (5.415s)
[358.669719] [065/131] (661s left) perf (invalid-create-userspace-config)
[358.749238] Starting subtest: invalid-create-userspace-config
[358.751709] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[358.795410] [066/131] (660s left) gem_render_linear_blits (basic)
[358.857733] Starting subtest: basic
[358.879457] Subtest basic: SUCCESS (0.024s)
[358.976486] [067/131] (660s left) gem_exec_schedule (pi-common)
[359.150773] Starting subtest: pi-common
[359.152994] Starting dynamic subtest: rcs0
[359.232157] Dynamic subtest rcs0: SUCCESS (0.083s)
[359.242828] Starting dynamic subtest: bcs0
[359.315185] Dynamic subtest bcs0: SUCCESS (0.081s)
[359.331663] Starting dynamic subtest: vcs0
[359.392741] Dynamic subtest vcs0: SUCCESS (0.076s)
[359.408108] Starting dynamic subtest: vcs1
[359.468883] Dynamic subtest vcs1: SUCCESS (0.075s)
[359.483985] Starting dynamic subtest: vecs0
[359.545314] Dynamic subtest vecs0: SUCCESS (0.074s)
[359.560340] Starting dynamic subtest: ccs0
[359.619519] Dynamic subtest ccs0: SUCCESS (0.073s)
[359.621949] Subtest pi-common: SUCCESS (0.472s)
[359.871432] [068/131] (660s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[359.977304] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[359.981460] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[360.087272] [069/131] (659s left) kms_chamelium_frames (dp-crc-fast)
[360.487905] Subtest dp-crc-fast: SKIP (0.000s)
[361.317333] [070/131] (658s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[361.366402] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[361.412305] [071/131] (658s left) gen9_exec_parse (secure-batches)
[361.474321] Subtest secure-batches: SKIP (0.000s)
[361.553834] [072/131] (658s left) core_getstats
[361.718825] [073/131] (658s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[361.815630] Starting subtest: y-tiled-8bpp-rotate-270
[361.819771] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[361.913800] [074/131] (658s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[362.049431] Starting subtest: basic-flip-before-cursor-varying-size
[362.973082] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.925s)
[363.775489] [075/131] (656s left) device_reset (unbind-cold-reset-rebind)
[363.830942] Starting subtest: unbind-cold-reset-rebind
[363.835525] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[363.906073] [076/131] (656s left) gem_vm_create (invalid-destroy)
[363.972000] Starting subtest: invalid-destroy
[363.974332] Subtest invalid-destroy: SUCCESS (0.002s)
[364.084902] [077/131] (656s left) i915_fb_tiling (basic-x-tiling)
[364.139693] Subtest basic-x-tiling: SKIP (0.000s)
[364.206693] [078/131] (656s left) kms_psr (psr2-primary-render)
[364.299489] Starting subtest: psr2-primary-render
[364.302200] Starting dynamic subtest: eDP-1
[366.073065] Dynamic subtest eDP-1: SUCCESS (1.773s)
[366.075503] Subtest psr2-primary-render: SUCCESS (1.773s)
[366.943068] [079/131] (653s left) kms_writeback (writeback-pixel-formats)
[367.050163] Subtest writeback-pixel-formats: SKIP (0.000s)
[367.096921] [080/131] (653s left) kms_cursor_crc (cursor-random-64x21)
[367.295591] Starting subtest: cursor-random-64x21
[367.341685] Subtest cursor-random-64x21: SKIP (0.040s)
[367.562373] [081/131] (652s left) kms_debugfs (display-off-read-all)
[367.664173] Starting subtest: display-off-read-all
[367.954985] Subtest display-off-read-all: SUCCESS (0.288s)
[368.784729] [082/131] (651s left) syncobj_timeline (invalid-query-bad-pad)
[368.844203] Starting subtest: invalid-query-bad-pad
[368.846633] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[368.935216] [083/131] (651s left) kms_vblank (query-forked-busy-hang)
[369.027290] Starting subtest: query-forked-busy-hang
[369.029571] Starting dynamic subtest: pipe-A-eDP-1
[396.809489] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.773s)
[396.824131] Starting dynamic subtest: pipe-D-eDP-1
[421.830717] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.012s)
[421.833154] Subtest query-forked-busy-hang: SUCCESS (52.791s)
[422.659360] [084/131] (597s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[422.753603] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[429.467965] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.715s)
[429.613734] [085/131] (590s left) gem_exec_schedule (promotion)
[429.687322] Starting subtest: promotion
[429.689461] Starting dynamic subtest: rcs0
[429.787204] Dynamic subtest rcs0: SUCCESS (0.105s)
[429.799040] Starting dynamic subtest: vcs0
[429.872563] Dynamic subtest vcs0: SUCCESS (0.086s)
[429.882449] Starting dynamic subtest: vcs1
[429.951515] Dynamic subtest vcs1: SUCCESS (0.078s)
[429.962662] Starting dynamic subtest: vecs0
[430.030626] Dynamic subtest vecs0: SUCCESS (0.078s)
[430.042091] Starting dynamic subtest: ccs0
[430.116182] Dynamic subtest ccs0: SUCCESS (0.084s)
[430.118754] Subtest promotion: SUCCESS (0.435s)
[431.168132] [086/131] (589s left) perf_pmu (interrupts-sync)
[431.208012] Starting subtest: interrupts-sync
[432.291191] Subtest interrupts-sync: SUCCESS (1.081s)
[432.424926] [087/131] (588s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[432.510344] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[432.512591] Starting dynamic subtest: pipe-A-default-mode
[432.804986] Dynamic subtest pipe-A-default-mode: SKIP (0.289s)
[432.809422] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.291s)
[433.608190] [088/131] (587s left) gem_tiled_pread_pwrite
[433.746097] [089/131] (586s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[434.146816] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[434.922944] [090/131] (585s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[435.028713] Starting subtest: fbcpsr-stridechange
[441.228904] Subtest fbcpsr-stridechange: SUCCESS (6.201s)
[441.370257] [091/131] (579s left) gem_userptr_blits (huge-split)
[441.438997] Starting subtest: huge-split
[441.445270] Subtest huge-split: SUCCESS (0.007s)
[441.587311] [092/131] (579s left) kms_big_fb (linear-16bpp-rotate-90)
[441.691872] Starting subtest: linear-16bpp-rotate-90
[441.710736] Subtest linear-16bpp-rotate-90: SKIP (0.018s)
[441.835581] [093/131] (579s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[441.959763] Starting subtest: short-busy-flip-before-cursor-toggle
[441.964316] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[442.102820] [094/131] (578s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[442.204190] Starting subtest: bad-pixel-format-y-tiled-ccs
[442.206252] Starting dynamic subtest: pipe-A-eDP-1
[442.226024] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[442.237627] Starting dynamic subtest: pipe-B-eDP-1
[442.254989] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[442.264775] Starting dynamic subtest: pipe-C-eDP-1
[442.282075] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[442.291901] Starting dynamic subtest: pipe-D-eDP-1
[442.310054] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[442.313435] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.004s)
[444.358386] [095/131] (576s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[444.480630] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[445.931883] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.451s)
[446.725052] [096/131] (574s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[446.827452] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[446.831958] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[446.945270] [097/131] (574s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[447.150058] Starting subtest: cursor-rapid-movement-128x128
[447.155084] Starting dynamic subtest: pipe-A-eDP-1
[447.694391] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.541s)
[447.722951] Starting dynamic subtest: pipe-D-eDP-1
[448.942214] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.226s)
[448.944552] Subtest cursor-rapid-movement-128x128: SUCCESS (1.791s)
[449.800720] [098/131] (571s left) kms_color (degamma)
[449.902269] Starting subtest: degamma
[449.904661] Starting dynamic subtest: pipe-A-eDP-1
[450.633606] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.731s)
[450.643617] Starting dynamic subtest: pipe-B-eDP-1
[452.012185] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.376s)
[452.022427] Starting dynamic subtest: pipe-C-eDP-1
[453.371308] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.361s)
[453.382188] Starting dynamic subtest: pipe-D-eDP-1
[454.739902] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.369s)
[454.742398] Subtest degamma: SUCCESS (4.839s)
[455.541245] [099/131] (565s left) vgem_basic (busy-fence)
[455.584092] Starting subtest: busy-fence
[455.586072] Subtest busy-fence: SUCCESS (0.000s)
[455.654007] [100/131] (565s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[455.706705] Starting subtest: etime-single-wait-for-submit-submitted
[455.808449] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.101s)
[455.883221] [101/131] (565s left) kms_cursor_crc (cursor-offscreen-32x10)
[456.049412] Starting subtest: cursor-offscreen-32x10
[456.093535] Subtest cursor-offscreen-32x10: SKIP (0.039s)
[456.372754] [102/131] (564s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[456.478183] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[456.481805] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[456.598846] [103/131] (564s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[456.697315] Starting subtest: basic-modeset-with-all-modifiers-formats
[457.067856] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[457.822825] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.755s)
[457.832974] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[457.845004] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.022s)
[457.854592] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[457.866904] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.022s)
[457.877937] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[458.011884] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.144s)
[458.024687] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[458.034902] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.022s)
[458.050432] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[458.055992] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.021s)
[458.065864] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[458.078228] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.022s)
[458.087446] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[458.101095] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.021s)
[458.117352] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[458.123581] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s)
[458.134976] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[458.144879] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.022s)
[458.154526] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[458.167230] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.022s)
[458.178342] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[458.189296] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.022s)
[458.198926] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[458.345383] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.153s)
[458.355074] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[458.366898] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.022s)
[458.376519] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[458.389334] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.022s)
[458.399281] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[458.411422] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s)
[458.421070] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[458.433669] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s)
[458.443080] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[458.456300] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.022s)
[458.468622] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[458.478188] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.022s)
[458.487727] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[458.500056] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.022s)
[458.510707] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[458.522725] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[458.532020] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[458.677861] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.155s)
[458.687430] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[458.700333] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.022s)
[458.709571] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[458.722958] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.022s)
[458.732184] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[458.744901] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s)
[458.754197] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[458.766962] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.022s)
[458.776079] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[458.789309] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s)
[458.798849] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[458.811437] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[458.822853] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[458.833725] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.021s)
[458.842837] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[458.855922] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.022s)
[459.232911] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.538s)
[460.005803] [104/131] (561s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[460.115556] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[466.895943] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.784s)
[467.041679] [105/131] (554s left) gem_flink_basic (flink-lifetime)
[467.100760] Starting subtest: flink-lifetime
[467.102997] Subtest flink-lifetime: SUCCESS (0.002s)
[467.200495] [106/131] (554s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[467.301144] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[467.305272] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[467.407460] [107/131] (554s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[467.511103] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[467.515277] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[467.622553] [108/131] (553s left) gem_pxp (reject-modify-context-protection-off-3)
[467.746986] Starting subtest: reject-modify-context-protection-off-3
[467.749521] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[467.860598] [109/131] (553s left) kms_psr (fbc-pr-cursor-blt)
[467.950430] Starting subtest: fbc-pr-cursor-blt
[467.954368] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[468.025080] [110/131] (553s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[472.988942] Starting subtest: psr2-cursor-plane-move-continuous-sf
[472.991790] Starting dynamic subtest: pipe-A-eDP-1
[484.100704] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.109s)
[484.111205] Starting dynamic subtest: pipe-B-eDP-1
[495.122928] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.022s)
[495.125264] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (22.135s)
[495.917188] [111/131] (525s left) kms_flip (modeset-vs-vblank-race-interruptible)
[496.015270] Starting subtest: modeset-vs-vblank-race-interruptible
[496.017582] Starting dynamic subtest: A-eDP1
[500.734715] Dynamic subtest A-eDP1: SUCCESS (4.718s)
[500.747792] Starting dynamic subtest: B-eDP1
[505.364635] Dynamic subtest B-eDP1: SUCCESS (4.627s)
[505.377703] Starting dynamic subtest: C-eDP1
[509.878393] Dynamic subtest C-eDP1: SUCCESS (4.512s)
[509.888594] Starting dynamic subtest: D-eDP1
[514.408991] Dynamic subtest D-eDP1: SUCCESS (4.530s)
[514.411400] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.396s)
[515.572202] [112/131] (506s left) gem_exec_reloc (basic-write-cpu-noreloc)
[515.634171] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[515.699300] [113/131] (506s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[515.805414] Starting subtest: 4-tiled-64bpp-rotate-90
[515.825009] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.019s)
[515.963891] [114/131] (505s left) syncobj_wait (wait-all-for-submit-snapshot)
[516.022856] Starting subtest: wait-all-for-submit-snapshot
[516.105181] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[516.187078] [115/131] (505s left) gem_ctx_exec (basic-norecovery)
[516.243697] Starting subtest: basic-norecovery
[516.589175] Subtest basic-norecovery: SUCCESS (0.346s)
[516.726850] [116/131] (505s left) gem_ctx_persistence (legacy-engines-hostile)
[516.779195] Starting subtest: legacy-engines-hostile
[516.781202] Starting dynamic subtest: render
[516.856021] Dynamic subtest render: SUCCESS (0.076s)
[516.870359] Starting dynamic subtest: bsd1
[516.975711] Dynamic subtest bsd1: SUCCESS (0.117s)
[516.991402] Starting dynamic subtest: bsd2
[517.089805] Dynamic subtest bsd2: SUCCESS (0.111s)
[517.104372] Starting dynamic subtest: blt
[517.200351] Dynamic subtest blt: SUCCESS (0.108s)
[517.215770] Starting dynamic subtest: vebox
[517.278412] Dynamic subtest vebox: SUCCESS (0.075s)
[517.280465] Subtest legacy-engines-hostile: SUCCESS (0.500s)
[517.422704] [117/131] (504s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[517.523190] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[524.751142] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.229s)
[524.861253] [118/131] (497s left) kms_psr (psr2-cursor-mmap-gtt)
[524.955250] Starting subtest: psr2-cursor-mmap-gtt
[524.957548] Starting dynamic subtest: eDP-1
[526.647843] Dynamic subtest eDP-1: SUCCESS (1.693s)
[526.650206] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.694s)
[527.437311] [119/131] (494s left) api_intel_allocator (standalone)
[527.500669] Starting subtest: standalone
[527.517099] Subtest standalone: SUCCESS (0.019s)
[527.648629] [120/131] (494s left) kms_busy (extended-modeset-hang-oldfb)
[527.754918] Starting subtest: extended-modeset-hang-oldfb
[527.757231] Starting dynamic subtest: pipe-A
[539.425166] Dynamic subtest pipe-A: SUCCESS (11.667s)
[539.435706] Starting dynamic subtest: pipe-D
[551.704876] Dynamic subtest pipe-D: SUCCESS (12.275s)
[551.707653] Subtest extended-modeset-hang-oldfb: SUCCESS (23.947s)
[552.505728] [121/131] (469s left) kms_rotation_crc (primary-rotation-270)
[552.607224] Starting subtest: primary-rotation-270
[552.611730] Subtest primary-rotation-270: SKIP (0.001s)
[552.685751] [122/131] (469s left) gem_ctx_sseu (invalid-args)
[552.741087] Subtest invalid-args: SKIP (0.000s)
[552.825735] [123/131] (469s left) prime_mmap (test_errors)
[552.884720] Starting subtest: test_errors
[552.886645] Starting dynamic subtest: test_errors-smem
[552.982370] Dynamic subtest test_errors-smem: SUCCESS (0.100s)
[552.984912] Subtest test_errors: SUCCESS (0.101s)
[553.081193] [124/131] (469s left) kms_lease (lease-invalid-plane)
[553.167382] Starting subtest: lease-invalid-plane
[553.169617] Starting dynamic subtest: pipe-A-eDP-1
[553.171963] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[553.182760] Starting dynamic subtest: pipe-B-eDP-1
[553.184696] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[553.194909] Starting dynamic subtest: pipe-C-eDP-1
[553.197157] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[553.206566] Starting dynamic subtest: pipe-D-eDP-1
[553.208453] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[553.210369] Subtest lease-invalid-plane: SUCCESS (0.004s)
[553.248942] [125/131] (468s left) kms_plane_alpha_blend (alpha-7efc)
[553.348395] Starting subtest: alpha-7efc
[553.645160] Starting dynamic subtest: pipe-A-eDP-1
[554.233907] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.586s)
[554.259180] Starting dynamic subtest: pipe-D-eDP-1
[555.494890] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.240s)
[555.497219] Subtest alpha-7efc: SUCCESS (2.143s)
[556.358699] [126/131] (465s left) kms_flip (flip-vs-blocking-wf-vblank)
[556.461223] Starting subtest: flip-vs-blocking-wf-vblank
[556.463569] Starting dynamic subtest: A-eDP1
[565.412267] Dynamic subtest A-eDP1: SUCCESS (8.949s)
[565.424204] Starting dynamic subtest: B-eDP1
[574.352041] Dynamic subtest B-eDP1: SUCCESS (8.937s)
[574.361940] Starting dynamic subtest: C-eDP1
[583.269797] Dynamic subtest C-eDP1: SUCCESS (8.911s)
[583.280218] Starting dynamic subtest: D-eDP1
[592.195552] Dynamic subtest D-eDP1: SUCCESS (8.925s)
[592.198044] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.731s)
[593.435367] [127/131] (428s left) kms_feature_discovery (display-4x)
[593.533044] Starting subtest: display-4x
[593.537274] Subtest display-4x: SKIP (0.000s)
[593.603651] [128/131] (428s left) kms_plane_alpha_blend (constant-alpha-min)
[593.695348] Starting subtest: constant-alpha-min
[593.991719] Starting dynamic subtest: pipe-A-eDP-1
[594.691796] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.698s)
[594.702990] Starting dynamic subtest: pipe-D-eDP-1
[596.208770] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.517s)
[596.211200] Subtest constant-alpha-min: SUCCESS (2.513s)
[597.008548] [129/131] (425s left) gem_ppgtt (shrink-vs-evict-any)
[597.061417] Starting subtest: shrink-vs-evict-any
[603.057217] Subtest shrink-vs-evict-any: SUCCESS (5.993s)
[603.126724] [130/131] (419s left) kms_vrr (flip-basic)
[603.232358] Starting subtest: flip-basic
[603.238861] Subtest flip-basic: SKIP (0.000s)
[603.306595] [131/131] (419s left) kms_hdr (static-toggle-suspend)
[603.409405] Starting subtest: static-toggle-suspend
[603.415891] Subtest static-toggle-suspend: SKIP (0.000s)
[603.480213] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_ctx_param
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: i915_suspend
results: parsing output: 7/ for test: gem_madvise
results: parsing output: 8/ for test: kms_psr2_sf
results: parsing output: 9/ for test: gem_exec_whisper
results: parsing output: 10/ for test: prime_mmap_coherency
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: i915_pm_rc6_residency
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: kms_rotation_crc
results: parsing output: 15/ for test: gen3_render_tiledx_blits
results: parsing output: 16/ for test: gem_exec_balancer
results: parsing output: 17/ for test: i915_query
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: kms_pm_rpm
results: parsing output: 20/ for test: gem_softpin
results: parsing output: 21/ for test: gem_exec_parallel
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_userptr_blits
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_pipe_crc_basic
results: parsing output: 26/ for test: perf_pmu
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: kms_ccs
results: parsing output: 29/ for test: prime_vgem
results: parsing output: 30/ for test: gem_ccs
results: parsing output: 31/ for test: gem_exec_reloc
results: parsing output: 32/ for test: api_intel_allocator
results: parsing output: 33/ for test: kms_flip
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: kms_ccs
results: parsing output: 38/ for test: kms_plane
results: parsing output: 39/ for test: gem_render_copy
results: parsing output: 40/ for test: gem_exec_params
results: parsing output: 41/ for test: gem_exec_flush
results: parsing output: 42/ for test: gem_exec_fence
results: parsing output: 43/ for test: gem_mmap
results: parsing output: 44/ for test: kms_flip_scaled_crc
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: kms_cursor_legacy
results: parsing output: 48/ for test: kms_plane_scaling
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: syncobj_wait
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: gem_mmap_offset
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_bad_reloc
results: parsing output: 55/ for test: perf
results: parsing output: 56/ for test: syncobj_timeline
results: parsing output: 57/ for test: gem_exec_schedule
results: parsing output: 58/ for test: gem_ctx_persistence
results: parsing output: 59/ for test: syncobj_timeline
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: prime_mmap_coherency
results: parsing output: 63/ for test: kms_pm_rpm
results: parsing output: 64/ for test: perf
results: parsing output: 65/ for test: gem_render_linear_blits
results: parsing output: 66/ for test: gem_exec_schedule
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_chamelium_frames
results: parsing output: 69/ for test: gem_lmem_swapping
results: parsing output: 70/ for test: gen9_exec_parse
results: parsing output: 71/ for test: core_getstats
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: kms_cursor_legacy
results: parsing output: 74/ for test: device_reset
results: parsing output: 75/ for test: gem_vm_create
results: parsing output: 76/ for test: i915_fb_tiling
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: kms_writeback
results: parsing output: 79/ for test: kms_cursor_crc
results: parsing output: 80/ for test: kms_debugfs
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: kms_vblank
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_exec_schedule
results: parsing output: 85/ for test: perf_pmu
results: parsing output: 86/ for test: kms_flip_scaled_crc
results: parsing output: 87/ for test: gem_tiled_pread_pwrite
results: parsing output: 88/ for test: kms_chamelium_hpd
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: gem_userptr_blits
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: kms_cursor_legacy
results: parsing output: 93/ for test: kms_ccs
results: parsing output: 94/ for test: kms_cursor_legacy
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_cursor_crc
results: parsing output: 97/ for test: kms_color
results: parsing output: 98/ for test: vgem_basic
results: parsing output: 99/ for test: syncobj_timeline
results: parsing output: 100/ for test: kms_cursor_crc
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_async_flips
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_flink_basic
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_pxp
results: parsing output: 108/ for test: kms_psr
results: parsing output: 109/ for test: kms_psr2_sf
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: gem_exec_reloc
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: syncobj_wait
results: parsing output: 114/ for test: gem_ctx_exec
results: parsing output: 115/ for test: gem_ctx_persistence
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: api_intel_allocator
results: parsing output: 119/ for test: kms_busy
results: parsing output: 120/ for test: kms_rotation_crc
results: parsing output: 121/ for test: gem_ctx_sseu
results: parsing output: 122/ for test: prime_mmap
results: parsing output: 123/ for test: kms_lease
results: parsing output: 124/ for test: kms_plane_alpha_blend
results: parsing output: 125/ for test: kms_flip
results: parsing output: 126/ for test: kms_feature_discovery
results: parsing output: 127/ for test: kms_plane_alpha_blend
results: parsing output: 128/ for test: gem_ppgtt
results: parsing output: 129/ for test: kms_vrr
results: parsing output: 130/ for test: kms_hdr
Done.