[62.650977] Initializing watchdogs
[62.651051]   /dev/watchdog0
[62.671729] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[62.683173] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[62.686811] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.689193] [001/132] (960s left) kms_cursor_edge_walk (128x128-left-edge)
[62.885100] Starting subtest: 128x128-left-edge
[62.886004] Starting dynamic subtest: pipe-A-DP-3
[66.341208] Dynamic subtest pipe-A-DP-3: SUCCESS (3.457s)
[66.350897] Starting dynamic subtest: pipe-D-DP-3
[69.643590] Dynamic subtest pipe-D-DP-3: SUCCESS (3.303s)
[69.644538] Subtest 128x128-left-edge: SUCCESS (6.763s)
[69.944709] [002/132] (953s left) kms_psr (psr2-cursor-mmap-gtt)
[70.126481] Subtest psr2-cursor-mmap-gtt: SKIP (0.000s)
[70.217802] [003/132] (953s left) kms_cursor_legacy (single-move)
[70.392948] Starting subtest: single-move
[70.393909] Starting dynamic subtest: pipe-A
[75.772227] Dynamic subtest pipe-A: SUCCESS (5.381s)
[75.780222] Starting dynamic subtest: pipe-B
[81.149920] Dynamic subtest pipe-B: SUCCESS (5.378s)
[81.157801] Starting dynamic subtest: pipe-C
[86.527364] Dynamic subtest pipe-C: SUCCESS (5.378s)
[86.535352] Starting dynamic subtest: pipe-D
[91.905868] Dynamic subtest pipe-D: SUCCESS (5.379s)
[91.913811] Starting dynamic subtest: all-pipes
[97.284534] Dynamic subtest all-pipes: SUCCESS (5.379s)
[97.285430] Subtest single-move: SUCCESS (26.896s)
[97.408559] [004/132] (925s left) dumb_buffer (invalid-bpp)
[97.477962] Starting subtest: invalid-bpp
[97.479171] Subtest invalid-bpp: SUCCESS (0.000s)
[97.660713] [005/132] (925s left) kms_fbcon_fbt (fbc)
[97.738224] Starting subtest: fbc
[101.349346] Subtest fbc: SUCCESS (3.610s)
[101.437415] [006/132] (922s left) gen9_exec_parse (bb-start-far)
[101.520719] Subtest bb-start-far: SKIP (0.000s)
[101.569504] [007/132] (921s left) kms_vblank (ts-continuation-dpms-suspend)
[101.749102] Starting subtest: ts-continuation-dpms-suspend
[101.749971] Starting dynamic subtest: pipe-A-DP-3
[121.719696] Dynamic subtest pipe-A-DP-3: SUCCESS (4.250s)
[121.730830] Starting dynamic subtest: pipe-D-DP-3
[140.991926] Dynamic subtest pipe-D-DP-3: SUCCESS (3.907s)
[140.992864] Subtest ts-continuation-dpms-suspend: SUCCESS (8.161s)
[141.331919] [008/132] (882s left) gem_tiled_swapping (non-threaded)
[141.406111] Subtest non-threaded: SKIP (0.000s)
[141.490556] [009/132] (882s left) api_intel_bb (object-noreloc-keep-cache-simple)
[141.564081] Starting subtest: object-noreloc-keep-cache-simple
[141.597195] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.033s)
[141.804741] [010/132] (882s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[141.987601] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[142.050124] [011/132] (881s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[142.234438] Starting subtest: psr-1p-primscrn-spr-indfb-move
[142.236132] Subtest psr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[142.447638] [012/132] (881s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[142.629423] Starting subtest: fbcpsr-tiling-4
[142.631097] Subtest fbcpsr-tiling-4: SKIP (0.000s)
[142.887292] [013/132] (881s left) kms_invalid_mode (overflow-vrefresh)
[143.067833] Starting subtest: overflow-vrefresh
[143.068768] Starting dynamic subtest: pipe-A-DP-3
[143.150770] Dynamic subtest pipe-A-DP-3: SUCCESS (0.083s)
[143.164630] Starting dynamic subtest: pipe-B-DP-3
[143.165789] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[143.178692] Starting dynamic subtest: pipe-C-DP-3
[143.179656] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[143.191981] Starting dynamic subtest: pipe-D-DP-3
[143.192944] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[143.193864] Subtest overflow-vrefresh: SUCCESS (0.090s)
[143.429035] [014/132] (880s left) gem_mmap (basic-small-bo)
[143.506899] Subtest basic-small-bo: SKIP (0.000s)
[143.623743] [015/132] (880s left) syncobj_timeline (single-wait-available-signaled)
[143.694104] Starting subtest: single-wait-available-signaled
[143.695100] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[143.860161] [016/132] (880s left) prime_mmap_kms (buffer-sharing)
[144.037508] Starting subtest: buffer-sharing
[144.376646] Subtest buffer-sharing: SUCCESS (0.338s)
[144.710304] [017/132] (879s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[144.888018] Starting subtest: async-flip-with-page-flip-events-tiled
[145.112592] Starting dynamic subtest: pipe-A-DP-3-4
[147.380102] Dynamic subtest pipe-A-DP-3-4: SUCCESS (2.267s)
[147.390618] Starting dynamic subtest: pipe-A-DP-3-x
[149.578525] Dynamic subtest pipe-A-DP-3-x: SUCCESS (2.198s)
[149.825117] Starting dynamic subtest: pipe-B-DP-3-4
[152.056468] Dynamic subtest pipe-B-DP-3-4: SUCCESS (2.241s)
[152.068596] Starting dynamic subtest: pipe-B-DP-3-x
[154.221810] Dynamic subtest pipe-B-DP-3-x: SUCCESS (2.165s)
[154.434416] Starting dynamic subtest: pipe-C-DP-3-4
[156.655522] Dynamic subtest pipe-C-DP-3-4: SUCCESS (2.231s)
[156.665746] Starting dynamic subtest: pipe-C-DP-3-x
[158.820866] Dynamic subtest pipe-C-DP-3-x: SUCCESS (2.165s)
[159.028972] Starting dynamic subtest: pipe-D-DP-3-4
[161.252719] Dynamic subtest pipe-D-DP-3-4: SUCCESS (2.233s)
[161.265333] Starting dynamic subtest: pipe-D-DP-3-x
[163.418084] Dynamic subtest pipe-D-DP-3-x: SUCCESS (2.165s)
[163.418981] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (18.531s)
[163.932593] [018/132] (860s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[164.118400] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[164.120054] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[164.348345] [019/132] (860s left) gem_wait (write-busy)
[164.431523] Starting subtest: write-busy
[164.432407] Starting dynamic subtest: all-engines
[165.060908] Dynamic subtest all-engines: SUCCESS (0.629s)
[165.071974] Starting dynamic subtest: rcs0
[165.604793] Dynamic subtest rcs0: SUCCESS (0.544s)
[165.615507] Starting dynamic subtest: bcs0
[166.146316] Dynamic subtest bcs0: SUCCESS (0.541s)
[166.156891] Starting dynamic subtest: vcs0
[166.687069] Dynamic subtest vcs0: SUCCESS (0.540s)
[166.697587] Starting dynamic subtest: vcs1
[167.227822] Dynamic subtest vcs1: SUCCESS (0.541s)
[167.238346] Starting dynamic subtest: vecs0
[167.769990] Dynamic subtest vecs0: SUCCESS (0.542s)
[167.780490] Starting dynamic subtest: vecs1
[168.310866] Dynamic subtest vecs1: SUCCESS (0.541s)
[168.321473] Starting dynamic subtest: ccs0
[168.852005] Dynamic subtest ccs0: SUCCESS (0.541s)
[168.853069] Subtest write-busy: SUCCESS (4.421s)
[169.198050] [FACT gem_wait (write-busy)] new: kernel.kmod_is_loaded.vgem: true
[169.199773] [020/132] (855s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[169.286449] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[169.288396] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[169.532053] [021/132] (855s left) kms_psr (psr-sprite-mmap-gtt)
[169.714344] Subtest psr-sprite-mmap-gtt: SKIP (0.000s)
[169.812105] [022/132] (855s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[170.002415] Starting subtest: fbcpsr-suspend
[170.004123] Subtest fbcpsr-suspend: SKIP (0.000s)
[170.174033] [023/132] (854s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[170.363479] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[170.365141] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[170.551424] [024/132] (854s left) kms_async_flips (invalid-async-flip-atomic)
[170.735891] Starting subtest: invalid-async-flip-atomic
[170.968204] Starting dynamic subtest: pipe-A-DP-3
[171.345451] Dynamic subtest pipe-A-DP-3: SUCCESS (0.377s)
[171.578617] Starting dynamic subtest: pipe-B-DP-3
[171.713425] Dynamic subtest pipe-B-DP-3: SUCCESS (0.145s)
[171.914907] Starting dynamic subtest: pipe-C-DP-3
[172.059148] Dynamic subtest pipe-C-DP-3: SUCCESS (0.155s)
[172.259449] Starting dynamic subtest: pipe-D-DP-3
[172.403257] Dynamic subtest pipe-D-DP-3: SUCCESS (0.156s)
[172.404286] Subtest invalid-async-flip-atomic: SUCCESS (1.670s)
[172.889531] [025/132] (852s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[173.078577] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[173.079446] Starting dynamic subtest: pipe-A-DP-3
[173.088023] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[173.098068] Starting dynamic subtest: pipe-B-DP-3
[173.106406] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[173.116298] Starting dynamic subtest: pipe-C-DP-3
[173.124394] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[173.134562] Starting dynamic subtest: pipe-D-DP-3
[173.145469] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[173.147401] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[173.566397] [026/132] (851s left) perf_pmu (idle)
[173.638142] Starting subtest: idle
[173.639075] Starting dynamic subtest: rcs0
[174.220124] Dynamic subtest rcs0: SUCCESS (0.581s)
[174.232121] Starting dynamic subtest: bcs0
[174.735976] Dynamic subtest bcs0: SUCCESS (0.515s)
[174.747400] Starting dynamic subtest: vcs0
[175.252359] Dynamic subtest vcs0: SUCCESS (0.513s)
[175.263455] Starting dynamic subtest: vcs1
[175.766039] Dynamic subtest vcs1: SUCCESS (0.515s)
[175.779149] Starting dynamic subtest: vecs0
[176.284045] Dynamic subtest vecs0: SUCCESS (0.517s)
[176.296795] Starting dynamic subtest: vecs1
[176.801920] Dynamic subtest vecs1: SUCCESS (0.517s)
[176.815109] Starting dynamic subtest: ccs0
[177.327346] Dynamic subtest ccs0: SUCCESS (0.522s)
[177.328275] Subtest idle: SUCCESS (3.691s)
[177.491184] [027/132] (847s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[177.571199] Starting subtest: invalid-signal-one-illegal-handle
[177.572116] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[177.740035] [028/132] (847s left) kms_pm_dc (dc3co-vpb-simulation)
[178.936116] Starting subtest: dc3co-vpb-simulation
[178.937946] Subtest dc3co-vpb-simulation: SKIP (0.000s)
[179.093285] [029/132] (846s left) gen9_exec_parse (shadow-peek)
[179.181524] Subtest shadow-peek: SKIP (0.000s)
[179.272404] [030/132] (846s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[179.462352] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[179.520504] [031/132] (845s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[179.719046] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[179.719886] Starting dynamic subtest: pipe-A-valid-mode
[182.245436] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.525s)
[182.247014] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (2.528s)
[182.573237] [032/132] (842s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[182.765556] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[182.767202] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[182.957753] [033/132] (842s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[183.149462] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[183.151128] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[183.343053] [034/132] (842s left) gem_exec_schedule (reorder-wide)
[183.553025] Subtest reorder-wide: SKIP (0.000s)
[183.844009] [035/132] (841s left) kms_prop_blob (blob-prop-lifetime)
[183.932082] Starting subtest: blob-prop-lifetime
[183.947986] Subtest blob-prop-lifetime: SUCCESS (0.017s)
[184.158123] [036/132] (841s left) perf_pmu (invalid-init)
[184.228104] Starting subtest: invalid-init
[184.229043] Subtest invalid-init: SUCCESS (0.000s)
[184.405882] [037/132] (841s left) kms_flip (basic-flip-vs-modeset)
[184.590344] Starting subtest: basic-flip-vs-modeset
[184.594522] Starting dynamic subtest: A-DP3
[185.603463] Dynamic subtest A-DP3: SUCCESS (1.008s)
[185.628795] Starting dynamic subtest: B-DP3
[186.398309] Dynamic subtest B-DP3: SUCCESS (0.794s)
[186.419679] Starting dynamic subtest: C-DP3
[187.188249] Dynamic subtest C-DP3: SUCCESS (0.786s)
[187.208099] Starting dynamic subtest: D-DP3
[187.941491] Dynamic subtest D-DP3: SUCCESS (0.754s)
[187.944213] Subtest basic-flip-vs-modeset: SUCCESS (3.355s)
[188.282633] [038/132] (837s left) i915_query (query-topology-unsupported)
[188.361143] Starting subtest: query-topology-unsupported
[188.363082] Subtest query-topology-unsupported: SKIP (0.000s)
[188.581242] [039/132] (837s left) kms_addfb_basic (small-bo)
[188.772046] Starting subtest: small-bo
[188.772928] Subtest small-bo: SUCCESS (0.000s)
[188.980414] [040/132] (837s left) sw_sync (alloc_fence)
[189.028903] Starting subtest: alloc_fence
[189.029889] Subtest alloc_fence: SUCCESS (0.000s)
[189.154310] [041/132] (837s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[189.341503] Starting subtest: plane-lut1d-pre-ctm3x4
[189.379400] Starting dynamic subtest: pipe-A-DP-3
[189.779365] Dynamic subtest pipe-A-DP-3: SUCCESS (0.400s)
[189.947389] Starting dynamic subtest: pipe-B-DP-3
[190.281293] Dynamic subtest pipe-B-DP-3: SUCCESS (0.348s)
[190.452534] Starting dynamic subtest: pipe-C-DP-3
[190.791450] Dynamic subtest pipe-C-DP-3: SUCCESS (0.349s)
[190.972010] Starting dynamic subtest: pipe-D-DP-3
[191.308308] Dynamic subtest pipe-D-DP-3: SUCCESS (0.348s)
[191.380822] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (2.040s)
[191.677711] [042/132] (834s left) gem_lmem_swapping (parallel-random)
[194.344423] Starting subtest: parallel-random
[194.345275] Starting dynamic subtest: lmem0
[235.277991] Dynamic subtest lmem0: SUCCESS (40.944s)
[235.279069] Subtest parallel-random: SUCCESS (40.945s)
[236.419870] [FACT gem_lmem_swapping (parallel-random)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[236.421001] [FACT gem_lmem_swapping (parallel-random)] deleted: kernel.kmod_is_loaded.i915: true
[236.422651] [043/132] (790s left) kms_plane_alpha_blend (alpha-transparent-fb)
[238.096507] Starting subtest: alpha-transparent-fb
[238.358532] Starting dynamic subtest: pipe-A-DP-3
[238.895130] Dynamic subtest pipe-A-DP-3: SUCCESS (0.535s)
[238.905957] Starting dynamic subtest: pipe-D-DP-3
[239.450585] Dynamic subtest pipe-D-DP-3: SUCCESS (0.555s)
[239.451495] Subtest alpha-transparent-fb: SUCCESS (1.361s)
[239.690866] [FACT kms_plane_alpha_blend (alpha-transparent-fb)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[239.693226] [FACT kms_plane_alpha_blend (alpha-transparent-fb)] new: kernel.kmod_is_loaded.i915: true
[239.695926] [044/132] (786s left) kms_big_fb (linear-addfb)
[239.896729] Starting subtest: linear-addfb
[239.897565] Subtest linear-addfb: SUCCESS (0.000s)
[240.043633] [045/132] (786s left) syncobj_timeline (invalid-wait-illegal-handle)
[240.120595] Starting subtest: invalid-wait-illegal-handle
[240.121808] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[240.312808] [046/132] (786s left) gem_exec_params (sol-reset-invalid)
[240.403505] Starting subtest: sol-reset-invalid
[240.407151] Subtest sol-reset-invalid: SUCCESS (0.002s)
[240.593758] [047/132] (786s left) gem_flink_basic (bad-flink)
[240.672253] Starting subtest: bad-flink
[240.673104] Subtest bad-flink: SUCCESS (0.000s)
[240.827593] [048/132] (785s left) gem_exec_fence (syncobj-timeline-repeat)
[241.513726] Starting subtest: syncobj-timeline-repeat
[241.884088] Subtest syncobj-timeline-repeat: SUCCESS (0.379s)
[242.215665] [049/132] (784s left) syncobj_wait (signal)
[242.293259] Starting subtest: signal
[242.294161] Subtest signal: SUCCESS (0.000s)
[242.458730] [050/132] (784s left) gem_exec_schedule (implicit-write-read)
[242.547426] Starting subtest: implicit-write-read
[242.548350] Starting dynamic subtest: rcs0
[242.846227] Dynamic subtest rcs0: SUCCESS (0.298s)
[242.857915] Starting dynamic subtest: bcs0
[243.053714] Dynamic subtest bcs0: SUCCESS (0.207s)
[243.065399] Starting dynamic subtest: vcs0
[243.266885] Dynamic subtest vcs0: SUCCESS (0.212s)
[243.278479] Starting dynamic subtest: vcs1
[243.479507] Dynamic subtest vcs1: SUCCESS (0.212s)
[243.494119] Starting dynamic subtest: vecs0
[243.695420] Dynamic subtest vecs0: SUCCESS (0.214s)
[243.707069] Starting dynamic subtest: vecs1
[243.911409] Dynamic subtest vecs1: SUCCESS (0.215s)
[243.922909] Starting dynamic subtest: ccs0
[244.179739] Dynamic subtest ccs0: SUCCESS (0.267s)
[244.180696] Subtest implicit-write-read: SUCCESS (1.632s)
[244.663707] [051/132] (782s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[244.854796] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[244.856466] Subtest fbcpsr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[245.054993] [052/132] (781s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[245.246083] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[245.246978] Starting dynamic subtest: pipe-A-DP-3
[245.255316] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[245.266920] Starting dynamic subtest: pipe-B-DP-3
[245.275172] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[245.286421] Starting dynamic subtest: pipe-C-DP-3
[245.294748] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[245.306550] Starting dynamic subtest: pipe-D-DP-3
[245.318487] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[245.320488] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.008s)
[245.736419] [053/132] (781s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[246.014228] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[246.160007] [054/132] (781s left) gem_ctx_engines (independent)
[246.246904] Starting subtest: independent
[246.247857] Starting dynamic subtest: rcs0
[246.408977] Dynamic subtest rcs0: SUCCESS (0.161s)
[246.420682] Starting dynamic subtest: bcs0
[246.565095] Dynamic subtest bcs0: SUCCESS (0.155s)
[246.577319] Starting dynamic subtest: vcs0
[246.727171] Dynamic subtest vcs0: SUCCESS (0.161s)
[246.738749] Starting dynamic subtest: vcs1
[246.889897] Dynamic subtest vcs1: SUCCESS (0.162s)
[246.901963] Starting dynamic subtest: vecs0
[247.049184] Dynamic subtest vecs0: SUCCESS (0.158s)
[247.060810] Starting dynamic subtest: vecs1
[247.207141] Dynamic subtest vecs1: SUCCESS (0.157s)
[247.218964] Starting dynamic subtest: ccs0
[247.369676] Dynamic subtest ccs0: SUCCESS (0.162s)
[247.381527] Starting dynamic subtest: all-engines
[247.759641] Dynamic subtest all-engines: SUCCESS (0.389s)
[247.760517] Subtest independent: SUCCESS (1.513s)
[248.812771] [055/132] (778s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[249.007725] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[250.284662] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.276s)
[250.482312] [056/132] (776s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[250.671669] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[253.734798] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (3.064s)
[254.000609] [057/132] (773s left) syncobj_wait (wait-for-submit-complex)
[254.080434] Starting subtest: wait-for-submit-complex
[254.142758] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[254.271944] [058/132] (773s left) gem_eio (context-create)
[254.560221] Starting subtest: context-create
[255.010589] Subtest context-create: SUCCESS (0.451s)
[255.286516] [059/132] (772s left) gem_exec_balancer (bonded-chain)
[255.381803] Starting subtest: bonded-chain
[269.220425] Subtest bonded-chain: SUCCESS (13.838s)
[269.700303] [060/132] (757s left) api_intel_allocator (simple-allocator)
[269.776144] Starting subtest: simple-allocator
[269.777064] Starting dynamic subtest: basic
[269.807267] Dynamic subtest basic: SUCCESS (0.031s)
[269.820414] Starting dynamic subtest: parallel-one
[269.987436] Dynamic subtest parallel-one: SUCCESS (0.179s)
[270.000450] Starting dynamic subtest: print
[270.001340] Dynamic subtest print: SUCCESS (0.000s)
[270.014698] Starting dynamic subtest: reuse
[270.015843] Dynamic subtest reuse: SUCCESS (0.000s)
[270.028667] Starting dynamic subtest: reserve
[270.029534] Dynamic subtest reserve: SUCCESS (0.000s)
[270.041644] Starting dynamic subtest: fork-reopen-allocator
[270.042670] Dynamic subtest fork-reopen-allocator: SUCCESS (0.014s)
[270.043820] Subtest simple-allocator: SUCCESS (0.229s)
[270.206406] [061/132] (757s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[270.405891] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[272.985996] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (2.581s)
[273.202873] [062/132] (754s left) gem_exec_basic (basic)
[273.287481] Starting subtest: basic
[273.288417] Starting dynamic subtest: rcs0-smem
[273.291090] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[273.304504] Starting dynamic subtest: bcs0-smem
[273.305390] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[273.317805] Starting dynamic subtest: vcs0-smem
[273.318849] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[273.331120] Starting dynamic subtest: vcs1-smem
[273.332367] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[273.344277] Starting dynamic subtest: vecs0-smem
[273.345426] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[273.357273] Starting dynamic subtest: vecs1-smem
[273.358558] Dynamic subtest vecs1-smem: SUCCESS (0.001s)
[273.370475] Starting dynamic subtest: ccs0-smem
[273.371566] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[273.383462] Starting dynamic subtest: rcs0-lmem0
[273.384544] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s)
[273.396566] Starting dynamic subtest: bcs0-lmem0
[273.397422] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s)
[273.409203] Starting dynamic subtest: vcs0-lmem0
[273.410105] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s)
[273.422450] Starting dynamic subtest: vcs1-lmem0
[273.423530] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s)
[273.435987] Starting dynamic subtest: vecs0-lmem0
[273.437080] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s)
[273.449164] Starting dynamic subtest: vecs1-lmem0
[273.450089] Dynamic subtest vecs1-lmem0: SUCCESS (0.000s)
[273.462455] Starting dynamic subtest: ccs0-lmem0
[273.463540] Dynamic subtest ccs0-lmem0: SUCCESS (0.000s)
[273.464724] Subtest basic: SUCCESS (0.022s)
[273.590585] [063/132] (754s left) gem_mmap_gtt (basic-small-bo-tiledy)
[273.669005] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[273.747109] [064/132] (754s left) gem_mmap_wc (bad-size)
[273.826098] Subtest bad-size: SKIP (0.000s)
[273.899728] [065/132] (754s left) sw_sync (sync_multi_consumer)
[273.948891] Starting subtest: sync_multi_consumer
[274.268161] Subtest sync_multi_consumer: SUCCESS (0.321s)
[274.408506] [066/132] (753s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[274.605989] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[274.607919] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[274.804434] [067/132] (753s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[274.995822] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[274.997470] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[275.182642] [068/132] (752s left) syncobj_wait (multi-wait-for-submit-signaled)
[275.263297] Starting subtest: multi-wait-for-submit-signaled
[275.264180] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[275.480515] [069/132] (752s left) gem_mmap_gtt (cpuset-big-copy)
[275.558105] Subtest cpuset-big-copy: SKIP (0.000s)
[275.630238] [070/132] (752s left) prime_busy (hang-wait)
[275.715130] Starting subtest: hang-wait
[275.720581] Starting dynamic subtest: rcs0
[301.602551] Dynamic subtest rcs0: SUCCESS (25.884s)
[301.615183] Starting dynamic subtest: bcs0
[308.763835] Dynamic subtest bcs0: SUCCESS (7.160s)
[308.776451] Starting dynamic subtest: vcs0
[315.731494] Dynamic subtest vcs0: SUCCESS (6.965s)
[315.744091] Starting dynamic subtest: vcs1
[322.726763] Dynamic subtest vcs1: SUCCESS (6.996s)
[322.739603] Starting dynamic subtest: vecs0
[329.750120] Dynamic subtest vecs0: SUCCESS (7.021s)
[329.762759] Starting dynamic subtest: vecs1
[336.727388] Dynamic subtest vecs1: SUCCESS (6.977s)
[336.739771] Starting dynamic subtest: ccs0
[350.561403] Dynamic subtest ccs0: SUCCESS (13.833s)
[350.562325] Subtest hang-wait: SUCCESS (74.846s)
[350.722479] [071/132] (677s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[350.911897] Starting subtest: fbc-rgb565-draw-pwrite
[353.988473] Subtest fbc-rgb565-draw-pwrite: SUCCESS (3.077s)
[354.186750] [072/132] (674s left) kms_cursor_crc (cursor-offscreen-128x128)
[354.561212] Starting subtest: cursor-offscreen-128x128
[354.565850] Starting dynamic subtest: pipe-A-DP-3
[357.103894] Dynamic subtest pipe-A-DP-3: SUCCESS (2.536s)
[357.154311] Starting dynamic subtest: pipe-D-DP-3
[359.631121] Dynamic subtest pipe-D-DP-3: SUCCESS (2.488s)
[359.632261] Subtest cursor-offscreen-128x128: SUCCESS (5.069s)
[360.113480] [073/132] (668s left) gem_ctx_param (invalid-set-no-zeromap)
[360.191727] Starting subtest: invalid-set-no-zeromap
[360.192571] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[360.373901] [074/132] (668s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[360.558509] Starting subtest: primary-yf-tiled-reflect-x-180
[360.658962] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.098s)
[360.876226] [075/132] (667s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[361.067750] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[363.807846] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (2.741s)
[364.087910] [076/132] (664s left) kms_selftest (drm_cmdline_parser)
[364.135761] Starting subtest: drm_cmdline_parser
[364.160032] Starting dynamic subtest: drm_test_cmdline_force_d_only
[364.274252] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.111s)
[364.287743] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[364.367345] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.090s)
[364.416069] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[364.450705] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.080s)
[364.466544] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[364.527646] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.076s)
[364.569387] Starting dynamic subtest: drm_test_cmdline_force_e_only
[364.619228] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.088s)
[364.659103] Starting dynamic subtest: drm_test_cmdline_res
[364.706473] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.084s)
[364.722617] Starting dynamic subtest: drm_test_cmdline_res_vesa
[364.783480] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.074s)
[364.818834] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[364.868474] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.082s)
[364.913065] Starting dynamic subtest: drm_test_cmdline_res_rblank
[364.948243] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.076s)
[364.976959] Starting dynamic subtest: drm_test_cmdline_res_bpp
[365.041349] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.092s)
[365.087497] Starting dynamic subtest: drm_test_cmdline_res_refresh
[365.142378] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.096s)
[365.181109] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[365.226960] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.083s)
[365.261219] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[365.329587] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.099s)
[365.376959] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[365.429306] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.088s)
[365.475246] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[365.505536] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.081s)
[365.525231] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[365.591401] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.084s)
[365.637468] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[365.668974] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.074s)
[365.687134] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[365.759403] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.088s)
[365.806397] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[365.844819] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.081s)
[365.871096] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[365.935389] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.088s)
[365.981875] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[366.020852] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.082s)
[366.052926] Starting dynamic subtest: drm_test_cmdline_name
[366.102400] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.079s)
[366.145902] Starting dynamic subtest: drm_test_cmdline_name_bpp
[366.192147] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.087s)
[366.227122] Starting dynamic subtest: drm_test_cmdline_name_option
[366.271908] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.077s)
[366.293865] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[366.350865] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.077s)
[366.382992] Starting dynamic subtest: drm_test_cmdline_rotate_0
[366.420745] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.068s)
[366.461793] Starting dynamic subtest: drm_test_cmdline_rotate_90
[366.503145] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.080s)
[366.536607] Starting dynamic subtest: drm_test_cmdline_rotate_180
[366.606372] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.100s)
[366.622486] Starting dynamic subtest: drm_test_cmdline_rotate_270
[366.691978] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.081s)
[366.735916] Starting dynamic subtest: drm_test_cmdline_hmirror
[366.775766] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.080s)
[366.800594] Starting dynamic subtest: drm_test_cmdline_vmirror
[366.852990] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.074s)
[366.868228] Starting dynamic subtest: drm_test_cmdline_margin_options
[366.946340] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.090s)
[366.992179] Starting dynamic subtest: drm_test_cmdline_multiple_options
[367.043468] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.092s)
[367.078277] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[367.127310] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.083s)
[367.140356] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[367.205787] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.077s)
[367.221729] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[367.286273] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.077s)
[367.331733] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[367.385303] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.096s)
[367.398991] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[367.473413] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.086s)
[367.490111] Starting dynamic subtest: drm_test_cmdline_invalid
[367.610812] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.132s)
[367.650508] Starting dynamic subtest: drm_test_cmdline_tv_options
[367.702252] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.089s)
[367.703248] Subtest drm_cmdline_parser: SUCCESS (3.566s)
[367.957781] [077/132] (660s left) gem_ctx_param (set-priority-not-supported)
[368.037685] Starting subtest: set-priority-not-supported
[368.039416] Subtest set-priority-not-supported: SKIP (0.000s)
[368.189404] [078/132] (660s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[368.380138] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[368.381889] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[368.578154] [079/132] (660s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[368.774092] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[368.775925] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[368.987341] [080/132] (660s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[369.183012] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[370.508858] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.325s)
[370.777861] [081/132] (658s left) kms_plane_multiple (tiling-4)
[370.966168] Starting subtest: tiling-4
[370.967067] Starting dynamic subtest: pipe-A-DP-3
[372.083775] Dynamic subtest pipe-A-DP-3: SUCCESS (1.116s)
[372.098112] Starting dynamic subtest: pipe-B-DP-3
[373.078582] Dynamic subtest pipe-B-DP-3: SUCCESS (0.994s)
[373.093309] Starting dynamic subtest: pipe-C-DP-3
[374.132804] Dynamic subtest pipe-C-DP-3: SUCCESS (1.052s)
[374.147098] Starting dynamic subtest: pipe-D-DP-3
[375.156895] Dynamic subtest pipe-D-DP-3: SUCCESS (1.022s)
[375.157835] Subtest tiling-4: SUCCESS (4.192s)
[375.452967] [082/132] (653s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[375.638481] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[375.641003] Starting dynamic subtest: pipe-A-DP-3
[375.649386] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[375.661988] Starting dynamic subtest: pipe-B-DP-3
[375.670215] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[375.682527] Starting dynamic subtest: pipe-C-DP-3
[375.690785] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[375.703453] Starting dynamic subtest: pipe-D-DP-3
[375.713972] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[375.715681] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[376.109279] [083/132] (653s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[376.386511] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[376.536444] [084/132] (652s left) perf (gen12-group-exclusive-stream-ctx-handle)
[376.938067] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[376.965823] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.028s)
[377.029385] [085/132] (652s left) kms_setmode (basic)
[377.127557] Starting subtest: basic
[377.289166] Starting dynamic subtest: pipe-A-DP-3
[379.455541] Dynamic subtest pipe-A-DP-3: SUCCESS (2.163s)
[379.593066] Starting dynamic subtest: pipe-B-DP-3
[381.740543] Dynamic subtest pipe-B-DP-3: SUCCESS (2.157s)
[381.815993] Subtest basic: SUCCESS (4.688s)
[382.140645] [086/132] (647s left) kms_psr (fbc-psr-primary-render)
[382.329910] Subtest fbc-psr-primary-render: SKIP (0.000s)
[382.390585] [087/132] (647s left) gem_create (create-valid-nonaligned)
[382.470397] Starting subtest: create-valid-nonaligned
[382.471729] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[382.763259] [088/132] (646s left) kms_atomic_transition (plane-all-transition-fencing)
[382.953794] Starting subtest: plane-all-transition-fencing
[382.956092] Starting dynamic subtest: pipe-A-DP-3
[386.694166] Dynamic subtest pipe-A-DP-3: SUCCESS (3.738s)
[386.816510] Starting dynamic subtest: pipe-B-DP-3
[390.724765] Dynamic subtest pipe-B-DP-3: SUCCESS (3.922s)
[390.830823] Subtest plane-all-transition-fencing: SUCCESS (7.876s)
[391.094089] [089/132] (638s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[391.286156] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[391.287925] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[391.493616] [090/132] (638s left) kms_lease (lease-unleased-connector)
[391.680763] Starting subtest: lease-unleased-connector
[391.683094] Starting dynamic subtest: pipe-A-DP-3
[391.783786] Dynamic subtest pipe-A-DP-3: SUCCESS (0.100s)
[391.796391] Starting dynamic subtest: pipe-B-DP-3
[391.886811] Dynamic subtest pipe-B-DP-3: SUCCESS (0.102s)
[391.901459] Starting dynamic subtest: pipe-C-DP-3
[391.993263] Dynamic subtest pipe-C-DP-3: SUCCESS (0.103s)
[392.006074] Starting dynamic subtest: pipe-D-DP-3
[392.097132] Dynamic subtest pipe-D-DP-3: SUCCESS (0.102s)
[392.098043] Subtest lease-unleased-connector: SUCCESS (0.415s)
[392.253112] [091/132] (637s left) drm_read (short-buffer-nonblock)
[392.526226] Starting subtest: short-buffer-nonblock
[392.527397] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[392.791786] [092/132] (637s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[392.984189] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[392.985907] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[393.191540] [093/132] (636s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[393.386226] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[393.387126] Starting dynamic subtest: pipe-A-DP-3
[393.408187] Dynamic subtest pipe-A-DP-3: SKIP (0.002s)
[393.420883] Starting dynamic subtest: pipe-B-DP-3
[393.442328] Dynamic subtest pipe-B-DP-3: SKIP (0.002s)
[393.454735] Starting dynamic subtest: pipe-C-DP-3
[393.479462] Dynamic subtest pipe-C-DP-3: SKIP (0.002s)
[393.493445] Starting dynamic subtest: pipe-D-DP-3
[393.517070] Dynamic subtest pipe-D-DP-3: SKIP (0.002s)
[393.518887] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.015s)
[393.869005] [094/132] (636s left) kms_pm_rpm (fences-dpms)
[396.075481] Starting subtest: fences-dpms
[396.078171] Subtest fences-dpms: SKIP (0.000s)
[396.544913] [095/132] (633s left) i915_getparams_basic (basic-subslice-total)
[396.622514] Starting subtest: basic-subslice-total
[396.624341] Subtest basic-subslice-total: SUCCESS (0.000s)
[396.814564] [096/132] (633s left) gem_exec_fence (submit67)
[397.020517] Starting subtest: submit67
[397.022648] Subtest submit67: SKIP (0.000s)
[397.782924] [097/132] (632s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[397.970305] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[397.971053] Starting dynamic subtest: pipe-A
[398.062289] Dynamic subtest pipe-A: SUCCESS (0.093s)
[398.080970] Starting dynamic subtest: pipe-B
[398.259007] Dynamic subtest pipe-B: SUCCESS (0.195s)
[398.282431] Starting dynamic subtest: pipe-C
[398.470714] Dynamic subtest pipe-C: SUCCESS (0.210s)
[398.493884] Starting dynamic subtest: pipe-D
[398.682846] Dynamic subtest pipe-D: SUCCESS (0.210s)
[398.683993] Subtest planes-unity-scaling-downscale-factor-0-5: SUCCESS (0.715s)
[399.013844] [098/132] (631s left) sw_sync (sync_busy)
[399.061883] Starting subtest: sync_busy
[399.064440] Subtest sync_busy: SUCCESS (0.003s)
[399.220711] [099/132] (631s left) i915_pm_rpm (sysfs-read)
[401.137621] Starting subtest: sysfs-read
[401.456560] Subtest sysfs-read: SUCCESS (0.313s)
[401.865308] [100/132] (628s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[402.062714] Starting subtest: flip-vs-dpms-on-nop-interruptible
[402.067584] Starting dynamic subtest: A-DP3
[403.181839] Dynamic subtest A-DP3: SUCCESS (1.113s)
[403.198811] Starting dynamic subtest: B-DP3
[404.207852] Dynamic subtest B-DP3: SUCCESS (1.020s)
[404.255612] Starting dynamic subtest: C-DP3
[405.272021] Dynamic subtest C-DP3: SUCCESS (1.058s)
[405.294279] Starting dynamic subtest: D-DP3
[406.298961] Dynamic subtest D-DP3: SUCCESS (1.021s)
[406.307765] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (4.244s)
[406.696169] [101/132] (624s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[406.894870] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[406.896650] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[407.093783] [102/132] (623s left) prime_mmap_coherency (write)
[407.177140] Starting subtest: write
[412.596862] Subtest write: SUCCESS (5.419s)
[412.798637] [103/132] (618s left) gem_mmap_wc (read)
[412.874132] Subtest read: SKIP (0.000s)
[412.955986] [104/132] (618s left) sysfs_timeslice_duration (timeout)
[413.043039] Starting subtest: timeout
[413.043938] Starting dynamic subtest: vecs0
[414.931150] Dynamic subtest vecs0: SUCCESS (1.887s)
[414.945493] Starting dynamic subtest: ccs0
[416.750128] Dynamic subtest ccs0: SUCCESS (1.818s)
[416.763097] Starting dynamic subtest: vcs0
[418.534017] Dynamic subtest vcs0: SUCCESS (1.783s)
[418.547294] Starting dynamic subtest: bcs0
[419.748054] Dynamic subtest bcs0: SUCCESS (1.213s)
[419.761532] Starting dynamic subtest: vecs1
[421.646106] Dynamic subtest vecs1: SUCCESS (1.897s)
[421.659734] Starting dynamic subtest: rcs0
[423.403438] Dynamic subtest rcs0: SUCCESS (1.756s)
[423.419094] Starting dynamic subtest: vcs1
[425.105093] Dynamic subtest vcs1: SUCCESS (1.700s)
[425.106310] Subtest timeout: SUCCESS (12.062s)
[425.312850] [105/132] (605s left) gem_softpin (allocator-nopin)
[425.406239] Starting subtest: allocator-nopin
[425.648628] Subtest allocator-nopin: SUCCESS (0.242s)
[425.862543] [106/132] (605s left) gem_mmap_gtt (isolation)
[425.938165] Subtest isolation: SKIP (0.000s)
[426.008991] [107/132] (605s left) kms_flip (flip-vs-absolute-wf_vblank)
[426.199529] Starting subtest: flip-vs-absolute-wf_vblank
[426.204398] Starting dynamic subtest: A-DP3
[434.331626] Dynamic subtest A-DP3: SUCCESS (8.127s)
[434.347483] Starting dynamic subtest: B-DP3
[442.384817] Dynamic subtest B-DP3: SUCCESS (8.051s)
[442.400610] Starting dynamic subtest: C-DP3
[450.421037] Dynamic subtest C-DP3: SUCCESS (8.034s)
[450.436465] Starting dynamic subtest: D-DP3
[458.474997] Dynamic subtest D-DP3: SUCCESS (8.052s)
[458.477263] Subtest flip-vs-absolute-wf_vblank: SUCCESS (32.277s)
[458.875334] [108/132] (572s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[459.064870] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[459.066602] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[459.275779] [109/132] (572s left) syncobj_eventfd (invalid-bad-pad)
[459.354294] Starting subtest: invalid-bad-pad
[459.355208] Subtest invalid-bad-pad: SUCCESS (0.000s)
[459.540809] [110/132] (571s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[459.739310] Starting subtest: yf-tiled-32bpp-rotate-180
[459.740993] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[459.956592] [111/132] (571s left) prime_self_import (export-vs-gem_close-race)
[460.005173] Starting subtest: export-vs-gem_close-race
[465.094109] Subtest export-vs-gem_close-race: SUCCESS (5.090s)
[465.305643] [112/132] (566s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[465.391521] Starting subtest: mixed-tiled-to-y-tiled-ccs
[465.393535] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[465.682817] [113/132] (566s left) prime_mmap (test_correct)
[465.776086] Starting subtest: test_correct
[465.777056] Starting dynamic subtest: test_correct-smem
[465.825554] Dynamic subtest test_correct-smem: SUCCESS (0.049s)
[465.840205] Starting dynamic subtest: test_correct-lmem0
[466.020422] Dynamic subtest test_correct-lmem0: SUCCESS (0.193s)
[466.021395] Subtest test_correct: SUCCESS (0.245s)
[466.219003] [114/132] (565s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[466.413911] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[466.467840] [115/132] (565s left) gem_exec_schedule (u-submit-early-slice)
[466.561565] Starting subtest: u-submit-early-slice
[466.562462] Starting dynamic subtest: rcs0
[466.648699] Dynamic subtest rcs0: SUCCESS (0.086s)
[466.663624] Starting dynamic subtest: bcs0
[466.706071] Dynamic subtest bcs0: SUCCESS (0.056s)
[466.720909] Starting dynamic subtest: vcs0
[466.762596] Dynamic subtest vcs0: SUCCESS (0.055s)
[466.777334] Starting dynamic subtest: vcs1
[466.819996] Dynamic subtest vcs1: SUCCESS (0.056s)
[466.834654] Starting dynamic subtest: vecs0
[466.874186] Dynamic subtest vecs0: SUCCESS (0.053s)
[466.889093] Starting dynamic subtest: vecs1
[466.931129] Dynamic subtest vecs1: SUCCESS (0.056s)
[466.945303] Starting dynamic subtest: ccs0
[466.986002] Dynamic subtest ccs0: SUCCESS (0.054s)
[466.988192] Subtest u-submit-early-slice: SUCCESS (0.425s)
[467.508346] [116/132] (564s left) dumb_buffer (map-valid)
[467.590404] Starting subtest: map-valid
[467.591439] Subtest map-valid: SUCCESS (0.000s)
[467.791179] [117/132] (564s left) kms_atomic_interruptible (legacy-cursor)
[467.977223] Starting subtest: legacy-cursor
[467.978114] Starting dynamic subtest: pipe-A-DP-3
[474.264105] Dynamic subtest pipe-A-DP-3: SUCCESS (6.284s)
[474.265224] Subtest legacy-cursor: SUCCESS (6.286s)
[474.581170] [118/132] (557s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[474.771072] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[478.263466] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (3.492s)
[478.547472] [119/132] (553s left) sysfs_heartbeat_interval (mixed)
[478.638060] Starting subtest: mixed
[478.638998] Starting dynamic subtest: vecs0
[483.878720] Dynamic subtest vecs0: SUCCESS (5.240s)
[483.894920] Starting dynamic subtest: ccs0
[489.059958] Dynamic subtest ccs0: SUCCESS (5.179s)
[489.078096] Starting dynamic subtest: vcs0
[494.288968] Dynamic subtest vcs0: SUCCESS (5.226s)
[494.305735] Starting dynamic subtest: bcs0
[499.538453] Dynamic subtest bcs0: SUCCESS (5.245s)
[499.555364] Starting dynamic subtest: vecs1
[504.754690] Dynamic subtest vecs1: SUCCESS (5.213s)
[504.775985] Starting dynamic subtest: rcs0
[509.973331] Dynamic subtest rcs0: SUCCESS (5.217s)
[509.992180] Starting dynamic subtest: vcs1
[515.223404] Dynamic subtest vcs1: SUCCESS (5.246s)
[515.227274] Subtest mixed: SUCCESS (36.587s)
[515.401872] [120/132] (516s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[515.487262] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[515.585364] [121/132] (516s left) kms_dsc (dsc-with-output-formats)
[515.771351] Starting subtest: dsc-with-output-formats
[515.779490] Subtest dsc-with-output-formats: SKIP (0.001s)
[515.931077] [122/132] (516s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[516.118210] Starting subtest: random-ccs-data-yf-tiled-ccs
[516.119104] Starting dynamic subtest: pipe-A-DP-3
[516.128084] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[516.141430] Starting dynamic subtest: pipe-B-DP-3
[516.150798] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[516.163794] Starting dynamic subtest: pipe-C-DP-3
[516.172879] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[516.186071] Starting dynamic subtest: pipe-D-DP-3
[516.196755] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[516.198520] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.007s)
[516.592102] [123/132] (515s left) kms_psr (fbc-psr2-cursor-plane-move)
[516.780315] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s)
[516.853341] [124/132] (515s left) i915_suspend (basic-s2idle-without-i915)
[516.901905] Starting subtest: basic-s2idle-without-i915
[535.742841] Subtest basic-s2idle-without-i915: SUCCESS (3.930s)
[535.879284] [125/132] (496s left) gem_exec_reloc (basic-cpu-gtt)
[535.979361] Subtest basic-cpu-gtt: SKIP (0.000s)
[536.058054] [126/132] (496s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[536.152086] Subtest no-spare-fences-busy: SKIP (0.000s)
[536.247525] [127/132] (496s left) gem_ctx_persistence (userptr)
[536.337115] Starting subtest: userptr
[536.574215] Subtest userptr: SUCCESS (0.237s)
[536.766082] [128/132] (496s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[536.965060] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[536.966781] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[537.183969] [129/132] (495s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[537.660999] Starting subtest: cursor-rapid-movement-512x512
[537.664834] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[537.958939] [130/132] (495s left) kms_content_protection (atomic-hdcp14)
[538.213208] Starting subtest: atomic-hdcp14
[538.257722] Starting dynamic subtest: pipe-A-DP-3
[659.644971] Dynamic subtest pipe-A-DP-3: FAIL (121.239s)
[659.646603] Subtest atomic-hdcp14: FAIL (121.388s)
[659.908223] [131/132] (373s left) syncobj_wait (wait-all-complex)
[659.991064] Starting subtest: wait-all-complex
[660.208159] Subtest wait-all-complex: SUCCESS (0.216s)
[660.348971] [132/132] (372s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[660.431099] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[660.537094] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[660.723481] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_edge_walk
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: kms_cursor_legacy
results: parsing output: 3/ for test: dumb_buffer
results: parsing output: 4/ for test: kms_fbcon_fbt
results: parsing output: 5/ for test: gen9_exec_parse
results: parsing output: 6/ for test: kms_vblank
results: parsing output: 7/ for test: gem_tiled_swapping
results: parsing output: 8/ for test: api_intel_bb
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_invalid_mode
results: parsing output: 13/ for test: gem_mmap
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: prime_mmap_kms
results: parsing output: 16/ for test: kms_async_flips
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: gem_wait
results: parsing output: 19/ for test: gem_render_copy
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_async_flips
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: perf_pmu
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: kms_pm_dc
results: parsing output: 28/ for test: gen9_exec_parse
results: parsing output: 29/ for test: kms_psr2_sf
results: parsing output: 30/ for test: kms_flip_scaled_crc
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: gem_exec_schedule
results: parsing output: 34/ for test: kms_prop_blob
results: parsing output: 35/ for test: perf_pmu
results: parsing output: 36/ for test: kms_flip
results: parsing output: 37/ for test: i915_query
results: parsing output: 38/ for test: kms_addfb_basic
results: parsing output: 39/ for test: sw_sync
results: parsing output: 40/ for test: kms_color_pipeline
results: parsing output: 41/ for test: gem_lmem_swapping
results: parsing output: 42/ for test: kms_plane_alpha_blend
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: gem_exec_params
results: parsing output: 46/ for test: gem_flink_basic
results: parsing output: 47/ for test: gem_exec_fence
results: parsing output: 48/ for test: syncobj_wait
results: parsing output: 49/ for test: gem_exec_schedule
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_ccs
results: parsing output: 52/ for test: kms_chamelium_frames
results: parsing output: 53/ for test: gem_ctx_engines
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: syncobj_wait
results: parsing output: 57/ for test: gem_eio
results: parsing output: 58/ for test: gem_exec_balancer
results: parsing output: 59/ for test: api_intel_allocator
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gem_exec_basic
results: parsing output: 62/ for test: gem_mmap_gtt
results: parsing output: 63/ for test: gem_mmap_wc
results: parsing output: 64/ for test: sw_sync
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: syncobj_wait
results: parsing output: 68/ for test: gem_mmap_gtt
results: parsing output: 69/ for test: prime_busy
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_cursor_crc
results: parsing output: 72/ for test: gem_ctx_param
results: parsing output: 73/ for test: kms_rotation_crc
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_selftest
results: parsing output: 76/ for test: gem_ctx_param
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: kms_plane_multiple
results: parsing output: 81/ for test: kms_ccs
results: parsing output: 82/ for test: kms_chamelium_hpd
results: parsing output: 83/ for test: perf
results: parsing output: 84/ for test: kms_setmode
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: gem_create
results: parsing output: 87/ for test: kms_atomic_transition
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_lease
results: parsing output: 90/ for test: drm_read
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: kms_pm_rpm
results: parsing output: 94/ for test: i915_getparams_basic
results: parsing output: 95/ for test: gem_exec_fence
results: parsing output: 96/ for test: kms_plane_scaling
results: parsing output: 97/ for test: sw_sync
results: parsing output: 98/ for test: i915_pm_rpm
results: parsing output: 99/ for test: kms_flip
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: prime_mmap_coherency
results: parsing output: 102/ for test: gem_mmap_wc
results: parsing output: 103/ for test: sysfs_timeslice_duration
results: parsing output: 104/ for test: gem_softpin
results: parsing output: 105/ for test: gem_mmap_gtt
results: parsing output: 106/ for test: kms_flip
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: syncobj_eventfd
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: prime_self_import
results: parsing output: 111/ for test: gem_render_copy
results: parsing output: 112/ for test: prime_mmap
results: parsing output: 113/ for test: kms_psr2_sf
results: parsing output: 114/ for test: gem_exec_schedule
results: parsing output: 115/ for test: dumb_buffer
results: parsing output: 116/ for test: kms_atomic_interruptible
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: sysfs_heartbeat_interval
results: parsing output: 119/ for test: gem_exec_reloc
results: parsing output: 120/ for test: kms_dsc
results: parsing output: 121/ for test: kms_ccs
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: i915_suspend
results: parsing output: 124/ for test: gem_exec_reloc
results: parsing output: 125/ for test: gem_fenced_exec_thrash
results: parsing output: 126/ for test: gem_ctx_persistence
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: kms_cursor_crc
results: parsing output: 129/ for test: kms_content_protection
results: parsing output: 130/ for test: syncobj_wait
results: parsing output: 131/ for test: syncobj_timeline
Done.