[59.401863] Initializing watchdogs
[59.401910]   /dev/watchdog0
[59.415733] [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]
[59.420130] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.422670] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.426334] [001/132] (960s left) perf_pmu (most-busy-check-all)
[59.494511] Starting subtest: most-busy-check-all
[59.496969] Starting dynamic subtest: rcs0
[60.886032] Dynamic subtest rcs0: SUCCESS (1.394s)
[60.896973] Starting dynamic subtest: bcs0
[62.869967] Dynamic subtest bcs0: SUCCESS (1.988s)
[62.881043] Starting dynamic subtest: vcs0
[64.916726] Dynamic subtest vcs0: SUCCESS (2.050s)
[64.927651] Starting dynamic subtest: vcs1
[66.902574] Dynamic subtest vcs1: SUCCESS (1.987s)
[66.914429] Starting dynamic subtest: vecs0
[68.884454] Dynamic subtest vecs0: SUCCESS (1.984s)
[68.893679] Starting dynamic subtest: ccs0
[70.933413] Dynamic subtest ccs0: SUCCESS (2.050s)
[70.936339] Subtest most-busy-check-all: SUCCESS (11.460s)
[71.046988] [002/132] (948s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[71.152640] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[71.157483] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[71.263488] [003/132] (948s left) kms_psr (pr-sprite-mmap-gtt)
[71.360355] Starting subtest: pr-sprite-mmap-gtt
[71.364908] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[71.431292] [004/132] (948s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[71.525409] Starting subtest: plane-lut1d-pre-ctm3x4
[71.683721] Starting dynamic subtest: pipe-A-plane-0
[71.860470] Dynamic subtest pipe-A-plane-0: SUCCESS (0.177s)
[71.868774] Starting dynamic subtest: pipe-A-plane-1
[72.024211] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[72.033450] Starting dynamic subtest: pipe-A-plane-2
[72.158048] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s)
[73.317586] Starting dynamic subtest: pipe-B-plane-0
[73.454841] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s)
[73.463997] Starting dynamic subtest: pipe-B-plane-1
[73.588595] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s)
[73.597585] Starting dynamic subtest: pipe-B-plane-2
[73.721386] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s)
[74.977880] Starting dynamic subtest: pipe-C-plane-0
[75.103127] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[75.112246] Starting dynamic subtest: pipe-C-plane-1
[75.236575] Dynamic subtest pipe-C-plane-1: SUCCESS (0.133s)
[75.245118] Starting dynamic subtest: pipe-C-plane-2
[75.402568] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[76.580679] Starting dynamic subtest: pipe-D-plane-0
[76.727887] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[76.735576] Starting dynamic subtest: pipe-D-plane-1
[76.883725] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[76.897094] Starting dynamic subtest: pipe-D-plane-2
[77.027627] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[77.313476] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (5.794s)
[78.153538] [005/132] (941s left) kms_flip (modeset-vs-vblank-race-interruptible)
[78.252888] Starting subtest: modeset-vs-vblank-race-interruptible
[78.255405] Starting dynamic subtest: A-eDP1
[82.969345] Dynamic subtest A-eDP1: SUCCESS (4.716s)
[82.981292] Starting dynamic subtest: B-eDP1
[87.609649] Dynamic subtest B-eDP1: SUCCESS (4.638s)
[87.620342] Starting dynamic subtest: C-eDP1
[92.165522] Dynamic subtest C-eDP1: SUCCESS (4.554s)
[92.175418] Starting dynamic subtest: D-eDP1
[96.706430] Dynamic subtest D-eDP1: SUCCESS (4.540s)
[96.708918] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.456s)
[97.873914] [006/132] (922s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[97.983863] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[97.988197] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[98.072630] [007/132] (922s left) kms_getfb (getfb-reject-nv12)
[98.158214] Starting subtest: getfb-reject-nv12
[98.160142] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[98.271276] [008/132] (921s left) gem_mmap_gtt (cpuset-medium-copy)
[98.322783] Subtest cpuset-medium-copy: SKIP (0.000s)
[98.382698] [009/132] (921s left) syncobj_timeline (wait-all-interrupted)
[98.433866] Starting subtest: wait-all-interrupted
[98.539993] Subtest wait-all-interrupted: SUCCESS (0.103s)
[98.610315] [010/132] (921s left) gem_mmap_gtt (basic-copy)
[98.675240] Subtest basic-copy: SKIP (0.000s)
[98.731414] [011/132] (921s left) kms_cursor_crc (cursor-onscreen-32x32)
[98.873639] Starting subtest: cursor-onscreen-32x32
[98.920638] Subtest cursor-onscreen-32x32: SKIP (0.041s)
[99.215245] [012/132] (921s left) gem_eio (throttle)
[99.433551] Starting subtest: throttle
[99.732272] Subtest throttle: SUCCESS (0.299s)
[99.859390] [013/132] (920s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[99.950858] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[99.952901] Starting dynamic subtest: pipe-A-eDP-1
[100.395496] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.421s)
[100.403546] Starting dynamic subtest: pipe-B-eDP-1
[101.843529] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.439s)
[101.853744] Starting dynamic subtest: pipe-C-eDP-1
[103.206385] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.363s)
[103.216217] Starting dynamic subtest: pipe-D-eDP-1
[104.532705] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.325s)
[104.534963] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.552s)
[105.724255] [014/132] (914s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[105.823361] Starting subtest: fbc-psr2-sprite-mmap-gtt
[105.825686] Starting dynamic subtest: eDP-1
[105.830153] Dynamic subtest eDP-1: SKIP (0.000s)
[105.834451] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[105.903616] [015/132] (914s left) gem_ctx_shared (q-out-order)
[105.960397] Starting subtest: Q-out-order
[105.962679] Starting dynamic subtest: rcs0
[106.095076] Dynamic subtest rcs0: SUCCESS (0.133s)
[106.110135] Starting dynamic subtest: vcs0
[106.176209] Dynamic subtest vcs0: SUCCESS (0.081s)
[106.191631] Starting dynamic subtest: vcs1
[106.250996] Dynamic subtest vcs1: SUCCESS (0.074s)
[106.265992] Starting dynamic subtest: vecs0
[106.325352] Dynamic subtest vecs0: SUCCESS (0.074s)
[106.338510] Starting dynamic subtest: ccs0
[106.414906] Dynamic subtest ccs0: SUCCESS (0.089s)
[106.417854] Subtest Q-out-order: SUCCESS (0.454s)
[108.023961] [FACT gem_ctx_shared (q-out-order)] new: kernel.kmod_is_loaded.vgem: true
[108.027141] [016/132] (912s left) kms_plane_multiple (tiling-4)
[108.120520] Starting subtest: tiling-4
[108.123020] Starting dynamic subtest: pipe-A-eDP-1
[111.870788] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.751s)
[111.879115] Starting dynamic subtest: pipe-B-eDP-1
[116.238069] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.367s)
[116.247194] Starting dynamic subtest: pipe-C-eDP-1
[120.567784] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.329s)
[120.579643] Starting dynamic subtest: pipe-D-eDP-1
[124.901205] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.330s)
[124.903533] Subtest tiling-4: SUCCESS (16.782s)
[125.720082] [017/132] (894s left) i915_pm_rc6_residency (rc6-accuracy)
[125.775616] Starting subtest: rc6-accuracy
[125.777864] Starting dynamic subtest: gt0
[128.947833] Dynamic subtest gt0: SUCCESS (3.169s)
[128.958392] Starting dynamic subtest: gt1
[132.119885] Dynamic subtest gt1: SUCCESS (3.168s)
[132.122562] Subtest rc6-accuracy: SUCCESS (6.343s)
[132.207716] [018/132] (888s left) kms_flip (absolute-wf_vblank)
[132.313269] Starting subtest: absolute-wf_vblank
[132.315580] Starting dynamic subtest: A-eDP1
[141.059294] Dynamic subtest A-eDP1: SUCCESS (8.748s)
[141.070760] Starting dynamic subtest: B-eDP1
[149.791534] Dynamic subtest B-eDP1: SUCCESS (8.731s)
[149.802903] Starting dynamic subtest: C-eDP1
[158.517960] Dynamic subtest C-eDP1: SUCCESS (8.723s)
[158.527750] Starting dynamic subtest: D-eDP1
[167.242311] Dynamic subtest D-eDP1: SUCCESS (8.725s)
[167.244640] Subtest absolute-wf_vblank: SUCCESS (34.934s)
[168.442338] [019/132] (852s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[168.535430] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[168.537741] Starting dynamic subtest: pipe-A-eDP-1
[168.561195] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[168.571929] Starting dynamic subtest: pipe-B-eDP-1
[168.593332] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[168.601179] Starting dynamic subtest: pipe-C-eDP-1
[168.622752] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[168.630725] Starting dynamic subtest: pipe-D-eDP-1
[168.652510] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[168.656570] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.005s)
[170.813103] [020/132] (849s left) api_intel_allocator (reopen-fork)
[170.875467] Starting subtest: reopen-fork
[174.202495] Subtest reopen-fork: SUCCESS (3.328s)
[174.278339] [021/132] (846s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[174.404781] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[175.427691] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.023s)
[175.538503] [022/132] (845s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[175.617257] Subtest untiled-to-tiled: SKIP (0.000s)
[175.689124] [023/132] (845s left) i915_hangman (gt-error-state-capture)
[175.762085] Starting subtest: gt-error-state-capture
[175.763659] Starting dynamic subtest: rcs0
[186.867316] Dynamic subtest rcs0: SUCCESS (11.103s)
[186.878506] Starting dynamic subtest: bcs0
[198.899357] Dynamic subtest bcs0: SUCCESS (12.029s)
[198.910955] Starting dynamic subtest: vcs0
[210.803601] Dynamic subtest vcs0: SUCCESS (11.901s)
[210.815563] Starting dynamic subtest: vcs1
[221.810331] Dynamic subtest vcs1: SUCCESS (11.004s)
[221.821215] Starting dynamic subtest: vecs0
[232.819231] Dynamic subtest vecs0: SUCCESS (11.006s)
[232.830454] Starting dynamic subtest: ccs0
[243.891805] Dynamic subtest ccs0: SUCCESS (11.069s)
[243.894686] Subtest gt-error-state-capture: SUCCESS (68.128s)
[243.980963] [024/132] (776s left) gem_pxp (display-protected-crc)
[244.102057] Starting subtest: display-protected-crc
[245.747384] Subtest display-protected-crc: SUCCESS (1.647s)
[245.862692] [025/132] (775s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[245.966908] Starting subtest: 4-tiled-8bpp-rotate-90
[245.988814] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.022s)
[246.091339] [026/132] (774s left) perf (polling-parameterized)
[246.209026] Starting subtest: polling-parameterized
[266.230843] Subtest polling-parameterized: SUCCESS (20.021s)
[266.279120] [027/132] (754s left) kms_rmfb (rmfb-ioctl)
[266.383565] Starting subtest: rmfb-ioctl
[266.385713] Starting dynamic subtest: pipe-A-eDP-1
[266.491933] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.108s)
[266.504397] Starting dynamic subtest: pipe-B-eDP-1
[267.672172] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.178s)
[267.682118] Starting dynamic subtest: pipe-C-eDP-1
[268.792572] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.119s)
[268.800808] Starting dynamic subtest: pipe-D-eDP-1
[269.927750] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.134s)
[269.930083] Subtest rmfb-ioctl: SUCCESS (3.546s)
[271.137301] [028/132] (749s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[271.191322] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[271.297428] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.105s)
[271.371969] [029/132] (749s left) kms_flip (wf_vblank-ts-check)
[271.456284] Starting subtest: wf_vblank-ts-check
[271.458539] Starting dynamic subtest: A-eDP1
[280.379863] Dynamic subtest A-eDP1: SUCCESS (8.925s)
[280.393305] Starting dynamic subtest: B-eDP1
[289.316075] Dynamic subtest B-eDP1: SUCCESS (8.933s)
[289.329628] Starting dynamic subtest: C-eDP1
[298.241102] Dynamic subtest C-eDP1: SUCCESS (8.921s)
[298.250982] Starting dynamic subtest: D-eDP1
[307.176378] Dynamic subtest D-eDP1: SUCCESS (8.930s)
[307.178881] Subtest wf_vblank-ts-check: SUCCESS (35.723s)
[308.409916] [030/132] (712s left) kms_frontbuffer_tracking (psr-2p-rte)
[308.513860] Starting subtest: psr-2p-rte
[308.518123] Subtest psr-2p-rte: SKIP (0.000s)
[308.620509] [031/132] (712s left) kms_content_protection (atomic-hdcp14)
[308.760998] Starting subtest: atomic-hdcp14
[308.765646] Subtest atomic-hdcp14: SKIP (0.000s)
[308.868577] [032/132] (712s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[308.965140] Starting subtest: psr-dirtyfb-ioctl
[308.967398] Starting dynamic subtest: A-eDP-1
[312.905982] Dynamic subtest A-eDP-1: SUCCESS (3.941s)
[312.908478] Subtest psr-dirtyfb-ioctl: SUCCESS (3.943s)
[313.710629] [033/132] (707s left) kms_pipe_crc_basic (suspend-read-crc)
[313.810978] Starting subtest: suspend-read-crc
[313.813149] Starting dynamic subtest: pipe-A-eDP-1
[331.391998] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.760s)
[331.402233] Starting dynamic subtest: pipe-B-eDP-1
[349.390341] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.226s)
[349.400698] Starting dynamic subtest: pipe-C-eDP-1
[367.342284] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.090s)
[367.353794] Starting dynamic subtest: pipe-D-eDP-1
[385.319127] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.038s)
[385.321264] Subtest suspend-read-crc: SUCCESS (12.120s)
[386.147626] [034/132] (635s left) gen9_exec_parse (bb-secure)
[386.204207] Subtest bb-secure: SKIP (0.000s)
[386.269134] [035/132] (635s left) gem_userptr_blits (invalid-null-pointer)
[386.325644] Starting subtest: invalid-null-pointer
[386.327470] Subtest invalid-null-pointer: SUCCESS (0.001s)
[386.450676] [036/132] (634s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[386.547953] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[386.551957] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[386.637835] [037/132] (634s left) gem_exec_reloc (basic-write-wc-noreloc)
[386.691259] Subtest basic-write-wc-noreloc: SKIP (0.000s)
[386.758854] [038/132] (634s left) sw_sync (sync_multi_consumer)
[386.804280] Starting subtest: sync_multi_consumer
[387.227467] Subtest sync_multi_consumer: SUCCESS (0.433s)
[387.286382] [039/132] (634s left) gem_userptr_blits (userfault)
[387.347071] Starting subtest: userfault
[387.349097] Subtest userfault: SUCCESS (0.006s)
[387.480503] [040/132] (634s left) gem_exec_reloc (basic-cpu)
[387.542732] Subtest basic-cpu: SKIP (0.000s)
[387.615578] [041/132] (633s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[387.686107] Starting subtest: x-tiled-to-vebox-yf-tiled
[387.690206] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[387.865825] [042/132] (633s left) gem_exec_reloc (basic-wc-active)
[387.919609] Subtest basic-wc-active: SKIP (0.000s)
[387.987188] [043/132] (633s left) gem_exec_balancer (full-pulse)
[388.041041] Starting subtest: full-pulse
[392.284212] Subtest full-pulse: SUCCESS (4.281s)
[392.641692] [044/132] (629s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[392.736443] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[392.740585] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[392.864389] [045/132] (628s left) perf (unprivileged-single-ctx-counters)
[393.006516] Starting subtest: unprivileged-single-ctx-counters
[393.011519] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[393.054795] [046/132] (628s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[393.165329] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[400.176679] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.043s)
[400.288983] [047/132] (621s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[400.405114] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[400.409498] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[400.499179] [048/132] (621s left) gem_exec_reloc (basic-wc-gtt-active)
[400.555645] Subtest basic-wc-gtt-active: SKIP (0.000s)
[400.620054] [049/132] (621s left) gem_close (basic)
[400.669295] Starting subtest: basic
[400.671630] Subtest basic: SUCCESS (0.000s)
[400.761394] [050/132] (621s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[400.867368] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[401.633916] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.770s)
[401.786693] [051/132] (620s left) kms_atomic_interruptible (legacy-dpms)
[401.891733] Starting subtest: legacy-dpms
[401.894065] Starting dynamic subtest: pipe-A-eDP-1
[409.289670] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.410s)
[409.292074] Subtest legacy-dpms: SUCCESS (7.411s)
[410.127360] [052/132] (611s left) gem_exec_reloc (basic-wc)
[410.199471] Subtest basic-wc: SKIP (0.000s)
[410.278822] [053/132] (611s left) gem_exec_fence (basic-busy-all)
[410.339267] Starting subtest: basic-busy-all
[410.418315] Subtest basic-busy-all: SUCCESS (0.080s)
[412.470458] [054/132] (609s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[412.574329] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[412.578810] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[412.680372] [055/132] (609s left) kms_vblank (query-idle-hang)
[412.777049] Starting subtest: query-idle-hang
[412.779008] Starting dynamic subtest: pipe-A-eDP-1
[439.200370] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.421s)
[439.215748] Starting dynamic subtest: pipe-D-eDP-1
[464.223901] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.025s)
[464.225798] Subtest query-idle-hang: SUCCESS (51.451s)
[465.060999] [056/132] (557s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[465.165546] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[465.225728] [057/132] (557s left) i915_drm_fdinfo (busy-idle-check-all)
[465.268508] Starting subtest: busy-idle-check-all
[465.270783] Starting dynamic subtest: rcs0
[465.275419] Dynamic subtest rcs0: SKIP (0.005s)
[465.284899] Starting dynamic subtest: bcs0
[465.289012] Dynamic subtest bcs0: SKIP (0.000s)
[465.300593] Starting dynamic subtest: vcs0
[465.304904] Dynamic subtest vcs0: SKIP (0.000s)
[465.313671] Starting dynamic subtest: vcs1
[465.317927] Dynamic subtest vcs1: SKIP (0.000s)
[465.326900] Starting dynamic subtest: vecs0
[465.330965] Dynamic subtest vecs0: SKIP (0.000s)
[465.339650] Starting dynamic subtest: ccs0
[465.343707] Dynamic subtest ccs0: SKIP (0.000s)
[465.347787] Subtest busy-idle-check-all: SKIP (0.010s)
[465.386038] [058/132] (556s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[465.516158] Starting subtest: psr-shrfb-scaledprimary
[471.260901] Subtest psr-shrfb-scaledprimary: SUCCESS (5.750s)
[471.375369] [059/132] (550s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite)
[471.476264] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite
[478.565444] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (7.095s)
[479.706580] [060/132] (542s left) kms_psr (fbc-pr-sprite-blt)
[479.810760] Starting subtest: fbc-pr-sprite-blt
[479.815045] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[479.882819] [061/132] (542s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[479.931460] Starting subtest: invalid-signal-one-illegal-handle
[479.933794] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[480.015531] [062/132] (542s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[480.110272] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[480.114361] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[480.208069] [063/132] (542s left) gem_ctx_persistence (engines-hostile-preempt)
[480.262290] Starting subtest: engines-hostile-preempt
[480.264441] Starting dynamic subtest: rcs0
[480.322860] Dynamic subtest rcs0: SUCCESS (0.060s)
[480.335342] Starting dynamic subtest: bcs0
[480.375561] Dynamic subtest bcs0: SUCCESS (0.050s)
[480.387308] Starting dynamic subtest: vcs0
[482.462868] Dynamic subtest vcs0: SUCCESS (2.083s)
[482.474502] Starting dynamic subtest: vcs1
[484.446076] Dynamic subtest vcs1: SUCCESS (1.979s)
[484.457683] Starting dynamic subtest: vecs0
[486.411523] Dynamic subtest vecs0: SUCCESS (1.962s)
[486.424063] Starting dynamic subtest: ccs0
[486.492975] Dynamic subtest ccs0: SUCCESS (0.080s)
[486.495944] Subtest engines-hostile-preempt: SUCCESS (6.228s)
[486.589505] [064/132] (535s left) i915_query (query-topology-known-pci-ids)
[486.647671] Starting subtest: query-topology-known-pci-ids
[486.652136] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[486.747443] [065/132] (535s left) gem_userptr_blits (coherency-sync)
[486.830679] Starting subtest: coherency-sync
[487.413672] Subtest coherency-sync: SKIP (0.544s)
[487.523089] [066/132] (535s left) kms_psr (psr2-sprite-plane-move)
[487.663643] Starting subtest: psr2-sprite-plane-move
[487.665947] Starting dynamic subtest: eDP-1
[489.421187] Dynamic subtest eDP-1: SUCCESS (1.755s)
[489.423410] Subtest psr2-sprite-plane-move: SUCCESS (1.756s)
[490.261426] [067/132] (532s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[490.368141] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[490.370784] Starting dynamic subtest: pipe-A-eDP-1
[490.394688] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[490.404322] Starting dynamic subtest: pipe-B-eDP-1
[490.425676] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[490.434762] Starting dynamic subtest: pipe-C-eDP-1
[490.456095] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[490.465461] Starting dynamic subtest: pipe-D-eDP-1
[490.488469] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[490.492535] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[492.618619] [068/132] (530s left) kms_plane (plane-position-hole)
[492.712880] Starting subtest: plane-position-hole
[493.238253] Starting dynamic subtest: pipe-A-plane-1
[494.540685] Dynamic subtest pipe-A-plane-1: SUCCESS (1.303s)
[494.550936] Starting dynamic subtest: pipe-A-plane-2
[495.824385] Dynamic subtest pipe-A-plane-2: SUCCESS (1.284s)
[495.835364] Starting dynamic subtest: pipe-A-plane-3
[497.128799] Dynamic subtest pipe-A-plane-3: SUCCESS (1.303s)
[497.139926] Starting dynamic subtest: pipe-A-plane-4
[498.384393] Dynamic subtest pipe-A-plane-4: SUCCESS (1.255s)
[498.396168] Starting dynamic subtest: pipe-A-plane-5
[498.411316] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[499.540557] Starting dynamic subtest: pipe-B-plane-1
[500.765050] Dynamic subtest pipe-B-plane-1: SUCCESS (1.232s)
[500.775851] Starting dynamic subtest: pipe-B-plane-2
[501.986910] Dynamic subtest pipe-B-plane-2: SUCCESS (1.221s)
[501.999382] Starting dynamic subtest: pipe-B-plane-3
[503.283263] Dynamic subtest pipe-B-plane-3: SUCCESS (1.295s)
[503.294041] Starting dynamic subtest: pipe-B-plane-4
[504.573051] Dynamic subtest pipe-B-plane-4: SUCCESS (1.291s)
[504.583728] Starting dynamic subtest: pipe-B-plane-5
[504.600295] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[504.602237] Subtest plane-position-hole: SUCCESS (11.883s)
[505.448908] [069/132] (517s left) gem_exec_schedule (preempt-engines)
[505.536580] Starting subtest: preempt-engines
[505.538987] Starting dynamic subtest: rcs0
[507.853458] Dynamic subtest rcs0: SUCCESS (2.316s)
[507.871352] Starting dynamic subtest: bcs0
[510.115423] Dynamic subtest bcs0: SUCCESS (2.259s)
[510.130155] Starting dynamic subtest: vcs0
[512.383485] Dynamic subtest vcs0: SUCCESS (2.265s)
[512.396672] Starting dynamic subtest: vcs1
[514.685686] Dynamic subtest vcs1: SUCCESS (2.299s)
[514.698489] Starting dynamic subtest: vecs0
[516.961034] Dynamic subtest vecs0: SUCCESS (2.273s)
[516.975180] Starting dynamic subtest: ccs0
[519.255818] Dynamic subtest ccs0: SUCCESS (2.293s)
[519.258633] Subtest preempt-engines: SUCCESS (13.719s)
[519.627279] [070/132] (503s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[519.728726] Starting subtest: random-ccs-data-y-tiled-ccs
[519.730965] Starting dynamic subtest: pipe-A-eDP-1
[519.755847] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[519.766466] Starting dynamic subtest: pipe-B-eDP-1
[519.790341] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[519.799508] Starting dynamic subtest: pipe-C-eDP-1
[519.823113] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[519.832194] Starting dynamic subtest: pipe-D-eDP-1
[519.856937] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[519.861376] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.004s)
[522.038568] [071/132] (500s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[522.135146] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[530.125960] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (7.993s)
[530.261680] [072/132] (492s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[530.354895] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[530.357257] Starting dynamic subtest: pipe-A-eDP-1
[530.377892] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[530.391780] Starting dynamic subtest: pipe-B-eDP-1
[530.411576] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[530.420874] Starting dynamic subtest: pipe-C-eDP-1
[530.440165] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[530.449400] Starting dynamic subtest: pipe-D-eDP-1
[530.468751] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[530.470968] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[532.686753] [073/132] (490s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[532.778728] Starting subtest: plane-all-modeset-transition-internal-panels
[532.780637] Starting dynamic subtest: pipe-A-eDP-1
[534.124642] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.346s)
[534.401624] Starting dynamic subtest: pipe-B-eDP-1
[535.441947] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.049s)
[535.711020] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.934s)
[536.553796] [074/132] (486s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[536.640171] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[536.642106] Starting dynamic subtest: pipe-A-eDP-1
[538.732550] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.094s)
[538.742324] Starting dynamic subtest: pipe-B-eDP-1
[540.877098] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.143s)
[540.886769] Starting dynamic subtest: pipe-C-eDP-1
[542.930529] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.053s)
[542.940747] Starting dynamic subtest: pipe-D-eDP-1
[545.001873] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.071s)
[545.003828] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.367s)
[546.186205] [075/132] (476s left) kms_lease (lease-invalid-crtc)
[546.289561] Starting subtest: lease-invalid-crtc
[546.291765] Starting dynamic subtest: pipe-A-eDP-1
[546.294004] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[546.303979] Starting dynamic subtest: pipe-B-eDP-1
[546.306183] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[546.315508] Starting dynamic subtest: pipe-C-eDP-1
[546.317845] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[546.327710] Starting dynamic subtest: pipe-D-eDP-1
[546.329882] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[546.332085] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[546.373530] [076/132] (476s left) gem_exec_whisper (basic-queues-priority)
[546.431646] Starting subtest: basic-queues-priority
[569.722180] Subtest basic-queues-priority: SUCCESS (23.291s)
[569.907765] [077/132] (453s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[569.995663] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[569.999702] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[570.067422] [078/132] (453s left) kms_flip (nonexisting-fb-interruptible)
[570.165012] Starting subtest: nonexisting-fb-interruptible
[570.167416] Starting dynamic subtest: A-eDP1
[571.361784] Dynamic subtest A-eDP1: SUCCESS (1.197s)
[571.371905] Starting dynamic subtest: B-eDP1
[572.494876] Dynamic subtest B-eDP1: SUCCESS (1.131s)
[572.504959] Starting dynamic subtest: C-eDP1
[573.623041] Dynamic subtest C-eDP1: SUCCESS (1.127s)
[573.634791] Starting dynamic subtest: D-eDP1
[574.743954] Dynamic subtest D-eDP1: SUCCESS (1.120s)
[574.746256] Subtest nonexisting-fb-interruptible: SUCCESS (4.584s)
[575.920946] [079/132] (447s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[576.025773] Starting subtest: fbc-rgb565-draw-mmap-wc
[580.042688] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (4.020s)
[581.250948] [080/132] (441s left) kms_pm_rpm (dpms-lpsp)
[582.777627] Starting subtest: dpms-lpsp
[583.409404] Subtest dpms-lpsp: SUCCESS (0.632s)
[583.530874] [081/132] (439s left) gem_fence_thrash (bo-write-verify-threaded-none)
[583.566479] Starting subtest: bo-write-verify-threaded-none
[583.584890] Subtest bo-write-verify-threaded-none: SKIP (0.016s)
[583.657712] [082/132] (439s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[583.756547] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[588.262083] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.513s)
[589.460248] [083/132] (433s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[589.549784] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[589.552109] Starting dynamic subtest: pipe-A
[589.570275] Dynamic subtest pipe-A: SKIP (0.016s)
[589.581445] Starting dynamic subtest: pipe-B
[589.597210] Dynamic subtest pipe-B: SKIP (0.028s)
[589.607681] Starting dynamic subtest: pipe-C
[589.625972] Dynamic subtest pipe-C: SKIP (0.028s)
[589.636178] Starting dynamic subtest: pipe-D
[589.654441] Dynamic subtest pipe-D: SKIP (0.028s)
[589.659400] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.103s)
[589.778475] [084/132] (433s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[589.875311] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[589.879705] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[589.957481] [085/132] (433s left) gem_spin_batch (spin-all-new)
[590.008520] Starting subtest: spin-all-new
[590.023582] Subtest spin-all-new: SUCCESS (0.014s)
[591.504941] [086/132] (431s left) kms_atomic_transition (plane-all-transition-nonblocking)
[591.594303] Starting subtest: plane-all-transition-nonblocking
[591.596736] Starting dynamic subtest: pipe-A-eDP-1
[594.085271] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.494s)
[594.397995] Starting dynamic subtest: pipe-B-eDP-1
[597.596765] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.210s)
[597.896369] Subtest plane-all-transition-nonblocking: SUCCESS (6.303s)
[598.737134] [087/132] (424s left) kms_vrr (seamless-rr-switch-vrr)
[598.835648] Starting subtest: seamless-rr-switch-vrr
[598.841826] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[598.935129] [088/132] (424s left) gem_exec_schedule (preempt-user)
[599.005695] Starting subtest: preempt-user
[599.007672] Starting dynamic subtest: rcs0
[599.023102] Dynamic subtest rcs0: SUCCESS (0.026s)
[599.034046] Starting dynamic subtest: bcs0
[599.041311] Dynamic subtest bcs0: SUCCESS (0.018s)
[599.051766] Starting dynamic subtest: vcs0
[599.064054] Dynamic subtest vcs0: SUCCESS (0.022s)
[599.074539] Starting dynamic subtest: vcs1
[599.085935] Dynamic subtest vcs1: SUCCESS (0.021s)
[599.096429] Starting dynamic subtest: vecs0
[599.108275] Dynamic subtest vecs0: SUCCESS (0.022s)
[599.118947] Starting dynamic subtest: ccs0
[599.129788] Dynamic subtest ccs0: SUCCESS (0.021s)
[599.132094] Subtest preempt-user: SUCCESS (0.133s)
[600.499183] [089/132] (423s left) kms_pm_rpm (pm-tiling)
[602.651421] Starting subtest: pm-tiling
[602.656687] Subtest pm-tiling: SKIP (0.000s)
[603.021212] [090/132] (420s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[603.124516] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[603.128994] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[603.218817] [091/132] (420s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[603.479334] Starting subtest: cursor-rapid-movement-256x256
[603.484642] Starting dynamic subtest: pipe-A-eDP-1
[604.032120] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.545s)
[604.065041] Starting dynamic subtest: pipe-D-eDP-1
[605.245248] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.187s)
[605.247180] Subtest cursor-rapid-movement-256x256: SUCCESS (1.765s)
[606.092769] [092/132] (417s left) gem_exec_reloc (basic-cpu-gtt)
[606.145271] Subtest basic-cpu-gtt: SKIP (0.000s)
[606.218983] [093/132] (417s left) api_intel_bb (object-reloc-keep-cache)
[606.266656] Starting subtest: object-reloc-keep-cache
[606.273939] Subtest object-reloc-keep-cache: SKIP (0.004s)
[606.395332] [094/132] (417s left) kms_invalid_mode (zero-vdisplay)
[606.498588] Starting subtest: zero-vdisplay
[606.500790] Starting dynamic subtest: pipe-A-eDP-1
[606.786635] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[606.797949] Starting dynamic subtest: pipe-B-eDP-1
[606.800284] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[606.810213] Starting dynamic subtest: pipe-C-eDP-1
[606.812124] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[606.821429] Starting dynamic subtest: pipe-D-eDP-1
[606.825135] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[606.827560] Subtest zero-vdisplay: SUCCESS (0.293s)
[607.612662] [095/132] (416s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[607.710652] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[607.712965] Starting dynamic subtest: pipe-A-eDP-1
[607.796260] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[607.807468] Starting dynamic subtest: pipe-B-eDP-1
[608.991566] Dynamic subtest pipe-B-eDP-1: SKIP (1.193s)
[608.996334] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.284s)
[610.182408] [096/132] (413s left) syncobj_basic (bad-handle-to-fd)
[610.235940] Starting subtest: bad-handle-to-fd
[610.237909] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[610.322042] [097/132] (413s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[610.375655] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[610.377837] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[610.493307] [098/132] (413s left) kms_addfb_basic (bad-pitch-0)
[610.558802] Starting subtest: bad-pitch-0
[610.560681] Subtest bad-pitch-0: SUCCESS (0.000s)
[610.702157] [099/132] (413s left) i915_pm_rps (thresholds)
[610.773759] Starting subtest: thresholds
[610.778169] Subtest thresholds: SKIP (0.000s)
[610.872369] [100/132] (413s left) gem_tiled_partial_pwrite_pread (reads)
[610.932641] Subtest reads: SKIP (0.000s)
[611.009477] [101/132] (413s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[611.108398] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[611.110758] Starting dynamic subtest: pipe-A-eDP-1
[616.932577] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.824s)
[616.944186] Starting dynamic subtest: pipe-B-eDP-1
[623.599008] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.664s)
[623.601372] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.491s)
[624.492016] [102/132] (399s left) gem_exec_suspend (basic-s0)
[624.565964] Starting subtest: basic-S0
[624.568354] Starting dynamic subtest: smem
[645.363899] Dynamic subtest smem: SUCCESS (6.853s)
[645.367060] Subtest basic-S0: SUCCESS (6.855s)
[645.564097] [103/132] (378s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[645.625344] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[645.727011] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.105s)
[645.804058] [104/132] (378s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[645.902430] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[645.907866] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[645.983146] [105/132] (378s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[646.082286] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[646.087272] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[646.162384] [106/132] (378s left) kms_psr (psr-primary-mmap-cpu)
[646.253123] Starting subtest: psr-primary-mmap-cpu
[646.255598] Starting dynamic subtest: eDP-1
[647.971445] Dynamic subtest eDP-1: SUCCESS (1.738s)
[647.973779] Subtest psr-primary-mmap-cpu: SUCCESS (1.739s)
[648.831169] [107/132] (375s left) gem_ctx_persistence (legacy-engines-mixed-process)
[648.896044] Starting subtest: legacy-engines-mixed-process
[648.898668] Starting dynamic subtest: render
[650.422505] Dynamic subtest render: SUCCESS (1.540s)
[650.435263] Starting dynamic subtest: bsd1
[652.405808] Dynamic subtest bsd1: SUCCESS (1.995s)
[652.416501] Starting dynamic subtest: bsd2
[654.371391] Dynamic subtest bsd2: SUCCESS (1.975s)
[654.383685] Starting dynamic subtest: blt
[656.366751] Dynamic subtest blt: SUCCESS (2.002s)
[656.380512] Starting dynamic subtest: vebox
[658.403523] Dynamic subtest vebox: SUCCESS (2.041s)
[658.406236] Subtest legacy-engines-mixed-process: SUCCESS (9.562s)
[658.488936] [108/132] (365s left) gem_exec_schedule (implicit-boths)
[658.563083] Starting subtest: implicit-boths
[658.565301] Starting dynamic subtest: rcs0
[658.738685] Dynamic subtest rcs0: SUCCESS (0.188s)
[658.754988] Starting dynamic subtest: vcs0
[658.879797] Dynamic subtest vcs0: SUCCESS (0.140s)
[658.893119] Starting dynamic subtest: vcs1
[658.993844] Dynamic subtest vcs1: SUCCESS (0.114s)
[659.006318] Starting dynamic subtest: vecs0
[659.105487] Dynamic subtest vecs0: SUCCESS (0.111s)
[659.119385] Starting dynamic subtest: ccs0
[659.246061] Dynamic subtest ccs0: SUCCESS (0.140s)
[659.248926] Subtest implicit-boths: SUCCESS (0.699s)
[660.510593] [109/132] (363s left) kms_prop_blob (blob-multiple)
[660.569257] Starting subtest: blob-multiple
[660.571294] Subtest blob-multiple: SUCCESS (0.004s)
[660.683622] [110/132] (363s left) gem_ctx_engines (independent)
[660.742257] Starting subtest: independent
[660.745263] Starting dynamic subtest: rcs0
[661.002017] Dynamic subtest rcs0: SUCCESS (0.258s)
[661.015093] Starting dynamic subtest: bcs0
[661.264775] Dynamic subtest bcs0: SUCCESS (0.263s)
[661.276185] Starting dynamic subtest: vcs0
[661.534442] Dynamic subtest vcs0: SUCCESS (0.269s)
[661.544745] Starting dynamic subtest: vcs1
[661.863249] Dynamic subtest vcs1: SUCCESS (0.329s)
[661.874537] Starting dynamic subtest: vecs0
[662.188800] Dynamic subtest vecs0: SUCCESS (0.325s)
[662.201037] Starting dynamic subtest: ccs0
[662.553793] Dynamic subtest ccs0: SUCCESS (0.364s)
[662.566129] Starting dynamic subtest: all-engines
[664.030728] Dynamic subtest all-engines: SUCCESS (1.479s)
[664.033245] Subtest independent: SUCCESS (3.295s)
[664.516578] [111/132] (360s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[664.618368] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[664.623311] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[664.712372] [112/132] (359s left) kms_dsc (dsc-with-formats)
[664.801912] Starting subtest: dsc-with-formats
[664.847385] Subtest dsc-with-formats: SKIP (0.001s)
[664.889958] [113/132] (359s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[664.980928] Starting subtest: y-tiled-8bpp-rotate-180
[664.985560] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[665.082713] [114/132] (359s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[665.176185] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[665.180793] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[665.273955] [115/132] (359s left) fbdev (read)
[665.317044] Starting subtest: read
[665.838251] Subtest read: SUCCESS (0.523s)
[665.902220] [116/132] (358s left) kms_chamelium_hpd (vga-hpd)
[666.285993] Subtest vga-hpd: SKIP (0.000s)
[667.059967] [117/132] (357s left) intel_hwmon (hwmon-write)
[667.122494] Subtest hwmon-write: SKIP (0.000s)
[667.188585] [118/132] (357s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[667.237576] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[667.243070] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[667.421123] [119/132] (357s left) dmabuf_sync_file (export-basic)
[667.466378] Starting subtest: export-basic
[667.469136] Subtest export-basic: SUCCESS (0.001s)
[667.525109] [120/132] (357s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[667.645377] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[668.524480] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.881s)
[668.690223] [121/132] (356s left) kms_chamelium_frames (hdmi-frame-dump)
[669.075239] Subtest hdmi-frame-dump: SKIP (0.000s)
[669.876097] [122/132] (355s left) gem_mmap_offset (partial-mmap)
[669.928500] Starting subtest: partial-mmap
[669.931496] Starting dynamic subtest: smem0
[669.934226] Dynamic subtest smem0: SUCCESS (0.004s)
[669.936838] Subtest partial-mmap: SUCCESS (0.005s)
[670.083207] [123/132] (355s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[670.191250] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[670.196256] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.000s)
[670.263962] [124/132] (354s left) kms_atomic (atomic-invalid-params)
[670.353228] Starting subtest: atomic-invalid-params
[670.355998] Starting dynamic subtest: pipe-A-eDP-1
[670.748529] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.393s)
[670.751347] Subtest atomic-invalid-params: SUCCESS (0.395s)
[671.628108] [125/132] (353s left) gem_exec_balancer (semaphore)
[671.688074] Starting subtest: semaphore
[673.393111] Subtest semaphore: SUCCESS (1.705s)
[673.689677] [126/132] (351s left) sysfs_preempt_timeout (idempotent)
[673.753268] Starting subtest: idempotent
[673.756258] Starting dynamic subtest: vecs0
[673.759204] Dynamic subtest vecs0: SUCCESS (0.000s)
[673.772566] Starting dynamic subtest: ccs0
[673.775067] Dynamic subtest ccs0: SUCCESS (0.000s)
[673.785506] Starting dynamic subtest: vcs0
[673.788412] Dynamic subtest vcs0: SUCCESS (0.000s)
[673.799106] Starting dynamic subtest: bcs0
[673.801620] Dynamic subtest bcs0: SUCCESS (0.000s)
[673.814504] Starting dynamic subtest: rcs0
[673.817404] Dynamic subtest rcs0: SUCCESS (0.000s)
[673.827525] Starting dynamic subtest: vcs1
[673.830321] Dynamic subtest vcs1: SUCCESS (0.000s)
[673.833304] Subtest idempotent: SUCCESS (0.006s)
[673.872577] [127/132] (351s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[673.963382] Starting subtest: fbcpsr-slowdraw
[699.123046] Subtest fbcpsr-slowdraw: SUCCESS (25.171s)
[699.262626] [128/132] (326s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[699.366939] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[706.432093] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.071s)
[706.580924] [129/132] (318s left) gem_exec_fence (parallel)
[706.770644] Starting subtest: parallel
[706.773559] Starting dynamic subtest: rcs0
[708.919334] Dynamic subtest rcs0: SUCCESS (2.151s)
[708.929988] Starting dynamic subtest: bcs0
[711.075067] Dynamic subtest bcs0: SUCCESS (2.156s)
[711.085731] Starting dynamic subtest: vcs0
[713.232314] Dynamic subtest vcs0: SUCCESS (2.157s)
[713.242489] Starting dynamic subtest: vcs1
[715.385102] Dynamic subtest vcs1: SUCCESS (2.153s)
[715.396120] Starting dynamic subtest: vecs0
[717.535259] Dynamic subtest vecs0: SUCCESS (2.150s)
[717.551780] Starting dynamic subtest: ccs0
[719.690065] Dynamic subtest ccs0: SUCCESS (2.155s)
[719.692072] Subtest parallel: SUCCESS (12.927s)
[720.454170] [130/132] (304s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[720.552569] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[720.554992] Starting dynamic subtest: pipe-A-default-mode
[723.296305] Dynamic subtest pipe-A-default-mode: SUCCESS (2.745s)
[723.299320] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.747s)
[724.134180] [131/132] (301s left) kms_cursor_edge_walk (128x128-top-bottom)
[724.224394] Starting subtest: 128x128-top-bottom
[724.227186] Starting dynamic subtest: pipe-A-eDP-1
[727.698257] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.474s)
[727.710204] Starting dynamic subtest: pipe-D-eDP-1
[730.817812] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.120s)
[730.820425] Subtest 128x128-top-bottom: SUCCESS (6.597s)
[731.624507] [132/132] (293s left) prime_self_import (basic-with_fd_dup)
[731.661054] Starting subtest: basic-with_fd_dup
[731.679101] Subtest basic-with_fd_dup: SUCCESS (0.018s)
[731.770057] Closing watchdogs
results: parsing output: 0/ for test: perf_pmu
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: kms_color_pipeline
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_getfb
results: parsing output: 7/ for test: gem_mmap_gtt
results: parsing output: 8/ for test: syncobj_timeline
results: parsing output: 9/ for test: gem_mmap_gtt
results: parsing output: 10/ for test: kms_cursor_crc
results: parsing output: 11/ for test: gem_eio
results: parsing output: 12/ for test: kms_ccs
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: gem_ctx_shared
results: parsing output: 15/ for test: kms_plane_multiple
results: parsing output: 16/ for test: i915_pm_rc6_residency
results: parsing output: 17/ for test: kms_flip
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: api_intel_allocator
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: gem_set_tiling_vs_blt
results: parsing output: 22/ for test: i915_hangman
results: parsing output: 23/ for test: gem_pxp
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: perf
results: parsing output: 26/ for test: kms_rmfb
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: kms_flip
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_content_protection
results: parsing output: 31/ for test: kms_dirtyfb
results: parsing output: 32/ for test: kms_pipe_crc_basic
results: parsing output: 33/ for test: gen9_exec_parse
results: parsing output: 34/ for test: gem_userptr_blits
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: gem_exec_reloc
results: parsing output: 37/ for test: sw_sync
results: parsing output: 38/ for test: gem_userptr_blits
results: parsing output: 39/ for test: gem_exec_reloc
results: parsing output: 40/ for test: gem_render_copy
results: parsing output: 41/ for test: gem_exec_reloc
results: parsing output: 42/ for test: gem_exec_balancer
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: perf
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: gem_exec_reloc
results: parsing output: 48/ for test: gem_close
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: kms_atomic_interruptible
results: parsing output: 51/ for test: gem_exec_reloc
results: parsing output: 52/ for test: gem_exec_fence
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_vblank
results: parsing output: 55/ for test: kms_tiled_display
results: parsing output: 56/ for test: i915_drm_fdinfo
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: gem_ctx_persistence
results: parsing output: 63/ for test: i915_query
results: parsing output: 64/ for test: gem_userptr_blits
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: kms_plane
results: parsing output: 68/ for test: gem_exec_schedule
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_ccs
results: parsing output: 72/ for test: kms_atomic_transition
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: kms_lease
results: parsing output: 75/ for test: gem_exec_whisper
results: parsing output: 76/ for test: kms_plane
results: parsing output: 77/ for test: kms_flip
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_pm_rpm
results: parsing output: 80/ for test: gem_fence_thrash
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_plane_scaling
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_spin_batch
results: parsing output: 85/ for test: kms_atomic_transition
results: parsing output: 86/ for test: kms_vrr
results: parsing output: 87/ for test: gem_exec_schedule
results: parsing output: 88/ for test: kms_pm_rpm
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_cursor_crc
results: parsing output: 91/ for test: gem_exec_reloc
results: parsing output: 92/ for test: api_intel_bb
results: parsing output: 93/ for test: kms_invalid_mode
results: parsing output: 94/ for test: kms_psr2_sf
results: parsing output: 95/ for test: syncobj_basic
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: kms_addfb_basic
results: parsing output: 98/ for test: i915_pm_rps
results: parsing output: 99/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 100/ for test: kms_psr2_sf
results: parsing output: 101/ for test: gem_exec_suspend
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_psr
results: parsing output: 106/ for test: gem_ctx_persistence
results: parsing output: 107/ for test: gem_exec_schedule
results: parsing output: 108/ for test: kms_prop_blob
results: parsing output: 109/ for test: gem_ctx_engines
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: kms_dsc
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: fbdev
results: parsing output: 115/ for test: kms_chamelium_hpd
results: parsing output: 116/ for test: intel_hwmon
results: parsing output: 117/ for test: gem_render_copy
results: parsing output: 118/ for test: dmabuf_sync_file
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: kms_chamelium_frames
results: parsing output: 121/ for test: gem_mmap_offset
results: parsing output: 122/ for test: kms_flip_scaled_crc
results: parsing output: 123/ for test: kms_atomic
results: parsing output: 124/ for test: gem_exec_balancer
results: parsing output: 125/ for test: sysfs_preempt_timeout
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gem_exec_fence
results: parsing output: 129/ for test: kms_flip_scaled_crc
results: parsing output: 130/ for test: kms_cursor_edge_walk
results: parsing output: 131/ for test: prime_self_import
Done.