[58.915085] Initializing watchdogs
[58.915137]   /dev/watchdog0
[58.929963] [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]
[58.934399] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.936601] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.939879] [001/154] (960s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[59.017198] Starting subtest: invalid-single-wait-unsubmitted
[59.019580] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[59.117174] [002/154] (960s left) kms_concurrent (multi-plane-atomic-lowres)
[59.207240] Starting subtest: multi-plane-atomic-lowres
[59.209526] Starting dynamic subtest: pipe-A-eDP-1
[59.736170] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.518s)
[59.744460] Starting dynamic subtest: pipe-B-eDP-1
[61.067448] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.307s)
[61.077301] Starting dynamic subtest: pipe-C-eDP-1
[62.311712] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.224s)
[62.321114] Starting dynamic subtest: pipe-D-eDP-1
[63.559861] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.234s)
[63.563054] Subtest multi-plane-atomic-lowres: SUCCESS (4.286s)
[64.383195] [003/154] (955s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[64.458620] Starting subtest: etime-multi-wait-all-submitted-signaled
[64.558940] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.101s)
[64.647901] [004/154] (954s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[65.038191] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[65.923894] [005/154] (953s left) gem_lmem_swapping (parallel-random)
[65.967255] Subtest parallel-random: SKIP (0.000s)
[66.005587] [006/154] (953s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-move)
[66.109029] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-move
[66.113408] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[66.227455] [007/154] (953s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[66.329879] Starting subtest: psr-rgb565-draw-render
[73.618738] Subtest psr-rgb565-draw-render: SUCCESS (7.257s)
[73.743341] [008/154] (945s left) api_intel_bb (destroy-bb)
[73.807993] Starting subtest: destroy-bb
[73.817495] Subtest destroy-bb: SUCCESS (0.008s)
[73.923153] [009/154] (945s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[74.019209] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[74.023174] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[74.105855] [010/154] (945s left) gem_barrier_race (remote-request)
[74.162927] Starting subtest: remote-request
[74.165401] Starting dynamic subtest: rcs0
[79.318609] Dynamic subtest rcs0: SUCCESS (5.148s)
[79.320739] Subtest remote-request: SUCCESS (5.148s)
[79.451220] [011/154] (940s left) kms_rotation_crc (cursor-rotation-180)
[79.548909] Starting subtest: cursor-rotation-180
[81.104794] Subtest cursor-rotation-180: SUCCESS (1.554s)
[82.287569] [012/154] (937s left) gem_readwrite (write-bad-handle)
[82.342640] Subtest write-bad-handle: SKIP (0.000s)
[82.409092] [013/154] (937s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[82.500834] Starting subtest: plane-use-after-nonblocking-unbind
[82.503158] Starting dynamic subtest: pipe-A-eDP-1
[82.560497] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.061s)
[82.870730] Starting dynamic subtest: pipe-B-eDP-1
[83.702138] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.839s)
[83.994101] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.493s)
[84.867982] [014/154] (935s left) gem_render_copy (y-tiled-ccs-to-linear)
[84.925083] Starting subtest: y-tiled-ccs-to-linear
[84.929541] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[85.104479] [015/154] (934s left) gem_softpin (allocator-nopin)
[85.152707] Starting subtest: allocator-nopin
[85.234326] Subtest allocator-nopin: SUCCESS (0.082s)
[85.349324] [016/154] (934s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[85.450824] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[85.454853] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[85.547024] [017/154] (934s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[85.658734] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[86.671078] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.012s)
[86.801366] [018/154] (933s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-shrfb-pgflip-blt)
[86.897960] Starting subtest: psrhdr-2p-primscrn-shrfb-pgflip-blt
[86.901760] Subtest psrhdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[87.005383] [019/154] (933s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[87.087942] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[87.089893] Starting dynamic subtest: pipe-A-eDP-1
[87.108965] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[87.118791] Starting dynamic subtest: pipe-B-eDP-1
[87.136857] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[87.144696] Starting dynamic subtest: pipe-C-eDP-1
[87.162542] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[87.171183] Starting dynamic subtest: pipe-D-eDP-1
[87.189758] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[87.193341] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.005s)
[89.325840] [020/154] (930s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[89.416466] Starting subtest: plane-all-modeset-transition-internal-panels
[89.418690] Starting dynamic subtest: pipe-A-eDP-1
[90.778267] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.360s)
[91.059771] Starting dynamic subtest: pipe-B-eDP-1
[92.106050] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.053s)
[92.379604] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.962s)
[93.222460] [021/154] (927s left) syncobj_wait (single-wait-all-signaled)
[93.281613] Starting subtest: single-wait-all-signaled
[93.284074] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[93.408824] [022/154] (926s left) perf (disabled-read-error)
[93.485141] Starting subtest: disabled-read-error
[93.499417] Subtest disabled-read-error: SUCCESS (0.014s)
[93.536394] [023/154] (926s left) api_intel_bb (blit-noreloc-purge-cache)
[93.583661] Starting subtest: blit-noreloc-purge-cache
[93.590757] Subtest blit-noreloc-purge-cache: SUCCESS (0.009s)
[93.719087] [024/154] (926s left) gen9_exec_parse (basic-rejected)
[93.772715] Subtest basic-rejected: SKIP (0.000s)
[93.840067] [025/154] (926s left) gem_softpin (evict-active)
[93.894890] Starting subtest: evict-active
[93.900228] Subtest evict-active: SUCCESS (0.005s)
[94.011370] [026/154] (926s left) gem_exec_schedule (semaphore-codependency)
[94.086331] Starting subtest: semaphore-codependency
[94.092288] Subtest semaphore-codependency: SUCCESS (0.013s)
[94.430661] [027/154] (926s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[94.527774] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[94.532756] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[94.612869] [028/154] (925s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[94.703777] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-mmap-gtt
[94.708005] Subtest fbchdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[94.779865] [029/154] (925s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[94.876280] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[94.880819] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[94.971389] [030/154] (925s left) prime_self_import (basic-llseek-size)
[95.010830] Starting subtest: basic-llseek-size
[95.026816] Subtest basic-llseek-size: SUCCESS (0.017s)
[95.121052] [031/154] (925s left) gem_exec_params (rs-invalid)
[95.173583] Starting subtest: rs-invalid
[95.178335] Subtest rs-invalid: SUCCESS (0.003s)
[95.283629] [032/154] (925s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[95.379439] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[102.051203] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.671s)
[102.176333] [033/154] (918s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[102.227624] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[102.230041] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[102.325197] [034/154] (918s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[102.411032] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[102.413339] Starting dynamic subtest: pipe-A-default-mode
[105.201450] Dynamic subtest pipe-A-default-mode: SUCCESS (2.790s)
[105.203964] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.791s)
[106.075027] [035/154] (914s left) gem_exec_nop (basic-sequential)
[106.147659] Starting subtest: basic-sequential
[120.768069] Subtest basic-sequential: SUCCESS (14.625s)
[120.994340] [036/154] (899s left) kms_async_flips (test-time-stamp-atomic)
[121.096027] Starting subtest: test-time-stamp-atomic
[121.474486] Starting dynamic subtest: pipe-A-eDP-1
[122.266360] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.791s)
[122.647510] Starting dynamic subtest: pipe-B-eDP-1
[123.498037] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.856s)
[123.881411] Starting dynamic subtest: pipe-C-eDP-1
[124.732303] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.856s)
[125.091724] Starting dynamic subtest: pipe-D-eDP-1
[125.862059] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.774s)
[125.864519] Subtest test-time-stamp-atomic: SUCCESS (4.766s)
[127.033597] [037/154] (893s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[127.134751] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[131.841059] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (4.712s)
[131.942965] [038/154] (888s left) i915_pm_rpm (gem-pread)
[133.459508] Starting subtest: gem-pread
[135.879089] Subtest gem-pread: SUCCESS (2.418s)
[135.961065] [039/154] (884s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[136.058389] Starting subtest: y-tiled-8bpp-rotate-0
[136.062686] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[136.154138] [040/154] (884s left) gem_pxp (display-protected-crc)
[136.275476] Starting subtest: display-protected-crc
[137.897819] Subtest display-protected-crc: SUCCESS (1.626s)
[138.026222] [041/154] (882s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip)
[138.129611] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip
[138.133837] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[138.225278] [042/154] (882s left) gem_ctx_persistence (engines-persistence)
[138.285280] Starting subtest: engines-persistence
[138.287613] Starting dynamic subtest: rcs0
[139.075898] Dynamic subtest rcs0: SUCCESS (0.790s)
[139.086726] Starting dynamic subtest: bcs0
[139.839654] Dynamic subtest bcs0: SUCCESS (0.762s)
[139.850251] Starting dynamic subtest: vcs0
[140.605161] Dynamic subtest vcs0: SUCCESS (0.763s)
[140.616546] Starting dynamic subtest: vcs1
[141.395050] Dynamic subtest vcs1: SUCCESS (0.788s)
[141.406826] Starting dynamic subtest: vecs0
[142.140960] Dynamic subtest vecs0: SUCCESS (0.744s)
[142.151895] Starting dynamic subtest: ccs0
[142.890341] Dynamic subtest ccs0: SUCCESS (0.747s)
[142.893075] Subtest engines-persistence: SUCCESS (4.605s)
[143.007788] [043/154] (878s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-onoff)
[143.108489] Starting subtest: fbchdr-1p-primscrn-spr-indfb-onoff
[143.112905] Subtest fbchdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[143.203859] [044/154] (877s left) kms_vrr (flip-dpms)
[143.301716] Starting subtest: flip-dpms
[143.308195] Subtest flip-dpms: SKIP (0.000s)
[143.368999] [045/154] (877s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-render)
[143.471581] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-render
[143.475657] Subtest psrhdr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[143.564874] [046/154] (877s left) kms_chamelium_color (ctm-0-75)
[143.655154] Subtest ctm-0-75: SKIP (0.000s)
[143.695431] [047/154] (877s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[143.802795] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[143.813129] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[143.912849] [048/154] (877s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[143.969809] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[143.973600] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[144.163689] [049/154] (877s left) kms_universal_plane (universal-plane-pageflip-windowed)
[144.249145] Starting subtest: universal-plane-pageflip-windowed
[144.251270] Starting dynamic subtest: pipe-A-eDP-1
[144.793950] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.542s)
[144.803742] Starting dynamic subtest: pipe-B-eDP-1
[146.039386] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.245s)
[146.049078] Starting dynamic subtest: pipe-C-eDP-1
[147.246599] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.208s)
[147.256731] Starting dynamic subtest: pipe-D-eDP-1
[148.466276] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.216s)
[148.468408] Subtest universal-plane-pageflip-windowed: SUCCESS (4.216s)
[149.356995] [050/154] (871s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-mmap-cpu)
[149.452342] Starting subtest: psrhdr-rgb101010-draw-mmap-cpu
[149.457091] Subtest psrhdr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[149.549977] [051/154] (871s left) kms_psr (fbc-psr2-sprite-plane-move)
[149.642596] Starting subtest: fbc-psr2-sprite-plane-move
[149.644804] Starting dynamic subtest: eDP-1
[149.648854] Dynamic subtest eDP-1: SKIP (0.000s)
[149.652975] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[149.725968] [052/154] (871s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-mmap-wc)
[149.829655] Starting subtest: fbcpsrhdr-rgb565-draw-mmap-wc
[149.833800] Subtest fbcpsrhdr-rgb565-draw-mmap-wc: SKIP (0.000s)
[149.933845] [053/154] (871s left) perf (polling-parameterized)
[150.009623] Starting subtest: polling-parameterized
[170.024333] Subtest polling-parameterized: SUCCESS (20.015s)
[170.068895] [054/154] (851s left) kms_dp_link_training (uhbr-mst)
[170.187775] Starting subtest: uhbr-mst
[170.195819] Subtest uhbr-mst: SKIP (0.000s)
[170.268759] [055/154] (851s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[170.383343] Starting subtest: cursorA-vs-flipB-legacy
[170.387825] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[170.523082] [056/154] (851s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[170.625250] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[170.629476] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[170.736702] [057/154] (850s left) kms_properties (crtc-properties-atomic)
[170.825840] Starting subtest: crtc-properties-atomic
[170.828105] Starting dynamic subtest: pipe-A-eDP-1
[171.267467] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.442s)
[171.277670] Starting dynamic subtest: pipe-B-eDP-1
[172.397972] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.130s)
[172.406778] Starting dynamic subtest: pipe-C-eDP-1
[173.520581] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.122s)
[173.529983] Starting dynamic subtest: pipe-D-eDP-1
[174.649317] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.127s)
[174.651699] Subtest crtc-properties-atomic: SUCCESS (3.825s)
[175.479291] [058/154] (846s left) gem_fence_thrash (bo-write-verify-threaded-none)
[175.517751] Starting subtest: bo-write-verify-threaded-none
[175.546650] Subtest bo-write-verify-threaded-none: SKIP (0.024s)
[175.599119] [059/154] (846s left) gem_exec_schedule (preempt-queue-chain)
[175.666710] Subtest preempt-queue-chain: SKIP (0.000s)
[175.948673] [060/154] (845s left) gem_workarounds (suspend-resume-context)
[176.008553] Starting subtest: suspend-resume-context
[192.157264] Subtest suspend-resume-context: SUCCESS (2.046s)
[192.277640] [061/154] (829s left) kms_plane_multiple (2x-tiling-4)
[192.385692] Starting subtest: 2x-tiling-4
[192.390361] Subtest 2x-tiling-4: SKIP (0.000s)
[192.469587] [062/154] (829s left) kms_dsc (dsc-basic)
[192.564279] Starting subtest: dsc-basic
[192.576914] Subtest dsc-basic: SKIP (0.001s)
[192.636477] [063/154] (829s left) kms_cursor_crc (cursor-size-hints)
[192.766224] Starting subtest: cursor-size-hints
[192.768641] Starting dynamic subtest: pipe-A-eDP-1
[193.389364] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.594s)
[193.399478] Starting dynamic subtest: pipe-D-eDP-1
[194.665415] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.227s)
[194.667736] Subtest cursor-size-hints: SUCCESS (1.824s)
[195.490690] [064/154] (826s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[195.583886] Starting subtest: 2x-flip-vs-rmfb-interruptible
[195.595892] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.010s)
[195.686688] [065/154] (826s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[195.788089] Starting subtest: yf-tiled-64bpp-rotate-180
[195.792475] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[195.898683] [066/154] (826s left) syncobj_timeline (single-wait-available-signaled)
[195.953068] Starting subtest: single-wait-available-signaled
[195.955290] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[196.042323] [067/154] (825s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[196.144566] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[196.149110] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[196.247191] [068/154] (825s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[196.358946] Starting subtest: fbc-rgb565-draw-mmap-wc
[200.478249] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (4.035s)
[201.645206] [069/154] (820s left) gem_render_copy (y-tiled)
[201.700114] Starting subtest: y-tiled
[201.704920] Subtest y-tiled: SKIP (0.000s)
[201.887784] [070/154] (820s left) kms_addfb_basic (unused-handle)
[201.930309] Starting subtest: unused-handle
[201.932737] Subtest unused-handle: SUCCESS (0.000s)
[202.068187] [071/154] (820s left) kms_cursor_crc (cursor-sliding-512x170)
[202.364323] Starting subtest: cursor-sliding-512x170
[202.368803] Subtest cursor-sliding-512x170: SKIP (0.001s)
[202.506998] [072/154] (819s left) kms_hdr (static-toggle)
[202.597251] Starting subtest: static-toggle
[202.599593] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[202.603657] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s)
[202.613569] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[202.617789] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s)
[202.621867] Subtest static-toggle: SKIP (0.003s)
[202.673051] [073/154] (819s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-blt)
[202.773828] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-blt
[202.777776] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[202.871832] [074/154] (819s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-render)
[202.961454] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-render
[202.964987] Subtest hdr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[203.049456] [075/154] (819s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[203.144103] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[203.148017] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[203.227320] [076/154] (819s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[203.329458] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc
[203.332946] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[203.423674] [077/154] (818s left) i915_suspend (basic-s3-without-i915)
[203.457070] Starting subtest: basic-s3-without-i915
[208.117323] Subtest basic-s3-without-i915: SKIP (4.614s)
[209.698770] [078/154] (812s left) kms_psr (pr-primary-render)
[209.802609] Starting subtest: pr-primary-render
[209.806886] Subtest pr-primary-render: SKIP (0.000s)
[209.875657] [079/154] (812s left) syncobj_wait (single-wait-for-submit-submitted)
[209.942459] Starting subtest: single-wait-for-submit-submitted
[210.048415] Subtest single-wait-for-submit-submitted: SUCCESS (0.104s)
[210.126499] [080/154] (812s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[210.218192] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[210.221505] Starting dynamic subtest: pipe-A-eDP-1
[221.005241] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.760s)
[221.015879] Starting dynamic subtest: pipe-B-eDP-1
[232.440903] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.427s)
[232.443353] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.189s)
[233.314124] [081/154] (789s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[233.418600] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[233.422590] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[233.484027] [082/154] (789s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[233.546243] Starting subtest: wait-all-for-submit-delayed-submit
[233.651896] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[233.745321] [083/154] (788s left) syncobj_timeline (multi-wait-submitted-signaled)
[233.805733] Starting subtest: multi-wait-submitted-signaled
[233.808035] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[233.901359] [084/154] (788s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[233.994182] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[233.996373] Starting dynamic subtest: pipe-A-eDP-1
[234.016523] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[234.025903] Starting dynamic subtest: pipe-B-eDP-1
[234.045860] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[234.054276] Starting dynamic subtest: pipe-C-eDP-1
[234.072995] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[234.081305] Starting dynamic subtest: pipe-D-eDP-1
[234.099796] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[234.101625] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.009s)
[236.261849] [085/154] (786s left) kms_joiner (basic-big-joiner)
[236.357386] Starting subtest: basic-big-joiner
[236.361386] Subtest basic-big-joiner: SKIP (0.000s)
[236.422148] [086/154] (786s left) gem_userptr_blits (huge-split)
[236.491641] Starting subtest: huge-split
[236.500783] Subtest huge-split: SUCCESS (0.009s)
[236.643698] [087/154] (786s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[236.743603] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[236.745938] Starting dynamic subtest: pipe-A-eDP-1
[237.187510] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.415s)
[237.198098] Starting dynamic subtest: pipe-B-eDP-1
[238.656903] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.467s)
[238.666427] Starting dynamic subtest: pipe-C-eDP-1
[239.988247] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.330s)
[239.999498] Starting dynamic subtest: pipe-D-eDP-1
[241.355633] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.368s)
[241.357765] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.585s)
[242.513313] [088/154] (780s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-wc)
[242.607372] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-wc
[242.611614] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[242.691930] [089/154] (780s left) perf (mi-rpc)
[242.813883] Starting subtest: mi-rpc
[242.818451] Subtest mi-rpc: SKIP (0.000s)
[242.860612] [090/154] (780s left) kms_pipe_crc_basic (suspend-read-crc)
[242.955594] Starting subtest: suspend-read-crc
[242.957916] Starting dynamic subtest: pipe-A-eDP-1
[260.076916] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.523s)
[260.086155] Starting dynamic subtest: pipe-B-eDP-1
[278.065413] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.171s)
[278.077130] Starting dynamic subtest: pipe-C-eDP-1
[296.067810] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.007s)
[296.078234] Starting dynamic subtest: pipe-D-eDP-1
[314.083771] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.079s)
[314.086496] Subtest suspend-read-crc: SUCCESS (11.784s)
[314.929266] [091/154] (708s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-rte)
[315.037355] Starting subtest: fbcpsrhdr-1p-rte
[315.042515] Subtest fbcpsrhdr-1p-rte: SKIP (0.000s)
[315.130835] [092/154] (707s left) kms_frontbuffer_tracking (fbchdr-stridechange)
[315.230342] Starting subtest: fbchdr-stridechange
[315.234930] Subtest fbchdr-stridechange: SKIP (0.000s)
[315.339371] [093/154] (707s left) gem_mmap_gtt (ptrace)
[315.395910] Subtest ptrace: SKIP (0.000s)
[315.454287] [094/154] (707s left) kms_plane (plane-panning-top-left)
[315.539681] Starting subtest: plane-panning-top-left
[315.542514] Starting dynamic subtest: pipe-A
[317.242457] Dynamic subtest pipe-A: SUCCESS (1.652s)
[317.253074] Starting dynamic subtest: pipe-B
[319.659736] Dynamic subtest pipe-B: SUCCESS (2.360s)
[319.662446] Subtest plane-panning-top-left: SUCCESS (4.014s)
[320.495483] [095/154] (702s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[320.597528] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[327.454388] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.784s)
[327.591606] [096/154] (695s left) kms_cursor_crc (cursor-alpha-transparent)
[327.680756] Starting subtest: cursor-alpha-transparent
[327.683745] Starting dynamic subtest: pipe-A-eDP-1
[328.296578] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.611s)
[328.307651] Starting dynamic subtest: pipe-D-eDP-1
[329.647490] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.341s)
[329.650109] Subtest cursor-alpha-transparent: SUCCESS (1.955s)
[330.503858] [097/154] (692s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-pwrite)
[330.607667] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-pwrite
[330.613722] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[330.686626] [098/154] (692s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[330.751643] Subtest writes-after-reads: SKIP (0.000s)
[330.816279] [099/154] (692s left) gem_mmap_wc (fault-concurrent)
[330.870611] Subtest fault-concurrent: SKIP (0.000s)
[330.937515] [100/154] (692s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[331.037349] Starting subtest: fbc-rgb101010-draw-mmap-wc
[333.514153] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (2.472s)
[334.716454] [101/154] (688s left) kms_frontbuffer_tracking (hdr-rgb565-draw-mmap-wc)
[334.821545] Starting subtest: hdr-rgb565-draw-mmap-wc
[334.826531] Subtest hdr-rgb565-draw-mmap-wc: SKIP (0.000s)
[334.916414] [102/154] (688s left) gem_ctx_exec (basic-invalid-context)
[334.980119] Starting subtest: basic-invalid-context
[334.985959] Subtest basic-invalid-context: SUCCESS (0.006s)
[335.103750] [103/154] (688s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[335.198429] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[342.111069] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.904s)
[342.251746] [104/154] (681s left) kms_lease (possible-crtcs-filtering)
[342.357411] Starting subtest: possible-crtcs-filtering
[342.363600] Subtest possible-crtcs-filtering: SUCCESS (0.006s)
[342.464799] [105/154] (681s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-blt)
[342.562682] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-blt
[342.567719] Subtest psrhdr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[342.646241] [106/154] (680s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[342.748761] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[351.473765] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.731s)
[351.588838] [107/154] (672s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[351.644870] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[351.751972] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.108s)
[351.830515] [108/154] (671s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[351.925257] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[351.930248] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[351.999339] [109/154] (671s left) kms_vblank (crtc-id)
[352.096768] Starting subtest: crtc-id
[352.099499] Starting dynamic subtest: pipe-A-eDP-1
[352.542035] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.444s)
[352.558515] Starting dynamic subtest: pipe-D-eDP-1
[353.671474] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.127s)
[353.674449] Subtest crtc-id: SUCCESS (1.574s)
[354.536442] [110/154] (669s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[354.638544] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[354.643522] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[354.719785] [111/154] (669s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[354.821019] Starting subtest: async-flip-with-page-flip-events-linear
[355.205570] Starting dynamic subtest: pipe-A-eDP-1
[358.001251] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.794s)
[358.367707] Starting dynamic subtest: pipe-B-eDP-1
[361.126139] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.767s)
[361.488356] Starting dynamic subtest: pipe-C-eDP-1
[364.255817] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.773s)
[364.632037] Starting dynamic subtest: pipe-D-eDP-1
[367.389433] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.764s)
[367.392576] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.568s)
[368.581426] [112/154] (655s left) gem_exec_store (dword)
[368.646049] Starting subtest: dword
[368.648353] Starting dynamic subtest: rcs0
[368.713849] Dynamic subtest rcs0: SUCCESS (0.069s)
[368.725730] Starting dynamic subtest: bcs0
[368.759578] Dynamic subtest bcs0: SUCCESS (0.043s)
[368.769611] Starting dynamic subtest: vcs0
[368.803669] Dynamic subtest vcs0: SUCCESS (0.041s)
[368.814794] Starting dynamic subtest: vcs1
[368.846573] Dynamic subtest vcs1: SUCCESS (0.041s)
[368.857142] Starting dynamic subtest: vecs0
[368.890555] Dynamic subtest vecs0: SUCCESS (0.042s)
[368.901911] Starting dynamic subtest: ccs0
[368.934875] Dynamic subtest ccs0: SUCCESS (0.042s)
[368.937640] Subtest dword: SUCCESS (0.291s)
[369.125313] [113/154] (654s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[369.217354] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[369.222125] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[370.323796] [114/154] (653s left) gem_exec_fence (basic-busy-all)
[370.390464] Starting subtest: basic-busy-all
[370.479312] Subtest basic-busy-all: SUCCESS (0.091s)
[372.600593] [FACT gem_exec_fence (basic-busy-all)] new: kernel.kmod_is_loaded.vgem: true
[372.605170] [115/154] (651s left) gem_shrink (reclaim)
[372.660022] Starting subtest: reclaim
[375.180431] Subtest reclaim: SUCCESS (2.517s)
[375.309255] [116/154] (648s left) kms_flip (2x-blocking-wf_vblank)
[375.409338] Starting subtest: 2x-blocking-wf_vblank
[375.417975] Subtest 2x-blocking-wf_vblank: SKIP (0.011s)
[375.498564] [117/154] (648s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[375.544465] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[375.646533] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.103s)
[375.736001] [118/154] (648s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-blt)
[375.831779] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-blt
[375.836610] Subtest hdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[375.930556] [119/154] (648s left) kms_pm_lpsp (screens-disabled)
[377.026259] Starting subtest: screens-disabled
[377.031564] Subtest screens-disabled: SKIP (0.000s)
[377.112282] [120/154] (647s left) kms_psr (psr-cursor-mmap-gtt)
[377.214195] Starting subtest: psr-cursor-mmap-gtt
[377.216459] Starting dynamic subtest: eDP-1
[378.931759] Dynamic subtest eDP-1: SUCCESS (1.718s)
[378.934574] Subtest psr-cursor-mmap-gtt: SUCCESS (1.720s)
[379.802016] [121/154] (644s left) vgem_basic (second-client)
[379.844631] Starting subtest: second-client
[379.864451] Subtest second-client: SUCCESS (0.022s)
[379.927170] [122/154] (644s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[380.011957] Starting subtest: flip-vs-dpms-off-vs-modeset
[380.014337] Starting dynamic subtest: A-eDP1
[383.660381] Dynamic subtest A-eDP1: SUCCESS (3.645s)
[383.671720] Starting dynamic subtest: B-eDP1
[386.870979] Dynamic subtest B-eDP1: SUCCESS (3.208s)
[386.882019] Starting dynamic subtest: C-eDP1
[390.066565] Dynamic subtest C-eDP1: SUCCESS (3.195s)
[390.077456] Starting dynamic subtest: D-eDP1
[393.288145] Dynamic subtest D-eDP1: SUCCESS (3.219s)
[393.290664] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.275s)
[394.099318] [123/154] (630s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-mmap-wc)
[394.201285] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-mmap-wc
[394.206191] Subtest hdr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[394.307102] [124/154] (630s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[394.410247] Starting subtest: 4-tiled-32bpp-rotate-270
[394.430306] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.020s)
[394.542947] [125/154] (629s left) kms_content_protection (dp-mst-lic-type-1)
[394.681733] Starting subtest: dp-mst-lic-type-1
[394.687547] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[394.793634] [126/154] (629s left) gem_exec_fence (syncobj-timeline-repeat)
[395.331077] Starting subtest: syncobj-timeline-repeat
[395.572034] Subtest syncobj-timeline-repeat: SUCCESS (0.241s)
[396.578139] [127/154] (627s left) gem_exec_capture (pi)
[396.631382] Starting subtest: pi
[396.634587] Starting dynamic subtest: rcs0
[400.993346] Dynamic subtest rcs0: SUCCESS (4.363s)
[401.003875] Starting dynamic subtest: bcs0
[405.032276] Dynamic subtest bcs0: SUCCESS (4.036s)
[405.047898] Starting dynamic subtest: vcs0
[409.060100] Dynamic subtest vcs0: SUCCESS (4.025s)
[409.070778] Starting dynamic subtest: vcs1
[413.065172] Dynamic subtest vcs1: SUCCESS (4.005s)
[413.076920] Starting dynamic subtest: vecs0
[417.069402] Dynamic subtest vecs0: SUCCESS (4.004s)
[417.079893] Starting dynamic subtest: ccs0
[421.070097] Dynamic subtest ccs0: SUCCESS (3.999s)
[421.072758] Subtest pi: SUCCESS (24.442s)
[421.151925] [128/154] (603s left) kms_flip (flip-vs-suspend-interruptible)
[421.301835] Starting subtest: flip-vs-suspend-interruptible
[421.304471] Starting dynamic subtest: A-eDP1
[566.162120] Dynamic subtest A-eDP1: SUCCESS (11.993s)
[566.166410] Subtest flip-vs-suspend-interruptible: SUCCESS (11.996s)
[566.314191] [129/154] (458s left) i915_pm_freq_mult (media-freq)
[566.382171] Starting subtest: media-freq
[566.384560] Starting dynamic subtest: gt0
[566.389145] Dynamic subtest gt0: SKIP (0.000s)
[566.401232] Starting dynamic subtest: gt1
[566.406586] Dynamic subtest gt1: SKIP (0.000s)
[566.411843] Subtest media-freq: SKIP (0.002s)
[566.496964] [130/154] (458s left) gem_exec_create (forked)
[566.578719] Starting subtest: forked
[566.581421] Starting dynamic subtest: smem
[588.339178] Dynamic subtest smem: SUCCESS (21.415s)
[588.342266] Subtest forked: SUCCESS (21.418s)
[588.526173] [131/154] (436s left) kms_pm_rpm (package-g7)
[590.570543] Starting subtest: package-g7
[590.575706] Subtest package-g7: SKIP (0.000s)
[590.956375] [132/154] (433s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-indfb-plflip-blt)
[591.056384] Starting subtest: fbchdr-2p-scndscrn-indfb-plflip-blt
[591.061386] Subtest fbchdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[591.144938] [133/154] (433s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[591.241802] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[591.247100] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[591.328538] [134/154] (433s left) gem_exec_balancer (hang)
[591.592677] Starting subtest: hang
[593.330055] Subtest hang: SUCCESS (1.738s)
[593.446920] [135/154] (431s left) core_setmaster (master-drop-set-shared-fd)
[593.516956] Starting subtest: master-drop-set-shared-fd
[593.526048] Subtest master-drop-set-shared-fd: SUCCESS (0.011s)
[593.565123] [136/154] (431s left) i915_drm_fdinfo (most-busy-idle-check-all)
[593.611160] Starting subtest: most-busy-idle-check-all
[593.613216] Starting dynamic subtest: rcs0
[593.618128] Dynamic subtest rcs0: SKIP (0.004s)
[593.630098] Starting dynamic subtest: bcs0
[593.635441] Dynamic subtest bcs0: SKIP (0.000s)
[593.645862] Starting dynamic subtest: vcs0
[593.650559] Dynamic subtest vcs0: SKIP (0.000s)
[593.660649] Starting dynamic subtest: vcs1
[593.665517] Dynamic subtest vcs1: SKIP (0.000s)
[593.675440] Starting dynamic subtest: vecs0
[593.680124] Dynamic subtest vecs0: SKIP (0.000s)
[593.690588] Starting dynamic subtest: ccs0
[593.695367] Dynamic subtest ccs0: SKIP (0.000s)
[593.699992] Subtest most-busy-idle-check-all: SKIP (0.010s)
[593.742732] [137/154] (431s left) kms_psr (fbc-psr-sprite-plane-onoff)
[593.837748] Starting subtest: fbc-psr-sprite-plane-onoff
[593.840817] Starting dynamic subtest: eDP-1
[593.846423] Dynamic subtest eDP-1: SKIP (0.000s)
[593.852643] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[593.915310] [138/154] (431s left) gem_ctx_persistence (legacy-engines-mixed)
[593.969823] Starting subtest: legacy-engines-mixed
[593.972637] Starting dynamic subtest: render
[594.038828] Dynamic subtest render: SUCCESS (0.069s)
[594.051317] Starting dynamic subtest: bsd1
[594.097959] Dynamic subtest bsd1: SUCCESS (0.057s)
[594.111778] Starting dynamic subtest: bsd2
[594.152550] Dynamic subtest bsd2: SUCCESS (0.052s)
[594.163988] Starting dynamic subtest: blt
[594.193585] Dynamic subtest blt: SUCCESS (0.039s)
[594.204542] Starting dynamic subtest: vebox
[594.239385] Dynamic subtest vebox: SUCCESS (0.045s)
[594.241890] Subtest legacy-engines-mixed: SUCCESS (0.270s)
[594.325202] [139/154] (430s left) kms_big_fb (linear-16bpp-rotate-0)
[594.423570] Starting subtest: linear-16bpp-rotate-0
[595.716295] Subtest linear-16bpp-rotate-0: SUCCESS (1.290s)
[595.828072] [140/154] (429s left) gem_mmap_gtt (close-race)
[595.887485] Subtest close-race: SKIP (0.000s)
[595.950738] [141/154] (429s left) kms_selftest (drm_format)
[595.988245] Starting subtest: drm_format
[596.039870] Starting dynamic subtest: drm_test_format_block_width_invalid
[596.123598] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.085s)
[596.135605] Starting dynamic subtest: drm_test_format_block_width_one_plane
[596.234034] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.110s)
[596.247187] Starting dynamic subtest: drm_test_format_block_width_two_plane
[596.342155] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.106s)
[596.354290] Starting dynamic subtest: drm_test_format_block_width_three_plane
[596.430432] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.087s)
[596.441538] Starting dynamic subtest: drm_test_format_block_width_tiled
[596.543257] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.112s)
[596.554463] Starting dynamic subtest: drm_test_format_block_height_invalid
[596.636248] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.091s)
[596.646551] Starting dynamic subtest: drm_test_format_block_height_one_plane
[596.730494] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.093s)
[596.741736] Starting dynamic subtest: drm_test_format_block_height_two_plane
[596.820755] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.090s)
[596.831037] Starting dynamic subtest: drm_test_format_block_height_three_plane
[596.920373] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.098s)
[596.931363] Starting dynamic subtest: drm_test_format_block_height_tiled
[597.013729] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.093s)
[597.024395] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[597.098657] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.084s)
[597.109406] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[597.188856] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.086s)
[597.199091] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[597.275744] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.086s)
[597.286193] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[597.357615] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.080s)
[597.369234] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[597.448690] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.089s)
[597.460613] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[597.549573] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.097s)
[597.559734] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[597.631105] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.080s)
[597.641520] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[597.708450] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.077s)
[597.710475] Subtest drm_format: SUCCESS (1.718s)
[597.846824] [142/154] (427s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[597.938459] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-cpu
[597.942218] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[598.037404] [143/154] (427s left) kms_psr (fbc-pr-no-drrs)
[598.127548] Starting subtest: fbc-pr-no-drrs
[598.132043] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[598.212757] [144/154] (427s left) kms_flip (dpms-vs-vblank-race-interruptible)
[598.310470] Starting subtest: dpms-vs-vblank-race-interruptible
[598.312286] Starting dynamic subtest: A-eDP1
[602.227424] Dynamic subtest A-eDP1: SUCCESS (3.911s)
[602.238736] Starting dynamic subtest: B-eDP1
[605.831872] Dynamic subtest B-eDP1: SUCCESS (3.602s)
[605.844300] Starting dynamic subtest: C-eDP1
[610.472627] Dynamic subtest C-eDP1: SUCCESS (4.637s)
[610.483554] Starting dynamic subtest: D-eDP1
[615.107840] Dynamic subtest D-eDP1: SUCCESS (4.633s)
[615.113265] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (16.793s)
[616.010392] [145/154] (409s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-render)
[616.122685] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-render
[616.127861] Subtest hdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[616.233990] [146/154] (409s left) perf_pmu (busy-idle-no-semaphores)
[616.277222] Starting subtest: busy-idle-no-semaphores
[616.279563] Starting dynamic subtest: rcs0
[616.934083] Dynamic subtest rcs0: SUCCESS (0.655s)
[616.948709] Starting dynamic subtest: bcs0
[617.585567] Dynamic subtest bcs0: SUCCESS (0.650s)
[617.599984] Starting dynamic subtest: vcs0
[618.238435] Dynamic subtest vcs0: SUCCESS (0.650s)
[618.252464] Starting dynamic subtest: vcs1
[619.996262] Dynamic subtest vcs1: SUCCESS (1.754s)
[620.011032] Starting dynamic subtest: vecs0
[621.977125] Dynamic subtest vecs0: SUCCESS (1.978s)
[621.991721] Starting dynamic subtest: ccs0
[623.961247] Dynamic subtest ccs0: SUCCESS (1.980s)
[623.964347] Subtest busy-idle-no-semaphores: SUCCESS (7.680s)
[624.092548] [147/154] (401s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[624.193636] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[624.198608] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[624.274812] [148/154] (401s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[624.367661] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-mmap-wc
[624.372677] Subtest fbchdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[624.451541] [149/154] (401s left) kms_chamelium_color (gamma)
[624.547500] Subtest gamma: SKIP (0.000s)
[624.595028] [150/154] (400s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[624.690579] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[624.693218] Starting dynamic subtest: pipe-A
[624.756517] Dynamic subtest pipe-A: SUCCESS (0.066s)
[624.769438] Starting dynamic subtest: pipe-B
[625.918461] Dynamic subtest pipe-B: SUCCESS (1.160s)
[625.932338] Starting dynamic subtest: pipe-C
[627.044821] Dynamic subtest pipe-C: SUCCESS (1.125s)
[627.056607] Starting dynamic subtest: pipe-D
[628.188222] Dynamic subtest pipe-D: SUCCESS (1.142s)
[628.191480] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.498s)
[629.342830] [151/154] (396s left) kms_flip (flip-vs-expired-vblank-interruptible)
[629.435977] Starting subtest: flip-vs-expired-vblank-interruptible
[629.438656] Starting dynamic subtest: A-eDP1
[638.159457] Dynamic subtest A-eDP1: SUCCESS (8.719s)
[638.173854] Starting dynamic subtest: B-eDP1
[646.788709] Dynamic subtest B-eDP1: SUCCESS (8.622s)
[646.800221] Starting dynamic subtest: C-eDP1
[655.404763] Dynamic subtest C-eDP1: SUCCESS (8.611s)
[655.419663] Starting dynamic subtest: D-eDP1
[664.032624] Dynamic subtest D-eDP1: SUCCESS (8.624s)
[664.035405] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.587s)
[665.193148] [152/154] (360s left) sysfs_heartbeat_interval (idempotent)
[665.247571] Starting subtest: idempotent
[665.250507] Starting dynamic subtest: vecs0
[665.253271] Dynamic subtest vecs0: SUCCESS (0.001s)
[665.267877] Starting dynamic subtest: ccs0
[665.270272] Dynamic subtest ccs0: SUCCESS (0.001s)
[665.280635] Starting dynamic subtest: vcs0
[665.282830] Dynamic subtest vcs0: SUCCESS (0.000s)
[665.293086] Starting dynamic subtest: bcs0
[665.295702] Dynamic subtest bcs0: SUCCESS (0.001s)
[665.307011] Starting dynamic subtest: rcs0
[665.309224] Dynamic subtest rcs0: SUCCESS (0.000s)
[665.319460] Starting dynamic subtest: vcs1
[665.321599] Dynamic subtest vcs1: SUCCESS (0.000s)
[665.323809] Subtest idempotent: SUCCESS (0.007s)
[665.365318] [153/154] (360s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[665.434089] Starting subtest: x-tiled-to-vebox-yf-tiled
[665.438667] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[665.621617] [154/154] (360s left) prime_busy (hang-wait)
[665.681735] Starting subtest: hang-wait
[665.684607] Starting dynamic subtest: rcs0
[691.856331] Dynamic subtest rcs0: SUCCESS (26.178s)
[691.869988] Starting dynamic subtest: bcs0
[698.948654] Dynamic subtest bcs0: SUCCESS (7.089s)
[698.960582] Starting dynamic subtest: vcs0
[705.985265] Dynamic subtest vcs0: SUCCESS (7.032s)
[705.998758] Starting dynamic subtest: vcs1
[712.959016] Dynamic subtest vcs1: SUCCESS (6.970s)
[712.972299] Starting dynamic subtest: vecs0
[719.935134] Dynamic subtest vecs0: SUCCESS (6.971s)
[719.948249] Starting dynamic subtest: ccs0
[733.837695] Dynamic subtest ccs0: SUCCESS (13.896s)
[733.840245] Subtest hang-wait: SUCCESS (68.152s)
[733.941245] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: kms_concurrent
results: parsing output: 2/ for test: syncobj_timeline
results: parsing output: 3/ for test: kms_chamelium_hpd
results: parsing output: 4/ for test: gem_lmem_swapping
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: api_intel_bb
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_barrier_race
results: parsing output: 10/ for test: kms_rotation_crc
results: parsing output: 11/ for test: gem_readwrite
results: parsing output: 12/ for test: kms_atomic_transition
results: parsing output: 13/ for test: gem_render_copy
results: parsing output: 14/ for test: gem_softpin
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_big_fb
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: kms_atomic_transition
results: parsing output: 20/ for test: syncobj_wait
results: parsing output: 21/ for test: perf
results: parsing output: 22/ for test: api_intel_bb
results: parsing output: 23/ for test: gen9_exec_parse
results: parsing output: 24/ for test: gem_softpin
results: parsing output: 25/ for test: gem_exec_schedule
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: prime_self_import
results: parsing output: 30/ for test: gem_exec_params
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: syncobj_wait
results: parsing output: 33/ for test: kms_flip_scaled_crc
results: parsing output: 34/ for test: gem_exec_nop
results: parsing output: 35/ for test: kms_async_flips
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: i915_pm_rpm
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: gem_pxp
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: gem_ctx_persistence
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_vrr
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_chamelium_color
results: parsing output: 46/ for test: kms_flip
results: parsing output: 47/ for test: gem_render_copy
results: parsing output: 48/ for test: kms_universal_plane
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: perf
results: parsing output: 53/ for test: kms_dp_link_training
results: parsing output: 54/ for test: kms_cursor_legacy
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_properties
results: parsing output: 57/ for test: gem_fence_thrash
results: parsing output: 58/ for test: gem_exec_schedule
results: parsing output: 59/ for test: gem_workarounds
results: parsing output: 60/ for test: kms_plane_multiple
results: parsing output: 61/ for test: kms_dsc
results: parsing output: 62/ for test: kms_cursor_crc
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: syncobj_timeline
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_render_copy
results: parsing output: 69/ for test: kms_addfb_basic
results: parsing output: 70/ for test: kms_cursor_crc
results: parsing output: 71/ for test: kms_hdr
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_plane
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: i915_suspend
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: syncobj_wait
results: parsing output: 79/ for test: kms_psr2_sf
results: parsing output: 80/ for test: kms_psr2_sf
results: parsing output: 81/ for test: syncobj_wait
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: kms_ccs
results: parsing output: 84/ for test: kms_joiner
results: parsing output: 85/ for test: gem_userptr_blits
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: perf
results: parsing output: 89/ for test: kms_pipe_crc_basic
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_mmap_gtt
results: parsing output: 93/ for test: kms_plane
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_cursor_crc
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 98/ for test: gem_mmap_wc
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_ctx_exec
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_lease
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: syncobj_wait
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_vblank
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_async_flips
results: parsing output: 111/ for test: gem_exec_store
results: parsing output: 112/ for test: kms_ccs
results: parsing output: 113/ for test: gem_exec_fence
results: parsing output: 114/ for test: gem_shrink
results: parsing output: 115/ for test: kms_flip
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_pm_lpsp
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: vgem_basic
results: parsing output: 121/ for test: kms_flip
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: kms_content_protection
results: parsing output: 125/ for test: gem_exec_fence
results: parsing output: 126/ for test: gem_exec_capture
results: parsing output: 127/ for test: kms_flip
results: parsing output: 128/ for test: i915_pm_freq_mult
results: parsing output: 129/ for test: gem_exec_create
results: parsing output: 130/ for test: kms_pm_rpm
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: gem_exec_balancer
results: parsing output: 134/ for test: core_setmaster
results: parsing output: 135/ for test: i915_drm_fdinfo
results: parsing output: 136/ for test: kms_psr
results: parsing output: 137/ for test: gem_ctx_persistence
results: parsing output: 138/ for test: kms_big_fb
results: parsing output: 139/ for test: gem_mmap_gtt
results: parsing output: 140/ for test: kms_selftest
results: parsing output: 141/ for test: kms_frontbuffer_tracking
results: parsing output: 142/ for test: kms_psr
results: parsing output: 143/ for test: kms_flip
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: perf_pmu
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: kms_chamelium_color
results: parsing output: 149/ for test: kms_plane_scaling
results: parsing output: 150/ for test: kms_flip
results: parsing output: 151/ for test: sysfs_heartbeat_interval
results: parsing output: 152/ for test: gem_render_copy
results: parsing output: 153/ for test: prime_busy
Done.