[58.417525] Initializing watchdogs
[58.417574]   /dev/watchdog0
[58.432188] [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.437025] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.439323] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.442528] [001/133] (960s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[58.559787] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[58.564125] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[58.632193] [002/133] (960s left) gem_mmap_offset (bad-object)
[58.692762] Starting subtest: bad-object
[58.695104] Subtest bad-object: SUCCESS (0.001s)
[58.783845] [003/133] (960s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[58.885974] Starting subtest: psr-2p-pri-indfb-multidraw
[58.890324] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[58.982950] [004/133] (960s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[59.094492] Starting subtest: x-tiled-addfb-size-offset-overflow
[59.096753] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[59.210655] [005/133] (959s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[59.308640] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[59.313280] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[59.400564] [006/133] (959s left) kms_flip (absolute-wf_vblank-interruptible)
[59.511593] Starting subtest: absolute-wf_vblank-interruptible
[59.513579] Starting dynamic subtest: A-eDP1
[68.292077] Dynamic subtest A-eDP1: SUCCESS (8.753s)
[68.301369] Starting dynamic subtest: B-eDP1
[77.022282] Dynamic subtest B-eDP1: SUCCESS (8.732s)
[77.031467] Starting dynamic subtest: C-eDP1
[85.701460] Dynamic subtest C-eDP1: SUCCESS (8.715s)
[85.710511] Starting dynamic subtest: D-eDP1
[94.472217] Dynamic subtest D-eDP1: SUCCESS (8.725s)
[94.476614] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.936s)
[95.628173] [007/133] (923s left) kms_chamelium_audio (hdmi-audio)
[96.039753] Subtest hdmi-audio: SKIP (0.000s)
[96.838192] [008/133] (922s left) kms_vblank (ts-continuation-modeset-rpm)
[96.928609] Starting subtest: ts-continuation-modeset-rpm
[96.931133] Starting dynamic subtest: pipe-A-eDP-1
[99.461254] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.530s)
[99.474602] Starting dynamic subtest: pipe-D-eDP-1
[101.704741] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.241s)
[101.707217] Subtest ts-continuation-modeset-rpm: SUCCESS (4.775s)
[102.589464] [009/133] (916s left) gem_exec_params (invalid-flag)
[102.652243] Starting subtest: invalid-flag
[102.654910] Subtest invalid-flag: SUCCESS (0.000s)
[102.763646] [010/133] (916s left) kms_chamelium_edid (dp-edid-resolution-list)
[103.152749] Subtest dp-edid-resolution-list: SKIP (0.000s)
[104.002752] [011/133] (915s left) kms_pm_lpsp (screens-disabled)
[105.100859] Starting subtest: screens-disabled
[105.105152] Subtest screens-disabled: SKIP (0.000s)
[105.166215] [012/133] (914s left) syncobj_wait (single-wait-for-submit-signaled)
[105.221024] Starting subtest: single-wait-for-submit-signaled
[105.223418] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[105.297683] [013/133] (914s left) gem_userptr_blits (huge-split)
[105.361759] Starting subtest: huge-split
[105.368345] Subtest huge-split: SUCCESS (0.006s)
[105.503700] [014/133] (913s left) dumb_buffer (create-valid-dumb)
[105.556786] Starting subtest: create-valid-dumb
[105.559077] Subtest create-valid-dumb: SUCCESS (0.000s)
[105.649988] [015/133] (913s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[105.697970] Starting subtest: etime-multi-wait-available-unsubmitted
[105.800877] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.102s)
[105.885684] [016/133] (913s left) gem_userptr_blits (create-destroy-sync)
[105.948563] Starting subtest: create-destroy-sync
[110.958966] Subtest create-destroy-sync: SUCCESS (5.010s)
[111.079873] [017/133] (908s left) gem_ctx_param (invalid-get-no-zeromap)
[111.130504] Starting subtest: invalid-get-no-zeromap
[111.132783] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[111.225585] [018/133] (908s left) gem_exec_params (invalid-ring)
[111.275766] Starting subtest: invalid-ring
[111.278234] Subtest invalid-ring: SUCCESS (0.000s)
[111.415710] [019/133] (908s left) perf (oa-exponents)
[111.550114] Starting subtest: oa-exponents
[111.552497] Starting dynamic subtest: 0-rcs0
[113.347561] Dynamic subtest 0-rcs0: SUCCESS (1.797s)
[113.355771] Starting dynamic subtest: 1-vecs0
[115.173451] Dynamic subtest 1-vecs0: SUCCESS (1.826s)
[115.176075] Subtest oa-exponents: SUCCESS (3.623s)
[115.218304] [020/133] (904s left) perf (non-sampling-read-error)
[115.314308] Starting subtest: non-sampling-read-error
[115.324069] Subtest non-sampling-read-error: SUCCESS (0.008s)
[115.364199] [021/133] (904s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[115.465161] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[119.594429] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.134s)
[120.722480] [022/133] (899s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[120.821078] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[120.825724] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[120.914173] [023/133] (898s left) gem_lmem_swapping (random-engines)
[120.966171] Subtest random-engines: SKIP (0.000s)
[121.005552] [024/133] (898s left) gem_tiling_max_stride
[121.119103] [025/133] (898s left) gem_mmap_gtt (basic-small-copy-xy)
[121.179124] Subtest basic-small-copy-XY: SKIP (0.000s)
[121.237438] [026/133] (898s left) gem_exec_schedule (smoketest)
[121.418728] Starting subtest: smoketest
[121.421170] Starting dynamic subtest: rcs0
[127.017168] Dynamic subtest rcs0: SUCCESS (5.499s)
[127.025479] Starting dynamic subtest: bcs0
[132.511025] Dynamic subtest bcs0: SUCCESS (5.492s)
[132.519742] Starting dynamic subtest: vcs0
[138.020878] Dynamic subtest vcs0: SUCCESS (5.507s)
[138.030564] Starting dynamic subtest: vcs1
[143.504113] Dynamic subtest vcs1: SUCCESS (5.488s)
[143.512614] Starting dynamic subtest: vecs0
[148.998554] Dynamic subtest vecs0: SUCCESS (5.485s)
[149.006875] Starting dynamic subtest: ccs0
[154.507246] Dynamic subtest ccs0: SUCCESS (5.508s)
[154.509612] Subtest smoketest: SUCCESS (32.983s)
[154.586970] [027/133] (865s left) kms_cursor_crc (cursor-random-128x128)
[154.794559] Starting subtest: cursor-random-128x128
[154.799776] Starting dynamic subtest: pipe-A-eDP-1
[158.154935] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.355s)
[158.182703] Starting dynamic subtest: pipe-D-eDP-1
[162.143471] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.966s)
[162.145740] Subtest cursor-random-128x128: SUCCESS (7.346s)
[162.991953] [028/133] (857s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[163.055576] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[163.113642] [029/133] (856s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[163.162817] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[163.264390] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[163.341608] [030/133] (856s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[163.453790] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[170.878073] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.428s)
[171.002392] [031/133] (849s left) gem_mmap_wc (coherency)
[171.072364] Subtest coherency: SKIP (0.000s)
[171.143343] [032/133] (849s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[171.197654] Starting subtest: yf-tiled-to-vebox-x-tiled
[171.202027] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[171.391982] [033/133] (848s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[171.480095] Starting subtest: psr-dirtyfb-ioctl
[171.482460] Starting dynamic subtest: A-eDP-1
[175.411401] Dynamic subtest A-eDP-1: SUCCESS (3.931s)
[175.413695] Subtest psr-dirtyfb-ioctl: SUCCESS (3.932s)
[176.202815] [034/133] (844s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[176.341733] Starting subtest: cursorA-vs-flipA-atomic-transitions
[187.512960] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.171s)
[188.327136] [035/133] (831s left) perf (sysctl-defaults)
[188.433651] Starting subtest: sysctl-defaults
[188.436105] Subtest sysctl-defaults: SUCCESS (0.000s)
[188.494800] [036/133] (831s left) gem_exec_schedule (pi-shared-iova)
[188.670883] Starting subtest: pi-shared-iova
[188.673383] Starting dynamic subtest: rcs0
[188.747122] Dynamic subtest rcs0: SUCCESS (0.079s)
[188.759632] Starting dynamic subtest: vcs0
[188.806905] Dynamic subtest vcs0: SUCCESS (0.058s)
[188.816532] Starting dynamic subtest: vcs1
[188.861478] Dynamic subtest vcs1: SUCCESS (0.055s)
[188.871978] Starting dynamic subtest: vecs0
[188.911310] Dynamic subtest vecs0: SUCCESS (0.048s)
[188.921986] Starting dynamic subtest: ccs0
[188.970155] Dynamic subtest ccs0: SUCCESS (0.057s)
[188.973156] Subtest pi-shared-iova: SUCCESS (0.304s)
[189.997747] [037/133] (830s left) kms_flip (2x-modeset-vs-vblank-race)
[190.090126] Starting subtest: 2x-modeset-vs-vblank-race
[190.099018] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s)
[190.175144] [038/133] (830s left) kms_plane_multiple (2x-tiling-x)
[190.272643] Starting subtest: 2x-tiling-x
[190.276916] Subtest 2x-tiling-x: SKIP (0.000s)
[190.343922] [039/133] (830s left) fbdev (unaligned-write)
[190.395186] Starting subtest: unaligned-write
[190.496392] Subtest unaligned-write: SUCCESS (0.101s)
[190.556760] [040/133] (829s left) sysfs_heartbeat_interval (mixed)
[190.619507] Starting subtest: mixed
[190.621568] Starting dynamic subtest: vecs0
[195.843568] Dynamic subtest vecs0: SUCCESS (5.227s)
[195.853915] Starting dynamic subtest: ccs0
[201.029309] Dynamic subtest ccs0: SUCCESS (5.185s)
[201.039751] Starting dynamic subtest: vcs0
[206.226268] Dynamic subtest vcs0: SUCCESS (5.195s)
[206.235483] Starting dynamic subtest: bcs0
[211.393315] Dynamic subtest bcs0: SUCCESS (5.165s)
[211.403228] Starting dynamic subtest: rcs0
[216.565929] Dynamic subtest rcs0: SUCCESS (5.171s)
[216.575680] Starting dynamic subtest: vcs1
[221.790069] Dynamic subtest vcs1: SUCCESS (5.222s)
[221.792446] Subtest mixed: SUCCESS (31.176s)
[221.879063] [041/133] (798s left) gem_exec_schedule (fairslice)
[221.948067] Starting subtest: fairslice
[221.949952] Starting dynamic subtest: rcs0
[223.970410] Dynamic subtest rcs0: SUCCESS (2.027s)
[223.979430] Starting dynamic subtest: bcs0
[225.998458] Dynamic subtest bcs0: SUCCESS (2.028s)
[226.007702] Starting dynamic subtest: vcs0
[228.021539] Dynamic subtest vcs0: SUCCESS (2.020s)
[228.030249] Starting dynamic subtest: vcs1
[230.041300] Dynamic subtest vcs1: SUCCESS (2.018s)
[230.050033] Starting dynamic subtest: vecs0
[232.059693] Dynamic subtest vecs0: SUCCESS (2.018s)
[232.068685] Starting dynamic subtest: ccs0
[234.132509] Dynamic subtest ccs0: SUCCESS (2.023s)
[234.135024] Subtest fairslice: SUCCESS (12.140s)
[234.378371] [042/133] (786s left) gem_ctx_engines (execute-allforone)
[234.439946] Starting subtest: execute-allforone
[234.464681] Subtest execute-allforone: SUCCESS (0.027s)
[236.008725] [043/133] (784s left) gem_ctx_sseu (engines)
[236.064333] Subtest engines: SKIP (0.000s)
[236.129311] [044/133] (784s left) syncobj_wait (invalid-signal-one-illegal-handle)
[236.183987] Starting subtest: invalid-signal-one-illegal-handle
[236.186270] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[236.274075] [045/133] (784s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[236.376272] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[236.380606] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[236.468983] [046/133] (784s left) gem_ppgtt (blt-vs-render-ctxn)
[236.526966] Starting subtest: blt-vs-render-ctxN
[269.507587] Subtest blt-vs-render-ctxN: SUCCESS (32.975s)
[269.622031] [047/133] (751s left) kms_psr (fbc-psr-sprite-render)
[269.752205] Starting subtest: fbc-psr-sprite-render
[269.754891] Starting dynamic subtest: eDP-1
[269.759326] Dynamic subtest eDP-1: SKIP (0.000s)
[269.763659] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[269.838806] [048/133] (750s left) kms_plane_scaling (planes-scaler-unity-scaling)
[269.928841] Starting subtest: planes-scaler-unity-scaling
[269.931671] Starting dynamic subtest: pipe-A
[269.993250] Dynamic subtest pipe-A: SUCCESS (0.065s)
[270.006701] Starting dynamic subtest: pipe-B
[271.150093] Dynamic subtest pipe-B: SUCCESS (1.155s)
[271.160470] Starting dynamic subtest: pipe-C
[272.266502] Dynamic subtest pipe-C: SUCCESS (1.115s)
[272.275474] Starting dynamic subtest: pipe-D
[273.403424] Dynamic subtest pipe-D: SUCCESS (1.136s)
[273.405799] Subtest planes-scaler-unity-scaling: SUCCESS (3.476s)
[274.578048] [049/133] (746s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[274.710444] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[292.310238] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.597s)
[293.185262] [050/133] (727s left) kms_feature_discovery (chamelium)
[293.281219] Starting subtest: chamelium
[293.285627] Subtest chamelium: SKIP (0.000s)
[293.351323] [051/133] (727s left) syncobj_timeline (wait-all-complex)
[293.413352] Starting subtest: wait-all-complex
[293.631900] Subtest wait-all-complex: SUCCESS (0.216s)
[293.719734] [052/133] (727s left) gem_softpin (noreloc)
[293.779788] Starting subtest: noreloc
[299.256678] Subtest noreloc: SUCCESS (5.415s)
[299.327171] [053/133] (721s left) gem_tiled_wb
[299.454976] [054/133] (721s left) intel_hwmon (hwmon-write)
[299.516432] Subtest hwmon-write: SKIP (0.000s)
[299.584282] [055/133] (721s left) gem_workarounds (reset)
[299.655064] Starting subtest: reset
[299.858960] Subtest reset: SUCCESS (0.203s)
[299.988570] [056/133] (721s left) kms_psr (fbc-psr2-cursor-blt)
[300.093723] Starting subtest: fbc-psr2-cursor-blt
[300.096197] Starting dynamic subtest: eDP-1
[300.100734] Dynamic subtest eDP-1: SKIP (0.000s)
[300.105507] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[300.163499] [057/133] (720s left) gen9_exec_parse (batch-invalid-length)
[300.216999] Subtest batch-invalid-length: SKIP (0.000s)
[300.291363] [058/133] (720s left) syncobj_wait (wait-any-interrupted)
[300.353016] Starting subtest: wait-any-interrupted
[300.456952] Subtest wait-any-interrupted: SUCCESS (0.102s)
[300.547343] [059/133] (720s left) kms_content_protection (legacy-hdcp14)
[300.694558] Starting subtest: legacy-hdcp14
[300.699310] Subtest legacy-hdcp14: SKIP (0.000s)
[300.810372] [060/133] (720s left) perf_pmu (rc6-suspend)
[300.853537] Starting subtest: rc6-suspend
[323.261157] Subtest rc6-suspend: SUCCESS (8.360s)
[324.152285] [061/133] (697s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[324.260518] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[324.262775] Starting dynamic subtest: pipe-A-eDP-1
[324.283631] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[324.294280] Starting dynamic subtest: pipe-B-eDP-1
[324.311400] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[324.319902] Starting dynamic subtest: pipe-C-eDP-1
[324.336746] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[324.345000] Starting dynamic subtest: pipe-D-eDP-1
[324.362641] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[324.366130] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[326.502091] [062/133] (694s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[326.608039] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[326.610363] Starting dynamic subtest: pipe-A-default-mode
[329.368747] Dynamic subtest pipe-A-default-mode: SUCCESS (2.766s)
[329.371196] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.767s)
[330.215515] [063/133] (691s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[330.308025] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[330.310268] Starting dynamic subtest: pipe-A-eDP-1
[330.370609] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[330.381593] Starting dynamic subtest: pipe-B-eDP-1
[330.439558] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[330.452298] Starting dynamic subtest: pipe-C-eDP-1
[330.507399] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[330.517626] Starting dynamic subtest: pipe-D-eDP-1
[330.575974] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[330.580374] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.009s)
[332.572268] [064/133] (688s left) i915_suspend (fence-restore-untiled)
[332.631303] Starting subtest: fence-restore-untiled
[332.636103] Subtest fence-restore-untiled: SKIP (0.000s)
[332.734621] [065/133] (688s left) kms_invalid_mode (int-max-clock)
[332.842890] Starting subtest: int-max-clock
[332.844996] Starting dynamic subtest: pipe-A-eDP-1
[333.140637] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.301s)
[333.150632] Starting dynamic subtest: pipe-B-eDP-1
[333.152642] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[333.162143] Starting dynamic subtest: pipe-C-eDP-1
[333.164472] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[333.180944] Starting dynamic subtest: pipe-D-eDP-1
[333.183534] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[333.186282] Subtest int-max-clock: SUCCESS (0.307s)
[334.002277] [066/133] (687s left) gem_lmem_swapping (parallel-random)
[334.049050] Subtest parallel-random: SKIP (0.000s)
[334.087698] [067/133] (687s left) gem_pxp (reject-modify-context-protection-off-1)
[334.221622] Starting subtest: reject-modify-context-protection-off-1
[334.224311] Subtest reject-modify-context-protection-off-1: SUCCESS (0.001s)
[334.322589] [068/133] (687s left) syncobj_wait (reset-multiple-signaled)
[334.392304] Starting subtest: reset-multiple-signaled
[334.394706] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[334.516375] [069/133] (687s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[334.625842] Starting subtest: 4-tiled-16bpp-rotate-90
[334.645009] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.019s)
[334.761890] [070/133] (686s left) kms_atomic (plane-cursor-legacy)
[334.863875] Starting subtest: plane-cursor-legacy
[334.866112] Starting dynamic subtest: pipe-A-eDP-1
[335.240140] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.376s)
[335.242504] Subtest plane-cursor-legacy: SUCCESS (0.378s)
[336.035399] [071/133] (685s left) syncobj_wait (wait-all-for-submit-complex)
[336.089800] Starting subtest: wait-all-for-submit-complex
[336.303030] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[336.380175] [072/133] (685s left) kms_pm_rpm (legacy-planes)
[338.117531] Starting subtest: legacy-planes
[338.119757] Starting dynamic subtest: plane-64
[346.401174] Dynamic subtest plane-64: SUCCESS (8.292s)
[346.413715] Starting dynamic subtest: plane-94
[354.723407] Dynamic subtest plane-94: SUCCESS (8.320s)
[354.736868] Starting dynamic subtest: plane-124
[363.009801] Dynamic subtest plane-124: SUCCESS (8.284s)
[363.022017] Starting dynamic subtest: plane-134
[371.325249] Dynamic subtest plane-134: SUCCESS (8.314s)
[371.327993] Subtest legacy-planes: SUCCESS (33.220s)
[371.710207] [073/133] (650s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[371.810854] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[371.815252] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[371.910894] [074/133] (649s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[372.013610] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[372.018042] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[372.103452] [075/133] (649s left) api_intel_bb (full-batch)
[372.164371] Starting subtest: full-batch
[372.166918] Subtest full-batch: SUCCESS (0.004s)
[372.313394] [076/133] (649s left) perf (whitelisted-registers-userspace-config)
[372.421408] Starting subtest: whitelisted-registers-userspace-config
[372.423731] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[372.460165] [077/133] (649s left) kms_lease (page-flip-implicit-plane)
[372.545745] Starting subtest: page-flip-implicit-plane
[372.547944] Starting dynamic subtest: pipe-A-eDP-1
[373.021410] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.477s)
[373.034422] Starting dynamic subtest: pipe-B-eDP-1
[374.149839] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.126s)
[374.160190] Starting dynamic subtest: pipe-C-eDP-1
[375.254646] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.103s)
[375.265095] Starting dynamic subtest: pipe-D-eDP-1
[376.381367] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.125s)
[376.383487] Subtest page-flip-implicit-plane: SUCCESS (3.837s)
[377.222276] [078/133] (644s left) gem_flink_basic (flink-lifetime)
[377.277751] Starting subtest: flink-lifetime
[377.280023] Subtest flink-lifetime: SUCCESS (0.002s)
[377.375013] [079/133] (644s left) i915_pm_rpm (system-suspend-devices)
[379.093290] Starting subtest: system-suspend-devices
[386.727833] Subtest system-suspend-devices: SUCCESS (7.637s)
[387.128267] [080/133] (635s left) kms_properties (plane-properties-atomic)
[387.231833] Starting subtest: plane-properties-atomic
[387.234075] Starting dynamic subtest: pipe-A-eDP-1
[387.783444] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.552s)
[387.793514] Starting dynamic subtest: pipe-B-eDP-1
[389.089602] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.303s)
[389.099844] Starting dynamic subtest: pipe-C-eDP-1
[390.335368] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.245s)
[390.344852] Starting dynamic subtest: pipe-D-eDP-1
[391.571749] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.235s)
[391.573965] Subtest plane-properties-atomic: SUCCESS (4.341s)
[392.370444] [081/133] (629s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[392.481606] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf
[392.485968] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[392.550378] [082/133] (629s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[392.669439] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[392.673480] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[392.766211] [083/133] (629s left) gem_mmap_wc (write-wc-read-gtt)
[392.827711] Subtest write-wc-read-gtt: SKIP (0.000s)
[392.884446] [084/133] (629s left) perf_pmu (busy-check-all)
[392.922971] Starting subtest: busy-check-all
[392.925318] Starting dynamic subtest: rcs0
[393.473522] Dynamic subtest rcs0: SUCCESS (0.551s)
[393.488369] Starting dynamic subtest: bcs0
[394.023430] Dynamic subtest bcs0: SUCCESS (0.548s)
[394.036673] Starting dynamic subtest: vcs0
[395.970470] Dynamic subtest vcs0: SUCCESS (1.943s)
[395.982245] Starting dynamic subtest: vcs1
[397.978961] Dynamic subtest vcs1: SUCCESS (1.982s)
[397.991397] Starting dynamic subtest: vecs0
[400.002539] Dynamic subtest vecs0: SUCCESS (2.045s)
[400.015256] Starting dynamic subtest: ccs0
[400.558329] Dynamic subtest ccs0: SUCCESS (0.554s)
[400.560947] Subtest busy-check-all: SUCCESS (7.638s)
[400.661688] [085/133] (621s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[400.776983] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[400.780928] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[400.849893] [086/133] (621s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[400.948069] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[400.950314] Starting dynamic subtest: pipe-A-eDP-1
[400.959204] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[400.970195] Starting dynamic subtest: pipe-B-eDP-1
[400.978965] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[400.988598] Starting dynamic subtest: pipe-C-eDP-1
[400.996553] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[401.005401] Starting dynamic subtest: pipe-D-eDP-1
[401.013625] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[401.017475] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s)
[403.240100] [087/133] (619s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[403.340676] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[403.344957] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[403.425201] [088/133] (619s left) syncobj_wait (invalid-reset-bad-pad)
[403.480170] Starting subtest: invalid-reset-bad-pad
[403.482083] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[403.596586] [089/133] (618s left) kms_scaling_modes (scaling-mode-full-aspect)
[403.689533] Starting subtest: scaling-mode-full-aspect
[403.691803] Starting dynamic subtest: pipe-A-eDP-1
[403.784677] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.096s)
[403.794703] Starting dynamic subtest: pipe-B-eDP-1
[404.960017] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.174s)
[404.970685] Starting dynamic subtest: pipe-C-eDP-1
[406.080113] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.119s)
[406.092650] Starting dynamic subtest: pipe-D-eDP-1
[407.218799] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.137s)
[407.220949] Subtest scaling-mode-full-aspect: SUCCESS (3.532s)
[408.407500] [090/133] (614s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[408.509986] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[408.513890] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[408.618311] [091/133] (614s left) gem_exec_balancer (parallel-bb-first)
[408.894517] Starting subtest: parallel-bb-first
[409.855027] Subtest parallel-bb-first: SUCCESS (0.961s)
[410.983697] [092/133] (611s left) gem_ctx_persistence (legacy-engines-cleanup)
[411.060485] Starting subtest: legacy-engines-cleanup
[411.063177] Starting dynamic subtest: render
[411.147542] Dynamic subtest render: SUCCESS (0.087s)
[411.163033] Starting dynamic subtest: bsd1
[411.197500] Dynamic subtest bsd1: SUCCESS (0.047s)
[411.209846] Starting dynamic subtest: bsd2
[411.233271] Dynamic subtest bsd2: SUCCESS (0.033s)
[411.244981] Starting dynamic subtest: blt
[411.251074] Dynamic subtest blt: SUCCESS (0.017s)
[411.260371] Starting dynamic subtest: vebox
[411.310233] Dynamic subtest vebox: SUCCESS (0.058s)
[411.312612] Subtest legacy-engines-cleanup: SUCCESS (0.252s)
[411.392865] [093/133] (611s left) kms_cursor_crc (cursor-alpha-opaque)
[411.497190] Starting subtest: cursor-alpha-opaque
[411.499521] Starting dynamic subtest: pipe-A-eDP-1
[412.128666] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.631s)
[412.139443] Starting dynamic subtest: pipe-D-eDP-1
[413.460370] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.329s)
[413.462545] Subtest cursor-alpha-opaque: SUCCESS (1.964s)
[414.260025] [094/133] (608s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[414.371634] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[415.373408] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.001s)
[415.508405] [095/133] (607s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[415.607985] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[415.610309] Starting dynamic subtest: pipe-A-eDP-1
[415.669237] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.063s)
[415.974696] Starting dynamic subtest: pipe-B-eDP-1
[416.761279] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.796s)
[417.050060] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.443s)
[417.917439] [096/133] (604s left) gem_exec_fence (nb-await)
[418.105394] Starting subtest: nb-await
[418.107879] Starting dynamic subtest: rcs0
[418.176856] Dynamic subtest rcs0: SUCCESS (0.071s)
[418.189487] Starting dynamic subtest: bcs0
[418.235134] Dynamic subtest bcs0: SUCCESS (0.056s)
[418.247294] Starting dynamic subtest: vcs0
[418.295760] Dynamic subtest vcs0: SUCCESS (0.058s)
[418.308086] Starting dynamic subtest: vcs1
[418.355556] Dynamic subtest vcs1: SUCCESS (0.057s)
[418.367322] Starting dynamic subtest: vecs0
[418.415135] Dynamic subtest vecs0: SUCCESS (0.057s)
[418.427850] Starting dynamic subtest: ccs0
[418.475005] Dynamic subtest ccs0: SUCCESS (0.057s)
[418.477815] Subtest nb-await: SUCCESS (0.371s)
[420.044928] [FACT gem_exec_fence (nb-await)] new: kernel.kmod_is_loaded.vgem: true
[420.048763] [097/133] (602s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[420.137911] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[420.142164] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[420.211151] [098/133] (602s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[420.313220] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[420.317479] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[420.411992] [099/133] (602s left) i915_drm_fdinfo (all-busy-check-all)
[420.461446] Starting subtest: all-busy-check-all
[420.466059] Subtest all-busy-check-all: SKIP (0.003s)
[420.551818] [100/133] (602s left) perf (create-destroy-userspace-config)
[420.643392] Starting subtest: create-destroy-userspace-config
[420.670231] Subtest create-destroy-userspace-config: SUCCESS (0.024s)
[420.715045] [101/133] (602s left) kms_color (degamma)
[420.815486] Starting subtest: degamma
[420.817583] Starting dynamic subtest: pipe-A-eDP-1
[421.542762] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.726s)
[421.553322] Starting dynamic subtest: pipe-B-eDP-1
[422.929022] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.386s)
[422.939169] Starting dynamic subtest: pipe-C-eDP-1
[424.309334] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.379s)
[424.319991] Starting dynamic subtest: pipe-D-eDP-1
[425.648061] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.338s)
[425.649911] Subtest degamma: SUCCESS (4.833s)
[426.438672] [102/133] (596s left) kms_plane_alpha_blend (constant-alpha-mid)
[426.534916] Starting subtest: constant-alpha-mid
[426.823342] Starting dynamic subtest: pipe-A-eDP-1
[427.723971] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.898s)
[427.734256] Starting dynamic subtest: pipe-D-eDP-1
[429.256646] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.533s)
[429.259074] Subtest constant-alpha-mid: SUCCESS (2.725s)
[430.100566] [103/133] (593s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[430.192671] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[430.196668] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[430.267221] [104/133] (592s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[430.317161] Subtest tiled-to-untiled: SKIP (0.000s)
[430.384603] [105/133] (592s left) api_intel_allocator (two-level-inception-interruptible)
[430.448179] Starting subtest: two-level-inception-interruptible
[435.905140] Subtest two-level-inception-interruptible: SUCCESS (5.406s)
[436.003279] [106/133] (587s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[436.132359] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[442.817914] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.690s)
[442.955859] [107/133] (580s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[443.050651] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[443.061902] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.011s)
[443.141139] [108/133] (580s left) gem_mmap_wc (write-read)
[443.204103] Subtest write-read: SKIP (0.000s)
[443.263267] [109/133] (580s left) gem_softpin (allocator-fork)
[443.316523] Starting subtest: allocator-fork
[445.526427] Subtest allocator-fork: SUCCESS (2.209s)
[445.667079] [110/133] (577s left) prime_self_import (reimport-vs-gem_close-race)
[445.702771] Starting subtest: reimport-vs-gem_close-race
[450.819840] Subtest reimport-vs-gem_close-race: SUCCESS (5.097s)
[450.894772] [111/133] (572s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[450.999830] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[451.004436] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[452.153441] [112/133] (571s left) kms_psr (fbc-pr-no-drrs)
[452.249835] Starting subtest: fbc-pr-no-drrs
[452.254354] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[452.328519] [113/133] (571s left) kms_cursor_edge_walk (128x128-left-edge)
[452.419191] Starting subtest: 128x128-left-edge
[452.421535] Starting dynamic subtest: pipe-A-eDP-1
[455.912684] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.494s)
[455.924020] Starting dynamic subtest: pipe-D-eDP-1
[459.039643] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.126s)
[459.042016] Subtest 128x128-left-edge: SUCCESS (6.623s)
[459.838729] [114/133] (563s left) gem_exec_whisper (basic-contexts-forked-all)
[459.914426] Starting subtest: basic-contexts-forked-all
[480.671008] Subtest basic-contexts-forked-all: SUCCESS (20.706s)
[480.801738] [115/133] (542s left) kms_selftest (drm_format_helper)
[480.845072] Starting subtest: drm_format_helper
[480.913681] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[481.022375] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.107s)
[481.033844] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[481.128865] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.104s)
[481.139637] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[481.224321] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.096s)
[481.234281] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[481.326070] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.101s)
[481.335885] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[481.428888] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.103s)
[481.440890] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[481.530762] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.100s)
[481.541023] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[481.635827] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.105s)
[481.646998] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[481.731801] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.094s)
[481.743585] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[481.828962] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.097s)
[481.841287] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[481.928160] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.096s)
[481.939360] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[482.022845] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.095s)
[482.032372] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[482.119827] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.094s)
[482.130903] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[482.214238] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.096s)
[482.223834] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[482.307655] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.092s)
[482.318611] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[482.395235] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.088s)
[482.405057] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[482.489524] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.093s)
[482.499019] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[482.593801] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.102s)
[482.595406] Subtest drm_format_helper: SUCCESS (1.749s)
[482.763376] [116/133] (540s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[482.812442] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[482.814750] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[482.919890] [117/133] (540s left) i915_pm_freq_api (freq-reset-multiple)
[482.986389] Starting subtest: freq-reset-multiple
[482.988819] Starting dynamic subtest: gt0
[492.436271] Dynamic subtest gt0: SUCCESS (9.449s)
[492.447558] Starting dynamic subtest: gt1
[500.699843] Dynamic subtest gt1: SUCCESS (8.265s)
[500.702474] Subtest freq-reset-multiple: SUCCESS (17.716s)
[500.780718] [118/133] (523s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[500.904626] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[500.908961] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[500.999375] [119/133] (522s left) vgem_basic (sysfs)
[501.039377] Starting subtest: sysfs
[501.041557] Subtest sysfs: SUCCESS (0.000s)
[501.097025] [120/133] (522s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[501.203621] Starting subtest: x-tiled-16bpp-rotate-270
[501.227988] Subtest x-tiled-16bpp-rotate-270: SKIP (0.024s)
[501.332267] [121/133] (522s left) kms_flip (blocking-wf_vblank)
[501.412840] Starting subtest: blocking-wf_vblank
[501.417859] Starting dynamic subtest: A-eDP1
[510.410321] Dynamic subtest A-eDP1: SUCCESS (8.963s)
[510.422103] Starting dynamic subtest: B-eDP1
[519.335119] Dynamic subtest B-eDP1: SUCCESS (8.924s)
[519.346094] Starting dynamic subtest: C-eDP1
[528.255748] Dynamic subtest C-eDP1: SUCCESS (8.910s)
[528.266103] Starting dynamic subtest: D-eDP1
[537.180821] Dynamic subtest D-eDP1: SUCCESS (8.924s)
[537.183184] Subtest blocking-wf_vblank: SUCCESS (35.735s)
[538.369215] [122/133] (485s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[538.421894] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[538.424214] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[538.519007] [123/133] (485s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[538.617649] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[538.621962] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[538.759141] [124/133] (485s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[538.852541] Starting subtest: fbc-psr-cursor-mmap-gtt
[538.854721] Starting dynamic subtest: eDP-1
[538.858601] Dynamic subtest eDP-1: SKIP (0.000s)
[538.862436] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[538.951826] [125/133] (485s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[539.059572] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[539.063769] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[539.158669] [126/133] (484s left) gem_wait (invalid-buf)
[539.209900] Starting subtest: invalid-buf
[539.212438] Subtest invalid-buf: SUCCESS (0.000s)
[539.414552] [127/133] (484s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[539.525329] Starting subtest: y-tiled-8bpp-rotate-270
[539.529841] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[539.631167] [128/133] (484s left) gem_exec_fence (concurrent)
[539.809838] Starting subtest: concurrent
[539.814890] Subtest concurrent: SKIP (0.000s)
[542.034251] [129/133] (482s left) kms_chamelium_frames (vga-frame-dump)
[542.423006] Subtest vga-frame-dump: SKIP (0.000s)
[543.265729] [130/133] (481s left) sriov_basic (enable-vfs-autoprobe-off)
[543.332536] Starting subtest: enable-vfs-autoprobe-off
[543.334578] Starting dynamic subtest: numvfs-1
[543.416443] Dynamic subtest numvfs-1: FAIL (0.026s)
[543.427927] Starting dynamic subtest: numvfs-2
[543.500619] Dynamic subtest numvfs-2: FAIL (0.004s)
[543.512542] Starting dynamic subtest: numvfs-3
[543.585014] Dynamic subtest numvfs-3: FAIL (0.004s)
[543.595007] Starting dynamic subtest: numvfs-4
[543.663889] Dynamic subtest numvfs-4: FAIL (0.004s)
[543.674042] Starting dynamic subtest: numvfs-5
[543.742347] Dynamic subtest numvfs-5: FAIL (0.004s)
[543.751825] Starting dynamic subtest: numvfs-6
[543.820450] Dynamic subtest numvfs-6: FAIL (0.004s)
[543.830450] Starting dynamic subtest: numvfs-7
[543.900459] Dynamic subtest numvfs-7: FAIL (0.004s)
[543.910630] Starting dynamic subtest: numvfs-random
[543.982240] Dynamic subtest numvfs-random: FAIL (0.004s)
[543.994533] Starting dynamic subtest: numvfs-all
[544.067797] Dynamic subtest numvfs-all: FAIL (0.499s)
[544.070020] Subtest enable-vfs-autoprobe-off: FAIL (0.559s)
[544.111624] [131/133] (480s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[544.211487] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[544.214818] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[544.309870] [132/133] (480s left) kms_psr (psr-basic)
[544.417378] Starting subtest: psr-basic
[544.419313] Starting dynamic subtest: eDP-1
[546.066749] Dynamic subtest eDP-1: SUCCESS (1.647s)
[546.069019] Subtest psr-basic: SUCCESS (1.648s)
[546.953899] [133/133] (477s left) kms_busy (extended-modeset-hang-newfb)
[547.051896] Starting subtest: extended-modeset-hang-newfb
[547.056763] Starting dynamic subtest: pipe-A
[581.896089] Dynamic subtest pipe-A: SUCCESS (34.850s)
[581.906735] Starting dynamic subtest: pipe-D
[604.874577] Dynamic subtest pipe-D: SUCCESS (22.981s)
[604.876744] Subtest extended-modeset-hang-newfb: SUCCESS (57.837s)
[605.667577] Closing watchdogs
results: parsing output: 0/ for test: kms_plane
results: parsing output: 1/ for test: gem_mmap_offset
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_flip
results: parsing output: 6/ for test: kms_chamelium_audio
results: parsing output: 7/ for test: kms_vblank
results: parsing output: 8/ for test: gem_exec_params
results: parsing output: 9/ for test: kms_chamelium_edid
results: parsing output: 10/ for test: kms_pm_lpsp
results: parsing output: 11/ for test: syncobj_wait
results: parsing output: 12/ for test: gem_userptr_blits
results: parsing output: 13/ for test: dumb_buffer
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: gem_userptr_blits
results: parsing output: 16/ for test: gem_ctx_param
results: parsing output: 17/ for test: gem_exec_params
results: parsing output: 18/ for test: perf
results: parsing output: 19/ for test: perf
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_lmem_swapping
results: parsing output: 23/ for test: gem_tiling_max_stride
results: parsing output: 24/ for test: gem_mmap_gtt
results: parsing output: 25/ for test: gem_exec_schedule
results: parsing output: 26/ for test: kms_cursor_crc
results: parsing output: 27/ for test: kms_pipe_b_c_ivb
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_mmap_wc
results: parsing output: 31/ for test: gem_render_copy
results: parsing output: 32/ for test: kms_dirtyfb
results: parsing output: 33/ for test: kms_cursor_legacy
results: parsing output: 34/ for test: perf
results: parsing output: 35/ for test: gem_exec_schedule
results: parsing output: 36/ for test: kms_flip
results: parsing output: 37/ for test: kms_plane_multiple
results: parsing output: 38/ for test: fbdev
results: parsing output: 39/ for test: sysfs_heartbeat_interval
results: parsing output: 40/ for test: gem_exec_schedule
results: parsing output: 41/ for test: gem_ctx_engines
results: parsing output: 42/ for test: gem_ctx_sseu
results: parsing output: 43/ for test: syncobj_wait
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_ppgtt
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: kms_plane_scaling
results: parsing output: 48/ for test: kms_cursor_legacy
results: parsing output: 49/ for test: kms_feature_discovery
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: gem_softpin
results: parsing output: 52/ for test: gem_tiled_wb
results: parsing output: 53/ for test: intel_hwmon
results: parsing output: 54/ for test: gem_workarounds
results: parsing output: 55/ for test: kms_psr
results: parsing output: 56/ for test: gen9_exec_parse
results: parsing output: 57/ for test: syncobj_wait
results: parsing output: 58/ for test: kms_content_protection
results: parsing output: 59/ for test: perf_pmu
results: parsing output: 60/ for test: kms_ccs
results: parsing output: 61/ for test: kms_flip_scaled_crc
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: i915_suspend
results: parsing output: 64/ for test: kms_invalid_mode
results: parsing output: 65/ for test: gem_lmem_swapping
results: parsing output: 66/ for test: gem_pxp
results: parsing output: 67/ for test: syncobj_wait
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: kms_atomic
results: parsing output: 70/ for test: syncobj_wait
results: parsing output: 71/ for test: kms_pm_rpm
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: api_intel_bb
results: parsing output: 75/ for test: perf
results: parsing output: 76/ for test: kms_lease
results: parsing output: 77/ for test: gem_flink_basic
results: parsing output: 78/ for test: i915_pm_rpm
results: parsing output: 79/ for test: kms_properties
results: parsing output: 80/ for test: kms_psr2_sf
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_mmap_wc
results: parsing output: 83/ for test: perf_pmu
results: parsing output: 84/ for test: kms_psr2_sf
results: parsing output: 85/ for test: kms_ccs
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: syncobj_wait
results: parsing output: 88/ for test: kms_scaling_modes
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: gem_exec_balancer
results: parsing output: 91/ for test: gem_ctx_persistence
results: parsing output: 92/ for test: kms_cursor_crc
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_atomic_transition
results: parsing output: 95/ for test: gem_exec_fence
results: parsing output: 96/ for test: kms_flip_scaled_crc
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: i915_drm_fdinfo
results: parsing output: 99/ for test: perf
results: parsing output: 100/ for test: kms_color
results: parsing output: 101/ for test: kms_plane_alpha_blend
results: parsing output: 102/ for test: kms_plane
results: parsing output: 103/ for test: gem_set_tiling_vs_blt
results: parsing output: 104/ for test: api_intel_allocator
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_flip
results: parsing output: 107/ for test: gem_mmap_wc
results: parsing output: 108/ for test: gem_softpin
results: parsing output: 109/ for test: prime_self_import
results: parsing output: 110/ for test: kms_ccs
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: kms_cursor_edge_walk
results: parsing output: 113/ for test: gem_exec_whisper
results: parsing output: 114/ for test: kms_selftest
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: i915_pm_freq_api
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: vgem_basic
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: kms_flip
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_wait
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: gem_exec_fence
results: parsing output: 128/ for test: kms_chamelium_frames
results: parsing output: 129/ for test: sriov_basic
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_psr
results: parsing output: 132/ for test: kms_busy
Done.