[58.772856] Initializing watchdogs
[58.772907]   /dev/watchdog0
[58.788478] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.793938] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.796515] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.798684] [001/153] (960s left) kms_async_flips (invalid-async-flip-atomic)
[58.893217] Starting subtest: invalid-async-flip-atomic
[59.275629] Starting dynamic subtest: pipe-A-eDP-1
[60.144639] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.856s)
[60.506141] Starting dynamic subtest: pipe-B-eDP-1
[61.394188] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.882s)
[61.750477] Starting dynamic subtest: pipe-C-eDP-1
[62.610091] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.855s)
[62.965406] Starting dynamic subtest: pipe-D-eDP-1
[63.751125] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.785s)
[63.752380] Subtest invalid-async-flip-atomic: SUCCESS (4.797s)
[64.915341] [002/153] (954s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[65.020702] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[65.022397] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[65.107703] [003/153] (954s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[65.197302] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[65.210301] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.011s)
[65.300910] [004/153] (954s left) prime_vgem (wait)
[65.406075] Starting subtest: wait
[65.407018] Starting dynamic subtest: rcs0
[65.461589] Dynamic subtest rcs0: SUCCESS (0.054s)
[65.467864] Starting dynamic subtest: bcs0
[65.520966] Dynamic subtest bcs0: SUCCESS (0.059s)
[65.527205] Starting dynamic subtest: vcs0
[65.567091] Dynamic subtest vcs0: SUCCESS (0.045s)
[65.573426] Starting dynamic subtest: vcs1
[65.611668] Dynamic subtest vcs1: SUCCESS (0.044s)
[65.618026] Starting dynamic subtest: vecs0
[65.659205] Dynamic subtest vecs0: SUCCESS (0.046s)
[65.665498] Starting dynamic subtest: ccs0
[65.701784] Dynamic subtest ccs0: SUCCESS (0.042s)
[65.703086] Subtest wait: SUCCESS (0.295s)
[65.818553] [FACT prime_vgem (wait)] new: kernel.kmod_is_loaded.vgem: true
[65.820274] [005/153] (953s left) vgem_basic (dmabuf-fence-before)
[65.860044] Starting subtest: dmabuf-fence-before
[65.861041] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[65.924372] [006/153] (953s left) api_intel_bb (bb-with-allocator)
[65.970360] Starting subtest: bb-with-allocator
[65.977724] Subtest bb-with-allocator: SUCCESS (0.009s)
[66.105536] [007/153] (953s left) gem_pxp (create-regular-context-1)
[66.221745] Starting subtest: create-regular-context-1
[66.223123] Subtest create-regular-context-1: SUCCESS (0.002s)
[66.342677] [008/153] (953s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-onoff)
[66.440927] Starting subtest: psrhdr-2p-primscrn-cur-indfb-onoff
[66.442613] Subtest psrhdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[66.526576] [009/153] (953s left) syncobj_wait (wait-any-complex)
[66.569525] Starting subtest: wait-any-complex
[66.632584] Subtest wait-any-complex: SUCCESS (0.062s)
[66.700679] [010/153] (952s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[66.800207] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[66.802563] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[66.908334] [011/153] (952s left) gem_userptr_blits (input-checking)
[66.958056] Starting subtest: input-checking
[66.958988] Subtest input-checking: SUCCESS (0.000s)
[67.072685] [012/153] (952s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[67.159775] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[67.161509] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[67.247960] [013/153] (952s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[67.331902] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[67.333588] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[67.416914] [014/153] (952s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[67.506610] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[67.508370] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[67.598343] [015/153] (952s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[67.692075] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[74.718178] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (7.004s)
[76.073254] [016/153] (943s left) gem_create (create-clear)
[76.131931] Starting subtest: create-clear
[76.133278] Starting dynamic subtest: smem0
[108.815691] Dynamic subtest smem0: SUCCESS (32.661s)
[108.817226] Subtest create-clear: SUCCESS (32.661s)
[109.002427] [017/153] (910s left) syncobj_timeline (etime-single-wait-all-submitted)
[109.046207] Starting subtest: etime-single-wait-all-submitted
[109.152868] Subtest etime-single-wait-all-submitted: SUCCESS (0.106s)
[109.252742] [018/153] (910s left) kms_rotation_crc (cursor-rotation-180)
[109.344946] Starting subtest: cursor-rotation-180
[110.844194] Subtest cursor-rotation-180: SUCCESS (1.499s)
[112.065353] [019/153] (907s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-shrfb-plflip-blt)
[112.156463] Starting subtest: fbcpsrhdr-2p-primscrn-shrfb-plflip-blt
[112.158338] Subtest fbcpsrhdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[112.245380] [020/153] (907s left) vgem_basic (dmabuf-fence)
[112.280999] Starting subtest: dmabuf-fence
[112.281897] Subtest dmabuf-fence: SUCCESS (0.000s)
[112.331564] [021/153] (907s left) sysfs_preempt_timeout (timeout)
[112.388850] Starting subtest: timeout
[112.389741] Starting dynamic subtest: vecs0
[122.332139] Dynamic subtest vecs0: SUCCESS (9.931s)
[122.339277] Starting dynamic subtest: ccs0
[123.646406] Dynamic subtest ccs0: SUCCESS (1.323s)
[123.657377] Starting dynamic subtest: vcs0
[133.345289] Dynamic subtest vcs0: SUCCESS (9.687s)
[133.355048] Starting dynamic subtest: bcs0
[134.594385] Dynamic subtest bcs0: SUCCESS (1.257s)
[134.603812] Starting dynamic subtest: rcs0
[135.826751] Dynamic subtest rcs0: SUCCESS (1.232s)
[135.836315] Starting dynamic subtest: vcs1
[145.313216] Dynamic subtest vcs1: SUCCESS (9.474s)
[145.314286] Subtest timeout: SUCCESS (32.909s)
[145.373500] [022/153] (874s left) kms_cursor_crc (cursor-size-change)
[145.462903] Starting subtest: cursor-size-change
[145.463871] Starting dynamic subtest: pipe-A-eDP-1
[146.291873] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.828s)
[146.299631] Starting dynamic subtest: pipe-D-eDP-1
[147.740580] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.447s)
[147.741489] Subtest cursor-size-change: SUCCESS (2.277s)
[148.625180] [023/153] (871s left) perf_pmu (most-busy-check-all)
[148.661933] Starting subtest: most-busy-check-all
[148.662942] Starting dynamic subtest: rcs0
[150.309789] Dynamic subtest rcs0: SUCCESS (1.637s)
[150.319774] Starting dynamic subtest: bcs0
[152.357419] Dynamic subtest bcs0: SUCCESS (2.047s)
[152.366298] Starting dynamic subtest: vcs0
[154.340710] Dynamic subtest vcs0: SUCCESS (1.983s)
[154.350520] Starting dynamic subtest: vcs1
[156.325058] Dynamic subtest vcs1: SUCCESS (1.983s)
[156.334509] Starting dynamic subtest: vecs0
[158.309531] Dynamic subtest vecs0: SUCCESS (1.983s)
[158.319193] Starting dynamic subtest: ccs0
[160.356876] Dynamic subtest ccs0: SUCCESS (2.046s)
[160.358061] Subtest most-busy-check-all: SUCCESS (11.687s)
[160.435340] [024/153] (859s left) gem_ctx_bad_destroy (double-destroy)
[160.485522] Starting subtest: double-destroy
[160.486636] Subtest double-destroy: SUCCESS (0.000s)
[160.545319] [025/153] (859s left) i915_pm_rps (engine-order)
[160.596895] Starting subtest: engine-order
[167.180704] Subtest engine-order: SUCCESS (6.575s)
[167.263433] [026/153] (852s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[167.363918] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[167.365835] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[167.452288] [027/153] (852s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[167.539298] Starting subtest: x-tiled-16bpp-rotate-270
[167.559549] Subtest x-tiled-16bpp-rotate-270: SKIP (0.020s)
[167.679725] [028/153] (852s left) gem_close (many-handles-one-vma)
[167.734495] Starting subtest: many-handles-one-vma
[167.755277] Subtest many-handles-one-vma: SUCCESS (0.021s)
[167.885162] [029/153] (852s left) api_intel_bb (full-batch)
[167.938170] Starting subtest: full-batch
[167.943640] Subtest full-batch: SUCCESS (0.006s)
[168.064977] [030/153] (852s left) kms_prop_blob (invalid-set-prop-any)
[168.107233] Starting subtest: invalid-set-prop-any
[168.108298] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[168.204194] [031/153] (852s left) perf (invalid-oa-exponent)
[168.323167] Starting subtest: invalid-oa-exponent
[168.337634] Subtest invalid-oa-exponent: SUCCESS (0.014s)
[168.375581] [032/153] (851s left) gem_exec_balancer (bonded-pair)
[168.432399] Starting subtest: bonded-pair
[168.434335] Subtest bonded-pair: SKIP (0.000s)
[168.738191] [033/153] (851s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[168.819421] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[168.820334] Starting dynamic subtest: pipe-A-default-mode
[170.003040] Dynamic subtest pipe-A-default-mode: SKIP (1.183s)
[170.004815] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.184s)
[170.160303] [034/153] (850s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[170.244863] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[180.063072] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.819s)
[180.204547] [035/153] (840s left) prime_vgem (fence-read-hang)
[180.285145] Subtest fence-read-hang: SKIP (0.000s)
[180.373586] [036/153] (840s left) core_setmaster (master-drop-set-root)
[180.427356] Starting subtest: master-drop-set-root
[180.451710] Subtest master-drop-set-root: SUCCESS (0.024s)
[180.493808] [037/153] (840s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-blt)
[180.582384] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-blt
[180.584087] Subtest fbchdr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[180.675235] [038/153] (839s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[180.771885] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[187.804213] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.035s)
[187.921265] [039/153] (832s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[188.038418] Starting subtest: 2x-flip-vs-cursor-legacy
[188.041525] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[188.177832] [040/153] (832s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-pwrite)
[188.264031] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-pwrite
[188.265826] Subtest hdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[188.371209] [041/153] (832s left) prime_vgem (basic-fence-flip)
[188.437355] Starting subtest: basic-fence-flip
[188.759562] Subtest basic-fence-flip: SUCCESS (0.322s)
[188.835551] [042/153] (831s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[188.920864] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-mmap-gtt
[188.922719] Subtest fbchdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[189.037733] [043/153] (831s left) gem_eio (suspend)
[189.236835] Starting subtest: suspend
[201.548792] Subtest suspend: SUCCESS (12.313s)
[208.683355] [044/153] (819s left) kms_psr (psr2-dpms)
[208.783185] Starting subtest: psr2-dpms
[208.784083] Starting dynamic subtest: eDP-1
[211.798493] Dynamic subtest eDP-1: SUCCESS (3.015s)
[211.799428] Subtest psr2-dpms: SUCCESS (3.016s)
[212.656904] [045/153] (815s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[212.756356] Starting subtest: 4-tiled-64bpp-rotate-90
[212.775981] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.020s)
[212.888072] [046/153] (814s left) kms_plane_alpha_blend (constant-alpha-max)
[212.966100] Starting subtest: constant-alpha-max
[213.251248] Starting dynamic subtest: pipe-A-eDP-1
[214.292580] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.041s)
[214.302370] Starting dynamic subtest: pipe-D-eDP-1
[215.893335] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.597s)
[215.894200] Subtest constant-alpha-max: SUCCESS (2.927s)
[216.739861] [047/153] (811s left) kms_flip (dpms-vs-vblank-race-interruptible)
[216.830332] Starting subtest: dpms-vs-vblank-race-interruptible
[216.832554] Starting dynamic subtest: A-eDP1
[220.721354] Dynamic subtest A-eDP1: SUCCESS (3.887s)
[220.730061] Starting dynamic subtest: B-eDP1
[224.306382] Dynamic subtest B-eDP1: SUCCESS (3.585s)
[224.318148] Starting dynamic subtest: C-eDP1
[228.911896] Dynamic subtest C-eDP1: SUCCESS (4.603s)
[228.920947] Starting dynamic subtest: D-eDP1
[233.564365] Dynamic subtest D-eDP1: SUCCESS (4.649s)
[233.565760] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (16.733s)
[234.427348] [048/153] (793s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[234.533659] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[234.535441] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[234.626146] [049/153] (793s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[234.715785] Starting subtest: pr-overlay-plane-move-continuous-sf
[234.717618] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[234.785200] [050/153] (793s left) kms_psr (psr-sprite-mmap-cpu)
[234.877194] Starting subtest: psr-sprite-mmap-cpu
[234.878157] Starting dynamic subtest: eDP-1
[236.633147] Dynamic subtest eDP-1: SUCCESS (1.756s)
[236.634439] Subtest psr-sprite-mmap-cpu: SUCCESS (1.757s)
[237.504191] [051/153] (790s left) gem_exec_params (dr4-dirt)
[237.558578] Starting subtest: DR4-dirt
[237.559666] Subtest DR4-dirt: SUCCESS (0.000s)
[237.655168] [052/153] (790s left) syncobj_timeline (multi-wait-all-available-submitted)
[237.700345] Starting subtest: multi-wait-all-available-submitted
[237.701299] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s)
[237.789491] [053/153] (790s left) kms_flip (busy-flip)
[237.875550] Starting subtest: busy-flip
[237.876407] Starting dynamic subtest: A-eDP1
[239.610789] Dynamic subtest A-eDP1: SUCCESS (1.734s)
[239.620341] Starting dynamic subtest: B-eDP1
[241.349527] Dynamic subtest B-eDP1: SUCCESS (1.737s)
[241.361206] Starting dynamic subtest: C-eDP1
[243.067215] Dynamic subtest C-eDP1: SUCCESS (1.713s)
[243.078871] Starting dynamic subtest: D-eDP1
[244.706122] Dynamic subtest D-eDP1: SUCCESS (1.637s)
[244.708559] Subtest busy-flip: SUCCESS (6.833s)
[245.863814] [054/153] (782s left) kms_frontbuffer_tracking (psrhdr-indfb-scaledprimary)
[245.960858] Starting subtest: psrhdr-indfb-scaledprimary
[245.963245] Subtest psrhdr-indfb-scaledprimary: SKIP (0.000s)
[246.050384] [055/153] (782s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[246.146315] Starting subtest: fbc-pr-cursor-mmap-cpu
[246.147924] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[246.215066] [056/153] (781s left) kms_flip (modeset-vs-vblank-race)
[246.300614] Starting subtest: modeset-vs-vblank-race
[246.302934] Starting dynamic subtest: A-eDP1
[251.079989] Dynamic subtest A-eDP1: SUCCESS (4.776s)
[251.099355] Starting dynamic subtest: B-eDP1
[255.817185] Dynamic subtest B-eDP1: SUCCESS (4.734s)
[255.830825] Starting dynamic subtest: C-eDP1
[260.531554] Dynamic subtest C-eDP1: SUCCESS (4.712s)
[260.543489] Starting dynamic subtest: D-eDP1
[265.166295] Dynamic subtest D-eDP1: SUCCESS (4.632s)
[265.168648] Subtest modeset-vs-vblank-race: SUCCESS (18.867s)
[266.323992] [057/153] (761s left) syncobj_basic (bad-fd-to-handle)
[266.373718] Starting subtest: bad-fd-to-handle
[266.374766] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[266.488168] [058/153] (761s left) gem_exec_reloc (basic-wc-gtt-active)
[266.543398] Subtest basic-wc-gtt-active: SKIP (0.000s)
[266.621332] [059/153] (761s left) kms_dp_aux_dev (basic)
[266.670583] Starting subtest: basic
[266.889376] Subtest basic: SUCCESS (0.219s)
[266.975495] [060/153] (761s left) perf (global-sseu-config)
[267.075468] Starting subtest: global-sseu-config
[267.077699] Subtest global-sseu-config: SKIP (0.000s)
[267.113033] [061/153] (761s left) kms_cursor_edge_walk (128x128-left-edge)
[267.201768] Starting subtest: 128x128-left-edge
[267.202729] Starting dynamic subtest: pipe-A-eDP-1
[270.701114] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.499s)
[270.711359] Starting dynamic subtest: pipe-D-eDP-1
[273.916279] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.213s)
[273.917193] Subtest 128x128-left-edge: SUCCESS (6.715s)
[274.721207] [062/153] (753s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[274.819361] Starting subtest: fbc-rgb565-draw-mmap-wc
[278.917459] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (4.098s)
[280.136363] [063/153] (748s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-blt)
[280.234805] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-blt
[280.236797] Subtest psrhdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[280.330108] [064/153] (748s left) kms_vblank (wait-forked-busy)
[280.418594] Starting subtest: wait-forked-busy
[280.419611] Starting dynamic subtest: pipe-A-eDP-1
[282.289614] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s)
[282.300677] Starting dynamic subtest: pipe-D-eDP-1
[284.889992] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.597s)
[284.891305] Subtest wait-forked-busy: SUCCESS (4.475s)
[285.693225] [065/153] (742s left) syncobj_timeline (wait-any-interrupted)
[285.753117] Starting subtest: wait-any-interrupted
[285.855791] Subtest wait-any-interrupted: SUCCESS (0.102s)
[285.926852] [066/153] (742s left) gem_exec_reloc (basic-cpu)
[285.989220] Subtest basic-cpu: SKIP (0.000s)
[286.065066] [067/153] (742s left) gem_ctx_shared (q-smoketest)
[286.125441] Starting subtest: Q-smoketest
[286.126556] Starting dynamic subtest: rcs0
[291.702503] Dynamic subtest rcs0: SUCCESS (5.503s)
[291.717141] Starting dynamic subtest: bcs0
[297.222104] Dynamic subtest bcs0: SUCCESS (5.528s)
[297.231805] Starting dynamic subtest: vcs0
[302.702809] Dynamic subtest vcs0: SUCCESS (5.481s)
[302.713379] Starting dynamic subtest: vcs1
[308.191573] Dynamic subtest vcs1: SUCCESS (5.485s)
[308.206610] Starting dynamic subtest: vecs0
[313.637550] Dynamic subtest vecs0: SUCCESS (5.481s)
[313.646956] Starting dynamic subtest: ccs0
[319.174970] Dynamic subtest ccs0: SUCCESS (5.534s)
[319.175877] Subtest Q-smoketest: SUCCESS (33.019s)
[319.342648] [068/153] (709s left) gem_exec_fence (nb-await)
[319.518803] Starting subtest: nb-await
[319.520088] Starting dynamic subtest: rcs0
[319.592881] Dynamic subtest rcs0: SUCCESS (0.079s)
[319.603496] Starting dynamic subtest: bcs0
[319.651811] Dynamic subtest bcs0: SUCCESS (0.057s)
[319.663945] Starting dynamic subtest: vcs0
[319.713318] Dynamic subtest vcs0: SUCCESS (0.059s)
[319.726352] Starting dynamic subtest: vcs1
[319.774400] Dynamic subtest vcs1: SUCCESS (0.059s)
[319.785786] Starting dynamic subtest: vecs0
[319.837146] Dynamic subtest vecs0: SUCCESS (0.061s)
[319.849655] Starting dynamic subtest: ccs0
[319.899374] Dynamic subtest ccs0: SUCCESS (0.059s)
[319.901761] Subtest nb-await: SUCCESS (0.387s)
[321.363787] [069/153] (707s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[321.471379] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[321.483648] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.011s)
[321.557055] [070/153] (707s left) kms_getfb (getfb2-handle-zero)
[321.638614] Starting subtest: getfb2-handle-zero
[321.639567] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[321.737319] [071/153] (706s left) kms_chamelium_color (ctm-0-75)
[321.826860] Subtest ctm-0-75: SKIP (0.000s)
[321.868993] [072/153] (706s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[321.963471] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[321.964453] Starting dynamic subtest: pipe-A-eDP-1
[321.972895] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[321.982079] Starting dynamic subtest: pipe-B-eDP-1
[321.990512] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[321.999292] Starting dynamic subtest: pipe-C-eDP-1
[322.007508] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[322.016166] Starting dynamic subtest: pipe-D-eDP-1
[322.024730] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[322.026406] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.006s)
[324.261507] [073/153] (704s left) kms_prop_blob (blob-multiple)
[324.314917] Starting subtest: blob-multiple
[324.317940] Subtest blob-multiple: SUCCESS (0.002s)
[324.422614] [074/153] (704s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[324.502455] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[324.503408] Starting dynamic subtest: pipe-A-eDP-1
[324.511998] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[324.521458] Starting dynamic subtest: pipe-B-eDP-1
[324.529958] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[324.540427] Starting dynamic subtest: pipe-C-eDP-1
[324.548709] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[324.557517] Starting dynamic subtest: pipe-D-eDP-1
[324.565251] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[324.566743] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[326.820550] [075/153] (702s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[326.919083] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[326.921022] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[327.034994] [076/153] (701s left) i915_query (test-query-geometry-subslices)
[327.091379] Starting subtest: test-query-geometry-subslices
[327.092521] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[327.189932] [077/153] (701s left) gem_mmap (bad-size)
[327.242142] Subtest bad-size: SKIP (0.000s)
[327.300948] [078/153] (701s left) kms_cursor_crc (cursor-onscreen-64x64)
[327.487346] Starting subtest: cursor-onscreen-64x64
[327.491446] Starting dynamic subtest: pipe-A-eDP-1
[329.622389] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.130s)
[329.654694] Starting dynamic subtest: pipe-D-eDP-1
[332.437741] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.790s)
[332.438685] Subtest cursor-onscreen-64x64: SUCCESS (4.951s)
[333.300068] [079/153] (695s left) gen9_exec_parse (bb-start-param)
[333.349334] Subtest bb-start-param: SKIP (0.000s)
[333.421284] [080/153] (695s left) kms_setmode (basic)
[333.465490] Starting subtest: basic
[333.799555] Starting dynamic subtest: pipe-A-eDP-1
[335.919336] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.108s)
[336.266667] Starting dynamic subtest: pipe-B-eDP-1
[338.356882] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.088s)
[338.656471] Subtest basic: SUCCESS (5.190s)
[339.493771] [081/153] (689s left) gem_exec_params (mmapped)
[339.541920] Starting subtest: mmapped
[339.544248] Subtest mmapped: SUCCESS (0.002s)
[339.651484] [082/153] (689s left) kms_force_connector_basic (force-connector-state)
[339.726527] Starting subtest: force-connector-state
[340.340211] Subtest force-connector-state: SUCCESS (0.613s)
[341.336628] [083/153] (687s left) gem_exec_schedule (submit-late-slice)
[341.403056] Starting subtest: submit-late-slice
[341.403964] Starting dynamic subtest: rcs0
[341.443147] Dynamic subtest rcs0: SUCCESS (0.040s)
[341.453199] Starting dynamic subtest: bcs0
[341.478873] Dynamic subtest bcs0: SUCCESS (0.035s)
[341.490456] Starting dynamic subtest: vcs0
[341.519725] Dynamic subtest vcs0: SUCCESS (0.040s)
[341.529467] Starting dynamic subtest: vcs1
[341.555183] Dynamic subtest vcs1: SUCCESS (0.035s)
[341.565468] Starting dynamic subtest: vecs0
[341.591087] Dynamic subtest vecs0: SUCCESS (0.035s)
[341.602357] Starting dynamic subtest: ccs0
[341.632264] Dynamic subtest ccs0: SUCCESS (0.040s)
[341.633322] Subtest submit-late-slice: SUCCESS (0.230s)
[343.413516] [084/153] (685s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[343.499097] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu
[343.501027] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[343.613843] [085/153] (685s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[343.698263] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[343.699943] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.000s)
[343.766552] [086/153] (685s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-mmap-gtt)
[343.858734] Starting subtest: hdr-rgb101010-draw-mmap-gtt
[343.860645] Subtest hdr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[343.953860] [087/153] (685s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[344.055086] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[344.056826] Subtest hdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[344.150526] [088/153] (685s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[344.238229] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[345.463755] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.226s)
[345.616474] [089/153] (683s left) kms_legacy_colorkey (invalid-plane)
[345.708805] Starting subtest: invalid-plane
[345.709775] Starting dynamic subtest: zero-id
[345.710768] Dynamic subtest zero-id: SUCCESS (0.000s)
[345.719635] Starting dynamic subtest: outrange-id
[345.720595] Dynamic subtest outrange-id: SUCCESS (0.000s)
[345.721632] Subtest invalid-plane: SUCCESS (0.001s)
[345.780805] [090/153] (683s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-render)
[345.874520] Starting subtest: fbcpsrhdr-rgb565-draw-render
[345.876333] Subtest fbcpsrhdr-rgb565-draw-render: SKIP (0.000s)
[345.970112] [091/153] (683s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[346.092390] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[347.073308] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.978s)
[347.918788] [092/153] (681s left) gem_exec_schedule (independent)
[347.980287] Starting subtest: independent
[347.981201] Starting dynamic subtest: rcs0
[349.347868] Dynamic subtest rcs0: SUCCESS (1.359s)
[349.358472] Starting dynamic subtest: vcs0
[351.338076] Dynamic subtest vcs0: SUCCESS (1.987s)
[351.352202] Starting dynamic subtest: vcs1
[353.332715] Dynamic subtest vcs1: SUCCESS (1.992s)
[353.347198] Starting dynamic subtest: vecs0
[355.310127] Dynamic subtest vecs0: SUCCESS (1.974s)
[355.323569] Starting dynamic subtest: ccs0
[357.348206] Dynamic subtest ccs0: SUCCESS (2.037s)
[357.349670] Subtest independent: SUCCESS (9.360s)
[357.639299] [093/153] (671s left) kms_psr (psr-dpms)
[357.730317] Starting subtest: psr-dpms
[357.731219] Starting dynamic subtest: eDP-1
[360.682581] Dynamic subtest eDP-1: SUCCESS (2.952s)
[360.683549] Subtest psr-dpms: SUCCESS (2.953s)
[361.522130] [094/153] (668s left) gem_exec_balancer (semaphore)
[361.583518] Starting subtest: semaphore
[363.339092] Subtest semaphore: SUCCESS (1.746s)
[363.656836] [095/153] (665s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[364.045810] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[364.890472] [096/153] (664s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[364.978736] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[364.979786] Starting dynamic subtest: pipe-A-eDP-1
[364.987915] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[364.997369] Starting dynamic subtest: pipe-B-eDP-1
[365.005393] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[365.015229] Starting dynamic subtest: pipe-C-eDP-1
[365.022206] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[365.030684] Starting dynamic subtest: pipe-D-eDP-1
[365.037516] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[365.038356] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[367.220079] [097/153] (662s left) gem_ctx_persistence (engines-mixed)
[367.267900] Starting subtest: engines-mixed
[367.268898] Starting dynamic subtest: rcs0
[367.331110] Dynamic subtest rcs0: SUCCESS (0.063s)
[367.341599] Starting dynamic subtest: bcs0
[367.389182] Dynamic subtest bcs0: SUCCESS (0.057s)
[367.400776] Starting dynamic subtest: vcs0
[367.453246] Dynamic subtest vcs0: SUCCESS (0.062s)
[367.465640] Starting dynamic subtest: vcs1
[367.503216] Dynamic subtest vcs1: SUCCESS (0.047s)
[367.514471] Starting dynamic subtest: vecs0
[367.549244] Dynamic subtest vecs0: SUCCESS (0.044s)
[367.559762] Starting dynamic subtest: ccs0
[367.603035] Dynamic subtest ccs0: SUCCESS (0.052s)
[367.605356] Subtest engines-mixed: SUCCESS (0.337s)
[367.691315] [098/153] (661s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[367.770283] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[367.771134] Starting dynamic subtest: pipe-A
[367.789852] Dynamic subtest pipe-A: SKIP (0.019s)
[367.798731] Starting dynamic subtest: pipe-B
[367.825507] Dynamic subtest pipe-B: SKIP (0.034s)
[367.834338] Starting dynamic subtest: pipe-C
[367.858265] Dynamic subtest pipe-C: SKIP (0.033s)
[367.866990] Starting dynamic subtest: pipe-D
[367.892892] Dynamic subtest pipe-D: SKIP (0.033s)
[367.894658] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.121s)
[367.993858] [099/153] (661s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[368.094866] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[368.096589] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[368.190067] [100/153] (661s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-pwrite)
[368.273905] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-pwrite
[368.275544] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[368.351299] [101/153] (661s left) kms_concurrent (multi-plane-atomic-lowres)
[368.440682] Starting subtest: multi-plane-atomic-lowres
[368.441805] Starting dynamic subtest: pipe-A-eDP-1
[368.959253] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.518s)
[368.970071] Starting dynamic subtest: pipe-B-eDP-1
[370.229218] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.269s)
[370.237980] Starting dynamic subtest: pipe-C-eDP-1
[371.517264] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.286s)
[371.526285] Starting dynamic subtest: pipe-D-eDP-1
[372.729062] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.211s)
[372.729997] Subtest multi-plane-atomic-lowres: SUCCESS (4.288s)
[373.608883] [102/153] (656s left) gen7_exec_parse (basic-offset)
[373.667818] Subtest basic-offset: SKIP (0.000s)
[373.741066] [103/153] (656s left) gem_ctx_persistence (saturated-hostile)
[373.795276] Starting subtest: saturated-hostile
[373.796119] Starting dynamic subtest: rcs0
[374.573637] Dynamic subtest rcs0: SUCCESS (0.779s)
[374.586888] Starting dynamic subtest: bcs0
[375.362493] Dynamic subtest bcs0: SUCCESS (0.786s)
[375.374806] Starting dynamic subtest: vcs0
[376.156590] Dynamic subtest vcs0: SUCCESS (0.792s)
[376.169635] Starting dynamic subtest: vcs1
[376.956682] Dynamic subtest vcs1: SUCCESS (0.798s)
[376.968730] Starting dynamic subtest: vecs0
[377.757495] Dynamic subtest vecs0: SUCCESS (0.799s)
[377.770802] Starting dynamic subtest: ccs0
[378.608840] Dynamic subtest ccs0: SUCCESS (0.849s)
[378.610545] Subtest saturated-hostile: SUCCESS (4.815s)
[378.686223] [104/153] (651s left) kms_chamelium_edid (dp-edid-resolution-list)
[379.072508] Subtest dp-edid-resolution-list: SKIP (0.000s)
[379.894890] [105/153] (650s left) gem_mmap_offset (basic-uaf)
[379.945545] Starting subtest: basic-uaf
[379.946444] Subtest basic-uaf: SUCCESS (0.001s)
[380.026594] [106/153] (649s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[380.130150] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[380.978368] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.848s)
[381.146064] [107/153] (648s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[381.246670] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[381.248271] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[381.342428] [108/153] (648s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-indfb-plflip-blt)
[381.430289] Starting subtest: fbchdr-1p-primscrn-indfb-plflip-blt
[381.431954] Subtest fbchdr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[381.520066] [109/153] (648s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[381.606122] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[381.607897] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[381.699863] [110/153] (648s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[381.800625] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[381.801561] Starting dynamic subtest: pipe-A-eDP-1
[381.823523] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[381.833723] Starting dynamic subtest: pipe-B-eDP-1
[381.854532] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[381.863354] Starting dynamic subtest: pipe-C-eDP-1
[381.885271] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[381.893608] Starting dynamic subtest: pipe-D-eDP-1
[381.914087] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[381.915740] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.010s)
[384.016950] [111/153] (646s left) gem_render_copy_redux (flink-interruptible)
[384.077665] Starting subtest: flink-interruptible
[384.885117] Subtest flink-interruptible: SUCCESS (0.808s)
[385.007904] [112/153] (645s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[385.102864] Starting subtest: y-tiled-64bpp-rotate-0
[385.104959] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[385.202409] [113/153] (645s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[385.287992] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[385.289785] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[385.412252] [114/153] (644s left) kms_universal_plane (disable-primary-vs-flip)
[385.508645] Starting subtest: disable-primary-vs-flip
[385.509674] Starting dynamic subtest: pipe-A-eDP-1
[387.055403] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.547s)
[387.064545] Starting dynamic subtest: pipe-B-eDP-1
[389.261352] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.203s)
[389.272637] Starting dynamic subtest: pipe-C-eDP-1
[391.454047] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.193s)
[391.464895] Starting dynamic subtest: pipe-D-eDP-1
[393.668227] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.212s)
[393.669403] Subtest disable-primary-vs-flip: SUCCESS (8.162s)
[394.513430] [115/153] (635s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[394.598533] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[394.599385] Starting dynamic subtest: pipe-A
[394.718849] Dynamic subtest pipe-A: SKIP (0.119s)
[394.727863] Starting dynamic subtest: pipe-B
[395.943432] Dynamic subtest pipe-B: SKIP (1.224s)
[395.952382] Starting dynamic subtest: pipe-C
[397.154935] Dynamic subtest pipe-C: SUCCESS (1.212s)
[397.163863] Starting dynamic subtest: pipe-D
[398.358501] Dynamic subtest pipe-D: SUCCESS (1.203s)
[398.360440] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.762s)
[399.519387] [116/153] (630s left) gem_ctx_exec (basic)
[399.570198] Starting subtest: basic
[399.576284] Subtest basic: SUCCESS (0.006s)
[399.678692] [117/153] (630s left) syncobj_timeline (signal-array)
[399.732217] Starting subtest: signal-array
[399.733355] Subtest signal-array: SUCCESS (0.000s)
[399.825104] [118/153] (630s left) kms_async_flips (crc)
[399.910476] Starting subtest: crc
[400.283924] Starting dynamic subtest: pipe-A-eDP-1
[403.209488] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.925s)
[403.607468] Starting dynamic subtest: pipe-B-eDP-1
[406.508983] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.911s)
[406.883393] Starting dynamic subtest: pipe-C-eDP-1
[409.775738] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.902s)
[410.146219] Starting dynamic subtest: pipe-D-eDP-1
[413.070577] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.930s)
[413.071564] Subtest crc: SUCCESS (13.157s)
[414.238172] [119/153] (616s left) gem_exec_reloc (basic-gtt-wc)
[414.287746] Subtest basic-gtt-wc: SKIP (0.000s)
[414.354251] [120/153] (616s left) i915_drm_fdinfo (busy-hang)
[414.386527] Starting subtest: busy-hang
[414.387670] Starting dynamic subtest: rcs0
[414.411242] Dynamic subtest rcs0: SKIP (0.023s)
[414.422964] Starting dynamic subtest: bcs0
[414.424799] Dynamic subtest bcs0: SKIP (0.000s)
[414.433849] Starting dynamic subtest: vcs0
[414.435678] Dynamic subtest vcs0: SKIP (0.000s)
[414.444417] Starting dynamic subtest: vcs1
[414.446252] Dynamic subtest vcs1: SKIP (0.000s)
[414.454715] Starting dynamic subtest: vecs0
[414.456576] Dynamic subtest vecs0: SKIP (0.000s)
[414.465116] Starting dynamic subtest: ccs0
[414.467040] Dynamic subtest ccs0: SKIP (0.000s)
[414.468831] Subtest busy-hang: SKIP (0.029s)
[414.500094] [121/153] (616s left) fbdev (pan)
[414.529168] Starting subtest: pan
[414.562582] Subtest pan: SUCCESS (0.035s)
[414.628701] [122/153] (615s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-pwrite)
[414.729849] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-pwrite
[414.731818] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[414.844849] [123/153] (615s left) syncobj_timeline (etime-multi-wait-all-submitted)
[414.898811] Starting subtest: etime-multi-wait-all-submitted
[415.019276] Subtest etime-multi-wait-all-submitted: SUCCESS (0.108s)
[415.079250] [124/153] (615s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[415.119535] Starting subtest: invalid-single-wait-all-unsubmitted
[415.120525] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[415.203594] [125/153] (615s left) gem_spin_batch (resubmit-new-all)
[415.266690] Starting subtest: resubmit-new-all
[415.267836] Starting dynamic subtest: rcs0
[415.280847] Dynamic subtest rcs0: SUCCESS (0.014s)
[415.289891] Starting dynamic subtest: bcs0
[415.292828] Dynamic subtest bcs0: SUCCESS (0.011s)
[415.304264] Starting dynamic subtest: vcs0
[415.305075] Dynamic subtest vcs0: SUCCESS (0.008s)
[415.314154] Starting dynamic subtest: vcs1
[415.314981] Dynamic subtest vcs1: SUCCESS (0.009s)
[415.325908] Starting dynamic subtest: vecs0
[415.326758] Dynamic subtest vecs0: SUCCESS (0.010s)
[415.335459] Starting dynamic subtest: ccs0
[415.337507] Dynamic subtest ccs0: SUCCESS (0.014s)
[415.338345] Subtest resubmit-new-all: SUCCESS (0.071s)
[417.349637] [126/153] (613s left) kms_cursor_crc (cursor-alpha-opaque)
[417.446088] Starting subtest: cursor-alpha-opaque
[417.447077] Starting dynamic subtest: pipe-A-eDP-1
[418.066697] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.620s)
[418.077928] Starting dynamic subtest: pipe-D-eDP-1
[419.377910] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.309s)
[419.378911] Subtest cursor-alpha-opaque: SUCCESS (1.932s)
[420.218145] [127/153] (610s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[420.315651] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[427.533467] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (7.225s)
[427.681952] [128/153] (603s left) kms_cursor_crc (cursor-random-64x21)
[427.871720] Starting subtest: cursor-random-64x21
[427.916674] Subtest cursor-random-64x21: SKIP (0.042s)
[428.178384] [129/153] (602s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[428.267694] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[428.295097] Starting dynamic subtest: pipe-A-plane-0
[428.583835] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[428.593134] Starting dynamic subtest: pipe-A-plane-3
[428.828526] Dynamic subtest pipe-A-plane-3: SUCCESS (0.244s)
[429.974196] Starting dynamic subtest: pipe-B-plane-0
[430.274527] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s)
[430.284088] Starting dynamic subtest: pipe-B-plane-3
[430.518984] Dynamic subtest pipe-B-plane-3: SUCCESS (0.244s)
[430.829162] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.562s)
[431.708623] [130/153] (599s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[431.801874] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[431.803647] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[431.868779] [131/153] (599s left) syncobj_wait (invalid-reset-zero-handles)
[431.926086] Starting subtest: invalid-reset-zero-handles
[431.927118] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[432.018077] [132/153] (598s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[432.110920] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[432.112693] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[432.234383] [133/153] (598s left) gem_exec_store (cachelines)
[432.289734] Starting subtest: cachelines
[432.290789] Starting dynamic subtest: rcs0
[432.360999] Dynamic subtest rcs0: SUCCESS (0.070s)
[432.374502] Starting dynamic subtest: bcs0
[432.426289] Dynamic subtest bcs0: SUCCESS (0.064s)
[432.439998] Starting dynamic subtest: vcs0
[432.494407] Dynamic subtest vcs0: SUCCESS (0.066s)
[432.506689] Starting dynamic subtest: vcs1
[432.548969] Dynamic subtest vcs1: SUCCESS (0.053s)
[432.560769] Starting dynamic subtest: vecs0
[432.615729] Dynamic subtest vecs0: SUCCESS (0.064s)
[432.628438] Starting dynamic subtest: ccs0
[432.672692] Dynamic subtest ccs0: SUCCESS (0.054s)
[432.673922] Subtest cachelines: SUCCESS (0.384s)
[432.853476] [134/153] (598s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[432.937331] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[440.473115] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.537s)
[440.592549] [135/153] (590s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-mmap-wc)
[440.680905] Starting subtest: fbcpsrhdr-rgb101010-draw-mmap-wc
[440.682738] Subtest fbcpsrhdr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[440.770220] [136/153] (590s left) kms_busy (extended-pageflip-hang-newfb)
[440.858957] Starting subtest: extended-pageflip-hang-newfb
[440.861349] Starting dynamic subtest: pipe-A
[467.191380] Dynamic subtest pipe-A: SUCCESS (26.328s)
[467.202483] Starting dynamic subtest: pipe-D
[491.118866] Dynamic subtest pipe-D: SUCCESS (23.921s)
[491.120022] Subtest extended-pageflip-hang-newfb: SUCCESS (50.255s)
[492.022475] [137/153] (539s left) kms_psr (fbc-psr-primary-page-flip)
[492.109975] Starting subtest: fbc-psr-primary-page-flip
[492.110960] Starting dynamic subtest: eDP-1
[492.113242] Dynamic subtest eDP-1: SKIP (0.000s)
[492.114970] Subtest fbc-psr-primary-page-flip: SKIP (0.001s)
[492.190798] [138/153] (538s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[492.282765] Starting subtest: fbc-psr2-primary-mmap-gtt
[492.284181] Starting dynamic subtest: eDP-1
[492.286099] Dynamic subtest eDP-1: SKIP (0.000s)
[492.288048] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s)
[492.366859] [139/153] (538s left) i915_pm_freq_api (freq-suspend)
[492.422543] Starting subtest: freq-suspend
[492.423561] Starting dynamic subtest: gt0
[508.970244] Dynamic subtest gt0: SUCCESS (1.639s)
[508.983982] Starting dynamic subtest: gt1
[525.972691] Dynamic subtest gt1: SUCCESS (1.615s)
[525.974527] Subtest freq-suspend: SUCCESS (3.257s)
[532.065702] [140/153] (505s left) kms_dsc (dsc-with-formats)
[532.169610] Starting subtest: dsc-with-formats
[532.184881] Subtest dsc-with-formats: SKIP (0.001s)
[532.242856] [141/153] (505s left) gem_pxp (reject-modify-context-protection-off-1)
[532.343378] Starting subtest: reject-modify-context-protection-off-1
[532.344492] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[532.451550] [142/153] (504s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-mmap-wc)
[532.548351] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-mmap-wc
[532.550288] Subtest psrhdr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[532.646619] [143/153] (504s left) syncobj_wait (reset-multiple-signaled)
[532.706269] Starting subtest: reset-multiple-signaled
[532.707436] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[532.829338] [144/153] (504s left) tools_test (sysfs_l3_parity)
[532.867129] Starting subtest: sysfs_l3_parity
[532.956095] Subtest sysfs_l3_parity: SKIP (0.083s)
[533.015812] [145/153] (504s left) gem_exercise_blt (fast-copy)
[533.079094] Starting subtest: fast-copy
[533.080166] Starting dynamic subtest: linear-smem-smem
[533.103710] Dynamic subtest linear-smem-smem: SUCCESS (0.023s)
[533.113845] Starting dynamic subtest: xmajor-smem-smem
[533.124117] Dynamic subtest xmajor-smem-smem: SUCCESS (0.019s)
[533.135913] Starting dynamic subtest: tile4-smem-smem
[533.143496] Dynamic subtest tile4-smem-smem: SUCCESS (0.018s)
[533.153281] Starting dynamic subtest: tile64-smem-smem
[533.162599] Dynamic subtest tile64-smem-smem: SUCCESS (0.018s)
[533.163606] Subtest fast-copy: SUCCESS (0.081s)
[533.272022] [146/153] (504s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[533.364698] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[533.366564] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[533.461366] [147/153] (504s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-pwrite)
[533.548959] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-pwrite
[533.550546] Subtest hdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[533.663317] [148/153] (503s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-mmap-wc)
[533.749862] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-mmap-wc
[533.752202] Subtest hdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[533.845044] [149/153] (503s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-shrfb-plflip-blt)
[533.932841] Starting subtest: fbchdr-2p-scndscrn-shrfb-plflip-blt
[533.934827] Subtest fbchdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[534.036899] [150/153] (503s left) kms_plane_lowres (tiling-y)
[534.127367] Starting subtest: tiling-y
[534.129250] Subtest tiling-y: SKIP (0.000s)
[534.197695] [151/153] (503s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-blt)
[534.292536] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-blt
[534.294365] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[534.386764] [152/153] (503s left) gem_exec_flush (basic-batch-kernel-default-uc)
[534.443343] Starting subtest: basic-batch-kernel-default-uc
[542.009913] Subtest basic-batch-kernel-default-uc: SUCCESS (7.419s)
[542.200386] [153/153] (495s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[542.274657] Starting subtest: y-tiled-to-vebox-yf-tiled
[542.277202] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[542.453942] Closing watchdogs
results: parsing output: 0/ for test: kms_async_flips
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_flip
results: parsing output: 3/ for test: prime_vgem
results: parsing output: 4/ for test: vgem_basic
results: parsing output: 5/ for test: api_intel_bb
results: parsing output: 6/ for test: gem_pxp
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: syncobj_wait
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_userptr_blits
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_frontbuffer_tracking
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_create
results: parsing output: 16/ for test: syncobj_timeline
results: parsing output: 17/ for test: kms_rotation_crc
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: vgem_basic
results: parsing output: 20/ for test: sysfs_preempt_timeout
results: parsing output: 21/ for test: kms_cursor_crc
results: parsing output: 22/ for test: perf_pmu
results: parsing output: 23/ for test: gem_ctx_bad_destroy
results: parsing output: 24/ for test: i915_pm_rps
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: gem_close
results: parsing output: 28/ for test: api_intel_bb
results: parsing output: 29/ for test: kms_prop_blob
results: parsing output: 30/ for test: perf
results: parsing output: 31/ for test: gem_exec_balancer
results: parsing output: 32/ for test: kms_flip_scaled_crc
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: prime_vgem
results: parsing output: 35/ for test: core_setmaster
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_cursor_legacy
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: prime_vgem
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: gem_eio
results: parsing output: 43/ for test: kms_psr
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: kms_plane_alpha_blend
results: parsing output: 46/ for test: kms_flip
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: kms_psr2_sf
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: gem_exec_params
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: kms_flip
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: syncobj_basic
results: parsing output: 57/ for test: gem_exec_reloc
results: parsing output: 58/ for test: kms_dp_aux_dev
results: parsing output: 59/ for test: perf
results: parsing output: 60/ for test: kms_cursor_edge_walk
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_vblank
results: parsing output: 64/ for test: syncobj_timeline
results: parsing output: 65/ for test: gem_exec_reloc
results: parsing output: 66/ for test: gem_ctx_shared
results: parsing output: 67/ for test: gem_exec_fence
results: parsing output: 68/ for test: kms_flip
results: parsing output: 69/ for test: kms_getfb
results: parsing output: 70/ for test: kms_chamelium_color
results: parsing output: 71/ for test: kms_ccs
results: parsing output: 72/ for test: kms_prop_blob
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: i915_query
results: parsing output: 76/ for test: gem_mmap
results: parsing output: 77/ for test: kms_cursor_crc
results: parsing output: 78/ for test: gen9_exec_parse
results: parsing output: 79/ for test: kms_setmode
results: parsing output: 80/ for test: gem_exec_params
results: parsing output: 81/ for test: kms_force_connector_basic
results: parsing output: 82/ for test: gem_exec_schedule
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_flip_scaled_crc
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: kms_legacy_colorkey
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_cursor_legacy
results: parsing output: 91/ for test: gem_exec_schedule
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: gem_exec_balancer
results: parsing output: 94/ for test: kms_chamelium_hpd
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: gem_ctx_persistence
results: parsing output: 97/ for test: kms_plane_scaling
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_concurrent
results: parsing output: 101/ for test: gen7_exec_parse
results: parsing output: 102/ for test: gem_ctx_persistence
results: parsing output: 103/ for test: kms_chamelium_edid
results: parsing output: 104/ for test: gem_mmap_offset
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: gem_render_copy_redux
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_universal_plane
results: parsing output: 114/ for test: kms_plane_scaling
results: parsing output: 115/ for test: gem_ctx_exec
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: kms_async_flips
results: parsing output: 118/ for test: gem_exec_reloc
results: parsing output: 119/ for test: i915_drm_fdinfo
results: parsing output: 120/ for test: fbdev
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: syncobj_wait
results: parsing output: 124/ for test: gem_spin_batch
results: parsing output: 125/ for test: kms_cursor_crc
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_cursor_crc
results: parsing output: 128/ for test: kms_plane
results: parsing output: 129/ for test: kms_joiner
results: parsing output: 130/ for test: syncobj_wait
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: gem_exec_store
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: kms_busy
results: parsing output: 136/ for test: kms_psr
results: parsing output: 137/ for test: kms_psr
results: parsing output: 138/ for test: i915_pm_freq_api
results: parsing output: 139/ for test: kms_dsc
results: parsing output: 140/ for test: gem_pxp
results: parsing output: 141/ for test: kms_frontbuffer_tracking
results: parsing output: 142/ for test: syncobj_wait
results: parsing output: 143/ for test: tools_test
results: parsing output: 144/ for test: gem_exercise_blt
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: kms_plane_lowres
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: gem_exec_flush
results: parsing output: 152/ for test: gem_render_copy
Done.