[49.215790] Initializing watchdogs
[49.215857]   /dev/watchdog0
[49.232158] [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.237836] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[49.241101] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[49.243105] [001/156] (960s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[49.343675] Starting subtest: fbc-tiling-linear
[50.499493] Subtest fbc-tiling-linear: SUCCESS (1.146s)
[50.637232] [002/156] (959s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[50.672928] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[50.710323] [003/156] (959s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[50.806110] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[50.807467] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[50.894011] [004/156] (958s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[50.988588] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[50.990031] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[51.065117] [005/156] (958s left) kms_force_connector_basic (prune-stale-modes)
[51.189715] Starting subtest: prune-stale-modes
[51.343512] Subtest prune-stale-modes: SUCCESS (0.153s)
[51.505350] [006/156] (958s left) perf_pmu (most-busy-check-all)
[51.546613] Starting subtest: most-busy-check-all
[51.547443] Starting dynamic subtest: rcs0
[52.072280] Dynamic subtest rcs0: SUCCESS (0.522s)
[52.081764] Starting dynamic subtest: bcs0
[52.600425] Dynamic subtest bcs0: SUCCESS (0.524s)
[52.610073] Starting dynamic subtest: vcs0
[53.126163] Dynamic subtest vcs0: SUCCESS (0.522s)
[53.134992] Starting dynamic subtest: vcs1
[53.646313] Dynamic subtest vcs1: SUCCESS (0.517s)
[53.656640] Starting dynamic subtest: vecs0
[54.169394] Dynamic subtest vecs0: SUCCESS (0.520s)
[54.170419] Subtest most-busy-check-all: SUCCESS (2.607s)
[54.240072] [007/156] (955s left) gem_ccs (large-ctrl-surf-copy)
[54.279080] Starting subtest: large-ctrl-surf-copy
[54.280557] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[54.331926] [008/156] (955s left) kms_plane_alpha_blend (coverage-7efc)
[54.424582] Starting subtest: coverage-7efc
[54.494603] Starting dynamic subtest: pipe-A-HDMI-A-1
[54.810386] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.314s)
[54.843827] Starting dynamic subtest: pipe-D-HDMI-A-1
[55.296479] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.457s)
[55.297311] Subtest coverage-7efc: SUCCESS (0.868s)
[55.467635] [009/156] (954s left) gem_mmap_gtt (fault-concurrent)
[55.506034] Starting subtest: fault-concurrent
[58.092121] Subtest fault-concurrent: SUCCESS (2.543s)
[58.165405] [010/156] (951s left) api_intel_allocator (gem-pool)
[58.200486] Starting subtest: gem-pool
[58.206170] Subtest gem-pool: SUCCESS (0.006s)
[58.313852] [011/156] (951s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-fullscreen)
[58.418355] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-fullscreen
[58.419824] Subtest fbchdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[58.502379] [012/156] (951s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[58.590702] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[58.592173] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[58.650909] [013/156] (951s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[58.739481] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[58.740276] Starting dynamic subtest: pipe-A-HDMI-A-1
[58.747418] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[58.754248] Starting dynamic subtest: pipe-B-HDMI-A-1
[58.761407] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[58.768093] Starting dynamic subtest: pipe-C-HDMI-A-1
[58.775212] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[58.781753] Starting dynamic subtest: pipe-D-HDMI-A-1
[58.789021] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[58.790514] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.006s)
[59.004462] [014/156] (951s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[59.096305] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[59.097103] Starting dynamic subtest: pipe-A-HDMI-A-1
[59.103718] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[59.110359] Starting dynamic subtest: pipe-B-HDMI-A-1
[59.116995] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[59.123523] Starting dynamic subtest: pipe-C-HDMI-A-1
[59.130189] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[59.136646] Starting dynamic subtest: pipe-D-HDMI-A-1
[59.143354] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[59.144692] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[59.350727] [015/156] (950s left) kms_frontbuffer_tracking (hdr-rgb565-draw-blt)
[59.443333] Starting subtest: hdr-rgb565-draw-blt
[59.444886] Subtest hdr-rgb565-draw-blt: SKIP (0.000s)
[59.536056] [016/156] (950s left) kms_pm_rpm (legacy-planes-dpms)
[60.947296] Starting subtest: legacy-planes-dpms
[60.948375] Starting dynamic subtest: plane-65
[69.454965] Dynamic subtest plane-65: SUCCESS (8.496s)
[69.465095] Starting dynamic subtest: plane-95
[77.968956] Dynamic subtest plane-95: SUCCESS (8.511s)
[77.979655] Starting dynamic subtest: plane-125
[86.276577] Dynamic subtest plane-125: SUCCESS (8.307s)
[86.286047] Starting dynamic subtest: plane-135
[94.800209] Dynamic subtest plane-135: SUCCESS (8.522s)
[94.809462] Starting dynamic subtest: plane-145
[103.209816] Dynamic subtest plane-145: SUCCESS (8.409s)
[103.220809] Starting dynamic subtest: plane-155
[111.410272] Dynamic subtest plane-155: SUCCESS (8.199s)
[111.411650] Subtest legacy-planes-dpms: SUCCESS (50.451s)
[111.627630] [017/156] (898s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[111.671450] Starting subtest: x-tiled-to-vebox-y-tiled
[111.672266] Starting dynamic subtest: smem
[111.768388] Dynamic subtest smem: SUCCESS (0.097s)
[111.769159] Subtest x-tiled-to-vebox-y-tiled: SUCCESS (0.097s)
[111.957097] [018/156] (898s left) sysfs_heartbeat_interval (invalid)
[111.993626] Starting subtest: invalid
[111.994364] Starting dynamic subtest: vecs0
[111.995079] Dynamic subtest vecs0: SUCCESS (0.000s)
[112.001810] Starting dynamic subtest: vcs0
[112.002517] Dynamic subtest vcs0: SUCCESS (0.000s)
[112.009077] Starting dynamic subtest: bcs0
[112.009803] Dynamic subtest bcs0: SUCCESS (0.000s)
[112.016183] Starting dynamic subtest: rcs0
[112.016869] Dynamic subtest rcs0: SUCCESS (0.000s)
[112.023380] Starting dynamic subtest: vcs1
[112.024104] Dynamic subtest vcs1: SUCCESS (0.000s)
[112.024787] Subtest invalid: SUCCESS (0.004s)
[112.052632] [019/156] (898s left) kms_frontbuffer_tracking (fbc-stridechange)
[112.144473] Starting subtest: fbc-stridechange
[113.103217] Subtest fbc-stridechange: SUCCESS (0.959s)
[113.232994] [020/156] (897s left) gem_ctx_param (basic-default)
[113.267271] Starting subtest: basic-default
[113.268019] Subtest basic-default: SUCCESS (0.000s)
[113.346495] [021/156] (897s left) kms_psr (fbc-pr-primary-mmap-gtt)
[113.437313] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[113.473639] [022/156] (897s left) i915_pm_freq_mult (media-freq)
[113.507495] Starting subtest: media-freq
[113.508266] Starting dynamic subtest: gt0
[113.509714] Dynamic subtest gt0: SKIP (0.000s)
[113.511192] Subtest media-freq: SKIP (0.001s)
[113.573616] [023/156] (896s left) prime_busy (before-wait)
[113.611496] Starting subtest: before-wait
[113.616136] Starting dynamic subtest: rcs0
[113.641287] Dynamic subtest rcs0: SUCCESS (0.025s)
[113.652929] Starting dynamic subtest: bcs0
[113.658180] Dynamic subtest bcs0: SUCCESS (0.016s)
[113.668181] Starting dynamic subtest: vcs0
[113.675332] Dynamic subtest vcs0: SUCCESS (0.016s)
[113.683503] Starting dynamic subtest: vcs1
[113.691469] Dynamic subtest vcs1: SUCCESS (0.015s)
[113.699349] Starting dynamic subtest: vecs0
[113.718151] Dynamic subtest vecs0: SUCCESS (0.026s)
[113.825565] Subtest before-wait: SUCCESS (0.214s)
[113.895864] [024/156] (896s left) gem_exec_gttfill (engines)
[113.938347] Starting subtest: engines
[113.939141] Starting dynamic subtest: rcs0
[137.407429] Dynamic subtest rcs0: SUCCESS (23.469s)
[137.416785] Starting dynamic subtest: bcs0
[160.544552] Dynamic subtest bcs0: SUCCESS (23.135s)
[160.554404] Starting dynamic subtest: vcs0
[183.563221] Dynamic subtest vcs0: SUCCESS (23.017s)
[183.572913] Starting dynamic subtest: vcs1
[206.609356] Dynamic subtest vcs1: SUCCESS (23.045s)
[206.617696] Starting dynamic subtest: vecs0
[229.663481] Dynamic subtest vecs0: SUCCESS (23.053s)
[229.664463] Subtest engines: SUCCESS (115.722s)
[229.855968] [025/156] (780s left) syncobj_timeline (etime-multi-wait-all-submitted)
[229.952969] Starting subtest: etime-multi-wait-all-submitted
[230.062697] Subtest etime-multi-wait-all-submitted: SUCCESS (0.108s)
[230.145367] [026/156] (780s left) gem_ctx_param (get-priority-new-ctx)
[230.178670] Starting subtest: get-priority-new-ctx
[230.179405] Subtest get-priority-new-ctx: SUCCESS (0.000s)
[230.238609] [027/156] (780s left) kms_big_fb (linear-32bpp-rotate-90)
[230.344945] Starting subtest: linear-32bpp-rotate-90
[230.428485] Subtest linear-32bpp-rotate-90: SKIP (0.083s)
[230.544595] [028/156] (780s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[230.584355] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[230.627678] [029/156] (780s left) gem_ctx_shared (disjoint-timelines)
[230.669222] Starting subtest: disjoint-timelines
[230.704275] Subtest disjoint-timelines: SUCCESS (0.035s)
[230.920145] [FACT gem_ctx_shared (disjoint-timelines)] new: kernel.kmod_is_loaded.vgem: true
[230.921865] [030/156] (779s left) kms_psr (fbc-psr2-cursor-plane-move)
[231.011834] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s)
[231.057440] [031/156] (779s left) gem_bad_reloc (negative-reloc-bltcopy)
[231.096811] Starting subtest: negative-reloc-bltcopy
[232.205021] Subtest negative-reloc-bltcopy: SUCCESS (1.100s)
[232.340884] [032/156] (778s left) kms_chamelium_hpd (hdmi-hpd)
[232.483770] Subtest hdmi-hpd: SKIP (0.000s)
[232.583884] [033/156] (778s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[232.678039] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[232.721320] [034/156] (778s left) gem_eio (wait-10ms)
[232.765215] Starting subtest: wait-10ms
[232.936391] Subtest wait-10ms: SUCCESS (0.171s)
[233.052411] [035/156] (777s left) kms_content_protection (legacy-hdcp14)
[233.148567] Starting subtest: legacy-hdcp14
[233.154523] Subtest legacy-hdcp14: SKIP (0.004s)
[233.254872] [036/156] (777s left) syncobj_wait (reset-signaled)
[233.289544] Starting subtest: reset-signaled
[233.290337] Subtest reset-signaled: SUCCESS (0.000s)
[233.361498] [037/156] (777s left) gem_ctx_isolation (dirty-switch)
[233.402502] Starting subtest: dirty-switch
[233.403248] Starting dynamic subtest: rcs0
[233.592565] Dynamic subtest rcs0: SUCCESS (0.181s)
[233.600249] Starting dynamic subtest: bcs0
[233.811588] Dynamic subtest bcs0: SUCCESS (0.218s)
[233.819306] Starting dynamic subtest: vcs0
[234.023934] Dynamic subtest vcs0: SUCCESS (0.212s)
[234.031794] Starting dynamic subtest: vcs1
[234.233785] Dynamic subtest vcs1: SUCCESS (0.218s)
[234.241707] Starting dynamic subtest: vecs0
[234.452639] Dynamic subtest vecs0: SUCCESS (0.210s)
[234.453416] Subtest dirty-switch: SUCCESS (1.042s)
[234.624345] [038/156] (776s left) gem_flink_basic (bad-open)
[234.657925] Starting subtest: bad-open
[234.658725] Subtest bad-open: SUCCESS (0.000s)
[234.719158] [039/156] (776s left) gem_caching (writes)
[234.756337] Starting subtest: writes
[243.979683] Subtest writes: SUCCESS (9.223s)
[244.086545] [040/156] (767s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[244.178557] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[244.179390] Starting dynamic subtest: pipe-A
[244.566051] Dynamic subtest pipe-A: SUCCESS (0.388s)
[244.576580] Starting dynamic subtest: pipe-B
[245.008451] Dynamic subtest pipe-B: SUCCESS (0.442s)
[245.020489] Starting dynamic subtest: pipe-C
[245.460504] Dynamic subtest pipe-C: SUCCESS (0.451s)
[245.473431] Starting dynamic subtest: pipe-D
[245.903755] Dynamic subtest pipe-D: SUCCESS (0.443s)
[245.904492] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (1.727s)
[246.099423] [041/156] (765s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[246.135006] Starting subtest: single-wait-all-for-submit-available-submitted
[246.135815] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[246.201760] [042/156] (765s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-render)
[246.297608] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-render
[246.299045] Subtest fbchdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[246.394979] [043/156] (764s left) kms_pm_rpm (system-suspend-idle)
[247.807041] Starting subtest: system-suspend-idle
[267.762676] Subtest system-suspend-idle: SUCCESS (4.912s)
[274.049846] [044/156] (743s left) kms_atomic_transition (modeset-transition)
[274.150492] Starting subtest: modeset-transition
[274.151273] Starting dynamic subtest: 1x-outputs
[275.421522] Dynamic subtest 1x-outputs: SUCCESS (1.261s)
[275.422614] Subtest modeset-transition: SUCCESS (1.262s)
[275.567844] [045/156] (741s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[275.669355] Starting subtest: pipe-fbc-rte
[275.673473] Subtest pipe-fbc-rte: SKIP (0.000s)
[275.768978] [046/156] (741s left) gem_spin_batch (resubmit-all)
[275.810688] Starting subtest: resubmit-all
[275.811447] Starting dynamic subtest: rcs0
[275.815449] Dynamic subtest rcs0: SUCCESS (0.004s)
[275.825010] Starting dynamic subtest: bcs0
[275.825802] Dynamic subtest bcs0: SUCCESS (0.002s)
[275.835093] Starting dynamic subtest: vcs0
[275.835829] Dynamic subtest vcs0: SUCCESS (0.002s)
[275.843992] Starting dynamic subtest: vcs1
[275.844708] Dynamic subtest vcs1: SUCCESS (0.002s)
[275.852823] Starting dynamic subtest: vecs0
[275.853525] Dynamic subtest vecs0: SUCCESS (0.002s)
[275.854238] Subtest resubmit-all: SUCCESS (0.016s)
[276.015738] [047/156] (741s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[276.108656] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[276.110094] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[276.208988] [048/156] (741s left) syncobj_basic (illegal-fd-to-handle)
[276.243724] Starting subtest: illegal-fd-to-handle
[276.244546] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[276.307003] [049/156] (741s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[276.399826] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[276.401240] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[276.493219] [050/156] (741s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[276.591123] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[277.272437] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (0.673s)
[277.405354] [051/156] (740s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[277.441144] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[277.547036] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.104s)
[277.636382] [052/156] (740s left) api_intel_bb (misplaced-blitter)
[277.671300] Starting subtest: misplaced-blitter
[277.675901] Subtest misplaced-blitter: SUCCESS (0.005s)
[277.784577] [053/156] (740s left) kms_atomic_interruptible (universal-setplane-cursor)
[277.875841] Starting subtest: universal-setplane-cursor
[277.877631] Starting dynamic subtest: pipe-A-HDMI-A-1
[284.084963] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.166s)
[284.085826] Subtest universal-setplane-cursor: SUCCESS (6.168s)
[284.223215] [054/156] (733s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[284.327396] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[284.328943] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[284.406110] [055/156] (733s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[284.498834] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[284.500257] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[284.588635] [056/156] (733s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[284.678416] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[284.679152] Starting dynamic subtest: pipe-A-valid-mode
[285.798699] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.115s)
[285.799531] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SUCCESS (1.117s)
[285.955038] [057/156] (732s left) gem_pxp (create-protected-buffer)
[286.061811] Starting subtest: create-protected-buffer
[286.063085] Subtest create-protected-buffer: SUCCESS (0.000s)
[286.166127] [058/156] (731s left) gem_fence_thrash (bo-write-verify-threaded-x)
[286.198472] Starting subtest: bo-write-verify-threaded-x
[291.360317] Subtest bo-write-verify-threaded-x: SUCCESS (5.113s)
[291.452082] [059/156] (726s left) gen9_exec_parse (allowed-single)
[291.489706] Subtest allowed-single: SKIP (0.000s)
[291.531243] [060/156] (726s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[291.630462] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[291.631870] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[291.720662] [061/156] (726s left) gem_exec_balancer (bonded-semaphore)
[291.763423] Starting subtest: bonded-semaphore
[296.097588] Subtest bonded-semaphore: SUCCESS (4.293s)
[296.246183] [062/156] (721s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[296.337346] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[296.356486] Starting dynamic subtest: pipe-A-plane-0
[296.565094] Dynamic subtest pipe-A-plane-0: SUCCESS (0.208s)
[296.583837] Starting dynamic subtest: pipe-A-plane-3
[296.740510] Dynamic subtest pipe-A-plane-3: SUCCESS (0.173s)
[296.754973] Starting dynamic subtest: pipe-A-plane-5
[296.907362] Dynamic subtest pipe-A-plane-5: SUCCESS (0.165s)
[297.067773] Starting dynamic subtest: pipe-B-plane-0
[297.232689] Dynamic subtest pipe-B-plane-0: SUCCESS (0.175s)
[297.246291] Starting dynamic subtest: pipe-B-plane-3
[297.399743] Dynamic subtest pipe-B-plane-3: SUCCESS (0.166s)
[297.416914] Starting dynamic subtest: pipe-B-plane-5
[297.575195] Dynamic subtest pipe-B-plane-5: SUCCESS (0.173s)
[297.649886] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SUCCESS (1.311s)
[297.810745] [063/156] (720s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[297.909776] Starting subtest: fbc-rgb565-draw-mmap-wc
[299.165139] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (1.254s)
[299.288795] [064/156] (719s left) kms_pwrite_crc (basic)
[299.381805] Starting subtest: basic
[299.698437] Subtest basic: SUCCESS (0.316s)
[299.848359] [065/156] (718s left) gem_flink_basic (bad-flink)
[299.885058] Starting subtest: bad-flink
[299.885799] Subtest bad-flink: SUCCESS (0.000s)
[299.963991] [066/156] (718s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-move)
[300.056539] Starting subtest: hdr-2p-primscrn-spr-indfb-move
[300.057994] Subtest hdr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[300.158861] [067/156] (718s left) gem_ctx_persistence (legacy-engines-persistence)
[300.197542] Starting subtest: legacy-engines-persistence
[300.198314] Starting dynamic subtest: render
[300.989032] Dynamic subtest render: SUCCESS (0.790s)
[301.001627] Starting dynamic subtest: bsd1
[301.762116] Dynamic subtest bsd1: SUCCESS (0.769s)
[301.774475] Starting dynamic subtest: bsd2
[302.525990] Dynamic subtest bsd2: SUCCESS (0.760s)
[302.538074] Starting dynamic subtest: blt
[303.290042] Dynamic subtest blt: SUCCESS (0.761s)
[303.302328] Starting dynamic subtest: vebox
[304.060179] Dynamic subtest vebox: SUCCESS (0.767s)
[304.061467] Subtest legacy-engines-persistence: SUCCESS (3.860s)
[304.134309] [068/156] (714s left) gen7_exec_parse (basic-allowed)
[304.172263] Subtest basic-allowed: SKIP (0.000s)
[304.212628] [069/156] (714s left) gem_exec_schedule (reorder-wide)
[304.376662] Starting subtest: reorder-wide
[304.377632] Starting dynamic subtest: rcs0
[304.456303] Dynamic subtest rcs0: SUCCESS (0.080s)
[304.470337] Starting dynamic subtest: bcs0
[304.537135] Dynamic subtest bcs0: SUCCESS (0.079s)
[304.551169] Starting dynamic subtest: vcs0
[304.612525] Dynamic subtest vcs0: SUCCESS (0.073s)
[304.626916] Starting dynamic subtest: vcs1
[304.689094] Dynamic subtest vcs1: SUCCESS (0.074s)
[304.708676] Starting dynamic subtest: vecs0
[304.771057] Dynamic subtest vecs0: SUCCESS (0.079s)
[304.772072] Subtest reorder-wide: SUCCESS (0.396s)
[304.978160] [070/156] (713s left) kms_frontbuffer_tracking (psrhdr-slowdraw)
[305.076421] Starting subtest: psrhdr-slowdraw
[305.077887] Subtest psrhdr-slowdraw: SKIP (0.000s)
[305.169511] [071/156] (713s left) perf (non-zero-reason)
[305.254868] Starting subtest: non-zero-reason
[305.255591] Starting dynamic subtest: 0-rcs0
[313.096160] Dynamic subtest 0-rcs0: SUCCESS (7.803s)
[313.097058] Subtest non-zero-reason: SUCCESS (7.804s)
[313.135035] [072/156] (705s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-pwrite)
[313.230195] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-pwrite
[313.231680] Subtest fbchdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[313.325444] [073/156] (705s left) i915_drm_fdinfo (all-busy-check-all)
[313.362634] Starting subtest: all-busy-check-all
[313.882603] Subtest all-busy-check-all: SUCCESS (0.519s)
[313.957465] [074/156] (704s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[314.051614] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt
[314.053092] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[314.143956] [075/156] (704s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[314.233580] Starting subtest: compare-crc-sanitycheck-nv12
[314.234374] Starting dynamic subtest: pipe-A-HDMI-A-1
[314.579601] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.345s)
[314.591108] Starting dynamic subtest: pipe-B-HDMI-A-1
[314.905594] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.323s)
[314.915127] Starting dynamic subtest: pipe-C-HDMI-A-1
[315.230285] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.323s)
[315.240969] Starting dynamic subtest: pipe-D-HDMI-A-1
[315.551256] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.318s)
[315.552017] Subtest compare-crc-sanitycheck-nv12: SUCCESS (1.318s)
[315.727758] [076/156] (703s left) gem_exec_reloc (basic-write-gtt)
[315.769557] Starting subtest: basic-write-gtt
[315.773965] Subtest basic-write-gtt: SUCCESS (0.006s)
[315.901738] [077/156] (702s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[315.995913] Starting subtest: cursor-rapid-movement-max-size
[315.998098] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[316.112568] [078/156] (702s left) kms_color_pipeline (plane-lut1d)
[316.204131] Starting subtest: plane-lut1d
[316.295865] Starting dynamic subtest: pipe-A-plane-0
[316.387468] Dynamic subtest pipe-A-plane-0: SUCCESS (0.091s)
[316.406167] Starting dynamic subtest: pipe-A-plane-1
[316.479068] Dynamic subtest pipe-A-plane-1: SUCCESS (0.088s)
[316.493227] Starting dynamic subtest: pipe-A-plane-2
[316.570677] Dynamic subtest pipe-A-plane-2: SUCCESS (0.089s)
[316.767986] Starting dynamic subtest: pipe-B-plane-0
[316.840531] Dynamic subtest pipe-B-plane-0: SUCCESS (0.083s)
[316.856246] Starting dynamic subtest: pipe-B-plane-1
[316.931708] Dynamic subtest pipe-B-plane-1: SUCCESS (0.089s)
[316.946286] Starting dynamic subtest: pipe-B-plane-2
[317.023915] Dynamic subtest pipe-B-plane-2: SUCCESS (0.091s)
[317.223940] Starting dynamic subtest: pipe-C-plane-0
[317.297507] Dynamic subtest pipe-C-plane-0: SUCCESS (0.083s)
[317.311870] Starting dynamic subtest: pipe-C-plane-1
[317.397540] Dynamic subtest pipe-C-plane-1: SUCCESS (0.098s)
[317.412093] Starting dynamic subtest: pipe-C-plane-2
[317.497539] Dynamic subtest pipe-C-plane-2: SUCCESS (0.097s)
[317.713471] Starting dynamic subtest: pipe-D-plane-0
[317.796681] Dynamic subtest pipe-D-plane-0: SUCCESS (0.091s)
[317.810669] Starting dynamic subtest: pipe-D-plane-1
[317.896867] Dynamic subtest pipe-D-plane-1: SUCCESS (0.098s)
[317.911221] Starting dynamic subtest: pipe-D-plane-2
[317.997030] Dynamic subtest pipe-D-plane-2: SUCCESS (0.098s)
[318.048847] Subtest plane-lut1d: SUCCESS (1.842s)
[318.176478] [079/156] (700s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[318.283564] Starting subtest: yf-tiled-16bpp-rotate-180
[318.285051] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[318.388035] [080/156] (700s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[318.488102] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[318.489553] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[318.595032] [081/156] (700s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[318.689900] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt
[318.691312] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[318.784700] [082/156] (700s left) gem_exec_reloc (basic-wc-read)
[318.823105] Starting subtest: basic-wc-read
[318.828711] Subtest basic-wc-read: SUCCESS (0.006s)
[318.952033] [083/156] (700s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[319.041480] Starting subtest: short-busy-flip-before-cursor-toggle
[319.042874] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[319.111549] [084/156] (700s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[319.204557] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[319.214259] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.009s)
[319.275325] [085/156] (699s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[319.368006] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[319.369460] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[319.472013] [086/156] (699s left) kms_draw_crc (draw-method-render)
[319.561593] Starting subtest: draw-method-render
[319.562338] Starting dynamic subtest: xrgb8888-untiled
[319.721252] Dynamic subtest xrgb8888-untiled: SUCCESS (0.160s)
[319.739264] Starting dynamic subtest: rgb565-untiled
[319.888171] Dynamic subtest rgb565-untiled: SUCCESS (0.164s)
[319.907588] Starting dynamic subtest: xrgb2101010-untiled
[320.046792] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.156s)
[320.064807] Starting dynamic subtest: xbgr16161616f-untiled
[320.205192] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.156s)
[320.224280] Starting dynamic subtest: xrgb8888-xtiled
[320.296731] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.089s)
[320.316788] Starting dynamic subtest: rgb565-xtiled
[320.388553] Dynamic subtest rgb565-xtiled: SUCCESS (0.089s)
[320.408814] Starting dynamic subtest: xrgb2101010-xtiled
[320.471737] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.081s)
[320.491577] Starting dynamic subtest: xbgr16161616f-xtiled
[320.555063] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.081s)
[320.576618] Starting dynamic subtest: xrgb8888-ytiled
[320.646833] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.088s)
[320.666421] Starting dynamic subtest: rgb565-ytiled
[320.738665] Dynamic subtest rgb565-ytiled: SUCCESS (0.089s)
[320.758446] Starting dynamic subtest: xrgb2101010-ytiled
[320.822131] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.081s)
[320.846123] Starting dynamic subtest: xbgr16161616f-ytiled
[320.913738] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.088s)
[320.916900] Subtest draw-method-render: SUCCESS (1.353s)
[321.019478] [087/156] (698s left) kms_cursor_crc (cursor-sliding-256x85)
[321.115750] Starting subtest: cursor-sliding-256x85
[321.120270] Starting dynamic subtest: pipe-A-HDMI-A-1
[322.299185] Dynamic subtest pipe-A-HDMI-A-1: FAIL (1.004s)
[322.308812] Starting dynamic subtest: pipe-D-HDMI-A-1
[324.072676] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.909s)
[324.073516] Subtest cursor-sliding-256x85: FAIL (2.955s)
[324.252520] [088/156] (695s left) kms_cursor_crc (cursor-onscreen-256x256)
[324.352675] Starting subtest: cursor-onscreen-256x256
[324.358224] Starting dynamic subtest: pipe-A-HDMI-A-1
[325.529678] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.171s)
[325.572160] Starting dynamic subtest: pipe-D-HDMI-A-1
[326.721678] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.159s)
[326.722479] Subtest cursor-onscreen-256x256: SUCCESS (2.367s)
[326.882534] [089/156] (692s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render)
[326.987947] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render
[326.989494] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[327.092458] [090/156] (692s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[327.185324] Starting subtest: fbcpsr-slowdraw
[327.186775] Subtest fbcpsr-slowdraw: SKIP (0.000s)
[327.282575] [091/156] (692s left) kms_lease (cursor-implicit-plane)
[327.371379] Starting subtest: cursor-implicit-plane
[327.373217] Starting dynamic subtest: pipe-A-HDMI-A-1
[327.550468] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.177s)
[327.564423] Starting dynamic subtest: pipe-B-HDMI-A-1
[327.725806] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.172s)
[327.737897] Starting dynamic subtest: pipe-C-HDMI-A-1
[327.898493] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.171s)
[327.916012] Starting dynamic subtest: pipe-D-HDMI-A-1
[328.059469] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.158s)
[328.060232] Subtest cursor-implicit-plane: SUCCESS (0.688s)
[328.187631] [092/156] (691s left) syncobj_wait (invalid-reset-zero-handles)
[328.222559] Starting subtest: invalid-reset-zero-handles
[328.223276] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[328.299624] [093/156] (691s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[328.393640] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[328.395125] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[328.486913] [094/156] (691s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[328.585273] Starting subtest: yf-tiled-64bpp-rotate-90
[328.586745] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[328.687354] [095/156] (690s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc)
[328.781203] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc
[328.782650] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[328.877252] [096/156] (690s left) gem_exec_fence (long-history)
[329.202208] Starting subtest: long-history
[334.935902] Subtest long-history: SUCCESS (5.725s)
[335.355269] [097/156] (684s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[335.450887] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[335.452313] Subtest psr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[335.548501] [098/156] (684s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[335.637859] Starting subtest: bad-rotation-90-yf-tiled-ccs
[335.638638] Starting dynamic subtest: pipe-A-HDMI-A-1
[335.645426] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[335.654657] Starting dynamic subtest: pipe-B-HDMI-A-1
[335.661149] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[335.670810] Starting dynamic subtest: pipe-C-HDMI-A-1
[335.677479] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[335.686601] Starting dynamic subtest: pipe-D-HDMI-A-1
[335.693461] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[335.694836] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.007s)
[335.912583] [099/156] (683s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[336.004570] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[338.399656] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (2.394s)
[338.556097] [100/156] (681s left) kms_chamelium_audio (dp-audio-edid)
[338.703334] Subtest dp-audio-edid: SKIP (0.000s)
[338.808170] [101/156] (681s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[338.902628] Starting subtest: addfb25-yf-tiled-legacy
[338.903415] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[339.023677] [102/156] (680s left) kms_frontbuffer_tracking (hdr-1p-primscrn-indfb-pgflip-blt)
[339.117040] Starting subtest: hdr-1p-primscrn-indfb-pgflip-blt
[339.118540] Subtest hdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[339.203029] [103/156] (680s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[339.297021] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[339.298467] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[339.395878] [104/156] (680s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[339.489599] Starting subtest: fbc-2p-pri-indfb-multidraw
[339.491094] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[339.584664] [105/156] (680s left) kms_sequence (queue-busy)
[339.673436] Starting subtest: queue-busy
[339.674192] Starting dynamic subtest: pipe-A-HDMI-A-1
[340.970201] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.296s)
[340.981058] Starting dynamic subtest: pipe-B-HDMI-A-1
[342.243199] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.271s)
[342.255296] Starting dynamic subtest: pipe-C-HDMI-A-1
[343.524870] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.279s)
[343.536702] Starting dynamic subtest: pipe-D-HDMI-A-1
[344.807830] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.280s)
[344.808656] Subtest queue-busy: SUCCESS (5.132s)
[344.930193] [106/156] (675s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[345.026314] Starting subtest: plane-upscale-20x20-with-rotation
[345.027024] Starting dynamic subtest: pipe-A
[346.112498] Dynamic subtest pipe-A: SKIP (1.083s)
[346.124339] Starting dynamic subtest: pipe-B
[347.271297] Dynamic subtest pipe-B: SKIP (1.158s)
[347.280771] Starting dynamic subtest: pipe-C
[348.418056] Dynamic subtest pipe-C: SKIP (1.145s)
[348.427463] Starting dynamic subtest: pipe-D
[349.573555] Dynamic subtest pipe-D: SKIP (1.151s)
[349.575039] Subtest plane-upscale-20x20-with-rotation: SKIP (4.541s)
[349.741985] [107/156] (670s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-pwrite)
[349.846797] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-pwrite
[349.848194] Subtest psrhdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[349.929972] [108/156] (670s left) gem_exec_reloc (basic-write-wc)
[349.969028] Starting subtest: basic-write-wc
[349.974903] Subtest basic-write-wc: SUCCESS (0.006s)
[350.104215] [109/156] (670s left) syncobj_timeline (reset-signaled)
[350.140337] Starting subtest: reset-signaled
[350.141131] Subtest reset-signaled: SUCCESS (0.001s)
[350.206232] [110/156] (670s left) kms_psr (pr-cursor-plane-move)
[350.296145] Subtest pr-cursor-plane-move: SKIP (0.000s)
[350.342730] [111/156] (669s left) syncobj_wait (invalid-wait-illegal-handle)
[350.379766] Starting subtest: invalid-wait-illegal-handle
[350.380579] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[350.439208] [112/156] (669s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[350.534498] Starting subtest: extended-pageflip-modeset-hang-oldfb
[350.535225] Starting dynamic subtest: pipe-A
[370.517383] Dynamic subtest pipe-A: SUCCESS (19.981s)
[370.530037] Starting dynamic subtest: pipe-D
[390.468876] Dynamic subtest pipe-D: SUCCESS (19.960s)
[390.469675] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (39.948s)
[390.608554] [113/156] (629s left) kms_psr (psr2-primary-blt)
[390.704118] Subtest psr2-primary-blt: SKIP (0.000s)
[390.746626] [114/156] (629s left) gem_softpin (evict-snoop-interruptible)
[390.787712] Starting subtest: evict-snoop-interruptible
[390.789224] Subtest evict-snoop-interruptible: SKIP (0.000s)
[390.852631] [115/156] (629s left) kms_force_connector_basic (force-load-detect)
[390.976629] Starting subtest: force-load-detect
[390.978212] Subtest force-load-detect: SKIP (0.000s)
[391.133216] [116/156] (629s left) kms_chamelium_edid (hdmi-mode-timings)
[391.272102] Subtest hdmi-mode-timings: SKIP (0.000s)
[391.372828] [117/156] (629s left) syncobj_timeline (invalid-signal-zero-handles)
[391.409777] Starting subtest: invalid-signal-zero-handles
[391.410611] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[391.471064] [118/156] (629s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt)
[391.562945] Starting subtest: fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt
[391.564386] Subtest fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[391.666894] [119/156] (628s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[391.758885] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[391.760436] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[391.845464] [120/156] (628s left) gem_mmap_gtt (fault-concurrent-x)
[391.881104] Starting subtest: fault-concurrent-X
[394.558595] Subtest fault-concurrent-X: SUCCESS (2.670s)
[394.684930] [121/156] (626s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[394.725146] Starting subtest: y-tiled-to-vebox-y-tiled
[394.725858] Starting dynamic subtest: smem
[394.820986] Dynamic subtest smem: SUCCESS (0.095s)
[394.821733] Subtest y-tiled-to-vebox-y-tiled: SUCCESS (0.096s)
[395.033564] [122/156] (625s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-plflip-blt)
[395.131484] Starting subtest: psrhdr-2p-scndscrn-shrfb-plflip-blt
[395.132873] Subtest psrhdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[395.221334] [123/156] (625s left) vgem_basic (debugfs)
[395.258737] Starting subtest: debugfs
[395.259455] Subtest debugfs: SUCCESS (0.000s)
[395.313359] [124/156] (625s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[395.400476] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[395.401212] Starting dynamic subtest: pipe-A-valid-mode
[396.617610] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.216s)
[396.618421] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (1.218s)
[396.771291] [125/156] (624s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[396.869568] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[396.871063] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[396.973802] [126/156] (623s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[397.066069] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[397.067492] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[397.165695] [127/156] (623s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[397.258204] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[397.259682] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[397.347716] [128/156] (623s left) kms_vblank (wait-forked-hang)
[397.435515] Starting subtest: wait-forked-hang
[397.436237] Starting dynamic subtest: pipe-A-HDMI-A-1
[411.478200] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (14.043s)
[411.490429] Starting dynamic subtest: pipe-D-HDMI-A-1
[425.797873] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (14.316s)
[425.798614] Subtest wait-forked-hang: SUCCESS (28.365s)
[425.979525] [129/156] (595s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[426.073510] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[426.075383] Starting dynamic subtest: pipe-A-valid-mode
[427.947266] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.873s)
[427.948314] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SUCCESS (1.874s)
[428.082731] [130/156] (593s left) gem_ctx_exec (basic-invalid-context)
[428.127848] Starting subtest: basic-invalid-context
[428.129816] Subtest basic-invalid-context: SUCCESS (0.002s)
[428.259942] [131/156] (592s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-msflip-blt)
[428.354853] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-msflip-blt
[428.356233] Subtest fbcpsrhdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[428.448661] [132/156] (592s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[428.536634] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (0.000s)
[428.583932] [133/156] (592s left) gem_ppgtt (blt-vs-render-ctxn)
[428.621530] Starting subtest: blt-vs-render-ctxN
[461.251788] Subtest blt-vs-render-ctxN: SUCCESS (32.621s)
[461.386825] [134/156] (559s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[461.469298] Starting subtest: basic-gtt-cpu-noreloc
[461.474005] Subtest basic-gtt-cpu-noreloc: SUCCESS (0.004s)
[461.600481] [135/156] (559s left) gem_softpin (invalid)
[461.639634] Starting subtest: invalid
[461.643649] Subtest invalid: SUCCESS (0.004s)
[461.754610] [136/156] (559s left) gem_exec_capture (capture)
[461.794199] Starting subtest: capture
[461.794969] Starting dynamic subtest: rcs0-smem
[463.077358] Dynamic subtest rcs0-smem: SUCCESS (1.282s)
[463.087084] Starting dynamic subtest: bcs0-smem
[464.357373] Dynamic subtest bcs0-smem: SUCCESS (1.271s)
[464.367079] Starting dynamic subtest: vcs0-smem
[465.629930] Dynamic subtest vcs0-smem: SUCCESS (1.271s)
[465.639389] Starting dynamic subtest: vcs1-smem
[466.901277] Dynamic subtest vcs1-smem: SUCCESS (1.273s)
[466.911696] Starting dynamic subtest: vecs0-smem
[468.173564] Dynamic subtest vecs0-smem: SUCCESS (1.271s)
[468.174250] Subtest capture: SUCCESS (6.372s)
[468.295567] [137/156] (553s left) gem_tiled_blits (basic)
[468.383012] Starting subtest: basic
[468.396640] Subtest basic: SUCCESS (0.014s)
[468.535712] [138/156] (552s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[468.676878] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[468.678286] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[468.790114] [139/156] (552s left) gem_mmap_offset (partial-remap)
[468.824684] Starting subtest: partial-remap
[468.825463] Starting dynamic subtest: smem0
[468.830054] Dynamic subtest smem0: SUCCESS (0.003s)
[468.830773] Subtest partial-remap: SUCCESS (0.004s)
[468.930433] [140/156] (552s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-blt)
[469.021880] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-blt
[469.023314] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[469.113096] [141/156] (552s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-blt)
[469.207479] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-blt
[469.208899] Subtest hdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[469.298532] [142/156] (552s left) i915_power (sanity)
[469.332385] Starting subtest: sanity
[473.353857] Subtest sanity: SUCCESS (4.010s)
[473.454821] [143/156] (548s left) gem_exec_schedule (preempt-queue)
[473.510289] Starting subtest: preempt-queue
[473.511010] Starting dynamic subtest: rcs0
[473.614159] Dynamic subtest rcs0: SUCCESS (0.104s)
[473.624420] Starting dynamic subtest: bcs0
[473.719623] Dynamic subtest bcs0: SUCCESS (0.104s)
[473.731763] Starting dynamic subtest: vcs0
[473.828325] Dynamic subtest vcs0: SUCCESS (0.107s)
[473.839234] Starting dynamic subtest: vcs1
[473.940024] Dynamic subtest vcs1: SUCCESS (0.111s)
[473.954262] Starting dynamic subtest: vecs0
[474.053684] Dynamic subtest vecs0: SUCCESS (0.112s)
[474.054462] Subtest preempt-queue: SUCCESS (0.545s)
[474.362850] [144/156] (547s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[474.454687] Starting subtest: cursorB-vs-flipA-legacy
[474.456238] Subtest cursorB-vs-flipA-legacy: SKIP (0.002s)
[474.537524] [145/156] (547s left) i915_pm_rps (reset)
[474.577190] Starting subtest: reset
[479.142286] Subtest reset: SUCCESS (4.532s)
[479.221271] [146/156] (542s left) kms_psr (fbc-psr-cursor-plane-onoff)
[479.313160] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s)
[479.359733] [147/156] (542s left) kms_setmode (clone-exclusive-crtc)
[479.393435] Starting subtest: clone-exclusive-crtc
[479.395476] Subtest clone-exclusive-crtc: SKIP (0.000s)
[479.473614] [148/156] (542s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[479.565921] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[479.567353] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[479.669459] [149/156] (542s left) kms_flip (flip-vs-rmfb)
[479.758618] Starting subtest: flip-vs-rmfb
[479.760963] Starting dynamic subtest: A-HDMI-A1
[487.485712] Dynamic subtest A-HDMI-A1: SUCCESS (7.722s)
[487.504447] Starting dynamic subtest: B-HDMI-A1
[495.142709] Dynamic subtest B-HDMI-A1: SUCCESS (7.653s)
[495.162098] Starting dynamic subtest: C-HDMI-A1
[502.826719] Dynamic subtest C-HDMI-A1: SUCCESS (7.681s)
[502.844191] Starting dynamic subtest: D-HDMI-A1
[510.504468] Dynamic subtest D-HDMI-A1: SUCCESS (7.680s)
[510.510390] Subtest flip-vs-rmfb: SUCCESS (30.754s)
[510.678829] [150/156] (511s left) gem_exec_whisper (basic-contexts-all)
[510.734133] Starting subtest: basic-contexts-all
[512.447553] Subtest basic-contexts-all: SUCCESS (1.713s)
[512.635531] [151/156] (509s left) dmabuf_sync_file (export-basic)
[512.671894] Starting subtest: export-basic
[512.673929] Subtest export-basic: SUCCESS (0.001s)
[512.730349] [152/156] (509s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[512.826689] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[512.828179] Subtest hdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[512.919359] [153/156] (509s left) gem_sync (basic-each)
[512.962478] Starting subtest: basic-each
[515.082016] Subtest basic-each: SUCCESS (2.120s)
[515.307152] [154/156] (506s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[515.401222] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[515.403089] Starting dynamic subtest: pipe-A-HDMI-A-1
[515.410459] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[515.420163] Starting dynamic subtest: pipe-B-HDMI-A-1
[515.427452] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[515.437066] Starting dynamic subtest: pipe-C-HDMI-A-1
[515.444317] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[515.453764] Starting dynamic subtest: pipe-D-HDMI-A-1
[515.461369] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[515.462734] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.007s)
[515.681369] [155/156] (506s left) syncobj_wait (multi-wait-for-submit-submitted)
[515.717830] Starting subtest: multi-wait-for-submit-submitted
[515.819177] Subtest multi-wait-for-submit-submitted: SUCCESS (0.101s)
[515.901060] [156/156] (506s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[515.991509] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt
[515.992973] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[516.098987] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_pipe_b_c_ivb
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_force_connector_basic
results: parsing output: 5/ for test: perf_pmu
results: parsing output: 6/ for test: gem_ccs
results: parsing output: 7/ for test: kms_plane_alpha_blend
results: parsing output: 8/ for test: gem_mmap_gtt
results: parsing output: 9/ for test: api_intel_allocator
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_plane
results: parsing output: 12/ for test: kms_ccs
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_pm_rpm
results: parsing output: 16/ for test: gem_render_copy
results: parsing output: 17/ for test: sysfs_heartbeat_interval
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_ctx_param
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: i915_pm_freq_mult
results: parsing output: 22/ for test: prime_busy
results: parsing output: 23/ for test: gem_exec_gttfill
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: gem_ctx_param
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: gem_lmem_swapping
results: parsing output: 28/ for test: gem_ctx_shared
results: parsing output: 29/ for test: kms_psr
results: parsing output: 30/ for test: gem_bad_reloc
results: parsing output: 31/ for test: kms_chamelium_hpd
results: parsing output: 32/ for test: kms_psr2_sf
results: parsing output: 33/ for test: gem_eio
results: parsing output: 34/ for test: kms_content_protection
results: parsing output: 35/ for test: syncobj_wait
results: parsing output: 36/ for test: gem_ctx_isolation
results: parsing output: 37/ for test: gem_flink_basic
results: parsing output: 38/ for test: gem_caching
results: parsing output: 39/ for test: kms_plane_scaling
results: parsing output: 40/ for test: syncobj_timeline
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_pm_rpm
results: parsing output: 43/ for test: kms_atomic_transition
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_spin_batch
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: syncobj_basic
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: api_intel_bb
results: parsing output: 52/ for test: kms_atomic_interruptible
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_flip_scaled_crc
results: parsing output: 56/ for test: gem_pxp
results: parsing output: 57/ for test: gem_fence_thrash
results: parsing output: 58/ for test: gen9_exec_parse
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_exec_balancer
results: parsing output: 61/ for test: kms_plane
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_pwrite_crc
results: parsing output: 64/ for test: gem_flink_basic
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_ctx_persistence
results: parsing output: 67/ for test: gen7_exec_parse
results: parsing output: 68/ for test: gem_exec_schedule
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: perf
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: i915_drm_fdinfo
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_pipe_crc_basic
results: parsing output: 75/ for test: gem_exec_reloc
results: parsing output: 76/ for test: kms_cursor_crc
results: parsing output: 77/ for test: kms_color_pipeline
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_exec_reloc
results: parsing output: 82/ for test: kms_cursor_legacy
results: parsing output: 83/ for test: kms_flip
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_draw_crc
results: parsing output: 86/ for test: kms_cursor_crc
results: parsing output: 87/ for test: kms_cursor_crc
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_lease
results: parsing output: 91/ for test: syncobj_wait
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_exec_fence
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_ccs
results: parsing output: 98/ for test: kms_cursor_legacy
results: parsing output: 99/ for test: kms_chamelium_audio
results: parsing output: 100/ for test: kms_addfb_basic
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_sequence
results: parsing output: 105/ for test: kms_plane_scaling
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_exec_reloc
results: parsing output: 108/ for test: syncobj_timeline
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: syncobj_wait
results: parsing output: 111/ for test: kms_busy
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: gem_softpin
results: parsing output: 114/ for test: kms_force_connector_basic
results: parsing output: 115/ for test: kms_chamelium_edid
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gem_mmap_gtt
results: parsing output: 120/ for test: gem_render_copy
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: vgem_basic
results: parsing output: 123/ for test: kms_flip_scaled_crc
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_frontbuffer_tracking
results: parsing output: 127/ for test: kms_vblank
results: parsing output: 128/ for test: kms_flip_scaled_crc
results: parsing output: 129/ for test: gem_ctx_exec
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_psr2_sf
results: parsing output: 132/ for test: gem_ppgtt
results: parsing output: 133/ for test: gem_exec_reloc
results: parsing output: 134/ for test: gem_softpin
results: parsing output: 135/ for test: gem_exec_capture
results: parsing output: 136/ for test: gem_tiled_blits
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: gem_mmap_offset
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: i915_power
results: parsing output: 142/ for test: gem_exec_schedule
results: parsing output: 143/ for test: kms_cursor_legacy
results: parsing output: 144/ for test: i915_pm_rps
results: parsing output: 145/ for test: kms_psr
results: parsing output: 146/ for test: kms_setmode
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: kms_flip
results: parsing output: 149/ for test: gem_exec_whisper
results: parsing output: 150/ for test: dmabuf_sync_file
results: parsing output: 151/ for test: kms_frontbuffer_tracking
results: parsing output: 152/ for test: gem_sync
results: parsing output: 153/ for test: kms_ccs
results: parsing output: 154/ for test: syncobj_wait
results: parsing output: 155/ for test: kms_frontbuffer_tracking
Done.