[61.004187] Initializing watchdogs
[61.004233]   /dev/watchdog0
[61.018834] [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]
[61.023529] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.025822] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.029185] [001/132] (960s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[61.158786] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[61.850261] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.692s)
[61.997971] [002/132] (959s left) gem_exec_reloc (basic-write-wc)
[62.052703] Subtest basic-write-wc: SKIP (0.000s)
[62.117829] [003/132] (959s left) gem_ctx_param (invalid-get-engines)
[62.175222] Starting subtest: invalid-get-engines
[62.177649] Subtest invalid-get-engines: SUCCESS (0.002s)
[62.298861] [004/132] (959s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[62.401979] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[62.406259] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[62.464260] [005/132] (959s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[62.555217] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[62.557548] Starting dynamic subtest: pipe-A
[62.576854] Dynamic subtest pipe-A: SKIP (0.019s)
[62.584788] Starting dynamic subtest: pipe-B
[62.615396] Dynamic subtest pipe-B: SKIP (0.038s)
[62.622688] Starting dynamic subtest: pipe-C
[62.654505] Dynamic subtest pipe-C: SKIP (0.037s)
[62.662789] Starting dynamic subtest: pipe-D
[62.691772] Dynamic subtest pipe-D: SKIP (0.038s)
[62.696125] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.133s)
[62.775532] [006/132] (958s left) kms_cursor_crc (cursor-random-max-size)
[63.091708] Starting subtest: cursor-random-max-size
[63.097276] Subtest cursor-random-max-size: SKIP (0.000s)
[63.225648] [007/132] (958s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[63.338091] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[68.273059] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.932s)
[69.461694] [008/132] (952s left) gem_userptr_blits (sync-unmap-after-close)
[69.543945] Starting subtest: sync-unmap-after-close
[69.554321] Subtest sync-unmap-after-close: SUCCESS (0.011s)
[69.690988] [009/132] (952s left) gem_exec_fence (submit3)
[69.861925] Starting subtest: submit3
[69.866697] Subtest submit3: SKIP (0.000s)
[71.980363] [FACT gem_exec_fence (submit3)] new: kernel.kmod_is_loaded.vgem: true
[71.983414] [010/132] (949s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[72.115081] Starting subtest: flip-vs-cursor-toggle
[80.624723] Subtest flip-vs-cursor-toggle: SUCCESS (8.507s)
[81.480525] [011/132] (940s left) i915_pm_rps (reset)
[81.552998] Starting subtest: reset
[89.984928] Subtest reset: SUCCESS (8.432s)
[90.104860] [012/132] (931s left) kms_vrr (negative-basic)
[90.206911] Starting subtest: negative-basic
[90.213712] Starting dynamic subtest: pipe-A-eDP-1
[95.629205] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.414s)
[95.910265] Subtest negative-basic: SUCCESS (5.704s)
[96.712022] [013/132] (925s left) kms_psr (psr-dpms)
[96.810988] Starting subtest: psr-dpms
[96.813350] Starting dynamic subtest: eDP-1
[99.729559] Dynamic subtest eDP-1: SUCCESS (2.920s)
[99.731867] Subtest psr-dpms: SUCCESS (2.920s)
[100.601690] [014/132] (921s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[100.701466] Starting subtest: 4-tiled-64bpp-rotate-180
[102.268370] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.568s)
[102.426342] [015/132] (919s left) gem_spin_batch (spin-all)
[102.485844] Starting subtest: spin-all
[102.503799] Subtest spin-all: SUCCESS (0.016s)
[103.939808] [016/132] (918s left) syncobj_timeline (invalid-transfer-non-existent-point)
[103.997128] Starting subtest: invalid-transfer-non-existent-point
[103.999603] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[104.129567] [017/132] (918s left) perf_pmu (init-sema)
[104.165479] Starting subtest: init-sema
[104.167910] Starting dynamic subtest: rcs0
[104.170343] Dynamic subtest rcs0: SUCCESS (0.002s)
[104.179200] Starting dynamic subtest: bcs0
[104.181370] Dynamic subtest bcs0: SUCCESS (0.000s)
[104.188894] Starting dynamic subtest: vcs0
[104.191132] Dynamic subtest vcs0: SUCCESS (0.000s)
[104.198637] Starting dynamic subtest: vcs1
[104.200825] Dynamic subtest vcs1: SUCCESS (0.001s)
[104.208458] Starting dynamic subtest: vecs0
[104.210656] Dynamic subtest vecs0: SUCCESS (0.000s)
[104.218282] Starting dynamic subtest: ccs0
[104.220173] Dynamic subtest ccs0: SUCCESS (0.000s)
[104.222075] Subtest init-sema: SUCCESS (0.005s)
[104.275751] [018/132] (917s left) gem_exec_schedule (preempt-queue-contexts-chain)
[104.356638] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[104.640643] [019/132] (917s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[105.017672] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[105.805695] [020/132] (916s left) kms_invalid_mode (bad-hsync-start)
[105.906140] Starting subtest: bad-hsync-start
[105.908546] Starting dynamic subtest: pipe-A-eDP-1
[106.201564] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.299s)
[106.211233] Starting dynamic subtest: pipe-B-eDP-1
[106.213618] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[106.221457] Starting dynamic subtest: pipe-C-eDP-1
[106.223381] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[106.231393] Starting dynamic subtest: pipe-D-eDP-1
[106.233715] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[106.235684] Subtest bad-hsync-start: SUCCESS (0.310s)
[107.054733] [021/132] (915s left) dmabuf_sync_file (export-multiwait)
[107.106647] Starting subtest: export-multiwait
[107.108675] Subtest export-multiwait: SUCCESS (0.001s)
[107.164638] [022/132] (915s left) kms_hdmi_inject (inject-audio)
[107.501493] Starting subtest: inject-audio
[107.783627] Subtest inject-audio: SUCCESS (0.285s)
[108.416603] [023/132] (913s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[108.511670] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[108.516126] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[108.632950] [024/132] (913s left) gem_mmap_gtt (cpuset-medium-copy)
[108.685813] Subtest cpuset-medium-copy: SKIP (0.000s)
[108.755605] [025/132] (913s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[108.855270] Starting subtest: fbcpsr-2p-rte
[108.859302] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[108.966140] [026/132] (913s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[109.090245] Starting subtest: flip-vs-cursor-atomic
[116.253586] Subtest flip-vs-cursor-atomic: SUCCESS (7.163s)
[117.089225] [027/132] (905s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[117.189185] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[117.192735] Starting dynamic subtest: pipe-A-eDP-1
[117.217145] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[117.226742] Starting dynamic subtest: pipe-B-eDP-1
[117.249752] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[117.257567] Starting dynamic subtest: pipe-C-eDP-1
[117.280732] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[117.290521] Starting dynamic subtest: pipe-D-eDP-1
[117.314822] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[117.319043] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s)
[119.398072] [028/132] (903s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[119.495273] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[119.499584] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[119.566241] [029/132] (903s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[119.657753] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[119.662244] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[119.728272] [030/132] (902s left) i915_getparams_basic (basic-eu-total)
[119.786113] Starting subtest: basic-eu-total
[119.790446] Subtest basic-eu-total: SUCCESS (0.000s)
[119.880563] [031/132] (902s left) i915_suspend (basic-s3-without-i915)
[119.915270] Starting subtest: basic-s3-without-i915
[123.109646] Subtest basic-s3-without-i915: SKIP (3.190s)
[124.679508] [032/132] (898s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[124.800507] Starting subtest: y-tiled-16bpp-rotate-90
[124.804957] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[124.896211] [033/132] (897s left) perf (missing-sample-flags)
[125.040685] Starting subtest: missing-sample-flags
[125.043037] Subtest missing-sample-flags: SUCCESS (0.000s)
[125.083495] [034/132] (897s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[125.179422] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[125.183531] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[125.273187] [035/132] (897s left) drm_read (empty-nonblock)
[125.448992] Starting subtest: empty-nonblock
[125.450898] Subtest empty-nonblock: SUCCESS (0.000s)
[125.555900] [036/132] (897s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[125.651178] Starting subtest: fbc-pr-sprite-mmap-gtt
[125.654804] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[125.720627] [037/132] (897s left) gem_exec_reloc (basic-wc-gtt-active)
[125.779596] Subtest basic-wc-gtt-active: SKIP (0.000s)
[125.856942] [038/132] (897s left) kms_cursor_legacy (torture-bo)
[125.982316] Starting subtest: torture-bo
[125.984273] Starting dynamic subtest: pipe-A
[131.865045] Dynamic subtest pipe-A: SUCCESS (5.878s)
[131.875238] Starting dynamic subtest: pipe-B
[138.694564] Dynamic subtest pipe-B: SUCCESS (6.828s)
[138.713200] Starting dynamic subtest: pipe-C
[145.789586] Dynamic subtest pipe-C: SUCCESS (7.096s)
[145.799533] Starting dynamic subtest: pipe-D
[152.839911] Dynamic subtest pipe-D: SUCCESS (7.048s)
[152.855509] Starting dynamic subtest: all-pipes
[158.743984] Dynamic subtest all-pipes: SUCCESS (5.903s)
[158.746240] Subtest torture-bo: SUCCESS (32.758s)
[158.899785] [039/132] (864s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[158.993174] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[158.997139] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[159.083929] [040/132] (864s left) gem_mmap_gtt (basic-copy)
[159.138610] Subtest basic-copy: SKIP (0.000s)
[159.197645] [041/132] (863s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[159.293356] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[166.293020] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.002s)
[166.404662] [042/132] (856s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[166.510499] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[166.514717] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[166.595038] [043/132] (856s left) kms_vblank (wait-forked)
[166.678912] Starting subtest: wait-forked
[166.681224] Starting dynamic subtest: pipe-A-eDP-1
[168.502436] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.823s)
[168.517226] Starting dynamic subtest: pipe-D-eDP-1
[170.993174] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.488s)
[170.995491] Subtest wait-forked: SUCCESS (4.314s)
[171.853822] [044/132] (851s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[171.940823] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[171.945477] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[172.035298] [045/132] (851s left) gem_ctx_param (get-priority-new-ctx)
[172.091297] Starting subtest: get-priority-new-ctx
[172.093615] Subtest get-priority-new-ctx: SUCCESS (0.002s)
[172.187153] [046/132] (851s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[172.281759] Starting subtest: fbc-pr-cursor-mmap-gtt
[172.286249] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[172.353566] [047/132] (851s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[172.467204] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[179.596159] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.132s)
[179.729657] [048/132] (843s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[179.820390] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[179.824895] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[179.921690] [049/132] (843s left) gem_exec_parallel (contexts)
[179.985930] Starting subtest: contexts
[179.988302] Starting dynamic subtest: rcs0
[182.840647] Dynamic subtest rcs0: SUCCESS (2.852s)
[182.851849] Starting dynamic subtest: bcs0
[186.147559] Dynamic subtest bcs0: SUCCESS (3.307s)
[186.155699] Starting dynamic subtest: vcs0
[190.348636] Dynamic subtest vcs0: SUCCESS (4.199s)
[190.358556] Starting dynamic subtest: vcs1
[194.423468] Dynamic subtest vcs1: SUCCESS (4.073s)
[194.433974] Starting dynamic subtest: vecs0
[198.372403] Dynamic subtest vecs0: SUCCESS (3.946s)
[198.383602] Starting dynamic subtest: ccs0
[201.928685] Dynamic subtest ccs0: SUCCESS (3.554s)
[201.931669] Subtest contexts: SUCCESS (21.941s)
[202.115309] [050/132] (821s left) kms_psr (psr-cursor-plane-move)
[202.220941] Starting subtest: psr-cursor-plane-move
[202.223289] Starting dynamic subtest: eDP-1
[203.985259] Dynamic subtest eDP-1: SUCCESS (1.763s)
[203.987581] Subtest psr-cursor-plane-move: SUCCESS (1.764s)
[204.840519] [051/132] (818s left) perf (short-reads)
[204.936242] Starting subtest: short-reads
[204.953799] Subtest short-reads: SUCCESS (0.018s)
[204.997569] [052/132] (818s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[205.102580] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[205.938255] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.837s)
[206.115780] [053/132] (817s left) kms_plane_scaling (invalid-num-scalers)
[206.209497] Starting subtest: invalid-num-scalers
[206.211831] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[206.229710] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.019s)
[206.239606] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[206.266475] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.037s)
[206.275091] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[206.303648] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.036s)
[206.311812] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[206.338465] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.032s)
[206.340602] Subtest invalid-num-scalers: SUCCESS (0.129s)
[206.437442] [054/132] (817s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[206.544062] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[206.548077] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[206.610798] [055/132] (817s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[206.720386] Starting subtest: cursor-vs-flip-atomic-transitions
[236.717183] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (29.994s)
[237.558609] [056/132] (786s left) perf (polling-small-buf)
[237.654886] Starting subtest: polling-small-buf
[237.748313] Subtest polling-small-buf: SUCCESS (0.091s)
[237.792920] [057/132] (786s left) kms_plane (pixel-format-linear-modifier)
[237.881311] Starting subtest: pixel-format-linear-modifier
[237.902657] Starting dynamic subtest: pipe-A-plane-0
[241.479942] Dynamic subtest pipe-A-plane-0: SUCCESS (3.578s)
[241.488150] Starting dynamic subtest: pipe-A-plane-3
[243.168778] Dynamic subtest pipe-A-plane-3: SUCCESS (1.688s)
[243.179559] Starting dynamic subtest: pipe-A-plane-5
[243.380253] Dynamic subtest pipe-A-plane-5: SUCCESS (0.209s)
[244.458056] Starting dynamic subtest: pipe-B-plane-0
[247.989070] Dynamic subtest pipe-B-plane-0: SUCCESS (3.544s)
[247.997251] Starting dynamic subtest: pipe-B-plane-3
[249.711899] Dynamic subtest pipe-B-plane-3: SUCCESS (1.722s)
[249.720871] Starting dynamic subtest: pipe-B-plane-5
[249.923088] Dynamic subtest pipe-B-plane-5: SUCCESS (0.210s)
[250.248158] Subtest pixel-format-linear-modifier: SUCCESS (12.365s)
[251.047891] [058/132] (772s left) syncobj_timeline (wait-all-snapshot)
[251.109598] Starting subtest: wait-all-snapshot
[251.190540] Subtest wait-all-snapshot: SUCCESS (0.082s)
[251.265860] [059/132] (772s left) gem_exec_schedule (preempt-queue-chain)
[251.338655] Subtest preempt-queue-chain: SKIP (0.000s)
[251.629612] [060/132] (772s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[251.680364] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[251.726008] [061/132] (772s left) gem_render_copy (y-tiled-ccs-to-linear)
[251.779314] Starting subtest: y-tiled-ccs-to-linear
[251.783412] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[251.961207] [062/132] (772s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[252.026369] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[252.030500] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[252.210540] [063/132] (771s left) kms_addfb_basic (legacy-format)
[252.271978] Starting subtest: legacy-format
[252.294813] Subtest legacy-format: SUCCESS (0.021s)
[252.435347] [064/132] (771s left) kms_flip (flip-vs-modeset-vs-hang)
[252.537503] Starting subtest: flip-vs-modeset-vs-hang
[252.539793] Starting dynamic subtest: A-eDP1
[303.341997] Dynamic subtest A-eDP1: SUCCESS (50.800s)
[303.350479] Starting dynamic subtest: D-eDP1
[353.393908] Dynamic subtest D-eDP1: SUCCESS (50.050s)
[353.396456] Subtest flip-vs-modeset-vs-hang: SUCCESS (100.855s)
[353.780568] [065/132] (670s left) gem_ctx_shared (q-smoketest-all)
[353.846772] Starting subtest: Q-smoketest-all
[386.236100] Subtest Q-smoketest-all: SUCCESS (32.339s)
[387.968979] [066/132] (636s left) gem_eio (in-flight-suspend)
[388.247203] Starting subtest: in-flight-suspend
[431.592365] Subtest in-flight-suspend: SUCCESS (13.701s)
[431.731142] [067/132] (592s left) kms_psr (pr-dpms)
[431.839332] Starting subtest: pr-dpms
[431.843866] Subtest pr-dpms: SKIP (0.000s)
[431.916345] [068/132] (592s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[432.014362] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[432.016565] Starting dynamic subtest: pipe-A-eDP-1
[432.041046] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[432.050966] Starting dynamic subtest: pipe-B-eDP-1
[432.074631] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[432.083230] Starting dynamic subtest: pipe-C-eDP-1
[432.106934] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[432.115767] Starting dynamic subtest: pipe-D-eDP-1
[432.139980] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[432.144392] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[434.329001] [069/132] (589s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[434.418224] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[438.922480] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.467s)
[440.084808] [070/132] (584s left) gem_mmap_gtt (basic-write-gtt)
[440.145422] Subtest basic-write-gtt: SKIP (0.000s)
[440.221451] [071/132] (584s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[440.325171] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[440.329476] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[440.423979] [072/132] (584s left) kms_cursor_crc (cursor-onscreen-128x42)
[440.671364] Starting subtest: cursor-onscreen-128x42
[440.718204] Subtest cursor-onscreen-128x42: SKIP (0.044s)
[440.925795] [073/132] (583s left) kms_atomic_interruptible (legacy-dpms)
[441.011252] Starting subtest: legacy-dpms
[441.013486] Starting dynamic subtest: pipe-A-eDP-1
[448.433326] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.396s)
[448.435627] Subtest legacy-dpms: SUCCESS (7.397s)
[449.285135] [074/132] (575s left) gem_mmap_offset (partial-remap)
[449.344809] Starting subtest: partial-remap
[449.346819] Starting dynamic subtest: smem0
[449.355843] Dynamic subtest smem0: SUCCESS (0.004s)
[449.358125] Subtest partial-remap: SUCCESS (0.005s)
[449.477212] [075/132] (575s left) kms_cursor_crc (cursor-tearing-position-change)
[449.602243] Starting subtest: cursor-tearing-position-change
[449.604486] Starting dynamic subtest: pipe-A-eDP-1
[450.186490] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.580s)
[450.196683] Starting dynamic subtest: pipe-D-eDP-1
[451.405907] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.213s)
[451.407819] Subtest cursor-tearing-position-change: SUCCESS (1.799s)
[452.251993] [076/132] (572s left) perf (low-oa-exponent-permissions)
[452.344867] Starting subtest: low-oa-exponent-permissions
[452.377450] Subtest low-oa-exponent-permissions: SUCCESS (0.033s)
[452.424480] [077/132] (572s left) syncobj_basic (bad-pad-fd-to-handle)
[452.471411] Starting subtest: bad-pad-fd-to-handle
[452.473333] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[452.571770] [078/132] (572s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[452.659822] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[452.664203] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[452.746055] [079/132] (571s left) gem_exec_fence (concurrent)
[452.912648] Starting subtest: concurrent
[452.917554] Subtest concurrent: SKIP (0.000s)
[454.651383] [080/132] (570s left) gem_exec_schedule (fairslice)
[454.719145] Starting subtest: fairslice
[454.721029] Starting dynamic subtest: rcs0
[456.740272] Dynamic subtest rcs0: SUCCESS (2.024s)
[456.751571] Starting dynamic subtest: bcs0
[458.765895] Dynamic subtest bcs0: SUCCESS (2.023s)
[458.776586] Starting dynamic subtest: vcs0
[460.788768] Dynamic subtest vcs0: SUCCESS (2.019s)
[460.799224] Starting dynamic subtest: vcs1
[462.809450] Dynamic subtest vcs1: SUCCESS (2.019s)
[462.822158] Starting dynamic subtest: vecs0
[464.829218] Dynamic subtest vecs0: SUCCESS (2.019s)
[464.840518] Starting dynamic subtest: ccs0
[466.848717] Dynamic subtest ccs0: SUCCESS (2.021s)
[466.850648] Subtest fairslice: SUCCESS (12.131s)
[467.147446] [081/132] (557s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[467.254180] Starting subtest: crc-primary-basic-y-tiled-ccs
[467.256461] Starting dynamic subtest: pipe-A-eDP-1
[467.277742] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[467.287478] Starting dynamic subtest: pipe-B-eDP-1
[467.308556] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[467.317631] Starting dynamic subtest: pipe-C-eDP-1
[467.338576] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[467.347561] Starting dynamic subtest: pipe-D-eDP-1
[467.369109] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[467.373128] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s)
[469.518521] [082/132] (555s left) gen9_exec_parse (secure-batches)
[469.583794] Subtest secure-batches: SKIP (0.000s)
[469.659809] [083/132] (555s left) kms_dsc (dsc-with-output-formats)
[469.745463] Starting subtest: dsc-with-output-formats
[469.766571] Subtest dsc-with-output-formats: SKIP (0.001s)
[469.817620] [084/132] (555s left) kms_plane_alpha_blend (constant-alpha-min)
[469.901487] Starting subtest: constant-alpha-min
[470.195790] Starting dynamic subtest: pipe-A-eDP-1
[470.900807] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.704s)
[470.912644] Starting dynamic subtest: pipe-D-eDP-1
[472.418798] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.514s)
[472.421092] Subtest constant-alpha-min: SUCCESS (2.516s)
[473.281643] [085/132] (551s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[473.394522] Starting subtest: x-tiled-32bpp-rotate-0
[474.894271] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.500s)
[475.028895] [086/132] (549s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[475.122436] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[475.124317] Starting dynamic subtest: pipe-A-eDP-1
[475.131881] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[475.143290] Starting dynamic subtest: pipe-B-eDP-1
[475.151201] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[475.161631] Starting dynamic subtest: pipe-C-eDP-1
[475.167969] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[475.176711] Starting dynamic subtest: pipe-D-eDP-1
[475.183826] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[475.187225] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s)
[477.366589] [087/132] (547s left) kms_color (ctm-green-to-red)
[477.469253] Starting subtest: ctm-green-to-red
[477.471512] Starting dynamic subtest: pipe-A-eDP-1
[478.166037] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.698s)
[478.175508] Starting dynamic subtest: pipe-B-eDP-1
[479.585059] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.417s)
[479.594628] Starting dynamic subtest: pipe-C-eDP-1
[480.957201] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.371s)
[480.966852] Starting dynamic subtest: pipe-D-eDP-1
[482.271485] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.309s)
[482.273813] Subtest ctm-green-to-red: SUCCESS (4.800s)
[483.085269] [088/132] (542s left) kms_chamelium_frames (dp-crc-single)
[483.472169] Subtest dp-crc-single: SKIP (0.000s)
[484.300382] [089/132] (540s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[484.401441] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[491.072247] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.671s)
[491.197518] [090/132] (533s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[491.329604] Starting subtest: cursorA-vs-flipB-toggle
[491.333979] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[491.475634] [091/132] (533s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[491.535780] Starting subtest: etime-single-wait-available-unsubmitted
[491.642319] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.106s)
[491.720044] [092/132] (533s left) syncobj_wait (invalid-reset-bad-pad)
[491.763774] Starting subtest: invalid-reset-bad-pad
[491.765773] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[491.852504] [093/132] (533s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[491.945727] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[499.241378] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.295s)
[499.369985] [094/132] (525s left) syncobj_wait (single-wait-all-submitted)
[499.429592] Starting subtest: single-wait-all-submitted
[499.528255] Subtest single-wait-all-submitted: SUCCESS (0.101s)
[499.606938] [095/132] (525s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[499.697646] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[506.490982] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.792s)
[506.655056] [096/132] (518s left) sysfs_preempt_timeout (idempotent)
[506.714154] Starting subtest: idempotent
[506.716404] Starting dynamic subtest: vecs0
[506.718701] Dynamic subtest vecs0: SUCCESS (0.000s)
[506.729447] Starting dynamic subtest: ccs0
[506.731218] Dynamic subtest ccs0: SUCCESS (0.000s)
[506.740086] Starting dynamic subtest: vcs0
[506.741988] Dynamic subtest vcs0: SUCCESS (0.000s)
[506.750816] Starting dynamic subtest: bcs0
[506.752686] Dynamic subtest bcs0: SUCCESS (0.000s)
[506.761485] Starting dynamic subtest: rcs0
[506.763366] Dynamic subtest rcs0: SUCCESS (0.000s)
[506.772185] Starting dynamic subtest: vcs1
[506.774130] Dynamic subtest vcs1: SUCCESS (0.000s)
[506.776139] Subtest idempotent: SUCCESS (0.007s)
[506.870917] [097/132] (518s left) gem_ccs (suspend-resume)
[506.930614] Starting subtest: suspend-resume
[506.934714] Subtest suspend-resume: SKIP (0.000s)
[507.032413] [098/132] (518s left) api_intel_bb (crc32)
[507.089935] Starting subtest: crc32
[507.092228] Starting dynamic subtest: rcs0-smem0
[507.416998] Dynamic subtest rcs0-smem0: SUCCESS (0.325s)
[507.429416] Starting dynamic subtest: bcs0-smem0
[507.725494] Dynamic subtest bcs0-smem0: SUCCESS (0.305s)
[507.736135] Starting dynamic subtest: vcs0-smem0
[508.094536] Dynamic subtest vcs0-smem0: SUCCESS (0.366s)
[508.106438] Starting dynamic subtest: vcs1-smem0
[508.485600] Dynamic subtest vcs1-smem0: SUCCESS (0.388s)
[508.496730] Starting dynamic subtest: vecs0-smem0
[508.861802] Dynamic subtest vecs0-smem0: SUCCESS (0.373s)
[508.873857] Starting dynamic subtest: ccs0-smem0
[509.159295] Dynamic subtest ccs0-smem0: SUCCESS (0.295s)
[509.162024] Subtest crc32: SUCCESS (2.070s)
[509.283217] [099/132] (516s left) kms_pm_backlight (fade)
[509.371311] Starting subtest: fade
[509.420466] Starting dynamic subtest: eDP-1
[511.904068] Dynamic subtest eDP-1: SUCCESS (2.480s)
[511.906371] Subtest fade: SUCCESS (2.532s)
[512.748955] [100/132] (512s left) gem_partial_pwrite_pread (writes-after-reads)
[512.808758] Subtest writes-after-reads: SKIP (0.000s)
[512.876942] [101/132] (512s left) gen3_render_mixed_blits
[512.990150] [102/132] (512s left) gem_wait (await)
[513.051019] Starting subtest: await
[513.053295] Starting dynamic subtest: all-engines
[514.174524] Dynamic subtest all-engines: SUCCESS (1.122s)
[514.193794] Starting dynamic subtest: rcs0
[515.238450] Dynamic subtest rcs0: SUCCESS (1.061s)
[515.255584] Starting dynamic subtest: bcs0
[516.297455] Dynamic subtest bcs0: SUCCESS (1.056s)
[516.314866] Starting dynamic subtest: vcs0
[517.350781] Dynamic subtest vcs0: SUCCESS (1.051s)
[517.366884] Starting dynamic subtest: vcs1
[518.406733] Dynamic subtest vcs1: SUCCESS (1.053s)
[518.426217] Starting dynamic subtest: vecs0
[519.462827] Dynamic subtest vecs0: SUCCESS (1.053s)
[519.480116] Starting dynamic subtest: ccs0
[520.519972] Dynamic subtest ccs0: SUCCESS (1.054s)
[520.522602] Subtest await: SUCCESS (7.467s)
[520.735904] [103/132] (505s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[520.846185] Starting subtest: modeset-transition-nonblocking-fencing
[520.848340] Starting dynamic subtest: 1x-outputs
[531.916913] Dynamic subtest 1x-outputs: SUCCESS (11.071s)
[531.919365] Subtest modeset-transition-nonblocking-fencing: SUCCESS (11.073s)
[532.781068] [104/132] (493s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[532.841682] Starting subtest: multi-wait-available-unsubmitted-submitted
[532.843592] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[532.946900] [105/132] (492s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[533.006981] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[533.114599] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.107s)
[533.192046] [106/132] (492s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[533.281040] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[533.285374] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[533.354373] [107/132] (492s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[533.447556] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[533.451598] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[533.552404] [108/132] (492s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[533.645729] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[533.649776] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[533.753471] [109/132] (492s left) kms_content_protection (dp-mst-lic-type-1)
[533.892331] Starting subtest: dp-mst-lic-type-1
[533.896874] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[534.024208] [110/132] (492s left) gem_exec_schedule (wide)
[534.205370] Starting subtest: wide
[534.207880] Starting dynamic subtest: rcs0
[544.582436] Dynamic subtest rcs0: SUCCESS (10.386s)
[544.594884] Starting dynamic subtest: vcs0
[556.774372] Dynamic subtest vcs0: SUCCESS (12.191s)
[556.786927] Starting dynamic subtest: vcs1
[569.310036] Dynamic subtest vcs1: SUCCESS (12.533s)
[569.320817] Starting dynamic subtest: vecs0
[578.967234] Dynamic subtest vecs0: SUCCESS (9.655s)
[578.982232] Starting dynamic subtest: ccs0
[591.664906] Dynamic subtest ccs0: SUCCESS (12.693s)
[591.667514] Subtest wide: SUCCESS (57.464s)
[593.516762] [111/132] (432s left) gem_ctx_persistence (legacy-engines-hostile)
[593.577354] Starting subtest: legacy-engines-hostile
[593.579897] Starting dynamic subtest: render
[593.667679] Dynamic subtest render: SUCCESS (0.089s)
[593.680427] Starting dynamic subtest: bsd1
[593.759066] Dynamic subtest bsd1: SUCCESS (0.090s)
[593.773517] Starting dynamic subtest: bsd2
[593.852138] Dynamic subtest bsd2: SUCCESS (0.090s)
[593.863741] Starting dynamic subtest: blt
[593.954076] Dynamic subtest blt: SUCCESS (0.099s)
[593.968647] Starting dynamic subtest: vebox
[594.050999] Dynamic subtest vebox: SUCCESS (0.094s)
[594.053400] Subtest legacy-engines-hostile: SUCCESS (0.475s)
[594.145119] [112/132] (431s left) kms_flip (bo-too-big-interruptible)
[594.236286] Starting subtest: bo-too-big-interruptible
[594.238528] Starting dynamic subtest: A-eDP1
[595.540964] Dynamic subtest A-eDP1: SUCCESS (1.303s)
[595.551835] Starting dynamic subtest: B-eDP1
[596.846666] Dynamic subtest B-eDP1: SUCCESS (1.304s)
[596.860722] Starting dynamic subtest: C-eDP1
[598.095433] Dynamic subtest C-eDP1: SUCCESS (1.245s)
[598.107093] Starting dynamic subtest: D-eDP1
[599.354858] Dynamic subtest D-eDP1: SUCCESS (1.257s)
[599.360468] Subtest bo-too-big-interruptible: SUCCESS (5.122s)
[600.562538] [113/132] (425s left) gem_pxp (verify-pxp-stale-ctx-execution)
[600.694315] Starting subtest: verify-pxp-stale-ctx-execution
[601.754910] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.062s)
[601.878882] [114/132] (424s left) gem_mmap_wc (bad-offset)
[601.932531] Subtest bad-offset: SKIP (0.000s)
[601.997302] [115/132] (424s left) gem_mmap_gtt (basic-short)
[602.055069] Subtest basic-short: SKIP (0.000s)
[602.119779] [116/132] (424s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[602.233795] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[602.238139] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[602.341098] [117/132] (423s left) gem_busy (extended)
[602.532447] Starting subtest: extended
[602.534623] Starting dynamic subtest: rcs0
[602.615951] Dynamic subtest rcs0: SUCCESS (0.086s)
[602.638237] Starting dynamic subtest: bcs0
[602.658641] Dynamic subtest bcs0: SUCCESS (0.040s)
[602.670773] Starting dynamic subtest: vcs0
[604.510179] Dynamic subtest vcs0: SUCCESS (1.847s)
[604.522094] Starting dynamic subtest: vcs1
[606.558458] Dynamic subtest vcs1: SUCCESS (2.044s)
[606.571297] Starting dynamic subtest: vecs0
[608.542372] Dynamic subtest vecs0: SUCCESS (1.981s)
[608.554246] Starting dynamic subtest: ccs0
[608.590238] Dynamic subtest ccs0: SUCCESS (0.046s)
[608.593119] Subtest extended: SUCCESS (6.060s)
[608.829526] [118/132] (417s left) gem_mmap_gtt (basic-small-bo-tiledx)
[608.884610] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[608.956134] [119/132] (417s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[609.062365] Starting subtest: primary-yf-tiled-reflect-x-90
[609.066788] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[609.147782] [120/132] (417s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[609.236706] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[609.240578] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.000s)
[609.321777] [121/132] (417s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[609.411712] Starting subtest: psr-modesetfrombusy
[615.537833] Subtest psr-modesetfrombusy: SUCCESS (6.128s)
[615.642996] [122/132] (410s left) i915_drm_fdinfo (busy)
[615.692634] Starting subtest: busy
[615.694491] Starting dynamic subtest: rcs0
[615.712413] Dynamic subtest rcs0: SKIP (0.019s)
[615.722481] Starting dynamic subtest: bcs0
[615.725976] Dynamic subtest bcs0: SKIP (0.001s)
[615.734894] Starting dynamic subtest: vcs0
[615.738470] Dynamic subtest vcs0: SKIP (0.001s)
[615.746770] Starting dynamic subtest: vcs1
[615.750369] Dynamic subtest vcs1: SKIP (0.000s)
[615.759404] Starting dynamic subtest: vecs0
[615.762979] Dynamic subtest vecs0: SKIP (0.000s)
[615.771730] Starting dynamic subtest: ccs0
[615.775278] Dynamic subtest ccs0: SKIP (0.000s)
[615.778930] Subtest busy: SKIP (0.030s)
[615.815415] [123/132] (410s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[615.905423] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[615.907282] Starting dynamic subtest: pipe-A-eDP-1
[615.926287] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[615.936957] Starting dynamic subtest: pipe-B-eDP-1
[615.954980] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[615.964449] Starting dynamic subtest: pipe-C-eDP-1
[615.982314] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[615.991108] Starting dynamic subtest: pipe-D-eDP-1
[616.009120] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[616.012695] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[618.175376] [124/132] (408s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[618.267176] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[618.276764] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[618.357822] [125/132] (408s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[618.462194] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[618.466690] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[618.533291] [126/132] (408s left) syncobj_wait (multi-wait-for-submit-submitted)
[618.584898] Starting subtest: multi-wait-for-submit-submitted
[618.690684] Subtest multi-wait-for-submit-submitted: SUCCESS (0.105s)
[618.781435] [127/132] (407s left) core_getclient (basic)
[618.838378] Starting subtest: basic
[618.840354] Subtest basic: SUCCESS (0.000s)
[618.930676] [128/132] (407s left) gem_exec_balancer (indices)
[618.988307] Starting subtest: indices
[621.499927] Subtest indices: SUCCESS (2.509s)
[621.798937] [129/132] (405s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[621.918805] Starting subtest: cursorB-vs-flipB-toggle
[621.923290] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[622.066761] [130/132] (404s left) kms_sequence (get-idle)
[622.154751] Starting subtest: get-idle
[622.156682] Starting dynamic subtest: pipe-A-eDP-1
[623.969858] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.812s)
[623.981228] Starting dynamic subtest: pipe-B-eDP-1
[626.446337] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.476s)
[626.457199] Starting dynamic subtest: pipe-C-eDP-1
[628.864446] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.417s)
[628.874597] Starting dynamic subtest: pipe-D-eDP-1
[631.302147] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.436s)
[631.304359] Subtest get-idle: SUCCESS (9.148s)
[632.112427] [131/132] (394s left) sw_sync (alloc_timeline)
[632.145452] Starting subtest: alloc_timeline
[632.147697] Subtest alloc_timeline: SUCCESS (0.000s)
[632.198106] [132/132] (394s left) kms_psr (fbc-psr2-suspend)
[632.292509] Starting subtest: fbc-psr2-suspend
[632.294787] Starting dynamic subtest: eDP-1
[632.298952] Dynamic subtest eDP-1: SKIP (0.000s)
[632.303062] Subtest fbc-psr2-suspend: SKIP (0.001s)
[632.362024] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: gem_exec_reloc
results: parsing output: 2/ for test: gem_ctx_param
results: parsing output: 3/ for test: kms_joiner
results: parsing output: 4/ for test: kms_plane_scaling
results: parsing output: 5/ for test: kms_cursor_crc
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_userptr_blits
results: parsing output: 8/ for test: gem_exec_fence
results: parsing output: 9/ for test: kms_cursor_legacy
results: parsing output: 10/ for test: i915_pm_rps
results: parsing output: 11/ for test: kms_vrr
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: gem_spin_batch
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: perf_pmu
results: parsing output: 17/ for test: gem_exec_schedule
results: parsing output: 18/ for test: kms_chamelium_hpd
results: parsing output: 19/ for test: kms_invalid_mode
results: parsing output: 20/ for test: dmabuf_sync_file
results: parsing output: 21/ for test: kms_hdmi_inject
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_mmap_gtt
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_cursor_legacy
results: parsing output: 26/ for test: kms_ccs
results: parsing output: 27/ for test: kms_plane
results: parsing output: 28/ for test: kms_flip_scaled_crc
results: parsing output: 29/ for test: i915_getparams_basic
results: parsing output: 30/ for test: i915_suspend
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: perf
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: drm_read
results: parsing output: 35/ for test: kms_psr
results: parsing output: 36/ for test: gem_exec_reloc
results: parsing output: 37/ for test: kms_cursor_legacy
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_mmap_gtt
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_vblank
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_ctx_param
results: parsing output: 45/ for test: kms_psr
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_exec_parallel
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: perf
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: kms_plane_scaling
results: parsing output: 53/ for test: kms_psr2_sf
results: parsing output: 54/ for test: kms_cursor_legacy
results: parsing output: 55/ for test: perf
results: parsing output: 56/ for test: kms_plane
results: parsing output: 57/ for test: syncobj_timeline
results: parsing output: 58/ for test: gem_exec_schedule
results: parsing output: 59/ for test: gem_lmem_swapping
results: parsing output: 60/ for test: gem_render_copy
results: parsing output: 61/ for test: gem_render_copy
results: parsing output: 62/ for test: kms_addfb_basic
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: gem_ctx_shared
results: parsing output: 65/ for test: gem_eio
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_mmap_gtt
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_cursor_crc
results: parsing output: 72/ for test: kms_atomic_interruptible
results: parsing output: 73/ for test: gem_mmap_offset
results: parsing output: 74/ for test: kms_cursor_crc
results: parsing output: 75/ for test: perf
results: parsing output: 76/ for test: syncobj_basic
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_exec_fence
results: parsing output: 79/ for test: gem_exec_schedule
results: parsing output: 80/ for test: kms_ccs
results: parsing output: 81/ for test: gen9_exec_parse
results: parsing output: 82/ for test: kms_dsc
results: parsing output: 83/ for test: kms_plane_alpha_blend
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: kms_ccs
results: parsing output: 86/ for test: kms_color
results: parsing output: 87/ for test: kms_chamelium_frames
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_cursor_legacy
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: syncobj_wait
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: syncobj_wait
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: sysfs_preempt_timeout
results: parsing output: 96/ for test: gem_ccs
results: parsing output: 97/ for test: api_intel_bb
results: parsing output: 98/ for test: kms_pm_backlight
results: parsing output: 99/ for test: gem_partial_pwrite_pread
results: parsing output: 100/ for test: gen3_render_mixed_blits
results: parsing output: 101/ for test: gem_wait
results: parsing output: 102/ for test: kms_atomic_transition
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: kms_flip_scaled_crc
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_content_protection
results: parsing output: 109/ for test: gem_exec_schedule
results: parsing output: 110/ for test: gem_ctx_persistence
results: parsing output: 111/ for test: kms_flip
results: parsing output: 112/ for test: gem_pxp
results: parsing output: 113/ for test: gem_mmap_wc
results: parsing output: 114/ for test: gem_mmap_gtt
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: gem_busy
results: parsing output: 117/ for test: gem_mmap_gtt
results: parsing output: 118/ for test: kms_rotation_crc
results: parsing output: 119/ for test: kms_flip_scaled_crc
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: i915_drm_fdinfo
results: parsing output: 122/ for test: kms_ccs
results: parsing output: 123/ for test: kms_flip
results: parsing output: 124/ for test: kms_psr2_sf
results: parsing output: 125/ for test: syncobj_wait
results: parsing output: 126/ for test: core_getclient
results: parsing output: 127/ for test: gem_exec_balancer
results: parsing output: 128/ for test: kms_cursor_legacy
results: parsing output: 129/ for test: kms_sequence
results: parsing output: 130/ for test: sw_sync
results: parsing output: 131/ for test: kms_psr
Done.