[90.808972] Initializing watchdogs
[90.809260]   /dev/watchdog0
[90.849073] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[90.863915] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[90.871244] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[90.879290] [001/133] (960s left) perf (polling-parameterized)
[91.152128] Starting subtest: polling-parameterized
[111.193805] Subtest polling-parameterized: SUCCESS (20.040s)
[111.324376] [002/133] (940s left) gem_exec_balancer (invalid-bonds)
[111.458976] Starting subtest: invalid-bonds
[111.467887] Subtest invalid-bonds: SUCCESS (0.009s)
[112.092474] [003/133] (939s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[112.440902] Starting subtest: multi-wait-for-submit-available-signaled
[112.510862] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.002s)
[112.966848] [004/133] (939s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[113.239673] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[113.245991] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[113.379525] [005/133] (939s left) gem_mmap (basic)
[113.493523] Starting subtest: basic
[113.514811] Subtest basic: SUCCESS (0.001s)
[113.657164] [006/133] (938s left) gem_exec_reloc (basic-softpin)
[113.783361] Starting subtest: basic-softpin
[113.792405] Subtest basic-softpin: SUCCESS (0.007s)
[114.027069] [007/133] (938s left) gem_exec_schedule (implicit-read-write)
[114.169117] Starting subtest: implicit-read-write
[114.173249] Starting dynamic subtest: rcs0
[114.303081] Dynamic subtest rcs0: SUCCESS (0.134s)
[114.325630] Starting dynamic subtest: bcs0
[114.449620] Dynamic subtest bcs0: SUCCESS (0.142s)
[114.480762] Starting dynamic subtest: vcs0
[114.567836] Dynamic subtest vcs0: SUCCESS (0.118s)
[114.592344] Starting dynamic subtest: vecs0
[114.687323] Dynamic subtest vecs0: SUCCESS (0.119s)
[114.693315] Subtest implicit-read-write: SUCCESS (0.525s)
[115.079267] [008/133] (937s left) gem_ctx_engines (independent)
[115.214883] Starting subtest: independent
[115.219322] Starting dynamic subtest: rcs0
[115.414856] Dynamic subtest rcs0: SUCCESS (0.195s)
[115.435077] Starting dynamic subtest: bcs0
[115.666482] Dynamic subtest bcs0: SUCCESS (0.252s)
[115.699172] Starting dynamic subtest: vcs0
[115.867068] Dynamic subtest vcs0: SUCCESS (0.206s)
[115.897071] Starting dynamic subtest: vecs0
[116.073086] Dynamic subtest vecs0: SUCCESS (0.202s)
[116.101057] Starting dynamic subtest: all-engines
[116.674686] Dynamic subtest all-engines: SUCCESS (0.602s)
[116.680955] Subtest independent: SUCCESS (1.463s)
[116.943728] [009/133] (935s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[117.154618] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[117.161099] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[117.309601] [010/133] (935s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[117.511889] Starting subtest: x-tiled-16bpp-rotate-0
[121.139058] Subtest x-tiled-16bpp-rotate-0: SUCCESS (3.626s)
[121.477135] [011/133] (931s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[121.668173] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.000s)
[121.772327] [012/133] (931s left) gem_exec_schedule (u-submit-early-slice)
[121.917719] Starting subtest: u-submit-early-slice
[121.921157] Starting dynamic subtest: rcs0
[121.971200] Dynamic subtest rcs0: SUCCESS (0.060s)
[121.997334] Starting dynamic subtest: bcs0
[122.026060] Dynamic subtest bcs0: SUCCESS (0.050s)
[122.046498] Starting dynamic subtest: vcs0
[122.073130] Dynamic subtest vcs0: SUCCESS (0.048s)
[122.095326] Starting dynamic subtest: vecs0
[122.125377] Dynamic subtest vecs0: SUCCESS (0.053s)
[122.128999] Subtest u-submit-early-slice: SUCCESS (0.217s)
[122.511266] [013/133] (930s left) fbdev (write)
[122.627226] Starting subtest: write
[123.410864] Subtest write: SUCCESS (0.784s)
[123.559362] [014/133] (929s left) sysfs_preempt_timeout (idempotent)
[123.673247] Starting subtest: idempotent
[123.678202] Starting dynamic subtest: vecs0
[123.681373] Dynamic subtest vecs0: SUCCESS (0.002s)
[123.703527] Starting dynamic subtest: vcs0
[123.707473] Dynamic subtest vcs0: SUCCESS (0.002s)
[123.728538] Starting dynamic subtest: bcs0
[123.732279] Dynamic subtest bcs0: SUCCESS (0.002s)
[123.753042] Starting dynamic subtest: rcs0
[123.757079] Dynamic subtest rcs0: SUCCESS (0.002s)
[123.761302] Subtest idempotent: SUCCESS (0.012s)
[123.854375] [015/133] (929s left) kms_content_protection (lic-type-0-hdcp14)
[124.051747] Starting subtest: lic-type-0-hdcp14
[124.096669] Subtest lic-type-0-hdcp14: SKIP (0.036s)
[124.230301] [016/133] (929s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[124.437187] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[124.678354] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.238s)
[124.943935] [017/133] (928s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[125.152296] Starting subtest: yf-tiled-32bpp-rotate-0
[130.207908] Subtest yf-tiled-32bpp-rotate-0: SUCCESS (5.053s)
[130.594685] [018/133] (922s left) gem_exec_async (forked-writes)
[130.735235] Starting subtest: forked-writes
[130.739832] Starting dynamic subtest: rcs0
[130.794071] Dynamic subtest rcs0: SUCCESS (0.063s)
[130.821047] Starting dynamic subtest: bcs0
[130.859758] Dynamic subtest bcs0: SUCCESS (0.069s)
[130.884137] Starting dynamic subtest: vcs0
[130.925030] Dynamic subtest vcs0: SUCCESS (0.064s)
[130.948390] Starting dynamic subtest: vecs0
[130.989043] Dynamic subtest vecs0: SUCCESS (0.061s)
[130.993641] Subtest forked-writes: SUCCESS (0.260s)
[131.240585] [019/133] (922s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[131.423059] Starting subtest: plane-lut1d-post-ctm3x4
[132.542606] Subtest plane-lut1d-post-ctm3x4: SKIP (1.111s)
[132.864643] [020/133] (920s left) gem_mmap_gtt (basic-wc)
[132.983049] Starting subtest: basic-wc
[133.618924] Subtest basic-wc: SUCCESS (0.631s)
[133.763338] [021/133] (920s left) gen7_exec_parse (load-register-reg)
[133.882868] Subtest load-register-reg: SKIP (0.000s)
[133.987743] [022/133] (919s left) gem_exec_suspend (basic-s3-devices)
[134.111110] Starting subtest: basic-S3-devices
[134.114388] Starting dynamic subtest: smem
[144.249556] Dynamic subtest smem: SUCCESS (10.137s)
[144.254204] Subtest basic-S3-devices: SUCCESS (10.138s)
[154.549259] [023/133] (909s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[154.763104] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[154.867152] [024/133] (909s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[155.123528] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[155.131073] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[155.270271] [025/133] (908s left) kms_feature_discovery (chamelium)
[155.462612] Starting subtest: chamelium
[155.468524] Subtest chamelium: SKIP (0.001s)
[155.603102] [026/133] (908s left) perf (whitelisted-registers-userspace-config)
[155.796144] Starting subtest: whitelisted-registers-userspace-config
[155.801803] Subtest whitelisted-registers-userspace-config: SUCCESS (0.002s)
[155.901878] [027/133] (908s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[156.102118] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[157.127928] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (1.027s)
[157.451458] [028/133] (907s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[157.635071] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[157.642097] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SKIP (0.000s)
[157.770529] [029/133] (906s left) gem_softpin (evict-snoop-interruptible)
[157.895126] Starting subtest: evict-snoop-interruptible
[157.902586] Subtest evict-snoop-interruptible: SKIP (0.000s)
[158.034294] [030/133] (906s left) kms_psr (fbc-pr-sprite-render)
[158.231054] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[158.330716] [031/133] (906s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[158.523376] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[158.533400] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[159.204743] [032/133] (905s left) gem_exec_store (pages)
[159.343610] Starting subtest: pages
[159.349110] Starting dynamic subtest: rcs0
[159.438853] Dynamic subtest rcs0: SUCCESS (0.096s)
[159.463340] Starting dynamic subtest: bcs0
[159.529567] Dynamic subtest bcs0: SUCCESS (0.088s)
[159.552983] Starting dynamic subtest: vcs0
[159.610871] Dynamic subtest vcs0: SUCCESS (0.082s)
[159.633571] Starting dynamic subtest: vecs0
[159.701209] Dynamic subtest vecs0: SUCCESS (0.089s)
[159.705561] Subtest pages: SUCCESS (0.361s)
[159.953275] [033/133] (905s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[160.159566] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[160.166437] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[160.303788] [034/133] (904s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[160.530086] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[164.097462] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SUCCESS (3.585s)
[164.301846] [035/133] (900s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[164.502046] Subtest psr2-overlay-plane-move-continuous-sf: SKIP (0.000s)
[164.599687] [036/133] (900s left) kms_dirtyfb (default-dirtyfb-ioctl)
[164.823101] Starting subtest: default-dirtyfb-ioctl
[164.830108] Starting dynamic subtest: A-HDMI-A-1
[166.531951] Dynamic subtest A-HDMI-A-1: SUCCESS (1.706s)
[166.565029] Starting dynamic subtest: A-HDMI-A-2
[168.140394] Dynamic subtest A-HDMI-A-2: SUCCESS (1.605s)
[168.145528] Subtest default-dirtyfb-ioctl: SUCCESS (3.319s)
[168.420659] [037/133] (896s left) syncobj_wait (invalid-signal-illegal-handle)
[168.543831] Starting subtest: invalid-signal-illegal-handle
[168.547140] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[168.682280] [038/133] (896s left) syncobj_wait (wait-all-delayed-signal)
[168.792512] Starting subtest: wait-all-delayed-signal
[168.895177] Subtest wait-all-delayed-signal: SUCCESS (0.106s)
[169.063852] [039/133] (896s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[169.350525] Starting subtest: basic-test-pattern-with-chamelium
[169.358208] Subtest basic-test-pattern-with-chamelium: SKIP (0.001s)
[169.483670] [040/133] (896s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[169.624437] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[169.628234] Starting dynamic subtest: pipe-A-HDMI-A-1
[169.673583] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[169.715365] Starting dynamic subtest: pipe-A-HDMI-A-2
[169.765561] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[169.804260] Starting dynamic subtest: pipe-B-HDMI-A-1
[169.835742] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[169.857606] Starting dynamic subtest: pipe-B-HDMI-A-2
[169.890245] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[169.912115] Starting dynamic subtest: pipe-C-HDMI-A-1
[169.943946] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[169.965933] Starting dynamic subtest: pipe-C-HDMI-A-2
[170.000643] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[170.007501] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.022s)
[170.628420] [041/133] (895s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[170.791486] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[170.798552] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[170.943857] [042/133] (894s left) gem_ctx_param (invalid-get-no-zeromap)
[171.055207] Starting subtest: invalid-get-no-zeromap
[171.058756] Subtest invalid-get-no-zeromap: SUCCESS (0.000s)
[171.193208] [043/133] (894s left) prime_mmap (test_forked)
[171.305315] Starting subtest: test_forked
[171.308538] Starting dynamic subtest: test_forked-smem
[171.339298] Dynamic subtest test_forked-smem: SUCCESS (0.033s)
[171.344129] Subtest test_forked: SUCCESS (0.034s)
[171.475418] [044/133] (894s left) kms_vrr (flip-dpms)
[171.613351] Starting subtest: flip-dpms
[171.627258] Subtest flip-dpms: SKIP (0.000s)
[171.773422] [045/133] (894s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[171.915241] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[171.923876] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[172.073586] [046/133] (894s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[172.588929] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[172.910422] [047/133] (893s left) kms_pwrite_crc
[174.268978] [048/133] (892s left) gem_partial_pwrite_pread (write-display)
[174.393107] Starting subtest: write-display
[188.643330] Subtest write-display: SUCCESS (14.254s)
[188.798090] [049/133] (877s left) dmabuf_sync_file (import-multiple-read-write)
[189.017581] Starting subtest: import-multiple-read-write
[189.028178] Subtest import-multiple-read-write: SUCCESS (0.016s)
[189.152637] [FACT dmabuf_sync_file (import-multiple-read-write)] new: kernel.kmod_is_loaded.vgem: true
[189.159525] [050/133] (877s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[189.292052] Starting subtest: 2x-long-cursor-vs-flip-atomic
[241.656060] Subtest 2x-long-cursor-vs-flip-atomic: SUCCESS (52.365s)
[242.009386] [051/133] (824s left) gem_eio (wait-wedge-1us)
[242.183566] Starting subtest: wait-wedge-1us
[242.364101] Subtest wait-wedge-1us: SUCCESS (0.184s)
[242.558914] [052/133] (824s left) perf (polling)
[242.780075] Starting subtest: polling
[242.789152] Starting dynamic subtest: 0-rcs0
[252.808137] Dynamic subtest 0-rcs0: SUCCESS (10.024s)
[252.812425] Subtest polling: SUCCESS (10.030s)
[252.920568] [053/133] (814s left) kms_frontbuffer_tracking (psr-1p-rte)
[253.078909] Starting subtest: psr-1p-rte
[253.087473] Subtest psr-1p-rte: SKIP (0.000s)
[253.239874] [054/133] (813s left) kms_cursor_edge_walk (256x256-left-edge)
[253.397064] Starting subtest: 256x256-left-edge
[253.403222] Starting dynamic subtest: pipe-A-HDMI-A-1
[257.368762] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.966s)
[257.392875] Starting dynamic subtest: pipe-C-HDMI-A-1
[260.825550] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.450s)
[260.829646] Subtest 256x256-left-edge: SUCCESS (7.428s)
[261.164879] [055/133] (806s left) gem_tiling_max_stride
[261.495766] [056/133] (805s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[261.666143] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[264.561164] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (2.896s)
[264.759795] [057/133] (802s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[264.872210] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[264.974116] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.103s)
[265.125570] [058/133] (802s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[265.277156] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[265.287095] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[265.430373] [059/133] (802s left) kms_joiner (basic-big-joiner)
[265.587269] Starting subtest: basic-big-joiner
[265.594214] Subtest basic-big-joiner: SKIP (0.000s)
[265.763349] [060/133] (801s left) gem_render_copy_redux (flink)
[265.899906] Starting subtest: flink
[268.839660] Subtest flink: SUCCESS (2.943s)
[269.008293] [061/133] (798s left) kms_psr (pr-sprite-blt)
[269.160514] Subtest pr-sprite-blt: SKIP (0.000s)
[269.272374] [062/133] (798s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[269.397142] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[269.401326] Starting dynamic subtest: smem
[269.754224] Dynamic subtest smem: SUCCESS (0.353s)
[269.758521] Subtest y-tiled-ccs-to-yf-tiled-ccs: SUCCESS (0.355s)
[270.010659] [063/133] (797s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[270.168932] Starting subtest: y-tiled-addfb-size-offset-overflow
[270.174077] Subtest y-tiled-addfb-size-offset-overflow: SUCCESS (0.001s)
[270.311270] [064/133] (797s left) i915_suspend (fence-restore-tiled2untiled)
[270.427424] Starting subtest: fence-restore-tiled2untiled
[289.310515] Subtest fence-restore-tiled2untiled: SUCCESS (4.068s)
[296.488953] [065/133] (778s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[296.644368] Starting subtest: primary-4-tiled-reflect-x-0
[296.650993] Subtest primary-4-tiled-reflect-x-0: SKIP (0.003s)
[296.829124] [066/133] (778s left) api_intel_allocator (gem-pool)
[296.941377] Starting subtest: gem-pool
[296.954786] Subtest gem-pool: SUCCESS (0.016s)
[297.131446] [067/133] (778s left) gem_lmem_swapping (parallel-random)
[297.250976] Subtest parallel-random: SKIP (0.000s)
[297.377586] [068/133] (778s left) syncobj_timeline (transfer-timeline-point)
[297.492842] Starting subtest: transfer-timeline-point
[297.496147] Subtest transfer-timeline-point: SUCCESS (0.002s)
[297.647433] [069/133] (778s left) gem_exec_flush (basic-uc-rw-default)
[297.780942] Starting subtest: basic-uc-rw-default
[303.203342] Subtest basic-uc-rw-default: SUCCESS (5.418s)
[303.483143] [070/133] (772s left) gem_exec_flush (basic-wb-set-default)
[303.615050] Starting subtest: basic-wb-set-default
[309.037851] Subtest basic-wb-set-default: SUCCESS (5.425s)
[309.329930] [071/133] (766s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[309.468134] Starting subtest: addfb25-x-tiled-mismatch-legacy
[309.472132] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[309.645552] [072/133] (766s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[309.790844] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[309.799803] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[309.932470] [073/133] (766s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[310.074836] Starting subtest: flip-vs-cursor-toggle
[334.260523] Subtest flip-vs-cursor-toggle: SUCCESS (24.187s)
[334.579954] [074/133] (741s left) kms_atomic_transition (plane-all-modeset-transition)
[334.737767] Starting subtest: plane-all-modeset-transition
[334.741315] Starting dynamic subtest: pipe-A-HDMI-A-1
[379.057489] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (44.325s)
[379.265096] Starting dynamic subtest: pipe-A-HDMI-A-2
[423.250544] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (44.015s)
[423.449053] Starting dynamic subtest: pipe-B-HDMI-A-1
[464.081546] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (40.655s)
[464.267274] Starting dynamic subtest: pipe-B-HDMI-A-2
[504.899286] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (40.656s)
[505.055068] Subtest plane-all-modeset-transition: SUCCESS (170.327s)
[505.359984] [075/133] (570s left) gem_eio (wait-10ms)
[505.507932] Starting subtest: wait-10ms
[505.656511] Subtest wait-10ms: SUCCESS (0.140s)
[505.854166] [076/133] (570s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[506.014288] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[506.021700] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[506.168278] [077/133] (570s left) kms_flip (bo-too-big)
[506.319243] Starting subtest: bo-too-big
[506.322851] Starting dynamic subtest: A-HDMI-A1
[507.433501] Dynamic subtest A-HDMI-A1: SUCCESS (1.113s)
[507.465289] Starting dynamic subtest: B-HDMI-A1
[508.251801] Dynamic subtest B-HDMI-A1: SUCCESS (0.805s)
[508.279437] Starting dynamic subtest: C-HDMI-A1
[509.068871] Dynamic subtest C-HDMI-A1: SUCCESS (0.823s)
[509.099170] Starting dynamic subtest: A-HDMI-A2
[509.917814] Dynamic subtest A-HDMI-A2: SUCCESS (0.840s)
[509.946254] Starting dynamic subtest: B-HDMI-A2
[510.746049] Dynamic subtest B-HDMI-A2: SUCCESS (0.827s)
[510.777311] Starting dynamic subtest: C-HDMI-A2
[511.583833] Dynamic subtest C-HDMI-A2: SUCCESS (0.830s)
[511.590831] Subtest bo-too-big: SUCCESS (5.270s)
[512.132788] [078/133] (564s left) gem_userptr_blits (mmap-offset-banned)
[512.270768] Starting subtest: mmap-offset-banned
[512.274434] Starting dynamic subtest: gtt
[512.278546] Dynamic subtest gtt: SUCCESS (0.001s)
[512.303502] Starting dynamic subtest: wb
[512.306896] Dynamic subtest wb: SUCCESS (0.001s)
[512.332265] Starting dynamic subtest: wc
[512.336184] Dynamic subtest wc: SUCCESS (0.000s)
[512.361296] Starting dynamic subtest: uc
[512.365338] Dynamic subtest uc: SUCCESS (0.000s)
[512.369503] Subtest mmap-offset-banned: SUCCESS (0.015s)
[512.481183] [079/133] (564s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[512.593293] Starting subtest: wait-all-for-submit-delayed-submit
[512.693897] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.105s)
[512.878731] [080/133] (563s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[513.019472] Starting subtest: primary-yf-tiled-reflect-x-0
[513.027857] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.004s)
[513.183131] [081/133] (563s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[513.341886] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[513.458888] [082/133] (563s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[513.616661] Starting subtest: 4-tiled-32bpp-rotate-90
[513.625091] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.000s)
[513.784480] [083/133] (563s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[513.933817] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[513.938976] Starting dynamic subtest: pipe-A-HDMI-A-1
[513.977794] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[514.029155] Starting dynamic subtest: pipe-A-HDMI-A-2
[514.071116] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[514.102542] Starting dynamic subtest: pipe-B-HDMI-A-1
[514.135538] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[514.162335] Starting dynamic subtest: pipe-B-HDMI-A-2
[514.195731] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s)
[514.220655] Starting dynamic subtest: pipe-C-HDMI-A-1
[514.252572] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[514.281121] Starting dynamic subtest: pipe-C-HDMI-A-2
[514.313165] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[514.319415] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.029s)
[515.018303] [084/133] (562s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[515.133340] Starting subtest: etime-multi-wait-for-submit-submitted
[515.238312] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.109s)
[515.414896] [085/133] (561s left) kms_chamelium_color (ctm-0-50)
[515.555834] Subtest ctm-0-50: SKIP (0.000s)
[515.681544] [086/133] (561s left) kms_plane (plane-position-hole-dpms)
[515.827610] Starting subtest: plane-position-hole-dpms
[516.586854] Starting dynamic subtest: pipe-A-plane-1
[517.441394] Dynamic subtest pipe-A-plane-1: SUCCESS (0.854s)
[517.470953] Starting dynamic subtest: pipe-A-plane-2
[518.326502] Dynamic subtest pipe-A-plane-2: SUCCESS (0.882s)
[518.353831] Starting dynamic subtest: pipe-A-plane-3
[519.240874] Dynamic subtest pipe-A-plane-3: SUCCESS (0.909s)
[519.273191] Starting dynamic subtest: pipe-A-plane-4
[519.279962] Dynamic subtest pipe-A-plane-4: SUCCESS (0.008s)
[519.761346] Starting dynamic subtest: pipe-B-plane-1
[520.514104] Dynamic subtest pipe-B-plane-1: SUCCESS (0.801s)
[520.543431] Starting dynamic subtest: pipe-B-plane-2
[521.407941] Dynamic subtest pipe-B-plane-2: SUCCESS (0.893s)
[521.453253] Starting dynamic subtest: pipe-B-plane-3
[522.239409] Dynamic subtest pipe-B-plane-3: SUCCESS (0.826s)
[522.271563] Starting dynamic subtest: pipe-B-plane-4
[522.281257] Dynamic subtest pipe-B-plane-4: SUCCESS (0.011s)
[522.286174] Subtest plane-position-hole-dpms: SUCCESS (6.433s)
[522.697071] [087/133] (554s left) gem_exec_schedule (deep)
[522.965962] Starting subtest: deep
[522.969338] Starting dynamic subtest: rcs0
[536.073863] Dynamic subtest rcs0: SUCCESS (13.067s)
[536.126482] Starting dynamic subtest: bcs0
[550.608833] Dynamic subtest bcs0: SUCCESS (14.552s)
[550.670840] Starting dynamic subtest: vcs0
[564.275578] Dynamic subtest vcs0: SUCCESS (13.649s)
[564.334372] Starting dynamic subtest: vecs0
[578.274066] Dynamic subtest vecs0: SUCCESS (13.993s)
[578.279822] Subtest deep: SUCCESS (55.304s)
[579.318144] [088/133] (498s left) syncobj_basic (bad-create-flags)
[579.421253] Starting subtest: bad-create-flags
[579.425626] Subtest bad-create-flags: SUCCESS (0.000s)
[579.571024] [089/133] (498s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[580.100428] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[580.406414] [090/133] (497s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[580.558824] Starting subtest: map-fixed-invalidate-overlap-busy
[580.565145] Starting dynamic subtest: gtt
[584.468937] Dynamic subtest gtt: SUCCESS (3.910s)
[584.497468] Starting dynamic subtest: wb
[588.183035] Dynamic subtest wb: SUCCESS (3.712s)
[588.217095] Starting dynamic subtest: wc
[591.861533] Dynamic subtest wc: SUCCESS (3.674s)
[591.892108] Starting dynamic subtest: uc
[595.553540] Dynamic subtest uc: SUCCESS (3.688s)
[595.559090] Subtest map-fixed-invalidate-overlap-busy: SUCCESS (14.999s)
[595.750937] [091/133] (482s left) perf_pmu (enable-race)
[595.872875] Starting subtest: enable-race
[595.877126] Starting dynamic subtest: rcs0
[608.505064] Dynamic subtest rcs0: SUCCESS (12.635s)
[608.531169] Starting dynamic subtest: bcs0
[621.171980] Dynamic subtest bcs0: SUCCESS (12.661s)
[621.197325] Starting dynamic subtest: vcs0
[633.802797] Dynamic subtest vcs0: SUCCESS (12.629s)
[633.831119] Starting dynamic subtest: vecs0
[646.435807] Dynamic subtest vecs0: SUCCESS (12.629s)
[646.439523] Subtest enable-race: SUCCESS (50.570s)
[646.598863] [092/133] (431s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[646.735810] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[646.742799] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SKIP (0.000s)
[646.918363] [093/133] (431s left) syncobj_basic (illegal-fd-to-handle)
[647.029429] Starting subtest: illegal-fd-to-handle
[647.033781] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[647.185041] [094/133] (431s left) gem_render_copy (linear-to-vebox-y-tiled)
[647.308056] Starting subtest: linear-to-vebox-y-tiled
[647.315920] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[647.582966] [095/133] (430s left) gem_userptr_blits (dmabuf-sync)
[647.719613] Starting subtest: dmabuf-sync
[647.732977] Subtest dmabuf-sync: SKIP (0.007s)
[647.944117] [096/133] (430s left) kms_vrr (seamless-rr-switch-vrr)
[648.083186] Starting subtest: seamless-rr-switch-vrr
[648.096645] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[648.265180] [097/133] (430s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[648.430612] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[651.030912] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SUCCESS (2.611s)
[651.251080] [098/133] (427s left) gem_ctx_persistence (idempotent)
[651.372328] Starting subtest: idempotent
[651.375849] Subtest idempotent: SUCCESS (0.000s)
[651.539056] [099/133] (427s left) kms_frontbuffer_tracking (fbc-stridechange)
[651.698439] Starting subtest: fbc-stridechange
[653.746847] Subtest fbc-stridechange: SUCCESS (2.050s)
[654.047052] [100/133] (424s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[654.210960] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[654.217421] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[654.370578] [101/133] (424s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[654.534814] Starting subtest: cursor-rapid-movement-256x85
[654.583798] Starting dynamic subtest: pipe-A-HDMI-A-1
[655.504468] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.918s)
[655.627514] Starting dynamic subtest: pipe-C-HDMI-A-1
[656.145899] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.569s)
[656.149919] Subtest cursor-rapid-movement-256x85: SUCCESS (1.614s)
[656.529411] [102/133] (422s left) gem_softpin (allocator-evict)
[656.659878] Starting subtest: allocator-evict
[656.665571] Starting dynamic subtest: rcs0
[684.825544] Dynamic subtest rcs0: SUCCESS (28.168s)
[684.854533] Starting dynamic subtest: bcs0
[711.462806] Dynamic subtest bcs0: SUCCESS (26.632s)
[711.498830] Starting dynamic subtest: vcs0
[737.829959] Dynamic subtest vcs0: SUCCESS (26.366s)
[737.862471] Starting dynamic subtest: vecs0
[764.184851] Dynamic subtest vecs0: SUCCESS (26.347s)
[764.188366] Subtest allocator-evict: SUCCESS (107.532s)
[764.352673] [103/133] (315s left) gem_exec_reloc (basic-wc-active)
[764.608674] Starting subtest: basic-wc-active
[764.749899] Subtest basic-wc-active: SUCCESS (0.141s)
[764.949347] [104/133] (314s left) i915_hangman (error-state-basic)
[765.087974] Starting subtest: error-state-basic
[765.100822] Subtest error-state-basic: SUCCESS (0.013s)
[765.306952] [105/133] (314s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[765.456838] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[765.463889] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[765.631179] [106/133] (314s left) kms_psr (psr2-cursor-mmap-gtt)
[765.776093] Subtest psr2-cursor-mmap-gtt: SKIP (0.000s)
[765.907974] [107/133] (313s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[766.048844] Starting subtest: plane-upscale-20x20-with-pixel-format
[766.056251] Starting dynamic subtest: pipe-A
[767.089859] Dynamic subtest pipe-A: SUCCESS (1.042s)
[767.137201] Starting dynamic subtest: pipe-B
[768.207326] Dynamic subtest pipe-B: SUCCESS (1.114s)
[768.262265] Starting dynamic subtest: pipe-C
[768.635251] Dynamic subtest pipe-C: SUCCESS (0.423s)
[768.639529] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (2.591s)
[769.156509] [108/133] (310s left) gem_wait (invalid-flags)
[769.290957] Starting subtest: invalid-flags
[769.294393] Subtest invalid-flags: SUCCESS (0.001s)
[769.618793] [109/133] (310s left) i915_pm_rpm (gem-execbuf)
[771.478232] Starting subtest: gem-execbuf
[771.482307] Starting dynamic subtest: smem0
[772.817880] Dynamic subtest smem0: SUCCESS (1.342s)
[772.821384] Subtest gem-execbuf: SUCCESS (1.347s)
[773.179827] [110/133] (306s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[773.368557] Starting subtest: nonblocking-crc-frame-sequence
[773.384833] Starting dynamic subtest: pipe-A-HDMI-A-1
[774.430175] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.049s)
[774.460793] Starting dynamic subtest: pipe-B-HDMI-A-2
[775.157378] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.724s)
[775.212206] Starting dynamic subtest: pipe-C-HDMI-A-1
[775.886500] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.717s)
[775.891322] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.513s)
[776.216259] [111/133] (304s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[776.394126] Starting subtest: fbcpsr-tiling-4
[776.401835] Subtest fbcpsr-tiling-4: SKIP (0.000s)
[776.549420] [112/133] (303s left) kms_pm_dc (dc6-dpms)
[777.702550] Starting subtest: dc6-dpms
[777.713224] Subtest dc6-dpms: SKIP (0.000s)
[777.864332] [113/133] (302s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[778.005832] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[778.019469] Starting dynamic subtest: pipe-A-HDMI-A-1
[778.035848] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[778.091858] Starting dynamic subtest: pipe-A-HDMI-A-2
[778.112213] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.002s)
[778.165220] Starting dynamic subtest: pipe-B-HDMI-A-1
[778.184889] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[778.229789] Starting dynamic subtest: pipe-B-HDMI-A-2
[778.242400] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[778.270075] Starting dynamic subtest: pipe-C-HDMI-A-1
[778.282637] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[778.311410] Starting dynamic subtest: pipe-C-HDMI-A-2
[778.324257] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[778.330674] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SKIP (0.051s)
[779.129833] [114/133] (301s left) gem_exec_parallel (contexts)
[779.264824] Starting subtest: contexts
[779.268261] Starting dynamic subtest: rcs0
[783.569998] Dynamic subtest rcs0: SUCCESS (4.300s)
[783.599579] Starting dynamic subtest: bcs0
[788.261839] Dynamic subtest bcs0: SUCCESS (4.687s)
[788.290718] Starting dynamic subtest: vcs0
[792.819565] Dynamic subtest vcs0: SUCCESS (4.555s)
[792.853792] Starting dynamic subtest: vecs0
[797.237806] Dynamic subtest vecs0: SUCCESS (4.414s)
[797.241492] Subtest contexts: SUCCESS (17.975s)
[797.518440] [115/133] (283s left) kms_atomic (crtc-invalid-params-fence)
[797.672096] Starting subtest: crtc-invalid-params-fence
[797.676840] Starting dynamic subtest: pipe-A-HDMI-A-1
[798.365237] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.686s)
[798.374326] Subtest crtc-invalid-params-fence: SUCCESS (0.694s)
[798.730332] [116/133] (282s left) kms_frontbuffer_tracking (fbc-suspend)
[798.898979] Starting subtest: fbc-suspend