[49.511807] Initializing watchdogs
[49.511877]   /dev/watchdog0
[49.527891] [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]
[49.533806] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[49.536780] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[49.538777] [001/132] (960s left) kms_cursor_crc (cursor-offscreen-256x256)
[49.637853] Starting subtest: cursor-offscreen-256x256
[49.653013] Starting dynamic subtest: pipe-A-HDMI-A-1
[50.969223] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.288s)
[51.012806] Starting dynamic subtest: pipe-D-HDMI-A-1
[52.263073] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.233s)
[52.263889] Subtest cursor-offscreen-256x256: SUCCESS (2.572s)
[52.414616] [002/132] (957s left) gem_userptr_blits (create-destroy-unsync)
[52.470345] Subtest create-destroy-unsync: SKIP (0.000s)
[52.584216] [003/132] (957s left) gem_ctx_param (non-root-set)
[52.617532] Starting subtest: non-root-set
[52.632416] Subtest non-root-set: SUCCESS (0.015s)
[52.710234] [004/132] (957s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[52.797652] Starting subtest: plane-use-after-nonblocking-unbind
[52.799184] Starting dynamic subtest: pipe-A-HDMI-A-1
[52.853737] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.054s)
[52.927418] Starting dynamic subtest: pipe-B-HDMI-A-1
[53.094195] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.171s)
[53.146095] Subtest plane-use-after-nonblocking-unbind: SUCCESS (0.343s)
[53.280474] [005/132] (956s left) kms_cursor_crc (cursor-random-64x21)
[53.372614] Starting subtest: cursor-random-64x21
[53.377449] Starting dynamic subtest: pipe-A-HDMI-A-1
[55.313354] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.911s)
[55.348001] Starting dynamic subtest: pipe-D-HDMI-A-1
[57.255439] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.894s)
[57.256166] Subtest cursor-random-64x21: SUCCESS (3.838s)
[57.388247] [006/132] (952s left) kms_content_protection (uevent-hdcp14)
[57.485399] Starting subtest: uevent-hdcp14
[57.499599] Subtest uevent-hdcp14: SKIP (0.013s)
[57.596336] [007/132] (952s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[57.630406] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[57.666848] [008/132] (952s left) kms_psr (fbc-psr-basic)
[57.752385] Subtest fbc-psr-basic: SKIP (0.000s)
[57.792304] [009/132] (952s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[57.878357] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[57.879034] Starting dynamic subtest: pipe-A-HDMI-A-1
[57.885550] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[57.891056] Starting dynamic subtest: pipe-B-HDMI-A-1
[57.897490] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[57.902975] Starting dynamic subtest: pipe-C-HDMI-A-1
[57.909442] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[57.914865] Starting dynamic subtest: pipe-D-HDMI-A-1
[57.921399] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[57.922705] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[58.110716] [010/132] (952s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[58.247772] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[58.331733] [011/132] (952s left) perf_pmu (interrupts-sync)
[58.371631] Starting subtest: interrupts-sync
[59.494847] Subtest interrupts-sync: SUCCESS (1.107s)
[59.574101] [FACT perf_pmu (interrupts-sync)] new: kernel.kmod_is_loaded.vgem: true
[59.576431] [012/132] (950s left) kms_hdr (bpc-switch-suspend)
[59.662594] Starting subtest: bpc-switch-suspend
[59.664819] Subtest bpc-switch-suspend: SKIP (0.001s)
[59.719431] [013/132] (950s left) gem_mmap_gtt (big-copy-odd)
[59.753721] Starting subtest: big-copy-odd
[66.953601] Subtest big-copy-odd: SUCCESS (7.171s)
[67.320121] [014/132] (943s left) i915_pm_freq_mult (media-freq)
[67.421589] Starting subtest: media-freq
[67.422328] Starting dynamic subtest: gt0
[67.423809] Dynamic subtest gt0: SKIP (0.000s)
[67.425449] Subtest media-freq: SKIP (0.001s)
[67.482831] [015/132] (943s left) kms_async_flips (test-time-stamp)
[67.582569] Starting subtest: test-time-stamp
[67.700768] Starting dynamic subtest: pipe-A-HDMI-A-1
[67.804463] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.103s)
[67.931823] Starting dynamic subtest: pipe-B-HDMI-A-1
[68.008216] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.082s)
[68.122204] Starting dynamic subtest: pipe-C-HDMI-A-1
[68.210943] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.096s)
[68.344140] Starting dynamic subtest: pipe-D-HDMI-A-1
[68.422772] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.084s)
[68.423533] Subtest test-time-stamp: SUCCESS (0.838s)
[68.664037] [016/132] (941s left) i915_query (test-query-geometry-subslices)
[68.703172] Starting subtest: test-query-geometry-subslices
[68.704675] Subtest test-query-geometry-subslices: SKIP (0.000s)
[68.757592] [017/132] (941s left) gem_ctx_persistence (legacy-engines-mixed)
[68.796398] Starting subtest: legacy-engines-mixed
[68.797120] Starting dynamic subtest: render
[68.838650] Dynamic subtest render: SUCCESS (0.042s)
[68.855463] Starting dynamic subtest: bsd1
[68.893690] Dynamic subtest bsd1: SUCCESS (0.053s)
[68.909417] Starting dynamic subtest: bsd2
[68.945599] Dynamic subtest bsd2: SUCCESS (0.050s)
[68.961675] Starting dynamic subtest: blt
[68.999554] Dynamic subtest blt: SUCCESS (0.052s)
[69.014998] Starting dynamic subtest: vebox
[69.055637] Dynamic subtest vebox: SUCCESS (0.055s)
[69.056729] Subtest legacy-engines-mixed: SUCCESS (0.259s)
[69.137555] [018/132] (941s left) gem_userptr_blits (unsync-unmap-cycles)
[69.176260] Subtest unsync-unmap-cycles: SKIP (0.000s)
[69.294549] [019/132] (941s left) kms_dsc (dsc-with-output-formats)
[69.381541] Starting subtest: dsc-with-output-formats
[69.388168] Subtest dsc-with-output-formats: SKIP (0.001s)
[69.457874] [020/132] (941s left) gem_ctx_exec (basic-invalid-context)
[69.492427] Starting subtest: basic-invalid-context
[69.494131] Subtest basic-invalid-context: SUCCESS (0.002s)
[69.594832] [021/132] (941s left) kms_pm_rpm (modeset-lpsp)
[71.005485] Starting subtest: modeset-lpsp
[72.289817] Subtest modeset-lpsp: SUCCESS (1.282s)
[72.397485] [022/132] (938s left) kms_psr (pr-cursor-render)
[72.486408] Subtest pr-cursor-render: SKIP (0.000s)
[72.531364] [023/132] (938s left) gem_softpin (evict-prime-sanity-check)
[72.568215] Starting subtest: evict-prime-sanity-check
[72.568986] Starting dynamic subtest: rcs0
[73.684752] Dynamic subtest rcs0: SUCCESS (1.115s)
[73.695345] Starting dynamic subtest: bcs0
[74.810868] Dynamic subtest bcs0: SUCCESS (1.124s)
[74.822761] Starting dynamic subtest: vcs0
[75.929817] Dynamic subtest vcs0: SUCCESS (1.117s)
[75.941411] Starting dynamic subtest: vcs1
[77.047292] Dynamic subtest vcs1: SUCCESS (1.116s)
[77.057952] Starting dynamic subtest: vecs0
[78.161726] Dynamic subtest vecs0: SUCCESS (1.113s)
[78.174258] Starting dynamic subtest: all
[79.274772] Dynamic subtest all: SUCCESS (1.112s)
[79.275824] Subtest evict-prime-sanity-check: SUCCESS (6.702s)
[79.351652] [024/132] (931s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[79.443923] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[79.445323] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[79.533894] [025/132] (931s left) kms_joiner (basic-big-joiner)
[79.620682] Starting subtest: basic-big-joiner
[79.622013] Subtest basic-big-joiner: SKIP (0.000s)
[79.674623] [026/132] (931s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[79.762597] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[79.763963] Subtest fbcpsr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[79.864806] [027/132] (931s left) kms_addfb_basic (addfb25-modifier-no-flag)
[79.949463] Starting subtest: addfb25-modifier-no-flag
[79.950174] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[80.045436] [028/132] (931s left) kms_flip (flip-vs-rmfb)
[80.130382] Starting subtest: flip-vs-rmfb
[80.132272] Starting dynamic subtest: A-HDMI-A1
[87.787850] Dynamic subtest A-HDMI-A1: SUCCESS (7.655s)
[87.806554] Starting dynamic subtest: B-HDMI-A1
[95.441125] Dynamic subtest B-HDMI-A1: SUCCESS (7.651s)
[95.459080] Starting dynamic subtest: C-HDMI-A1
[103.103966] Dynamic subtest C-HDMI-A1: SUCCESS (7.660s)
[103.120570] Starting dynamic subtest: D-HDMI-A1
[110.763514] Dynamic subtest D-HDMI-A1: SUCCESS (7.657s)
[110.767843] Subtest flip-vs-rmfb: SUCCESS (30.638s)
[110.927498] [029/132] (900s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[111.017067] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[111.018892] Starting dynamic subtest: pipe-A-HDMI-A-1
[111.025790] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[111.033136] Starting dynamic subtest: pipe-B-HDMI-A-1
[111.040007] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[111.047012] Starting dynamic subtest: pipe-C-HDMI-A-1
[111.053836] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[111.060604] Starting dynamic subtest: pipe-D-HDMI-A-1
[111.067272] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[111.068589] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SKIP (0.010s)
[111.250297] [030/132] (899s left) gem_busy (extended)
[111.432516] Starting subtest: extended
[111.433578] Starting dynamic subtest: rcs0
[111.464635] Dynamic subtest rcs0: SUCCESS (0.040s)
[111.482928] Starting dynamic subtest: bcs0
[111.485105] Dynamic subtest bcs0: SUCCESS (0.018s)
[111.494036] Starting dynamic subtest: vcs0
[111.505938] Dynamic subtest vcs0: SUCCESS (0.020s)
[111.516244] Starting dynamic subtest: vcs1
[111.529275] Dynamic subtest vcs1: SUCCESS (0.022s)
[111.540775] Starting dynamic subtest: vecs0
[111.557387] Dynamic subtest vecs0: SUCCESS (0.026s)
[111.560476] Subtest extended: SUCCESS (0.136s)
[111.788825] [031/132] (899s left) sw_sync (sync_busy_fork_unixsocket)
[111.826633] Starting subtest: sync_busy_fork_unixsocket
[111.835678] Subtest sync_busy_fork_unixsocket: SUCCESS (0.009s)
[111.894148] [032/132] (899s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[111.933476] Starting subtest: x-tiled-to-vebox-yf-tiled
[111.934175] Starting dynamic subtest: smem
[112.000626] Dynamic subtest smem: SUCCESS (0.066s)
[112.001323] Subtest x-tiled-to-vebox-yf-tiled: SUCCESS (0.068s)
[112.185337] [033/132] (899s left) gem_exec_store (dword)
[112.226736] Starting subtest: dword
[112.227460] Starting dynamic subtest: rcs0
[112.268717] Dynamic subtest rcs0: SUCCESS (0.041s)
[112.286499] Starting dynamic subtest: bcs0
[112.287332] Dynamic subtest bcs0: SUCCESS (0.016s)
[112.296989] Starting dynamic subtest: vcs0
[112.302918] Dynamic subtest vcs0: SUCCESS (0.014s)
[112.311495] Starting dynamic subtest: vcs1
[112.324401] Dynamic subtest vcs1: SUCCESS (0.020s)
[112.334659] Starting dynamic subtest: vecs0
[112.344031] Dynamic subtest vecs0: SUCCESS (0.018s)
[112.344769] Subtest dword: SUCCESS (0.118s)
[112.538496] [034/132] (898s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping)
[112.626393] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping
[112.627852] Subtest pixel-format-yf-tiled-modifier-source-clamping: SKIP (0.000s)
[112.682134] [035/132] (898s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[112.771812] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[112.773221] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[112.869503] [036/132] (898s left) kms_getfb (getfb-handle-valid)
[112.957108] Starting subtest: getfb-handle-valid
[112.957831] Subtest getfb-handle-valid: SUCCESS (0.000s)
[113.052584] [037/132] (898s left) kms_frontbuffer_tracking (fbc-2p-rte)
[113.142739] Starting subtest: fbc-2p-rte
[113.144074] Subtest fbc-2p-rte: SKIP (0.000s)
[113.246633] [038/132] (898s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[113.335962] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[113.337376] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[113.427117] [039/132] (898s left) api_intel_bb (blit-reloc-purge-cache)
[113.462034] Starting subtest: blit-reloc-purge-cache
[113.468918] Subtest blit-reloc-purge-cache: SUCCESS (0.007s)
[113.569422] [040/132] (897s left) gem_mmap (bad-offset)
[113.603788] Starting subtest: bad-offset
[113.604459] Subtest bad-offset: SUCCESS (0.000s)
[113.701262] [041/132] (897s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[113.798245] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[114.414874] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (0.616s)
[114.548807] [042/132] (897s left) gem_sync (basic-many-each)
[114.593215] Starting subtest: basic-many-each
[116.822119] Subtest basic-many-each: SUCCESS (2.228s)
[117.028502] [043/132] (894s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[117.114383] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[117.115840] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[117.174268] [044/132] (894s left) syncobj_basic (bad-handle-to-fd)
[117.209236] Starting subtest: bad-handle-to-fd
[117.209971] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[117.274802] [045/132] (894s left) kms_psr (psr-cursor-mmap-gtt)
[117.360669] Subtest psr-cursor-mmap-gtt: SKIP (0.000s)
[117.405261] [046/132] (894s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[117.500340] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[117.501725] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[117.593295] [047/132] (894s left) syncobj_eventfd (timeline-wait-before-signal)
[117.628072] Starting subtest: timeline-wait-before-signal
[117.659872] Subtest timeline-wait-before-signal: SUCCESS (0.031s)
[117.736252] [048/132] (894s left) syncobj_timeline (transfer-timeline-point)
[117.770983] Starting subtest: transfer-timeline-point
[117.771698] Subtest transfer-timeline-point: SUCCESS (0.000s)
[117.851541] [049/132] (894s left) kms_psr (fbc-pr-suspend)
[117.936686] Subtest fbc-pr-suspend: SKIP (0.000s)
[117.980775] [050/132] (894s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[118.068593] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[118.113680] [051/132] (893s left) i915_drm_fdinfo (virtual-busy-hang)
[118.150513] Starting subtest: virtual-busy-hang
[123.343865] Subtest virtual-busy-hang: SUCCESS (5.193s)
[123.418577] [052/132] (888s left) kms_vrr (flip-dpms)
[123.504889] Starting subtest: flip-dpms
[123.506957] Subtest flip-dpms: SKIP (0.000s)
[123.579855] [053/132] (888s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[123.668771] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[125.024811] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (1.356s)
[125.144018] [054/132] (887s left) gem_ctx_shared (detached-shared-gtt)
[125.186779] Starting subtest: detached-shared-gtt
[127.369976] Subtest detached-shared-gtt: SUCCESS (2.149s)
[127.524247] [055/132] (884s left) gem_exec_gttfill (engines)
[127.567758] Starting subtest: engines
[127.568440] Starting dynamic subtest: rcs0
[150.700339] Dynamic subtest rcs0: SUCCESS (23.130s)
[150.709901] Starting dynamic subtest: bcs0
[173.686593] Dynamic subtest bcs0: SUCCESS (22.981s)
[173.695316] Starting dynamic subtest: vcs0
[196.920499] Dynamic subtest vcs0: SUCCESS (23.230s)
[196.933758] Starting dynamic subtest: vcs1
[220.112428] Dynamic subtest vcs1: SUCCESS (23.189s)
[220.123322] Starting dynamic subtest: vecs0
[243.137244] Dynamic subtest vecs0: SUCCESS (23.022s)
[243.137977] Subtest engines: SUCCESS (115.558s)
[243.328242] [056/132] (768s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[243.475864] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[243.477236] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[243.575694] [057/132] (768s left) gem_exec_flush (basic-batch-kernel-default-uc)
[243.619333] Starting subtest: basic-batch-kernel-default-uc
[249.183967] Subtest basic-batch-kernel-default-uc: SUCCESS (5.564s)
[249.380352] [058/132] (762s left) kms_prop_blob (blob-prop-lifetime)
[249.414416] Starting subtest: blob-prop-lifetime
[249.416186] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[249.480078] [059/132] (762s left) gem_watchdog (default-physical)
[249.520305] Starting subtest: default-physical
[250.787887] Subtest default-physical: SUCCESS (1.258s)
[250.875164] [060/132] (761s left) kms_selftest (drm_dp_mst_helper)
[250.922447] Starting subtest: drm_dp_mst_helper
[250.931065] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[251.009184] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.079s)
[251.025888] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[251.097173] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.084s)
[251.110140] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[251.182309] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.081s)
[251.183173] Subtest drm_dp_mst_helper: SUCCESS (0.259s)
[251.303059] [061/132] (761s left) kms_atomic_transition (plane-all-transition-nonblocking)
[251.392465] Starting subtest: plane-all-transition-nonblocking
[251.393147] Starting dynamic subtest: pipe-A-HDMI-A-1
[253.347282] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.954s)
[253.424923] Starting dynamic subtest: pipe-B-HDMI-A-1
[255.449672] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.033s)
[255.507671] Subtest plane-all-transition-nonblocking: SUCCESS (4.115s)
[255.668111] [062/132] (756s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[255.768736] Starting subtest: fbc-rgb101010-draw-mmap-wc
[258.246276] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (2.478s)
[258.349269] [063/132] (754s left) gem_userptr_blits (sync-unmap-after-close)
[258.393996] Starting subtest: sync-unmap-after-close
[258.405939] Subtest sync-unmap-after-close: SUCCESS (0.012s)
[258.507688] [064/132] (754s left) gem_mmap_offset (partial-mmap)
[258.542763] Starting subtest: partial-mmap
[258.543424] Starting dynamic subtest: smem0
[258.546860] Dynamic subtest smem0: SUCCESS (0.004s)
[258.547543] Subtest partial-mmap: SUCCESS (0.005s)
[258.671963] [065/132] (753s left) perf_pmu (busy-idle-check-all)
[258.709593] Starting subtest: busy-idle-check-all
[258.710347] Starting dynamic subtest: rcs0
[259.331651] Dynamic subtest rcs0: SUCCESS (0.619s)
[259.343298] Starting dynamic subtest: bcs0
[259.956259] Dynamic subtest bcs0: SUCCESS (0.624s)
[259.969644] Starting dynamic subtest: vcs0
[260.584865] Dynamic subtest vcs0: SUCCESS (0.624s)
[260.598812] Starting dynamic subtest: vcs1
[261.210663] Dynamic subtest vcs1: SUCCESS (0.624s)
[261.224178] Starting dynamic subtest: vecs0
[261.840253] Dynamic subtest vecs0: SUCCESS (0.624s)
[261.841354] Subtest busy-idle-check-all: SUCCESS (3.130s)
[261.909204] [066/132] (750s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[262.011217] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[262.705454] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (0.694s)
[262.836932] [067/132] (749s left) kms_plane_cursor (viewport)
[262.923119] Starting subtest: viewport
[262.924463] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64
[264.296990] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (1.372s)
[264.346675] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128
[265.714285] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (1.382s)
[265.757721] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256
[267.131276] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (1.383s)
[267.224058] Starting dynamic subtest: pipe-B-HDMI-A-1-size-64
[268.659869] Dynamic subtest pipe-B-HDMI-A-1-size-64: SUCCESS (1.444s)
[268.692883] Starting dynamic subtest: pipe-B-HDMI-A-1-size-128
[270.084896] Dynamic subtest pipe-B-HDMI-A-1-size-128: SUCCESS (1.400s)
[270.118552] Starting dynamic subtest: pipe-B-HDMI-A-1-size-256
[271.510438] Dynamic subtest pipe-B-HDMI-A-1-size-256: SUCCESS (1.400s)
[271.594165] Starting dynamic subtest: pipe-C-HDMI-A-1-size-64
[273.016232] Dynamic subtest pipe-C-HDMI-A-1-size-64: SUCCESS (1.429s)
[273.051806] Starting dynamic subtest: pipe-C-HDMI-A-1-size-128
[274.449741] Dynamic subtest pipe-C-HDMI-A-1-size-128: SUCCESS (1.408s)
[274.486997] Starting dynamic subtest: pipe-C-HDMI-A-1-size-256
[275.891165] Dynamic subtest pipe-C-HDMI-A-1-size-256: SUCCESS (1.416s)
[275.979600] Starting dynamic subtest: pipe-D-HDMI-A-1-size-64
[277.388555] Dynamic subtest pipe-D-HDMI-A-1-size-64: SUCCESS (1.419s)
[277.422436] Starting dynamic subtest: pipe-D-HDMI-A-1-size-128
[278.780562] Dynamic subtest pipe-D-HDMI-A-1-size-128: SUCCESS (1.367s)
[278.816360] Starting dynamic subtest: pipe-D-HDMI-A-1-size-256
[280.188926] Dynamic subtest pipe-D-HDMI-A-1-size-256: SUCCESS (1.383s)
[280.263996] Subtest viewport: SUCCESS (17.340s)
[280.371934] [068/132] (732s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[280.485636] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[280.487049] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[280.578845] [069/132] (732s left) kms_lease (atomic-implicit-crtc)
[280.665259] Starting subtest: atomic-implicit-crtc
[280.665961] Starting dynamic subtest: pipe-A-HDMI-A-1
[280.669455] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[280.677174] Starting dynamic subtest: pipe-B-HDMI-A-1
[280.680630] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.008s)
[280.688446] Starting dynamic subtest: pipe-C-HDMI-A-1
[280.691930] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.008s)
[280.699838] Starting dynamic subtest: pipe-D-HDMI-A-1
[280.703374] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.008s)
[280.704053] Subtest atomic-implicit-crtc: SUCCESS (0.034s)
[280.760664] [070/132] (732s left) gem_exec_schedule (noreorder)
[280.931139] Starting subtest: noreorder
[280.931986] Starting dynamic subtest: rcs0
[280.977869] Dynamic subtest rcs0: SUCCESS (0.047s)
[280.996383] Starting dynamic subtest: bcs0
[281.031598] Dynamic subtest bcs0: SUCCESS (0.051s)
[281.051215] Starting dynamic subtest: vcs0
[281.091707] Dynamic subtest vcs0: SUCCESS (0.057s)
[281.110166] Starting dynamic subtest: vcs1
[281.149549] Dynamic subtest vcs1: SUCCESS (0.055s)
[281.167984] Starting dynamic subtest: vecs0
[281.200637] Dynamic subtest vecs0: SUCCESS (0.048s)
[281.204846] Subtest noreorder: SUCCESS (0.273s)
[281.375976] [071/132] (731s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[281.461973] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[281.463809] Starting dynamic subtest: pipe-A-HDMI-A-1
[281.470943] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[281.478987] Starting dynamic subtest: pipe-B-HDMI-A-1
[281.486147] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[281.493852] Starting dynamic subtest: pipe-C-HDMI-A-1
[281.501043] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[281.508563] Starting dynamic subtest: pipe-D-HDMI-A-1
[281.515881] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[281.517253] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SKIP (0.007s)
[281.722042] [072/132] (731s left) gem_exercise_blt (fast-copy-emit)
[281.759978] Starting subtest: fast-copy-emit
[281.760765] Starting dynamic subtest: linear-smem-smem-emit
[281.779294] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.019s)
[281.788197] Starting dynamic subtest: ymajor-smem-smem-emit
[281.796773] Dynamic subtest ymajor-smem-smem-emit: SUCCESS (0.016s)
[281.805727] Starting dynamic subtest: tile4-smem-smem-emit
[281.813381] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.016s)
[281.822288] Starting dynamic subtest: tile64-smem-smem-emit
[281.830052] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.016s)
[281.830804] Subtest fast-copy-emit: SUCCESS (0.071s)
[281.936550] [073/132] (731s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[282.024130] Starting subtest: cursorB-vs-flipB-varying-size
[282.025481] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[282.083242] [074/132] (730s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[282.174387] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[282.175831] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[282.264263] [075/132] (730s left) kms_psr (fbc-pr-cursor-blt)
[282.352878] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[282.395788] [076/132] (730s left) kms_debugfs (display-off-read-all)
[282.484035] Starting subtest: display-off-read-all
[282.540992] Subtest display-off-read-all: SUCCESS (0.058s)
[282.651835] [077/132] (730s left) kms_cursor_edge_walk (64x64-left-edge)
[282.741991] Starting subtest: 64x64-left-edge
[282.742750] Starting dynamic subtest: pipe-A-HDMI-A-1
[284.496367] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.754s)
[284.505741] Starting dynamic subtest: pipe-D-HDMI-A-1
[286.182907] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.684s)
[286.183616] Subtest 64x64-left-edge: SUCCESS (3.442s)
[286.289173] [078/132] (726s left) prime_busy (hang)
[286.327897] Starting subtest: hang
[286.330068] Starting dynamic subtest: rcs0
[300.666696] Dynamic subtest rcs0: SUCCESS (14.303s)
[300.673857] Starting dynamic subtest: bcs0
[307.577981] Dynamic subtest bcs0: SUCCESS (6.910s)
[307.585208] Starting dynamic subtest: vcs0
[314.592400] Dynamic subtest vcs0: SUCCESS (7.039s)
[314.600067] Starting dynamic subtest: vcs1
[321.568296] Dynamic subtest vcs1: SUCCESS (6.975s)
[321.575613] Starting dynamic subtest: vecs0
[328.570343] Dynamic subtest vecs0: SUCCESS (6.975s)
[328.571299] Subtest hang: SUCCESS (42.209s)
[328.650807] [079/132] (684s left) syncobj_wait (invalid-reset-zero-handles)
[328.686744] Starting subtest: invalid-reset-zero-handles
[328.687411] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[328.743422] [080/132] (684s left) gem_exec_reloc (basic-cpu-wc-active)
[328.781128] Starting subtest: basic-cpu-wc-active
[328.909734] Subtest basic-cpu-wc-active: SUCCESS (0.120s)
[329.026661] [081/132] (684s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[329.117743] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[329.119082] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[329.209873] [082/132] (684s left) gem_mmap_wc (fault-concurrent)
[329.243792] Starting subtest: fault-concurrent
[329.319817] Subtest fault-concurrent: SUCCESS (0.077s)
[329.375758] [083/132] (683s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[329.469338] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[329.470813] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[329.571755] [084/132] (683s left) dmabuf_sync_file (export-multiwait)
[329.606978] Starting subtest: export-multiwait
[329.607698] Subtest export-multiwait: SUCCESS (0.001s)
[329.687817] [085/132] (683s left) gem_create (create-valid-nonaligned)
[329.721896] Starting subtest: create-valid-nonaligned
[329.722592] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[329.906201] [086/132] (683s left) gem_fence_thrash (bo-write-verify-none)
[329.939037] Starting subtest: bo-write-verify-none
[331.127854] Subtest bo-write-verify-none: SUCCESS (1.181s)
[331.216204] [087/132] (682s left) kms_plane_alpha_blend (constant-alpha-max)
[331.307008] Starting subtest: constant-alpha-max
[331.373645] Starting dynamic subtest: pipe-A-HDMI-A-1
[331.864708] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.491s)
[331.874137] Starting dynamic subtest: pipe-D-HDMI-A-1
[332.393479] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.526s)
[332.394230] Subtest constant-alpha-max: SUCCESS (1.087s)
[332.568995] [088/132] (680s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[332.669569] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[332.670957] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[332.747077] [089/132] (680s left) kms_rmfb (rmfb-ioctl)
[332.835305] Starting subtest: rmfb-ioctl
[332.835972] Starting dynamic subtest: pipe-A-HDMI-A-1
[332.930091] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.094s)
[332.942268] Starting dynamic subtest: pipe-B-HDMI-A-1
[333.097651] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.165s)
[333.109825] Starting dynamic subtest: pipe-C-HDMI-A-1
[333.275788] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.176s)
[333.285969] Starting dynamic subtest: pipe-D-HDMI-A-1
[333.454356] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.177s)
[333.455063] Subtest rmfb-ioctl: SUCCESS (0.620s)
[333.621141] [090/132] (679s left) syncobj_wait (reset-during-wait-for-submit)
[333.659014] Starting subtest: reset-during-wait-for-submit
[333.763326] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[333.850445] [091/132] (679s left) kms_chamelium_edid (dp-mode-timings)
[333.990221] Subtest dp-mode-timings: SKIP (0.000s)
[334.086951] [092/132] (679s left) gem_userptr_blits (sync-unmap-cycles)
[334.136499] Starting subtest: sync-unmap-cycles
[339.542478] Subtest sync-unmap-cycles: SUCCESS (5.372s)
[339.626146] [093/132] (674s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[339.738153] Starting subtest: extended-modeset-hang-oldfb-with-reset
[339.738862] Starting dynamic subtest: pipe-A
[341.276748] Dynamic subtest pipe-A: SUCCESS (1.552s)
[341.290484] Starting dynamic subtest: pipe-D
[342.848799] Dynamic subtest pipe-D: SUCCESS (1.567s)
[342.849520] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (3.127s)
[343.006014] [094/132] (670s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[343.049450] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[343.050166] Starting dynamic subtest: smem
[343.150061] Dynamic subtest smem: SUCCESS (0.100s)
[343.150810] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SUCCESS (0.101s)
[343.356417] [095/132] (670s left) api_intel_bb (lot-of-buffers)
[343.390878] Starting subtest: lot-of-buffers
[344.689036] Subtest lot-of-buffers: SUCCESS (1.290s)
[344.812787] [096/132] (669s left) gem_exec_fence (syncobj-timeline-repeat)
[345.280463] Starting subtest: syncobj-timeline-repeat
[345.642169] Subtest syncobj-timeline-repeat: SUCCESS (0.363s)
[345.813328] [097/132] (668s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[345.847016] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[345.950813] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.103s)
[346.030081] [098/132] (667s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[346.118360] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[346.120534] Starting dynamic subtest: pipe-A-HDMI-A-1
[346.127410] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[346.135334] Starting dynamic subtest: pipe-B-HDMI-A-1
[346.142044] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[346.149889] Starting dynamic subtest: pipe-C-HDMI-A-1
[346.156636] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[346.164331] Starting dynamic subtest: pipe-D-HDMI-A-1
[346.170916] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[346.172214] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SKIP (0.007s)
[346.356739] [099/132] (667s left) kms_pm_rpm (dpms-lpsp)
[347.756133] Starting subtest: dpms-lpsp
[347.851653] Subtest dpms-lpsp: SUCCESS (0.095s)
[347.960350] [100/132] (666s left) syncobj_wait (invalid-reset-bad-pad)
[347.995581] Starting subtest: invalid-reset-bad-pad
[347.996312] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[348.054148] [101/132] (666s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[348.140192] Starting subtest: bad-pixel-format-yf-tiled-ccs
[348.141967] Starting dynamic subtest: pipe-A-HDMI-A-1
[348.148727] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[348.156875] Starting dynamic subtest: pipe-B-HDMI-A-1
[348.171016] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[348.178927] Starting dynamic subtest: pipe-C-HDMI-A-1
[348.185492] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[348.193752] Starting dynamic subtest: pipe-D-HDMI-A-1
[348.200598] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[348.202039] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.007s)
[348.372913] [102/132] (665s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[348.466862] Starting subtest: psr-rgb101010-draw-mmap-cpu
[348.468328] Subtest psr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[348.547152] [103/132] (665s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[348.582484] Subtest invalidate-primary-flip-overlay: SKIP (0.000s)
[348.643213] [104/132] (665s left) gem_exec_reloc (basic-cpu-read)
[348.681110] Starting subtest: basic-cpu-read
[348.686173] Subtest basic-cpu-read: SUCCESS (0.005s)
[348.801690] [105/132] (665s left) syncobj_wait (invalid-signal-illegal-handle)
[348.835907] Starting subtest: invalid-signal-illegal-handle
[348.836603] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[348.894686] [106/132] (665s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[348.981105] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[348.981818] Starting dynamic subtest: pipe-A-valid-mode
[350.189752] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.207s)
[350.190483] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SUCCESS (1.209s)
[350.347265] [107/132] (663s left) syncobj_timeline (multi-wait-all-signaled)
[350.385109] Starting subtest: multi-wait-all-signaled
[350.385939] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[350.447766] [108/132] (663s left) gem_eio (execbuf)
[350.491262] Starting subtest: execbuf
[350.520424] Subtest execbuf: SUCCESS (0.029s)
[350.644274] [109/132] (663s left) gem_set_tiling_vs_pwrite
[350.770615] [110/132] (663s left) i915_hangman (engine-error-state-capture)
[350.814573] Starting subtest: engine-error-state-capture
[350.815354] Starting dynamic subtest: rcs0
[354.427705] Dynamic subtest rcs0: SUCCESS (3.612s)
[354.440077] Starting dynamic subtest: bcs0
[358.399803] Dynamic subtest bcs0: SUCCESS (3.969s)
[358.412468] Starting dynamic subtest: vcs0
[362.376880] Dynamic subtest vcs0: SUCCESS (3.974s)
[362.391092] Starting dynamic subtest: vcs1
[366.393920] Dynamic subtest vcs1: SUCCESS (4.015s)
[366.407844] Starting dynamic subtest: vecs0
[370.362831] Dynamic subtest vecs0: SUCCESS (3.966s)
[370.367144] Subtest engine-error-state-capture: SUCCESS (19.549s)
[370.470422] [111/132] (643s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[370.561543] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[370.562909] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[370.644628] [112/132] (643s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[370.734816] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[370.736232] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[370.842863] [113/132] (643s left) gen7_exec_parse (oacontrol-tracking)
[370.879448] Subtest oacontrol-tracking: SKIP (0.000s)
[370.926883] [114/132] (643s left) syncobj_timeline (invalid-transfer-non-existent-point)
[370.960916] Starting subtest: invalid-transfer-non-existent-point
[370.961597] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[371.032960] [115/132] (643s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[371.119054] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[371.119822] Starting dynamic subtest: pipe-A-valid-mode
[372.166783] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.047s)
[372.167496] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SUCCESS (1.049s)
[372.315264] [116/132] (642s left) gem_exec_balancer (semaphore)
[372.360239] Starting subtest: semaphore
[373.662609] Subtest semaphore: SUCCESS (1.302s)
[373.849737] [117/132] (640s left) kms_async_flips (async-flip-hang)
[373.940983] Starting subtest: async-flip-hang
[374.063940] Starting dynamic subtest: pipe-A-HDMI-A-1
[388.731702] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (14.631s)
[388.841697] Starting dynamic subtest: pipe-B-HDMI-A-1
[403.578788] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (14.711s)
[403.676061] Starting dynamic subtest: pipe-C-HDMI-A-1
[418.400684] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (14.724s)
[418.523264] Starting dynamic subtest: pipe-D-HDMI-A-1
[433.786634] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (15.237s)
[433.787322] Subtest async-flip-hang: SUCCESS (59.812s)
[433.982906] [118/132] (580s left) kms_color (ctm-red-to-blue)
[434.072863] Starting subtest: ctm-red-to-blue
[434.073549] Starting dynamic subtest: pipe-A-HDMI-A-1
[434.387588] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.314s)
[434.398571] Starting dynamic subtest: pipe-B-HDMI-A-1
[434.681483] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.293s)
[434.692072] Starting dynamic subtest: pipe-C-HDMI-A-1
[434.968511] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.285s)
[434.978224] Starting dynamic subtest: pipe-D-HDMI-A-1
[435.260758] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.292s)
[435.261471] Subtest ctm-red-to-blue: SUCCESS (1.188s)
[435.413089] [119/132] (579s left) gem_exec_balancer (parallel)
[435.577813] Subtest parallel: SKIP (0.000s)
[435.650639] [120/132] (579s left) gem_mmap_wc (write-wc-read-gtt)
[435.684121] Starting subtest: write-wc-read-gtt
[435.995830] Subtest write-wc-read-gtt: SUCCESS (0.304s)
[436.082409] [121/132] (578s left) kms_plane_scaling (planes-upscale-factor-0-25)
[436.172973] Starting subtest: planes-upscale-factor-0-25
[436.173701] Starting dynamic subtest: pipe-A
[436.237256] Dynamic subtest pipe-A: SUCCESS (0.065s)
[436.246498] Starting dynamic subtest: pipe-B
[436.363421] Dynamic subtest pipe-B: SUCCESS (0.125s)
[436.376789] Starting dynamic subtest: pipe-C
[436.506666] Dynamic subtest pipe-C: SUCCESS (0.142s)
[436.516136] Starting dynamic subtest: pipe-D
[436.642836] Dynamic subtest pipe-D: SUCCESS (0.135s)
[436.643619] Subtest planes-upscale-factor-0-25: SUCCESS (0.471s)
[436.837480] [122/132] (578s left) gem_eio (in-flight-suspend)
[436.882494] Starting subtest: in-flight-suspend
[473.522439] Subtest in-flight-suspend: SUCCESS (7.618s)
[482.697730] [123/132] (541s left) gem_ctx_exec (basic-norecovery)
[482.744734] Starting subtest: basic-norecovery
[482.758897] Subtest basic-norecovery: SUCCESS (0.013s)
[482.874976] [124/132] (541s left) kms_big_fb (4-tiled-addfb)
[482.973990] Starting subtest: 4-tiled-addfb
[482.975394] Subtest 4-tiled-addfb: SKIP (0.000s)
[483.088225] [125/132] (541s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[483.175632] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[483.176522] Starting dynamic subtest: pipe-A
[484.271804] Dynamic subtest pipe-A: SKIP (1.065s)
[484.281165] Starting dynamic subtest: pipe-B
[485.434833] Dynamic subtest pipe-B: SKIP (1.134s)
[485.444088] Starting dynamic subtest: pipe-C
[486.590322] Dynamic subtest pipe-C: SKIP (1.131s)
[486.599506] Starting dynamic subtest: pipe-D
[487.773674] Dynamic subtest pipe-D: SKIP (1.161s)
[487.775099] Subtest plane-scaler-with-clipping-clamping-rotation: SKIP (4.494s)
[487.950201] [126/132] (536s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[488.054847] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[488.056203] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[488.138787] [127/132] (536s left) sysfs_timeslice_duration (invalid)
[488.177738] Starting subtest: invalid
[488.179537] Starting dynamic subtest: vecs0
[488.180246] Dynamic subtest vecs0: SUCCESS (0.000s)
[488.189584] Starting dynamic subtest: vcs0
[488.190282] Dynamic subtest vcs0: SUCCESS (0.000s)
[488.199252] Starting dynamic subtest: bcs0
[488.199922] Dynamic subtest bcs0: SUCCESS (0.000s)
[488.208592] Starting dynamic subtest: rcs0
[488.209273] Dynamic subtest rcs0: SUCCESS (0.000s)
[488.218563] Starting dynamic subtest: vcs1
[488.219240] Dynamic subtest vcs1: SUCCESS (0.000s)
[488.219906] Subtest invalid: SUCCESS (0.007s)
[488.255517] [128/132] (535s left) gem_exec_schedule (semaphore-codependency)
[488.304049] Starting subtest: semaphore-codependency
[488.309712] Subtest semaphore-codependency: SUCCESS (0.007s)
[488.587682] [129/132] (535s left) syncobj_timeline (etime-single-wait-submitted)
[488.622352] Starting subtest: etime-single-wait-submitted
[488.724030] Subtest etime-single-wait-submitted: SUCCESS (0.100s)
[488.790323] [130/132] (535s left) perf_pmu (busy-accuracy-2)
[488.830749] Starting subtest: busy-accuracy-2
[488.831456] Starting dynamic subtest: rcs0
[492.081720] Dynamic subtest rcs0: SUCCESS (3.213s)
[492.092034] Starting dynamic subtest: bcs0
[495.132376] Dynamic subtest bcs0: SUCCESS (3.025s)
[495.142344] Starting dynamic subtest: vcs0
[498.176495] Dynamic subtest vcs0: SUCCESS (3.028s)
[498.187269] Starting dynamic subtest: vcs1
[501.215713] Dynamic subtest vcs1: SUCCESS (3.028s)
[501.227980] Starting dynamic subtest: vecs0
[504.251543] Dynamic subtest vecs0: SUCCESS (3.023s)
[504.252493] Subtest busy-accuracy-2: SUCCESS (15.324s)
[504.323400] [131/132] (520s left) syncobj_wait (single-wait-signaled)
[504.359596] Starting subtest: single-wait-signaled
[504.360299] Subtest single-wait-signaled: SUCCESS (0.000s)
[504.429837] [132/132] (519s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[504.526905] Starting subtest: y-tiled-16bpp-rotate-0
[505.623920] Subtest y-tiled-16bpp-rotate-0: SUCCESS (1.094s)
[505.743743] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_crc
results: parsing output: 1/ for test: gem_userptr_blits
results: parsing output: 2/ for test: gem_ctx_param
results: parsing output: 3/ for test: kms_atomic_transition
results: parsing output: 4/ for test: kms_cursor_crc
results: parsing output: 5/ for test: kms_content_protection
results: parsing output: 6/ for test: kms_pipe_b_c_ivb
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: kms_chamelium_hpd
results: parsing output: 10/ for test: perf_pmu
results: parsing output: 11/ for test: kms_hdr
results: parsing output: 12/ for test: gem_mmap_gtt
results: parsing output: 13/ for test: i915_pm_freq_mult
results: parsing output: 14/ for test: kms_async_flips
results: parsing output: 15/ for test: i915_query
results: parsing output: 16/ for test: gem_ctx_persistence
results: parsing output: 17/ for test: gem_userptr_blits
results: parsing output: 18/ for test: kms_dsc
results: parsing output: 19/ for test: gem_ctx_exec
results: parsing output: 20/ for test: kms_pm_rpm
results: parsing output: 21/ for test: kms_psr
results: parsing output: 22/ for test: gem_softpin
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_joiner
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_addfb_basic
results: parsing output: 27/ for test: kms_flip
results: parsing output: 28/ for test: kms_ccs
results: parsing output: 29/ for test: gem_busy
results: parsing output: 30/ for test: sw_sync
results: parsing output: 31/ for test: gem_render_copy
results: parsing output: 32/ for test: gem_exec_store
results: parsing output: 33/ for test: kms_plane
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_getfb
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: api_intel_bb
results: parsing output: 39/ for test: gem_mmap
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: gem_sync
results: parsing output: 42/ for test: kms_flip_scaled_crc
results: parsing output: 43/ for test: syncobj_basic
results: parsing output: 44/ for test: kms_psr
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: syncobj_eventfd
results: parsing output: 47/ for test: syncobj_timeline
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_psr2_sf
results: parsing output: 50/ for test: i915_drm_fdinfo
results: parsing output: 51/ for test: kms_vrr
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_ctx_shared
results: parsing output: 54/ for test: gem_exec_gttfill
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_exec_flush
results: parsing output: 57/ for test: kms_prop_blob
results: parsing output: 58/ for test: gem_watchdog
results: parsing output: 59/ for test: kms_selftest
results: parsing output: 60/ for test: kms_atomic_transition
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: gem_userptr_blits
results: parsing output: 63/ for test: gem_mmap_offset
results: parsing output: 64/ for test: perf_pmu
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: kms_plane_cursor
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: kms_lease
results: parsing output: 69/ for test: gem_exec_schedule
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: gem_exercise_blt
results: parsing output: 72/ for test: kms_cursor_legacy
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: kms_debugfs
results: parsing output: 76/ for test: kms_cursor_edge_walk
results: parsing output: 77/ for test: prime_busy
results: parsing output: 78/ for test: syncobj_wait
results: parsing output: 79/ for test: gem_exec_reloc
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_mmap_wc
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: dmabuf_sync_file
results: parsing output: 84/ for test: gem_create
results: parsing output: 85/ for test: gem_fence_thrash
results: parsing output: 86/ for test: kms_plane_alpha_blend
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_rmfb
results: parsing output: 89/ for test: syncobj_wait
results: parsing output: 90/ for test: kms_chamelium_edid
results: parsing output: 91/ for test: gem_userptr_blits
results: parsing output: 92/ for test: kms_busy
results: parsing output: 93/ for test: gem_render_copy
results: parsing output: 94/ for test: api_intel_bb
results: parsing output: 95/ for test: gem_exec_fence
results: parsing output: 96/ for test: syncobj_wait
results: parsing output: 97/ for test: kms_ccs
results: parsing output: 98/ for test: kms_pm_rpm
results: parsing output: 99/ for test: syncobj_wait
results: parsing output: 100/ for test: kms_ccs
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_psr_stress_test
results: parsing output: 103/ for test: gem_exec_reloc
results: parsing output: 104/ for test: syncobj_wait
results: parsing output: 105/ for test: kms_flip_scaled_crc
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: gem_eio
results: parsing output: 108/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 109/ for test: i915_hangman
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: gen7_exec_parse
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: kms_flip_scaled_crc
results: parsing output: 115/ for test: gem_exec_balancer
results: parsing output: 116/ for test: kms_async_flips
results: parsing output: 117/ for test: kms_color
results: parsing output: 118/ for test: gem_exec_balancer
results: parsing output: 119/ for test: gem_mmap_wc
results: parsing output: 120/ for test: kms_plane_scaling
results: parsing output: 121/ for test: gem_eio
results: parsing output: 122/ for test: gem_ctx_exec
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: kms_plane_scaling
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: sysfs_timeslice_duration
results: parsing output: 127/ for test: gem_exec_schedule
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: perf_pmu
results: parsing output: 130/ for test: syncobj_wait
results: parsing output: 131/ for test: kms_big_fb
Done.