[40.713664] Initializing watchdogs
[40.713703]   /dev/watchdog0
[40.723213] [001/130] (960s left) gem_caching (writes)
[40.790109] Starting subtest: writes
[43.827735] Subtest writes: SUCCESS (3.029s)
[43.973891] [002/130] (957s left) sriov_basic (bind-unbind-vf)
[44.041076] Subtest bind-unbind-vf: SKIP (0.000s)
[44.070838] [003/130] (957s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[44.275374] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[44.277425] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[44.348065] [004/130] (956s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[44.554092] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[44.555021] Starting dynamic subtest: pipe-A-DP-3
[44.578600] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[44.583884] Starting dynamic subtest: pipe-B-DP-3
[44.610192] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[44.616190] Starting dynamic subtest: pipe-C-DP-3
[44.641969] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[44.654052] Starting dynamic subtest: pipe-D-DP-3
[44.688146] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[44.691212] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SKIP (0.008s)
[44.712447] [005/130] (956s left) gem_mmap (bad-offset)
[44.804231] Subtest bad-offset: SKIP (0.000s)
[44.843735] [006/130] (956s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[45.038479] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[45.040362] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[45.129668] [007/130] (956s left) gem_exec_reloc (basic-wc-active)
[45.227084] Subtest basic-wc-active: SKIP (0.000s)
[45.265661] [008/130] (956s left) kms_psr (psr2-cursor-plane-onoff)
[45.466273] Subtest psr2-cursor-plane-onoff: SKIP (0.000s)
[45.481340] [009/130] (955s left) api_intel_bb (render-ccs)
[45.530901] Starting subtest: render-ccs
[45.608051] Subtest render-ccs: SUCCESS (0.077s)
[45.725113] [010/130] (955s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[45.905707] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[45.923564] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.017s)
[45.974589] [011/130] (955s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[46.163073] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.000s)
[46.188029] [012/130] (955s left) kms_psr (pr-cursor-plane-onoff)
[46.365369] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[46.389803] [013/130] (955s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[46.453056] Subtest writes-after-reads: SKIP (0.000s)
[46.493357] [014/130] (954s left) syncobj_timeline (etime-multi-wait-submitted)
[46.566986] Starting subtest: etime-multi-wait-submitted
[46.670855] Subtest etime-multi-wait-submitted: SUCCESS (0.102s)
[46.749562] [015/130] (954s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[46.800989] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[46.801939] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[46.894878] [016/130] (954s left) kms_plane_scaling (planes-upscale-factor-0-25)
[47.086012] Starting subtest: planes-upscale-factor-0-25
[47.086873] Starting dynamic subtest: pipe-A
[59.071396] Dynamic subtest pipe-A: SUCCESS (11.940s)
[59.084658] Starting dynamic subtest: pipe-B
[70.615857] Dynamic subtest pipe-B: SUCCESS (11.536s)
[70.631131] Starting dynamic subtest: pipe-C
[82.065157] Dynamic subtest pipe-C: SUCCESS (11.447s)
[82.072654] Starting dynamic subtest: pipe-D
[93.371779] Dynamic subtest pipe-D: SUCCESS (11.304s)
[93.372706] Subtest planes-upscale-factor-0-25: SUCCESS (46.230s)
[93.650440] [017/130] (907s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[93.902786] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[93.904732] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[93.985805] [018/130] (907s left) gem_softpin (allocator-fork)
[94.062041] Starting subtest: allocator-fork
[96.303871] Subtest allocator-fork: SUCCESS (2.242s)
[96.449114] [019/130] (905s left) gem_mmap_gtt (flink-race)
[96.549438] Subtest flink-race: SKIP (0.000s)
[96.591234] [020/130] (905s left) gem_exec_schedule (u-fairslice)
[96.656928] Starting subtest: u-fairslice
[96.657679] Starting dynamic subtest: rcs0
[98.694940] Dynamic subtest rcs0: SUCCESS (2.037s)
[98.700377] Starting dynamic subtest: bcs0
[100.709939] Dynamic subtest bcs0: SUCCESS (2.014s)
[100.715625] Starting dynamic subtest: vcs0
[102.728265] Dynamic subtest vcs0: SUCCESS (2.018s)
[102.734263] Starting dynamic subtest: vcs1
[104.744067] Dynamic subtest vcs1: SUCCESS (2.014s)
[104.749898] Starting dynamic subtest: vecs0
[106.759075] Dynamic subtest vecs0: SUCCESS (2.014s)
[106.764793] Starting dynamic subtest: vecs1
[108.775226] Dynamic subtest vecs1: SUCCESS (2.016s)
[108.781120] Starting dynamic subtest: ccs0
[110.789295] Dynamic subtest ccs0: SUCCESS (2.013s)
[110.790291] Subtest u-fairslice: SUCCESS (14.131s)
[111.135474] [021/130] (890s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[111.325378] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[111.327449] Starting dynamic subtest: pipe-A-valid-mode
[113.153955] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.826s)
[113.155383] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (1.828s)
[113.381895] [022/130] (888s left) gem_exec_reloc (basic-scanout)
[113.476990] Subtest basic-scanout: SKIP (0.000s)
[113.513477] [023/130] (888s left) gem_exec_fence (submit)
[113.690803] Starting subtest: submit
[113.692875] Subtest submit: SKIP (0.000s)
[114.390838] [024/130] (887s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[114.582783] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[114.584726] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[114.661607] [025/130] (887s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[114.950152] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[115.066433] [026/130] (886s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[115.257259] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[115.259418] Starting dynamic subtest: pipe-A-DP-3
[115.267242] Dynamic subtest pipe-A-DP-3: SUCCESS (0.001s)
[115.272746] Starting dynamic subtest: pipe-B-DP-3
[115.280985] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[115.286329] Starting dynamic subtest: pipe-C-DP-3
[115.295189] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[115.301065] Starting dynamic subtest: pipe-D-DP-3
[115.308111] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[115.308885] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SUCCESS (0.009s)
[115.355422] [027/130] (886s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[115.569861] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[115.571534] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[115.636730] [028/130] (886s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[115.847297] Starting subtest: disable-crc-after-crtc
[115.849451] Starting dynamic subtest: pipe-A-DP-3
[116.552274] Dynamic subtest pipe-A-DP-3: SUCCESS (0.702s)
[116.566981] Starting dynamic subtest: pipe-B-DP-3
[117.173056] Dynamic subtest pipe-B-DP-3: SUCCESS (0.618s)
[117.180571] Starting dynamic subtest: pipe-C-DP-3
[117.781113] Dynamic subtest pipe-C-DP-3: SUCCESS (0.606s)
[117.788645] Starting dynamic subtest: pipe-D-DP-3
[118.435109] Dynamic subtest pipe-D-DP-3: SUCCESS (0.653s)
[118.435972] Subtest disable-crc-after-crtc: SUCCESS (2.588s)
[118.649772] [029/130] (883s left) kms_psr (psr-cursor-blt)
[118.868012] Subtest psr-cursor-blt: SKIP (0.000s)
[118.890089] [030/130] (883s left) kms_invalid_mode (zero-vdisplay)
[119.073956] Starting subtest: zero-vdisplay
[119.074857] Starting dynamic subtest: pipe-A-DP-3
[119.159265] Dynamic subtest pipe-A-DP-3: SUCCESS (0.084s)
[119.168213] Starting dynamic subtest: pipe-B-DP-3
[119.169153] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[119.177838] Starting dynamic subtest: pipe-C-DP-3
[119.178736] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[119.187439] Starting dynamic subtest: pipe-D-DP-3
[119.188417] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[119.189515] Subtest zero-vdisplay: SUCCESS (0.094s)
[119.355506] [031/130] (882s left) gem_ctx_isolation (dirty-create)
[119.457301] Starting subtest: dirty-create
[119.458191] Starting dynamic subtest: rcs0
[119.913935] Dynamic subtest rcs0: SUCCESS (0.457s)
[119.920013] Starting dynamic subtest: bcs0
[120.355382] Dynamic subtest bcs0: SUCCESS (0.441s)
[120.361178] Starting dynamic subtest: vcs0
[120.816540] Dynamic subtest vcs0: SUCCESS (0.460s)
[120.822308] Starting dynamic subtest: vcs1
[121.279997] Dynamic subtest vcs1: SUCCESS (0.463s)
[121.286025] Starting dynamic subtest: vecs0
[121.744943] Dynamic subtest vecs0: SUCCESS (0.464s)
[121.750819] Starting dynamic subtest: vecs1
[122.208939] Dynamic subtest vecs1: SUCCESS (0.463s)
[122.214666] Starting dynamic subtest: ccs0
[122.676798] Dynamic subtest ccs0: SUCCESS (0.467s)
[122.677719] Subtest dirty-create: SUCCESS (3.220s)
[122.934404] [032/130] (879s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[123.150589] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[123.152212] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[123.255485] [033/130] (878s left) gem_eio (in-flight-1us)
[123.511706] Starting subtest: in-flight-1us
[128.440315] Subtest in-flight-1us: SUCCESS (4.929s)
[128.620699] [034/130] (873s left) kms_cursor_crc (cursor-sliding-max-size)
[129.023901] Starting subtest: cursor-sliding-max-size
[129.026369] Subtest cursor-sliding-max-size: SKIP (0.000s)
[129.212557] [035/130] (872s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[129.432727] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[129.434531] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[129.543279] [036/130] (872s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[129.765977] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[132.624341] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (2.859s)
[132.758441] [037/130] (869s left) kms_color (legacy-gamma)
[132.938247] Starting subtest: legacy-gamma
[132.940255] Starting dynamic subtest: pipe-A-DP-3
[133.586814] Dynamic subtest pipe-A-DP-3: SUCCESS (0.647s)
[133.597697] Starting dynamic subtest: pipe-B-DP-3
[134.169128] Dynamic subtest pipe-B-DP-3: SUCCESS (0.579s)
[134.179032] Starting dynamic subtest: pipe-C-DP-3
[134.783845] Dynamic subtest pipe-C-DP-3: SUCCESS (0.612s)
[134.793790] Starting dynamic subtest: pipe-D-DP-3
[135.368950] Dynamic subtest pipe-D-DP-3: SUCCESS (0.582s)
[135.370078] Subtest legacy-gamma: SUCCESS (2.431s)
[135.603538] [038/130] (866s left) kms_addfb_basic (invalid-set-prop-any)
[135.689256] Starting subtest: invalid-set-prop-any
[135.690153] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[135.912677] [039/130] (866s left) kms_pm_rpm (system-suspend-modeset)
[138.482344] Starting subtest: system-suspend-modeset
[158.661577] Subtest system-suspend-modeset: SUCCESS (5.179s)
[161.005522] [040/130] (858s left) kms_vblank (wait-forked-hang)
[161.203109] Starting subtest: wait-forked-hang
[161.205211] Starting dynamic subtest: pipe-A-DP-3
[163.554118] Dynamic subtest pipe-A-DP-3: SUCCESS (2.349s)
[163.574136] Starting dynamic subtest: pipe-D-DP-3
[165.889338] Dynamic subtest pipe-D-DP-3: SUCCESS (2.329s)
[165.890269] Subtest wait-forked-hang: SUCCESS (4.686s)
[166.148098] [041/130] (853s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[166.346345] Starting subtest: yf-tiled-64bpp-rotate-270
[166.348024] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[166.414915] [042/130] (852s left) kms_plane_scaling (plane-downscale-factor-0-25-with-rotation)
[166.603121] Starting subtest: plane-downscale-factor-0-25-with-rotation
[166.603998] Starting dynamic subtest: pipe-A
[167.154250] Dynamic subtest pipe-A: SKIP (0.549s)
[167.162149] Starting dynamic subtest: pipe-B
[168.303336] Dynamic subtest pipe-B: SKIP (1.147s)
[168.311163] Starting dynamic subtest: pipe-C
[169.436052] Dynamic subtest pipe-C: SKIP (1.134s)
[169.444002] Starting dynamic subtest: pipe-D
[170.569754] Dynamic subtest pipe-D: SKIP (1.133s)
[170.571217] Subtest plane-downscale-factor-0-25-with-rotation: SKIP (3.965s)
[170.662686] [043/130] (848s left) kms_chamelium_hpd (dp-hpd-fast)
[170.940415] Subtest dp-hpd-fast: SKIP (0.000s)
[171.051116] [044/130] (848s left) gem_softpin (evict-snoop-interruptible)
[171.103139] Starting subtest: evict-snoop-interruptible
[171.104713] Subtest evict-snoop-interruptible: SKIP (0.000s)
[171.188121] [045/130] (848s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[171.377576] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[171.401008] [046/130] (847s left) gem_wait (write-wait)
[171.457714] Starting subtest: write-wait
[171.458668] Starting dynamic subtest: all-engines
[172.555747] Dynamic subtest all-engines: SUCCESS (1.097s)
[172.567578] Starting dynamic subtest: rcs0
[173.618413] Dynamic subtest rcs0: SUCCESS (1.039s)
[173.629113] Starting dynamic subtest: bcs0
[174.678784] Dynamic subtest bcs0: SUCCESS (1.017s)
[174.695805] Starting dynamic subtest: vcs0
[175.742706] Dynamic subtest vcs0: SUCCESS (1.025s)
[175.755169] Starting dynamic subtest: vcs1
[176.804910] Dynamic subtest vcs1: SUCCESS (1.028s)
[176.817646] Starting dynamic subtest: vecs0
[177.866789] Dynamic subtest vecs0: SUCCESS (1.031s)
[177.907202] Starting dynamic subtest: vecs1
[178.938769] Dynamic subtest vecs1: SUCCESS (1.045s)
[178.951222] Starting dynamic subtest: ccs0
[179.998846] Dynamic subtest ccs0: SUCCESS (1.036s)
[180.000956] Subtest write-wait: SUCCESS (8.335s)
[180.235601] [047/130] (839s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[180.430547] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[181.624877] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.174s)
[181.767549] [048/130] (837s left) kms_properties (connector-properties-legacy)
[181.953138] Starting subtest: connector-properties-legacy
[181.955344] Starting dynamic subtest: pipe-A-DP-3
[183.633930] Dynamic subtest pipe-A-DP-3: SUCCESS (1.656s)
[183.652140] Starting dynamic subtest: pipe-None-DP-1
[183.654228] Dynamic subtest pipe-None-DP-1: SUCCESS (0.003s)
[183.665140] Starting dynamic subtest: pipe-None-DP-2
[183.666728] Dynamic subtest pipe-None-DP-2: SUCCESS (0.003s)
[183.675164] Starting dynamic subtest: pipe-None-HDMI-A-1
[183.677275] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.002s)
[183.684878] Starting dynamic subtest: pipe-None-HDMI-A-2
[183.686509] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.002s)
[183.694319] Starting dynamic subtest: pipe-None-DP-4
[183.696083] Dynamic subtest pipe-None-DP-4: SUCCESS (0.002s)
[183.703896] Starting dynamic subtest: pipe-None-HDMI-A-3
[183.705717] Dynamic subtest pipe-None-HDMI-A-3: SUCCESS (0.002s)
[183.706613] Subtest connector-properties-legacy: SUCCESS (1.681s)
[183.868880] [049/130] (835s left) syncobj_wait (reset-signaled)
[183.935207] Starting subtest: reset-signaled
[183.936203] Subtest reset-signaled: SUCCESS (0.000s)
[184.019777] [050/130] (835s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[184.350140] Starting subtest: cursor-rapid-movement-256x256
[184.354566] Starting dynamic subtest: pipe-A-DP-3
[184.773303] Dynamic subtest pipe-A-DP-3: SUCCESS (0.414s)
[184.818996] Starting dynamic subtest: pipe-D-DP-3
[185.197957] Dynamic subtest pipe-D-DP-3: SUCCESS (0.382s)
[185.199109] Subtest cursor-rapid-movement-256x256: SUCCESS (0.839s)
[185.534138] [051/130] (834s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[185.740269] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[185.743323] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[185.802035] [052/130] (834s left) i915_pm_rpm (gem-evict-pwrite)
[187.411771] Starting subtest: gem-evict-pwrite
[187.414372] Subtest gem-evict-pwrite: SKIP (0.000s)
[187.612211] [053/130] (832s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[187.665904] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[187.704379] [054/130] (832s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[187.899114] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[190.745563] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (2.829s)
[190.924386] [055/130] (828s left) gem_exec_reloc (basic-write-wc)
[190.984628] Subtest basic-write-wc: SKIP (0.000s)
[191.023063] [056/130] (828s left) perf_pmu (invalid-open)
[191.072809] Starting subtest: invalid-open
[191.073642] Subtest invalid-open: SUCCESS (0.000s)
[191.181556] [057/130] (828s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[191.372331] Starting subtest: x-tiled-16bpp-rotate-180
[192.904926] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.526s)
[193.042228] [058/130] (826s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[193.228880] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[193.230501] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[193.317291] [059/130] (826s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[193.532107] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[193.532974] Starting dynamic subtest: pipe-A-DP-3
[193.541046] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[193.549128] Starting dynamic subtest: pipe-B-DP-3
[193.558443] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[193.566480] Starting dynamic subtest: pipe-C-DP-3
[193.577438] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[193.585886] Starting dynamic subtest: pipe-D-DP-3
[193.596354] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[193.598453] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SKIP (0.006s)
[193.611066] [060/130] (826s left) syncobj_timeline (invalid-transfer-bad-pad)
[193.664105] Starting subtest: invalid-transfer-bad-pad
[193.665209] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[193.767341] [061/130] (826s left) gem_exec_reloc (basic-concurrent16)
[193.858304] Subtest basic-concurrent16: SKIP (0.000s)
[193.902582] [062/130] (826s left) gem_exec_balancer (bonded-false-hang)
[194.180239] Starting subtest: bonded-false-hang
[194.181898] Subtest bonded-false-hang: SKIP (0.000s)
[194.258412] [063/130] (825s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[194.453782] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[194.471933] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.017s)
[194.546134] [064/130] (825s left) gem_softpin (noreloc-s3)
[194.625753] Starting subtest: noreloc-S3
[215.176416] Subtest noreloc-S3: SUCCESS (5.419s)
[216.290351] [065/130] (819s left) kms_universal_plane (universal-plane-sanity)
[216.478729] Starting subtest: universal-plane-sanity
[216.481010] Starting dynamic subtest: pipe-A-DP-3
[217.006452] Dynamic subtest pipe-A-DP-3: SUCCESS (0.524s)
[217.022376] Starting dynamic subtest: pipe-B-DP-3
[217.487857] Dynamic subtest pipe-B-DP-3: SUCCESS (0.478s)
[217.498964] Starting dynamic subtest: pipe-C-DP-3
[217.950181] Dynamic subtest pipe-C-DP-3: SUCCESS (0.460s)
[217.964699] Starting dynamic subtest: pipe-D-DP-3
[218.434726] Dynamic subtest pipe-D-DP-3: SUCCESS (0.481s)
[218.435694] Subtest universal-plane-sanity: SUCCESS (1.952s)
[218.660194] [066/130] (817s left) prime_vgem (basic-write)
[218.785747] Starting subtest: basic-write
[218.808313] Subtest basic-write: SKIP (0.022s)
[218.900902] [067/130] (817s left) kms_dsc (dsc-with-formats)
[219.091062] Starting subtest: dsc-with-formats
[219.094328] Subtest dsc-with-formats: SKIP (0.001s)
[219.161662] [068/130] (817s left) gem_ctx_persistence (engines-hostile-preempt)
[219.254965] Starting subtest: engines-hostile-preempt
[219.255893] Starting dynamic subtest: rcs0
[219.345996] Dynamic subtest rcs0: SUCCESS (0.090s)
[219.355835] Starting dynamic subtest: bcs0
[219.376731] Dynamic subtest bcs0: SUCCESS (0.030s)
[219.386929] Starting dynamic subtest: vcs0
[219.439238] Dynamic subtest vcs0: SUCCESS (0.061s)
[219.471899] Starting dynamic subtest: vcs1
[219.503793] Dynamic subtest vcs1: SUCCESS (0.063s)
[219.539735] Starting dynamic subtest: vecs0
[219.544005] Dynamic subtest vecs0: SUCCESS (0.038s)
[219.557155] Starting dynamic subtest: vecs1
[219.595758] Dynamic subtest vecs1: SUCCESS (0.051s)
[219.606908] Starting dynamic subtest: ccs0
[219.635775] Dynamic subtest ccs0: SUCCESS (0.039s)
[219.636794] Subtest engines-hostile-preempt: SUCCESS (0.381s)
[219.770546] [069/130] (816s left) gem_pxp (create-regular-buffer)
[222.373656] Subtest create-regular-buffer: SKIP (0.000s)
[222.437235] [070/130] (813s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[222.618943] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[222.620670] Subtest psr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[222.715073] [071/130] (813s left) kms_selftest (drm_dp_mst_helper)
[222.806203] Starting subtest: drm_dp_mst_helper
[222.810707] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[222.889585] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.078s)
[222.919610] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[222.980236] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.089s)
[223.015440] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[223.058930] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.077s)
[223.059919] Subtest drm_dp_mst_helper: SUCCESS (0.252s)
[223.210217] [072/130] (813s left) gen9_exec_parse (bb-chained)
[223.295996] Subtest bb-chained: SKIP (0.000s)
[223.346104] [073/130] (813s left) kms_setmode (invalid-clone-single-crtc-stealing)
[223.399573] Starting subtest: invalid-clone-single-crtc-stealing
[223.401869] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[223.488998] [074/130] (813s left) kms_content_protection (lic-type-1)
[223.730260] Starting subtest: lic-type-1
[224.373321] Subtest lic-type-1: SKIP (0.639s)
[224.712540] [075/130] (811s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[224.898079] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[224.899812] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[224.995433] [076/130] (811s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[225.220205] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[227.815381] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (2.594s)
[227.966247] [077/130] (808s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[228.164505] Starting subtest: y-tiled-32bpp-rotate-180
[228.166129] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[228.258028] [078/130] (808s left) api_intel_bb (crc32)
[228.333706] Starting subtest: crc32
[228.334704] Starting dynamic subtest: rcs0-lmem0
[228.586153] Dynamic subtest rcs0-lmem0: SUCCESS (0.251s)
[228.598680] Starting dynamic subtest: rcs0-smem0
[228.894613] Dynamic subtest rcs0-smem0: SUCCESS (0.306s)
[228.906158] Starting dynamic subtest: bcs0-lmem0
[229.150189] Dynamic subtest bcs0-lmem0: SUCCESS (0.251s)
[229.161725] Starting dynamic subtest: bcs0-smem0
[229.504323] Dynamic subtest bcs0-smem0: SUCCESS (0.338s)
[229.522124] Starting dynamic subtest: vcs0-lmem0
[229.964774] Dynamic subtest vcs0-lmem0: SUCCESS (0.440s)
[229.975259] Starting dynamic subtest: vcs0-smem0
[230.539949] Dynamic subtest vcs0-smem0: SUCCESS (0.552s)
[230.551123] Starting dynamic subtest: vcs1-lmem0
[230.992026] Dynamic subtest vcs1-lmem0: SUCCESS (0.434s)
[231.003923] Starting dynamic subtest: vcs1-smem0
[231.556098] Dynamic subtest vcs1-smem0: SUCCESS (0.544s)
[231.567004] Starting dynamic subtest: vecs0-lmem0
[231.998550] Dynamic subtest vecs0-lmem0: SUCCESS (0.427s)
[232.009475] Starting dynamic subtest: vecs0-smem0
[232.573446] Dynamic subtest vecs0-smem0: SUCCESS (0.556s)
[232.585379] Starting dynamic subtest: vecs1-lmem0
[233.020284] Dynamic subtest vecs1-lmem0: SUCCESS (0.432s)
[233.036984] Starting dynamic subtest: vecs1-smem0
[233.573822] Dynamic subtest vecs1-smem0: SUCCESS (0.537s)
[233.584888] Starting dynamic subtest: ccs0-lmem0
[233.839048] Dynamic subtest ccs0-lmem0: SUCCESS (0.256s)
[233.851973] Starting dynamic subtest: ccs0-smem0
[234.179195] Dynamic subtest ccs0-smem0: SUCCESS (0.330s)
[234.181810] Subtest crc32: SUCCESS (5.687s)
[234.296100] [079/130] (802s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[234.492776] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[234.494549] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[234.570518] [080/130] (802s left) drm_fdinfo (virtual-busy-hang-all)
[234.649644] Starting subtest: virtual-busy-hang-all
[234.651706] Subtest virtual-busy-hang-all: SKIP (0.000s)
[234.727890] [081/130] (802s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[234.933838] Starting subtest: 2x-flip-vs-cursor-legacy
[234.936832] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.002s)
[234.990334] [082/130] (801s left) dmabuf_sync_file (export-basic)
[235.042473] Starting subtest: export-basic
[235.043488] Subtest export-basic: SUCCESS (0.001s)
[235.091822] [083/130] (801s left) gem_exec_fair (basic-flow)
[235.157475] Subtest basic-flow: SKIP (0.000s)
[235.189260] [084/130] (801s left) gem_ctx_param (get-priority-new-ctx)
[235.251089] Starting subtest: get-priority-new-ctx
[235.252050] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[235.355159] [085/130] (801s left) syncobj_timeline (wait-any-snapshot)
[235.447088] Starting subtest: wait-any-snapshot
[235.529826] Subtest wait-any-snapshot: SUCCESS (0.081s)
[235.587804] [086/130] (801s left) kms_plane (pixel-format)
[235.769782] Starting subtest: pixel-format
[235.806548] Starting dynamic subtest: pipe-A-plane-0
[243.966073] Dynamic subtest pipe-A-plane-0: SUCCESS (8.067s)
[243.975183] Starting dynamic subtest: pipe-A-plane-3
[248.939171] Dynamic subtest pipe-A-plane-3: SUCCESS (4.949s)
[248.949139] Starting dynamic subtest: pipe-A-plane-5
[249.207275] Dynamic subtest pipe-A-plane-5: SUCCESS (0.266s)
[249.513939] Starting dynamic subtest: pipe-B-plane-0
[257.495153] Dynamic subtest pipe-B-plane-0: SUCCESS (7.983s)
[257.508610] Starting dynamic subtest: pipe-B-plane-3
[262.417392] Dynamic subtest pipe-B-plane-3: SUCCESS (4.916s)
[262.426640] Starting dynamic subtest: pipe-B-plane-5
[262.667041] Dynamic subtest pipe-B-plane-5: SUCCESS (0.249s)
[262.757846] Subtest pixel-format: SUCCESS (26.846s)
[263.017800] [087/130] (774s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[263.227897] Starting subtest: short-flip-after-cursor-atomic-transitions
[264.269960] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (1.041s)
[264.528113] [088/130] (772s left) perf_pmu (busy)
[264.579516] Starting subtest: busy
[264.580450] Starting dynamic subtest: rcs0
[265.162682] Dynamic subtest rcs0: SUCCESS (0.582s)
[265.174460] Starting dynamic subtest: bcs0
[265.731615] Dynamic subtest bcs0: SUCCESS (0.566s)
[265.747508] Starting dynamic subtest: vcs0
[266.297450] Dynamic subtest vcs0: SUCCESS (0.563s)
[266.313528] Starting dynamic subtest: vcs1
[266.859634] Dynamic subtest vcs1: SUCCESS (0.559s)
[266.871077] Starting dynamic subtest: vecs0
[267.417311] Dynamic subtest vecs0: SUCCESS (0.555s)
[267.429057] Starting dynamic subtest: vecs1
[267.975471] Dynamic subtest vecs1: SUCCESS (0.555s)
[267.987513] Starting dynamic subtest: ccs0
[268.539224] Dynamic subtest ccs0: SUCCESS (0.561s)
[268.541029] Subtest busy: SUCCESS (3.959s)
[268.626606] [089/130] (768s left) kms_flip (absolute-wf_vblank)
[268.803537] Starting subtest: absolute-wf_vblank
[268.808199] Starting dynamic subtest: A-DP3
[276.641263] Dynamic subtest A-DP3: SUCCESS (7.830s)
[276.651170] Starting dynamic subtest: B-DP3
[284.410494] Dynamic subtest B-DP3: SUCCESS (7.765s)
[284.419338] Starting dynamic subtest: C-DP3
[292.175597] Dynamic subtest C-DP3: SUCCESS (7.761s)
[292.184729] Starting dynamic subtest: D-DP3
[299.940143] Dynamic subtest D-DP3: SUCCESS (7.760s)
[299.942453] Subtest absolute-wf_vblank: SUCCESS (31.127s)
[300.214323] [090/130] (737s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[300.416777] Starting subtest: 4-tiled-16bpp-rotate-0
[301.936159] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.518s)
[302.089088] [091/130] (735s left) kms_cursor_edge_walk (64x64-top-bottom)
[302.278892] Starting subtest: 64x64-top-bottom
[302.281162] Starting dynamic subtest: pipe-A-DP-3
[305.743416] Dynamic subtest pipe-A-DP-3: SUCCESS (3.461s)
[305.755286] Starting dynamic subtest: pipe-D-DP-3
[309.059305] Dynamic subtest pipe-D-DP-3: SUCCESS (3.311s)
[309.060345] Subtest 64x64-top-bottom: SUCCESS (6.776s)
[309.272630] [092/130] (728s left) gem_ctx_shared (q-independent)
[309.364434] Starting subtest: Q-independent
[309.365504] Starting dynamic subtest: rcs0
[309.579860] Dynamic subtest rcs0: SUCCESS (0.215s)
[309.588213] Starting dynamic subtest: bcs0
[309.718040] Dynamic subtest bcs0: SUCCESS (0.138s)
[309.726529] Starting dynamic subtest: vcs0
[309.866366] Dynamic subtest vcs0: SUCCESS (0.148s)
[309.874623] Starting dynamic subtest: vcs1
[310.015255] Dynamic subtest vcs1: SUCCESS (0.148s)
[310.023890] Starting dynamic subtest: vecs0
[310.169938] Dynamic subtest vecs0: SUCCESS (0.154s)
[310.178586] Starting dynamic subtest: vecs1
[310.323066] Dynamic subtest vecs1: SUCCESS (0.152s)
[310.331842] Starting dynamic subtest: ccs0
[310.469550] Dynamic subtest ccs0: SUCCESS (0.146s)
[310.470409] Subtest Q-independent: SUCCESS (1.105s)
[310.812294] [093/130] (726s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[311.031222] Starting subtest: x-tiled-64bpp-rotate-270
[311.073356] Subtest x-tiled-64bpp-rotate-270: SKIP (0.042s)
[311.231284] [094/130] (726s left) gem_exec_schedule (wide)
[311.459178] Starting subtest: wide
[311.461079] Starting dynamic subtest: rcs0
[328.931420] Dynamic subtest rcs0: SUCCESS (17.466s)
[328.940362] Starting dynamic subtest: bcs0
[337.869785] Dynamic subtest bcs0: SUCCESS (8.941s)
[337.878943] Starting dynamic subtest: vcs0
[346.011340] Dynamic subtest vcs0: SUCCESS (8.142s)
[346.020116] Starting dynamic subtest: vcs1
[354.602903] Dynamic subtest vcs1: SUCCESS (8.592s)
[354.611499] Starting dynamic subtest: vecs0
[362.637517] Dynamic subtest vecs0: SUCCESS (8.034s)
[362.646107] Starting dynamic subtest: vecs1
[370.911905] Dynamic subtest vecs1: SUCCESS (8.273s)
[370.920717] Starting dynamic subtest: ccs0
[379.218507] Dynamic subtest ccs0: SUCCESS (8.304s)
[379.219245] Subtest wide: SUCCESS (67.758s)
[380.194584] [095/130] (657s left) kms_hdmi_inject (inject-audio)
[380.342075] Starting subtest: inject-audio
[380.344487] Subtest inject-audio: SKIP (0.000s)
[380.542974] [096/130] (657s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[380.633184] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[380.635252] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[380.843215] [097/130] (656s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[381.051838] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[381.052783] Starting dynamic subtest: pipe-A-DP-3
[381.061877] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[381.070733] Starting dynamic subtest: pipe-B-DP-3
[381.081371] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[381.089688] Starting dynamic subtest: pipe-C-DP-3
[381.100044] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[381.109383] Starting dynamic subtest: pipe-D-DP-3
[381.120117] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[381.122358] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SKIP (0.005s)
[381.138235] [098/130] (656s left) i915_module_load (reload-with-fault-injection)
[381.188806] Starting subtest: reload-with-fault-injection
[401.914029] Killing the test because the kernel is tainted.
[402.169049] Aborting: Lockdep not active

/proc/lockdep_stats contents:
 lock-classes:                         1842 [max: 8192]
 direct dependencies:                 18108 [max: 32768]
 indirect dependencies:              149934
 all direct dependencies:            361686
 dependency chains:                   27148 [max: 131072]
 dependency chain hlocks used:       117477 [max: 655360]
 dependency chain hlocks lost:            0
 in-hardirq chains:                     275
 in-softirq chains:                     939
 in-process chains:                   25934
 stack-trace entries:                203340 [max: 1048576]
 number of stack traces:              10721
 number of stack hash chains:          7878
 combined max dependencies:      2433609104
 hardirq-safe locks:                     99
 hardirq-unsafe locks:                 1038
 softirq-safe locks:                    207
 softirq-unsafe locks:                  945
 irq-safe locks:                        232
 irq-unsafe locks:                     1038
 hardirq-read-safe locks:                 4
 hardirq-read-unsafe locks:             357
 softirq-read-safe locks:                 8
 softirq-read-unsafe locks:             352
 irq-read-safe locks:                     8
 irq-read-unsafe locks:                 357
 uncategorized locks:                   326
 unused locks:                            1
 max locking depth:                      21
 max bfs queue depth:                   465
 max lock class index:                 1925
 debug_locks:                             0

 zapped classes:                        529
 zapped lock chains:                  10465
 large chain blocks:                      1

[402.170263] Closing watchdogs
Done.