[50.908318] Initializing watchdogs
[50.908382]   /dev/watchdog0
[50.924212] [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]
[50.929879] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[50.932514] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[50.934721] [001/156] (960s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[51.040993] Starting subtest: fbc-tiling-linear
[52.162755] Subtest fbc-tiling-linear: SUCCESS (1.111s)
[52.285745] [002/156] (959s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[52.322962] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[52.356986] [003/156] (959s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[52.453224] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[52.454643] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[52.542327] [004/156] (958s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[52.636091] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[52.637466] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[52.747800] [005/156] (958s left) kms_force_connector_basic (prune-stale-modes)
[52.872701] Starting subtest: prune-stale-modes
[53.022821] Subtest prune-stale-modes: SUCCESS (0.149s)
[53.177971] [006/156] (958s left) perf_pmu (most-busy-check-all)
[53.218626] Starting subtest: most-busy-check-all
[53.219404] Starting dynamic subtest: rcs0
[53.745142] Dynamic subtest rcs0: SUCCESS (0.522s)
[53.755093] Starting dynamic subtest: bcs0
[54.271449] Dynamic subtest bcs0: SUCCESS (0.522s)
[54.281824] Starting dynamic subtest: vcs0
[54.796246] Dynamic subtest vcs0: SUCCESS (0.521s)
[54.806906] Starting dynamic subtest: vcs1
[55.324273] Dynamic subtest vcs1: SUCCESS (0.524s)
[55.334534] Starting dynamic subtest: vecs0
[55.852223] Dynamic subtest vecs0: SUCCESS (0.524s)
[55.853333] Subtest most-busy-check-all: SUCCESS (2.616s)
[55.923891] [007/156] (955s left) gem_ccs (large-ctrl-surf-copy)
[55.961207] Starting subtest: large-ctrl-surf-copy
[55.963006] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[56.015590] [008/156] (955s left) kms_plane_alpha_blend (coverage-7efc)
[56.105362] Starting subtest: coverage-7efc
[56.176781] Starting dynamic subtest: pipe-A-HDMI-A-1
[56.493293] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.314s)
[56.526078] Starting dynamic subtest: pipe-D-HDMI-A-1
[57.013749] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.491s)
[57.014495] Subtest coverage-7efc: SUCCESS (0.904s)
[57.158514] [009/156] (954s left) gem_mmap_gtt (fault-concurrent)
[57.197405] Starting subtest: fault-concurrent
[59.773986] Subtest fault-concurrent: SUCCESS (2.533s)
[59.863968] [010/156] (951s left) api_intel_allocator (gem-pool)
[59.896851] Starting subtest: gem-pool
[59.903047] Subtest gem-pool: SUCCESS (0.007s)
[60.025337] [011/156] (951s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-fullscreen)
[60.120504] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-fullscreen
[60.121922] Subtest fbchdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[60.216346] [012/156] (951s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[60.303851] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[60.305305] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[60.378318] [013/156] (951s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[60.465619] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[60.466345] Starting dynamic subtest: pipe-A-HDMI-A-1
[60.473145] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[60.479964] Starting dynamic subtest: pipe-B-HDMI-A-1
[60.486778] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[60.493565] Starting dynamic subtest: pipe-C-HDMI-A-1
[60.500366] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[60.507481] Starting dynamic subtest: pipe-D-HDMI-A-1
[60.514585] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[60.516015] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.006s)
[60.714402] [014/156] (951s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[60.805033] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[60.805823] Starting dynamic subtest: pipe-A-HDMI-A-1
[60.813053] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[60.819710] Starting dynamic subtest: pipe-B-HDMI-A-1
[60.826397] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[60.832939] Starting dynamic subtest: pipe-C-HDMI-A-1
[60.839644] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[60.846145] Starting dynamic subtest: pipe-D-HDMI-A-1
[60.853006] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[60.854366] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[61.069418] [015/156] (950s left) kms_frontbuffer_tracking (hdr-rgb565-draw-blt)
[61.162551] Starting subtest: hdr-rgb565-draw-blt
[61.164058] Subtest hdr-rgb565-draw-blt: SKIP (0.000s)
[61.244233] [016/156] (950s left) kms_pm_rpm (legacy-planes-dpms)
[62.657912] Starting subtest: legacy-planes-dpms
[62.659200] Starting dynamic subtest: plane-65
[70.959270] Dynamic subtest plane-65: SUCCESS (8.290s)
[70.967302] Starting dynamic subtest: plane-95
[79.259923] Dynamic subtest plane-95: SUCCESS (8.287s)
[79.266808] Starting dynamic subtest: plane-125
[87.746992] Dynamic subtest plane-125: SUCCESS (8.493s)
[87.758178] Starting dynamic subtest: plane-135
[96.249729] Dynamic subtest plane-135: SUCCESS (8.501s)
[96.260283] Starting dynamic subtest: plane-145
[104.761280] Dynamic subtest plane-145: SUCCESS (8.510s)
[104.772214] Starting dynamic subtest: plane-155
[113.070962] Dynamic subtest plane-155: SUCCESS (8.308s)
[113.072198] Subtest legacy-planes-dpms: SUCCESS (50.395s)
[113.269871] [017/156] (898s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[113.312012] Starting subtest: x-tiled-to-vebox-y-tiled
[113.312742] Starting dynamic subtest: smem
[113.408662] Dynamic subtest smem: SUCCESS (0.096s)
[113.409388] Subtest x-tiled-to-vebox-y-tiled: SUCCESS (0.097s)
[113.588606] [018/156] (898s left) sysfs_heartbeat_interval (invalid)
[113.626822] Starting subtest: invalid
[113.627561] Starting dynamic subtest: vecs0
[113.628285] Dynamic subtest vecs0: SUCCESS (0.000s)
[113.635068] Starting dynamic subtest: vcs0
[113.635804] Dynamic subtest vcs0: SUCCESS (0.000s)
[113.643083] Starting dynamic subtest: bcs0
[113.643799] Dynamic subtest bcs0: SUCCESS (0.000s)
[113.650815] Starting dynamic subtest: rcs0
[113.651531] Dynamic subtest rcs0: SUCCESS (0.000s)
[113.658104] Starting dynamic subtest: vcs1
[113.658816] Dynamic subtest vcs1: SUCCESS (0.000s)
[113.659505] Subtest invalid: SUCCESS (0.004s)
[113.691941] [019/156] (898s left) kms_frontbuffer_tracking (fbc-stridechange)
[113.783726] Starting subtest: fbc-stridechange
[114.770150] Subtest fbc-stridechange: SUCCESS (0.987s)
[114.895477] [020/156] (897s left) gem_ctx_param (basic-default)
[114.930907] Starting subtest: basic-default
[114.931678] Subtest basic-default: SUCCESS (0.000s)
[115.006891] [021/156] (897s left) kms_psr (fbc-pr-primary-mmap-gtt)
[115.097460] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[115.140669] [022/156] (897s left) i915_pm_freq_mult (media-freq)
[115.175169] Starting subtest: media-freq
[115.175957] Starting dynamic subtest: gt0
[115.177498] Dynamic subtest gt0: SKIP (0.000s)
[115.178978] Subtest media-freq: SKIP (0.001s)
[115.227234] [023/156] (897s left) prime_busy (before-wait)
[115.263572] Starting subtest: before-wait
[115.268754] Starting dynamic subtest: rcs0
[115.297308] Dynamic subtest rcs0: SUCCESS (0.028s)
[115.307295] Starting dynamic subtest: bcs0
[115.315924] Dynamic subtest bcs0: SUCCESS (0.018s)
[115.327615] Starting dynamic subtest: vcs0
[115.332585] Dynamic subtest vcs0: SUCCESS (0.016s)
[115.341151] Starting dynamic subtest: vcs1
[115.348458] Dynamic subtest vcs1: SUCCESS (0.015s)
[115.356709] Starting dynamic subtest: vecs0
[115.366573] Dynamic subtest vecs0: SUCCESS (0.017s)
[115.476227] Subtest before-wait: SUCCESS (0.211s)
[115.558625] [024/156] (896s left) gem_exec_gttfill (engines)
[115.601471] Starting subtest: engines
[115.602260] Starting dynamic subtest: rcs0
[139.155329] Dynamic subtest rcs0: SUCCESS (23.553s)
[139.165454] Starting dynamic subtest: bcs0
[162.267339] Dynamic subtest bcs0: SUCCESS (23.112s)
[162.275943] Starting dynamic subtest: vcs0
[185.518442] Dynamic subtest vcs0: SUCCESS (23.251s)
[185.527211] Starting dynamic subtest: vcs1
[208.488373] Dynamic subtest vcs1: SUCCESS (22.969s)
[208.502012] Starting dynamic subtest: vecs0
[231.829450] Dynamic subtest vecs0: SUCCESS (23.340s)
[231.830202] Subtest engines: SUCCESS (116.228s)
[232.016609] [025/156] (780s left) syncobj_timeline (etime-multi-wait-all-submitted)
[232.127274] Starting subtest: etime-multi-wait-all-submitted
[232.229911] Subtest etime-multi-wait-all-submitted: SUCCESS (0.102s)
[232.295805] [026/156] (780s left) gem_ctx_param (get-priority-new-ctx)
[232.330477] Starting subtest: get-priority-new-ctx
[232.331260] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[232.389735] [027/156] (780s left) kms_big_fb (linear-32bpp-rotate-90)
[232.497580] Starting subtest: linear-32bpp-rotate-90
[232.580110] Subtest linear-32bpp-rotate-90: SKIP (0.082s)
[232.690657] [028/156] (779s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[232.729460] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[232.765637] [029/156] (779s left) gem_ctx_shared (disjoint-timelines)
[232.808039] Starting subtest: disjoint-timelines
[232.843495] Subtest disjoint-timelines: SUCCESS (0.035s)
[233.057157] [FACT gem_ctx_shared (disjoint-timelines)] new: kernel.kmod_is_loaded.vgem: true
[233.059429] [030/156] (779s left) kms_psr (fbc-psr2-cursor-plane-move)
[233.156104] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s)
[233.206539] [031/156] (779s left) gem_bad_reloc (negative-reloc-bltcopy)
[233.250008] Starting subtest: negative-reloc-bltcopy
[234.437599] Subtest negative-reloc-bltcopy: SUCCESS (1.188s)
[234.551079] [032/156] (778s left) kms_chamelium_hpd (hdmi-hpd)
[234.722906] Subtest hdmi-hpd: SKIP (0.000s)
[234.824900] [033/156] (777s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[234.920048] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[234.960741] [034/156] (777s left) gem_eio (wait-10ms)
[235.005755] Starting subtest: wait-10ms
[235.175009] Subtest wait-10ms: SUCCESS (0.169s)
[235.300648] [035/156] (777s left) kms_content_protection (legacy-hdcp14)
[235.397061] Starting subtest: legacy-hdcp14
[235.402628] Subtest legacy-hdcp14: SKIP (0.004s)
[235.491787] [036/156] (777s left) syncobj_wait (reset-signaled)
[235.527579] Starting subtest: reset-signaled
[235.528394] Subtest reset-signaled: SUCCESS (0.000s)
[235.594883] [037/156] (777s left) gem_ctx_isolation (dirty-switch)
[235.637016] Starting subtest: dirty-switch
[235.637815] Starting dynamic subtest: rcs0
[235.827373] Dynamic subtest rcs0: SUCCESS (0.181s)
[235.835749] Starting dynamic subtest: bcs0
[236.044484] Dynamic subtest bcs0: SUCCESS (0.216s)
[236.052827] Starting dynamic subtest: vcs0
[236.263907] Dynamic subtest vcs0: SUCCESS (0.219s)
[236.271951] Starting dynamic subtest: vcs1
[236.477140] Dynamic subtest vcs1: SUCCESS (0.221s)
[236.485594] Starting dynamic subtest: vecs0
[236.697613] Dynamic subtest vecs0: SUCCESS (0.211s)
[236.698361] Subtest dirty-switch: SUCCESS (1.052s)
[236.881777] [038/156] (775s left) gem_flink_basic (bad-open)
[236.915452] Starting subtest: bad-open
[236.916211] Subtest bad-open: SUCCESS (0.000s)
[236.973833] [039/156] (775s left) gem_caching (writes)
[237.011231] Starting subtest: writes
[246.311737] Subtest writes: SUCCESS (9.300s)
[246.419874] [040/156] (766s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[246.509700] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[246.510398] Starting dynamic subtest: pipe-A
[246.896988] Dynamic subtest pipe-A: SUCCESS (0.387s)
[246.915758] Starting dynamic subtest: pipe-B
[247.347784] Dynamic subtest pipe-B: SUCCESS (0.450s)
[247.358665] Starting dynamic subtest: pipe-C
[247.790965] Dynamic subtest pipe-C: SUCCESS (0.443s)
[247.802495] Starting dynamic subtest: pipe-D
[248.233143] Dynamic subtest pipe-D: SUCCESS (0.441s)
[248.233910] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (1.724s)
[248.428010] [041/156] (764s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[248.463961] Starting subtest: single-wait-all-for-submit-available-submitted
[248.464728] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[248.530884] [042/156] (764s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-render)
[248.625146] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-render
[248.626590] Subtest fbchdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[248.732667] [043/156] (764s left) kms_pm_rpm (system-suspend-idle)
[250.146483] Starting subtest: system-suspend-idle
[269.935633] Subtest system-suspend-idle: SUCCESS (4.915s)
[277.148965] [044/156] (742s left) kms_atomic_transition (modeset-transition)
[277.240306] Starting subtest: modeset-transition
[277.241030] Starting dynamic subtest: 1x-outputs
[278.520596] Dynamic subtest 1x-outputs: SUCCESS (1.266s)
[278.521393] Subtest modeset-transition: SUCCESS (1.267s)
[278.665414] [045/156] (741s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[278.762870] Starting subtest: pipe-fbc-rte
[278.767216] Subtest pipe-fbc-rte: SKIP (0.000s)
[278.869516] [046/156] (741s left) gem_spin_batch (resubmit-all)
[278.913843] Starting subtest: resubmit-all
[278.914783] Starting dynamic subtest: rcs0
[278.917824] Dynamic subtest rcs0: SUCCESS (0.004s)
[278.928666] Starting dynamic subtest: bcs0
[278.929483] Dynamic subtest bcs0: SUCCESS (0.002s)
[278.938574] Starting dynamic subtest: vcs0
[278.939304] Dynamic subtest vcs0: SUCCESS (0.002s)
[278.948059] Starting dynamic subtest: vcs1
[278.948786] Dynamic subtest vcs1: SUCCESS (0.002s)
[278.957529] Starting dynamic subtest: vecs0
[278.958247] Dynamic subtest vecs0: SUCCESS (0.002s)
[278.958937] Subtest resubmit-all: SUCCESS (0.015s)
[279.123585] [047/156] (741s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[279.218923] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[279.220362] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[279.307470] [048/156] (740s left) syncobj_basic (illegal-fd-to-handle)
[279.341315] Starting subtest: illegal-fd-to-handle
[279.342057] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[279.419209] [049/156] (740s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[279.514402] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[279.515906] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[279.625194] [050/156] (740s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[279.724478] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[280.420794] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (0.686s)
[280.564381] [051/156] (739s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[280.599501] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[280.704273] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.103s)
[280.784061] [052/156] (739s left) api_intel_bb (misplaced-blitter)
[280.819550] Starting subtest: misplaced-blitter
[280.823492] Subtest misplaced-blitter: SUCCESS (0.004s)
[280.932321] [053/156] (739s left) kms_atomic_interruptible (universal-setplane-cursor)
[281.023783] Starting subtest: universal-setplane-cursor
[281.025503] Starting dynamic subtest: pipe-A-HDMI-A-1
[287.245194] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.164s)
[287.245951] Subtest universal-setplane-cursor: SUCCESS (6.166s)
[287.424407] [054/156] (733s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[287.526315] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[287.527817] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[287.623669] [055/156] (732s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[287.715832] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[287.717228] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[287.807046] [056/156] (732s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[287.897250] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[287.898958] Starting dynamic subtest: pipe-A-valid-mode
[288.972504] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.069s)
[288.973317] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SUCCESS (1.070s)
[289.123952] [057/156] (731s left) gem_pxp (create-protected-buffer)
[289.231837] Starting subtest: create-protected-buffer
[289.232929] Subtest create-protected-buffer: SUCCESS (0.000s)
[289.338388] [058/156] (731s left) gem_fence_thrash (bo-write-verify-threaded-x)
[289.371614] Starting subtest: bo-write-verify-threaded-x
[294.109826] Subtest bo-write-verify-threaded-x: SUCCESS (4.689s)
[294.180594] [059/156] (726s left) gen9_exec_parse (allowed-single)
[294.218582] Subtest allowed-single: SKIP (0.000s)
[294.261570] [060/156] (726s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[294.355939] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[294.357355] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[294.441655] [061/156] (726s left) gem_exec_balancer (bonded-semaphore)
[294.485491] Starting subtest: bonded-semaphore
[298.813828] Subtest bonded-semaphore: SUCCESS (4.285s)
[298.976778] [062/156] (721s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[299.072343] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[299.089254] Starting dynamic subtest: pipe-A-plane-0
[299.297962] Dynamic subtest pipe-A-plane-0: SUCCESS (0.208s)
[299.316286] Starting dynamic subtest: pipe-A-plane-3
[299.464984] Dynamic subtest pipe-A-plane-3: SUCCESS (0.164s)
[299.482862] Starting dynamic subtest: pipe-A-plane-5
[299.631824] Dynamic subtest pipe-A-plane-5: SUCCESS (0.164s)
[299.783595] Starting dynamic subtest: pipe-B-plane-0
[299.940940] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[299.960143] Starting dynamic subtest: pipe-B-plane-3
[300.116205] Dynamic subtest pipe-B-plane-3: SUCCESS (0.173s)
[300.134785] Starting dynamic subtest: pipe-B-plane-5
[300.283102] Dynamic subtest pipe-B-plane-5: SUCCESS (0.165s)
[300.356619] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SUCCESS (1.283s)
[300.516627] [063/156] (720s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[300.613829] Starting subtest: fbc-rgb565-draw-mmap-wc
[301.878822] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (1.263s)
[301.990337] [064/156] (718s left) kms_pwrite_crc (basic)
[302.081313] Starting subtest: basic
[302.386945] Subtest basic: SUCCESS (0.305s)
[302.553611] [065/156] (718s left) gem_flink_basic (bad-flink)
[302.591162] Starting subtest: bad-flink
[302.591965] Subtest bad-flink: SUCCESS (0.000s)
[302.648785] [066/156] (718s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-move)
[302.740928] Starting subtest: hdr-2p-primscrn-spr-indfb-move
[302.742365] Subtest hdr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[302.844257] [067/156] (718s left) gem_ctx_persistence (legacy-engines-persistence)
[302.882687] Starting subtest: legacy-engines-persistence
[302.883434] Starting dynamic subtest: render
[303.632103] Dynamic subtest render: SUCCESS (0.748s)
[303.644418] Starting dynamic subtest: bsd1
[304.398076] Dynamic subtest bsd1: SUCCESS (0.763s)
[304.410706] Starting dynamic subtest: bsd2
[305.170001] Dynamic subtest bsd2: SUCCESS (0.768s)
[305.182365] Starting dynamic subtest: blt
[305.936145] Dynamic subtest blt: SUCCESS (0.763s)
[305.949060] Starting dynamic subtest: vebox
[306.708073] Dynamic subtest vebox: SUCCESS (0.769s)
[306.709592] Subtest legacy-engines-persistence: SUCCESS (3.826s)
[306.784557] [068/156] (714s left) gen7_exec_parse (basic-allowed)
[306.822407] Subtest basic-allowed: SKIP (0.000s)
[306.869611] [069/156] (714s left) gem_exec_schedule (reorder-wide)
[307.039440] Starting subtest: reorder-wide
[307.040651] Starting dynamic subtest: rcs0
[307.118498] Dynamic subtest rcs0: SUCCESS (0.078s)
[307.131850] Starting dynamic subtest: bcs0
[307.201361] Dynamic subtest bcs0: SUCCESS (0.081s)
[307.215997] Starting dynamic subtest: vcs0
[307.278123] Dynamic subtest vcs0: SUCCESS (0.075s)
[307.293644] Starting dynamic subtest: vcs1
[307.355366] Dynamic subtest vcs1: SUCCESS (0.075s)
[307.371554] Starting dynamic subtest: vecs0
[307.433072] Dynamic subtest vecs0: SUCCESS (0.076s)
[307.434090] Subtest reorder-wide: SUCCESS (0.395s)
[307.622109] [070/156] (713s left) kms_frontbuffer_tracking (psrhdr-slowdraw)
[307.717873] Starting subtest: psrhdr-slowdraw
[307.719301] Subtest psrhdr-slowdraw: SKIP (0.000s)
[307.809638] [071/156] (713s left) perf (non-zero-reason)
[307.901617] Starting subtest: non-zero-reason
[307.902373] Starting dynamic subtest: 0-rcs0
[315.643043] Dynamic subtest 0-rcs0: SUCCESS (7.704s)
[315.643929] Subtest non-zero-reason: SUCCESS (7.705s)
[315.681556] [072/156] (705s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-pwrite)
[315.777547] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-pwrite
[315.779027] Subtest fbchdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[315.856465] [073/156] (705s left) i915_drm_fdinfo (all-busy-check-all)
[315.894967] Starting subtest: all-busy-check-all
[316.415722] Subtest all-busy-check-all: SUCCESS (0.520s)
[316.490736] [074/156] (704s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[316.583600] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt
[316.585040] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[316.690388] [075/156] (704s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[316.779844] Starting subtest: compare-crc-sanitycheck-nv12
[316.781799] Starting dynamic subtest: pipe-A-HDMI-A-1
[317.123850] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.342s)
[317.136326] Starting dynamic subtest: pipe-B-HDMI-A-1
[317.449158] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.324s)
[317.460708] Starting dynamic subtest: pipe-C-HDMI-A-1
[317.785841] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.333s)
[317.795721] Starting dynamic subtest: pipe-D-HDMI-A-1
[318.112363] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.326s)
[318.114315] Subtest compare-crc-sanitycheck-nv12: SUCCESS (1.333s)
[318.266023] [076/156] (703s left) gem_exec_reloc (basic-write-gtt)
[318.308595] Starting subtest: basic-write-gtt
[318.314920] Subtest basic-write-gtt: SUCCESS (0.006s)
[318.438210] [077/156] (703s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[318.532070] Starting subtest: cursor-rapid-movement-max-size
[318.534334] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[318.620327] [078/156] (702s left) kms_color_pipeline (plane-lut1d)
[318.712691] Starting subtest: plane-lut1d
[318.801889] Starting dynamic subtest: pipe-A-plane-0
[318.900507] Dynamic subtest pipe-A-plane-0: SUCCESS (0.099s)
[318.919253] Starting dynamic subtest: pipe-A-plane-1
[319.000445] Dynamic subtest pipe-A-plane-1: SUCCESS (0.097s)
[319.017459] Starting dynamic subtest: pipe-A-plane-2
[319.100530] Dynamic subtest pipe-A-plane-2: SUCCESS (0.098s)
[319.310574] Starting dynamic subtest: pipe-B-plane-0
[319.384065] Dynamic subtest pipe-B-plane-0: SUCCESS (0.083s)
[319.400551] Starting dynamic subtest: pipe-B-plane-1
[319.475968] Dynamic subtest pipe-B-plane-1: SUCCESS (0.089s)
[319.492599] Starting dynamic subtest: pipe-B-plane-2
[319.575970] Dynamic subtest pipe-B-plane-2: SUCCESS (0.098s)
[319.798609] Starting dynamic subtest: pipe-C-plane-0
[319.881420] Dynamic subtest pipe-C-plane-0: SUCCESS (0.091s)
[319.895455] Starting dynamic subtest: pipe-C-plane-1
[319.981442] Dynamic subtest pipe-C-plane-1: SUCCESS (0.097s)
[319.997364] Starting dynamic subtest: pipe-C-plane-2
[320.073822] Dynamic subtest pipe-C-plane-2: SUCCESS (0.089s)
[320.292375] Starting dynamic subtest: pipe-D-plane-0
[320.374958] Dynamic subtest pipe-D-plane-0: SUCCESS (0.092s)
[320.389659] Starting dynamic subtest: pipe-D-plane-1
[320.474870] Dynamic subtest pipe-D-plane-1: SUCCESS (0.098s)
[320.491519] Starting dynamic subtest: pipe-D-plane-2
[320.575007] Dynamic subtest pipe-D-plane-2: SUCCESS (0.098s)
[320.624266] Subtest plane-lut1d: SUCCESS (1.911s)
[320.748491] [079/156] (700s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[320.852551] Starting subtest: yf-tiled-16bpp-rotate-180
[320.854187] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[320.947003] [080/156] (700s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[321.044182] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[321.045661] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[321.153331] [081/156] (700s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[321.247354] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt
[321.248789] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[321.351589] [082/156] (700s left) gem_exec_reloc (basic-wc-read)
[321.389641] Starting subtest: basic-wc-read
[321.395401] Subtest basic-wc-read: SUCCESS (0.006s)
[321.515138] [083/156] (700s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[321.612484] Starting subtest: short-busy-flip-before-cursor-toggle
[321.613926] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[321.698294] [084/156] (700s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[321.792070] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[321.801611] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.009s)
[321.878830] [085/156] (700s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[321.972097] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[321.973525] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[322.071142] [086/156] (699s left) kms_draw_crc (draw-method-render)
[322.159779] Starting subtest: draw-method-render
[322.160655] Starting dynamic subtest: xrgb8888-untiled
[322.326920] Dynamic subtest xrgb8888-untiled: SUCCESS (0.167s)
[322.347420] Starting dynamic subtest: rgb565-untiled
[322.501836] Dynamic subtest rgb565-untiled: SUCCESS (0.172s)
[322.521439] Starting dynamic subtest: xrgb2101010-untiled
[322.660317] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.156s)
[322.680298] Starting dynamic subtest: xbgr16161616f-untiled
[322.827156] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.164s)
[322.845952] Starting dynamic subtest: xrgb8888-xtiled
[322.918701] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.089s)
[322.935519] Starting dynamic subtest: rgb565-xtiled
[323.010508] Dynamic subtest rgb565-xtiled: SUCCESS (0.089s)
[323.028278] Starting dynamic subtest: xrgb2101010-xtiled
[323.093722] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.081s)
[323.111963] Starting dynamic subtest: xbgr16161616f-xtiled
[323.177274] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.081s)
[323.200615] Starting dynamic subtest: xrgb8888-ytiled
[323.277290] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.096s)
[323.296126] Starting dynamic subtest: rgb565-ytiled
[323.369111] Dynamic subtest rgb565-ytiled: SUCCESS (0.089s)
[323.388405] Starting dynamic subtest: xrgb2101010-ytiled
[323.452182] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.081s)
[323.469560] Starting dynamic subtest: xbgr16161616f-ytiled
[323.535804] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.081s)
[323.538911] Subtest draw-method-render: SUCCESS (1.377s)
[323.670383] [087/156] (698s left) kms_cursor_crc (cursor-sliding-256x85)
[323.768944] Starting subtest: cursor-sliding-256x85
[323.773299] Starting dynamic subtest: pipe-A-HDMI-A-1
[324.982236] Dynamic subtest pipe-A-HDMI-A-1: FAIL (1.024s)
[324.992438] Starting dynamic subtest: pipe-D-HDMI-A-1
[326.741627] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.906s)
[326.742488] Subtest cursor-sliding-256x85: FAIL (2.972s)
[326.898317] [088/156] (695s left) kms_cursor_crc (cursor-onscreen-256x256)
[326.995883] Starting subtest: cursor-onscreen-256x256
[326.999448] Starting dynamic subtest: pipe-A-HDMI-A-1
[328.182404] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.182s)
[328.221525] Starting dynamic subtest: pipe-D-HDMI-A-1
[329.366510] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.155s)
[329.367304] Subtest cursor-onscreen-256x256: SUCCESS (2.371s)
[329.549592] [089/156] (692s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render)
[329.652979] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render
[329.654386] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[329.742606] [090/156] (692s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[329.835868] Starting subtest: fbcpsr-slowdraw
[329.837240] Subtest fbcpsr-slowdraw: SKIP (0.000s)
[329.933149] [091/156] (692s left) kms_lease (cursor-implicit-plane)
[330.021551] Starting subtest: cursor-implicit-plane
[330.023412] Starting dynamic subtest: pipe-A-HDMI-A-1
[330.199503] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.176s)
[330.213839] Starting dynamic subtest: pipe-B-HDMI-A-1
[330.364170] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.162s)
[330.376737] Starting dynamic subtest: pipe-C-HDMI-A-1
[330.536045] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.170s)
[330.547492] Starting dynamic subtest: pipe-D-HDMI-A-1
[330.700304] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.162s)
[330.702748] Subtest cursor-implicit-plane: SUCCESS (0.679s)
[330.829466] [092/156] (691s left) syncobj_wait (invalid-reset-zero-handles)
[330.867973] Starting subtest: invalid-reset-zero-handles
[330.868763] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[330.929360] [093/156] (691s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[331.021389] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[331.022904] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[331.112836] [094/156] (691s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[331.211672] Starting subtest: yf-tiled-64bpp-rotate-90
[331.213112] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[331.292495] [095/156] (691s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc)
[331.387602] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc
[331.389147] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[331.479625] [096/156] (690s left) gem_exec_fence (long-history)
[331.810907] Starting subtest: long-history
[337.520244] Subtest long-history: SUCCESS (5.703s)
[337.989833] [097/156] (684s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[338.089726] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[338.091157] Subtest psr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[338.201820] [098/156] (684s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[338.289558] Starting subtest: bad-rotation-90-yf-tiled-ccs
[338.290317] Starting dynamic subtest: pipe-A-HDMI-A-1
[338.297463] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[338.307280] Starting dynamic subtest: pipe-B-HDMI-A-1
[338.314025] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[338.323915] Starting dynamic subtest: pipe-C-HDMI-A-1
[338.330570] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[338.340085] Starting dynamic subtest: pipe-D-HDMI-A-1
[338.347076] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[338.348488] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.006s)
[338.573603] [099/156] (683s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[338.664570] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[341.064829] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (2.399s)
[341.235511] [100/156] (681s left) kms_chamelium_audio (dp-audio-edid)
[341.383916] Subtest dp-audio-edid: SKIP (0.000s)
[341.498499] [101/156] (681s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[341.591403] Starting subtest: addfb25-yf-tiled-legacy
[341.592135] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[341.711797] [102/156] (680s left) kms_frontbuffer_tracking (hdr-1p-primscrn-indfb-pgflip-blt)
[341.806198] Starting subtest: hdr-1p-primscrn-indfb-pgflip-blt
[341.807614] Subtest hdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[341.886292] [103/156] (680s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[341.979925] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[341.981403] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[342.063014] [104/156] (680s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[342.156689] Starting subtest: fbc-2p-pri-indfb-multidraw
[342.158226] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[342.261166] [105/156] (680s left) kms_sequence (queue-busy)
[342.350565] Starting subtest: queue-busy
[342.351314] Starting dynamic subtest: pipe-A-HDMI-A-1
[343.642314] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.291s)
[343.654512] Starting dynamic subtest: pipe-B-HDMI-A-1
[344.916738] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.271s)
[344.929402] Starting dynamic subtest: pipe-C-HDMI-A-1
[346.192524] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.272s)
[346.203065] Starting dynamic subtest: pipe-D-HDMI-A-1
[347.473570] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.279s)
[347.474356] Subtest queue-busy: SUCCESS (5.121s)
[347.589610] [106/156] (675s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[347.690965] Starting subtest: plane-upscale-20x20-with-rotation
[347.691760] Starting dynamic subtest: pipe-A
[348.816313] Dynamic subtest pipe-A: SKIP (1.123s)
[348.826580] Starting dynamic subtest: pipe-B
[350.035128] Dynamic subtest pipe-B: SKIP (1.218s)
[350.047247] Starting dynamic subtest: pipe-C
[351.262673] Dynamic subtest pipe-C: SKIP (1.224s)
[351.272549] Starting dynamic subtest: pipe-D
[352.408402] Dynamic subtest pipe-D: SKIP (1.146s)
[352.409768] Subtest plane-upscale-20x20-with-rotation: SKIP (4.714s)
[352.595344] [107/156] (670s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-pwrite)
[352.705599] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-pwrite
[352.706989] Subtest psrhdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[352.800959] [108/156] (670s left) gem_exec_reloc (basic-write-wc)
[352.840117] Starting subtest: basic-write-wc
[352.845957] Subtest basic-write-wc: SUCCESS (0.006s)
[352.968977] [109/156] (669s left) syncobj_timeline (reset-signaled)
[353.003935] Starting subtest: reset-signaled
[353.004684] Subtest reset-signaled: SUCCESS (0.000s)
[353.069984] [110/156] (669s left) kms_psr (pr-cursor-plane-move)
[353.159167] Subtest pr-cursor-plane-move: SKIP (0.000s)
[353.207185] [111/156] (669s left) syncobj_wait (invalid-wait-illegal-handle)
[353.242986] Starting subtest: invalid-wait-illegal-handle
[353.243752] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[353.319267] [112/156] (669s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[353.412505] Starting subtest: extended-pageflip-modeset-hang-oldfb
[353.414342] Starting dynamic subtest: pipe-A
[373.412684] Dynamic subtest pipe-A: SUCCESS (19.996s)
[373.425125] Starting dynamic subtest: pipe-D
[393.369537] Dynamic subtest pipe-D: SUCCESS (19.959s)
[393.370346] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (39.961s)
[393.504888] [113/156] (629s left) kms_psr (psr2-primary-blt)
[393.599265] Subtest psr2-primary-blt: SKIP (0.000s)
[393.648349] [114/156] (629s left) gem_softpin (evict-snoop-interruptible)
[393.689589] Starting subtest: evict-snoop-interruptible
[393.691095] Subtest evict-snoop-interruptible: SKIP (0.000s)
[393.768226] [115/156] (629s left) kms_force_connector_basic (force-load-detect)
[393.891605] Starting subtest: force-load-detect
[393.893031] Subtest force-load-detect: SKIP (0.000s)
[394.049938] [116/156] (629s left) kms_chamelium_edid (hdmi-mode-timings)
[394.198955] Subtest hdmi-mode-timings: SKIP (0.000s)
[394.300119] [117/156] (628s left) syncobj_timeline (invalid-signal-zero-handles)
[394.338133] Starting subtest: invalid-signal-zero-handles
[394.339030] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[394.401278] [118/156] (628s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt)
[394.492546] Starting subtest: fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt
[394.493933] Subtest fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[394.584959] [119/156] (628s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[394.677234] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[394.678702] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[394.779954] [120/156] (628s left) gem_mmap_gtt (fault-concurrent-x)
[394.814685] Starting subtest: fault-concurrent-X
[397.543813] Subtest fault-concurrent-X: SUCCESS (2.721s)
[397.645336] [121/156] (625s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[397.685631] Starting subtest: y-tiled-to-vebox-y-tiled
[397.686363] Starting dynamic subtest: smem
[397.783165] Dynamic subtest smem: SUCCESS (0.097s)
[397.783942] Subtest y-tiled-to-vebox-y-tiled: SUCCESS (0.098s)
[397.972296] [122/156] (625s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-plflip-blt)
[398.067030] Starting subtest: psrhdr-2p-scndscrn-shrfb-plflip-blt
[398.068434] Subtest psrhdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[398.180409] [123/156] (625s left) vgem_basic (debugfs)
[398.222710] Starting subtest: debugfs
[398.223428] Subtest debugfs: SUCCESS (0.000s)
[398.277541] [124/156] (625s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[398.364354] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[398.366120] Starting dynamic subtest: pipe-A-valid-mode
[399.653063] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.287s)
[399.653784] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (1.288s)
[399.779048] [125/156] (623s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[399.888638] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[399.890072] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[399.981324] [126/156] (623s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[400.074176] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[400.075648] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[400.182799] [127/156] (623s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[400.275591] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[400.277049] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[400.391715] [128/156] (623s left) kms_vblank (wait-forked-hang)
[400.481499] Starting subtest: wait-forked-hang
[400.483342] Starting dynamic subtest: pipe-A-HDMI-A-1
[414.377538] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (13.894s)
[414.391524] Starting dynamic subtest: pipe-D-HDMI-A-1
[428.700379] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (14.315s)
[428.701201] Subtest wait-forked-hang: SUCCESS (28.216s)
[428.879399] [129/156] (594s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[428.979880] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[428.982119] Starting dynamic subtest: pipe-A-valid-mode
[430.836998] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.854s)
[430.837804] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SUCCESS (1.856s)
[431.009286] [130/156] (592s left) gem_ctx_exec (basic-invalid-context)
[431.056263] Starting subtest: basic-invalid-context
[431.058625] Subtest basic-invalid-context: SUCCESS (0.003s)
[431.167303] [131/156] (592s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-msflip-blt)
[431.262646] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-msflip-blt
[431.264119] Subtest fbcpsrhdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[431.367629] [132/156] (592s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[431.457312] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (0.000s)
[431.504844] [133/156] (592s left) gem_ppgtt (blt-vs-render-ctxn)
[431.543090] Starting subtest: blt-vs-render-ctxN
[464.229971] Subtest blt-vs-render-ctxN: SUCCESS (32.668s)
[464.348834] [134/156] (559s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[464.446639] Starting subtest: basic-gtt-cpu-noreloc
[464.450765] Subtest basic-gtt-cpu-noreloc: SUCCESS (0.004s)
[464.578397] [135/156] (559s left) gem_softpin (invalid)
[464.615842] Starting subtest: invalid
[464.619963] Subtest invalid: SUCCESS (0.004s)
[464.742536] [136/156] (559s left) gem_exec_capture (capture)
[464.782310] Starting subtest: capture
[464.783016] Starting dynamic subtest: rcs0-smem
[466.058624] Dynamic subtest rcs0-smem: SUCCESS (1.269s)
[466.068233] Starting dynamic subtest: bcs0-smem
[467.330434] Dynamic subtest bcs0-smem: SUCCESS (1.269s)
[467.340239] Starting dynamic subtest: vcs0-smem
[468.602354] Dynamic subtest vcs0-smem: SUCCESS (1.270s)
[468.612211] Starting dynamic subtest: vcs1-smem
[469.874580] Dynamic subtest vcs1-smem: SUCCESS (1.274s)
[469.884592] Starting dynamic subtest: vecs0-smem
[471.146521] Dynamic subtest vecs0-smem: SUCCESS (1.267s)
[471.147209] Subtest capture: SUCCESS (6.355s)
[471.254998] [137/156] (552s left) gem_tiled_blits (basic)
[471.342764] Starting subtest: basic
[471.358153] Subtest basic: SUCCESS (0.016s)
[471.485581] [138/156] (552s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[471.654013] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[471.655545] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[471.762688] [139/156] (552s left) gem_mmap_offset (partial-remap)
[471.798181] Starting subtest: partial-remap
[471.798920] Starting dynamic subtest: smem0
[471.803607] Dynamic subtest smem0: SUCCESS (0.003s)
[471.804305] Subtest partial-remap: SUCCESS (0.004s)
[471.910356] [140/156] (552s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-blt)
[472.001935] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-blt
[472.003373] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[472.102763] [141/156] (552s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-blt)
[472.196907] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-blt
[472.198451] Subtest hdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[472.294453] [142/156] (552s left) i915_power (sanity)
[472.329675] Starting subtest: sanity
[476.350049] Subtest sanity: SUCCESS (4.010s)
[476.463984] [143/156] (547s left) gem_exec_schedule (preempt-queue)
[476.519188] Starting subtest: preempt-queue
[476.520106] Starting dynamic subtest: rcs0
[476.629432] Dynamic subtest rcs0: SUCCESS (0.108s)
[476.641065] Starting dynamic subtest: bcs0
[476.735626] Dynamic subtest bcs0: SUCCESS (0.106s)
[476.746971] Starting dynamic subtest: vcs0
[476.842053] Dynamic subtest vcs0: SUCCESS (0.105s)
[476.854556] Starting dynamic subtest: vcs1
[476.949383] Dynamic subtest vcs1: SUCCESS (0.106s)
[476.960419] Starting dynamic subtest: vecs0
[477.054362] Dynamic subtest vecs0: SUCCESS (0.104s)
[477.055186] Subtest preempt-queue: SUCCESS (0.535s)
[477.373351] [144/156] (547s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[477.464694] Starting subtest: cursorB-vs-flipA-legacy
[477.467148] Subtest cursorB-vs-flipA-legacy: SKIP (0.002s)
[477.525369] [145/156] (546s left) i915_pm_rps (reset)
[477.564171] Starting subtest: reset
[482.127179] Subtest reset: SUCCESS (4.530s)
[482.217431] [146/156] (542s left) kms_psr (fbc-psr-cursor-plane-onoff)
[482.313026] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s)
[482.357425] [147/156] (542s left) kms_setmode (clone-exclusive-crtc)
[482.392562] Starting subtest: clone-exclusive-crtc
[482.394779] Subtest clone-exclusive-crtc: SKIP (0.000s)
[482.470276] [148/156] (542s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[482.564266] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[482.565682] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[482.654158] [149/156] (542s left) kms_flip (flip-vs-rmfb)
[482.748239] Starting subtest: flip-vs-rmfb
[482.751191] Starting dynamic subtest: A-HDMI-A1
[490.441641] Dynamic subtest A-HDMI-A1: SUCCESS (7.687s)
[490.459344] Starting dynamic subtest: B-HDMI-A1
[498.118822] Dynamic subtest B-HDMI-A1: SUCCESS (7.674s)
[498.138507] Starting dynamic subtest: C-HDMI-A1
[505.800930] Dynamic subtest C-HDMI-A1: SUCCESS (7.679s)
[505.818666] Starting dynamic subtest: D-HDMI-A1
[513.491366] Dynamic subtest D-HDMI-A1: SUCCESS (7.690s)
[513.494705] Subtest flip-vs-rmfb: SUCCESS (30.748s)
[513.663067] [150/156] (511s left) gem_exec_whisper (basic-contexts-all)
[513.707498] Starting subtest: basic-contexts-all
[515.457610] Subtest basic-contexts-all: SUCCESS (1.750s)
[515.658688] [151/156] (509s left) dmabuf_sync_file (export-basic)
[515.698991] Starting subtest: export-basic
[515.699774] Subtest export-basic: SUCCESS (0.001s)
[515.752754] [152/156] (509s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[515.848179] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[515.849622] Subtest hdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[515.947331] [153/156] (508s left) gem_sync (basic-each)
[515.991576] Starting subtest: basic-each
[518.081458] Subtest basic-each: SUCCESS (2.090s)
[518.281832] [154/156] (506s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[518.374561] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[518.375328] Starting dynamic subtest: pipe-A-HDMI-A-1
[518.383153] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[518.393542] Starting dynamic subtest: pipe-B-HDMI-A-1
[518.401212] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[518.411265] Starting dynamic subtest: pipe-C-HDMI-A-1
[518.418834] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[518.429611] Starting dynamic subtest: pipe-D-HDMI-A-1
[518.438188] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[518.440529] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.007s)
[518.630714] [155/156] (506s left) syncobj_wait (multi-wait-for-submit-submitted)
[518.673854] Starting subtest: multi-wait-for-submit-submitted
[518.776167] Subtest multi-wait-for-submit-submitted: SUCCESS (0.102s)
[518.862555] [156/156] (506s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[518.957568] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt
[518.959044] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[519.056420] 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.