[44.826271] Initializing watchdogs
[44.826337]   /dev/watchdog0
[44.842315] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[44.848127] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[44.850696] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[44.853560] [001/156] (960s left) kms_psr (fbc-psr2-cursor-plane-move)
[44.951280] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s)
[44.996948] [002/156] (960s left) gem_mmap_offset (partial-mmap)
[45.030925] Starting subtest: partial-mmap
[45.031665] Starting dynamic subtest: smem0
[45.034607] Dynamic subtest smem0: SUCCESS (0.004s)
[45.035536] Subtest partial-mmap: SUCCESS (0.004s)
[45.153495] [003/156] (960s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[45.249574] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-mmap-cpu
[45.250969] Subtest hdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[45.350329] [004/156] (960s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[45.450565] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[45.452047] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[45.529662] [005/156] (959s left) kms_invalid_mode (zero-vdisplay)
[45.618546] Starting subtest: zero-vdisplay
[45.619320] Starting dynamic subtest: pipe-A-HDMI-A-1
[45.670839] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.052s)
[45.679937] Starting dynamic subtest: pipe-B-HDMI-A-1
[45.680715] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[45.688089] Starting dynamic subtest: pipe-C-HDMI-A-1
[45.688838] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[45.697086] Starting dynamic subtest: pipe-D-HDMI-A-1
[45.697849] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[45.698654] Subtest zero-vdisplay: SUCCESS (0.060s)
[45.821016] [006/156] (959s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[45.912835] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[45.913628] Starting dynamic subtest: pipe-A-HDMI-A-1
[46.447628] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.532s)
[46.454810] Starting dynamic subtest: pipe-B-HDMI-A-1
[47.041435] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.593s)
[47.047364] Starting dynamic subtest: pipe-C-HDMI-A-1
[47.634590] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.592s)
[47.640566] Starting dynamic subtest: pipe-D-HDMI-A-1
[48.228764] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.593s)
[48.229659] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SUCCESS (2.314s)
[48.391958] [007/156] (957s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-fullscreen)
[48.488102] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-fullscreen
[48.489462] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[48.578115] [008/156] (957s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[48.670457] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[48.671943] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[48.769475] [009/156] (956s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[48.862160] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[48.863553] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[48.962430] [010/156] (956s left) kms_plane_scaling (planes-downscale-factor-0-5)
[49.050733] Starting subtest: planes-downscale-factor-0-5
[49.051444] Starting dynamic subtest: pipe-A
[49.195289] Dynamic subtest pipe-A: SUCCESS (0.145s)
[49.201449] Starting dynamic subtest: pipe-B
[49.345196] Dynamic subtest pipe-B: SUCCESS (0.150s)
[49.351357] Starting dynamic subtest: pipe-C
[49.495164] Dynamic subtest pipe-C: SUCCESS (0.150s)
[49.501181] Starting dynamic subtest: pipe-D
[49.637220] Dynamic subtest pipe-D: SUCCESS (0.142s)
[49.638533] Subtest planes-downscale-factor-0-5: SUCCESS (0.587s)
[49.828109] [011/156] (955s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[49.921539] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[49.922946] Subtest hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[50.016141] [012/156] (955s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[50.107136] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[50.108489] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[50.201112] [013/156] (955s left) gen7_exec_parse (bitmasks)
[50.242397] Subtest bitmasks: SKIP (0.000s)
[50.283282] [014/156] (955s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[50.375655] Starting subtest: fbc-2p-pri-indfb-multidraw
[50.377116] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[50.452744] [015/156] (955s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[50.541799] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[50.543277] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s)
[50.594835] [016/156] (955s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[50.693089] Starting subtest: y-tiled-32bpp-rotate-90
[51.930708] Subtest y-tiled-32bpp-rotate-90: SUCCESS (1.237s)
[52.081523] [017/156] (953s left) sysfs_heartbeat_interval (nopreempt)
[52.119453] Starting subtest: nopreempt
[52.120194] Starting dynamic subtest: vecs0
[55.698643] Dynamic subtest vecs0: SUCCESS (3.578s)
[55.708022] Starting dynamic subtest: vcs0
[59.305539] Dynamic subtest vcs0: SUCCESS (3.606s)
[59.318403] Starting dynamic subtest: bcs0
[62.904217] Dynamic subtest bcs0: SUCCESS (3.597s)
[62.912258] Starting dynamic subtest: rcs0
[66.533874] Dynamic subtest rcs0: SUCCESS (3.629s)
[66.541701] Starting dynamic subtest: vcs1
[70.454722] Dynamic subtest vcs1: SUCCESS (3.920s)
[70.455772] Subtest nopreempt: SUCCESS (18.336s)
[70.524281] [018/156] (935s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[70.617868] Starting subtest: bad-rotation-90-y-tiled-ccs
[70.618643] Starting dynamic subtest: pipe-A-HDMI-A-1
[70.625800] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[70.634565] Starting dynamic subtest: pipe-B-HDMI-A-1
[70.641649] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[70.650166] Starting dynamic subtest: pipe-C-HDMI-A-1
[70.657278] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[70.665173] Starting dynamic subtest: pipe-D-HDMI-A-1
[70.672068] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[70.673425] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.005s)
[70.876203] [019/156] (935s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[70.974793] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[70.976198] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[71.044559] [020/156] (935s left) prime_vgem (wait)
[71.146643] Starting subtest: wait
[71.147396] Starting dynamic subtest: rcs0
[71.171613] Dynamic subtest rcs0: SUCCESS (0.025s)
[71.181402] Starting dynamic subtest: bcs0
[71.195800] Dynamic subtest bcs0: SUCCESS (0.024s)
[71.203478] Starting dynamic subtest: vcs0
[71.211698] Dynamic subtest vcs0: SUCCESS (0.015s)
[71.219216] Starting dynamic subtest: vcs1
[71.229066] Dynamic subtest vcs1: SUCCESS (0.017s)
[71.235639] Starting dynamic subtest: vecs0
[71.247195] Dynamic subtest vecs0: SUCCESS (0.018s)
[71.248063] Subtest wait: SUCCESS (0.101s)
[71.373670] [FACT prime_vgem (wait)] new: kernel.kmod_is_loaded.vgem: true
[71.375304] [021/156] (934s left) i915_power (sanity)
[71.407606] Starting subtest: sanity
[75.427710] Subtest sanity: SUCCESS (4.011s)
[75.543831] [022/156] (930s left) prime_vgem (fence-write-hang)
[75.604710] Subtest fence-write-hang: SKIP (0.000s)
[75.708990] [023/156] (930s left) perf (invalid-oa-exponent)
[75.802381] Starting subtest: invalid-oa-exponent
[75.817829] Subtest invalid-oa-exponent: SUCCESS (0.015s)
[75.859814] [024/156] (930s left) perf (mi-rpc)
[75.933790] Starting subtest: mi-rpc
[75.935142] Subtest mi-rpc: SKIP (0.000s)
[75.984840] [025/156] (930s left) gem_render_copy_redux (flink)
[76.023126] Starting subtest: flink
[76.817963] Subtest flink: SUCCESS (0.795s)
[76.943317] [026/156] (929s left) kms_cursor_crc (cursor-random-32x10)
[77.035220] Starting subtest: cursor-random-32x10
[77.087289] Subtest cursor-random-32x10: SKIP (0.051s)
[77.171376] [027/156] (929s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[77.264434] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[77.265891] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[77.356694] [028/156] (929s left) kms_cursor_crc (cursor-offscreen-64x64)
[77.445275] Starting subtest: cursor-offscreen-64x64
[77.449565] Starting dynamic subtest: pipe-A-HDMI-A-1
[78.703032] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.253s)
[78.748825] Starting dynamic subtest: pipe-D-HDMI-A-1
[79.981022] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.241s)
[79.981753] Subtest cursor-offscreen-64x64: SUCCESS (2.536s)
[80.149411] [029/156] (926s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[80.294396] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[80.398324] [030/156] (926s left) syncobj_wait (invalid-signal-bad-pad)
[80.436741] Starting subtest: invalid-signal-bad-pad
[80.437492] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[80.511361] [031/156] (925s left) gem_busy (extended)
[80.687284] Starting subtest: extended
[80.688361] Starting dynamic subtest: rcs0
[80.710789] Dynamic subtest rcs0: SUCCESS (0.032s)
[80.726911] Starting dynamic subtest: bcs0
[80.737186] Dynamic subtest bcs0: SUCCESS (0.026s)
[80.748208] Starting dynamic subtest: vcs0
[80.753952] Dynamic subtest vcs0: SUCCESS (0.016s)
[80.762639] Starting dynamic subtest: vcs1
[80.771970] Dynamic subtest vcs1: SUCCESS (0.017s)
[80.780163] Starting dynamic subtest: vecs0
[80.785561] Dynamic subtest vecs0: SUCCESS (0.013s)
[80.786370] Subtest extended: SUCCESS (0.107s)
[81.013640] [032/156] (925s left) gem_exec_fence (syncobj-timeline-repeat)
[81.462136] Starting subtest: syncobj-timeline-repeat
[81.817054] Subtest syncobj-timeline-repeat: SUCCESS (0.356s)
[81.979663] [033/156] (924s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[82.013112] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[82.122045] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.107s)
[82.186212] [034/156] (924s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[82.281503] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[82.282974] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[82.403966] [035/156] (924s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[82.511470] Starting subtest: yf-tiled-32bpp-rotate-270
[82.512894] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[82.605499] [036/156] (924s left) syncobj_basic (create-signaled)
[82.638617] Starting subtest: create-signaled
[82.639351] Subtest create-signaled: SUCCESS (0.000s)
[82.698679] [037/156] (924s left) vgem_basic (dmabuf-fence)
[82.735924] Starting subtest: dmabuf-fence
[82.736642] Subtest dmabuf-fence: SUCCESS (0.001s)
[82.804948] [038/156] (923s left) dmabuf_sync_file (import-multiple-read-write)
[82.844156] Starting subtest: import-multiple-read-write
[82.848425] Subtest import-multiple-read-write: SUCCESS (0.005s)
[82.896954] [039/156] (923s left) api_intel_bb (offset-control)
[82.930242] Starting subtest: offset-control
[82.935399] Subtest offset-control: SUCCESS (0.005s)
[83.041331] [040/156] (923s left) kms_chamelium_edid (dp-mode-timings)
[83.189207] Subtest dp-mode-timings: SKIP (0.000s)
[83.300297] [041/156] (923s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[83.394659] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[83.396109] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[83.469291] [042/156] (923s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-fullscreen)
[83.565495] Starting subtest: hdr-1p-primscrn-spr-indfb-fullscreen
[83.566872] Subtest hdr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[83.644807] [043/156] (923s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[83.731734] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[83.732413] Starting dynamic subtest: pipe-A-HDMI-A-1
[83.739074] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[83.746487] Starting dynamic subtest: pipe-B-HDMI-A-1
[83.753644] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[83.761040] Starting dynamic subtest: pipe-C-HDMI-A-1
[83.768274] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[83.775414] Starting dynamic subtest: pipe-D-HDMI-A-1
[83.782548] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[83.783890] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.007s)
[83.984480] [044/156] (923s left) kms_flip (blocking-absolute-wf_vblank)
[84.073538] Starting subtest: blocking-absolute-wf_vblank
[84.075882] Starting dynamic subtest: A-HDMI-A1
[91.773821] Dynamic subtest A-HDMI-A1: SUCCESS (7.676s)
[91.780973] Starting dynamic subtest: B-HDMI-A1
[99.427623] Dynamic subtest B-HDMI-A1: SUCCESS (7.671s)
[99.438541] Starting dynamic subtest: C-HDMI-A1
[107.120710] Dynamic subtest C-HDMI-A1: SUCCESS (7.665s)
[107.127923] Starting dynamic subtest: D-HDMI-A1
[114.759949] Dynamic subtest D-HDMI-A1: SUCCESS (7.664s)
[114.760965] Subtest blocking-absolute-wf_vblank: SUCCESS (30.687s)
[114.923210] [045/156] (892s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[115.019501] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[116.533707] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (1.515s)
[116.662334] [046/156] (890s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[116.752710] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[116.753407] Starting dynamic subtest: pipe-A
[116.886926] Dynamic subtest pipe-A: SUCCESS (0.135s)
[116.895168] Starting dynamic subtest: pipe-B
[117.037325] Dynamic subtest pipe-B: SUCCESS (0.150s)
[117.044799] Starting dynamic subtest: pipe-C
[117.200094] Dynamic subtest pipe-C: SUCCESS (0.162s)
[117.208264] Starting dynamic subtest: pipe-D
[117.358115] Dynamic subtest pipe-D: SUCCESS (0.157s)
[117.358813] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SUCCESS (0.607s)
[117.554341] [047/156] (889s left) kms_plane_alpha_blend (constant-alpha-max)
[117.645284] Starting subtest: constant-alpha-max
[117.710437] Starting dynamic subtest: pipe-A-HDMI-A-1
[118.191497] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.480s)
[118.201375] Starting dynamic subtest: pipe-D-HDMI-A-1
[118.702778] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.510s)
[118.703512] Subtest constant-alpha-max: SUCCESS (1.058s)
[118.879365] [048/156] (888s left) gem_ctx_persistence (file)
[118.918282] Starting subtest: file
[118.999224] Subtest file: SUCCESS (0.080s)
[119.109060] [049/156] (888s left) perf_pmu (init-busy)
[119.146174] Starting subtest: init-busy
[119.146957] Starting dynamic subtest: rcs0
[119.147714] Dynamic subtest rcs0: SUCCESS (0.001s)
[119.158754] Starting dynamic subtest: bcs0
[119.159560] Dynamic subtest bcs0: SUCCESS (0.001s)
[119.167238] Starting dynamic subtest: vcs0
[119.168032] Dynamic subtest vcs0: SUCCESS (0.001s)
[119.175643] Starting dynamic subtest: vcs1
[119.176420] Dynamic subtest vcs1: SUCCESS (0.001s)
[119.183682] Starting dynamic subtest: vecs0
[119.184533] Dynamic subtest vecs0: SUCCESS (0.001s)
[119.185268] Subtest init-busy: SUCCESS (0.008s)
[119.219179] [050/156] (888s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[119.319029] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[119.320411] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[119.391793] [051/156] (887s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[119.482116] Starting subtest: plane-all-modeset-transition-fencing
[119.482873] Starting dynamic subtest: pipe-A-HDMI-A-1
[132.456663] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (12.974s)
[132.501828] Starting dynamic subtest: pipe-B-HDMI-A-1
[143.725144] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (11.231s)
[143.751736] Subtest plane-all-modeset-transition-fencing: SUCCESS (24.270s)
[143.894013] [052/156] (863s left) gem_partial_pwrite_pread (write-snoop)
[143.934702] Starting subtest: write-snoop
[154.220572] Subtest write-snoop: SUCCESS (10.286s)
[154.323481] [053/156] (853s left) kms_psr (pr-cursor-plane-move)
[154.413803] Subtest pr-cursor-plane-move: SKIP (0.000s)
[154.458258] [054/156] (852s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[154.555958] Starting subtest: x-tiled-32bpp-rotate-270
[154.631653] Subtest x-tiled-32bpp-rotate-270: SKIP (0.075s)
[154.746362] [055/156] (852s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[154.781651] Starting subtest: invalid-multi-wait-unsubmitted
[154.782340] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[154.851263] [056/156] (852s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-blt)
[154.942330] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-blt
[154.943827] Subtest fbchdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[155.023641] [057/156] (852s left) kms_rotation_crc (exhaust-fences)
[155.111834] Starting subtest: exhaust-fences
[156.239363] Subtest exhaust-fences: SUCCESS (1.128s)
[156.335333] [058/156] (851s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[156.429423] Starting subtest: psr-rgb101010-draw-mmap-gtt
[156.430819] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[156.540257] [059/156] (851s left) gem_softpin (evict-prime)
[156.577270] Starting subtest: evict-prime
[156.577988] Starting dynamic subtest: rcs0
[157.704937] Dynamic subtest rcs0: SUCCESS (1.127s)
[157.729955] Starting dynamic subtest: bcs0
[158.829902] Dynamic subtest bcs0: SUCCESS (1.123s)
[158.854715] Starting dynamic subtest: vcs0
[159.952770] Dynamic subtest vcs0: SUCCESS (1.120s)
[159.979728] Starting dynamic subtest: vcs1
[161.072728] Dynamic subtest vcs1: SUCCESS (1.118s)
[161.101409] Starting dynamic subtest: vecs0
[162.194668] Dynamic subtest vecs0: SUCCESS (1.120s)
[162.223887] Starting dynamic subtest: all
[163.317881] Dynamic subtest all: SUCCESS (1.121s)
[163.319212] Subtest evict-prime: SUCCESS (6.741s)
[163.416640] [060/156] (844s left) gem_mmap_gtt (close-race)
[163.450159] Starting subtest: close-race
[183.550474] Subtest close-race: SUCCESS (20.066s)
[183.642997] [061/156] (824s left) kms_dsc (dsc-basic-ultrajoiner)
[183.735115] Starting subtest: dsc-basic-ultrajoiner
[183.736587] Subtest dsc-basic-ultrajoiner: SKIP (0.000s)
[183.796200] [062/156] (824s left) gem_exec_whisper (basic-fds-forked)
[183.839345] Starting subtest: basic-fds-forked
[187.125180] Subtest basic-fds-forked: SUCCESS (3.285s)
[187.319188] [063/156] (820s left) kms_setmode (basic-clone-single-crtc)
[187.352984] Starting subtest: basic-clone-single-crtc
[187.355151] Subtest basic-clone-single-crtc: SKIP (0.001s)
[187.435211] [064/156] (820s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-render)
[187.531430] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-render
[187.532845] Subtest hdr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[187.624929] [065/156] (820s left) kms_atomic (atomic-plane-damage)
[187.715036] Starting subtest: atomic-plane-damage
[187.770978] Starting dynamic subtest: pipe-A-HDMI-A-1
[187.971144] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.201s)
[187.971907] Subtest atomic-plane-damage: SUCCESS (0.257s)
[188.116116] [066/156] (819s left) gem_mmap_wc (write-wc-read-gtt)
[188.152391] Starting subtest: write-wc-read-gtt
[188.456702] Subtest write-wc-read-gtt: SUCCESS (0.296s)
[188.533315] [067/156] (819s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[188.626093] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[188.627555] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[188.718998] [068/156] (819s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[188.817403] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[189.169449] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.352s)
[189.328730] [069/156] (818s left) kms_cursor_crc (cursor-sliding-32x32)
[189.420096] Starting subtest: cursor-sliding-32x32
[189.483893] Subtest cursor-sliding-32x32: SKIP (0.063s)
[189.577982] [070/156] (818s left) gem_ctx_param (invalid-ctx-get)
[189.612321] Starting subtest: invalid-ctx-get
[189.613038] Subtest invalid-ctx-get: SUCCESS (0.000s)
[189.674575] [071/156] (818s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[189.764396] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[189.810821] [072/156] (818s left) kms_psr (psr-sprite-plane-move)
[189.900633] Subtest psr-sprite-plane-move: SKIP (0.000s)
[189.943967] [073/156] (818s left) gem_ctx_exec (basic-invalid-context)
[189.979116] Starting subtest: basic-invalid-context
[189.981288] Subtest basic-invalid-context: SUCCESS (0.002s)
[190.102477] [074/156] (818s left) kms_frontbuffer_tracking (fbchdr-2p-rte)
[190.194380] Starting subtest: fbchdr-2p-rte
[190.195874] Subtest fbchdr-2p-rte: SKIP (0.000s)
[190.304056] [075/156] (818s left) gem_ctx_shared (q-smoketest)
[190.349216] Starting subtest: Q-smoketest
[190.349937] Starting dynamic subtest: rcs0
[195.808268] Dynamic subtest rcs0: SUCCESS (5.420s)
[195.817649] Starting dynamic subtest: bcs0
[201.230649] Dynamic subtest bcs0: SUCCESS (5.422s)
[201.240357] Starting dynamic subtest: vcs0
[206.647529] Dynamic subtest vcs0: SUCCESS (5.416s)
[206.656430] Starting dynamic subtest: vcs1
[212.073779] Dynamic subtest vcs1: SUCCESS (5.425s)
[212.084849] Starting dynamic subtest: vecs0
[217.503483] Dynamic subtest vecs0: SUCCESS (5.426s)
[217.504423] Subtest Q-smoketest: SUCCESS (27.114s)
[217.651224] [076/156] (790s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[217.685727] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[217.686431] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[217.749204] [077/156] (790s left) perf (low-oa-exponent-permissions)
[217.822163] Starting subtest: low-oa-exponent-permissions
[217.858037] Subtest low-oa-exponent-permissions: SUCCESS (0.036s)
[217.902681] [078/156] (790s left) perf_pmu (enable-race)
[217.938521] Starting subtest: enable-race
[217.939301] Starting dynamic subtest: rcs0
[230.533142] Dynamic subtest rcs0: SUCCESS (12.569s)
[230.543809] Starting dynamic subtest: bcs0
[243.103237] Dynamic subtest bcs0: SUCCESS (12.568s)
[243.117596] Starting dynamic subtest: vcs0
[255.655077] Dynamic subtest vcs0: SUCCESS (12.577s)
[255.664211] Starting dynamic subtest: vcs1
[268.248669] Dynamic subtest vcs1: SUCCESS (12.568s)
[268.266059] Starting dynamic subtest: vecs0
[280.816472] Dynamic subtest vecs0: SUCCESS (12.575s)
[280.817434] Subtest enable-race: SUCCESS (62.862s)
[280.869022] [079/156] (727s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-mmap-wc)
[280.967482] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-mmap-wc
[280.968904] Subtest fbchdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[281.074598] [080/156] (727s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[281.164366] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[281.165087] Starting dynamic subtest: pipe-A-HDMI-A-1
[281.172238] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[281.180572] Starting dynamic subtest: pipe-B-HDMI-A-1
[281.187427] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[281.195535] Starting dynamic subtest: pipe-C-HDMI-A-1
[281.202366] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[281.210231] Starting dynamic subtest: pipe-D-HDMI-A-1
[281.217153] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[281.218533] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.007s)
[281.427673] [081/156] (727s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-shrfb-pgflip-blt)
[281.524963] Starting subtest: hdr-2p-scndscrn-shrfb-pgflip-blt
[281.526444] Subtest hdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[281.627891] [082/156] (727s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-shrfb-pgflip-blt)
[281.721672] Starting subtest: fbcpsrhdr-2p-scndscrn-shrfb-pgflip-blt
[281.723146] Subtest fbcpsrhdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[281.824651] [083/156] (726s left) i915_drm_fdinfo (basics)
[281.862035] Starting subtest: basics
[281.862793] Subtest basics: SUCCESS (0.000s)
[281.926960] [084/156] (726s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[282.019349] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-mmap-cpu
[282.020795] Subtest fbchdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[282.115266] [085/156] (726s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[282.241920] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[282.286169] [086/156] (726s left) kms_frontbuffer_tracking (fbchdr-tiling-4)
[282.380738] Starting subtest: fbchdr-tiling-4
[282.382134] Subtest fbchdr-tiling-4: SKIP (0.000s)
[282.462904] [087/156] (726s left) kms_prop_blob (blob-prop-lifetime)
[282.498406] Starting subtest: blob-prop-lifetime
[282.499127] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[282.578844] [088/156] (726s left) prime_self_import (basic-llseek-bad)
[282.610922] Starting subtest: basic-llseek-bad
[282.613872] Subtest basic-llseek-bad: SUCCESS (0.002s)
[282.719649] [089/156] (726s left) gem_exec_fence (basic-busy)
[282.884648] Starting subtest: basic-busy
[282.885760] Starting dynamic subtest: rcs0
[282.917506] Dynamic subtest rcs0: SUCCESS (0.032s)
[282.937144] Starting dynamic subtest: bcs0
[282.952675] Dynamic subtest bcs0: SUCCESS (0.033s)
[282.968136] Starting dynamic subtest: vcs0
[282.985501] Dynamic subtest vcs0: SUCCESS (0.031s)
[282.999492] Starting dynamic subtest: vcs1
[283.015425] Dynamic subtest vcs1: SUCCESS (0.028s)
[283.029771] Starting dynamic subtest: vecs0
[283.053628] Dynamic subtest vecs0: SUCCESS (0.036s)
[283.054846] Subtest basic-busy: SUCCESS (0.170s)
[283.561863] [090/156] (725s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[283.658839] Starting subtest: fbc-rgb565-draw-pwrite
[285.020073] Subtest fbc-rgb565-draw-pwrite: SUCCESS (1.361s)
[285.134302] [091/156] (723s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[285.170864] Starting subtest: invalid-multi-wait-unsubmitted
[285.171664] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[285.233388] [092/156] (723s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-mmap-gtt)
[285.329427] Starting subtest: fbcpsrhdr-rgb565-draw-mmap-gtt
[285.330930] Subtest fbcpsrhdr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[285.424071] [093/156] (723s left) gem_pxp (reject-modify-context-protection-off-1)
[285.528269] Starting subtest: reject-modify-context-protection-off-1
[285.529315] Subtest reject-modify-context-protection-off-1: SUCCESS (0.001s)
[285.599689] [094/156] (723s left) gem_ctx_persistence (legacy-engines-persistence)
[285.638229] Starting subtest: legacy-engines-persistence
[285.639023] Starting dynamic subtest: render
[286.393792] Dynamic subtest render: SUCCESS (0.755s)
[286.406304] Starting dynamic subtest: bsd1
[287.162598] Dynamic subtest bsd1: SUCCESS (0.765s)
[287.174332] Starting dynamic subtest: bsd2
[287.930681] Dynamic subtest bsd2: SUCCESS (0.765s)
[287.943769] Starting dynamic subtest: blt
[288.704720] Dynamic subtest blt: SUCCESS (0.770s)
[288.716385] Starting dynamic subtest: vebox
[289.465719] Dynamic subtest vebox: SUCCESS (0.758s)
[289.470331] Subtest legacy-engines-persistence: SUCCESS (3.831s)
[289.539880] [095/156] (719s left) kms_addfb_basic (bad-pitch-256)
[289.574719] Starting subtest: bad-pitch-256
[289.575479] Subtest bad-pitch-256: SUCCESS (0.000s)
[289.726675] [096/156] (719s left) kms_psr (pr-sprite-blt)
[289.817767] Subtest pr-sprite-blt: SKIP (0.000s)
[289.861740] [097/156] (719s left) gem_exec_schedule (preempt-contexts)
[289.907961] Starting subtest: preempt-contexts
[289.908736] Starting dynamic subtest: rcs0
[289.947144] Dynamic subtest rcs0: SUCCESS (0.039s)
[289.957264] Starting dynamic subtest: bcs0
[289.990342] Dynamic subtest bcs0: SUCCESS (0.042s)
[289.999101] Starting dynamic subtest: vcs0
[290.033491] Dynamic subtest vcs0: SUCCESS (0.042s)
[290.042509] Starting dynamic subtest: vcs1
[290.074080] Dynamic subtest vcs1: SUCCESS (0.039s)
[290.083095] Starting dynamic subtest: vecs0
[290.118167] Dynamic subtest vecs0: SUCCESS (0.043s)
[290.118922] Subtest preempt-contexts: SUCCESS (0.210s)
[290.419930] [098/156] (718s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[290.453082] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[290.492936] [099/156] (718s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-mmap-cpu)
[290.587740] Starting subtest: psrhdr-rgb565-draw-mmap-cpu
[290.589101] Subtest psrhdr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[290.683697] [100/156] (718s left) gem_exec_schedule (smoketest-all)
[290.729047] Starting subtest: smoketest-all
[323.009867] Subtest smoketest-all: SUCCESS (32.264s)
[323.293375] [101/156] (686s left) kms_frontbuffer_tracking (hdr-rgb565-draw-pwrite)
[323.390462] Starting subtest: hdr-rgb565-draw-pwrite
[323.391875] Subtest hdr-rgb565-draw-pwrite: SKIP (0.000s)
[323.488979] [102/156] (685s left) syncobj_timeline (invalid-signal-zero-handles)
[323.525159] Starting subtest: invalid-signal-zero-handles
[323.525929] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[323.593665] [103/156] (685s left) kms_properties (crtc-properties-legacy)
[323.682242] Starting subtest: crtc-properties-legacy
[323.683073] Starting dynamic subtest: pipe-A-HDMI-A-1
[323.842308] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.159s)
[323.853362] Starting dynamic subtest: pipe-B-HDMI-A-1
[324.054896] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.209s)
[324.063826] Starting dynamic subtest: pipe-C-HDMI-A-1
[324.238062] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.182s)
[324.247757] Starting dynamic subtest: pipe-D-HDMI-A-1
[324.450159] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.210s)
[324.450906] Subtest crtc-properties-legacy: SUCCESS (0.768s)
[324.606535] [104/156] (684s left) gem_softpin (32b-excludes-last-page)
[324.648138] Starting subtest: 32b-excludes-last-page
[324.650264] Subtest 32b-excludes-last-page: SUCCESS (0.002s)
[324.754586] [105/156] (684s left) gem_exec_schedule (u-independent)
[324.799745] Starting subtest: u-independent
[324.800447] Starting dynamic subtest: rcs0
[324.905596] Dynamic subtest rcs0: SUCCESS (0.105s)
[324.921577] Starting dynamic subtest: bcs0
[325.014399] Dynamic subtest bcs0: SUCCESS (0.106s)
[325.034447] Starting dynamic subtest: vcs0
[325.127915] Dynamic subtest vcs0: SUCCESS (0.111s)
[325.148500] Starting dynamic subtest: vcs1
[325.242882] Dynamic subtest vcs1: SUCCESS (0.112s)
[325.262758] Starting dynamic subtest: vecs0
[325.366553] Dynamic subtest vecs0: SUCCESS (0.121s)
[325.368050] Subtest u-independent: SUCCESS (0.568s)
[325.669525] [106/156] (683s left) gem_ctx_param (invalid-param-get)
[325.703034] Starting subtest: invalid-param-get
[325.703735] Subtest invalid-param-get: SUCCESS (0.000s)
[325.775397] [107/156] (683s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-pwrite)
[325.889313] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-pwrite
[325.890710] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[325.971670] [108/156] (683s left) gem_mmap_wc (write-gtt-read-wc)
[326.005579] Starting subtest: write-gtt-read-wc
[326.322416] Subtest write-gtt-read-wc: SUCCESS (0.309s)
[326.400152] [109/156] (683s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-wc)
[326.495177] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-wc
[326.496689] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[326.598816] [110/156] (683s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-shrfb-msflip-blt)
[326.692829] Starting subtest: psrhdr-2p-primscrn-shrfb-msflip-blt
[326.694266] Subtest psrhdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[326.788481] [111/156] (683s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[326.883114] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[326.884878] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[327.011469] [112/156] (682s left) kms_content_protection (uevent)
[327.106551] Starting subtest: uevent
[327.112182] Subtest uevent: SKIP (0.004s)
[327.204879] [113/156] (682s left) kms_psr (psr-cursor-plane-move)
[327.295807] Subtest psr-cursor-plane-move: SKIP (0.000s)
[327.341247] [114/156] (682s left) kms_psr (fbc-pr-suspend)
[327.431631] Subtest fbc-pr-suspend: SKIP (0.000s)
[327.473872] [115/156] (682s left) kms_pm_rpm (cursor)
[328.881229] Starting subtest: cursor
[341.281031] Subtest cursor: SUCCESS (12.391s)
[341.459594] [116/156] (668s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[341.554538] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[341.555947] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[341.662471] [117/156] (668s left) kms_plane (plane-panning-bottom-right)
[341.750492] Starting subtest: plane-panning-bottom-right
[341.751240] Starting dynamic subtest: pipe-A
[342.127761] Dynamic subtest pipe-A: SUCCESS (0.376s)
[342.140804] Starting dynamic subtest: pipe-B
[342.479994] Dynamic subtest pipe-B: SUCCESS (0.349s)
[342.480802] Subtest plane-panning-bottom-right: SUCCESS (0.730s)
[342.622031] [118/156] (667s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[342.715266] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[342.716794] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[342.777338] [119/156] (667s left) gem_userptr_blits (huge-split)
[342.830402] Starting subtest: huge-split
[342.834317] Subtest huge-split: SUCCESS (0.004s)
[342.958824] [120/156] (667s left) kms_hdr (static-toggle-suspend)
[343.048085] Starting subtest: static-toggle-suspend
[343.049903] Starting dynamic subtest: pipe-A-HDMI-A-1-XRGB2101010
[343.051306] Dynamic subtest pipe-A-HDMI-A-1-XRGB2101010: SKIP (0.000s)
[343.059863] Starting dynamic subtest: pipe-A-HDMI-A-1-XRGB16161616F
[343.061282] Dynamic subtest pipe-A-HDMI-A-1-XRGB16161616F: SKIP (0.000s)
[343.062634] Subtest static-toggle-suspend: SKIP (0.004s)
[343.110869] [121/156] (667s left) gem_exec_balancer (bonded-true-hang)
[343.272228] Starting subtest: bonded-true-hang
[358.653197] Subtest bonded-true-hang: SUCCESS (15.379s)
[358.733918] [122/156] (651s left) syncobj_timeline (signal-array)
[358.768213] Starting subtest: signal-array
[358.768973] Subtest signal-array: SUCCESS (0.000s)
[358.846672] [123/156] (651s left) gen3_render_linear_blits
[358.924817] [124/156] (651s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[359.015495] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[359.016265] Starting dynamic subtest: pipe-A-HDMI-A-1
[359.023448] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[359.034102] Starting dynamic subtest: pipe-B-HDMI-A-1
[359.041264] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[359.051622] Starting dynamic subtest: pipe-C-HDMI-A-1
[359.058210] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[359.066360] Starting dynamic subtest: pipe-D-HDMI-A-1
[359.073689] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[359.075135] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SKIP (0.006s)
[359.274182] [125/156] (651s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-pwrite)
[359.368432] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-pwrite
[359.369887] Subtest psrhdr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[359.451563] [126/156] (650s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite)
[359.543454] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite
[360.807819] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (1.265s)
[360.949339] [127/156] (649s left) kms_flip (2x-flip-vs-dpms-on-nop)
[361.044546] Starting subtest: 2x-flip-vs-dpms-on-nop
[361.054180] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.009s)
[361.151760] [128/156] (649s left) perf (oa-exponents)
[361.239879] Starting subtest: oa-exponents
[361.240586] Starting dynamic subtest: 0-rcs0
[364.630844] Dynamic subtest 0-rcs0: SUCCESS (3.383s)
[364.631575] Subtest oa-exponents: SUCCESS (3.384s)
[364.672258] [129/156] (645s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[364.789434] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[364.790831] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[364.887793] [130/156] (645s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[364.982474] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc
[364.983929] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[365.069952] [131/156] (645s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[365.159448] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[365.208117] [132/156] (645s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[365.301477] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[365.302893] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[365.398100] [133/156] (645s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[365.492519] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[365.493942] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[365.601161] [134/156] (645s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[365.691056] Starting subtest: addfb25-yf-tiled-legacy
[365.691804] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[365.800055] [135/156] (645s left) kms_lease (setcrtc-implicit-plane)
[365.889085] Starting subtest: setcrtc-implicit-plane
[365.890941] Starting dynamic subtest: pipe-A-HDMI-A-1
[366.092962] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.203s)
[366.106978] Starting dynamic subtest: pipe-B-HDMI-A-1
[366.266187] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.170s)
[366.279072] Starting dynamic subtest: pipe-C-HDMI-A-1
[366.451726] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.183s)
[366.462132] Starting dynamic subtest: pipe-D-HDMI-A-1
[366.626930] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.170s)
[366.627734] Subtest setcrtc-implicit-plane: SUCCESS (0.735s)
[366.796537] [136/156] (644s left) kms_vblank (wait-idle)
[366.886176] Starting subtest: wait-idle
[366.888057] Starting dynamic subtest: pipe-A-HDMI-A-1
[368.068988] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.181s)
[368.083729] Starting dynamic subtest: pipe-D-HDMI-A-1
[369.258530] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.184s)
[369.260379] Subtest wait-idle: SUCCESS (2.373s)
[369.428299] [137/156] (641s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[369.526777] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[370.827780] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (1.302s)
[370.977134] [138/156] (639s left) kms_cursor_legacy (torture-move)
[371.069952] Starting subtest: torture-move
[371.070720] Starting dynamic subtest: pipe-A
[376.569738] Dynamic subtest pipe-A: SUCCESS (5.465s)
[376.579525] Starting dynamic subtest: pipe-B
[382.054186] Dynamic subtest pipe-B: SUCCESS (5.483s)
[382.065754] Starting dynamic subtest: pipe-C
[387.537190] Dynamic subtest pipe-C: SUCCESS (5.483s)
[387.549460] Starting dynamic subtest: pipe-D
[393.029883] Dynamic subtest pipe-D: SUCCESS (5.491s)
[393.041602] Starting dynamic subtest: all-pipes
[398.521315] Dynamic subtest all-pipes: SUCCESS (5.489s)
[398.522080] Subtest torture-move: SUCCESS (27.417s)
[398.571920] [139/156] (612s left) gem_exec_suspend (basic-s3-devices)
[398.621771] Starting subtest: basic-S3-devices
[398.622578] Starting dynamic subtest: smem
[405.645992] Dynamic subtest smem: SUCCESS (7.024s)
[405.646843] Subtest basic-S3-devices: SUCCESS (7.025s)
[414.877558] [140/156] (605s left) i915_getparams_basic (basic-subslice-total)
[414.922914] Starting subtest: basic-subslice-total
[414.924409] Subtest basic-subslice-total: SUCCESS (0.000s)
[414.989944] [141/156] (605s left) i915_pm_rpm (system-suspend-execbuf)
[416.388804] Starting subtest: system-suspend-execbuf
[460.467758] Subtest system-suspend-execbuf: SUCCESS (28.988s)
[460.708642] [142/156] (559s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-indfb-pgflip-blt)
[460.803335] Starting subtest: psrhdr-1p-primscrn-indfb-pgflip-blt
[460.804726] Subtest psrhdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[460.898667] [143/156] (559s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[460.993637] Starting subtest: fbcpsr-stridechange
[460.995119] Subtest fbcpsr-stridechange: SKIP (0.000s)
[461.101557] [144/156] (559s left) gem_exec_flush (basic-wb-ro-before-default)
[461.144235] Starting subtest: basic-wb-ro-before-default
[466.576148] Subtest basic-wb-ro-before-default: SUCCESS (5.430s)
[466.785704] [145/156] (553s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[466.875939] Starting subtest: plane-ctm3x4-lut1d
[466.970275] Starting dynamic subtest: pipe-A-plane-0
[467.061856] Dynamic subtest pipe-A-plane-0: SUCCESS (0.091s)
[467.078169] Starting dynamic subtest: pipe-A-plane-1
[467.154044] Dynamic subtest pipe-A-plane-1: SUCCESS (0.089s)
[467.169824] Starting dynamic subtest: pipe-A-plane-2
[467.253093] Dynamic subtest pipe-A-plane-2: SUCCESS (0.095s)
[467.470063] Starting dynamic subtest: pipe-B-plane-0
[467.545419] Dynamic subtest pipe-B-plane-0: SUCCESS (0.083s)
[467.564168] Starting dynamic subtest: pipe-B-plane-1
[467.635697] Dynamic subtest pipe-B-plane-1: SUCCESS (0.088s)
[467.651995] Starting dynamic subtest: pipe-B-plane-2
[467.727582] Dynamic subtest pipe-B-plane-2: SUCCESS (0.089s)
[467.925498] Starting dynamic subtest: pipe-C-plane-0
[468.000104] Dynamic subtest pipe-C-plane-0: SUCCESS (0.083s)
[468.019676] Starting dynamic subtest: pipe-C-plane-1
[468.100195] Dynamic subtest pipe-C-plane-1: SUCCESS (0.097s)
[468.115579] Starting dynamic subtest: pipe-C-plane-2
[468.199856] Dynamic subtest pipe-C-plane-2: SUCCESS (0.097s)
[468.402613] Starting dynamic subtest: pipe-D-plane-0
[468.485602] Dynamic subtest pipe-D-plane-0: SUCCESS (0.092s)
[468.500558] Starting dynamic subtest: pipe-D-plane-1
[468.585642] Dynamic subtest pipe-D-plane-1: SUCCESS (0.098s)
[468.602544] Starting dynamic subtest: pipe-D-plane-2
[468.685576] Dynamic subtest pipe-D-plane-2: SUCCESS (0.098s)
[468.734871] Subtest plane-ctm3x4-lut1d: SUCCESS (1.858s)
[468.854212] [146/156] (551s left) sw_sync (sync_random_merge)
[468.891008] Starting subtest: sync_random_merge
[468.954428] Subtest sync_random_merge: SUCCESS (0.063s)
[469.018605] [147/156] (551s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[469.052599] Starting subtest: single-wait-for-submit-available-submitted
[469.053330] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[469.133467] [148/156] (551s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[469.226402] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[469.227918] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[469.329017] [149/156] (551s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[469.417959] Starting subtest: cursorB-vs-flipA-varying-size
[469.420360] Subtest cursorB-vs-flipA-varying-size: SKIP (0.002s)
[469.498635] [150/156] (551s left) gem_exec_params (mmapped)
[469.537766] Starting subtest: mmapped
[469.538579] Subtest mmapped: SUCCESS (0.001s)
[469.654985] [151/156] (550s left) perf (short-reads)
[469.735108] Starting subtest: short-reads
[469.747366] Subtest short-reads: SUCCESS (0.012s)
[469.791275] [152/156] (550s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[469.882006] Starting subtest: flip-vs-cursor-varying-size
[478.614934] Subtest flip-vs-cursor-varying-size: SUCCESS (8.732s)
[478.774842] [153/156] (541s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-move)
[478.872361] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-move
[478.873792] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[478.973932] [154/156] (541s left) gem_exercise_blt (fast-copy)
[479.010567] Starting subtest: fast-copy
[479.011313] Starting dynamic subtest: linear-smem-smem
[479.030663] Dynamic subtest linear-smem-smem: SUCCESS (0.019s)
[479.041376] Starting dynamic subtest: ymajor-smem-smem
[479.049720] Dynamic subtest ymajor-smem-smem: SUCCESS (0.018s)
[479.060326] Starting dynamic subtest: tile4-smem-smem
[479.067840] Dynamic subtest tile4-smem-smem: SUCCESS (0.017s)
[479.078436] Starting dynamic subtest: tile64-smem-smem
[479.086071] Dynamic subtest tile64-smem-smem: SUCCESS (0.017s)
[479.086791] Subtest fast-copy: SUCCESS (0.076s)
[479.207458] [155/156] (541s left) gem_exec_flush (basic-batch-kernel-default-uc)
[479.249423] Starting subtest: basic-batch-kernel-default-uc
[484.829755] Subtest basic-batch-kernel-default-uc: SUCCESS (5.581s)
[485.028204] [156/156] (535s left) gem_eio (in-flight-1us)
[485.072933] Starting subtest: in-flight-1us
[487.328810] Subtest in-flight-1us: SUCCESS (2.256s)
[487.471815] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
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_invalid_mode
results: parsing output: 5/ for test: kms_ccs
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_plane_scaling
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gen7_exec_parse
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_flip_scaled_crc
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: sysfs_heartbeat_interval
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: prime_vgem
results: parsing output: 20/ for test: i915_power
results: parsing output: 21/ for test: prime_vgem
results: parsing output: 22/ for test: perf
results: parsing output: 23/ for test: perf
results: parsing output: 24/ for test: gem_render_copy_redux
results: parsing output: 25/ for test: kms_cursor_crc
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_cursor_crc
results: parsing output: 28/ for test: kms_chamelium_hpd
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: gem_busy
results: parsing output: 31/ for test: gem_exec_fence
results: parsing output: 32/ for test: syncobj_timeline
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: syncobj_basic
results: parsing output: 36/ for test: vgem_basic
results: parsing output: 37/ for test: dmabuf_sync_file
results: parsing output: 38/ for test: api_intel_bb
results: parsing output: 39/ for test: kms_chamelium_edid
results: parsing output: 40/ for test: kms_plane
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_plane_scaling
results: parsing output: 46/ for test: kms_plane_alpha_blend
results: parsing output: 47/ for test: gem_ctx_persistence
results: parsing output: 48/ for test: perf_pmu
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: kms_atomic_transition
results: parsing output: 51/ for test: gem_partial_pwrite_pread
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_rotation_crc
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_softpin
results: parsing output: 59/ for test: gem_mmap_gtt
results: parsing output: 60/ for test: kms_dsc
results: parsing output: 61/ for test: gem_exec_whisper
results: parsing output: 62/ for test: kms_setmode
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_atomic
results: parsing output: 65/ for test: gem_mmap_wc
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: kms_cursor_crc
results: parsing output: 69/ for test: gem_ctx_param
results: parsing output: 70/ for test: kms_psr2_sf
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: gem_ctx_exec
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_ctx_shared
results: parsing output: 75/ for test: syncobj_wait
results: parsing output: 76/ for test: perf
results: parsing output: 77/ for test: perf_pmu
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: i915_drm_fdinfo
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_tiled_display
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_prop_blob
results: parsing output: 87/ for test: prime_self_import
results: parsing output: 88/ for test: gem_exec_fence
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: syncobj_wait
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_pxp
results: parsing output: 93/ for test: gem_ctx_persistence
results: parsing output: 94/ for test: kms_addfb_basic
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: gem_exec_schedule
results: parsing output: 97/ for test: kms_pipe_b_c_ivb
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_exec_schedule
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: syncobj_timeline
results: parsing output: 102/ for test: kms_properties
results: parsing output: 103/ for test: gem_softpin
results: parsing output: 104/ for test: gem_exec_schedule
results: parsing output: 105/ for test: gem_ctx_param
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_mmap_wc
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_content_protection
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: kms_pm_rpm
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_plane
results: parsing output: 117/ for test: kms_flip_scaled_crc
results: parsing output: 118/ for test: gem_userptr_blits
results: parsing output: 119/ for test: kms_hdr
results: parsing output: 120/ for test: gem_exec_balancer
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: gen3_render_linear_blits
results: parsing output: 123/ for test: kms_ccs
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_flip
results: parsing output: 127/ for test: perf
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_psr2_sf
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: kms_addfb_basic
results: parsing output: 134/ for test: kms_lease
results: parsing output: 135/ for test: kms_vblank
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: kms_cursor_legacy
results: parsing output: 138/ for test: gem_exec_suspend
results: parsing output: 139/ for test: i915_getparams_basic
results: parsing output: 140/ for test: i915_pm_rpm
results: parsing output: 141/ for test: kms_frontbuffer_tracking
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: gem_exec_flush
results: parsing output: 144/ for test: kms_color_pipeline
results: parsing output: 145/ for test: sw_sync
results: parsing output: 146/ for test: syncobj_timeline
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: kms_cursor_legacy
results: parsing output: 149/ for test: gem_exec_params
results: parsing output: 150/ for test: perf
results: parsing output: 151/ for test: kms_cursor_legacy
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: gem_exercise_blt
results: parsing output: 154/ for test: gem_exec_flush
results: parsing output: 155/ for test: gem_eio
Done.