[37.784086] Initializing watchdogs [37.784123] /dev/watchdog0 [37.790434] [001/130] (960s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted) [37.889725] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted [37.891584] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s) [37.950350] [002/130] (960s left) kms_chamelium_frames (hdmi-aspect-ratio) [38.325169] Subtest hdmi-aspect-ratio: SKIP (0.000s) [39.157306] [003/130] (959s left) gem_exec_reloc (basic-gtt-wc) [39.209676] Subtest basic-gtt-wc: SKIP (0.000s) [39.253817] [004/130] (959s left) kms_vblank (invalid) [39.336708] Starting subtest: invalid [39.338968] Starting dynamic subtest: pipe-A-eDP-1 [39.723072] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.385s) [39.726032] Subtest invalid: SUCCESS (0.385s) [40.582973] [005/130] (957s left) gem_exec_reloc (basic-cpu-read) [40.635700] Subtest basic-cpu-read: SKIP (0.000s) [40.675989] [006/130] (957s left) kms_pm_dc (dc9-dpms) [40.760570] Starting subtest: dc9-dpms [42.143558] Subtest dc9-dpms: SUCCESS (1.382s) [42.199386] [007/130] (956s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25) [42.280771] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25 [42.283139] Starting dynamic subtest: pipe-A [42.292353] Dynamic subtest pipe-A: SKIP (0.004s) [42.297984] Starting dynamic subtest: pipe-B [42.306789] Dynamic subtest pipe-B: SKIP (0.016s) [42.311701] Starting dynamic subtest: pipe-C [42.320526] Dynamic subtest pipe-C: SKIP (0.016s) [42.325371] Starting dynamic subtest: pipe-D [42.337664] Dynamic subtest pipe-D: SKIP (0.016s) [42.341345] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.052s) [42.395548] [008/130] (955s left) perf (non-sampling-read-error) [42.512257] Starting subtest: non-sampling-read-error [42.523739] Subtest non-sampling-read-error: SUCCESS (0.012s) [42.547893] [009/130] (955s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu) [42.649468] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu [42.653724] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [42.718028] [010/130] (955s left) gem_exec_schedule (submit-golden-slice) [42.778670] Starting subtest: submit-golden-slice [42.781053] Starting dynamic subtest: rcs0 [42.810055] Dynamic subtest rcs0: SUCCESS (0.037s) [42.819044] Starting dynamic subtest: bcs0 [42.832909] Dynamic subtest bcs0: SUCCESS (0.024s) [42.839904] Starting dynamic subtest: vcs0 [42.857777] Dynamic subtest vcs0: SUCCESS (0.024s) [42.863714] Starting dynamic subtest: vcs1 [42.881170] Dynamic subtest vcs1: SUCCESS (0.024s) [42.886822] Starting dynamic subtest: vecs0 [42.903435] Dynamic subtest vecs0: SUCCESS (0.022s) [42.908787] Starting dynamic subtest: ccs0 [42.929574] Dynamic subtest ccs0: SUCCESS (0.026s) [42.931857] Subtest submit-golden-slice: SUCCESS (0.157s) [44.463994] [011/130] (953s left) gem_set_tiling_vs_gtt [44.548519] [012/130] (953s left) intel_hwmon (hwmon-write) [44.602838] Subtest hwmon-write: SKIP (0.000s) [44.637507] [013/130] (953s left) gem_mmap_gtt (medium-copy-xy) [44.680358] Subtest medium-copy-XY: SKIP (0.000s) [44.705120] [014/130] (953s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt) [44.800602] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt [47.981317] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (3.150s) [48.098501] [015/130] (950s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite) [48.187622] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite [48.191936] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [48.254698] [016/130] (950s left) kms_rotation_crc (primary-4-tiled-reflect-x-0) [48.333518] Starting subtest: primary-4-tiled-reflect-x-0 [55.385416] Subtest primary-4-tiled-reflect-x-0: SUCCESS (6.967s) [56.588660] [017/130] (942s left) kms_lease (atomic-implicit-crtc) [56.669842] Starting subtest: atomic-implicit-crtc [56.672203] Starting dynamic subtest: pipe-A-eDP-1 [56.685161] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [56.691246] Starting dynamic subtest: pipe-B-eDP-1 [56.703406] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s) [56.708930] Starting dynamic subtest: pipe-C-eDP-1 [56.720432] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s) [56.726074] Starting dynamic subtest: pipe-D-eDP-1 [56.737633] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.006s) [56.739978] Subtest atomic-implicit-crtc: SUCCESS (0.021s) [56.788278] [018/130] (941s left) gem_create (hog-create) [56.841113] Starting subtest: hog-create [56.843430] Starting dynamic subtest: smem0 [89.391423] Dynamic subtest smem0: SUCCESS (32.502s) [89.393886] Subtest hog-create: SUCCESS (32.503s) [89.549995] [019/130] (909s left) kms_chamelium_hpd (dp-hpd-storm-disable) [89.926392] Subtest dp-hpd-storm-disable: SKIP (0.000s) [90.805301] [020/130] (907s left) kms_flip (wf_vblank-ts-check-interruptible) [90.891044] Starting subtest: wf_vblank-ts-check-interruptible [90.895855] Starting dynamic subtest: A-eDP1 [99.911307] Dynamic subtest A-eDP1: SUCCESS (9.016s) [99.918155] Starting dynamic subtest: B-eDP1 [108.871037] Dynamic subtest B-eDP1: SUCCESS (8.958s) [108.878915] Starting dynamic subtest: C-eDP1 [117.818169] Dynamic subtest C-eDP1: SUCCESS (8.946s) [117.823767] Starting dynamic subtest: D-eDP1 [126.779486] Dynamic subtest D-eDP1: SUCCESS (8.960s) [126.784305] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.888s) [128.005866] [021/130] (870s left) syncobj_timeline (invalid-wait-illegal-handle) [128.051292] Starting subtest: invalid-wait-illegal-handle [128.053617] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s) [128.105361] [022/130] (870s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt) [128.200511] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt [133.032788] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (4.836s) [133.141614] [023/130] (865s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers) [133.226739] Starting subtest: plane-upscale-factor-0-25-with-modifiers [133.229106] Starting dynamic subtest: pipe-A [133.564848] Dynamic subtest pipe-A: SUCCESS (0.338s) [133.571687] Starting dynamic subtest: pipe-B [135.014847] Dynamic subtest pipe-B: SUCCESS (1.450s) [135.022150] Starting dynamic subtest: pipe-C [136.488728] Dynamic subtest pipe-C: SUCCESS (1.473s) [136.495630] Starting dynamic subtest: pipe-D [137.957173] Dynamic subtest pipe-D: SUCCESS (1.469s) [137.959437] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.730s) [139.141915] [024/130] (859s left) kms_cdclk (mode-transition-all-outputs) [139.219783] Starting subtest: mode-transition-all-outputs [139.507666] Subtest mode-transition-all-outputs: SKIP (0.282s) [140.358421] [025/130] (858s left) gem_exec_schedule (manyslice) [140.424656] Starting subtest: manyslice [140.426882] Starting dynamic subtest: rcs0 [144.549197] Dynamic subtest rcs0: SUCCESS (4.133s) [144.557300] Starting dynamic subtest: bcs0 [150.164118] Dynamic subtest bcs0: SUCCESS (5.615s) [150.171600] Starting dynamic subtest: vcs0 [154.234440] Dynamic subtest vcs0: SUCCESS (4.070s) [154.242403] Starting dynamic subtest: vcs1 [159.293524] Dynamic subtest vcs1: SUCCESS (5.058s) [159.304205] Starting dynamic subtest: vecs0 [164.349379] Dynamic subtest vecs0: SUCCESS (5.055s) [164.357312] Starting dynamic subtest: ccs0 [170.006495] Dynamic subtest ccs0: SUCCESS (5.657s) [170.009635] Subtest manyslice: SUCCESS (29.590s) [170.286288] [026/130] (828s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render) [170.385777] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render [170.389807] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [170.452641] [027/130] (828s left) gem_userptr_blits (huge-split) [170.504880] Starting subtest: huge-split [170.513034] Subtest huge-split: SUCCESS (0.008s) [170.603701] [028/130] (828s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt) [170.702562] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt [175.655041] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.956s) [175.775022] [029/130] (823s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted) [175.819789] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted [175.922492] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.103s) [175.974616] [030/130] (822s left) syncobj_timeline (wait-all-for-submit-delayed-submit) [176.025535] Starting subtest: wait-all-for-submit-delayed-submit [176.126741] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s) [176.181819] [031/130] (822s left) gem_exec_whisper (basic-sync-all) [176.230449] Starting subtest: basic-sync-all [183.304120] Subtest basic-sync-all: SUCCESS (7.071s) [183.458223] [032/130] (815s left) gem_render_copy (y-tiled-to-vebox-x-tiled) [183.502945] Starting subtest: y-tiled-to-vebox-x-tiled [183.507162] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s) [183.660070] [033/130] (815s left) kms_vrr (seamless-rr-switch-vrr) [183.751877] Starting subtest: seamless-rr-switch-vrr [183.758680] Subtest seamless-rr-switch-vrr: SKIP (0.000s) [183.800137] [034/130] (815s left) kms_cursor_crc (cursor-sliding-512x512) [184.012764] Starting subtest: cursor-sliding-512x512 [184.017225] Subtest cursor-sliding-512x512: SKIP (0.001s) [184.139018] [035/130] (814s left) perf_pmu (module-unload) [184.226834] Starting subtest: module-unload [222.310665] Subtest module-unload: SUCCESS (38.081s) [222.324169] [036/130] (776s left) syncobj_wait (multi-wait-for-submit-submitted) [223.811778] Starting subtest: multi-wait-for-submit-submitted [223.912955] Subtest multi-wait-for-submit-submitted: SUCCESS (0.103s) [223.941702] [037/130] (775s left) gem_caching (reads) [223.994231] Subtest reads: SKIP (0.000s) [224.030928] [038/130] (774s left) syncobj_wait (invalid-reset-zero-handles) [224.081210] Starting subtest: invalid-reset-zero-handles [224.083475] Subtest invalid-reset-zero-handles: SUCCESS (0.000s) [224.141710] [039/130] (774s left) gem_exec_fence (basic-wait-all) [224.191421] Starting subtest: basic-wait-all [224.282987] Subtest basic-wait-all: SUCCESS (0.095s) [226.382557] [040/130] (772s left) syncobj_basic (bad-destroy) [226.434902] Starting subtest: bad-destroy [226.437790] Subtest bad-destroy: SUCCESS (0.000s) [226.486767] [041/130] (772s left) sw_sync (sync_merge_invalid) [226.518805] Starting subtest: sync_merge_invalid [226.538400] Subtest sync_merge_invalid: SUCCESS (0.019s) [226.576130] [042/130] (772s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf) [231.725452] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf [231.730195] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.002s) [232.584920] [043/130] (766s left) kms_color (invalid-gamma-lut-sizes) [232.667871] Starting subtest: invalid-gamma-lut-sizes [232.670288] Starting dynamic subtest: pipe-A [232.949465] Dynamic subtest pipe-A: SUCCESS (0.280s) [232.958022] Starting dynamic subtest: pipe-B [232.960888] Dynamic subtest pipe-B: SUCCESS (0.001s) [232.966846] Starting dynamic subtest: pipe-C [232.969385] Dynamic subtest pipe-C: SUCCESS (0.001s) [232.975433] Starting dynamic subtest: pipe-D [232.978023] Dynamic subtest pipe-D: SUCCESS (0.001s) [232.980395] Subtest invalid-gamma-lut-sizes: SUCCESS (0.284s) [233.864036] [044/130] (765s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions) [233.985064] Starting subtest: cursor-vs-flip-atomic-transitions [262.966382] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (28.980s) [263.882062] [045/130] (735s left) kms_big_fb (linear-8bpp-rotate-180) [263.975047] Starting subtest: linear-8bpp-rotate-180 [264.939662] Subtest linear-8bpp-rotate-180: SUCCESS (0.967s) [265.049083] [046/130] (734s left) kms_addfb_basic (clobberred-modifier) [265.099839] Starting subtest: clobberred-modifier [265.104385] Subtest clobberred-modifier: SKIP (0.000s) [265.229604] [047/130] (733s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu) [265.318871] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu [269.934948] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.617s) [270.010650] [048/130] (729s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move) [270.112739] Starting subtest: psr-1p-primscrn-spr-indfb-move [275.413059] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (5.304s) [275.512182] [049/130] (723s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf) [280.650484] Starting subtest: fbc-psr2-cursor-plane-update-sf [280.653302] Starting dynamic subtest: pipe-A-eDP-1 [281.516820] Dynamic subtest pipe-A-eDP-1: SKIP (0.860s) [281.525393] Starting dynamic subtest: pipe-B-eDP-1 [282.733950] Dynamic subtest pipe-B-eDP-1: SKIP (1.218s) [282.738200] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (2.083s) [283.976481] [050/130] (715s left) gem_bad_reloc (negative-reloc-bltcopy) [284.036542] Subtest negative-reloc-bltcopy: SKIP (0.000s) [284.074317] [051/130] (715s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render) [284.163898] Starting subtest: psr-rgb101010-draw-render [289.017601] Subtest psr-rgb101010-draw-render: SUCCESS (4.858s) [289.117844] [052/130] (710s left) kms_prop_blob (blob-prop-core) [289.159354] Starting subtest: blob-prop-core [289.162128] Subtest blob-prop-core: SUCCESS (0.000s) [289.220520] [053/130] (709s left) perf (i915-ref-count) [289.280429] Starting subtest: i915-ref-count [289.329236] Subtest i915-ref-count: SUCCESS (0.046s) [289.362195] [054/130] (709s left) kms_content_protection (legacy) [289.490633] Starting subtest: legacy [293.499430] Subtest legacy: SKIP (4.006s) [294.731780] [055/130] (704s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc) [294.825263] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc [294.830024] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [294.894712] [056/130] (704s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs) [294.991095] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs [294.993451] Starting dynamic subtest: pipe-A-eDP-1 [295.018257] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [295.026266] Starting dynamic subtest: pipe-B-eDP-1 [295.047389] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [295.054101] Starting dynamic subtest: pipe-C-eDP-1 [295.075875] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [295.082404] Starting dynamic subtest: pipe-D-eDP-1 [295.104853] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [295.108998] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.003s) [297.349818] [057/130] (701s left) gem_mmap_gtt (basic-read) [297.401444] Subtest basic-read: SKIP (0.000s) [297.425536] [058/130] (701s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt) [297.513660] Starting subtest: fbcpsr-rgb101010-draw-blt [302.278385] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (4.768s) [302.365505] [059/130] (696s left) syncobj_wait (single-wait-all-submitted) [302.406059] Starting subtest: single-wait-all-submitted [302.507138] Subtest single-wait-all-submitted: SUCCESS (0.102s) [302.558912] [060/130] (696s left) gem_exec_suspend (basic-s3-devices) [302.608987] Starting subtest: basic-S3-devices [302.611142] Starting dynamic subtest: smem [314.343928] Dynamic subtest smem: SUCCESS (11.732s) [314.347287] Subtest basic-S3-devices: SUCCESS (11.733s) [314.502804] [061/130] (684s left) gem_pxp (verify-pxp-stale-ctx-execution) [317.084352] Subtest verify-pxp-stale-ctx-execution: SKIP (0.000s) [317.130257] [062/130] (682s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling) [317.215040] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling [317.217436] Starting dynamic subtest: pipe-A-default-mode [319.987110] Dynamic subtest pipe-A-default-mode: SUCCESS (2.769s) [319.989180] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.770s) [320.905383] [063/130] (678s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs) [321.000873] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs [321.003232] Starting dynamic subtest: pipe-A-eDP-1 [321.025930] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [321.032217] Starting dynamic subtest: pipe-B-eDP-1 [321.054183] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [321.060530] Starting dynamic subtest: pipe-C-eDP-1 [321.082536] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [321.088921] Starting dynamic subtest: pipe-D-eDP-1 [321.111278] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [321.115719] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.003s) [323.337199] [064/130] (676s left) dmabuf_sync_file (import-multiple-read-only) [323.370357] Starting subtest: import-multiple-read-only [323.373212] Subtest import-multiple-read-only: SUCCESS (0.004s) [323.403726] [065/130] (675s left) gen9_exec_parse (unaligned-access) [323.463037] Subtest unaligned-access: SKIP (0.000s) [323.501327] [066/130] (675s left) gem_exec_flush (basic-uc-ro-default) [323.554839] Starting subtest: basic-uc-ro-default [328.981560] Subtest basic-uc-ro-default: SUCCESS (5.420s) [329.135984] [067/130] (670s left) perf_pmu (rc6) [329.169397] Starting subtest: rc6 [329.171243] Starting dynamic subtest: gt0 [335.531974] Dynamic subtest gt0: SUCCESS (6.361s) [335.542224] Starting dynamic subtest: runtime-pm-gt0 [343.252929] Dynamic subtest runtime-pm-gt0: SUCCESS (7.719s) [343.263312] Starting dynamic subtest: runtime-pm-long-gt0 [355.680762] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.427s) [355.692269] Starting dynamic subtest: other-idle-gt0 [362.024552] Dynamic subtest other-idle-gt0: SUCCESS (6.342s) [362.034377] Starting dynamic subtest: gt1 [368.366897] Dynamic subtest gt1: SUCCESS (6.340s) [368.377432] Starting dynamic subtest: runtime-pm-gt1 [375.802858] Dynamic subtest runtime-pm-gt1: SUCCESS (7.435s) [375.813391] Starting dynamic subtest: runtime-pm-long-gt1 [388.253627] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.449s) [388.262268] Starting dynamic subtest: other-idle-gt1 [394.597261] Dynamic subtest other-idle-gt1: SUCCESS (6.342s) [394.600088] Subtest rc6: SUCCESS (65.425s) [395.695524] [068/130] (603s left) kms_big_fb (4-tiled-8bpp-rotate-180) [395.791800] Starting subtest: 4-tiled-8bpp-rotate-180 [396.723786] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (0.934s) [396.807199] [069/130] (602s left) gem_ctx_param (invalid-get-no-zeromap) [396.851240] Starting subtest: invalid-get-no-zeromap [396.853636] Subtest invalid-get-no-zeromap: SUCCESS (0.001s) [396.928529] [070/130] (602s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling) [397.018163] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling [397.020495] Starting dynamic subtest: pipe-A-default-mode [397.307925] Dynamic subtest pipe-A-default-mode: SKIP (0.284s) [397.313179] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.286s) [398.199472] [071/130] (601s left) kms_vblank (wait-forked-busy) [398.287850] Starting subtest: wait-forked-busy [398.290183] Starting dynamic subtest: pipe-A-eDP-1 [400.164423] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s) [400.178536] Starting dynamic subtest: pipe-D-eDP-1 [402.789964] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.622s) [402.792637] Subtest wait-forked-busy: SUCCESS (4.501s) [403.641429] [072/130] (595s left) kms_plane_alpha_blend (alpha-transparent-fb) [403.725812] Starting subtest: alpha-transparent-fb [403.996816] Starting dynamic subtest: pipe-A-eDP-1 [404.563048] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.564s) [404.571062] Starting dynamic subtest: pipe-D-eDP-1 [405.954133] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.391s) [405.956888] Subtest alpha-transparent-fb: SUCCESS (2.227s) [406.838214] [073/130] (592s left) kms_invalid_mode (clock-too-high) [406.940959] Starting subtest: clock-too-high [406.943256] Starting dynamic subtest: pipe-A-eDP-1 [406.947537] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [406.954339] Starting dynamic subtest: pipe-B-eDP-1 [406.958806] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [406.965054] Starting dynamic subtest: pipe-C-eDP-1 [406.969188] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [406.975182] Starting dynamic subtest: pipe-D-eDP-1 [406.979312] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [406.983467] Subtest clock-too-high: SKIP (0.003s) [406.996877] [074/130] (592s left) drm_fdinfo (memory-info-idle) [407.027149] Starting subtest: memory-info-idle [407.029631] Starting dynamic subtest: smem0 [407.077929] Dynamic subtest smem0: SUCCESS (0.049s) [407.080181] Subtest memory-info-idle: SUCCESS (0.050s) [407.104204] [075/130] (592s left) gem_softpin (full) [407.151073] Starting subtest: full [407.157422] Subtest full: SUCCESS (0.006s) [407.235710] [076/130] (592s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs) [407.312842] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs [407.315153] Starting dynamic subtest: pipe-A-eDP-1 [407.335570] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [407.344075] Starting dynamic subtest: pipe-B-eDP-1 [407.364861] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [407.371392] Starting dynamic subtest: pipe-C-eDP-1 [407.391155] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [407.397227] Starting dynamic subtest: pipe-D-eDP-1 [407.417291] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [407.419222] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.004s) [409.655265] [077/130] (589s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area) [414.756260] Starting subtest: psr2-overlay-primary-update-sf-dmg-area [414.758572] Starting dynamic subtest: pipe-A-eDP-1 [421.488329] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.727s) [421.497928] Starting dynamic subtest: pipe-B-eDP-1 [428.213502] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.727s) [428.216177] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (13.457s) [429.109391] [078/130] (570s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt) [429.210599] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt [429.215193] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [429.256325] [079/130] (570s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt) [429.354424] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt [429.358617] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [429.413406] [080/130] (570s left) kms_big_fb (4-tiled-16bpp-rotate-180) [429.509479] Starting subtest: 4-tiled-16bpp-rotate-180 [430.527823] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.021s) [430.596236] [081/130] (569s left) gem_linear_blits (normal) [431.056267] Starting subtest: normal [433.473894] Subtest normal: SUCCESS (2.417s) [433.564676] [082/130] (566s left) gem_busy (parallel) [433.770751] Starting subtest: parallel [433.773631] Starting dynamic subtest: rcs0 [435.368059] Dynamic subtest rcs0: SUCCESS (1.595s) [435.379904] Starting dynamic subtest: bcs0 [437.351701] Dynamic subtest bcs0: SUCCESS (1.983s) [437.362818] Starting dynamic subtest: vcs0 [439.399550] Dynamic subtest vcs0: SUCCESS (2.046s) [439.409626] Starting dynamic subtest: vcs1 [441.383574] Dynamic subtest vcs1: SUCCESS (1.983s) [441.394393] Starting dynamic subtest: vecs0 [443.367457] Dynamic subtest vecs0: SUCCESS (1.983s) [443.378462] Starting dynamic subtest: ccs0 [445.351756] Dynamic subtest ccs0: SUCCESS (1.982s) [445.355271] Subtest parallel: SUCCESS (11.579s) [445.515715] [083/130] (554s left) perf (non-system-wide-paranoid) [445.597693] Starting subtest: non-system-wide-paranoid [445.621066] Subtest non-system-wide-paranoid: SUCCESS (0.024s) [445.648895] [084/130] (554s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset) [445.745116] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset [445.759677] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.014s) [445.789437] [085/130] (553s left) gem_render_copy (y-tiled-ccs-to-y-tiled) [445.837596] Starting subtest: y-tiled-ccs-to-y-tiled [445.841836] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s) [445.974845] [086/130] (553s left) kms_plane (planar-pixel-format-settings) [446.057238] Starting subtest: planar-pixel-format-settings [446.082766] Subtest planar-pixel-format-settings: SUCCESS (0.025s) [446.125395] [087/130] (553s left) kms_busy (extended-modeset-hang-newfb-with-reset) [446.226923] Starting subtest: extended-modeset-hang-newfb-with-reset [446.229266] Starting dynamic subtest: pipe-A [461.765167] Dynamic subtest pipe-A: SUCCESS (15.535s) [461.773753] Starting dynamic subtest: pipe-D [477.380336] Dynamic subtest pipe-D: SUCCESS (15.612s) [477.382824] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (31.151s) [478.263053] [088/130] (521s left) i915_selftest (live) [481.695467] Starting subtest: live [481.698450] Starting dynamic subtest: sanitycheck [484.174187] Dynamic subtest sanitycheck: SUCCESS (2.479s) [484.183916] Starting dynamic subtest: uncore [486.460046] Dynamic subtest uncore: SUCCESS (2.285s) [486.468331] Starting dynamic subtest: workarounds [492.677712] Warning: kernel log ringbuffer underflow, some records lost. [510.175223] Dynamic subtest workarounds: FAIL (23.567s) [510.178882] Subtest live: FAIL (28.334s) [510.183396] Killing the test because the kernel is tainted. [510.188997] Aborting: Kernel badly tainted (0x240, 0x200) (check dmesg for details): TAINT_WARN: WARN_ON has happened. [510.191194] Closing watchdogs