[140.781358] Initializing watchdogs
[140.781420]   /dev/watchdog0
[140.797332] [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]
[140.802891] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[140.805422] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[140.807721] [001/156] (960s left) kms_cursor_edge_walk (256x256-left-edge)
[140.907699] Starting subtest: 256x256-left-edge
[140.908431] Starting dynamic subtest: pipe-A-HDMI-A-1
[142.721357] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.813s)
[142.729138] Starting dynamic subtest: pipe-D-HDMI-A-1
[144.425986] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.703s)
[144.426798] Subtest 256x256-left-edge: SUCCESS (3.518s)
[144.555316] [002/156] (956s left) gem_mmap_wc (write-read)
[144.590112] Starting subtest: write-read
[144.592366] Subtest write-read: SUCCESS (0.003s)
[144.689744] [003/156] (956s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[144.781823] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[144.821647] [004/156] (956s left) kms_plane_multiple (2x-tiling-none)
[144.909744] Starting subtest: 2x-tiling-none
[144.911182] Subtest 2x-tiling-none: SKIP (0.000s)
[144.961432] [005/156] (956s left) kms_atomic (plane-invalid-params)
[145.054186] Starting subtest: plane-invalid-params
[145.056010] Starting dynamic subtest: pipe-A-HDMI-A-1
[145.228048] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.173s)
[145.228811] Subtest plane-invalid-params: SUCCESS (0.174s)
[145.392951] [006/156] (956s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[145.494417] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[146.089790] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (0.595s)
[146.234136] [007/156] (955s left) perf_pmu (busy-accuracy-98)
[146.273734] Starting subtest: busy-accuracy-98
[146.274489] Starting dynamic subtest: rcs0
[149.301645] Dynamic subtest rcs0: SUCCESS (3.024s)
[149.310347] Starting dynamic subtest: bcs0
[152.328835] Dynamic subtest bcs0: SUCCESS (3.026s)
[152.336832] Starting dynamic subtest: vcs0
[155.355420] Dynamic subtest vcs0: SUCCESS (3.025s)
[155.362522] Starting dynamic subtest: vcs1
[158.380261] Dynamic subtest vcs1: SUCCESS (3.026s)
[158.388469] Starting dynamic subtest: vecs0
[161.404823] Dynamic subtest vecs0: SUCCESS (3.024s)
[161.405885] Subtest busy-accuracy-98: SUCCESS (15.127s)
[161.467742] [008/156] (940s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[161.562340] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[161.563709] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[161.662466] [009/156] (939s left) gem_exec_schedule (u-lateslice)
[161.704569] Starting subtest: u-lateslice
[161.705293] Starting dynamic subtest: rcs0
[161.721058] Dynamic subtest rcs0: SUCCESS (0.016s)
[161.728604] Starting dynamic subtest: bcs0
[161.735990] Dynamic subtest bcs0: SUCCESS (0.015s)
[161.744215] Starting dynamic subtest: vcs0
[161.751988] Dynamic subtest vcs0: SUCCESS (0.016s)
[161.759772] Starting dynamic subtest: vcs1
[161.766034] Dynamic subtest vcs1: SUCCESS (0.014s)
[161.773069] Starting dynamic subtest: vecs0
[161.781941] Dynamic subtest vecs0: SUCCESS (0.016s)
[161.782841] Subtest u-lateslice: SUCCESS (0.077s)
[162.098471] [010/156] (939s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-blt)
[162.190398] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-blt
[162.191878] Subtest hdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[162.284803] [011/156] (939s left) gem_softpin (softpin)
[162.325729] Starting subtest: softpin
[194.590746] Subtest softpin: SUCCESS (32.254s)
[194.748589] [012/156] (907s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[194.842096] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[194.843564] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[194.933103] [013/156] (906s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[195.026122] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu
[195.027500] Subtest psrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[195.116562] [014/156] (906s left) kms_flip (blocking-wf_vblank)
[195.204359] Starting subtest: blocking-wf_vblank
[195.206077] Starting dynamic subtest: A-HDMI-A1
[203.051219] Dynamic subtest A-HDMI-A1: SUCCESS (7.826s)
[203.058008] Starting dynamic subtest: B-HDMI-A1
[210.867185] Dynamic subtest B-HDMI-A1: SUCCESS (7.805s)
[210.873942] Starting dynamic subtest: C-HDMI-A1
[218.678066] Dynamic subtest C-HDMI-A1: SUCCESS (7.809s)
[218.685172] Starting dynamic subtest: D-HDMI-A1
[226.465166] Dynamic subtest D-HDMI-A1: SUCCESS (7.810s)
[226.465889] Subtest blocking-wf_vblank: SUCCESS (31.260s)
[226.613761] [015/156] (875s left) kms_plane_alpha_blend (alpha-7efc)
[226.707604] Starting subtest: alpha-7efc
[226.773887] Starting dynamic subtest: pipe-A-HDMI-A-1
[227.078769] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.305s)
[227.109171] Starting dynamic subtest: pipe-D-HDMI-A-1
[227.566933] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.464s)
[227.567726] Subtest alpha-7efc: SUCCESS (0.860s)
[227.740578] [016/156] (874s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[227.844770] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[227.846139] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[227.940890] [017/156] (874s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[228.039808] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[228.362813] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.323s)
[228.493876] [018/156] (873s left) i915_pm_rps (basic-api)
[228.532996] Starting subtest: basic-api
[228.535445] Subtest basic-api: SUCCESS (0.002s)
[228.612901] [019/156] (873s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-blt)
[228.707224] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-blt
[228.708658] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[228.809313] [020/156] (873s left) gem_mmap_offset (isolation)
[228.843206] Starting subtest: isolation
[228.850410] Subtest isolation: SUCCESS (0.006s)
[228.950621] [021/156] (873s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[229.049996] Starting subtest: yf-tiled-addfb-size-offset-overflow
[229.051424] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[229.141826] [022/156] (873s left) gem_userptr_blits (coherency-sync)
[229.187488] Starting subtest: coherency-sync
[229.516519] Subtest coherency-sync: SKIP (0.314s)
[229.632539] [023/156] (872s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[229.770486] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[229.771870] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[229.928445] [024/156] (872s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-pgflip-blt)
[230.027493] Starting subtest: psrhdr-2p-scndscrn-shrfb-pgflip-blt
[230.028964] Subtest psrhdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[230.132812] [025/156] (872s left) sw_sync (sync_busy_fork_unixsocket)
[230.172826] Starting subtest: sync_busy_fork_unixsocket
[230.181224] Subtest sync_busy_fork_unixsocket: SUCCESS (0.008s)
[230.241481] [026/156] (872s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[230.726627] Starting subtest: syncobj-timeline-invalid-flags
[230.727801] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.002s)
[230.897722] [FACT gem_exec_fence (syncobj-timeline-invalid-flags)] new: kernel.kmod_is_loaded.vgem: true
[230.901256] [027/156] (871s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-indfb-msflip-blt)
[230.994341] Starting subtest: psrhdr-2p-scndscrn-indfb-msflip-blt
[230.995725] Subtest psrhdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[231.082375] [028/156] (871s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[231.172805] Starting subtest: short-busy-flip-before-cursor-toggle
[231.174201] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[231.236540] [029/156] (871s left) kms_frontbuffer_tracking (hdr-2p-primscrn-indfb-plflip-blt)
[231.329476] Starting subtest: hdr-2p-primscrn-indfb-plflip-blt
[231.330945] Subtest hdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[231.422867] [030/156] (871s left) gem_mmap_gtt (basic-write-read-distinct)
[231.456993] Starting subtest: basic-write-read-distinct
[231.460456] Subtest basic-write-read-distinct: SUCCESS (0.004s)
[231.554471] [031/156] (870s left) i915_suspend (fence-restore-untiled)
[231.587431] Starting subtest: fence-restore-untiled
[251.462171] Subtest fence-restore-untiled: SUCCESS (5.319s)
[256.579886] [032/156] (851s left) dmabuf (all-tests)
[256.624209] Starting subtest: all-tests
[256.625649] Subtest all-tests: SKIP (0.000s)
[256.685133] [033/156] (850s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[256.781090] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc
[256.782599] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[256.889358] [034/156] (850s left) kms_lease (empty-lease)
[256.979311] Starting subtest: empty-lease
[256.980019] Starting dynamic subtest: pipe-A-HDMI-A-1
[256.980761] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[256.991303] Starting dynamic subtest: pipe-B-HDMI-A-1
[256.992108] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[257.000732] Starting dynamic subtest: pipe-C-HDMI-A-1
[257.001548] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[257.010204] Starting dynamic subtest: pipe-D-HDMI-A-1
[257.010960] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[257.011663] Subtest empty-lease: SUCCESS (0.010s)
[257.068474] [035/156] (850s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[257.160214] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[257.160913] Starting dynamic subtest: pipe-A-HDMI-A-1
[257.167715] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[257.176482] Starting dynamic subtest: pipe-B-HDMI-A-1
[257.183320] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[257.191811] Starting dynamic subtest: pipe-C-HDMI-A-1
[257.198611] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[257.207156] Starting dynamic subtest: pipe-D-HDMI-A-1
[257.214316] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[257.215802] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SKIP (0.005s)
[257.417956] [036/156] (850s left) kms_lease (master-vs-lease)
[257.515284] Starting subtest: master-vs-lease
[257.516082] Subtest master-vs-lease: SUCCESS (0.001s)
[257.576105] [037/156] (850s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[257.669804] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-mmap-cpu
[257.671226] Subtest fbchdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[257.778811] [038/156] (850s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[257.870511] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[257.871329] Starting dynamic subtest: pipe-A-valid-mode
[259.878400] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.951s)
[259.879151] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SUCCESS (1.953s)
[260.040220] [039/156] (847s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[260.136331] Starting subtest: primary-yf-tiled-reflect-x-90
[260.189848] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.051s)
[260.280458] [040/156] (847s left) gem_userptr_blits (usage-restrictions)
[260.321414] Starting subtest: usage-restrictions
[260.322154] Subtest usage-restrictions: SUCCESS (0.000s)
[260.452098] [041/156] (847s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[260.544961] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[260.546404] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[260.636060] [042/156] (847s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite)
[260.730581] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite
[260.732069] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[260.826910] [043/156] (847s left) kms_psr (fbc-pr-primary-mmap-cpu)
[260.917040] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[260.962051] [044/156] (847s left) kms_hdr (bpc-switch-suspend)
[261.052398] Starting subtest: bpc-switch-suspend
[261.053999] Starting dynamic subtest: pipe-A-HDMI-A-1-XRGB2101010
[261.055414] Dynamic subtest pipe-A-HDMI-A-1-XRGB2101010: SKIP (0.000s)
[261.064310] Starting dynamic subtest: pipe-A-HDMI-A-1-XRGB16161616F
[261.065717] Dynamic subtest pipe-A-HDMI-A-1-XRGB16161616F: SKIP (0.000s)
[261.067118] Subtest bpc-switch-suspend: SKIP (0.003s)
[261.136706] [045/156] (846s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-blt)
[261.231611] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-blt
[261.233077] Subtest hdr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[261.319759] [046/156] (846s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[261.409653] Starting subtest: plane-ctm3x4-lut1d
[261.492378] Starting dynamic subtest: pipe-A-plane-0
[261.593436] Dynamic subtest pipe-A-plane-0: SUCCESS (0.099s)
[261.604777] Starting dynamic subtest: pipe-A-plane-1
[261.687612] Dynamic subtest pipe-A-plane-1: SUCCESS (0.091s)
[261.703656] Starting dynamic subtest: pipe-A-plane-2
[261.781099] Dynamic subtest pipe-A-plane-2: SUCCESS (0.090s)
[261.992852] Starting dynamic subtest: pipe-B-plane-0
[262.075735] Dynamic subtest pipe-B-plane-0: SUCCESS (0.092s)
[262.093508] Starting dynamic subtest: pipe-B-plane-1
[262.177139] Dynamic subtest pipe-B-plane-1: SUCCESS (0.098s)
[262.193307] Starting dynamic subtest: pipe-B-plane-2
[262.272933] Dynamic subtest pipe-B-plane-2: SUCCESS (0.090s)
[262.505568] Starting dynamic subtest: pipe-C-plane-0
[262.591190] Dynamic subtest pipe-C-plane-0: SUCCESS (0.092s)
[262.606626] Starting dynamic subtest: pipe-C-plane-1
[262.684608] Dynamic subtest pipe-C-plane-1: SUCCESS (0.090s)
[262.700645] Starting dynamic subtest: pipe-C-plane-2
[262.798058] Dynamic subtest pipe-C-plane-2: SUCCESS (0.107s)
[263.020141] Starting dynamic subtest: pipe-D-plane-0
[263.105707] Dynamic subtest pipe-D-plane-0: SUCCESS (0.092s)
[263.119773] Starting dynamic subtest: pipe-D-plane-1
[263.207319] Dynamic subtest pipe-D-plane-1: SUCCESS (0.099s)
[263.220644] Starting dynamic subtest: pipe-D-plane-2
[263.309019] Dynamic subtest pipe-D-plane-2: SUCCESS (0.099s)
[263.359931] Subtest plane-ctm3x4-lut1d: SUCCESS (1.916s)
[263.479190] [047/156] (844s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-onoff)
[263.581396] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-onoff
[263.582828] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[263.682868] [048/156] (844s left) syncobj_wait (invalid-reset-illegal-handle)
[263.717220] Starting subtest: invalid-reset-illegal-handle
[263.717991] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[263.789574] [049/156] (844s left) kms_cursor_crc (cursor-random-256x256)
[263.883087] Starting subtest: cursor-random-256x256
[263.887237] Starting dynamic subtest: pipe-A-HDMI-A-1
[265.830109] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.917s)
[265.870765] Starting dynamic subtest: pipe-D-HDMI-A-1
[267.767339] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.888s)
[267.768059] Subtest cursor-random-256x256: SUCCESS (3.840s)
[267.957250] [050/156] (840s left) gem_mmap_gtt (bad-object)
[267.994061] Starting subtest: bad-object
[267.994774] Subtest bad-object: SUCCESS (0.000s)
[268.089435] [051/156] (840s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[268.193486] Starting subtest: y-tiled-64bpp-rotate-270
[268.235660] Subtest y-tiled-64bpp-rotate-270: SKIP (0.041s)
[268.332696] [052/156] (840s left) kms_force_connector_basic (force-load-detect)
[268.460384] Starting subtest: force-load-detect
[268.465943] Subtest force-load-detect: SKIP (0.000s)
[268.616262] [053/156] (839s left) kms_fb_coherency (memset-crc)
[268.707344] Starting subtest: memset-crc
[268.708068] Starting dynamic subtest: mmap-gtt
[268.950416] Dynamic subtest mmap-gtt: SUCCESS (0.240s)
[269.027718] Starting dynamic subtest: mmap-offset-wc
[269.248883] Dynamic subtest mmap-offset-wc: SUCCESS (0.228s)
[269.327012] Starting dynamic subtest: mmap-offset-uc
[269.901219] Dynamic subtest mmap-offset-uc: SUCCESS (0.578s)
[269.971683] Starting dynamic subtest: mmap-legacy-wc
[270.181788] Dynamic subtest mmap-legacy-wc: SUCCESS (0.218s)
[270.248431] Subtest memset-crc: SUCCESS (1.530s)
[270.417448] [054/156] (838s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[270.517127] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[270.518574] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[270.609709] [055/156] (837s left) kms_vblank (ts-continuation-idle)
[270.698404] Starting subtest: ts-continuation-idle
[270.699114] Starting dynamic subtest: pipe-A-HDMI-A-1
[270.868541] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.168s)
[270.881208] Starting dynamic subtest: pipe-D-HDMI-A-1
[271.033425] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.159s)
[271.034280] Subtest ts-continuation-idle: SUCCESS (0.334s)
[271.183451] [056/156] (837s left) kms_chamelium_color (ctm-0-50)
[271.276396] Subtest ctm-0-50: SKIP (0.000s)
[271.319677] [057/156] (837s left) gem_mmap_wc (bad-size)
[271.355645] Starting subtest: bad-size
[271.356480] Subtest bad-size: SUCCESS (0.001s)
[271.464336] [058/156] (837s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[271.557906] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[271.559271] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[271.653226] [059/156] (837s left) kms_flip (2x-flip-vs-modeset)
[271.741087] Starting subtest: 2x-flip-vs-modeset
[271.750303] Subtest 2x-flip-vs-modeset: SKIP (0.009s)
[271.833398] [060/156] (836s left) kms_async_flips (async-flip-hang)
[271.921561] Starting subtest: async-flip-hang
[272.057423] Starting dynamic subtest: pipe-A-HDMI-A-1
[287.055181] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (14.925s)
[287.162296] Starting dynamic subtest: pipe-B-HDMI-A-1
[302.387794] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (15.219s)
[302.507585] Starting dynamic subtest: pipe-C-HDMI-A-1
[317.262182] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (14.730s)
[317.355294] Starting dynamic subtest: pipe-D-HDMI-A-1
[332.109702] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (14.724s)
[332.110480] Subtest async-flip-hang: SUCCESS (60.106s)
[332.320540] [061/156] (776s left) gem_wait (busy)
[332.370419] Starting subtest: busy
[332.371663] Starting dynamic subtest: all-engines
[332.901674] Dynamic subtest all-engines: SUCCESS (0.530s)
[332.910566] Starting dynamic subtest: rcs0
[333.423510] Dynamic subtest rcs0: SUCCESS (0.521s)
[333.432091] Starting dynamic subtest: bcs0
[333.938384] Dynamic subtest bcs0: SUCCESS (0.514s)
[333.947943] Starting dynamic subtest: vcs0
[334.455550] Dynamic subtest vcs0: SUCCESS (0.516s)
[334.464157] Starting dynamic subtest: vcs1
[334.971518] Dynamic subtest vcs1: SUCCESS (0.515s)
[334.980219] Starting dynamic subtest: vecs0
[335.484478] Dynamic subtest vecs0: SUCCESS (0.511s)
[335.485192] Subtest busy: SUCCESS (3.113s)
[335.677151] [062/156] (773s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[335.771966] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[337.430141] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SUCCESS (1.658s)
[337.562204] [063/156] (771s left) gem_mmap_wc (write-gtt-read-wc)
[337.596498] Starting subtest: write-gtt-read-wc
[337.912581] Subtest write-gtt-read-wc: SUCCESS (0.307s)
[337.996451] [064/156] (770s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt)
[338.089853] Starting subtest: fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt
[338.091290] Subtest fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[338.189758] [065/156] (770s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-shrfb-plflip-blt)
[338.281982] Starting subtest: fbchdr-2p-primscrn-shrfb-plflip-blt
[338.283378] Subtest fbchdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[338.393229] [066/156] (770s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[338.426505] Starting subtest: basic-write-cpu-read-gtt
[338.661479] Subtest basic-write-cpu-read-gtt: SUCCESS (0.226s)
[338.738483] [067/156] (770s left) gem_userptr_blits (create-destroy-unsync)
[338.778772] Subtest create-destroy-unsync: SKIP (0.000s)
[338.909334] [068/156] (770s left) gem_exec_balancer (sliced)
[338.954432] Starting subtest: sliced
[340.444384] Subtest sliced: SUCCESS (1.481s)
[340.626916] [069/156] (768s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[340.721091] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[340.722543] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[340.822591] [070/156] (768s left) syncobj_eventfd (binary-wait)
[340.858354] Starting subtest: binary-wait
[340.868216] Subtest binary-wait: SUCCESS (0.010s)
[340.928601] [071/156] (768s left) kms_pm_backlight (fade)
[341.017354] Subtest fade: SKIP (0.000s)
[341.065409] [072/156] (768s left) kms_vblank (query-forked-hang)
[341.154569] Starting subtest: query-forked-hang
[341.155270] Starting dynamic subtest: pipe-A-HDMI-A-1
[355.170723] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (14.010s)
[355.182479] Starting dynamic subtest: pipe-D-HDMI-A-1
[368.982583] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (13.810s)
[368.983420] Subtest query-forked-hang: SUCCESS (27.825s)
[369.151749] [073/156] (740s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[369.256461] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[369.257882] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[369.342586] [074/156] (739s left) kms_pm_rpm (cursor-dpms)
[370.746810] Starting subtest: cursor-dpms
[382.666601] Subtest cursor-dpms: SUCCESS (11.924s)
[382.886279] [075/156] (726s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[382.983582] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[382.985023] Subtest hdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[383.084835] [076/156] (726s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[383.227512] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[383.325692] [077/156] (726s left) gen9_exec_parse (allowed-all)
[383.370116] Subtest allowed-all: SKIP (0.000s)
[383.415068] [078/156] (726s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[384.808713] Starting subtest: modeset-non-lpsp-stress-no-wait
[384.901139] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.093s)
[385.025033] [079/156] (724s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[385.120002] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[385.121416] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[385.226322] [080/156] (724s left) gem_exec_balancer (invalid-balancer)
[385.268309] Starting subtest: invalid-balancer
[386.598432] Subtest invalid-balancer: SUCCESS (1.322s)
[386.780090] [081/156] (722s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[386.818111] Starting subtest: saturated-hostile-nopreempt
[386.818909] Starting dynamic subtest: rcs0
[387.557828] Dynamic subtest rcs0: SUCCESS (0.733s)
[387.569743] Starting dynamic subtest: bcs0
[388.310218] Dynamic subtest bcs0: SUCCESS (0.748s)
[388.322091] Starting dynamic subtest: vcs0
[389.076954] Dynamic subtest vcs0: SUCCESS (0.766s)
[389.088074] Starting dynamic subtest: vcs1
[389.822898] Dynamic subtest vcs1: SUCCESS (0.742s)
[389.834550] Starting dynamic subtest: vecs0
[390.577021] Dynamic subtest vecs0: SUCCESS (0.750s)
[390.577943] Subtest saturated-hostile-nopreempt: SUCCESS (3.752s)
[390.686408] [082/156] (718s left) syncobj_wait (single-wait-all-submitted)
[390.721095] Starting subtest: single-wait-all-submitted
[390.829293] Subtest single-wait-all-submitted: SUCCESS (0.104s)
[390.910170] [083/156] (718s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[391.000517] Starting subtest: bad-aux-stride-y-tiled-ccs
[391.001253] Starting dynamic subtest: pipe-A-HDMI-A-1
[391.007917] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[391.016801] Starting dynamic subtest: pipe-B-HDMI-A-1
[391.023561] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[391.032433] Starting dynamic subtest: pipe-C-HDMI-A-1
[391.039145] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[391.047683] Starting dynamic subtest: pipe-D-HDMI-A-1
[391.054581] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[391.055965] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.006s)
[391.252833] [084/156] (718s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[391.290714] Starting subtest: single-wait-for-submit-available-signaled
[391.291506] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.001s)
[391.372922] [085/156] (718s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-blt)
[391.464940] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-blt
[391.466455] Subtest psrhdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[391.566456] [086/156] (718s left) i915_pm_freq_api (freq-reset-multiple)
[391.604066] Subtest freq-reset-multiple: SKIP (0.000s)
[391.648197] [087/156] (718s left) gem_exec_reloc (basic-cpu-wc)
[391.686812] Starting subtest: basic-cpu-wc
[391.691871] Subtest basic-cpu-wc: SUCCESS (0.005s)
[391.810777] [088/156] (718s left) kms_plane (pixel-format-y-tiled-modifier)
[391.898721] Starting subtest: pixel-format-y-tiled-modifier
[391.914813] Starting dynamic subtest: pipe-A-plane-0
[392.197945] Dynamic subtest pipe-A-plane-0: SUCCESS (0.283s)
[392.218028] Starting dynamic subtest: pipe-A-plane-3
[392.448040] Dynamic subtest pipe-A-plane-3: SUCCESS (0.248s)
[392.465817] Starting dynamic subtest: pipe-A-plane-5
[392.689745] Dynamic subtest pipe-A-plane-5: SUCCESS (0.239s)
[392.708394] Starting dynamic subtest: pipe-A-plane-7
[392.709795] Dynamic subtest pipe-A-plane-7: SKIP (0.000s)
[392.842204] Starting dynamic subtest: pipe-B-plane-0
[393.083701] Dynamic subtest pipe-B-plane-0: SUCCESS (0.250s)
[393.100905] Starting dynamic subtest: pipe-B-plane-3
[393.317014] Dynamic subtest pipe-B-plane-3: SUCCESS (0.230s)
[393.337577] Starting dynamic subtest: pipe-B-plane-5
[393.550476] Dynamic subtest pipe-B-plane-5: SUCCESS (0.231s)
[393.570486] Starting dynamic subtest: pipe-B-plane-7
[393.571979] Dynamic subtest pipe-B-plane-7: SKIP (0.000s)
[393.609059] Subtest pixel-format-y-tiled-modifier: SUCCESS (1.710s)
[393.773485] [089/156] (716s left) gem_gpgpu_fill (offset-16x16)
[393.811251] Starting subtest: offset-16x16
[393.815440] Subtest offset-16x16: SUCCESS (0.004s)
[393.934956] [090/156] (716s left) gem_exec_schedule (noreorder-corked)
[394.104863] Starting subtest: noreorder-corked
[394.105746] Starting dynamic subtest: rcs0
[395.221147] Dynamic subtest rcs0: SUCCESS (1.117s)
[395.233305] Starting dynamic subtest: bcs0
[396.331989] Dynamic subtest bcs0: SUCCESS (1.108s)
[396.344055] Starting dynamic subtest: vcs0
[397.455279] Dynamic subtest vcs0: SUCCESS (1.121s)
[397.467883] Starting dynamic subtest: vcs1
[398.573225] Dynamic subtest vcs1: SUCCESS (1.115s)
[398.585778] Starting dynamic subtest: vecs0
[399.687008] Dynamic subtest vecs0: SUCCESS (1.111s)
[399.688062] Subtest noreorder-corked: SUCCESS (5.585s)
[399.871626] [091/156] (710s left) gem_ctx_param (invalid-size-get)
[399.905840] Starting subtest: invalid-size-get
[399.906578] Subtest invalid-size-get: SUCCESS (0.000s)
[399.978580] [092/156] (710s left) gem_spin_batch (resubmit)
[400.024343] Starting subtest: resubmit
[400.025065] Starting dynamic subtest: rcs0
[400.026896] Dynamic subtest rcs0: SUCCESS (0.002s)
[400.037696] Starting dynamic subtest: bcs0
[400.038419] Dynamic subtest bcs0: SUCCESS (0.002s)
[400.047362] Starting dynamic subtest: vcs0
[400.048095] Dynamic subtest vcs0: SUCCESS (0.002s)
[400.056875] Starting dynamic subtest: vcs1
[400.057571] Dynamic subtest vcs1: SUCCESS (0.002s)
[400.065892] Starting dynamic subtest: vecs0
[400.066604] Dynamic subtest vecs0: SUCCESS (0.002s)
[400.067303] Subtest resubmit: SUCCESS (0.015s)
[400.221243] [093/156] (709s left) kms_psr (psr2-sprite-blt)
[400.311842] Subtest psr2-sprite-blt: SKIP (0.000s)
[400.361601] [094/156] (709s left) api_intel_allocator (simple-allocator)
[400.396764] Starting subtest: simple-allocator
[400.397517] Starting dynamic subtest: basic
[400.398331] Dynamic subtest basic: SUCCESS (0.002s)
[400.407887] Starting dynamic subtest: parallel-one
[400.585417] Dynamic subtest parallel-one: SUCCESS (0.178s)
[400.594742] Starting dynamic subtest: print
[400.595598] Dynamic subtest print: SUCCESS (0.000s)
[400.605028] Starting dynamic subtest: reuse
[400.605718] Dynamic subtest reuse: SUCCESS (0.000s)
[400.614228] Starting dynamic subtest: reserve
[400.614915] Dynamic subtest reserve: SUCCESS (0.000s)
[400.623231] Starting dynamic subtest: fork-reopen-allocator
[400.623916] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s)
[400.624595] Subtest simple-allocator: SUCCESS (0.198s)
[400.661771] [095/156] (709s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[400.754473] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[402.159433] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (1.405s)
[402.287836] [096/156] (707s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-blt)
[402.382945] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-blt
[402.384330] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[402.483285] [097/156] (707s left) kms_addfb_basic (bad-pitch-256)
[402.518021] Starting subtest: bad-pitch-256
[402.518800] Subtest bad-pitch-256: SUCCESS (0.000s)
[402.652684] [098/156] (707s left) gem_exec_params (no-bsd)
[402.693406] Starting subtest: no-bsd
[402.694228] Subtest no-bsd: SUCCESS (0.001s)
[402.800855] [099/156] (707s left) prime_mmap (test_dup)
[402.836043] Starting subtest: test_dup
[402.836769] Starting dynamic subtest: test_dup-smem
[402.837459] Dynamic subtest test_dup-smem: SUCCESS (0.002s)
[402.838205] Subtest test_dup: SUCCESS (0.002s)
[402.940445] [100/156] (707s left) gem_exec_whisper (basic-normal-all)
[402.986483] Starting subtest: basic-normal-all
[404.150424] Subtest basic-normal-all: SUCCESS (1.164s)
[404.346104] [101/156] (706s left) perf (polling-parameterized)
[404.435925] Starting subtest: polling-parameterized
[424.488426] Subtest polling-parameterized: SUCCESS (20.016s)
[424.553288] [102/156] (685s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[424.647635] Starting subtest: primary-4-tiled-reflect-x-180
[424.699828] Subtest primary-4-tiled-reflect-x-180: SKIP (0.051s)
[424.800278] [103/156] (685s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[424.840215] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[424.840961] Starting dynamic subtest: smem
[424.962728] Dynamic subtest smem: SUCCESS (0.113s)
[424.963483] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SUCCESS (0.114s)
[425.151446] [104/156] (685s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[425.241243] Starting subtest: cursor-vs-flip-toggle
[457.203631] Subtest cursor-vs-flip-toggle: SUCCESS (31.954s)
[457.351480] [105/156] (653s left) kms_flip (2x-dpms-vs-vblank-race)
[457.446363] Starting subtest: 2x-dpms-vs-vblank-race
[457.455201] Subtest 2x-dpms-vs-vblank-race: SKIP (0.009s)
[457.559666] [106/156] (653s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[457.595001] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[457.699254] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.103s)
[457.779490] [107/156] (652s left) gem_exec_params (readonly)
[457.816564] Starting subtest: readonly
[457.817459] Subtest readonly: SUCCESS (0.001s)
[457.929425] [108/156] (652s left) kms_content_protection (mei-interface)
[458.023302] Starting subtest: mei-interface
[458.028892] Subtest mei-interface: SKIP (0.005s)
[458.126794] [109/156] (652s left) gem_mmap_wc (close)
[458.160769] Starting subtest: close
[458.163495] Subtest close: SUCCESS (0.003s)
[458.260594] [110/156] (652s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-render)
[458.351726] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-render
[458.353094] Subtest hdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[458.452803] [111/156] (652s left) kms_getfb (getfb-handle-valid)
[458.540581] Starting subtest: getfb-handle-valid
[458.541354] Subtest getfb-handle-valid: SUCCESS (0.000s)
[458.654644] [112/156] (652s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-pwrite)
[458.748264] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-pwrite
[458.749727] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[458.854704] [113/156] (652s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-pwrite)
[458.947015] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-pwrite
[458.948430] Subtest hdr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[459.055800] [114/156] (652s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[459.143789] Starting subtest: plane-scaler-unity-scaling-with-rotation
[459.144497] Starting dynamic subtest: pipe-A
[460.252593] Dynamic subtest pipe-A: SKIP (1.106s)
[460.261842] Starting dynamic subtest: pipe-B
[461.432096] Dynamic subtest pipe-B: SKIP (1.175s)
[461.442539] Starting dynamic subtest: pipe-C
[462.598292] Dynamic subtest pipe-C: SKIP (1.168s)
[462.607643] Starting dynamic subtest: pipe-D
[463.803363] Dynamic subtest pipe-D: SKIP (1.204s)
[463.804809] Subtest plane-scaler-unity-scaling-with-rotation: SKIP (4.657s)
[463.984967] [115/156] (647s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[464.083605] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[464.084314] Starting dynamic subtest: pipe-A-valid-mode
[464.904922] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.820s)
[464.905692] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SUCCESS (0.821s)
[465.058845] [116/156] (646s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[465.155896] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[465.157385] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[465.259384] [117/156] (645s left) kms_psr (psr2-cursor-plane-move)
[465.348198] Subtest psr2-cursor-plane-move: SKIP (0.000s)
[465.392919] [118/156] (645s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[465.490472] Starting subtest: x-tiled-64bpp-rotate-270
[465.532307] Subtest x-tiled-64bpp-rotate-270: SKIP (0.041s)
[465.647018] [119/156] (645s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[465.737894] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[465.784343] [120/156] (645s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[465.877807] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[465.879351] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[465.979357] [121/156] (645s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[466.073277] Starting subtest: psr-rgb565-draw-mmap-gtt
[466.074681] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[466.172101] [122/156] (645s left) kms_psr (fbc-psr2-cursor-render)
[466.262276] Subtest fbc-psr2-cursor-render: SKIP (0.000s)
[466.309715] [123/156] (645s left) kms_frontbuffer_tracking (fbc-2p-rte)
[466.403671] Starting subtest: fbc-2p-rte
[466.405094] Subtest fbc-2p-rte: SKIP (0.000s)
[466.505352] [124/156] (645s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[466.599225] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[466.600607] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[466.709507] [125/156] (644s left) syncobj_timeline (multi-wait-available-submitted)
[466.746261] Starting subtest: multi-wait-available-submitted
[466.747001] Subtest multi-wait-available-submitted: SUCCESS (0.001s)
[466.807242] [126/156] (644s left) kms_hdmi_inject (inject-4k)
[466.893705] Starting subtest: inject-4k
[467.124936] Subtest inject-4k: SUCCESS (0.230s)
[467.286169] [127/156] (644s left) syncobj_timeline (multi-wait-for-submit-signaled)
[467.322048] Starting subtest: multi-wait-for-submit-signaled
[467.322770] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[467.387115] [128/156] (644s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[467.474632] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[467.476453] Starting dynamic subtest: pipe-A-HDMI-A-1
[467.483968] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[467.493471] Starting dynamic subtest: pipe-B-HDMI-A-1
[467.501425] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[467.513872] Starting dynamic subtest: pipe-C-HDMI-A-1
[467.521749] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[467.530546] Starting dynamic subtest: pipe-D-HDMI-A-1
[467.538376] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[467.539774] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.007s)
[467.733647] [129/156] (643s left) vgem_basic (dmabuf-mmap)
[467.771110] Starting subtest: dmabuf-mmap
[467.794126] Subtest dmabuf-mmap: SUCCESS (0.024s)
[467.851983] [130/156] (643s left) kms_flip (flip-vs-rmfb)
[467.939226] Starting subtest: flip-vs-rmfb
[467.941643] Starting dynamic subtest: A-HDMI-A1
[475.615874] Dynamic subtest A-HDMI-A1: SUCCESS (7.672s)
[475.632492] Starting dynamic subtest: B-HDMI-A1
[483.294917] Dynamic subtest B-HDMI-A1: SUCCESS (7.673s)
[483.316082] Starting dynamic subtest: C-HDMI-A1
[490.968188] Dynamic subtest C-HDMI-A1: SUCCESS (7.667s)
[490.983006] Starting dynamic subtest: D-HDMI-A1
[498.657517] Dynamic subtest D-HDMI-A1: SUCCESS (7.688s)
[498.663069] Subtest flip-vs-rmfb: SUCCESS (30.721s)
[498.831325] [131/156] (612s left) kms_addfb_basic (clobberred-modifier)
[498.871840] Starting subtest: clobberred-modifier
[498.872586] Subtest clobberred-modifier: SUCCESS (0.000s)
[499.017467] [132/156] (612s left) core_getclient (basic)
[499.051197] Starting subtest: basic
[499.051934] Subtest basic: SUCCESS (0.000s)
[499.113374] [133/156] (612s left) gem_exec_balancer (bonded-chain)
[499.156155] Starting subtest: bonded-chain
[506.541819] Subtest bonded-chain: SUCCESS (7.379s)
[506.728384] [134/156] (605s left) gem_eio (in-flight-10ms)
[506.772881] Starting subtest: in-flight-10ms
[509.113669] Subtest in-flight-10ms: SUCCESS (2.341s)
[509.237289] [135/156] (602s left) gem_bad_reloc (negative-reloc-lut)
[509.277582] Starting subtest: negative-reloc-lut
[509.279835] Subtest negative-reloc-lut: SUCCESS (0.000s)
[509.401709] [136/156] (602s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[509.496820] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[509.498327] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[509.600777] [137/156] (602s left) i915_drm_fdinfo (most-busy-idle-check-all)
[509.639568] Starting subtest: most-busy-idle-check-all
[509.640355] Starting dynamic subtest: rcs0
[510.294026] Dynamic subtest rcs0: SUCCESS (0.654s)
[510.307330] Starting dynamic subtest: bcs0
[510.932322] Dynamic subtest bcs0: SUCCESS (0.636s)
[510.946582] Starting dynamic subtest: vcs0
[511.565804] Dynamic subtest vcs0: SUCCESS (0.631s)
[511.578496] Starting dynamic subtest: vcs1
[512.196875] Dynamic subtest vcs1: SUCCESS (0.629s)
[512.210849] Starting dynamic subtest: vecs0
[512.834019] Dynamic subtest vecs0: SUCCESS (0.636s)
[512.837884] Subtest most-busy-idle-check-all: SUCCESS (3.196s)
[512.920606] [138/156] (599s left) prime_self_import (reimport-vs-gem_close-race)
[512.953966] Starting subtest: reimport-vs-gem_close-race
[517.997376] Subtest reimport-vs-gem_close-race: SUCCESS (5.044s)
[518.104434] [139/156] (594s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[518.196414] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.000s)
[518.240990] [140/156] (593s left) kms_chamelium_color (degamma)
[518.332596] Subtest degamma: SKIP (0.000s)
[518.382494] [141/156] (593s left) kms_cursor_crc (cursor-onscreen-max-size)
[518.478668] Starting subtest: cursor-onscreen-max-size
[518.480906] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[518.581838] [142/156] (593s left) gem_mmap_gtt (big-bo-tiledy)
[518.615924] Starting subtest: big-bo-tiledY
[518.896805] Subtest big-bo-tiledY: SUCCESS (0.281s)
[519.004487] [143/156] (593s left) gem_mmap_gtt (medium-copy-odd)
[519.096766] Starting subtest: medium-copy-odd
[522.566800] Subtest medium-copy-odd: SUCCESS (3.470s)
[522.659585] [144/156] (589s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[522.807622] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[522.809089] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[522.914087] [145/156] (589s left) gem_render_copy (linear-to-vebox-yf-tiled)
[522.953974] Starting subtest: linear-to-vebox-yf-tiled
[522.954730] Starting dynamic subtest: smem
[523.023177] Dynamic subtest smem: SUCCESS (0.069s)
[523.024197] Subtest linear-to-vebox-yf-tiled: SUCCESS (0.070s)
[523.255633] [146/156] (589s left) kms_addfb_basic (invalid-set-prop)
[523.290448] Starting subtest: invalid-set-prop
[523.291150] Subtest invalid-set-prop: SUCCESS (0.000s)
[523.448972] [147/156] (589s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[523.543030] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[523.544432] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[523.644880] [148/156] (588s left) gem_ctx_engines (execute-allforone)
[523.689437] Starting subtest: execute-allforone
[523.696489] Subtest execute-allforone: SUCCESS (0.007s)
[523.895916] [149/156] (588s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[523.989629] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[523.991015] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[524.100160] [150/156] (588s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-render)
[524.192802] Starting subtest: fbcpsrhdr-rgb101010-draw-render
[524.194236] Subtest fbcpsrhdr-rgb101010-draw-render: SKIP (0.000s)
[524.288547] [151/156] (588s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[524.381048] Starting subtest: fbc-2p-pri-indfb-multidraw
[524.382478] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[524.479357] [152/156] (588s left) syncobj_timeline (etime-multi-wait-submitted)
[524.521636] Starting subtest: etime-multi-wait-submitted
[524.626451] Subtest etime-multi-wait-submitted: SUCCESS (0.104s)
[524.708884] [153/156] (588s left) gem_sync (basic-many-each)
[524.755150] Starting subtest: basic-many-each
[526.981404] Subtest basic-many-each: SUCCESS (2.226s)
[527.187237] [154/156] (585s left) gem_ctx_persistence (engines-persistence)
[527.227361] Starting subtest: engines-persistence
[527.228084] Starting dynamic subtest: rcs0
[528.006122] Dynamic subtest rcs0: SUCCESS (0.779s)
[528.019452] Starting dynamic subtest: bcs0
[528.777051] Dynamic subtest bcs0: SUCCESS (0.769s)
[528.792490] Starting dynamic subtest: vcs0
[529.545112] Dynamic subtest vcs0: SUCCESS (0.766s)
[529.558685] Starting dynamic subtest: vcs1
[530.318202] Dynamic subtest vcs1: SUCCESS (0.771s)
[530.331904] Starting dynamic subtest: vecs0
[531.076019] Dynamic subtest vecs0: SUCCESS (0.756s)
[531.077218] Subtest engines-persistence: SUCCESS (3.851s)
[531.160915] [155/156] (581s left) sysfs_heartbeat_interval (invalid)
[531.200350] Starting subtest: invalid
[531.201129] Starting dynamic subtest: vecs0
[531.201825] Dynamic subtest vecs0: SUCCESS (0.000s)
[531.212201] Starting dynamic subtest: vcs0
[531.212917] Dynamic subtest vcs0: SUCCESS (0.000s)
[531.222152] Starting dynamic subtest: bcs0
[531.222859] Dynamic subtest bcs0: SUCCESS (0.000s)
[531.232267] Starting dynamic subtest: rcs0
[531.233003] Dynamic subtest rcs0: SUCCESS (0.001s)
[531.242132] Starting dynamic subtest: vcs1
[531.242829] Dynamic subtest vcs1: SUCCESS (0.000s)
[531.243501] Subtest invalid: SUCCESS (0.007s)
[531.277146] [156/156] (581s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[531.372049] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[531.373508] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[531.459289] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_edge_walk
results: parsing output: 1/ for test: gem_mmap_wc
results: parsing output: 2/ for test: kms_psr2_sf
results: parsing output: 3/ for test: kms_plane_multiple
results: parsing output: 4/ for test: kms_atomic
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: perf_pmu
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: gem_exec_schedule
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_softpin
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_flip
results: parsing output: 14/ for test: kms_plane_alpha_blend
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: kms_big_fb
results: parsing output: 17/ for test: i915_pm_rps
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_mmap_offset
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: gem_userptr_blits
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: sw_sync
results: parsing output: 25/ for test: gem_exec_fence
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_cursor_legacy
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: gem_mmap_gtt
results: parsing output: 30/ for test: i915_suspend
results: parsing output: 31/ for test: dmabuf
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_lease
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: kms_lease
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_flip_scaled_crc
results: parsing output: 38/ for test: kms_rotation_crc
results: parsing output: 39/ for test: gem_userptr_blits
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_psr
results: parsing output: 43/ for test: kms_hdr
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_color_pipeline
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: syncobj_wait
results: parsing output: 48/ for test: kms_cursor_crc
results: parsing output: 49/ for test: gem_mmap_gtt
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: kms_force_connector_basic
results: parsing output: 52/ for test: kms_fb_coherency
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_vblank
results: parsing output: 55/ for test: kms_chamelium_color
results: parsing output: 56/ for test: gem_mmap_wc
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_flip
results: parsing output: 59/ for test: kms_async_flips
results: parsing output: 60/ for test: gem_wait
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: gem_mmap_wc
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_mmap_gtt
results: parsing output: 66/ for test: gem_userptr_blits
results: parsing output: 67/ for test: gem_exec_balancer
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: syncobj_eventfd
results: parsing output: 70/ for test: kms_pm_backlight
results: parsing output: 71/ for test: kms_vblank
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: kms_pm_rpm
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_chamelium_hpd
results: parsing output: 76/ for test: gen9_exec_parse
results: parsing output: 77/ for test: kms_pm_rpm
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_exec_balancer
results: parsing output: 80/ for test: gem_ctx_persistence
results: parsing output: 81/ for test: syncobj_wait
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: i915_pm_freq_api
results: parsing output: 86/ for test: gem_exec_reloc
results: parsing output: 87/ for test: kms_plane
results: parsing output: 88/ for test: gem_gpgpu_fill
results: parsing output: 89/ for test: gem_exec_schedule
results: parsing output: 90/ for test: gem_ctx_param
results: parsing output: 91/ for test: gem_spin_batch
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: api_intel_allocator
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_addfb_basic
results: parsing output: 97/ for test: gem_exec_params
results: parsing output: 98/ for test: prime_mmap
results: parsing output: 99/ for test: gem_exec_whisper
results: parsing output: 100/ for test: perf
results: parsing output: 101/ for test: kms_rotation_crc
results: parsing output: 102/ for test: gem_render_copy
results: parsing output: 103/ for test: kms_cursor_legacy
results: parsing output: 104/ for test: kms_flip
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: gem_exec_params
results: parsing output: 107/ for test: kms_content_protection
results: parsing output: 108/ for test: gem_mmap_wc
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_getfb
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_plane_scaling
results: parsing output: 114/ for test: kms_flip_scaled_crc
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: kms_psr2_sf
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: syncobj_timeline
results: parsing output: 125/ for test: kms_hdmi_inject
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: kms_ccs
results: parsing output: 128/ for test: vgem_basic
results: parsing output: 129/ for test: kms_flip
results: parsing output: 130/ for test: kms_addfb_basic
results: parsing output: 131/ for test: core_getclient
results: parsing output: 132/ for test: gem_exec_balancer
results: parsing output: 133/ for test: gem_eio
results: parsing output: 134/ for test: gem_bad_reloc
results: parsing output: 135/ for test: kms_frontbuffer_tracking
results: parsing output: 136/ for test: i915_drm_fdinfo
results: parsing output: 137/ for test: prime_self_import
results: parsing output: 138/ for test: kms_psr
results: parsing output: 139/ for test: kms_chamelium_color
results: parsing output: 140/ for test: kms_cursor_crc
results: parsing output: 141/ for test: gem_mmap_gtt
results: parsing output: 142/ for test: gem_mmap_gtt
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: gem_render_copy
results: parsing output: 145/ for test: kms_addfb_basic
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: gem_ctx_engines
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: syncobj_timeline
results: parsing output: 152/ for test: gem_sync
results: parsing output: 153/ for test: gem_ctx_persistence
results: parsing output: 154/ for test: sysfs_heartbeat_interval
results: parsing output: 155/ for test: kms_frontbuffer_tracking
Done.