[39.877425] Initializing watchdogs
[39.877516]   /dev/watchdog0
[39.885477] [001/130] (960s left) kms_flip (flip-vs-expired-vblank-interruptible)
[41.895547] Starting subtest: flip-vs-expired-vblank-interruptible
[41.902257] Starting dynamic subtest: A-HDMI-A3
[49.668204] Dynamic subtest A-HDMI-A3: SUCCESS (7.765s)
[49.677284] Starting dynamic subtest: B-HDMI-A3
[57.335813] Dynamic subtest B-HDMI-A3: SUCCESS (7.722s)
[57.341751] Starting dynamic subtest: C-HDMI-A3
[64.987566] Dynamic subtest C-HDMI-A3: SUCCESS (7.677s)
[64.993978] Starting dynamic subtest: D-HDMI-A3
[72.643551] Dynamic subtest D-HDMI-A3: SUCCESS (7.665s)
[72.645491] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (30.840s)
[72.817631] [002/130] (927s left) kms_joiner (basic-force-big-joiner)
[74.815516] Starting subtest: basic-force-big-joiner
[74.817261] Subtest basic-force-big-joiner: SKIP (0.000s)
[74.883334] [003/130] (925s left) gem_exec_reloc (basic-write-read-active)
[74.998464] Subtest basic-write-read-active: SKIP (0.000s)
[75.065784] [004/130] (925s left) gem_exec_reloc (basic-wc-cpu-active)
[75.147175] Subtest basic-wc-cpu-active: SKIP (0.000s)
[75.208465] [005/130] (925s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[75.276226] Starting subtest: multi-wait-available-submitted-signaled
[75.277127] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.001s)
[75.349257] [006/130] (925s left) gem_exec_reloc (basic-wc-read-noreloc)
[75.440407] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[75.490658] [007/130] (924s left) gem_ctx_shared (q-in-order)
[75.557347] Starting subtest: Q-in-order
[75.558231] Starting dynamic subtest: rcs0
[75.787422] Dynamic subtest rcs0: SUCCESS (0.226s)
[75.793694] Starting dynamic subtest: bcs0
[75.902731] Dynamic subtest bcs0: SUCCESS (0.115s)
[75.908944] Starting dynamic subtest: vcs0
[76.017882] Dynamic subtest vcs0: SUCCESS (0.115s)
[76.024019] Starting dynamic subtest: vcs1
[76.129163] Dynamic subtest vcs1: SUCCESS (0.115s)
[76.135610] Starting dynamic subtest: vecs0
[76.258307] Dynamic subtest vecs0: SUCCESS (0.124s)
[76.260332] Subtest Q-in-order: SUCCESS (0.696s)
[76.507425] [008/130] (923s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[78.502132] Starting subtest: crc-primary-suspend-y-tiled-ccs
[78.503936] Starting dynamic subtest: pipe-A-HDMI-A-3
[78.507298] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[78.513716] Starting dynamic subtest: pipe-B-HDMI-A-3
[78.516978] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[78.523174] Starting dynamic subtest: pipe-C-HDMI-A-3
[78.526523] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[78.532709] Starting dynamic subtest: pipe-D-HDMI-A-3
[78.536052] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[78.537747] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.006s)
[78.691125] [009/130] (921s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[80.683992] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[80.685750] Starting dynamic subtest: pipe-A-HDMI-A-3
[80.693393] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[80.699660] Starting dynamic subtest: pipe-B-HDMI-A-3
[80.707339] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[80.713394] Starting dynamic subtest: pipe-C-HDMI-A-3
[80.721243] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[80.727279] Starting dynamic subtest: pipe-D-HDMI-A-3
[80.735533] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[80.737143] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[80.868468] [010/130] (919s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[86.049979] Starting subtest: dpms-mode-unset-lpsp
[87.232588] Subtest dpms-mode-unset-lpsp: SKIP (1.181s)
[88.433307] [011/130] (912s left) sysfs_heartbeat_interval (precise)
[88.544518] Starting subtest: precise
[88.546213] Starting dynamic subtest: vecs0
[89.895506] Dynamic subtest vecs0: SUCCESS (1.350s)
[89.905178] Starting dynamic subtest: vcs0
[91.200944] Dynamic subtest vcs0: SUCCESS (1.305s)
[91.207408] Starting dynamic subtest: bcs0
[93.920220] Dynamic subtest bcs0: SUCCESS (2.719s)
[93.926720] Starting dynamic subtest: rcs0
[95.196955] Dynamic subtest rcs0: SUCCESS (1.277s)
[95.203704] Starting dynamic subtest: vcs1
[96.407505] Dynamic subtest vcs1: SUCCESS (1.211s)
[96.408345] Subtest precise: SUCCESS (7.864s)
[96.510069] [012/130] (904s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[98.513021] Starting subtest: psr-rgb565-draw-pwrite
[98.514521] Subtest psr-rgb565-draw-pwrite: SKIP (0.000s)
[98.598520] [013/130] (902s left) api_intel_bb (blit-noreloc-purge-cache)
[98.738405] Starting subtest: blit-noreloc-purge-cache
[98.760420] Subtest blit-noreloc-purge-cache: SUCCESS (0.022s)
[98.910303] [014/130] (901s left) perf (short-reads)
[99.197831] Starting subtest: short-reads
[99.227332] Subtest short-reads: SUCCESS (0.030s)
[99.258202] [015/130] (901s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[101.257099] Starting subtest: flip-vs-dpms-off-vs-modeset
[101.263238] Starting dynamic subtest: A-HDMI-A3
[101.970556] Dynamic subtest A-HDMI-A3: SUCCESS (0.708s)
[101.977780] Starting dynamic subtest: B-HDMI-A3
[102.653296] Dynamic subtest B-HDMI-A3: SUCCESS (0.682s)
[102.660208] Starting dynamic subtest: C-HDMI-A3
[103.364568] Dynamic subtest C-HDMI-A3: SUCCESS (0.711s)
[103.371307] Starting dynamic subtest: D-HDMI-A3
[104.075147] Dynamic subtest D-HDMI-A3: SUCCESS (0.710s)
[104.076108] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (2.819s)
[104.216843] [016/130] (896s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[106.212182] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[106.213968] Starting dynamic subtest: pipe-A-HDMI-A-3
[106.221958] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s)
[106.228906] Starting dynamic subtest: pipe-B-HDMI-A-3
[106.237146] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s)
[106.243821] Starting dynamic subtest: pipe-C-HDMI-A-3
[106.252113] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s)
[106.258725] Starting dynamic subtest: pipe-D-HDMI-A-3
[106.267185] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s)
[106.268905] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.009s)
[106.410604] [017/130] (894s left) gem_exec_schedule (pi-userfault)
[106.642453] Starting subtest: pi-userfault
[106.643744] Starting dynamic subtest: rcs0
[106.657737] Dynamic subtest rcs0: SUCCESS (0.016s)
[106.668070] Starting dynamic subtest: bcs0
[106.669101] Dynamic subtest bcs0: SUCCESS (0.009s)
[106.679135] Starting dynamic subtest: vcs0
[106.680222] Dynamic subtest vcs0: SUCCESS (0.009s)
[106.690572] Starting dynamic subtest: vcs1
[106.691742] Dynamic subtest vcs1: SUCCESS (0.009s)
[106.701743] Starting dynamic subtest: vecs0
[106.702823] Dynamic subtest vecs0: SUCCESS (0.009s)
[106.703995] Subtest pi-userfault: SUCCESS (0.056s)
[106.876074] [018/130] (893s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-cpu)
[108.910230] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-cpu
[108.911938] Subtest psr-1p-offscren-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[109.000163] [019/130] (891s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[111.090473] Starting subtest: fbc-1p-pri-indfb-multidraw
[119.910791] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (8.819s)
[120.079919] [020/130] (880s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[122.089946] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[122.091771] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[122.186657] [021/130] (878s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[124.451392] Starting subtest: cursor-rapid-movement-256x85
[124.457942] Starting dynamic subtest: pipe-A-HDMI-A-3
[124.865752] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.408s)
[124.894645] Starting dynamic subtest: pipe-D-HDMI-A-3
[125.206258] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.315s)
[125.207082] Subtest cursor-rapid-movement-256x85: SUCCESS (0.753s)
[125.511843] [022/130] (875s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[127.525535] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[127.527220] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[127.630988] [023/130] (873s left) gem_userptr_blits (unsync-unmap)
[127.777385] Subtest unsync-unmap: SKIP (0.000s)
[127.924891] [024/130] (873s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[129.951281] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[129.953145] Starting dynamic subtest: pipe-A-valid-mode
[129.993235] Dynamic subtest pipe-A-valid-mode: SKIP (0.039s)
[129.994819] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.041s)
[130.082423] [025/130] (870s left) gem_exec_basic (basic)
[130.152724] Starting subtest: basic
[130.153568] Starting dynamic subtest: rcs0-smem
[130.156545] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[130.163832] Starting dynamic subtest: bcs0-smem
[130.164760] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[130.171572] Starting dynamic subtest: vcs0-smem
[130.172465] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[130.179212] Starting dynamic subtest: vcs1-smem
[130.180112] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[130.186853] Starting dynamic subtest: vecs0-smem
[130.187731] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[130.194212] Starting dynamic subtest: rcs0-lmem0
[130.195107] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s)
[130.201614] Starting dynamic subtest: bcs0-lmem0
[130.202527] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s)
[130.209044] Starting dynamic subtest: vcs0-lmem0
[130.210010] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s)
[130.216512] Starting dynamic subtest: vcs1-lmem0
[130.217411] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s)
[130.223927] Starting dynamic subtest: vecs0-lmem0
[130.224836] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s)
[130.225762] Subtest basic: SUCCESS (0.012s)
[130.390308] [026/130] (870s left) i915_suspend (debugfs-reader)
[130.458999] Starting subtest: debugfs-reader
[157.906559] Subtest debugfs-reader: SUCCESS (11.575s)
[165.062909] [027/130] (858s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[167.082719] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[167.084286] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[167.200566] [028/130] (856s left) gem_exec_schedule (u-fairslice-all)
[167.347266] Starting subtest: u-fairslice-all
[169.429366] Subtest u-fairslice-all: SUCCESS (2.082s)
[169.843755] [029/130] (854s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[172.003873] Starting subtest: cursor-rapid-movement-128x42
[172.010431] Starting dynamic subtest: pipe-A-HDMI-A-3
[172.446707] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.437s)
[172.477968] Starting dynamic subtest: pipe-D-HDMI-A-3
[172.804143] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.334s)
[172.805028] Subtest cursor-rapid-movement-128x42: SUCCESS (0.800s)
[173.180746] [030/130] (850s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[175.194283] Starting subtest: x-tiled-8bpp-rotate-0
[176.765510] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.567s)
[176.900464] [031/130] (847s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[178.899734] Starting subtest: basic-flip-after-cursor-varying-size
[179.883296] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.983s)
[180.037827] [032/130] (844s left) gem_spin_batch (spin-each)
[180.103063] Starting subtest: spin-each
[183.516580] Subtest spin-each: SUCCESS (3.413s)
[183.749371] [033/130] (840s left) syncobj_wait (reset-multiple-signaled)
[183.799348] Starting subtest: reset-multiple-signaled
[183.800157] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[183.883511] [034/130] (840s left) kms_atomic_interruptible (universal-setplane-primary)
[185.907170] Starting subtest: universal-setplane-primary
[185.909223] Starting dynamic subtest: pipe-A-HDMI-A-3
[192.108340] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (6.200s)
[192.109151] Subtest universal-setplane-primary: SUCCESS (6.202s)
[192.224630] [035/130] (832s left) gem_mmap_gtt (close-race)
[192.274755] Subtest close-race: SKIP (0.000s)
[192.301619] [036/130] (831s left) gem_exec_params (invalid-fence-in)
[192.355964] Starting subtest: invalid-fence-in
[192.356795] Subtest invalid-fence-in: SUCCESS (0.000s)
[192.485375] [037/130] (831s left) gem_readwrite (read-bad-handle)
[192.549629] Subtest read-bad-handle: SKIP (0.000s)
[192.585484] [038/130] (831s left) gem_ctx_exec (basic-close-race)
[192.637971] Starting subtest: basic-close-race
[198.271652] Subtest basic-close-race: SUCCESS (5.628s)
[198.427899] [039/130] (825s left) kms_writeback (writeback-fb-id-xrgb2101010)
[200.442239] Subtest writeback-fb-id-XRGB2101010: SKIP (0.000s)
[200.468252] [040/130] (823s left) gem_eio (banned)
[200.674489] Starting subtest: banned
[201.505142] Subtest banned: SUCCESS (0.831s)
[203.530141] [041/130] (820s left) kms_plane_alpha_blend (constant-alpha-mid)
[205.596560] Starting subtest: constant-alpha-mid
[205.840385] Starting dynamic subtest: pipe-A-HDMI-A-3
[206.560051] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.720s)
[206.570404] Starting dynamic subtest: pipe-D-HDMI-A-3
[207.262319] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.699s)
[207.263151] Subtest constant-alpha-mid: SUCCESS (1.665s)
[207.401383] [042/130] (817s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[209.396482] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[209.397278] Starting dynamic subtest: pipe-A
[210.165907] Dynamic subtest pipe-A: SUCCESS (0.769s)
[210.179592] Starting dynamic subtest: pipe-B
[210.938506] Dynamic subtest pipe-B: SUCCESS (0.772s)
[210.954883] Starting dynamic subtest: pipe-C
[211.712864] Dynamic subtest pipe-C: SUCCESS (0.773s)
[211.724599] Starting dynamic subtest: pipe-D
[212.469757] Dynamic subtest pipe-D: SUCCESS (0.756s)
[212.470880] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (3.074s)
[212.630422] [043/130] (811s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[214.657442] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[214.659289] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[214.795641] [044/130] (809s left) kms_chamelium_edid (vga-edid-read)
[216.916703] Subtest vga-edid-read: SKIP (0.000s)
[216.986197] [045/130] (807s left) gem_mmap_wc (write-read-distinct)
[217.038794] Subtest write-read-distinct: SKIP (0.000s)
[217.067937] [046/130] (807s left) gem_exec_params (invalid-batch-start-offset)
[217.124109] Starting subtest: invalid-batch-start-offset
[217.126328] Subtest invalid-batch-start-offset: SUCCESS (0.002s)
[217.303189] [047/130] (807s left) kms_psr (fbc-psr-sprite-plane-move)
[219.309119] Subtest fbc-psr-sprite-plane-move: SKIP (0.000s)
[219.383949] [048/130] (805s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[221.467246] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[221.468910] Subtest fbcpsr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[221.574632] [049/130] (803s left) syncobj_eventfd (timeline-wait)
[221.710929] Starting subtest: timeline-wait
[221.722030] Subtest timeline-wait: SUCCESS (0.011s)
[221.792840] [050/130] (803s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[223.797528] Starting subtest: coverage-vs-premult-vs-constant
[224.038797] Starting dynamic subtest: pipe-A-HDMI-A-3
[224.492311] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.453s)
[224.502697] Starting dynamic subtest: pipe-D-HDMI-A-3
[224.942126] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.448s)
[224.943038] Subtest coverage-vs-premult-vs-constant: SUCCESS (1.145s)
[225.110676] [051/130] (799s left) kms_addfb_basic (basic-x-tiled-legacy)
[225.184064] Starting subtest: basic-x-tiled-legacy
[225.186206] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[227.234707] [052/130] (797s left) gem_exec_fence (basic-busy-all)
[227.391310] Starting subtest: basic-busy-all
[227.483515] Subtest basic-busy-all: SUCCESS (0.093s)
[228.223854] [053/130] (796s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[230.216676] Starting subtest: plane-upscale-20x20-with-pixel-format
[230.217556] Starting dynamic subtest: pipe-A
[232.600944] Dynamic subtest pipe-A: SUCCESS (2.384s)
[232.615665] Starting dynamic subtest: pipe-B
[234.957609] Dynamic subtest pipe-B: SUCCESS (2.355s)
[234.973208] Starting dynamic subtest: pipe-C
[235.249187] Dynamic subtest pipe-C: SUCCESS (0.290s)
[235.266310] Starting dynamic subtest: pipe-D
[235.538884] Dynamic subtest pipe-D: SUCCESS (0.288s)
[235.540019] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.323s)
[235.698595] [054/130] (789s left) api_intel_bb (simple-bb-ctx)
[235.752659] Starting subtest: simple-bb-ctx
[235.773005] Subtest simple-bb-ctx: SUCCESS (0.021s)
[235.902560] [055/130] (789s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[237.918142] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[237.919714] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[238.031344] [056/130] (787s left) gem_ctx_persistence (engines-mixed)
[238.171640] Starting subtest: engines-mixed
[238.172500] Starting dynamic subtest: rcs0
[238.230320] Dynamic subtest rcs0: SUCCESS (0.058s)
[238.243387] Starting dynamic subtest: bcs0
[238.291874] Dynamic subtest bcs0: SUCCESS (0.060s)
[238.328972] Starting dynamic subtest: vcs0
[238.368626] Dynamic subtest vcs0: SUCCESS (0.073s)
[238.399114] Starting dynamic subtest: vcs1
[238.435598] Dynamic subtest vcs1: SUCCESS (0.064s)
[238.463017] Starting dynamic subtest: vecs0
[238.496583] Dynamic subtest vecs0: SUCCESS (0.058s)
[238.500584] Subtest engines-mixed: SUCCESS (0.326s)
[238.660548] [057/130] (786s left) gem_userptr_blits (access-control)
[238.758561] Starting subtest: access-control
[238.760207] Subtest access-control: SKIP (0.000s)
[238.867459] [058/130] (786s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[240.872964] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[240.874728] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[241.003024] [059/130] (784s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[243.081901] Starting subtest: 2x-long-cursor-vs-flip-legacy
[243.085731] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.003s)
[243.150124] [060/130] (782s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[245.218052] Starting subtest: cursorA-vs-flipA-legacy
[256.131151] Subtest cursorA-vs-flipA-legacy: SUCCESS (10.912s)
[256.262932] [061/130] (769s left) kms_invalid_mode (bad-hsync-end)
[258.258132] Starting subtest: bad-hsync-end
[258.260490] Starting dynamic subtest: pipe-A-HDMI-A-3
[258.298929] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.039s)
[258.309653] Starting dynamic subtest: pipe-B-HDMI-A-3
[258.310482] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.001s)
[258.319606] Starting dynamic subtest: pipe-C-HDMI-A-3
[258.320577] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.001s)
[258.330293] Starting dynamic subtest: pipe-D-HDMI-A-3
[258.331470] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.001s)
[258.332369] Subtest bad-hsync-end: SUCCESS (0.050s)
[258.430862] [062/130] (766s left) gem_exercise_blt (fast-copy-emit)
[258.498007] Starting subtest: fast-copy-emit
[258.499021] Starting dynamic subtest: linear-smem-smem-emit
[258.529152] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.030s)
[258.540032] Starting dynamic subtest: linear-smem-lmem0-emit
[258.545273] Dynamic subtest linear-smem-lmem0-emit: SUCCESS (0.015s)
[258.556109] Starting dynamic subtest: linear-lmem0-smem-emit
[258.605533] Dynamic subtest linear-lmem0-smem-emit: SUCCESS (0.059s)
[258.616475] Starting dynamic subtest: linear-lmem0-lmem0-emit
[258.664751] Dynamic subtest linear-lmem0-lmem0-emit: SUCCESS (0.058s)
[258.675490] Starting dynamic subtest: ymajor-smem-smem-emit
[258.680333] Dynamic subtest ymajor-smem-smem-emit: SUCCESS (0.014s)
[258.691304] Starting dynamic subtest: ymajor-smem-lmem0-emit
[258.695310] Dynamic subtest ymajor-smem-lmem0-emit: SUCCESS (0.014s)
[258.706072] Starting dynamic subtest: ymajor-lmem0-smem-emit
[258.756170] Dynamic subtest ymajor-lmem0-smem-emit: SUCCESS (0.060s)
[258.766902] Starting dynamic subtest: ymajor-lmem0-lmem0-emit
[258.816002] Dynamic subtest ymajor-lmem0-lmem0-emit: SUCCESS (0.059s)
[258.826689] Starting dynamic subtest: tile4-smem-smem-emit
[258.832429] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.015s)
[258.843124] Starting dynamic subtest: tile4-smem-lmem0-emit
[258.847353] Dynamic subtest tile4-smem-lmem0-emit: SUCCESS (0.014s)
[258.858220] Starting dynamic subtest: tile4-lmem0-smem-emit
[258.908104] Dynamic subtest tile4-lmem0-smem-emit: SUCCESS (0.059s)
[258.918771] Starting dynamic subtest: tile4-lmem0-lmem0-emit
[258.968203] Dynamic subtest tile4-lmem0-lmem0-emit: SUCCESS (0.059s)
[258.978837] Starting dynamic subtest: tile64-smem-smem-emit
[258.984555] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.015s)
[258.995470] Starting dynamic subtest: tile64-smem-lmem0-emit
[258.999410] Dynamic subtest tile64-smem-lmem0-emit: SUCCESS (0.014s)
[259.010154] Starting dynamic subtest: tile64-lmem0-smem-emit
[259.059845] Dynamic subtest tile64-lmem0-smem-emit: SUCCESS (0.059s)
[259.070755] Starting dynamic subtest: tile64-lmem0-lmem0-emit
[259.119012] Dynamic subtest tile64-lmem0-lmem0-emit: SUCCESS (0.058s)
[259.119955] Subtest fast-copy-emit: SUCCESS (0.622s)
[259.223482] [063/130] (766s left) kms_dsc (dsc-fractional-bpp)
[261.228000] Starting subtest: dsc-fractional-bpp
[261.229659] Subtest dsc-fractional-bpp: SKIP (0.000s)
[261.299157] [064/130] (764s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[263.348064] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[263.349924] Subtest psr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[263.438832] [065/130] (761s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[263.576267] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[263.687908] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.107s)
[263.814065] [066/130] (761s left) vgem_basic (sysfs)
[263.892177] Starting subtest: sysfs
[263.893004] Subtest sysfs: SUCCESS (0.000s)
[263.945503] [067/130] (761s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[265.965965] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[267.191130] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.225s)
[267.353387] [068/130] (758s left) kms_getfb (getfb2-handle-closed)
[267.404330] Starting subtest: getfb2-handle-closed
[267.405156] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[267.507304] [069/130] (758s left) kms_prop_blob (invalid-set-prop)
[267.563907] Starting subtest: invalid-set-prop
[267.564779] Subtest invalid-set-prop: SUCCESS (0.000s)
[267.640895] [070/130] (757s left) gem_ppgtt (blt-vs-render-ctxn)
[267.730004] Starting subtest: blt-vs-render-ctxN
[300.641644] Subtest blt-vs-render-ctxN: SUCCESS (32.908s)
[300.804862] [071/130] (724s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[302.881627] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[305.519135] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (2.637s)
[305.680597] [072/130] (719s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[307.701762] Starting subtest: primary-yf-tiled-reflect-x-270
[307.801426] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.099s)
[307.967634] [073/130] (717s left) i915_pm_freq_api (freq-reset)
[308.051102] Starting subtest: freq-reset
[308.051942] Starting dynamic subtest: gt0
[308.329629] Dynamic subtest gt0: SUCCESS (0.276s)
[308.330700] Subtest freq-reset: SUCCESS (0.278s)
[308.403911] [074/130] (717s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[310.398865] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[310.401192] Starting dynamic subtest: pipe-A-HDMI-A-3
[310.409426] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s)
[310.419437] Starting dynamic subtest: pipe-B-HDMI-A-3
[310.427677] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s)
[310.437543] Starting dynamic subtest: pipe-C-HDMI-A-3
[310.446197] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s)
[310.455969] Starting dynamic subtest: pipe-D-HDMI-A-3
[310.464799] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s)
[310.466557] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.013s)
[310.599007] [075/130] (715s left) kms_chamelium_audio (hdmi-audio-edid)
[312.636030] Subtest hdmi-audio-edid: SKIP (0.000s)
[312.706748] [076/130] (713s left) gem_madvise (dontneed-before-pwrite)
[312.755335] Starting subtest: dontneed-before-pwrite
[312.758457] Subtest dontneed-before-pwrite: SKIP (0.002s)
[312.806506] [077/130] (713s left) gen9_exec_parse (bb-start-out)
[312.864097] Subtest bb-start-out: SKIP (0.000s)
[312.906297] [078/130] (712s left) dumb_buffer (map-invalid-size)
[312.962620] Starting subtest: map-invalid-size
[312.963468] Subtest map-invalid-size: SUCCESS (0.000s)
[313.069395] [079/130] (712s left) gem_userptr_blits (process-exit)
[313.149708] Starting subtest: process-exit
[313.164281] Subtest process-exit: SUCCESS (0.015s)
[313.324616] [080/130] (712s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[315.333559] Subtest psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[315.355068] [081/130] (710s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[315.414965] Starting subtest: single-wait-for-submit-available-signaled
[315.415792] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[315.502109] [082/130] (710s left) kms_psr (fbc-pr-primary-mmap-cpu)
[317.535132] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[317.571292] [083/130] (708s left) perf_pmu (semaphore-busy)
[317.632472] Starting subtest: semaphore-busy
[317.633461] Starting dynamic subtest: rcs0
[319.275493] Dynamic subtest rcs0: SUCCESS (1.637s)
[319.286309] Starting dynamic subtest: bcs0
[320.906480] Dynamic subtest bcs0: SUCCESS (1.626s)
[320.917341] Starting dynamic subtest: vcs0
[322.536468] Dynamic subtest vcs0: SUCCESS (1.625s)
[322.547375] Starting dynamic subtest: vcs1
[324.164348] Dynamic subtest vcs1: SUCCESS (1.623s)
[324.175253] Starting dynamic subtest: vecs0
[325.796392] Dynamic subtest vecs0: SUCCESS (1.629s)
[325.797325] Subtest semaphore-busy: SUCCESS (8.163s)
[325.916479] [084/130] (700s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc)
[327.914196] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc
[327.916125] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[328.005634] [085/130] (698s left) kms_prime (basic-crc-vgem)
[332.789277] Subtest basic-crc-vgem: SKIP (0.000s)
[332.861528] [086/130] (693s left) gem_exec_whisper (basic-contexts-priority-all)
[332.927985] Starting subtest: basic-contexts-priority-all
[347.395603] Subtest basic-contexts-priority-all: SUCCESS (14.463s)
[347.627809] [087/130] (678s left) kms_vblank (query-forked)
[349.637843] Starting subtest: query-forked
[349.640262] Starting dynamic subtest: pipe-A-HDMI-A-3
[352.042155] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.402s)
[352.056878] Starting dynamic subtest: pipe-D-HDMI-A-3
[354.297173] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.249s)
[354.298014] Subtest query-forked: SUCCESS (4.659s)
[354.420100] [088/130] (671s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[356.424928] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[356.427249] Starting dynamic subtest: pipe-A-valid-mode
[356.471288] Dynamic subtest pipe-A-valid-mode: SKIP (0.043s)
[356.472992] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SKIP (0.045s)
[356.573769] [089/130] (669s left) gem_mmap_wc (pf-nonblock)
[356.641285] Subtest pf-nonblock: SKIP (0.000s)
[356.667442] [090/130] (669s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[356.721286] Subtest no-spare-fences-busy: SKIP (0.000s)
[356.750258] [091/130] (669s left) kms_psr (fbc-psr2-sprite-render)
[358.747193] Subtest fbc-psr2-sprite-render: SKIP (0.000s)
[358.783858] [092/130] (667s left) gem_softpin (noreloc-interruptible)
[358.854249] Starting subtest: noreloc-interruptible
[364.303668] Subtest noreloc-interruptible: SUCCESS (5.445s)
[364.422345] [093/130] (661s left) gem_mmap (bad-object)
[364.472452] Subtest bad-object: SKIP (0.000s)
[364.498990] [094/130] (661s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[366.500754] Starting subtest: fbcpsr-2p-rte
[366.502478] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[366.578615] [095/130] (659s left) kms_selftest (drm_dp_mst_helper)
[366.678602] Starting subtest: drm_dp_mst_helper
[366.753222] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[366.879332] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.150s)
[366.893675] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[367.022007] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.137s)
[367.058445] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[367.184683] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.159s)
[367.185858] Subtest drm_dp_mst_helper: SUCCESS (0.505s)
[367.382965] [096/130] (659s left) kms_busy (basic-hang)
[369.408433] Starting subtest: basic-hang
[369.417434] Starting dynamic subtest: flip-pipe-A
[370.105098] Dynamic subtest flip-pipe-A: SUCCESS (0.688s)
[370.116736] Starting dynamic subtest: modeset-pipe-A
[370.724645] Dynamic subtest modeset-pipe-A: SUCCESS (0.618s)
[370.739795] Starting dynamic subtest: flip-pipe-D
[371.119018] Dynamic subtest flip-pipe-D: SUCCESS (0.389s)
[371.131780] Starting dynamic subtest: modeset-pipe-D
[371.815594] Dynamic subtest modeset-pipe-D: SUCCESS (0.694s)
[371.820725] Subtest basic-hang: SUCCESS (2.411s)
[371.986158] [097/130] (654s left) kms_flip (2x-blocking-wf_vblank)
[373.981567] Starting subtest: 2x-blocking-wf_vblank
[374.000594] Subtest 2x-blocking-wf_vblank: SKIP (0.019s)
[374.092599] [098/130] (652s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[376.168300] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[379.165321] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (2.996s)
[379.327520] [099/130] (647s left) gem_softpin (allocator-basic-reserve)
[379.392031] Starting subtest: allocator-basic-reserve
[379.616803] Subtest allocator-basic-reserve: SUCCESS (0.221s)
[379.764097] [100/130] (646s left) kms_color (ctm-signed)
[381.762002] Starting subtest: ctm-signed
[381.762895] Starting dynamic subtest: pipe-A-HDMI-A-3
[382.883020] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (1.120s)
[382.894121] Starting dynamic subtest: pipe-B-HDMI-A-3
[383.850106] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.966s)
[383.863078] Starting dynamic subtest: pipe-C-HDMI-A-3
[384.774899] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.924s)
[384.793313] Starting dynamic subtest: pipe-D-HDMI-A-3
[385.688152] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.911s)
[385.689083] Subtest ctm-signed: SUCCESS (3.926s)
[385.820296] [101/130] (640s left) kms_psr (psr-cursor-render)
[387.817377] Subtest psr-cursor-render: SKIP (0.000s)
[387.851996] [102/130] (638s left) kms_flip (basic-plain-flip)
[389.835873] Starting subtest: basic-plain-flip
[389.841594] Starting dynamic subtest: A-HDMI-A3
[390.575870] Dynamic subtest A-HDMI-A3: SUCCESS (0.734s)
[390.595142] Starting dynamic subtest: B-HDMI-A3
[391.257928] Dynamic subtest B-HDMI-A3: SUCCESS (0.678s)
[391.300004] Starting dynamic subtest: C-HDMI-A3
[391.957866] Dynamic subtest C-HDMI-A3: SUCCESS (0.692s)
[391.979936] Starting dynamic subtest: D-HDMI-A3
[392.655678] Dynamic subtest D-HDMI-A3: SUCCESS (0.690s)
[392.658199] Subtest basic-plain-flip: SUCCESS (2.823s)
[392.833447] [103/130] (633s left) kms_cursor_crc (cursor-offscreen-128x42)
[394.976547] Starting subtest: cursor-offscreen-128x42
[394.983602] Starting dynamic subtest: pipe-A-HDMI-A-3
[397.452053] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.469s)
[397.486851] Starting dynamic subtest: pipe-D-HDMI-A-3
[399.846689] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.369s)
[399.847614] Subtest cursor-offscreen-128x42: SUCCESS (4.869s)
[400.170447] [104/130] (626s left) kms_psr (pr-cursor-mmap-gtt)
[402.168940] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[402.197201] [105/130] (624s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[404.214934] Starting subtest: y-tiled-16bpp-rotate-0
[406.053031] Subtest y-tiled-16bpp-rotate-0: SUCCESS (1.833s)
[406.230267] [106/130] (620s left) device_reset (unbind-reset-rebind)
[406.329410] Starting subtest: unbind-reset-rebind
[418.931263] Killing the test because the kernel is tainted.
[539.138560] Timeout. Killing the current test with SIGKILL.
[540.139526] Child refuses to die, tainted 0x40240. Aborting.
[540.147637] Closing watchdogs
[540.152394] Closing watchdogs
Done.