[57.519537] Initializing watchdogs
[57.519602]   /dev/watchdog0
[57.539569] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[57.550968] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[57.554718] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.557239] [001/132] (960s left) gem_mmap_gtt (basic-write-read-distinct)
[57.632443] Subtest basic-write-read-distinct: SKIP (0.000s)
[57.697182] [002/132] (960s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[57.880253] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[57.895770] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.015s)
[58.019706] [003/132] (960s left) kms_flip (2x-flip-vs-modeset)
[58.203074] Starting subtest: 2x-flip-vs-modeset
[58.218404] Subtest 2x-flip-vs-modeset: SKIP (0.015s)
[58.369608] [004/132] (959s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[58.549778] Starting subtest: cursorB-vs-flipA-varying-size
[58.552665] Subtest cursorB-vs-flipA-varying-size: SKIP (0.002s)
[58.662291] [005/132] (959s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[58.841976] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[58.842947] Starting dynamic subtest: pipe-A-valid-mode
[58.933475] Dynamic subtest pipe-A-valid-mode: SKIP (0.090s)
[58.935383] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.091s)
[59.188596] [006/132] (959s left) kms_getfb (getfb2-accept-nv12)
[59.368167] Starting subtest: getfb2-accept-nv12
[59.370072] Subtest getfb2-accept-nv12: SUCCESS (0.002s)
[59.585909] [007/132] (958s left) kms_psr (pr-sprite-mmap-gtt)
[59.766902] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[59.827910] [008/132] (958s left) kms_cursor_edge_walk (128x128-top-edge)
[60.009691] Starting subtest: 128x128-top-edge
[60.011642] Starting dynamic subtest: pipe-A-DP-3
[63.510152] Dynamic subtest pipe-A-DP-3: SUCCESS (3.510s)
[63.520375] Starting dynamic subtest: pipe-D-DP-3
[66.826434] Dynamic subtest pipe-D-DP-3: SUCCESS (3.321s)
[66.827456] Subtest 128x128-top-edge: SUCCESS (6.834s)
[67.215121] [009/132] (951s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[69.020921] Starting subtest: dpms-mode-unset-lpsp
[69.429209] Subtest dpms-mode-unset-lpsp: SKIP (0.407s)
[69.869488] [010/132] (948s left) kms_plane_scaling (2x-scaler-multi-pipe)
[70.053498] Starting subtest: 2x-scaler-multi-pipe
[70.056271] Subtest 2x-scaler-multi-pipe: SKIP (0.002s)
[70.218338] [011/132] (948s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[70.396532] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[70.397441] Starting dynamic subtest: pipe-A-DP-3
[70.405551] Dynamic subtest pipe-A-DP-3: SUCCESS (0.002s)
[70.413593] Starting dynamic subtest: pipe-B-DP-3
[70.421423] Dynamic subtest pipe-B-DP-3: SUCCESS (0.002s)
[70.429374] Starting dynamic subtest: pipe-C-DP-3
[70.437044] Dynamic subtest pipe-C-DP-3: SUCCESS (0.002s)
[70.444870] Starting dynamic subtest: pipe-D-DP-3
[70.452291] Dynamic subtest pipe-D-DP-3: SUCCESS (0.003s)
[70.453149] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SUCCESS (0.013s)
[70.894698] [012/132] (947s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[71.081412] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[71.083162] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[71.245109] [013/132] (947s left) kms_atomic_transition (modeset-transition)
[71.425938] Starting subtest: modeset-transition
[71.426895] Starting dynamic subtest: 1x-outputs
[74.032937] Dynamic subtest 1x-outputs: SUCCESS (2.607s)
[74.035051] Subtest modeset-transition: SUCCESS (2.608s)
[74.342705] [014/132] (944s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[74.529049] Starting subtest: fbc-rgb565-draw-mmap-wc
[74.530853] Subtest fbc-rgb565-draw-mmap-wc: SKIP (0.000s)
[74.731655] [015/132] (944s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[74.915075] Starting subtest: cursorB-vs-flipA-atomic-transitions
[74.917898] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.002s)
[75.086832] [016/132] (944s left) syncobj_eventfd (invalid-bad-pad)
[75.162212] Starting subtest: invalid-bad-pad
[75.163186] Subtest invalid-bad-pad: SUCCESS (0.000s)
[75.302317] [017/132] (943s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[75.480952] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[75.481917] Starting dynamic subtest: pipe-A-DP-3
[75.485380] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[75.493540] Starting dynamic subtest: pipe-B-DP-3
[75.497183] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[75.505209] Starting dynamic subtest: pipe-C-DP-3
[75.508796] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[75.516760] Starting dynamic subtest: pipe-D-DP-3
[75.520123] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[75.521846] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[75.964222] [018/132] (943s left) i915_hangman (error-state-basic)
[76.057866] Starting subtest: error-state-basic
[76.285819] Subtest error-state-basic: SUCCESS (0.228s)
[76.419635] [019/132] (942s left) gem_ctx_sseu (invalid-args)
[76.503292] Subtest invalid-args: SKIP (0.000s)
[76.575833] [020/132] (942s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[76.761660] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[76.763396] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[76.949232] [021/132] (942s left) gem_mmap_gtt (flink-race)
[77.019939] Subtest flink-race: SKIP (0.000s)
[77.090106] [022/132] (942s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[77.170620] Starting subtest: y-tiled-ccs-to-yf-tiled
[77.172564] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[77.431239] [023/132] (942s left) kms_plane_cursor (primary)
[77.615253] Starting subtest: primary
[77.617075] Starting dynamic subtest: pipe-A-DP-3-size-64
[80.753499] Dynamic subtest pipe-A-DP-3-size-64: SUCCESS (3.136s)
[80.813504] Starting dynamic subtest: pipe-A-DP-3-size-128
[83.869293] Dynamic subtest pipe-A-DP-3-size-128: SUCCESS (3.067s)
[83.931406] Starting dynamic subtest: pipe-A-DP-3-size-256
[87.037306] Dynamic subtest pipe-A-DP-3-size-256: SUCCESS (3.116s)
[87.187355] Starting dynamic subtest: pipe-B-DP-3-size-64
[90.384859] Dynamic subtest pipe-B-DP-3-size-64: SUCCESS (3.205s)
[90.424791] Starting dynamic subtest: pipe-B-DP-3-size-128
[93.534953] Dynamic subtest pipe-B-DP-3-size-128: SUCCESS (3.117s)
[93.574509] Starting dynamic subtest: pipe-B-DP-3-size-256
[96.668582] Dynamic subtest pipe-B-DP-3-size-256: SUCCESS (3.101s)
[96.802493] Starting dynamic subtest: pipe-C-DP-3-size-64
[99.950714] Dynamic subtest pipe-C-DP-3-size-64: SUCCESS (3.156s)
[99.990772] Starting dynamic subtest: pipe-C-DP-3-size-128
[103.133501] Dynamic subtest pipe-C-DP-3-size-128: SUCCESS (3.150s)
[103.178987] Starting dynamic subtest: pipe-C-DP-3-size-256
[106.301172] Dynamic subtest pipe-C-DP-3-size-256: SUCCESS (3.133s)
[106.402648] Starting dynamic subtest: pipe-D-DP-3-size-64
[109.563514] Dynamic subtest pipe-D-DP-3-size-64: SUCCESS (3.169s)
[109.607509] Starting dynamic subtest: pipe-D-DP-3-size-128
[112.713375] Dynamic subtest pipe-D-DP-3-size-128: SUCCESS (3.116s)
[112.753259] Starting dynamic subtest: pipe-D-DP-3-size-256
[115.880194] Dynamic subtest pipe-D-DP-3-size-256: SUCCESS (3.134s)
[115.972259] Subtest primary: SUCCESS (38.356s)
[116.269155] [024/132] (903s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[116.463618] Starting subtest: 4-tiled-16bpp-rotate-90
[116.519597] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.055s)
[116.715772] [025/132] (903s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[116.900898] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[116.902547] Subtest psr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[117.102059] [026/132] (902s left) gen7_exec_parse (bitmasks)
[117.179152] Subtest bitmasks: SKIP (0.000s)
[117.258329] [027/132] (902s left) kms_big_fb (linear-32bpp-rotate-180)
[117.450059] Starting subtest: linear-32bpp-rotate-180
[119.454038] Subtest linear-32bpp-rotate-180: SUCCESS (2.003s)
[119.698248] [028/132] (900s left) gem_pread (bench)
[119.770063] Subtest bench: SKIP (0.000s)
[119.843786] [029/132] (900s left) kms_cursor_crc (cursor-onscreen-64x64)
[120.162294] Starting subtest: cursor-onscreen-64x64
[120.167288] Starting dynamic subtest: pipe-A-DP-3
[122.921573] Dynamic subtest pipe-A-DP-3: SUCCESS (2.753s)
[122.974251] Starting dynamic subtest: pipe-D-DP-3
[125.691450] Dynamic subtest pipe-D-DP-3: SUCCESS (2.725s)
[125.692492] Subtest cursor-onscreen-64x64: SUCCESS (5.528s)
[126.194072] [030/132] (893s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[126.381804] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[126.433978] [031/132] (893s left) gem_userptr_blits (probe)
[126.527758] Starting subtest: probe
[126.652013] Subtest probe: SUCCESS (0.124s)
[126.812877] [032/132] (893s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[126.995364] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[126.996279] Starting dynamic subtest: pipe-A-DP-3
[127.004885] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[127.013614] Starting dynamic subtest: pipe-B-DP-3
[127.022431] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[127.031104] Starting dynamic subtest: pipe-C-DP-3
[127.039504] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[127.048070] Starting dynamic subtest: pipe-D-DP-3
[127.056885] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[127.059032] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[127.499080] [033/132] (892s left) perf (gen12-group-concurrent-oa-buffer-read)
[127.892543] Starting subtest: gen12-group-concurrent-oa-buffer-read
[137.952009] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.059s)
[138.020826] [034/132] (882s left) gem_exec_flush (basic-wb-pro-default)
[138.100534] Subtest basic-wb-pro-default: SKIP (0.000s)
[138.212975] [035/132] (882s left) gem_userptr_blits (dmabuf-unsync)
[138.294267] Subtest dmabuf-unsync: SKIP (0.000s)
[138.512644] [036/132] (881s left) kms_content_protection (lic-type-1)
[138.762418] Starting subtest: lic-type-1
[138.768459] Subtest lic-type-1: SKIP (0.003s)
[139.003307] [037/132] (881s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[139.074082] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[139.154633] [038/132] (881s left) gem_ctx_param (invalid-get-no-zeromap)
[139.225486] Starting subtest: invalid-get-no-zeromap
[139.227445] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[139.364228] [039/132] (881s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[139.555624] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[139.557390] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[139.750814] [040/132] (881s left) kms_getfb (getfb-handle-closed)
[139.934371] Starting subtest: getfb-handle-closed
[139.935275] Subtest getfb-handle-closed: SUCCESS (0.000s)
[140.136585] [041/132] (880s left) i915_pm_rpm (gem-execbuf-stress)
[142.054279] Starting subtest: gem-execbuf-stress
[142.055560] Starting dynamic subtest: lmem0
[145.729556] Dynamic subtest lmem0: SUCCESS (3.676s)
[145.773586] Starting dynamic subtest: extra-wait-lmem0
[199.333406] Dynamic subtest extra-wait-lmem0: SUCCESS (53.600s)
[199.345842] Starting dynamic subtest: smem0
[202.956206] Dynamic subtest smem0: SUCCESS (3.620s)
[202.998198] Starting dynamic subtest: extra-wait-smem0
[256.437852] Dynamic subtest extra-wait-smem0: SUCCESS (53.478s)
[256.439640] Subtest gem-execbuf-stress: SUCCESS (114.386s)
[256.836689] [042/132] (764s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[257.018032] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[257.020415] Starting dynamic subtest: pipe-A-DP-3
[257.028972] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[257.038146] Starting dynamic subtest: pipe-B-DP-3
[257.046446] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[257.055532] Starting dynamic subtest: pipe-C-DP-3
[257.063716] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[257.074379] Starting dynamic subtest: pipe-D-DP-3
[257.083693] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[257.085569] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.006s)
[257.482544] [043/132] (763s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[257.666339] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[257.667245] Starting dynamic subtest: pipe-A-valid-mode
[260.615101] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.947s)
[260.616569] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SUCCESS (2.949s)
[260.916025] [044/132] (760s left) gem_ctx_param (invalid-size-get)
[260.987502] Starting subtest: invalid-size-get
[260.989565] Subtest invalid-size-get: SUCCESS (0.002s)
[261.124082] [045/132] (760s left) gem_lmem_swapping (massive-random)
[263.924704] Starting subtest: massive-random
[263.925532] Starting dynamic subtest: lmem0
[264.251542] Dynamic subtest lmem0: SUCCESS (0.328s)
[264.252430] Subtest massive-random: SUCCESS (0.329s)
[267.963897] [FACT gem_lmem_swapping (massive-random)] deleted: kernel.kmod_is_loaded.i915: true
[267.966012] [046/132] (753s left) gem_close_race (basic-threads)
[269.635452] Starting subtest: basic-threads
[270.882390] Subtest basic-threads: SUCCESS (1.247s)
[271.176054] [FACT gem_close_race (basic-threads)] new: kernel.kmod_is_loaded.i915: true
[271.179449] [047/132] (750s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[271.366248] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs
[271.367182] Starting dynamic subtest: pipe-A-DP-3
[271.375821] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[271.384627] Starting dynamic subtest: pipe-B-DP-3
[271.393122] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[271.401976] Starting dynamic subtest: pipe-C-DP-3
[271.410288] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[271.418973] Starting dynamic subtest: pipe-D-DP-3
[271.427541] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[271.429533] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[271.853353] [048/132] (749s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[272.050418] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[272.052243] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[272.225136] [049/132] (749s left) api_intel_bb (blit-noreloc-keep-cache)
[272.295495] Starting subtest: blit-noreloc-keep-cache
[272.332789] Subtest blit-noreloc-keep-cache: SUCCESS (0.037s)
[272.517612] [050/132] (749s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[272.701167] Starting subtest: fbc-shrfb-scaledprimary
[274.275786] Subtest fbc-shrfb-scaledprimary: SUCCESS (1.574s)
[274.476430] [051/132] (747s left) gem_ctx_persistence (legacy-engines-hang)
[274.555550] Starting subtest: legacy-engines-hang
[274.556431] Starting dynamic subtest: render
[274.665541] Dynamic subtest render: SUCCESS (0.109s)
[274.678403] Starting dynamic subtest: bsd1
[274.759209] Dynamic subtest bsd1: SUCCESS (0.091s)
[274.800962] Starting dynamic subtest: bsd2
[274.827372] Dynamic subtest bsd2: SUCCESS (0.064s)
[274.845302] Starting dynamic subtest: blt
[274.880635] Dynamic subtest blt: SUCCESS (0.051s)
[274.913085] Starting dynamic subtest: vebox
[274.935481] Dynamic subtest vebox: SUCCESS (0.052s)
[274.936627] Subtest legacy-engines-hang: SUCCESS (0.381s)
[275.171820] [052/132] (746s left) kms_plane_scaling (planes-downscale-factor-0-5)
[275.351393] Starting subtest: planes-downscale-factor-0-5
[275.352200] Starting dynamic subtest: pipe-A
[275.440905] Dynamic subtest pipe-A: SUCCESS (0.090s)
[275.451029] Starting dynamic subtest: pipe-B
[275.642257] Dynamic subtest pipe-B: SUCCESS (0.200s)
[275.659385] Starting dynamic subtest: pipe-C
[275.872492] Dynamic subtest pipe-C: SUCCESS (0.229s)
[275.882521] Starting dynamic subtest: pipe-D
[276.069793] Dynamic subtest pipe-D: SUCCESS (0.196s)
[276.070854] Subtest planes-downscale-factor-0-5: SUCCESS (0.720s)
[276.451364] [053/132] (745s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[276.634332] Starting subtest: random-ccs-data-yf-tiled-ccs
[276.635245] Starting dynamic subtest: pipe-A-DP-3
[276.644859] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[276.654200] Starting dynamic subtest: pipe-B-DP-3
[276.664224] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[276.673400] Starting dynamic subtest: pipe-C-DP-3
[276.682795] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[276.691762] Starting dynamic subtest: pipe-D-DP-3
[276.702420] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[276.704429] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.007s)
[277.108518] [054/132] (744s left) kms_frontbuffer_tracking (psr-suspend)
[277.297208] Starting subtest: psr-suspend
[277.298970] Subtest psr-suspend: SKIP (0.000s)
[277.460480] [055/132] (744s left) gem_cs_tlb (engines)
[277.539169] Starting subtest: engines
[277.540144] Starting dynamic subtest: rcs0
[279.694382] Dynamic subtest rcs0: SUCCESS (2.154s)
[279.704280] Starting dynamic subtest: bcs0
[281.849867] Dynamic subtest bcs0: SUCCESS (2.154s)
[281.859725] Starting dynamic subtest: vcs0
[284.004274] Dynamic subtest vcs0: SUCCESS (2.153s)
[284.014084] Starting dynamic subtest: vcs1
[286.157479] Dynamic subtest vcs1: SUCCESS (2.152s)
[286.167230] Starting dynamic subtest: vecs0
[288.310758] Dynamic subtest vecs0: SUCCESS (2.152s)
[288.320511] Starting dynamic subtest: vecs1
[290.464365] Dynamic subtest vecs1: SUCCESS (2.152s)
[290.474279] Starting dynamic subtest: ccs0
[292.618502] Dynamic subtest ccs0: SUCCESS (2.153s)
[292.619610] Subtest engines: SUCCESS (15.079s)
[292.780269] [056/132] (729s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[292.967810] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[293.018570] [057/132] (729s left) gem_tiled_pread_pwrite
[293.183439] [058/132] (728s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[293.370299] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[293.372054] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[293.518791] [059/132] (728s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[293.701283] Starting subtest: cursorB-vs-flipB-varying-size
[293.703127] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[293.855817] [060/132] (728s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[293.942388] Subtest untiled-to-tiled: SKIP (0.000s)
[294.026935] [061/132] (728s left) gem_exec_schedule (u-submit-golden-slice)
[294.115554] Starting subtest: u-submit-golden-slice
[294.116447] Starting dynamic subtest: rcs0
[294.200500] Dynamic subtest rcs0: SUCCESS (0.084s)
[294.211792] Starting dynamic subtest: bcs0
[294.260636] Dynamic subtest bcs0: SUCCESS (0.059s)
[294.270884] Starting dynamic subtest: vcs0
[294.315193] Dynamic subtest vcs0: SUCCESS (0.054s)
[294.326225] Starting dynamic subtest: vcs1
[294.372778] Dynamic subtest vcs1: SUCCESS (0.056s)
[294.384134] Starting dynamic subtest: vecs0
[294.427924] Dynamic subtest vecs0: SUCCESS (0.054s)
[294.437509] Starting dynamic subtest: vecs1
[294.483012] Dynamic subtest vecs1: SUCCESS (0.054s)
[294.492830] Starting dynamic subtest: ccs0
[294.540434] Dynamic subtest ccs0: SUCCESS (0.056s)
[294.541507] Subtest u-submit-golden-slice: SUCCESS (0.425s)
[295.022176] [062/132] (727s left) i915_suspend (sysfs-reader)
[295.104535] Starting subtest: sysfs-reader
[316.598085] Subtest sysfs-reader: SUCCESS (5.798s)
[316.678175] [063/132] (705s left) gem_exec_reloc (basic-gtt)
[316.781192] Subtest basic-gtt: SKIP (0.000s)
[316.873609] [064/132] (705s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[317.056604] Starting subtest: nonblocking-crc-frame-sequence
[317.057518] Starting dynamic subtest: pipe-A-DP-3
[317.743306] Dynamic subtest pipe-A-DP-3: SUCCESS (0.685s)
[317.763951] Starting dynamic subtest: pipe-B-DP-3
[318.388919] Dynamic subtest pipe-B-DP-3: SUCCESS (0.642s)
[318.405994] Starting dynamic subtest: pipe-C-DP-3
[319.052146] Dynamic subtest pipe-C-DP-3: SUCCESS (0.662s)
[319.071803] Starting dynamic subtest: pipe-D-DP-3
[319.689385] Dynamic subtest pipe-D-DP-3: SUCCESS (0.633s)
[319.690439] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.634s)
[319.988031] [065/132] (702s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[320.064785] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[320.175112] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.109s)
[320.324746] [066/132] (702s left) gem_exec_balancer (parallel-balancer)
[320.736395] Starting subtest: parallel-balancer
[322.342806] Subtest parallel-balancer: SUCCESS (1.606s)
[322.490039] [067/132] (700s left) gem_exec_fence (concurrent)
[322.719544] Starting subtest: concurrent
[322.722209] Subtest concurrent: SKIP (0.000s)
[323.511556] [FACT gem_exec_fence (concurrent)] new: kernel.kmod_is_loaded.vgem: true
[323.513715] [068/132] (699s left) kms_psr (fbc-psr-cursor-plane-onoff)
[323.704656] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s)
[323.776627] [069/132] (699s left) gem_exec_params (invalid-fence-in-submit)
[323.861697] Starting subtest: invalid-fence-in-submit
[323.865469] Subtest invalid-fence-in-submit: SUCCESS (0.003s)
[324.100740] [070/132] (698s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[324.297346] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[324.299157] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[324.444335] [071/132] (698s left) kms_dsc (dsc-with-bpc-formats)
[324.636545] Starting subtest: dsc-with-bpc-formats
[324.695761] Subtest dsc-with-bpc-formats: SKIP (0.005s)
[324.813839] [072/132] (698s left) device_reset (unbind-cold-reset-rebind)
[324.900737] Starting subtest: unbind-cold-reset-rebind
[324.902782] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[325.043688] [073/132] (698s left) kms_psr (psr2-sprite-mmap-gtt)
[325.236872] Subtest psr2-sprite-mmap-gtt: SKIP (0.000s)
[325.313024] [074/132] (697s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[325.519522] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[325.521408] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[325.733927] [075/132] (697s left) kms_colorop (plane-xr24-xr24-pq_125_eotf)
[326.031382] Subtest plane-XR24-XR24-pq_125_eotf: SKIP (0.000s)
[326.221698] [076/132] (697s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[326.441188] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[326.442110] Starting dynamic subtest: pipe-A
[328.379454] Dynamic subtest pipe-A: SUCCESS (1.938s)
[328.405291] Starting dynamic subtest: pipe-B
[330.525848] Dynamic subtest pipe-B: SUCCESS (2.144s)
[330.550512] Starting dynamic subtest: pipe-C
[330.838268] Dynamic subtest pipe-C: SUCCESS (0.310s)
[330.862009] Starting dynamic subtest: pipe-D
[331.167635] Dynamic subtest pipe-D: SUCCESS (0.328s)
[331.168660] Subtest plane-downscale-factor-0-5-with-pixel-format: SUCCESS (4.727s)
[331.510392] [077/132] (691s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[331.704677] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[334.314289] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (2.610s)
[334.581029] [078/132] (688s left) kms_setmode (invalid-clone-single-crtc)
[334.660803] Starting subtest: invalid-clone-single-crtc
[334.663579] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[334.830681] [079/132] (688s left) gem_userptr_blits (unsync-unmap-cycles)
[334.919462] Subtest unsync-unmap-cycles: SKIP (0.000s)
[335.117703] [080/132] (688s left) perf_pmu (idle)
[335.190023] Starting subtest: idle
[335.190911] Starting dynamic subtest: rcs0
[335.773740] Dynamic subtest rcs0: SUCCESS (0.579s)
[335.786823] Starting dynamic subtest: bcs0
[336.288774] Dynamic subtest bcs0: SUCCESS (0.516s)
[336.303933] Starting dynamic subtest: vcs0
[336.805784] Dynamic subtest vcs0: SUCCESS (0.513s)
[336.821706] Starting dynamic subtest: vcs1
[337.325819] Dynamic subtest vcs1: SUCCESS (0.516s)
[337.341739] Starting dynamic subtest: vecs0
[337.842991] Dynamic subtest vecs0: SUCCESS (0.513s)
[337.858179] Starting dynamic subtest: vecs1
[338.361940] Dynamic subtest vecs1: SUCCESS (0.515s)
[338.377466] Starting dynamic subtest: ccs0
[338.882589] Dynamic subtest ccs0: SUCCESS (0.516s)
[338.885420] Subtest idle: SUCCESS (3.694s)
[339.052412] [081/132] (684s left) gem_exec_schedule (noreorder)
[339.294745] Starting subtest: noreorder
[339.299047] Starting dynamic subtest: rcs0
[339.409785] Dynamic subtest rcs0: SUCCESS (0.114s)
[339.430889] Starting dynamic subtest: bcs0
[339.478235] Dynamic subtest bcs0: SUCCESS (0.066s)
[339.529437] Starting dynamic subtest: vcs0
[339.562468] Dynamic subtest vcs0: SUCCESS (0.081s)
[339.584239] Starting dynamic subtest: vcs1
[339.630142] Dynamic subtest vcs1: SUCCESS (0.066s)
[339.671207] Starting dynamic subtest: vecs0
[339.724861] Dynamic subtest vecs0: SUCCESS (0.092s)
[339.769822] Starting dynamic subtest: vecs1
[339.824169] Dynamic subtest vecs1: SUCCESS (0.096s)
[339.871013] Starting dynamic subtest: ccs0
[339.922078] Dynamic subtest ccs0: SUCCESS (0.095s)
[339.931631] Subtest noreorder: SUCCESS (0.629s)
[340.188598] [082/132] (683s left) syncobj_timeline (signal)
[340.267766] Starting subtest: signal
[340.268686] Subtest signal: SUCCESS (0.000s)
[340.444508] [083/132] (683s left) kms_prop_blob (blob-prop-validate)
[340.525103] Starting subtest: blob-prop-validate
[340.526029] Subtest blob-prop-validate: SUCCESS (0.000s)
[340.675408] [084/132] (683s left) kms_psr (fbc-pr-dpms)
[340.861808] Subtest fbc-pr-dpms: SKIP (0.000s)
[340.927704] [085/132] (683s left) kms_chamelium_frames (hdmi-crc-single)
[341.208732] Subtest hdmi-crc-single: SKIP (0.000s)
[341.367806] [086/132] (682s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[341.561998] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[341.563735] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[341.726958] [087/132] (682s left) kms_cursor_crc (cursor-size-change)
[341.920640] Starting subtest: cursor-size-change
[341.921530] Starting dynamic subtest: pipe-A-DP-3
[342.900668] Dynamic subtest pipe-A-DP-3: SUCCESS (0.978s)
[342.920818] Starting dynamic subtest: pipe-D-DP-3
[343.701889] Dynamic subtest pipe-D-DP-3: SUCCESS (0.798s)
[343.702929] Subtest cursor-size-change: SUCCESS (1.782s)
[344.375810] [088/132] (679s left) kms_color (invalid-ctm-matrix-sizes)
[344.605182] Starting subtest: invalid-ctm-matrix-sizes
[344.606126] Starting dynamic subtest: pipe-A
[344.608603] Dynamic subtest pipe-A: SUCCESS (0.003s)
[344.623358] Starting dynamic subtest: pipe-B
[344.624301] Dynamic subtest pipe-B: SUCCESS (0.005s)
[344.637908] Starting dynamic subtest: pipe-C
[344.638812] Dynamic subtest pipe-C: SUCCESS (0.006s)
[344.652146] Starting dynamic subtest: pipe-D
[344.653386] Dynamic subtest pipe-D: SUCCESS (0.006s)
[344.654602] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.024s)
[344.791969] [089/132] (679s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[344.871696] Starting subtest: invalid-multi-wait-all-unsubmitted
[344.872849] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[345.019841] [090/132] (679s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[345.214691] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[347.925767] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (2.712s)
[348.116901] [091/132] (676s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[348.304732] Starting subtest: short-flip-before-cursor-toggle
[349.348400] Subtest short-flip-before-cursor-toggle: SUCCESS (1.045s)
[349.666153] [092/132] (674s left) kms_async_flips (async-flip-suspend-resume)
[349.854549] Starting subtest: async-flip-suspend-resume
[350.080415] Starting dynamic subtest: pipe-A-DP-3
[371.031824] Dynamic subtest pipe-A-DP-3: SUCCESS (5.005s)
[371.233442] Starting dynamic subtest: pipe-B-DP-3
[391.452983] Dynamic subtest pipe-B-DP-3: SUCCESS (4.669s)
[391.636957] Starting dynamic subtest: pipe-C-DP-3
[411.893182] Dynamic subtest pipe-C-DP-3: SUCCESS (4.084s)
[412.071907] Starting dynamic subtest: pipe-D-DP-3
[432.252007] Dynamic subtest pipe-D-DP-3: SUCCESS (4.522s)
[432.252941] Subtest async-flip-suspend-resume: SUCCESS (19.038s)
[432.731530] [093/132] (591s left) gem_exec_params (invalid-ring)
[432.819876] Starting subtest: invalid-ring
[432.820843] Subtest invalid-ring: SUCCESS (0.000s)
[433.028249] [094/132] (591s left) gem_ccs (block-multicopy-inplace)
[433.116098] Starting subtest: block-multicopy-inplace
[433.117024] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0-multicopy
[433.162238] Dynamic subtest linear-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.045s)
[433.177410] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0-multicopy
[433.262393] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.099s)
[433.277258] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0-multicopy
[433.278160] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.014s)
[433.291893] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0-multicopy
[433.384105] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.105s)
[433.398888] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0-multicopy
[433.399835] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.014s)
[433.413439] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0-multicopy
[433.499142] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.099s)
[433.514276] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0-multicopy
[433.515725] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.015s)
[433.530814] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0-multicopy
[433.615550] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.099s)
[433.616520] Subtest block-multicopy-inplace: SUCCESS (0.500s)
[433.787162] [095/132] (590s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[434.120225] Starting subtest: cursor-rapid-movement-64x64
[434.125538] Starting dynamic subtest: pipe-A-DP-3
[434.606108] Dynamic subtest pipe-A-DP-3: SUCCESS (0.480s)
[434.657444] Starting dynamic subtest: pipe-D-DP-3
[435.035893] Dynamic subtest pipe-D-DP-3: SUCCESS (0.391s)
[435.036921] Subtest cursor-rapid-movement-64x64: SUCCESS (0.915s)
[435.604580] [096/132] (589s left) kms_psr (psr-sprite-blt)
[435.798592] Subtest psr-sprite-blt: SKIP (0.000s)
[435.857649] [097/132] (589s left) gem_ctx_param (basic)
[435.943406] Starting subtest: basic
[435.945798] Subtest basic: SUCCESS (0.001s)
[436.135172] [098/132] (588s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[436.215131] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[436.216084] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[436.387534] [099/132] (588s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[436.581629] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[436.583510] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[436.782500] [100/132] (588s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[437.053983] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[437.202903] [101/132] (588s left) gem_render_copy_redux (interruptible)
[437.293980] Starting subtest: interruptible
[438.102845] Subtest interruptible: SUCCESS (0.809s)
[438.316665] [102/132] (587s left) gem_workarounds (reset-fd)
[438.412994] Starting subtest: reset-fd
[438.644755] Subtest reset-fd: SUCCESS (0.232s)
[438.849729] [103/132] (586s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[439.043689] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[439.045522] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[439.230469] [104/132] (586s left) perf (enable-disable)
[439.669069] Starting subtest: enable-disable
[439.669981] Starting dynamic subtest: 0-rcs0
[441.945232] Dynamic subtest 0-rcs0: SUCCESS (2.276s)
[441.946138] Subtest enable-disable: SUCCESS (2.278s)
[442.023039] [105/132] (583s left) prime_mmap (test_correct_cpu_write)
[442.122580] Starting subtest: test_correct_cpu_write
[442.123543] Starting dynamic subtest: test_correct_cpu_write-smem
[442.124481] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[442.139304] Starting dynamic subtest: test_correct_cpu_write-lmem0
[442.140359] Dynamic subtest test_correct_cpu_write-lmem0: SUCCESS (0.000s)
[442.141450] Subtest test_correct_cpu_write: SUCCESS (0.003s)
[442.327104] [106/132] (583s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[442.521667] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[442.523485] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[442.682513] [107/132] (583s left) gem_softpin (allocator-basic-reserve)
[442.768977] Starting subtest: allocator-basic-reserve
[443.001901] Subtest allocator-basic-reserve: SUCCESS (0.226s)
[443.198807] [108/132] (582s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[443.391257] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[443.392106] Starting dynamic subtest: pipe-A
[445.011681] Dynamic subtest pipe-A: SUCCESS (1.620s)
[445.043801] Starting dynamic subtest: pipe-B
[446.741221] Dynamic subtest pipe-B: SUCCESS (1.728s)
[446.769785] Starting dynamic subtest: pipe-C
[447.054903] Dynamic subtest pipe-C: SUCCESS (0.312s)
[447.088040] Starting dynamic subtest: pipe-D
[447.369655] Dynamic subtest pipe-D: SUCCESS (0.312s)
[447.370659] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (3.979s)
[447.704291] [109/132] (578s left) perf (buffer-fill)
[447.937390] Starting subtest: buffer-fill
[447.938404] Starting dynamic subtest: 0-rcs0
[450.112096] Dynamic subtest 0-rcs0: SUCCESS (2.174s)
[450.113072] Subtest buffer-fill: SUCCESS (2.175s)
[450.168348] [110/132] (575s left) prime_vgem (basic-blt)
[450.271030] Starting subtest: basic-blt
[450.336183] Subtest basic-blt: SUCCESS (0.065s)
[450.566079] [111/132] (575s left) gem_exec_suspend (basic-s4-devices)
[450.653942] Starting subtest: basic-S4-devices
[450.654888] Starting dynamic subtest: smem
[461.475391] Dynamic subtest smem: SUCCESS (10.821s)
[461.492605] Starting dynamic subtest: lmem0
[472.082483] Dynamic subtest lmem0: SUCCESS (10.606s)
[472.083564] Subtest basic-S4-devices: SUCCESS (21.429s)
[481.361768] [112/132] (553s left) prime_self_import (basic-llseek-size)
[481.414864] Starting subtest: basic-llseek-size
[481.451134] Subtest basic-llseek-size: SUCCESS (0.036s)
[481.596344] [113/132] (553s left) syncobj_wait (single-wait-all-for-submit-submitted)
[481.678095] Starting subtest: single-wait-all-for-submit-submitted
[481.785805] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.106s)
[481.913733] [114/132] (553s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[482.105589] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[482.107360] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[482.263680] [115/132] (553s left) i915_drm_fdinfo (all-busy-check-all)
[482.336861] Starting subtest: all-busy-check-all
[482.370052] Subtest all-busy-check-all: SKIP (0.032s)
[482.553259] [116/132] (552s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[482.831026] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[482.832850] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[483.049305] [117/132] (552s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[483.250998] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[483.252761] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[483.445591] [118/132] (552s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[483.534878] Starting subtest: x-tiled-to-vebox-yf-tiled
[483.536887] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[483.781649] [119/132] (551s left) api_intel_bb (misplaced-blitter)
[483.861266] Starting subtest: misplaced-blitter
[483.895189] Subtest misplaced-blitter: SUCCESS (0.034s)
[484.111118] [120/132] (551s left) kms_big_fb (x-tiled-addfb)
[484.310930] Starting subtest: x-tiled-addfb
[484.311883] Subtest x-tiled-addfb: SUCCESS (0.000s)
[484.511214] [121/132] (551s left) kms_vblank (wait-forked)
[484.709461] Starting subtest: wait-forked
[484.712036] Starting dynamic subtest: pipe-A-DP-3
[487.104357] Dynamic subtest pipe-A-DP-3: SUCCESS (2.393s)
[487.137982] Starting dynamic subtest: pipe-D-DP-3
[489.436794] Dynamic subtest pipe-D-DP-3: SUCCESS (2.321s)
[489.438024] Subtest wait-forked: SUCCESS (4.727s)
[489.743009] [122/132] (546s left) kms_joiner (basic-max-non-joiner)
[489.939523] Starting subtest: basic-max-non-joiner
[489.941184] Subtest basic-max-non-joiner: SKIP (0.000s)
[490.122632] [123/132] (545s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[490.328558] Starting subtest: yf-tiled-32bpp-rotate-0
[490.330362] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[490.532471] [124/132] (545s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[490.726096] Starting subtest: primary-4-tiled-reflect-x-0
[501.057933] Subtest primary-4-tiled-reflect-x-0: SUCCESS (10.331s)
[501.505654] [125/132] (534s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[501.702185] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[501.703883] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[501.909946] [126/132] (534s left) gem_exec_schedule (submit-early-slice)
[502.008068] Starting subtest: submit-early-slice
[502.009016] Starting dynamic subtest: rcs0
[502.089577] Dynamic subtest rcs0: SUCCESS (0.081s)
[502.106452] Starting dynamic subtest: bcs0
[502.144656] Dynamic subtest bcs0: SUCCESS (0.054s)
[502.161456] Starting dynamic subtest: vcs0
[502.199782] Dynamic subtest vcs0: SUCCESS (0.054s)
[502.216586] Starting dynamic subtest: vcs1
[502.254035] Dynamic subtest vcs1: SUCCESS (0.053s)
[502.270777] Starting dynamic subtest: vecs0
[502.309045] Dynamic subtest vecs0: SUCCESS (0.054s)
[502.325831] Starting dynamic subtest: vecs1
[502.365862] Dynamic subtest vecs1: SUCCESS (0.056s)
[502.382595] Starting dynamic subtest: ccs0
[502.421956] Dynamic subtest ccs0: SUCCESS (0.055s)
[502.422887] Subtest submit-early-slice: SUCCESS (0.414s)
[502.950780] [127/132] (533s left) kms_colorop (plane-xr30-xr30-pq_inv_eotf)
[503.251832] Subtest plane-XR30-XR30-pq_inv_eotf: SKIP (0.000s)
[503.433275] [128/132] (533s left) gem_close (basic)
[503.516120] Starting subtest: basic
[503.517046] Subtest basic: SUCCESS (0.000s)
[503.692801] [129/132] (532s left) syncobj_timeline (wait-any-complex)
[503.780354] Starting subtest: wait-any-complex
[503.842432] Subtest wait-any-complex: SUCCESS (0.062s)
[503.972412] [130/132] (532s left) gem_exec_fence (parallel)
[504.188358] Starting subtest: parallel
[504.189283] Starting dynamic subtest: rcs0
[506.336992] Dynamic subtest rcs0: SUCCESS (2.153s)
[506.353920] Starting dynamic subtest: bcs0
[508.490719] Dynamic subtest bcs0: SUCCESS (2.152s)
[508.508030] Starting dynamic subtest: vcs0
[510.641792] Dynamic subtest vcs0: SUCCESS (2.150s)
[510.658455] Starting dynamic subtest: vcs1
[512.798761] Dynamic subtest vcs1: SUCCESS (2.156s)
[512.815844] Starting dynamic subtest: vecs0
[514.950156] Dynamic subtest vecs0: SUCCESS (2.150s)
[514.966994] Starting dynamic subtest: vecs1
[517.106956] Dynamic subtest vecs1: SUCCESS (2.155s)
[517.123346] Starting dynamic subtest: ccs0
[519.260299] Dynamic subtest ccs0: SUCCESS (2.152s)
[519.261176] Subtest parallel: SUCCESS (15.076s)
[520.061419] [131/132] (516s left) syncobj_basic (bad-flags-handle-to-fd)
[520.143044] Starting subtest: bad-flags-handle-to-fd
[520.143966] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[520.355489] [132/132] (516s left) kms_dsc (dsc-fractional-bpp)
[520.544027] Starting subtest: dsc-fractional-bpp
[520.549280] Subtest dsc-fractional-bpp: SKIP (0.000s)
[520.712930] Closing watchdogs
results: parsing output: 0/ for test: gem_mmap_gtt
results: parsing output: 1/ for test: kms_flip
results: parsing output: 2/ for test: kms_flip
results: parsing output: 3/ for test: kms_cursor_legacy
results: parsing output: 4/ for test: kms_flip_scaled_crc
results: parsing output: 5/ for test: kms_getfb
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: kms_cursor_edge_walk
results: parsing output: 8/ for test: kms_pm_rpm
results: parsing output: 9/ for test: kms_plane_scaling
results: parsing output: 10/ for test: kms_ccs
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_atomic_transition
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_cursor_legacy
results: parsing output: 15/ for test: syncobj_eventfd
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: i915_hangman
results: parsing output: 18/ for test: gem_ctx_sseu
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gem_mmap_gtt
results: parsing output: 21/ for test: gem_render_copy
results: parsing output: 22/ for test: kms_plane_cursor
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gen7_exec_parse
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: gem_pread
results: parsing output: 28/ for test: kms_cursor_crc
results: parsing output: 29/ for test: kms_psr2_sf
results: parsing output: 30/ for test: gem_userptr_blits
results: parsing output: 31/ for test: kms_ccs
results: parsing output: 32/ for test: perf
results: parsing output: 33/ for test: gem_exec_flush
results: parsing output: 34/ for test: gem_userptr_blits
results: parsing output: 35/ for test: kms_content_protection
results: parsing output: 36/ for test: gem_mmap_gtt
results: parsing output: 37/ for test: gem_ctx_param
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_getfb
results: parsing output: 40/ for test: i915_pm_rpm
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: kms_flip_scaled_crc
results: parsing output: 43/ for test: gem_ctx_param
results: parsing output: 44/ for test: gem_lmem_swapping
results: parsing output: 45/ for test: gem_close_race
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: api_intel_bb
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_ctx_persistence
results: parsing output: 51/ for test: kms_plane_scaling
results: parsing output: 52/ for test: kms_ccs
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_cs_tlb
results: parsing output: 55/ for test: kms_psr2_sf
results: parsing output: 56/ for test: gem_tiled_pread_pwrite
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_cursor_legacy
results: parsing output: 59/ for test: gem_set_tiling_vs_blt
results: parsing output: 60/ for test: gem_exec_schedule
results: parsing output: 61/ for test: i915_suspend
results: parsing output: 62/ for test: gem_exec_reloc
results: parsing output: 63/ for test: kms_pipe_crc_basic
results: parsing output: 64/ for test: syncobj_timeline
results: parsing output: 65/ for test: gem_exec_balancer
results: parsing output: 66/ for test: gem_exec_fence
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: gem_exec_params
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_dsc
results: parsing output: 71/ for test: device_reset
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: kms_colorop
results: parsing output: 75/ for test: kms_plane_scaling
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_setmode
results: parsing output: 78/ for test: gem_userptr_blits
results: parsing output: 79/ for test: perf_pmu
results: parsing output: 80/ for test: gem_exec_schedule
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: kms_prop_blob
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: kms_chamelium_frames
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_cursor_crc
results: parsing output: 87/ for test: kms_color
results: parsing output: 88/ for test: syncobj_timeline
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_cursor_legacy
results: parsing output: 91/ for test: kms_async_flips
results: parsing output: 92/ for test: gem_exec_params
results: parsing output: 93/ for test: gem_ccs
results: parsing output: 94/ for test: kms_cursor_crc
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: gem_ctx_param
results: parsing output: 97/ for test: syncobj_timeline
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_chamelium_hpd
results: parsing output: 100/ for test: gem_render_copy_redux
results: parsing output: 101/ for test: gem_workarounds
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: perf
results: parsing output: 104/ for test: prime_mmap
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_softpin
results: parsing output: 107/ for test: kms_plane_scaling
results: parsing output: 108/ for test: perf
results: parsing output: 109/ for test: prime_vgem
results: parsing output: 110/ for test: gem_exec_suspend
results: parsing output: 111/ for test: prime_self_import
results: parsing output: 112/ for test: syncobj_wait
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: i915_drm_fdinfo
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: gem_render_copy
results: parsing output: 118/ for test: api_intel_bb
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: kms_vblank
results: parsing output: 121/ for test: kms_joiner
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: kms_rotation_crc
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_exec_schedule
results: parsing output: 126/ for test: kms_colorop
results: parsing output: 127/ for test: gem_close
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: gem_exec_fence
results: parsing output: 130/ for test: syncobj_basic
results: parsing output: 131/ for test: kms_dsc
Done.