[56.632590] Initializing watchdogs
[56.632650]   /dev/watchdog0
[56.648583] [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]
[56.654501] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.657023] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.659099] [001/154] (960s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[56.758310] Starting subtest: fbc-tiling-linear
[59.021122] Subtest fbc-tiling-linear: SUCCESS (2.259s)
[59.198675] [002/154] (958s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[59.232806] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[59.276543] [003/154] (957s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[59.370222] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[59.371656] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[59.497530] [004/154] (957s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[59.590149] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[59.591533] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[59.731208] [005/154] (957s left) kms_force_connector_basic (prune-stale-modes)
[59.852577] Starting subtest: prune-stale-modes
[59.998427] Subtest prune-stale-modes: SUCCESS (0.146s)
[60.192953] [006/154] (957s left) perf_pmu (most-busy-check-all)
[60.234217] Starting subtest: most-busy-check-all
[60.234982] Starting dynamic subtest: rcs0
[60.755193] Dynamic subtest rcs0: SUCCESS (0.520s)
[60.764910] Starting dynamic subtest: bcs0
[61.274131] Dynamic subtest bcs0: SUCCESS (0.518s)
[61.282929] Starting dynamic subtest: vcs0
[61.791109] Dynamic subtest vcs0: SUCCESS (0.516s)
[61.800879] Starting dynamic subtest: vcs1
[62.312150] Dynamic subtest vcs1: SUCCESS (0.520s)
[62.321113] Starting dynamic subtest: vecs0
[62.835118] Dynamic subtest vecs0: SUCCESS (0.521s)
[62.836220] Subtest most-busy-check-all: SUCCESS (2.598s)
[62.936198] [007/154] (954s left) gem_ccs (large-ctrl-surf-copy)
[62.975399] Starting subtest: large-ctrl-surf-copy
[62.976820] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[63.072854] [008/154] (954s left) kms_plane_alpha_blend (coverage-7efc)
[63.162534] Starting subtest: coverage-7efc
[63.232798] Starting dynamic subtest: pipe-A-HDMI-A-1
[63.735683] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.502s)
[63.762901] Starting dynamic subtest: pipe-D-HDMI-A-1
[64.422104] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.665s)
[64.422880] Subtest coverage-7efc: SUCCESS (1.259s)
[64.591577] [009/154] (952s left) gem_mmap_gtt (fault-concurrent)
[64.626615] Starting subtest: fault-concurrent
[67.209731] Subtest fault-concurrent: SUCCESS (2.547s)
[67.534821] [010/154] (949s left) api_intel_allocator (gem-pool)
[67.584195] Starting subtest: gem-pool
[67.591874] Subtest gem-pool: SUCCESS (0.008s)
[67.912227] [011/154] (949s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-fullscreen)
[68.033693] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-fullscreen
[68.035346] Subtest fbchdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[68.207684] [012/154] (949s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[68.302459] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[68.303858] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[68.407589] [013/154] (949s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[68.494473] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[68.495213] Starting dynamic subtest: pipe-A-HDMI-A-1
[68.502051] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[68.508688] Starting dynamic subtest: pipe-B-HDMI-A-1
[68.515157] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[68.521719] Starting dynamic subtest: pipe-C-HDMI-A-1
[68.528251] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[68.535092] Starting dynamic subtest: pipe-D-HDMI-A-1
[68.541705] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[68.543012] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.006s)
[68.782675] [014/154] (948s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[68.870488] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[68.871228] Starting dynamic subtest: pipe-A-HDMI-A-1
[68.878059] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[68.884814] Starting dynamic subtest: pipe-B-HDMI-A-1
[68.891467] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[68.898147] Starting dynamic subtest: pipe-C-HDMI-A-1
[68.904737] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[68.911215] Starting dynamic subtest: pipe-D-HDMI-A-1
[68.917973] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[68.919354] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[69.156855] [015/154] (948s left) kms_frontbuffer_tracking (hdr-rgb565-draw-blt)
[69.250402] Starting subtest: hdr-rgb565-draw-blt
[69.251782] Subtest hdr-rgb565-draw-blt: SKIP (0.000s)
[69.385693] [016/154] (948s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[69.425443] Starting subtest: x-tiled-to-vebox-y-tiled
[69.426234] Starting dynamic subtest: smem
[69.523348] Dynamic subtest smem: SUCCESS (0.098s)
[69.524096] Subtest x-tiled-to-vebox-y-tiled: SUCCESS (0.098s)
[69.745016] [017/154] (948s left) sysfs_heartbeat_interval (invalid)
[69.782063] Starting subtest: invalid
[69.782826] Starting dynamic subtest: vecs0
[69.783525] Dynamic subtest vecs0: SUCCESS (0.000s)
[69.790589] Starting dynamic subtest: vcs0
[69.791304] Dynamic subtest vcs0: SUCCESS (0.000s)
[69.798268] Starting dynamic subtest: bcs0
[69.798975] Dynamic subtest bcs0: SUCCESS (0.000s)
[69.805361] Starting dynamic subtest: rcs0
[69.806049] Dynamic subtest rcs0: SUCCESS (0.000s)
[69.812534] Starting dynamic subtest: vcs1
[69.813227] Dynamic subtest vcs1: SUCCESS (0.000s)
[69.813946] Subtest invalid: SUCCESS (0.003s)
[69.895234] [018/154] (947s left) kms_frontbuffer_tracking (fbc-stridechange)
[69.987459] Starting subtest: fbc-stridechange
[71.977678] Subtest fbc-stridechange: SUCCESS (1.989s)
[72.137588] [019/154] (945s left) gem_ctx_param (basic-default)
[72.171599] Starting subtest: basic-default
[72.172389] Subtest basic-default: SUCCESS (0.000s)
[72.269646] [020/154] (945s left) kms_psr (fbc-pr-primary-mmap-gtt)
[72.362422] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[72.404699] [021/154] (945s left) i915_pm_freq_mult (media-freq)
[72.438174] Starting subtest: media-freq
[72.438942] Starting dynamic subtest: gt0
[72.440353] Dynamic subtest gt0: SKIP (0.000s)
[72.441786] Subtest media-freq: SKIP (0.000s)
[72.535344] [022/154] (945s left) prime_busy (before-wait)
[72.573217] Starting subtest: before-wait
[72.578225] Starting dynamic subtest: rcs0
[72.600558] Dynamic subtest rcs0: SUCCESS (0.022s)
[72.607313] Starting dynamic subtest: bcs0
[72.617020] Dynamic subtest bcs0: SUCCESS (0.016s)
[72.627344] Starting dynamic subtest: vcs0
[72.640082] Dynamic subtest vcs0: SUCCESS (0.023s)
[72.652052] Starting dynamic subtest: vcs1
[72.655163] Dynamic subtest vcs1: SUCCESS (0.015s)
[72.663301] Starting dynamic subtest: vecs0
[72.666938] Dynamic subtest vecs0: SUCCESS (0.011s)
[72.779992] Subtest before-wait: SUCCESS (0.200s)
[72.876815] [023/154] (945s left) gem_exec_gttfill (engines)
[72.921513] Starting subtest: engines
[72.922315] Starting dynamic subtest: rcs0
[96.408967] Dynamic subtest rcs0: SUCCESS (23.486s)
[96.422390] Starting dynamic subtest: bcs0
[119.450470] Dynamic subtest bcs0: SUCCESS (23.041s)
[119.459146] Starting dynamic subtest: vcs0
[142.451382] Dynamic subtest vcs0: SUCCESS (23.000s)
[142.459818] Starting dynamic subtest: vcs1
[165.589619] Dynamic subtest vcs1: SUCCESS (23.139s)
[165.598215] Starting dynamic subtest: vecs0
[188.897772] Dynamic subtest vecs0: SUCCESS (23.308s)
[188.898564] Subtest engines: SUCCESS (115.976s)
[189.118033] [024/154] (828s left) syncobj_timeline (etime-multi-wait-all-submitted)
[189.211076] Starting subtest: etime-multi-wait-all-submitted
[189.318088] Subtest etime-multi-wait-all-submitted: SUCCESS (0.106s)
[189.416591] [025/154] (828s left) gem_ctx_param (get-priority-new-ctx)
[189.449954] Starting subtest: get-priority-new-ctx
[189.450767] Subtest get-priority-new-ctx: SUCCESS (0.000s)
[189.547760] [026/154] (828s left) kms_big_fb (linear-32bpp-rotate-90)
[189.652120] Starting subtest: linear-32bpp-rotate-90
[189.750783] Subtest linear-32bpp-rotate-90: SKIP (0.098s)
[189.908720] [027/154] (828s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[189.948252] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[189.986149] [028/154] (828s left) gem_ctx_shared (disjoint-timelines)
[190.027645] Starting subtest: disjoint-timelines
[190.055868] Subtest disjoint-timelines: SUCCESS (0.028s)
[190.309361] [FACT gem_ctx_shared (disjoint-timelines)] new: kernel.kmod_is_loaded.vgem: true
[190.310942] [029/154] (827s left) kms_psr (fbc-psr2-cursor-plane-move)
[190.398136] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s)
[190.442892] [030/154] (827s left) gem_bad_reloc (negative-reloc-bltcopy)
[190.481478] Starting subtest: negative-reloc-bltcopy
[191.596038] Subtest negative-reloc-bltcopy: SUCCESS (1.106s)
[191.753448] [031/154] (826s left) kms_chamelium_hpd (hdmi-hpd)
[191.900414] Subtest hdmi-hpd: SKIP (0.000s)
[192.011094] [032/154] (826s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[192.102104] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[192.155565] [033/154] (826s left) gem_eio (wait-10ms)
[192.199591] Starting subtest: wait-10ms
[192.361937] Subtest wait-10ms: SUCCESS (0.163s)
[192.527307] [034/154] (825s left) kms_content_protection (legacy-hdcp14)
[192.623993] Starting subtest: legacy-hdcp14
[192.629426] Subtest legacy-hdcp14: SKIP (0.004s)
[192.757623] [035/154] (825s left) syncobj_wait (reset-signaled)
[192.792435] Starting subtest: reset-signaled
[192.793205] Subtest reset-signaled: SUCCESS (0.000s)
[192.924408] [036/154] (825s left) gem_ctx_isolation (dirty-switch)
[192.966446] Starting subtest: dirty-switch
[192.967220] Starting dynamic subtest: rcs0
[193.152782] Dynamic subtest rcs0: SUCCESS (0.177s)
[193.160311] Starting dynamic subtest: bcs0
[193.364272] Dynamic subtest bcs0: SUCCESS (0.211s)
[193.371732] Starting dynamic subtest: vcs0
[193.585654] Dynamic subtest vcs0: SUCCESS (0.221s)
[193.593460] Starting dynamic subtest: vcs1
[193.804590] Dynamic subtest vcs1: SUCCESS (0.218s)
[193.811961] Starting dynamic subtest: vecs0
[194.028888] Dynamic subtest vecs0: SUCCESS (0.224s)
[194.029644] Subtest dirty-switch: SUCCESS (1.054s)
[194.239894] [037/154] (824s left) gem_flink_basic (bad-open)
[194.274089] Starting subtest: bad-open
[194.274803] Subtest bad-open: SUCCESS (0.000s)
[194.364943] [038/154] (824s left) gem_caching (writes)
[194.402607] Starting subtest: writes
[203.687358] Subtest writes: SUCCESS (9.285s)
[203.833285] [039/154] (814s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[203.922568] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[203.923361] Starting dynamic subtest: pipe-A
[204.776210] Dynamic subtest pipe-A: SUCCESS (0.853s)
[204.791272] Starting dynamic subtest: pipe-B
[205.655783] Dynamic subtest pipe-B: SUCCESS (0.879s)
[205.669211] Starting dynamic subtest: pipe-C
[206.535819] Dynamic subtest pipe-C: SUCCESS (0.879s)
[206.556932] Starting dynamic subtest: pipe-D
[207.416414] Dynamic subtest pipe-D: SUCCESS (0.878s)
[207.417920] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (3.493s)
[207.659839] [040/154] (811s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[207.697468] Starting subtest: single-wait-all-for-submit-available-submitted
[207.698195] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[207.786990] [041/154] (810s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-render)
[207.882488] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-render
[207.883885] Subtest fbchdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[207.999675] [042/154] (810s left) kms_pm_rpm (system-suspend-idle)
[209.419067] Starting subtest: system-suspend-idle
[228.696038] Subtest system-suspend-idle: SUCCESS (4.841s)
[234.996369] [043/154] (789s left) kms_atomic_transition (modeset-transition)
[235.093354] Starting subtest: modeset-transition
[235.094146] Starting dynamic subtest: 1x-outputs
[237.351738] Dynamic subtest 1x-outputs: SUCCESS (2.209s)
[237.352904] Subtest modeset-transition: SUCCESS (2.209s)
[237.512198] [044/154] (787s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[237.612334] Starting subtest: pipe-fbc-rte
[237.616551] Subtest pipe-fbc-rte: SKIP (0.000s)
[237.758314] [045/154] (787s left) gem_spin_batch (resubmit-all)
[237.801310] Starting subtest: resubmit-all
[237.802036] Starting dynamic subtest: rcs0
[237.805344] Dynamic subtest rcs0: SUCCESS (0.004s)
[237.816211] Starting dynamic subtest: bcs0
[237.816919] Dynamic subtest bcs0: SUCCESS (0.002s)
[237.825671] Starting dynamic subtest: vcs0
[237.826401] Dynamic subtest vcs0: SUCCESS (0.002s)
[237.835359] Starting dynamic subtest: vcs1
[237.836072] Dynamic subtest vcs1: SUCCESS (0.002s)
[237.844226] Starting dynamic subtest: vecs0
[237.844926] Dynamic subtest vecs0: SUCCESS (0.002s)
[237.845612] Subtest resubmit-all: SUCCESS (0.013s)
[238.020841] [046/154] (786s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[238.113338] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[238.114751] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[238.226773] [047/154] (786s left) syncobj_basic (illegal-fd-to-handle)
[238.260195] Starting subtest: illegal-fd-to-handle
[238.260927] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[238.366250] [048/154] (786s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[238.458028] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[238.459461] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[238.590309] [049/154] (786s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[238.689640] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[240.049969] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.354s)
[240.232956] [050/154] (784s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[240.266681] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[240.369315] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.102s)
[240.480816] [051/154] (784s left) api_intel_bb (misplaced-blitter)
[240.514467] Starting subtest: misplaced-blitter
[240.518893] Subtest misplaced-blitter: SUCCESS (0.005s)
[240.652151] [052/154] (784s left) kms_atomic_interruptible (universal-setplane-cursor)
[240.746562] Starting subtest: universal-setplane-cursor
[240.747335] Starting dynamic subtest: pipe-A-HDMI-A-1
[246.993420] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.229s)
[246.994277] Subtest universal-setplane-cursor: SUCCESS (6.230s)
[247.158283] [053/154] (778s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[247.258587] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[247.259941] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[247.392827] [054/154] (777s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[247.486053] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[247.487493] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[247.603031] [055/154] (777s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[247.692529] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[247.693233] Starting dynamic subtest: pipe-A-valid-mode
[248.647042] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.953s)
[248.647831] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SUCCESS (0.954s)
[248.845789] [056/154] (776s left) gem_pxp (create-protected-buffer)
[248.949589] Starting subtest: create-protected-buffer
[248.950699] Subtest create-protected-buffer: SUCCESS (0.000s)
[249.074564] [057/154] (776s left) gen9_exec_parse (allowed-single)
[249.112390] Subtest allowed-single: SKIP (0.000s)
[249.179287] [058/154] (776s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[249.273166] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[249.274569] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[249.397871] [059/154] (776s left) gem_exec_balancer (bonded-semaphore)
[249.440346] Starting subtest: bonded-semaphore
[253.781876] Subtest bonded-semaphore: SUCCESS (4.301s)
[254.001528] [060/154] (771s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[254.092506] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[254.136103] Starting dynamic subtest: pipe-A-plane-0
[254.553581] Dynamic subtest pipe-A-plane-0: SUCCESS (0.417s)
[254.571049] Starting dynamic subtest: pipe-A-plane-3
[254.876259] Dynamic subtest pipe-A-plane-3: SUCCESS (0.321s)
[254.892429] Starting dynamic subtest: pipe-A-plane-5
[255.199287] Dynamic subtest pipe-A-plane-5: SUCCESS (0.321s)
[255.383539] Starting dynamic subtest: pipe-B-plane-0
[255.727736] Dynamic subtest pipe-B-plane-0: SUCCESS (0.360s)
[255.744855] Starting dynamic subtest: pipe-B-plane-3
[256.069406] Dynamic subtest pipe-B-plane-3: SUCCESS (0.340s)
[256.085754] Starting dynamic subtest: pipe-B-plane-5
[256.392473] Dynamic subtest pipe-B-plane-5: SUCCESS (0.321s)
[256.474837] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SUCCESS (2.380s)
[256.682774] [061/154] (769s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[256.779313] Starting subtest: fbc-rgb565-draw-mmap-wc
[259.139947] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (2.359s)
[259.322750] [062/154] (766s left) kms_pwrite_crc (basic)
[259.415212] Starting subtest: basic
[259.938122] Subtest basic: SUCCESS (0.513s)
[260.104904] [063/154] (765s left) gem_flink_basic (bad-flink)
[260.137642] Starting subtest: bad-flink
[260.138697] Subtest bad-flink: SUCCESS (0.000s)
[260.237867] [064/154] (765s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-move)
[260.330284] Starting subtest: hdr-2p-primscrn-spr-indfb-move
[260.331767] Subtest hdr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[260.464908] [065/154] (765s left) gem_ctx_persistence (legacy-engines-persistence)
[260.503235] Starting subtest: legacy-engines-persistence
[260.504012] Starting dynamic subtest: render
[261.269328] Dynamic subtest render: SUCCESS (0.765s)
[261.282032] Starting dynamic subtest: bsd1
[262.053461] Dynamic subtest bsd1: SUCCESS (0.782s)
[262.066834] Starting dynamic subtest: bsd2
[262.816386] Dynamic subtest bsd2: SUCCESS (0.760s)
[262.831389] Starting dynamic subtest: blt
[263.574125] Dynamic subtest blt: SUCCESS (0.756s)
[263.586596] Starting dynamic subtest: vebox
[264.348398] Dynamic subtest vebox: SUCCESS (0.772s)
[264.349486] Subtest legacy-engines-persistence: SUCCESS (3.843s)
[264.445945] [066/154] (761s left) gen7_exec_parse (basic-allowed)
[264.483260] Subtest basic-allowed: SKIP (0.000s)
[264.528950] [067/154] (761s left) gem_exec_schedule (reorder-wide)
[264.693255] Starting subtest: reorder-wide
[264.694179] Starting dynamic subtest: rcs0
[264.768752] Dynamic subtest rcs0: SUCCESS (0.076s)
[264.784077] Starting dynamic subtest: bcs0
[264.850846] Dynamic subtest bcs0: SUCCESS (0.081s)
[264.863904] Starting dynamic subtest: vcs0
[264.929268] Dynamic subtest vcs0: SUCCESS (0.077s)
[264.941324] Starting dynamic subtest: vcs1
[265.003681] Dynamic subtest vcs1: SUCCESS (0.073s)
[265.017281] Starting dynamic subtest: vecs0
[265.081979] Dynamic subtest vecs0: SUCCESS (0.077s)
[265.083058] Subtest reorder-wide: SUCCESS (0.390s)
[265.282278] [068/154] (760s left) kms_frontbuffer_tracking (psrhdr-slowdraw)
[265.378151] Starting subtest: psrhdr-slowdraw
[265.379626] Subtest psrhdr-slowdraw: SKIP (0.000s)
[265.496326] [069/154] (760s left) perf (non-zero-reason)
[265.634158] Starting subtest: non-zero-reason
[265.634947] Starting dynamic subtest: 0-rcs0
[273.472305] Dynamic subtest 0-rcs0: SUCCESS (7.805s)
[273.473123] Subtest non-zero-reason: SUCCESS (7.805s)
[273.509052] [070/154] (752s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-pwrite)
[273.604303] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-pwrite
[273.605789] Subtest fbchdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[273.729663] [071/154] (752s left) i915_drm_fdinfo (all-busy-check-all)
[273.768489] Starting subtest: all-busy-check-all
[274.283847] Subtest all-busy-check-all: SUCCESS (0.516s)
[274.389182] [072/154] (751s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[274.481604] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt
[274.483067] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[274.595754] [073/154] (751s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[274.684612] Starting subtest: compare-crc-sanitycheck-nv12
[274.685354] Starting dynamic subtest: pipe-A-HDMI-A-1
[275.240863] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.556s)
[275.250958] Starting dynamic subtest: pipe-B-HDMI-A-1
[275.716456] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.473s)
[275.726629] Starting dynamic subtest: pipe-C-HDMI-A-1
[276.185245] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.467s)
[276.195546] Starting dynamic subtest: pipe-D-HDMI-A-1
[276.646729] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.460s)
[276.647462] Subtest compare-crc-sanitycheck-nv12: SUCCESS (1.963s)
[276.834415] [074/154] (749s left) gem_exec_reloc (basic-write-gtt)
[276.874076] Starting subtest: basic-write-gtt
[276.880554] Subtest basic-write-gtt: SUCCESS (0.006s)
[277.058713] [075/154] (749s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[277.152105] Starting subtest: cursor-rapid-movement-max-size
[277.154117] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[277.267578] [076/154] (749s left) kms_color_pipeline (plane-lut1d)
[277.356159] Starting subtest: plane-lut1d
[277.541431] Starting dynamic subtest: pipe-A-plane-0
[277.730722] Dynamic subtest pipe-A-plane-0: SUCCESS (0.189s)
[277.751707] Starting dynamic subtest: pipe-A-plane-1
[277.901211] Dynamic subtest pipe-A-plane-1: SUCCESS (0.169s)
[277.919578] Starting dynamic subtest: pipe-A-plane-2
[278.072111] Dynamic subtest pipe-A-plane-2: SUCCESS (0.169s)
[278.366401] Starting dynamic subtest: pipe-B-plane-0
[278.525728] Dynamic subtest pipe-B-plane-0: SUCCESS (0.170s)
[278.543135] Starting dynamic subtest: pipe-B-plane-1
[278.696514] Dynamic subtest pipe-B-plane-1: SUCCESS (0.169s)
[278.714083] Starting dynamic subtest: pipe-B-plane-2
[278.866950] Dynamic subtest pipe-B-plane-2: SUCCESS (0.169s)
[279.150187] Starting dynamic subtest: pipe-C-plane-0
[279.304593] Dynamic subtest pipe-C-plane-0: SUCCESS (0.170s)
[279.322033] Starting dynamic subtest: pipe-C-plane-1
[279.475198] Dynamic subtest pipe-C-plane-1: SUCCESS (0.169s)
[279.489916] Starting dynamic subtest: pipe-C-plane-2
[279.646045] Dynamic subtest pipe-C-plane-2: SUCCESS (0.169s)
[279.931647] Starting dynamic subtest: pipe-D-plane-0
[280.090266] Dynamic subtest pipe-D-plane-0: SUCCESS (0.170s)
[280.104662] Starting dynamic subtest: pipe-D-plane-1
[280.261188] Dynamic subtest pipe-D-plane-1: SUCCESS (0.169s)
[280.277922] Starting dynamic subtest: pipe-D-plane-2
[280.431993] Dynamic subtest pipe-D-plane-2: SUCCESS (0.169s)
[280.476926] Subtest plane-lut1d: SUCCESS (3.120s)
[280.651563] [077/154] (745s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[280.751057] Starting subtest: yf-tiled-16bpp-rotate-180
[280.752542] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[280.895560] [078/154] (745s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[280.993222] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[280.994630] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[281.123947] [079/154] (745s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[281.213923] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt
[281.215327] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[281.351230] [080/154] (745s left) gem_exec_reloc (basic-wc-read)
[281.390914] Starting subtest: basic-wc-read
[281.396510] Subtest basic-wc-read: SUCCESS (0.006s)
[281.578577] [081/154] (744s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[281.668691] Starting subtest: short-busy-flip-before-cursor-toggle
[281.670092] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[281.787021] [082/154] (744s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[281.879846] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[281.889633] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.009s)
[281.994626] [083/154] (744s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[282.088117] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[282.089505] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[282.257850] [084/154] (744s left) kms_draw_crc (draw-method-render)
[282.350544] Starting subtest: draw-method-render
[282.357972] Starting dynamic subtest: xrgb8888-untiled
[282.686239] Dynamic subtest xrgb8888-untiled: SUCCESS (0.336s)
[282.705146] Starting dynamic subtest: rgb565-untiled
[283.027701] Dynamic subtest rgb565-untiled: SUCCESS (0.340s)
[283.046424] Starting dynamic subtest: xrgb2101010-untiled
[283.312065] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.283s)
[283.329539] Starting dynamic subtest: xbgr16161616f-untiled
[283.615769] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.302s)
[283.635713] Starting dynamic subtest: xrgb8888-xtiled
[283.786929] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.169s)
[283.806593] Starting dynamic subtest: rgb565-xtiled
[283.957691] Dynamic subtest rgb565-xtiled: SUCCESS (0.169s)
[283.978264] Starting dynamic subtest: xrgb2101010-xtiled
[284.109447] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.150s)
[284.128935] Starting dynamic subtest: xbgr16161616f-xtiled
[284.261187] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.150s)
[284.281840] Starting dynamic subtest: xrgb8888-ytiled
[284.432130] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.169s)
[284.451843] Starting dynamic subtest: rgb565-ytiled
[284.603344] Dynamic subtest rgb565-ytiled: SUCCESS (0.169s)
[284.614480] Starting dynamic subtest: xrgb2101010-ytiled
[284.754784] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.150s)
[284.774597] Starting dynamic subtest: xbgr16161616f-ytiled
[284.906501] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.150s)
[284.907601] Subtest draw-method-render: SUCCESS (2.557s)
[285.070368] [085/154] (741s left) kms_cursor_crc (cursor-sliding-256x85)
[285.164417] Starting subtest: cursor-sliding-256x85
[285.168616] Starting dynamic subtest: pipe-A-HDMI-A-1
[289.227647] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.057s)
[289.262850] Starting dynamic subtest: pipe-D-HDMI-A-1
[293.234302] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (3.981s)
[293.235076] Subtest cursor-sliding-256x85: SUCCESS (8.068s)
[293.424462] [086/154] (733s left) kms_cursor_crc (cursor-onscreen-256x256)
[293.519671] Starting subtest: cursor-onscreen-256x256
[293.523931] Starting dynamic subtest: pipe-A-HDMI-A-1
[296.068459] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.543s)
[296.101749] Starting dynamic subtest: pipe-D-HDMI-A-1
[298.529838] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.436s)
[298.530620] Subtest cursor-onscreen-256x256: SUCCESS (5.009s)
[298.739187] [087/154] (728s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render)
[298.833228] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render
[298.834638] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[298.964203] [088/154] (727s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[299.055176] Starting subtest: fbcpsr-slowdraw
[299.056586] Subtest fbcpsr-slowdraw: SKIP (0.000s)
[299.172903] [089/154] (727s left) kms_lease (cursor-implicit-plane)
[299.261982] Starting subtest: cursor-implicit-plane
[299.262717] Starting dynamic subtest: pipe-A-HDMI-A-1
[299.568071] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.305s)
[299.579514] Starting dynamic subtest: pipe-B-HDMI-A-1
[299.800877] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.231s)
[299.811670] Starting dynamic subtest: pipe-C-HDMI-A-1
[300.023396] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.220s)
[300.034038] Starting dynamic subtest: pipe-D-HDMI-A-1
[300.250078] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.226s)
[300.250891] Subtest cursor-implicit-plane: SUCCESS (0.989s)
[300.424910] [090/154] (726s left) syncobj_wait (invalid-reset-zero-handles)
[300.460901] Starting subtest: invalid-reset-zero-handles
[300.461647] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[300.595333] [091/154] (726s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[300.691725] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[300.693163] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[300.822720] [092/154] (726s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[300.921858] Starting subtest: yf-tiled-64bpp-rotate-90
[300.923333] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[301.030680] [093/154] (726s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc)
[301.127157] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc
[301.128554] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[301.258675] [094/154] (725s left) gem_exec_fence (long-history)
[301.568996] Starting subtest: long-history
[307.296589] Subtest long-history: SUCCESS (5.718s)
[307.791190] [095/154] (719s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[307.886515] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[307.887930] Subtest psr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[308.035871] [096/154] (719s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[308.127168] Starting subtest: bad-rotation-90-yf-tiled-ccs
[308.127937] Starting dynamic subtest: pipe-A-HDMI-A-1
[308.135014] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[308.144594] Starting dynamic subtest: pipe-B-HDMI-A-1
[308.151570] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[308.160921] Starting dynamic subtest: pipe-C-HDMI-A-1
[308.167571] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[308.176730] Starting dynamic subtest: pipe-D-HDMI-A-1
[308.183468] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[308.184797] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.007s)
[308.448087] [097/154] (718s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[308.536631] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[310.721478] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (2.183s)
[310.926237] [098/154] (716s left) kms_chamelium_audio (dp-audio-edid)
[311.077925] Subtest dp-audio-edid: SKIP (0.000s)
[311.190675] [099/154] (716s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[311.280193] Starting subtest: addfb25-yf-tiled-legacy
[311.280968] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[311.443599] [100/154] (716s left) kms_frontbuffer_tracking (hdr-1p-primscrn-indfb-pgflip-blt)
[311.538937] Starting subtest: hdr-1p-primscrn-indfb-pgflip-blt
[311.540345] Subtest hdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[311.665925] [101/154] (715s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[311.757591] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[311.759000] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[311.880952] [102/154] (715s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[311.973964] Starting subtest: fbc-2p-pri-indfb-multidraw
[311.975339] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[312.107990] [103/154] (715s left) kms_sequence (queue-busy)
[312.196948] Starting subtest: queue-busy
[312.197717] Starting dynamic subtest: pipe-A-HDMI-A-1
[315.024618] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.826s)
[315.035132] Starting dynamic subtest: pipe-B-HDMI-A-1
[317.761097] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.733s)
[317.770648] Starting dynamic subtest: pipe-C-HDMI-A-1
[320.481301] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.718s)
[320.493554] Starting dynamic subtest: pipe-D-HDMI-A-1
[323.210693] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.726s)
[323.211447] Subtest queue-busy: SUCCESS (11.010s)
[323.366370] [104/154] (704s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[323.460531] Starting subtest: plane-upscale-20x20-with-rotation
[323.461336] Starting dynamic subtest: pipe-A
[323.955920] Dynamic subtest pipe-A: SKIP (0.493s)
[323.965680] Starting dynamic subtest: pipe-B
[324.466501] Dynamic subtest pipe-B: SKIP (0.510s)
[324.476084] Starting dynamic subtest: pipe-C
[324.995940] Dynamic subtest pipe-C: SKIP (0.529s)
[325.005619] Starting dynamic subtest: pipe-D
[325.516069] Dynamic subtest pipe-D: SKIP (0.519s)
[325.517522] Subtest plane-upscale-20x20-with-rotation: SKIP (2.054s)
[325.737244] [105/154] (701s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-pwrite)
[325.835234] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-pwrite
[325.836623] Subtest psrhdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[325.945183] [106/154] (701s left) gem_exec_reloc (basic-write-wc)
[325.983511] Starting subtest: basic-write-wc
[325.988731] Subtest basic-write-wc: SUCCESS (0.005s)
[326.136525] [107/154] (701s left) syncobj_timeline (reset-signaled)
[326.172446] Starting subtest: reset-signaled
[326.173165] Subtest reset-signaled: SUCCESS (0.000s)
[326.266348] [108/154] (701s left) kms_psr (pr-cursor-plane-move)
[326.357876] Subtest pr-cursor-plane-move: SKIP (0.000s)
[326.415231] [109/154] (701s left) syncobj_wait (invalid-wait-illegal-handle)
[326.451407] Starting subtest: invalid-wait-illegal-handle
[326.452183] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[326.552793] [110/154] (701s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[326.647882] Starting subtest: extended-pageflip-modeset-hang-oldfb
[326.648596] Starting dynamic subtest: pipe-A
[346.348077] Dynamic subtest pipe-A: SUCCESS (19.704s)
[346.362765] Starting dynamic subtest: pipe-D
[366.300266] Dynamic subtest pipe-D: SUCCESS (19.933s)
[366.301007] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (39.644s)
[366.450235] [111/154] (661s left) kms_psr (psr2-primary-blt)
[366.541018] Subtest psr2-primary-blt: SKIP (0.000s)
[366.585150] [112/154] (661s left) gem_softpin (evict-snoop-interruptible)
[366.626038] Starting subtest: evict-snoop-interruptible
[366.627456] Subtest evict-snoop-interruptible: SKIP (0.000s)
[366.755473] [113/154] (661s left) kms_force_connector_basic (force-load-detect)
[366.877697] Starting subtest: force-load-detect
[366.883141] Subtest force-load-detect: SKIP (0.000s)
[367.076300] [114/154] (660s left) kms_chamelium_edid (hdmi-mode-timings)
[367.205970] Subtest hdmi-mode-timings: SKIP (0.000s)
[367.317047] [115/154] (660s left) syncobj_timeline (invalid-signal-zero-handles)
[367.353088] Starting subtest: invalid-signal-zero-handles
[367.353822] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[367.457509] [116/154] (660s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt)
[367.549264] Starting subtest: fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt
[367.550695] Subtest fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[367.685437] [117/154] (660s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[367.785031] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[367.786378] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[367.913381] [118/154] (660s left) gem_mmap_gtt (fault-concurrent-x)
[367.947980] Starting subtest: fault-concurrent-X
[370.637932] Subtest fault-concurrent-X: SUCCESS (2.681s)
[370.778152] [119/154] (657s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[370.817984] Starting subtest: y-tiled-to-vebox-y-tiled
[370.818706] Starting dynamic subtest: smem
[370.915233] Dynamic subtest smem: SUCCESS (0.097s)
[370.915969] Subtest y-tiled-to-vebox-y-tiled: SUCCESS (0.098s)
[371.121543] [120/154] (657s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-plflip-blt)
[371.220902] Starting subtest: psrhdr-2p-scndscrn-shrfb-plflip-blt
[371.222362] Subtest psrhdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[371.340643] [121/154] (657s left) vgem_basic (debugfs)
[371.392105] Starting subtest: debugfs
[371.392897] Subtest debugfs: SUCCESS (0.000s)
[371.479120] [122/154] (656s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[371.569088] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[371.569840] Starting dynamic subtest: pipe-A-valid-mode
[372.679604] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.110s)
[372.680428] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (1.112s)
[372.858740] [123/154] (655s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[372.954579] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[372.955990] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[373.085476] [124/154] (655s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[373.177327] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[373.178742] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[373.295475] [125/154] (655s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[373.388220] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[373.389717] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[373.523170] [126/154] (655s left) kms_vblank (wait-forked-hang)
[373.615750] Starting subtest: wait-forked-hang
[373.616626] Starting dynamic subtest: pipe-A-HDMI-A-1
[388.345074] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (14.726s)
[388.360175] Starting dynamic subtest: pipe-D-HDMI-A-1
[402.140720] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (13.787s)
[402.141461] Subtest wait-forked-hang: SUCCESS (28.520s)
[402.351748] [127/154] (626s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[402.443273] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[402.444032] Starting dynamic subtest: pipe-A-valid-mode
[404.235194] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.791s)
[404.235939] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SUCCESS (1.793s)
[404.423560] [128/154] (624s left) gem_ctx_exec (basic-invalid-context)
[404.460697] Starting subtest: basic-invalid-context
[404.462401] Subtest basic-invalid-context: SUCCESS (0.002s)
[404.593577] [129/154] (624s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-msflip-blt)
[404.687132] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-msflip-blt
[404.688506] Subtest fbcpsrhdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[404.803715] [130/154] (624s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[404.892299] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (0.000s)
[404.937722] [131/154] (623s left) gem_ppgtt (blt-vs-render-ctxn)
[404.975881] Starting subtest: blt-vs-render-ctxN
[437.570530] Subtest blt-vs-render-ctxN: SUCCESS (32.575s)
[437.722510] [132/154] (591s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[437.811732] Starting subtest: basic-gtt-cpu-noreloc
[437.815726] Subtest basic-gtt-cpu-noreloc: SUCCESS (0.004s)
[437.995791] [133/154] (590s left) gem_softpin (invalid)
[438.035027] Starting subtest: invalid
[438.040107] Subtest invalid: SUCCESS (0.005s)
[438.181912] [134/154] (590s left) gem_exec_capture (capture)
[438.221841] Starting subtest: capture
[438.222637] Starting dynamic subtest: rcs0-smem
[439.499923] Dynamic subtest rcs0-smem: SUCCESS (1.270s)
[439.509401] Starting dynamic subtest: bcs0-smem
[440.771742] Dynamic subtest bcs0-smem: SUCCESS (1.273s)
[440.781223] Starting dynamic subtest: vcs0-smem
[442.044021] Dynamic subtest vcs0-smem: SUCCESS (1.268s)
[442.053494] Starting dynamic subtest: vcs1-smem
[443.315961] Dynamic subtest vcs1-smem: SUCCESS (1.269s)
[443.325444] Starting dynamic subtest: vecs0-smem
[444.587742] Dynamic subtest vecs0-smem: SUCCESS (1.270s)
[444.588460] Subtest capture: SUCCESS (6.357s)
[444.731554] [135/154] (584s left) gem_tiled_blits (basic)
[444.831028] Starting subtest: basic
[444.844173] Subtest basic: SUCCESS (0.014s)
[444.994674] [136/154] (584s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[445.143959] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[445.145448] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[445.284780] [137/154] (583s left) gem_mmap_offset (partial-remap)
[445.320536] Starting subtest: partial-remap
[445.321288] Starting dynamic subtest: smem0
[445.325873] Dynamic subtest smem0: SUCCESS (0.003s)
[445.326564] Subtest partial-remap: SUCCESS (0.004s)
[445.476789] [138/154] (583s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-blt)
[445.572891] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-blt
[445.574356] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[445.702875] [139/154] (583s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-blt)
[445.797198] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-blt
[445.798675] Subtest hdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[445.910958] [140/154] (583s left) i915_power (sanity)
[445.944587] Starting subtest: sanity
[449.965020] Subtest sanity: SUCCESS (4.009s)
[450.115579] [141/154] (579s left) gem_exec_schedule (preempt-queue)
[450.170169] Starting subtest: preempt-queue
[450.171014] Starting dynamic subtest: rcs0
[450.290400] Dynamic subtest rcs0: SUCCESS (0.111s)
[450.301235] Starting dynamic subtest: bcs0
[450.393079] Dynamic subtest bcs0: SUCCESS (0.110s)
[450.404962] Starting dynamic subtest: vcs0
[450.505333] Dynamic subtest vcs0: SUCCESS (0.111s)
[450.516143] Starting dynamic subtest: vcs1
[450.611214] Dynamic subtest vcs1: SUCCESS (0.105s)
[450.630845] Starting dynamic subtest: vecs0
[450.717597] Dynamic subtest vecs0: SUCCESS (0.105s)
[450.718688] Subtest preempt-queue: SUCCESS (0.548s)
[451.037226] [142/154] (578s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[451.129818] Starting subtest: cursorB-vs-flipA-legacy
[451.132272] Subtest cursorB-vs-flipA-legacy: SKIP (0.002s)
[451.224877] [143/154] (578s left) i915_pm_rps (reset)
[451.264022] Starting subtest: reset
[455.826859] Subtest reset: SUCCESS (4.530s)
[455.946363] [144/154] (573s left) kms_psr (fbc-psr-cursor-plane-onoff)
[456.038393] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s)
[456.085606] [145/154] (573s left) kms_setmode (clone-exclusive-crtc)
[456.119549] Starting subtest: clone-exclusive-crtc
[456.121626] Subtest clone-exclusive-crtc: SKIP (0.000s)
[456.216927] [146/154] (573s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[456.312403] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[456.313798] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[456.463490] [147/154] (573s left) kms_flip (flip-vs-rmfb)
[456.552517] Starting subtest: flip-vs-rmfb
[456.555625] Starting dynamic subtest: A-HDMI-A1
[464.262237] Dynamic subtest A-HDMI-A1: SUCCESS (7.709s)
[464.273924] Starting dynamic subtest: B-HDMI-A1
[471.937845] Dynamic subtest B-HDMI-A1: SUCCESS (7.674s)
[471.957955] Starting dynamic subtest: C-HDMI-A1
[479.618531] Dynamic subtest C-HDMI-A1: SUCCESS (7.677s)
[479.636416] Starting dynamic subtest: D-HDMI-A1
[487.292642] Dynamic subtest D-HDMI-A1: SUCCESS (7.674s)
[487.297764] Subtest flip-vs-rmfb: SUCCESS (30.752s)
[487.482949] [148/154] (542s left) gem_exec_whisper (basic-contexts-all)
[487.527365] Starting subtest: basic-contexts-all
[489.228718] Subtest basic-contexts-all: SUCCESS (1.700s)
[489.440025] [149/154] (540s left) dmabuf_sync_file (export-basic)
[489.481206] Starting subtest: export-basic
[489.483070] Subtest export-basic: SUCCESS (0.001s)
[489.568287] [150/154] (540s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[489.666887] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[489.668360] Subtest hdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[489.816489] [151/154] (539s left) gem_sync (basic-each)
[489.860841] Starting subtest: basic-each
[491.958285] Subtest basic-each: SUCCESS (2.097s)
[492.178945] [152/154] (537s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[492.276135] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[492.276917] Starting dynamic subtest: pipe-A-HDMI-A-1
[492.284729] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[492.294419] Starting dynamic subtest: pipe-B-HDMI-A-1
[492.301953] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[492.313947] Starting dynamic subtest: pipe-C-HDMI-A-1
[492.321544] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[492.332980] Starting dynamic subtest: pipe-D-HDMI-A-1
[492.340651] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[492.342003] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.008s)
[492.579922] [153/154] (537s left) syncobj_wait (multi-wait-for-submit-submitted)
[492.617413] Starting subtest: multi-wait-for-submit-submitted
[492.721291] Subtest multi-wait-for-submit-submitted: SUCCESS (0.103s)
[492.841080] [154/154] (537s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[492.932267] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt
[492.933758] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[493.053930] 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: gem_render_copy
results: parsing output: 16/ for test: sysfs_heartbeat_interval
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: gem_ctx_param
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: i915_pm_freq_mult
results: parsing output: 21/ for test: prime_busy
results: parsing output: 22/ for test: gem_exec_gttfill
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: gem_ctx_param
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: gem_lmem_swapping
results: parsing output: 27/ for test: gem_ctx_shared
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: gem_bad_reloc
results: parsing output: 30/ for test: kms_chamelium_hpd
results: parsing output: 31/ for test: kms_psr2_sf
results: parsing output: 32/ for test: gem_eio
results: parsing output: 33/ for test: kms_content_protection
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: gem_ctx_isolation
results: parsing output: 36/ for test: gem_flink_basic
results: parsing output: 37/ for test: gem_caching
results: parsing output: 38/ for test: kms_plane_scaling
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_pm_rpm
results: parsing output: 42/ for test: kms_atomic_transition
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_spin_batch
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: syncobj_basic
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: api_intel_bb
results: parsing output: 51/ for test: kms_atomic_interruptible
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_flip_scaled_crc
results: parsing output: 55/ for test: gem_pxp
results: parsing output: 56/ for test: gen9_exec_parse
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_exec_balancer
results: parsing output: 59/ for test: kms_plane
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_pwrite_crc
results: parsing output: 62/ for test: gem_flink_basic
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: gem_ctx_persistence
results: parsing output: 65/ for test: gen7_exec_parse
results: parsing output: 66/ for test: gem_exec_schedule
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: perf
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: i915_drm_fdinfo
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_pipe_crc_basic
results: parsing output: 73/ for test: gem_exec_reloc
results: parsing output: 74/ for test: kms_cursor_crc
results: parsing output: 75/ for test: kms_color_pipeline
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_exec_reloc
results: parsing output: 80/ for test: kms_cursor_legacy
results: parsing output: 81/ for test: kms_flip
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_draw_crc
results: parsing output: 84/ for test: kms_cursor_crc
results: parsing output: 85/ for test: kms_cursor_crc
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_lease
results: parsing output: 89/ for test: syncobj_wait
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_exec_fence
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: kms_cursor_legacy
results: parsing output: 97/ for test: kms_chamelium_audio
results: parsing output: 98/ for test: kms_addfb_basic
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_sequence
results: parsing output: 103/ for test: kms_plane_scaling
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_exec_reloc
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: syncobj_wait
results: parsing output: 109/ for test: kms_busy
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: gem_softpin
results: parsing output: 112/ for test: kms_force_connector_basic
results: parsing output: 113/ for test: kms_chamelium_edid
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: gem_mmap_gtt
results: parsing output: 118/ for test: gem_render_copy
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: vgem_basic
results: parsing output: 121/ for test: kms_flip_scaled_crc
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_vblank
results: parsing output: 126/ for test: kms_flip_scaled_crc
results: parsing output: 127/ for test: gem_ctx_exec
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_psr2_sf
results: parsing output: 130/ for test: gem_ppgtt
results: parsing output: 131/ for test: gem_exec_reloc
results: parsing output: 132/ for test: gem_softpin
results: parsing output: 133/ for test: gem_exec_capture
results: parsing output: 134/ for test: gem_tiled_blits
results: parsing output: 135/ for test: kms_frontbuffer_tracking
results: parsing output: 136/ for test: gem_mmap_offset
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: i915_power
results: parsing output: 140/ for test: gem_exec_schedule
results: parsing output: 141/ for test: kms_cursor_legacy
results: parsing output: 142/ for test: i915_pm_rps
results: parsing output: 143/ for test: kms_psr
results: parsing output: 144/ for test: kms_setmode
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: kms_flip
results: parsing output: 147/ for test: gem_exec_whisper
results: parsing output: 148/ for test: dmabuf_sync_file
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: gem_sync
results: parsing output: 151/ for test: kms_ccs
results: parsing output: 152/ for test: syncobj_wait
results: parsing output: 153/ for test: kms_frontbuffer_tracking
Done.