[46.963570] Initializing watchdogs
[46.963631]   /dev/watchdog0
[46.978580] [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]
[46.983981] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[46.986381] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[46.988821] [001/156] (960s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[47.087244] Starting subtest: fbc-tiling-linear
[48.148855] Subtest fbc-tiling-linear: SUCCESS (1.111s)
[48.287451] [002/156] (959s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[48.320429] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[48.357893] [003/156] (959s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[48.449031] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[48.450327] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[48.531530] [004/156] (959s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[48.619869] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[48.621163] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[48.717047] [005/156] (958s left) kms_force_connector_basic (prune-stale-modes)
[48.836199] Starting subtest: prune-stale-modes
[48.979164] Subtest prune-stale-modes: SUCCESS (0.149s)
[49.124633] [006/156] (958s left) perf_pmu (most-busy-check-all)
[49.165440] Starting subtest: most-busy-check-all
[49.166128] Starting dynamic subtest: rcs0
[49.687987] Dynamic subtest rcs0: SUCCESS (0.542s)
[49.696856] Starting dynamic subtest: bcs0
[50.209288] Dynamic subtest bcs0: SUCCESS (0.538s)
[50.219513] Starting dynamic subtest: vcs0
[50.728017] Dynamic subtest vcs0: SUCCESS (0.535s)
[50.736972] Starting dynamic subtest: vcs1
[51.247174] Dynamic subtest vcs1: SUCCESS (0.533s)
[51.256097] Starting dynamic subtest: vecs0
[51.766016] Dynamic subtest vecs0: SUCCESS (0.533s)
[51.766885] Subtest most-busy-check-all: SUCCESS (2.683s)
[51.839281] [007/156] (955s left) gem_ccs (large-ctrl-surf-copy)
[51.877117] Starting subtest: large-ctrl-surf-copy
[51.878523] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[51.930699] [008/156] (955s left) kms_plane_alpha_blend (coverage-7efc)
[52.019234] Starting subtest: coverage-7efc
[52.095708] Starting dynamic subtest: pipe-A-HDMI-A-1
[52.384343] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.295s)
[52.421526] Starting dynamic subtest: pipe-D-HDMI-A-1
[52.859480] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.456s)
[52.860206] Subtest coverage-7efc: SUCCESS (0.861s)
[53.013651] [009/156] (954s left) gem_mmap_gtt (fault-concurrent)
[53.053492] Starting subtest: fault-concurrent
[55.616872] Subtest fault-concurrent: SUCCESS (2.577s)
[55.707253] [010/156] (952s left) api_intel_allocator (gem-pool)
[55.750370] Starting subtest: gem-pool
[55.757432] Subtest gem-pool: SUCCESS (0.007s)
[55.848456] [011/156] (952s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-fullscreen)
[55.942472] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-fullscreen
[55.943803] Subtest fbchdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[56.030946] [012/156] (951s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[56.117536] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[56.118932] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[56.176606] [013/156] (951s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[56.265070] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[56.265847] Starting dynamic subtest: pipe-A-HDMI-A-1
[56.279857] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[56.286518] Starting dynamic subtest: pipe-B-HDMI-A-1
[56.293405] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[56.299941] Starting dynamic subtest: pipe-C-HDMI-A-1
[56.306687] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[56.312763] Starting dynamic subtest: pipe-D-HDMI-A-1
[56.319849] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[56.321310] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.006s)
[56.509523] [014/156] (951s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[56.598875] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[56.599720] Starting dynamic subtest: pipe-A-HDMI-A-1
[56.606751] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[56.616526] Starting dynamic subtest: pipe-B-HDMI-A-1
[56.623432] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[56.632134] Starting dynamic subtest: pipe-C-HDMI-A-1
[56.639044] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[56.646087] Starting dynamic subtest: pipe-D-HDMI-A-1
[56.652786] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[56.654125] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[56.846367] [015/156] (951s left) kms_frontbuffer_tracking (hdr-rgb565-draw-blt)
[56.941477] Starting subtest: hdr-rgb565-draw-blt
[56.942899] Subtest hdr-rgb565-draw-blt: SKIP (0.000s)
[57.045402] [016/156] (951s left) kms_pm_rpm (legacy-planes-dpms)
[58.456909] Starting subtest: legacy-planes-dpms
[58.457897] Starting dynamic subtest: plane-65
[66.733465] Dynamic subtest plane-65: SUCCESS (8.330s)
[66.741856] Starting dynamic subtest: plane-95
[74.936896] Dynamic subtest plane-95: SUCCESS (8.220s)
[74.948503] Starting dynamic subtest: plane-125
[83.247453] Dynamic subtest plane-125: SUCCESS (8.313s)
[83.260298] Starting dynamic subtest: plane-135
[91.650982] Dynamic subtest plane-135: SUCCESS (8.401s)
[91.660151] Starting dynamic subtest: plane-145
[100.040890] Dynamic subtest plane-145: SUCCESS (8.388s)
[100.050043] Starting dynamic subtest: plane-155
[108.336965] Dynamic subtest plane-155: SUCCESS (8.294s)
[108.338049] Subtest legacy-planes-dpms: SUCCESS (49.950s)
[108.537867] [017/156] (899s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[108.581666] Starting subtest: x-tiled-to-vebox-y-tiled
[108.582360] Starting dynamic subtest: smem
[108.679469] Dynamic subtest smem: SUCCESS (0.097s)
[108.680202] Subtest x-tiled-to-vebox-y-tiled: SUCCESS (0.098s)
[108.856394] [018/156] (899s left) sysfs_heartbeat_interval (invalid)
[108.894388] Starting subtest: invalid
[108.895112] Starting dynamic subtest: vecs0
[108.895816] Dynamic subtest vecs0: SUCCESS (0.000s)
[108.903065] Starting dynamic subtest: vcs0
[108.903838] Dynamic subtest vcs0: SUCCESS (0.000s)
[108.910462] Starting dynamic subtest: bcs0
[108.911176] Dynamic subtest bcs0: SUCCESS (0.000s)
[108.917651] Starting dynamic subtest: rcs0
[108.918360] Dynamic subtest rcs0: SUCCESS (0.000s)
[108.924729] Starting dynamic subtest: vcs1
[108.925414] Dynamic subtest vcs1: SUCCESS (0.000s)
[108.926096] Subtest invalid: SUCCESS (0.004s)
[108.959417] [019/156] (899s left) kms_frontbuffer_tracking (fbc-stridechange)
[109.052673] Starting subtest: fbc-stridechange
[109.995627] Subtest fbc-stridechange: SUCCESS (0.944s)
[110.124054] [020/156] (898s left) gem_ctx_param (basic-default)
[110.159146] Starting subtest: basic-default
[110.160195] Subtest basic-default: SUCCESS (0.000s)
[110.231999] [021/156] (898s left) kms_psr (fbc-pr-primary-mmap-gtt)
[110.322280] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[110.364328] [022/156] (897s left) i915_pm_freq_mult (media-freq)
[110.399092] Starting subtest: media-freq
[110.399831] Starting dynamic subtest: gt0
[110.401203] Dynamic subtest gt0: SKIP (0.000s)
[110.402545] Subtest media-freq: SKIP (0.001s)
[110.468074] [023/156] (897s left) prime_busy (before-wait)
[110.505082] Starting subtest: before-wait
[110.509942] Starting dynamic subtest: rcs0
[110.528041] Dynamic subtest rcs0: SUCCESS (0.018s)
[110.538071] Starting dynamic subtest: bcs0
[110.548654] Dynamic subtest bcs0: SUCCESS (0.020s)
[110.560977] Starting dynamic subtest: vcs0
[110.568225] Dynamic subtest vcs0: SUCCESS (0.019s)
[110.578808] Starting dynamic subtest: vcs1
[110.585274] Dynamic subtest vcs1: SUCCESS (0.016s)
[110.593444] Starting dynamic subtest: vecs0
[110.600313] Dynamic subtest vecs0: SUCCESS (0.014s)
[110.708561] Subtest before-wait: SUCCESS (0.203s)
[110.789733] [024/156] (897s left) gem_exec_gttfill (engines)
[110.833007] Starting subtest: engines
[110.833790] Starting dynamic subtest: rcs0
[134.225539] Dynamic subtest rcs0: SUCCESS (23.391s)
[134.240479] Starting dynamic subtest: bcs0
[157.266464] Dynamic subtest bcs0: SUCCESS (23.040s)
[157.274122] Starting dynamic subtest: vcs0
[180.385727] Dynamic subtest vcs0: SUCCESS (23.118s)
[180.398416] Starting dynamic subtest: vcs1
[203.456908] Dynamic subtest vcs1: SUCCESS (23.070s)
[203.469332] Starting dynamic subtest: vecs0
[226.576934] Dynamic subtest vecs0: SUCCESS (23.118s)
[226.577938] Subtest engines: SUCCESS (115.741s)
[226.772269] [025/156] (781s left) syncobj_timeline (etime-multi-wait-all-submitted)
[226.883719] Starting subtest: etime-multi-wait-all-submitted
[226.990283] Subtest etime-multi-wait-all-submitted: SUCCESS (0.106s)
[227.061430] [026/156] (781s left) gem_ctx_param (get-priority-new-ctx)
[227.095886] Starting subtest: get-priority-new-ctx
[227.096646] Subtest get-priority-new-ctx: SUCCESS (0.000s)
[227.148621] [027/156] (781s left) kms_big_fb (linear-32bpp-rotate-90)
[227.255971] Starting subtest: linear-32bpp-rotate-90
[227.332249] Subtest linear-32bpp-rotate-90: SKIP (0.076s)
[227.443069] [028/156] (781s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[227.482663] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[227.518707] [029/156] (781s left) gem_ctx_shared (disjoint-timelines)
[227.561293] Starting subtest: disjoint-timelines
[227.598547] Subtest disjoint-timelines: SUCCESS (0.037s)
[227.820938] [FACT gem_ctx_shared (disjoint-timelines)] new: kernel.kmod_is_loaded.vgem: true
[227.822971] [030/156] (780s left) kms_psr (fbc-psr2-cursor-plane-move)
[227.912372] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s)
[227.956828] [031/156] (780s left) gem_bad_reloc (negative-reloc-bltcopy)
[227.997182] Starting subtest: negative-reloc-bltcopy
[229.109262] Subtest negative-reloc-bltcopy: SUCCESS (1.101s)
[229.211130] [032/156] (779s left) kms_chamelium_hpd (hdmi-hpd)
[229.358543] Subtest hdmi-hpd: SKIP (0.000s)
[229.457297] [033/156] (779s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[229.552812] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[229.602404] [034/156] (779s left) gem_eio (wait-10ms)
[229.646477] Starting subtest: wait-10ms
[229.815307] Subtest wait-10ms: SUCCESS (0.169s)
[229.933100] [035/156] (778s left) kms_content_protection (legacy-hdcp14)
[230.031724] Starting subtest: legacy-hdcp14
[230.036056] Subtest legacy-hdcp14: SKIP (0.003s)
[230.116015] [036/156] (778s left) syncobj_wait (reset-signaled)
[230.151265] Starting subtest: reset-signaled
[230.151980] Subtest reset-signaled: SUCCESS (0.000s)
[230.216545] [037/156] (778s left) gem_ctx_isolation (dirty-switch)
[230.258051] Starting subtest: dirty-switch
[230.258769] Starting dynamic subtest: rcs0
[230.447895] Dynamic subtest rcs0: SUCCESS (0.181s)
[230.455690] Starting dynamic subtest: bcs0
[230.661511] Dynamic subtest bcs0: SUCCESS (0.213s)
[230.669066] Starting dynamic subtest: vcs0
[230.861619] Dynamic subtest vcs0: SUCCESS (0.199s)
[230.869184] Starting dynamic subtest: vcs1
[231.077221] Dynamic subtest vcs1: SUCCESS (0.224s)
[231.085341] Starting dynamic subtest: vecs0
[231.302576] Dynamic subtest vecs0: SUCCESS (0.216s)
[231.303361] Subtest dirty-switch: SUCCESS (1.036s)
[231.478837] [038/156] (777s left) gem_flink_basic (bad-open)
[231.511744] Starting subtest: bad-open
[231.512436] Subtest bad-open: SUCCESS (0.000s)
[231.583972] [039/156] (777s left) gem_caching (writes)
[231.622681] Starting subtest: writes
[240.893562] Subtest writes: SUCCESS (9.271s)
[240.991408] [040/156] (768s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[241.082740] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[241.083436] Starting dynamic subtest: pipe-A
[241.473114] Dynamic subtest pipe-A: SUCCESS (0.390s)
[241.485907] Starting dynamic subtest: pipe-B
[241.915610] Dynamic subtest pipe-B: SUCCESS (0.442s)
[241.923847] Starting dynamic subtest: pipe-C
[242.368332] Dynamic subtest pipe-C: SUCCESS (0.452s)
[242.386426] Starting dynamic subtest: pipe-D
[242.819299] Dynamic subtest pipe-D: SUCCESS (0.450s)
[242.820020] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (1.737s)
[243.007791] [041/156] (766s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[243.044193] Starting subtest: single-wait-all-for-submit-available-submitted
[243.044942] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[243.121276] [042/156] (765s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-render)
[243.217270] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-render
[243.218740] Subtest fbchdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[243.305849] [043/156] (765s left) kms_pm_rpm (system-suspend-idle)
[244.725957] Starting subtest: system-suspend-idle
[264.828142] Subtest system-suspend-idle: SUCCESS (4.883s)
[272.083447] [044/156] (744s left) kms_atomic_transition (modeset-transition)
[272.175851] Starting subtest: modeset-transition
[272.176590] Starting dynamic subtest: 1x-outputs
[273.407406] Dynamic subtest 1x-outputs: SUCCESS (1.260s)
[273.408083] Subtest modeset-transition: SUCCESS (1.261s)
[273.550395] [045/156] (742s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[273.643644] Starting subtest: pipe-fbc-rte
[273.647664] Subtest pipe-fbc-rte: SKIP (0.000s)
[273.731237] [046/156] (742s left) gem_spin_batch (resubmit-all)
[273.772180] Starting subtest: resubmit-all
[273.772909] Starting dynamic subtest: rcs0
[273.776022] Dynamic subtest rcs0: SUCCESS (0.004s)
[273.786407] Starting dynamic subtest: bcs0
[273.787207] Dynamic subtest bcs0: SUCCESS (0.002s)
[273.795585] Starting dynamic subtest: vcs0
[273.796247] Dynamic subtest vcs0: SUCCESS (0.002s)
[273.804293] Starting dynamic subtest: vcs1
[273.804938] Dynamic subtest vcs1: SUCCESS (0.002s)
[273.812325] Starting dynamic subtest: vecs0
[273.812970] Dynamic subtest vecs0: SUCCESS (0.002s)
[273.813618] Subtest resubmit-all: SUCCESS (0.016s)
[273.966879] [047/156] (742s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[274.055755] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[274.057110] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[274.148397] [048/156] (742s left) syncobj_basic (illegal-fd-to-handle)
[274.181064] Starting subtest: illegal-fd-to-handle
[274.181758] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[274.247970] [049/156] (742s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[274.336608] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[274.337888] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[274.438140] [050/156] (741s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[274.531978] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[275.196835] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (0.688s)
[275.342016] [051/156] (741s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[275.375936] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[275.482428] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.108s)
[275.557270] [052/156] (740s left) api_intel_bb (misplaced-blitter)
[275.590442] Starting subtest: misplaced-blitter
[275.595633] Subtest misplaced-blitter: SUCCESS (0.005s)
[275.714381] [053/156] (740s left) kms_atomic_interruptible (universal-setplane-cursor)
[275.805667] Starting subtest: universal-setplane-cursor
[275.807406] Starting dynamic subtest: pipe-A-HDMI-A-1
[282.009924] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.337s)
[282.010627] Subtest universal-setplane-cursor: SUCCESS (6.339s)
[282.157259] [054/156] (734s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[282.259814] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[282.261307] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[282.355325] [055/156] (734s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[282.450373] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[282.451786] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[282.527110] [056/156] (734s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[282.615542] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[282.616284] Starting dynamic subtest: pipe-A-valid-mode
[283.723384] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.121s)
[283.724861] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SUCCESS (1.122s)
[283.875421] [057/156] (732s left) gem_pxp (create-protected-buffer)
[283.979180] Starting subtest: create-protected-buffer
[283.980092] Subtest create-protected-buffer: SUCCESS (0.000s)
[284.070760] [058/156] (732s left) gem_fence_thrash (bo-write-verify-threaded-x)
[284.103447] Starting subtest: bo-write-verify-threaded-x
[288.766031] Subtest bo-write-verify-threaded-x: SUCCESS (4.667s)
[288.834210] [059/156] (727s left) gen9_exec_parse (allowed-single)
[288.872768] Subtest allowed-single: SKIP (0.000s)
[288.916564] [060/156] (727s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[289.018893] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[289.020248] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[289.114249] [061/156] (727s left) gem_exec_balancer (bonded-semaphore)
[289.157170] Starting subtest: bonded-semaphore
[293.484140] Subtest bonded-semaphore: SUCCESS (4.312s)
[293.640296] [062/156] (723s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[293.730333] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[293.746722] Starting dynamic subtest: pipe-A-plane-0
[293.946096] Dynamic subtest pipe-A-plane-0: SUCCESS (0.200s)
[293.962814] Starting dynamic subtest: pipe-A-plane-3
[294.120513] Dynamic subtest pipe-A-plane-3: SUCCESS (0.173s)
[294.137392] Starting dynamic subtest: pipe-A-plane-5
[294.286727] Dynamic subtest pipe-A-plane-5: SUCCESS (0.165s)
[294.446125] Starting dynamic subtest: pipe-B-plane-0
[294.620853] Dynamic subtest pipe-B-plane-0: SUCCESS (0.183s)
[294.638010] Starting dynamic subtest: pipe-B-plane-3
[294.786926] Dynamic subtest pipe-B-plane-3: SUCCESS (0.165s)
[294.804468] Starting dynamic subtest: pipe-B-plane-5
[294.961378] Dynamic subtest pipe-B-plane-5: SUCCESS (0.173s)
[295.042816] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SUCCESS (1.317s)
[295.201065] [063/156] (721s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[295.297918] Starting subtest: fbc-rgb565-draw-mmap-wc
[296.529186] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (1.235s)
[296.642432] [064/156] (720s left) kms_pwrite_crc (basic)
[296.734083] Starting subtest: basic
[297.026581] Subtest basic: SUCCESS (0.294s)
[297.163655] [065/156] (719s left) gem_flink_basic (bad-flink)
[297.199586] Starting subtest: bad-flink
[297.200362] Subtest bad-flink: SUCCESS (0.000s)
[297.277153] [066/156] (719s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-move)
[297.369037] Starting subtest: hdr-2p-primscrn-spr-indfb-move
[297.370505] Subtest hdr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[297.481714] [067/156] (719s left) gem_ctx_persistence (legacy-engines-persistence)
[297.520728] Starting subtest: legacy-engines-persistence
[297.521511] Starting dynamic subtest: render
[298.281929] Dynamic subtest render: SUCCESS (0.761s)
[298.294319] Starting dynamic subtest: bsd1
[299.052084] Dynamic subtest bsd1: SUCCESS (0.768s)
[299.065525] Starting dynamic subtest: bsd2
[299.823042] Dynamic subtest bsd2: SUCCESS (0.768s)
[299.835269] Starting dynamic subtest: blt
[300.587133] Dynamic subtest blt: SUCCESS (0.762s)
[300.600182] Starting dynamic subtest: vebox
[301.359129] Dynamic subtest vebox: SUCCESS (0.769s)
[301.360218] Subtest legacy-engines-persistence: SUCCESS (3.839s)
[301.445173] [068/156] (715s left) gen7_exec_parse (basic-allowed)
[301.483440] Subtest basic-allowed: SKIP (0.000s)
[301.530143] [069/156] (715s left) gem_exec_schedule (reorder-wide)
[301.697254] Starting subtest: reorder-wide
[301.698095] Starting dynamic subtest: rcs0
[301.775934] Dynamic subtest rcs0: SUCCESS (0.080s)
[301.790160] Starting dynamic subtest: bcs0
[301.854428] Dynamic subtest bcs0: SUCCESS (0.077s)
[301.868304] Starting dynamic subtest: vcs0
[301.929512] Dynamic subtest vcs0: SUCCESS (0.073s)
[301.949553] Starting dynamic subtest: vcs1
[302.006982] Dynamic subtest vcs1: SUCCESS (0.075s)
[302.023901] Starting dynamic subtest: vecs0
[302.093091] Dynamic subtest vecs0: SUCCESS (0.084s)
[302.093956] Subtest reorder-wide: SUCCESS (0.399s)
[302.280163] [070/156] (714s left) kms_frontbuffer_tracking (psrhdr-slowdraw)
[302.375930] Starting subtest: psrhdr-slowdraw
[302.377335] Subtest psrhdr-slowdraw: SKIP (0.000s)
[302.470033] [071/156] (714s left) perf (non-zero-reason)
[302.570473] Starting subtest: non-zero-reason
[302.571241] Starting dynamic subtest: 0-rcs0
[310.322886] Dynamic subtest 0-rcs0: SUCCESS (7.720s)
[310.323690] Subtest non-zero-reason: SUCCESS (7.721s)
[310.362869] [072/156] (706s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-pwrite)
[310.456918] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-pwrite
[310.458397] Subtest fbchdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[310.553351] [073/156] (706s left) i915_drm_fdinfo (all-busy-check-all)
[310.590855] Starting subtest: all-busy-check-all
[311.107607] Subtest all-busy-check-all: SUCCESS (0.517s)
[311.177278] [074/156] (706s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[311.270666] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt
[311.272107] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[311.367432] [075/156] (706s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[311.456469] Starting subtest: compare-crc-sanitycheck-nv12
[311.458342] Starting dynamic subtest: pipe-A-HDMI-A-1
[311.788548] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.331s)
[311.799506] Starting dynamic subtest: pipe-B-HDMI-A-1
[312.128643] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.336s)
[312.140920] Starting dynamic subtest: pipe-C-HDMI-A-1
[312.453318] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.323s)
[312.464325] Starting dynamic subtest: pipe-D-HDMI-A-1
[312.774266] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.320s)
[312.775038] Subtest compare-crc-sanitycheck-nv12: SUCCESS (1.319s)
[312.928654] [076/156] (704s left) gem_exec_reloc (basic-write-gtt)
[312.971761] Starting subtest: basic-write-gtt
[312.977900] Subtest basic-write-gtt: SUCCESS (0.006s)
[313.092491] [077/156] (704s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[313.187286] Starting subtest: cursor-rapid-movement-max-size
[313.189418] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[313.304408] [078/156] (704s left) kms_color_pipeline (plane-lut1d)
[313.394514] Starting subtest: plane-lut1d
[313.489692] Starting dynamic subtest: pipe-A-plane-0
[313.581007] Dynamic subtest pipe-A-plane-0: SUCCESS (0.091s)
[313.597929] Starting dynamic subtest: pipe-A-plane-1
[313.672517] Dynamic subtest pipe-A-plane-1: SUCCESS (0.090s)
[313.689050] Starting dynamic subtest: pipe-A-plane-2
[313.764199] Dynamic subtest pipe-A-plane-2: SUCCESS (0.090s)
[313.976738] Starting dynamic subtest: pipe-B-plane-0
[314.052231] Dynamic subtest pipe-B-plane-0: SUCCESS (0.091s)
[314.068164] Starting dynamic subtest: pipe-B-plane-1
[314.152031] Dynamic subtest pipe-B-plane-1: SUCCESS (0.097s)
[314.168693] Starting dynamic subtest: pipe-B-plane-2
[314.243967] Dynamic subtest pipe-B-plane-2: SUCCESS (0.089s)
[314.454645] Starting dynamic subtest: pipe-C-plane-0
[314.537575] Dynamic subtest pipe-C-plane-0: SUCCESS (0.092s)
[314.553107] Starting dynamic subtest: pipe-C-plane-1
[314.637673] Dynamic subtest pipe-C-plane-1: SUCCESS (0.098s)
[314.652655] Starting dynamic subtest: pipe-C-plane-2
[314.737692] Dynamic subtest pipe-C-plane-2: SUCCESS (0.098s)
[314.953361] Starting dynamic subtest: pipe-D-plane-0
[315.036672] Dynamic subtest pipe-D-plane-0: SUCCESS (0.091s)
[315.051227] Starting dynamic subtest: pipe-D-plane-1
[315.136585] Dynamic subtest pipe-D-plane-1: SUCCESS (0.098s)
[315.150212] Starting dynamic subtest: pipe-D-plane-2
[315.236671] Dynamic subtest pipe-D-plane-2: SUCCESS (0.098s)
[315.287055] Subtest plane-lut1d: SUCCESS (1.892s)
[315.411594] [079/156] (702s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[315.518884] Starting subtest: yf-tiled-16bpp-rotate-180
[315.520341] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[315.612114] [080/156] (702s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[315.711401] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[315.712839] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[315.813760] [081/156] (701s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[315.907730] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt
[315.909198] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[316.005356] [082/156] (701s left) gem_exec_reloc (basic-wc-read)
[316.044000] Starting subtest: basic-wc-read
[316.049767] Subtest basic-wc-read: SUCCESS (0.006s)
[316.171185] [083/156] (701s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[316.261574] Starting subtest: short-busy-flip-before-cursor-toggle
[316.262996] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[316.319424] [084/156] (701s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[316.413880] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[316.423630] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.009s)
[316.500301] [085/156] (701s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[316.593951] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[316.595370] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[316.687429] [086/156] (701s left) kms_draw_crc (draw-method-render)
[316.776081] Starting subtest: draw-method-render
[316.776872] Starting dynamic subtest: xrgb8888-untiled
[316.940194] Dynamic subtest xrgb8888-untiled: SUCCESS (0.163s)
[316.957728] Starting dynamic subtest: rgb565-untiled
[317.106641] Dynamic subtest rgb565-untiled: SUCCESS (0.165s)
[317.124089] Starting dynamic subtest: xrgb2101010-untiled
[317.264848] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.156s)
[317.282767] Starting dynamic subtest: xbgr16161616f-untiled
[317.431671] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.165s)
[317.450113] Starting dynamic subtest: xrgb8888-xtiled
[317.523295] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.090s)
[317.540126] Starting dynamic subtest: rgb565-xtiled
[317.606762] Dynamic subtest rgb565-xtiled: SUCCESS (0.081s)
[317.628015] Starting dynamic subtest: xrgb2101010-xtiled
[317.689968] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.080s)
[317.711994] Starting dynamic subtest: xbgr16161616f-xtiled
[317.781572] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.089s)
[317.800239] Starting dynamic subtest: xrgb8888-ytiled
[317.873294] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.090s)
[317.891676] Starting dynamic subtest: rgb565-ytiled
[317.964838] Dynamic subtest rgb565-ytiled: SUCCESS (0.089s)
[317.981005] Starting dynamic subtest: xrgb2101010-ytiled
[318.048190] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.081s)
[318.064782] Starting dynamic subtest: xbgr16161616f-ytiled
[318.131582] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.081s)
[318.134362] Subtest draw-method-render: SUCCESS (1.357s)
[318.245735] [087/156] (699s left) kms_cursor_crc (cursor-sliding-256x85)
[318.340575] Starting subtest: cursor-sliding-256x85
[318.344314] Starting dynamic subtest: pipe-A-HDMI-A-1
[319.527755] Dynamic subtest pipe-A-HDMI-A-1: FAIL (1.005s)
[319.537412] Starting dynamic subtest: pipe-D-HDMI-A-1
[321.295126] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.909s)
[321.295899] Subtest cursor-sliding-256x85: FAIL (2.957s)
[321.446782] [088/156] (696s left) kms_cursor_crc (cursor-onscreen-256x256)
[321.547084] Starting subtest: cursor-onscreen-256x256
[321.551453] Starting dynamic subtest: pipe-A-HDMI-A-1
[322.715404] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.164s)
[322.761403] Starting dynamic subtest: pipe-D-HDMI-A-1
[323.915819] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.162s)
[323.916611] Subtest cursor-onscreen-256x256: SUCCESS (2.370s)
[324.077732] [089/156] (693s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render)
[324.175251] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render
[324.176703] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[324.266251] [090/156] (693s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[324.360231] Starting subtest: fbcpsr-slowdraw
[324.361695] Subtest fbcpsr-slowdraw: SKIP (0.000s)
[324.461405] [091/156] (693s left) kms_lease (cursor-implicit-plane)
[324.551562] Starting subtest: cursor-implicit-plane
[324.552335] Starting dynamic subtest: pipe-A-HDMI-A-1
[324.727766] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.175s)
[324.741356] Starting dynamic subtest: pipe-B-HDMI-A-1
[324.896990] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.166s)
[324.907858] Starting dynamic subtest: pipe-C-HDMI-A-1
[325.068521] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.170s)
[325.084093] Starting dynamic subtest: pipe-D-HDMI-A-1
[325.259343] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.189s)
[325.260151] Subtest cursor-implicit-plane: SUCCESS (0.710s)
[325.397768] [092/156] (692s left) syncobj_wait (invalid-reset-zero-handles)
[325.437513] Starting subtest: invalid-reset-zero-handles
[325.438319] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[325.504122] [093/156] (692s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[325.596876] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[325.598236] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[325.696245] [094/156] (692s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[325.794008] Starting subtest: yf-tiled-64bpp-rotate-90
[325.795420] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[325.897441] [095/156] (692s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc)
[325.992245] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc
[325.993600] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[326.088408] [096/156] (692s left) gem_exec_fence (long-history)
[326.409519] Starting subtest: long-history
[332.140975] Subtest long-history: SUCCESS (5.718s)
[332.534236] [097/156] (685s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[332.630926] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[332.632414] Subtest psr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[332.721549] [098/156] (685s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[332.809988] Starting subtest: bad-rotation-90-yf-tiled-ccs
[332.810797] Starting dynamic subtest: pipe-A-HDMI-A-1
[332.817910] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[332.829462] Starting dynamic subtest: pipe-B-HDMI-A-1
[332.836576] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[332.847797] Starting dynamic subtest: pipe-C-HDMI-A-1
[332.854644] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[332.865287] Starting dynamic subtest: pipe-D-HDMI-A-1
[332.872680] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[332.874439] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.006s)
[333.071407] [099/156] (685s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[333.162897] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[335.532666] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (2.371s)
[335.689202] [100/156] (682s left) kms_chamelium_audio (dp-audio-edid)
[335.840777] Subtest dp-audio-edid: SKIP (0.000s)
[335.942984] [101/156] (682s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[336.036477] Starting subtest: addfb25-yf-tiled-legacy
[336.037219] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[336.143423] [102/156] (682s left) kms_frontbuffer_tracking (hdr-1p-primscrn-indfb-pgflip-blt)
[336.235930] Starting subtest: hdr-1p-primscrn-indfb-pgflip-blt
[336.237337] Subtest hdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[336.324478] [103/156] (682s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[336.417927] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[336.419319] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[336.516411] [104/156] (682s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[336.609577] Starting subtest: fbc-2p-pri-indfb-multidraw
[336.611033] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[336.718388] [105/156] (682s left) kms_sequence (queue-busy)
[336.808507] Starting subtest: queue-busy
[336.809235] Starting dynamic subtest: pipe-A-HDMI-A-1
[338.092565] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.284s)
[338.103056] Starting dynamic subtest: pipe-B-HDMI-A-1
[339.365441] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.272s)
[339.377047] Starting dynamic subtest: pipe-C-HDMI-A-1
[340.645854] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.279s)
[340.659313] Starting dynamic subtest: pipe-D-HDMI-A-1
[341.932444] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.283s)
[341.933201] Subtest queue-busy: SUCCESS (5.126s)
[342.058926] [106/156] (676s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[342.152195] Starting subtest: plane-upscale-20x20-with-rotation
[342.153012] Starting dynamic subtest: pipe-A
[343.252657] Dynamic subtest pipe-A: SKIP (1.099s)
[343.261818] Starting dynamic subtest: pipe-B
[344.405896] Dynamic subtest pipe-B: SKIP (1.153s)
[344.417742] Starting dynamic subtest: pipe-C
[345.614012] Dynamic subtest pipe-C: SKIP (1.207s)
[345.625325] Starting dynamic subtest: pipe-D
[346.775754] Dynamic subtest pipe-D: SKIP (1.161s)
[346.777370] Subtest plane-upscale-20x20-with-rotation: SKIP (4.624s)
[346.954031] [107/156] (671s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-pwrite)
[347.061241] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-pwrite
[347.062651] Subtest psrhdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[347.166873] [108/156] (671s left) gem_exec_reloc (basic-write-wc)
[347.205305] Starting subtest: basic-write-wc
[347.210566] Subtest basic-write-wc: SUCCESS (0.005s)
[347.325862] [109/156] (671s left) syncobj_timeline (reset-signaled)
[347.361845] Starting subtest: reset-signaled
[347.362566] Subtest reset-signaled: SUCCESS (0.000s)
[347.426028] [110/156] (671s left) kms_psr (pr-cursor-plane-move)
[347.517908] Subtest pr-cursor-plane-move: SKIP (0.000s)
[347.563274] [111/156] (671s left) syncobj_wait (invalid-wait-illegal-handle)
[347.599077] Starting subtest: invalid-wait-illegal-handle
[347.599787] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[347.667064] [112/156] (671s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[347.760423] Starting subtest: extended-pageflip-modeset-hang-oldfb
[347.762254] Starting dynamic subtest: pipe-A
[368.111917] Dynamic subtest pipe-A: SUCCESS (20.352s)
[368.124661] Starting dynamic subtest: pipe-D
[388.078638] Dynamic subtest pipe-D: SUCCESS (19.958s)
[388.079367] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (40.318s)
[388.223461] [113/156] (630s left) kms_psr (psr2-primary-blt)
[388.320665] Subtest psr2-primary-blt: SKIP (0.000s)
[388.366895] [114/156] (630s left) gem_softpin (evict-snoop-interruptible)
[388.407236] Starting subtest: evict-snoop-interruptible
[388.408725] Subtest evict-snoop-interruptible: SKIP (0.000s)
[388.475053] [115/156] (630s left) kms_force_connector_basic (force-load-detect)
[388.599553] Starting subtest: force-load-detect
[388.602766] Subtest force-load-detect: SKIP (0.000s)
[388.755599] [116/156] (630s left) kms_chamelium_edid (hdmi-mode-timings)
[388.903838] Subtest hdmi-mode-timings: SKIP (0.000s)
[389.016569] [117/156] (630s left) syncobj_timeline (invalid-signal-zero-handles)
[389.053901] Starting subtest: invalid-signal-zero-handles
[389.054661] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[389.131707] [118/156] (630s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt)
[389.223840] Starting subtest: fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt
[389.225386] Subtest fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[389.323967] [119/156] (629s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[389.421376] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[389.422829] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[389.535863] [120/156] (629s left) gem_mmap_gtt (fault-concurrent-x)
[389.571726] Starting subtest: fault-concurrent-X
[392.292760] Subtest fault-concurrent-X: SUCCESS (2.713s)
[392.398158] [121/156] (627s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[392.438912] Starting subtest: y-tiled-to-vebox-y-tiled
[392.439621] Starting dynamic subtest: smem
[392.534903] Dynamic subtest smem: SUCCESS (0.095s)
[392.536914] Subtest y-tiled-to-vebox-y-tiled: SUCCESS (0.097s)
[392.718347] [122/156] (626s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-plflip-blt)
[392.812979] Starting subtest: psrhdr-2p-scndscrn-shrfb-plflip-blt
[392.814379] Subtest psrhdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[392.918272] [123/156] (626s left) vgem_basic (debugfs)
[392.954156] Starting subtest: debugfs
[392.954928] Subtest debugfs: SUCCESS (0.000s)
[393.018640] [124/156] (626s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[393.106716] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[393.108574] Starting dynamic subtest: pipe-A-valid-mode
[394.318358] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.210s)
[394.319169] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (1.212s)
[394.468717] [125/156] (625s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[394.566162] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[394.567636] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[394.655484] [126/156] (624s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[394.747903] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[394.749274] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[394.857894] [127/156] (624s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[394.951815] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[394.953307] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[395.047658] [128/156] (624s left) kms_vblank (wait-forked-hang)
[395.135483] Starting subtest: wait-forked-hang
[395.137258] Starting dynamic subtest: pipe-A-HDMI-A-1
[409.086613] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (13.951s)
[409.099570] Starting dynamic subtest: pipe-D-HDMI-A-1
[422.906652] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (13.819s)
[422.908973] Subtest wait-forked-hang: SUCCESS (27.777s)
[423.108358] [129/156] (596s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[423.201746] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[423.202467] Starting dynamic subtest: pipe-A-valid-mode
[425.098522] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.896s)
[425.099336] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SUCCESS (1.898s)
[425.261296] [130/156] (594s left) gem_ctx_exec (basic-invalid-context)
[425.299525] Starting subtest: basic-invalid-context
[425.301969] Subtest basic-invalid-context: SUCCESS (0.002s)
[425.416146] [131/156] (594s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-msflip-blt)
[425.511245] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-msflip-blt
[425.512631] Subtest fbcpsrhdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[425.607881] [132/156] (594s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[425.699835] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (0.000s)
[425.749475] [133/156] (594s left) gem_ppgtt (blt-vs-render-ctxn)
[425.787831] Starting subtest: blt-vs-render-ctxN
[458.438308] Subtest blt-vs-render-ctxN: SUCCESS (32.650s)
[458.545555] [134/156] (561s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[458.631763] Starting subtest: basic-gtt-cpu-noreloc
[458.635869] Subtest basic-gtt-cpu-noreloc: SUCCESS (0.004s)
[458.773160] [135/156] (561s left) gem_softpin (invalid)
[458.812801] Starting subtest: invalid
[458.817343] Subtest invalid: SUCCESS (0.005s)
[458.936128] [136/156] (561s left) gem_exec_capture (capture)
[458.976451] Starting subtest: capture
[458.977161] Starting dynamic subtest: rcs0-smem
[460.251464] Dynamic subtest rcs0-smem: SUCCESS (1.275s)
[460.261643] Starting dynamic subtest: bcs0-smem
[461.531697] Dynamic subtest bcs0-smem: SUCCESS (1.274s)
[461.541301] Starting dynamic subtest: vcs0-smem
[462.803572] Dynamic subtest vcs0-smem: SUCCESS (1.268s)
[462.812827] Starting dynamic subtest: vcs1-smem
[464.075403] Dynamic subtest vcs1-smem: SUCCESS (1.275s)
[464.085069] Starting dynamic subtest: vecs0-smem
[465.347459] Dynamic subtest vecs0-smem: SUCCESS (1.268s)
[465.348335] Subtest capture: SUCCESS (6.366s)
[465.446233] [137/156] (554s left) gem_tiled_blits (basic)
[465.544866] Starting subtest: basic
[465.554690] Subtest basic: SUCCESS (0.011s)
[465.678008] [138/156] (554s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[465.829626] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[465.831094] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[465.912263] [139/156] (554s left) gem_mmap_offset (partial-remap)
[465.948485] Starting subtest: partial-remap
[465.949222] Starting dynamic subtest: smem0
[465.953858] Dynamic subtest smem0: SUCCESS (0.003s)
[465.954579] Subtest partial-remap: SUCCESS (0.004s)
[466.058576] [140/156] (554s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-blt)
[466.150524] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-blt
[466.151862] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[466.250231] [141/156] (554s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-blt)
[466.343987] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-blt
[466.345455] Subtest hdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[466.451621] [142/156] (553s left) i915_power (sanity)
[466.485535] Starting subtest: sanity
[470.506332] Subtest sanity: SUCCESS (4.012s)
[470.610267] [143/156] (549s left) gem_exec_schedule (preempt-queue)
[470.667513] Starting subtest: preempt-queue
[470.668336] Starting dynamic subtest: rcs0
[470.778484] Dynamic subtest rcs0: SUCCESS (0.109s)
[470.789138] Starting dynamic subtest: bcs0
[470.885384] Dynamic subtest bcs0: SUCCESS (0.107s)
[470.896232] Starting dynamic subtest: vcs0
[470.993063] Dynamic subtest vcs0: SUCCESS (0.107s)
[471.005000] Starting dynamic subtest: vcs1
[471.100874] Dynamic subtest vcs1: SUCCESS (0.106s)
[471.111427] Starting dynamic subtest: vecs0
[471.209931] Dynamic subtest vecs0: SUCCESS (0.108s)
[471.210696] Subtest preempt-queue: SUCCESS (0.543s)
[471.511289] [144/156] (548s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[471.604551] Starting subtest: cursorB-vs-flipA-legacy
[471.606946] Subtest cursorB-vs-flipA-legacy: SKIP (0.002s)
[471.663591] [145/156] (548s left) i915_pm_rps (reset)
[471.702150] Starting subtest: reset
[476.272104] Subtest reset: SUCCESS (4.541s)
[476.351626] [146/156] (544s left) kms_psr (fbc-psr-cursor-plane-onoff)
[476.444106] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s)
[476.492630] [147/156] (544s left) kms_setmode (clone-exclusive-crtc)
[476.527971] Starting subtest: clone-exclusive-crtc
[476.530108] Subtest clone-exclusive-crtc: SKIP (0.000s)
[476.604747] [148/156] (543s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[476.697215] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[476.698656] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[476.798536] [149/156] (543s left) kms_flip (flip-vs-rmfb)
[476.887392] Starting subtest: flip-vs-rmfb
[476.890288] Starting dynamic subtest: A-HDMI-A1
[484.615574] Dynamic subtest A-HDMI-A1: SUCCESS (7.728s)
[484.636035] Starting dynamic subtest: B-HDMI-A1
[492.286209] Dynamic subtest B-HDMI-A1: SUCCESS (7.668s)
[492.304704] Starting dynamic subtest: C-HDMI-A1
[499.949129] Dynamic subtest C-HDMI-A1: SUCCESS (7.656s)
[499.967248] Starting dynamic subtest: D-HDMI-A1
[507.611846] Dynamic subtest D-HDMI-A1: SUCCESS (7.658s)
[507.615546] Subtest flip-vs-rmfb: SUCCESS (30.725s)
[507.776218] [150/156] (512s left) gem_exec_whisper (basic-contexts-all)
[507.828297] Starting subtest: basic-contexts-all
[509.619321] Subtest basic-contexts-all: SUCCESS (1.789s)
[509.812300] [151/156] (510s left) dmabuf_sync_file (export-basic)
[509.855309] Starting subtest: export-basic
[509.856078] Subtest export-basic: SUCCESS (0.001s)
[509.918170] [152/156] (510s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[510.014931] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[510.016329] Subtest hdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[510.099625] [153/156] (510s left) gem_sync (basic-each)
[510.144397] Starting subtest: basic-each
[512.247892] Subtest basic-each: SUCCESS (2.103s)
[512.460194] [154/156] (508s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[512.551917] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[512.552670] Starting dynamic subtest: pipe-A-HDMI-A-1
[512.560546] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[512.574217] Starting dynamic subtest: pipe-B-HDMI-A-1
[512.581970] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[512.595031] Starting dynamic subtest: pipe-C-HDMI-A-1
[512.602538] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[512.611778] Starting dynamic subtest: pipe-D-HDMI-A-1
[512.619292] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[512.620680] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.007s)
[512.813433] [155/156] (508s left) syncobj_wait (multi-wait-for-submit-submitted)
[512.849805] Starting subtest: multi-wait-for-submit-submitted
[512.953105] Subtest multi-wait-for-submit-submitted: SUCCESS (0.104s)
[513.030584] [156/156] (507s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[513.123322] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt
[513.124858] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[513.205942] 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.