[59.515972] Initializing watchdogs
[59.516045]   /dev/watchdog0
[59.530413] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.535056] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.537091] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.539528] [001/131] (960s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[59.656678] Starting subtest: fbc-farfromfence-mmap-gtt
[59.658622] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[59.769746] [002/131] (960s left) gem_exec_parallel (basic)
[59.832627] Starting subtest: basic
[59.833746] Starting dynamic subtest: rcs0
[61.267907] Dynamic subtest rcs0: SUCCESS (1.435s)
[61.274062] Starting dynamic subtest: bcs0
[62.729946] Dynamic subtest bcs0: SUCCESS (1.461s)
[62.738310] Starting dynamic subtest: vcs0
[65.944296] Dynamic subtest vcs0: SUCCESS (3.211s)
[65.953648] Starting dynamic subtest: vcs1
[67.927786] Dynamic subtest vcs1: SUCCESS (1.982s)
[67.934346] Starting dynamic subtest: vecs0
[69.846963] Dynamic subtest vecs0: SUCCESS (1.919s)
[69.855343] Starting dynamic subtest: ccs0
[71.447198] Dynamic subtest ccs0: SUCCESS (1.600s)
[71.448042] Subtest basic: SUCCESS (11.613s)
[71.660746] [003/131] (948s left) perf_pmu (rc6-suspend)
[71.709562] Starting subtest: rc6-suspend
[95.051484] Subtest rc6-suspend: SUCCESS (8.144s)
[98.449374] [004/131] (924s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[98.540567] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[98.541558] Starting dynamic subtest: pipe-A-eDP-1
[98.550407] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[98.558377] Starting dynamic subtest: pipe-B-eDP-1
[98.569360] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[98.577544] Starting dynamic subtest: pipe-C-eDP-1
[98.586331] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[98.593018] Starting dynamic subtest: pipe-D-eDP-1
[98.601778] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[98.603377] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[100.717749] [005/131] (922s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[100.801096] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[100.802143] Starting dynamic subtest: pipe-A-eDP-1
[100.811362] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[100.819182] Starting dynamic subtest: pipe-B-eDP-1
[100.827573] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[100.834178] Starting dynamic subtest: pipe-C-eDP-1
[100.842871] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[100.848999] Starting dynamic subtest: pipe-D-eDP-1
[100.857673] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[100.859311] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[102.967691] [006/131] (920s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[103.051075] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[103.052994] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[103.164951] [007/131] (920s left) gem_lmem_swapping (verify)
[103.196874] Subtest verify: SKIP (0.000s)
[103.227843] [008/131] (920s left) kms_cursor_crc (cursor-onscreen-32x32)
[103.374405] Starting subtest: cursor-onscreen-32x32
[103.419767] Subtest cursor-onscreen-32x32: SKIP (0.044s)
[103.718271] [009/131] (919s left) gem_exec_schedule (semaphore-resolve)
[103.786812] Starting subtest: semaphore-resolve
[103.824479] Subtest semaphore-resolve: SUCCESS (0.038s)
[104.209198] [010/131] (919s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[104.298468] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[104.300472] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[104.408391] [011/131] (918s left) gem_workarounds (reset-fd)
[104.471486] Starting subtest: reset-fd
[104.660264] Subtest reset-fd: SUCCESS (0.189s)
[104.792330] [012/131] (918s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[104.879696] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[104.880599] Starting dynamic subtest: pipe-A-default-mode
[105.167122] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[105.168962] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.287s)
[106.004227] [013/131] (917s left) gem_ctx_shared (q-out-order)
[106.070262] Starting subtest: Q-out-order
[106.071297] Starting dynamic subtest: rcs0
[106.237634] Dynamic subtest rcs0: SUCCESS (0.167s)
[106.252528] Starting dynamic subtest: vcs0
[106.315321] Dynamic subtest vcs0: SUCCESS (0.078s)
[106.330448] Starting dynamic subtest: vcs1
[106.392706] Dynamic subtest vcs1: SUCCESS (0.077s)
[106.409959] Starting dynamic subtest: vecs0
[106.469641] Dynamic subtest vecs0: SUCCESS (0.076s)
[106.484517] Starting dynamic subtest: ccs0
[106.558193] Dynamic subtest ccs0: SUCCESS (0.088s)
[106.559656] Subtest Q-out-order: SUCCESS (0.487s)
[108.195190] [FACT gem_ctx_shared (q-out-order)] new: kernel.kmod_is_loaded.vgem: true
[108.196834] [014/131] (915s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[108.296365] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[108.298408] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[108.422470] [015/131] (915s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[108.518248] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[108.520280] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[108.618254] [016/131] (914s left) gem_exec_balancer (parallel-keep-in-fence)
[108.874083] Starting subtest: parallel-keep-in-fence
[109.921463] Subtest parallel-keep-in-fence: SUCCESS (1.047s)
[110.042998] [017/131] (913s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[110.102074] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[110.103132] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[110.221803] [018/131] (913s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[110.314637] Starting subtest: basic-modeset-with-all-modifiers-formats
[110.685091] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[111.691983] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: FAIL (0.786s)
[111.699248] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[111.756179] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: FAIL (0.183s)
[111.765214] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[111.818096] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: FAIL (0.019s)
[111.825754] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[111.960892] Dynamic subtest pipe-A-eDP-1-4-RGB565: FAIL (0.132s)
[111.968670] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[112.018033] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: FAIL (0.009s)
[112.027515] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[112.080396] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: FAIL (0.192s)
[112.087468] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[112.137252] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: FAIL (0.017s)
[112.144901] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[112.194440] Dynamic subtest pipe-A-eDP-1-4-YUYV: FAIL (0.008s)
[112.201801] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[112.253392] Dynamic subtest pipe-A-eDP-1-4-Y210: FAIL (0.011s)
[112.260867] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[112.317471] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: FAIL (0.011s)
[112.326358] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[112.381433] Dynamic subtest pipe-A-eDP-1-4-XV30: FAIL (0.210s)
[112.389602] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[112.449495] Dynamic subtest pipe-A-eDP-1-4-XV36: FAIL (0.015s)
[112.459496] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[112.594483] Dynamic subtest pipe-A-eDP-1-x-RGB565: FAIL (0.135s)
[112.602256] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[112.654776] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: FAIL (0.009s)
[112.661879] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[112.713095] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: FAIL (0.202s)
[112.720636] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[112.771138] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: FAIL (0.016s)
[112.778549] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[112.827810] Dynamic subtest pipe-A-eDP-1-x-YUYV: FAIL (0.010s)
[112.834999] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[112.886254] Dynamic subtest pipe-A-eDP-1-x-Y210: FAIL (0.011s)
[112.893974] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[112.945794] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: FAIL (0.202s)
[112.953318] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[113.004860] Dynamic subtest pipe-A-eDP-1-x-XV30: FAIL (0.016s)
[113.012538] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[113.063122] Dynamic subtest pipe-A-eDP-1-x-XV36: FAIL (0.011s)
[113.070224] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[113.194608] Dynamic subtest pipe-A-eDP-1-linear-RGB565: FAIL (0.146s)
[113.202467] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[113.251950] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: FAIL (0.009s)
[113.258937] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[113.309611] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: FAIL (0.193s)
[113.316811] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[113.366411] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: FAIL (0.018s)
[113.373653] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[113.423598] Dynamic subtest pipe-A-eDP-1-linear-YUYV: FAIL (0.008s)
[113.431125] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[113.481604] Dynamic subtest pipe-A-eDP-1-linear-Y210: FAIL (0.011s)
[113.488638] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[113.538935] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: FAIL (0.011s)
[113.545711] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[113.595298] Dynamic subtest pipe-A-eDP-1-linear-XV30: FAIL (0.208s)
[113.602102] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[113.651742] Dynamic subtest pipe-A-eDP-1-linear-XV36: FAIL (0.015s)
[113.907274] Subtest basic-modeset-with-all-modifiers-formats: FAIL (3.592s)
[114.764338] [019/131] (908s left) kms_pm_dc (dc5-retention-flops)
[115.863349] Starting subtest: dc5-retention-flops
[115.865612] Subtest dc5-retention-flops: SKIP (0.000s)
[115.955163] [020/131] (907s left) i915_fb_tiling (basic-x-tiling)
[115.999493] Subtest basic-x-tiling: SKIP (0.000s)
[116.054185] [021/131] (907s left) i915_pm_rps (thresholds-idle-park)
[116.107117] Starting subtest: thresholds-idle-park
[116.109491] Subtest thresholds-idle-park: SKIP (0.001s)
[116.214364] [022/131] (907s left) gem_exec_reloc (basic-wc-cpu)
[116.270827] Subtest basic-wc-cpu: SKIP (0.000s)
[116.363644] [023/131] (907s left) gem_eio (execbuf)
[116.604122] Starting subtest: execbuf
[116.974832] Subtest execbuf: SUCCESS (0.366s)
[117.084673] [024/131] (906s left) gem_exec_balancer (nohangcheck)
[117.343955] Starting subtest: nohangcheck
[118.236020] Subtest nohangcheck: SUCCESS (0.891s)
[118.359244] [025/131] (905s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[118.457126] Starting subtest: yf-tiled-16bpp-rotate-180
[118.459021] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[118.576447] [026/131] (905s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[118.670420] Starting subtest: 2x-flip-vs-modeset-vs-hang
[118.680388] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.011s)
[118.810034] [027/131] (905s left) gem_userptr_blits (huge-split)
[118.880175] Starting subtest: huge-split
[118.887394] Subtest huge-split: SUCCESS (0.007s)
[119.016766] [028/131] (904s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[119.060029] Starting subtest: invalid-multi-wait-unsubmitted
[119.061108] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[119.171952] [029/131] (904s left) kms_cursor_crc (cursor-onscreen-64x21)
[119.360714] Starting subtest: cursor-onscreen-64x21
[119.399453] Subtest cursor-onscreen-64x21: SKIP (0.038s)
[119.647604] [030/131] (904s left) kms_invalid_mode (zero-clock)
[119.735567] Starting subtest: zero-clock
[119.736740] Starting dynamic subtest: pipe-A-eDP-1
[120.025204] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[120.033536] Starting dynamic subtest: pipe-B-eDP-1
[120.034473] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[120.041554] Starting dynamic subtest: pipe-C-eDP-1
[120.042468] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[120.049921] Starting dynamic subtest: pipe-D-eDP-1
[120.050855] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[120.051708] Subtest zero-clock: SUCCESS (0.294s)
[120.890096] [031/131] (903s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[121.006879] Starting subtest: basic-flip-before-cursor-legacy
[121.941018] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.933s)
[122.820511] [032/131] (901s left) kms_chamelium_edid (hdmi-mode-timings)
[123.193897] Subtest hdmi-mode-timings: SKIP (0.000s)
[124.012575] [033/131] (900s left) api_intel_bb (intel-bb-blit-y)
[124.066520] Starting subtest: intel-bb-blit-y
[127.935444] Subtest intel-bb-blit-y: SUCCESS (3.866s)
[128.091525] [034/131] (896s left) kms_psr (psr-sprite-plane-move)
[128.185448] Starting subtest: psr-sprite-plane-move
[128.186318] Starting dynamic subtest: eDP-1
[129.981384] Dynamic subtest eDP-1: SUCCESS (1.796s)
[129.982376] Subtest psr-sprite-plane-move: SUCCESS (1.796s)
[130.811281] [035/131] (893s left) kms_flip (flip-vs-blocking-wf-vblank)
[130.902830] Starting subtest: flip-vs-blocking-wf-vblank
[130.903785] Starting dynamic subtest: A-eDP1
[139.850687] Dynamic subtest A-eDP1: SUCCESS (8.946s)
[139.867486] Starting dynamic subtest: B-eDP1
[148.786060] Dynamic subtest B-eDP1: SUCCESS (8.933s)
[148.794053] Starting dynamic subtest: C-eDP1
[157.709555] Dynamic subtest C-eDP1: SUCCESS (8.923s)
[157.718568] Starting dynamic subtest: D-eDP1
[166.633873] Dynamic subtest D-eDP1: SUCCESS (8.923s)
[166.636060] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.733s)
[167.872834] [036/131] (856s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[167.952575] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[167.954424] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[168.054645] [037/131] (856s left) kms_content_protection (lic-type-0)
[168.195771] Starting subtest: lic-type-0
[168.197414] Subtest lic-type-0: SKIP (0.000s)
[168.360916] [038/131] (855s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[168.437859] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[168.438750] Starting dynamic subtest: pipe-A-default-mode
[168.744045] Dynamic subtest pipe-A-default-mode: SKIP (0.305s)
[168.746096] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.306s)
[169.615834] [039/131] (854s left) kms_dp_link_training (uhbr-mst)
[169.699427] Starting subtest: uhbr-mst
[169.702986] Subtest uhbr-mst: SKIP (0.000s)
[169.788765] [040/131] (854s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[169.878980] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[169.880626] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[170.009081] [041/131] (854s left) gem_exec_params (cliprects-invalid)
[170.063767] Starting subtest: cliprects-invalid
[170.064713] Subtest cliprects-invalid: SUCCESS (0.000s)
[170.191966] [042/131] (854s left) gem_userptr_blits (relocations)
[170.244799] Starting subtest: relocations
[170.246570] Subtest relocations: SKIP (0.000s)
[170.397116] [043/131] (853s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[170.454245] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[170.514305] [044/131] (853s left) gem_mmap_gtt (medium-copy-xy)
[170.568522] Subtest medium-copy-XY: SKIP (0.000s)
[170.624733] [045/131] (853s left) kms_plane (pixel-format-source-clamping)
[170.708389] Starting subtest: pixel-format-source-clamping
[170.738008] Starting dynamic subtest: pipe-A-plane-0
[175.526761] Dynamic subtest pipe-A-plane-0: SUCCESS (4.789s)
[175.534923] Starting dynamic subtest: pipe-A-plane-3
[177.804442] Dynamic subtest pipe-A-plane-3: SUCCESS (2.277s)
[177.812908] Starting dynamic subtest: pipe-A-plane-5
[177.813873] Dynamic subtest pipe-A-plane-5: SUCCESS (0.000s)
[178.892816] Starting dynamic subtest: pipe-B-plane-0
[183.684425] Dynamic subtest pipe-B-plane-0: SUCCESS (4.800s)
[183.692194] Starting dynamic subtest: pipe-B-plane-3
[185.973459] Dynamic subtest pipe-B-plane-3: SUCCESS (2.288s)
[185.983268] Starting dynamic subtest: pipe-B-plane-5
[185.984170] Dynamic subtest pipe-B-plane-5: SUCCESS (0.000s)
[186.281442] Subtest pixel-format-source-clamping: SUCCESS (15.572s)
[187.173730] [046/131] (837s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[187.268777] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[187.270459] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[187.393989] [047/131] (837s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[187.472471] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[187.474164] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[187.577591] [048/131] (836s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[187.670640] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[187.672270] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[187.776893] [049/131] (836s left) api_intel_allocator (standalone)
[187.821915] Starting subtest: standalone
[187.837474] Subtest standalone: SUCCESS (0.016s)
[187.987259] [050/131] (836s left) kms_lease (cursor-implicit-plane)
[188.076709] Starting subtest: cursor-implicit-plane
[188.077568] Starting dynamic subtest: pipe-A-eDP-1
[188.535724] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.459s)
[188.543956] Starting dynamic subtest: pipe-B-eDP-1
[189.683015] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.146s)
[189.691227] Starting dynamic subtest: pipe-C-eDP-1
[190.783382] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.100s)
[190.794693] Starting dynamic subtest: pipe-D-eDP-1
[191.917617] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.131s)
[191.918670] Subtest cursor-implicit-plane: SUCCESS (3.841s)
[192.792193] [051/131] (831s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[192.835741] Starting subtest: invalid-signal-one-illegal-handle
[192.836616] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[192.940011] [052/131] (831s left) kms_vblank (accuracy-idle)
[193.021948] Starting subtest: accuracy-idle
[193.022899] Starting dynamic subtest: pipe-A-eDP-1
[194.771738] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.750s)
[194.782758] Starting dynamic subtest: pipe-D-eDP-1
[197.223017] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.448s)
[197.223880] Subtest accuracy-idle: SUCCESS (4.201s)
[198.050647] [053/131] (826s left) gem_softpin (evict-snoop-interruptible)
[198.110732] Starting subtest: evict-snoop-interruptible
[198.112749] Subtest evict-snoop-interruptible: SKIP (0.000s)
[198.229594] [054/131] (826s left) syncobj_wait (single-wait-all-submitted)
[198.279470] Starting subtest: single-wait-all-submitted
[198.390672] Subtest single-wait-all-submitted: SUCCESS (0.109s)
[198.478135] [055/131] (826s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[198.570924] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[198.572617] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[198.678206] [056/131] (826s left) i915_pm_rps (fence-order)
[198.735070] Starting subtest: fence-order
[202.232902] Subtest fence-order: SUCCESS (3.500s)
[202.368456] [057/131] (822s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[202.408396] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[202.471816] [058/131] (822s left) kms_cdclk (mode-transition)
[202.568564] Starting subtest: mode-transition
[202.569517] Starting dynamic subtest: pipe-A-eDP-1
[202.856372] Dynamic subtest pipe-A-eDP-1: SKIP (0.286s)
[202.865427] Starting dynamic subtest: pipe-B-eDP-1
[202.867329] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[202.875093] Starting dynamic subtest: pipe-C-eDP-1
[202.876911] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[202.885048] Starting dynamic subtest: pipe-D-eDP-1
[202.887447] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[202.889616] Subtest mode-transition: SKIP (0.293s)
[203.674296] [059/131] (821s left) gem_softpin (allocator-nopin)
[203.737080] Starting subtest: allocator-nopin
[203.849858] Subtest allocator-nopin: SUCCESS (0.112s)
[204.018961] [060/131] (820s left) gem_exec_flush (basic-wb-ro-before-default)
[204.082035] Starting subtest: basic-wb-ro-before-default
[209.534753] Subtest basic-wb-ro-before-default: SUCCESS (5.452s)
[209.722638] [061/131] (815s left) gem_exec_schedule (preemptive-hang)
[209.912901] Starting subtest: preemptive-hang
[209.914716] Starting dynamic subtest: rcs0
[219.244878] Dynamic subtest rcs0: SUCCESS (9.332s)
[219.259104] Starting dynamic subtest: bcs0
[228.253009] Dynamic subtest bcs0: SUCCESS (9.010s)
[228.262922] Starting dynamic subtest: vcs0
[237.215339] Dynamic subtest vcs0: SUCCESS (8.958s)
[237.225191] Starting dynamic subtest: vcs1
[246.309229] Dynamic subtest vcs1: SUCCESS (9.094s)
[246.317634] Starting dynamic subtest: vecs0
[255.193406] Dynamic subtest vecs0: SUCCESS (8.881s)
[255.204014] Starting dynamic subtest: ccs0
[264.220692] Dynamic subtest ccs0: SUCCESS (9.028s)
[264.222777] Subtest preemptive-hang: SUCCESS (54.310s)
[264.472418] [062/131] (760s left) vgem_basic (second-client)
[264.514013] Starting subtest: second-client
[264.538438] Subtest second-client: SUCCESS (0.023s)
[264.619892] [063/131] (760s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[264.721498] Starting subtest: x-tiled-32bpp-rotate-270
[264.742012] Subtest x-tiled-32bpp-rotate-270: SKIP (0.020s)
[264.873106] [064/131] (760s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[264.983661] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[265.947102] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.964s)
[266.810348] [065/131] (758s left) kms_addfb_basic (bo-too-small)
[266.893683] Starting subtest: bo-too-small
[266.894553] Subtest bo-too-small: SUCCESS (0.000s)
[267.016117] [066/131] (758s left) gen7_exec_parse (load-register-reg)
[267.068442] Subtest load-register-reg: SKIP (0.000s)
[267.143273] [067/131] (758s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[267.195090] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[267.302167] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.104s)
[267.384937] [068/131] (757s left) kms_frontbuffer_tracking (basic)
[267.471271] Starting subtest: basic
[270.672200] Subtest basic: SUCCESS (3.201s)
[270.821726] [069/131] (754s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[270.928133] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[270.930077] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[271.058678] [070/131] (754s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[271.160933] Starting subtest: cursorB-vs-flipB-varying-size
[271.162650] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[271.312565] [071/131] (754s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[276.278973] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[276.279771] Starting dynamic subtest: pipe-A-eDP-1
[287.702238] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.420s)
[287.710624] Starting dynamic subtest: pipe-B-eDP-1
[299.111787] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.408s)
[299.113075] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.833s)
[299.971701] [072/131] (725s left) gem_mmap_offset (bad-extensions)
[300.014455] Starting subtest: bad-extensions
[300.015412] Subtest bad-extensions: SUCCESS (0.000s)
[300.110576] [073/131] (725s left) kms_rotation_crc (bad-tiling)
[300.195711] Starting subtest: bad-tiling
[300.197436] Subtest bad-tiling: SKIP (0.001s)
[300.287356] [074/131] (725s left) gem_create (create-ext-placement-each)
[300.447265] Starting subtest: create-ext-placement-each
[300.448613] Subtest create-ext-placement-each: SUCCESS (0.000s)
[300.571339] [075/131] (724s left) kms_prop_blob (blob-prop-core)
[300.617416] Starting subtest: blob-prop-core
[300.618453] Subtest blob-prop-core: SUCCESS (0.000s)
[300.757534] [076/131] (724s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[300.859087] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[307.868541] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.011s)
[307.987001] [077/131] (717s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[308.364802] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[309.194084] [078/131] (716s left) sysfs_timeslice_duration (invalid)
[309.245972] Starting subtest: invalid
[309.247038] Starting dynamic subtest: vecs0
[309.248112] Dynamic subtest vecs0: SUCCESS (0.000s)
[309.257898] Starting dynamic subtest: ccs0
[309.258800] Dynamic subtest ccs0: SUCCESS (0.000s)
[309.266671] Starting dynamic subtest: vcs0
[309.267555] Dynamic subtest vcs0: SUCCESS (0.000s)
[309.275501] Starting dynamic subtest: bcs0
[309.276460] Dynamic subtest bcs0: SUCCESS (0.000s)
[309.284732] Starting dynamic subtest: rcs0
[309.285616] Dynamic subtest rcs0: SUCCESS (0.000s)
[309.293326] Starting dynamic subtest: vcs1
[309.294259] Dynamic subtest vcs1: SUCCESS (0.000s)
[309.295125] Subtest invalid: SUCCESS (0.006s)
[309.369637] [079/131] (716s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[309.452173] Starting subtest: fbc-psr-sprite-mmap-cpu
[309.453130] Starting dynamic subtest: eDP-1
[309.454966] Dynamic subtest eDP-1: SKIP (0.000s)
[309.456656] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s)
[309.531499] [080/131] (716s left) fbdev (unaligned-write)
[309.566659] Starting subtest: unaligned-write
[309.671602] Subtest unaligned-write: SUCCESS (0.102s)
[309.750434] [081/131] (715s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[309.803359] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[309.805032] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[309.993926] [082/131] (715s left) kms_psr (pr-primary-page-flip)
[310.084407] Starting subtest: pr-primary-page-flip
[310.086257] Subtest pr-primary-page-flip: SKIP (0.000s)
[310.161072] [083/131] (715s left) gem_exec_params (invalid-bsd1-flag-on-render)
[310.213629] Starting subtest: invalid-bsd1-flag-on-render
[310.214708] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[310.351555] [084/131] (715s left) kms_psr (psr2-sprite-blt)
[310.439978] Starting subtest: psr2-sprite-blt
[310.440899] Starting dynamic subtest: eDP-1
[312.119882] Dynamic subtest eDP-1: SUCCESS (1.679s)
[312.120762] Subtest psr2-sprite-blt: SUCCESS (1.680s)
[312.997258] [085/131] (712s left) gem_userptr_blits (unsync-unmap)
[313.060378] Subtest unsync-unmap: SKIP (0.000s)
[313.216831] [086/131] (712s left) kms_big_fb (linear-8bpp-rotate-0)
[313.313461] Starting subtest: linear-8bpp-rotate-0
[314.503294] Subtest linear-8bpp-rotate-0: SUCCESS (1.190s)
[314.669019] [087/131] (711s left) kms_psr (fbc-pr-cursor-plane-move)
[314.754966] Starting subtest: fbc-pr-cursor-plane-move
[314.756715] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[314.846241] [088/131] (711s left) gem_ctx_isolation (dirty-create)
[314.910968] Starting subtest: dirty-create
[314.912090] Starting dynamic subtest: rcs0
[315.103173] Dynamic subtest rcs0: SUCCESS (0.192s)
[315.113075] Starting dynamic subtest: bcs0
[315.299786] Dynamic subtest bcs0: SUCCESS (0.196s)
[315.310955] Starting dynamic subtest: vcs0
[315.506619] Dynamic subtest vcs0: SUCCESS (0.206s)
[315.515132] Starting dynamic subtest: vcs1
[317.309696] Dynamic subtest vcs1: SUCCESS (1.802s)
[317.318316] Starting dynamic subtest: vecs0
[319.323550] Dynamic subtest vecs0: SUCCESS (2.012s)
[319.332213] Starting dynamic subtest: ccs0
[321.370209] Dynamic subtest ccs0: SUCCESS (2.046s)
[321.371395] Subtest dirty-create: SUCCESS (6.460s)
[321.655191] [089/131] (704s left) gem_exec_schedule (fairslice-all)
[321.711983] Starting subtest: fairslice-all
[323.797365] Subtest fairslice-all: SUCCESS (2.085s)
[324.115427] [090/131] (701s left) prime_vgem (basic-blt)
[324.198904] Starting subtest: basic-blt
[324.232283] Subtest basic-blt: SUCCESS (0.033s)
[324.358917] [091/131] (701s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[324.405845] Starting subtest: multi-wait-all-for-submit-submitted
[324.508457] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.101s)
[324.592475] [092/131] (701s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[324.678249] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[332.036526] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.359s)
[332.188676] [093/131] (693s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[332.307452] Starting subtest: cursorA-vs-flipA-atomic
[343.422094] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.112s)
[344.253614] [094/131] (681s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[344.353573] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[345.034663] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.681s)
[345.215116] [095/131] (680s left) syncobj_timeline (single-wait-for-submit-signaled)
[345.265488] Starting subtest: single-wait-for-submit-signaled
[345.266629] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[345.371471] [096/131] (680s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[345.465054] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[345.466849] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[345.591993] [097/131] (680s left) gem_pread (bench)
[345.653524] Subtest bench: SKIP (0.000s)
[345.718405] [098/131] (680s left) kms_atomic (plane-cursor-legacy)
[345.813659] Starting subtest: plane-cursor-legacy
[345.814472] Starting dynamic subtest: pipe-A-eDP-1
[346.188663] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.373s)
[346.190074] Subtest plane-cursor-legacy: SUCCESS (0.375s)
[346.989973] [099/131] (679s left) kms_pipe_crc_basic (read-crc)
[347.074827] Starting subtest: read-crc
[347.075677] Starting dynamic subtest: pipe-A-eDP-1
[347.775509] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.699s)
[347.783974] Starting dynamic subtest: pipe-B-eDP-1
[349.150781] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.374s)
[349.160313] Starting dynamic subtest: pipe-C-eDP-1
[350.448500] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.295s)
[350.456803] Starting dynamic subtest: pipe-D-eDP-1
[351.752794] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.302s)
[351.753820] Subtest read-crc: SUCCESS (4.677s)
[352.615390] [100/131] (673s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[352.713301] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[352.715035] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[352.845466] [101/131] (673s left) kms_cursor_edge_walk (256x256-left-edge)
[352.938901] Starting subtest: 256x256-left-edge
[352.939874] Starting dynamic subtest: pipe-A-eDP-1
[356.370234] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.430s)
[356.378430] Starting dynamic subtest: pipe-D-eDP-1
[359.496283] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.124s)
[359.497314] Subtest 256x256-left-edge: SUCCESS (6.556s)
[360.315951] [102/131] (666s left) kms_vblank (ts-continuation-idle-hang)
[360.403748] Starting subtest: ts-continuation-idle-hang
[360.404556] Starting dynamic subtest: pipe-A-eDP-1
[386.864785] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.458s)
[386.874776] Starting dynamic subtest: pipe-D-eDP-1
[401.846645] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.979s)
[401.847636] Subtest ts-continuation-idle-hang: SUCCESS (41.441s)
[402.673636] [103/131] (623s left) kms_pm_backlight (brightness-with-dpms)
[402.764804] Starting subtest: brightness-with-dpms
[402.815529] Starting dynamic subtest: eDP-1
[405.254242] Dynamic subtest eDP-1: SUCCESS (2.436s)
[405.255654] Subtest brightness-with-dpms: SUCCESS (2.489s)
[406.133511] [104/131] (620s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[406.217643] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[410.880550] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.662s)
[412.046762] [105/131] (614s left) kms_getfb (getfb2-accept-nv12)
[412.132957] Starting subtest: getfb2-accept-nv12
[412.133850] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[412.255933] [106/131] (614s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[412.346429] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[412.347398] Starting dynamic subtest: pipe-A-default-mode
[412.639292] Dynamic subtest pipe-A-default-mode: SKIP (0.292s)
[412.640872] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.294s)
[413.444157] [107/131] (613s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[413.538171] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[413.539858] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[413.666917] [108/131] (612s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[413.782376] Starting subtest: 2x-long-cursor-vs-flip-atomic
[413.785120] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[413.932431] [109/131] (612s left) kms_atomic_interruptible (legacy-setmode)
[414.026994] Starting subtest: legacy-setmode
[414.027957] Starting dynamic subtest: pipe-A-eDP-1
[420.918289] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.889s)
[420.919377] Subtest legacy-setmode: SUCCESS (6.891s)
[421.784644] [110/131] (604s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[421.887070] Starting subtest: psr-rgb101010-draw-mmap-cpu
[428.856189] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (6.970s)
[429.024804] [111/131] (597s left) kms_cursor_legacy (forked-move)
[429.148028] Starting subtest: forked-move
[429.149012] Starting dynamic subtest: pipe-A
[434.613834] Dynamic subtest pipe-A: SUCCESS (5.462s)
[434.624779] Starting dynamic subtest: pipe-B
[440.087889] Dynamic subtest pipe-B: SUCCESS (5.471s)
[440.096244] Starting dynamic subtest: pipe-C
[445.570907] Dynamic subtest pipe-C: SUCCESS (5.482s)
[445.583423] Starting dynamic subtest: pipe-D
[451.037067] Dynamic subtest pipe-D: SUCCESS (5.464s)
[451.047810] Starting dynamic subtest: all-pipes
[456.529850] Dynamic subtest all-pipes: SUCCESS (5.490s)
[456.531064] Subtest forked-move: SUCCESS (27.378s)
[456.689029] [112/131] (570s left) syncobj_wait (reset-signaled)
[456.744494] Starting subtest: reset-signaled
[456.745992] Subtest reset-signaled: SUCCESS (0.000s)
[456.867445] [113/131] (569s left) gem_ctx_persistence (heartbeat-hostile)
[456.929129] Starting subtest: heartbeat-hostile
[456.931072] Subtest heartbeat-hostile: SKIP (0.000s)
[457.060516] [114/131] (569s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[457.157636] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[457.159567] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[457.300791] [115/131] (569s left) kms_psr (fbc-psr2-primary-blt)
[457.388860] Starting subtest: fbc-psr2-primary-blt
[457.389744] Starting dynamic subtest: eDP-1
[457.391441] Dynamic subtest eDP-1: SKIP (0.000s)
[457.393149] Subtest fbc-psr2-primary-blt: SKIP (0.001s)
[457.472552] [116/131] (569s left) gem_exec_whisper (basic-contexts-priority)
[457.527355] Starting subtest: basic-contexts-priority
[482.427025] Subtest basic-contexts-priority: SUCCESS (24.894s)
[482.614089] [117/131] (544s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[482.733872] Starting subtest: flip-vs-cursor-crc-atomic
[483.385004] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.650s)
[484.223782] [118/131] (542s left) vgem_basic (dmabuf-export)
[484.257613] Starting subtest: dmabuf-export
[484.317942] Subtest dmabuf-export: SUCCESS (0.061s)
[484.459535] [119/131] (542s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[489.416485] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[489.421123] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.002s)
[490.284094] [120/131] (536s left) gem_exec_fence (syncobj-timeline-chain-engines)
[490.824498] Starting subtest: syncobj-timeline-chain-engines
[490.939491] Subtest syncobj-timeline-chain-engines: SUCCESS (0.116s)
[492.184738] [121/131] (534s left) kms_busy (extended-modeset-hang-newfb)
[492.275091] Starting subtest: extended-modeset-hang-newfb
[492.276051] Starting dynamic subtest: pipe-A
[527.738013] Dynamic subtest pipe-A: SUCCESS (35.460s)
[527.747825] Starting dynamic subtest: pipe-D
[545.009736] Dynamic subtest pipe-D: SUCCESS (17.270s)
[545.010876] Subtest extended-modeset-hang-newfb: SUCCESS (52.734s)
[545.827906] [122/131] (481s left) i915_drm_fdinfo (busy-idle)
[545.861351] Starting subtest: busy-idle
[545.862192] Starting dynamic subtest: rcs0
[545.891840] Dynamic subtest rcs0: SKIP (0.029s)
[545.901703] Starting dynamic subtest: bcs0
[545.903294] Dynamic subtest bcs0: SKIP (0.000s)
[545.911649] Starting dynamic subtest: vcs0
[545.913293] Dynamic subtest vcs0: SKIP (0.000s)
[545.921528] Starting dynamic subtest: vcs1
[545.923253] Dynamic subtest vcs1: SKIP (0.000s)
[545.931271] Starting dynamic subtest: vecs0
[545.932852] Dynamic subtest vecs0: SKIP (0.000s)
[545.940789] Starting dynamic subtest: ccs0
[545.942382] Dynamic subtest ccs0: SKIP (0.000s)
[545.944034] Subtest busy-idle: SKIP (0.034s)
[545.975022] [123/131] (481s left) perf_pmu (busy-double-start)
[546.009385] Starting subtest: busy-double-start
[546.010930] Starting dynamic subtest: rcs0
[549.601834] Dynamic subtest rcs0: FAIL (3.570s)
[549.610234] Starting dynamic subtest: bcs0
[553.156009] Dynamic subtest bcs0: SUCCESS (3.576s)
[553.169650] Starting dynamic subtest: vcs0
[557.639459] Dynamic subtest vcs0: FAIL (4.455s)
[557.647651] Starting dynamic subtest: vcs1
[561.605825] Dynamic subtest vcs1: FAIL (3.964s)
[561.614563] Starting dynamic subtest: vecs0
[565.637040] Dynamic subtest vecs0: FAIL (4.032s)
[565.645636] Starting dynamic subtest: ccs0
[569.203827] Dynamic subtest ccs0: FAIL (3.567s)
[569.204662] Subtest busy-double-start: FAIL (23.172s)
[569.312328] [124/131] (457s left) gem_render_copy (yf-tiled)
[569.365124] Starting subtest: yf-tiled
[569.366824] Subtest yf-tiled: SKIP (0.000s)
[569.566081] [125/131] (457s left) device_reset (unbind-reset-rebind)
[569.606002] Starting subtest: unbind-reset-rebind
[574.316382] Subtest unbind-reset-rebind: SUCCESS (4.706s)
[574.349585] [126/131] (452s left) gem_exercise_blt (fast-copy-emit)
[574.412328] Starting subtest: fast-copy-emit
[574.413508] Starting dynamic subtest: linear-smem-smem-emit
[574.433644] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.022s)
[574.444550] Starting dynamic subtest: xmajor-smem-smem-emit
[574.452077] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.018s)
[574.460933] Starting dynamic subtest: tile4-smem-smem-emit
[574.468914] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.016s)
[574.478122] Starting dynamic subtest: tile64-smem-smem-emit
[574.485317] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.016s)
[574.486353] Subtest fast-copy-emit: SUCCESS (0.075s)
[574.641181] [127/131] (452s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[574.723620] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[574.724515] Starting dynamic subtest: pipe-A
[574.739446] Dynamic subtest pipe-A: SKIP (0.015s)
[574.748405] Starting dynamic subtest: pipe-B
[574.771380] Dynamic subtest pipe-B: SKIP (0.030s)
[574.780198] Starting dynamic subtest: pipe-C
[574.802637] Dynamic subtest pipe-C: SKIP (0.031s)
[574.810981] Starting dynamic subtest: pipe-D
[574.834265] Dynamic subtest pipe-D: SKIP (0.031s)
[574.835906] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.110s)
[574.957329] [128/131] (452s left) gem_render_copy_redux (interruptible)
[575.018787] Starting subtest: interruptible
[575.281699] Subtest interruptible: SUCCESS (0.263s)
[575.441757] [129/131] (451s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[575.536380] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[575.537264] Starting dynamic subtest: pipe-A-eDP-1
[575.545130] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[575.555265] Starting dynamic subtest: pipe-B-eDP-1
[575.562963] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[575.571485] Starting dynamic subtest: pipe-C-eDP-1
[575.579436] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[575.587879] Starting dynamic subtest: pipe-D-eDP-1
[575.595128] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[575.595947] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[577.749004] [130/131] (449s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[577.844624] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[577.846290] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[578.967373] [131/131] (448s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[579.066191] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[579.067948] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[579.198897] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_exec_parallel
results: parsing output: 2/ for test: perf_pmu
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: kms_ccs
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: gem_lmem_swapping
results: parsing output: 7/ for test: kms_cursor_crc
results: parsing output: 8/ for test: gem_exec_schedule
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_workarounds
results: parsing output: 11/ for test: kms_flip_scaled_crc
results: parsing output: 12/ for test: gem_ctx_shared
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_exec_balancer
results: parsing output: 16/ for test: syncobj_timeline
results: parsing output: 17/ for test: kms_async_flips
results: parsing output: 18/ for test: kms_pm_dc
results: parsing output: 19/ for test: i915_fb_tiling
results: parsing output: 20/ for test: i915_pm_rps
results: parsing output: 21/ for test: gem_exec_reloc
results: parsing output: 22/ for test: gem_eio
results: parsing output: 23/ for test: gem_exec_balancer
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: kms_flip
results: parsing output: 26/ for test: gem_userptr_blits
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: kms_cursor_crc
results: parsing output: 29/ for test: kms_invalid_mode
results: parsing output: 30/ for test: kms_cursor_legacy
results: parsing output: 31/ for test: kms_chamelium_edid
results: parsing output: 32/ for test: api_intel_bb
results: parsing output: 33/ for test: kms_psr
results: parsing output: 34/ for test: kms_flip
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_content_protection
results: parsing output: 37/ for test: kms_flip_scaled_crc
results: parsing output: 38/ for test: kms_dp_link_training
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_exec_params
results: parsing output: 41/ for test: gem_userptr_blits
results: parsing output: 42/ for test: gem_exec_reloc
results: parsing output: 43/ for test: gem_mmap_gtt
results: parsing output: 44/ for test: kms_plane
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: api_intel_allocator
results: parsing output: 49/ for test: kms_lease
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: kms_vblank
results: parsing output: 52/ for test: gem_softpin
results: parsing output: 53/ for test: syncobj_wait
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: i915_pm_rps
results: parsing output: 56/ for test: kms_pipe_b_c_ivb
results: parsing output: 57/ for test: kms_cdclk
results: parsing output: 58/ for test: gem_softpin
results: parsing output: 59/ for test: gem_exec_flush
results: parsing output: 60/ for test: gem_exec_schedule
results: parsing output: 61/ for test: vgem_basic
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: kms_cursor_legacy
results: parsing output: 64/ for test: kms_addfb_basic
results: parsing output: 65/ for test: gen7_exec_parse
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: kms_cursor_legacy
results: parsing output: 70/ for test: kms_psr2_sf
results: parsing output: 71/ for test: gem_mmap_offset
results: parsing output: 72/ for test: kms_rotation_crc
results: parsing output: 73/ for test: gem_create
results: parsing output: 74/ for test: kms_prop_blob
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_chamelium_hpd
results: parsing output: 77/ for test: sysfs_timeslice_duration
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: fbdev
results: parsing output: 80/ for test: gem_render_copy
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: gem_exec_params
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: gem_userptr_blits
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: gem_ctx_isolation
results: parsing output: 88/ for test: gem_exec_schedule
results: parsing output: 89/ for test: prime_vgem
results: parsing output: 90/ for test: syncobj_wait
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_cursor_legacy
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_pread
results: parsing output: 97/ for test: kms_atomic
results: parsing output: 98/ for test: kms_pipe_crc_basic
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_cursor_edge_walk
results: parsing output: 101/ for test: kms_vblank
results: parsing output: 102/ for test: kms_pm_backlight
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_getfb
results: parsing output: 105/ for test: kms_flip_scaled_crc
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_cursor_legacy
results: parsing output: 108/ for test: kms_atomic_interruptible
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_cursor_legacy
results: parsing output: 111/ for test: syncobj_wait
results: parsing output: 112/ for test: gem_ctx_persistence
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: gem_exec_whisper
results: parsing output: 116/ for test: kms_cursor_legacy
results: parsing output: 117/ for test: vgem_basic
results: parsing output: 118/ for test: kms_psr2_sf
results: parsing output: 119/ for test: gem_exec_fence
results: parsing output: 120/ for test: kms_busy
results: parsing output: 121/ for test: i915_drm_fdinfo
results: parsing output: 122/ for test: perf_pmu
results: parsing output: 123/ for test: gem_render_copy
results: parsing output: 124/ for test: device_reset
results: parsing output: 125/ for test: gem_exercise_blt
results: parsing output: 126/ for test: kms_plane_scaling
results: parsing output: 127/ for test: gem_render_copy_redux
results: parsing output: 128/ for test: kms_ccs
results: parsing output: 129/ for test: kms_ccs
results: parsing output: 130/ for test: kms_frontbuffer_tracking
Done.